RC5 - Print don't start with pre-heated bed

[edwilliams16]

Gets up to temperature, but then won't count down to start. I preheated for a while before I told S3D to start the print. This is with RC5.

Possible duplicate: #3585

SENT: G90
SENT: M82
SENT: M106 S0
SENT: M140 S95
SENT: M190 S95
RECEIVED: ok
RECEIVED: ok
RECEIVED: ok
RECEIVED: ok
RECEIVED:  T:229.2 /230.0 B:92.7 /95.0 B@:127 @:87
RECEIVED:  T:229.1 /230.0 B:92.8 /95.0 B@:127 @:89
RECEIVED:  T:229.1 /230.0 B:92.8 /95.0 B@:127 @:90
RECEIVED:  T:229.1 /230.0 B:92.9 /95.0 B@:127 @:93
RECEIVED:  T:229.3 /230.0 B:93.0 /95.0 B@:127 @:86
RECEIVED:  T:229.9 /230.0 B:93.0 /95.0 B@:127 @:70
RECEIVED:  T:230.0 /230.0 B:93.1 /95.0 B@:127 @:67
RECEIVED:  T:230.0 /230.0 B:93.1 /95.0 B@:127 @:69
RECEIVED:  T:229.9 /230.0 B:93.2 /95.0 B@:127 @:72
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:230.0 /230.0 B:93.2 /95.0 B@:127 @:71
RECEIVED:  T:230.0 /230.0 B:93.4 /95.0 B@:127 @:71
RECEIVED:  T:230.0 /230.0 B:93.4 /95.0 B@:127 @:72
RECEIVED:  T:230.1 /230.0 B:93.4 /95.0 B@:127 @:70
RECEIVED:  T:230.1 /230.0 B:93.5 /95.0 B@:127 @:70
RECEIVED:  T:230.0 /230.0 B:93.5 /95.0 B@:127 @:73
RECEIVED:  T:230.1 /230.0 B:93.6 /95.0 B@:127 @:70
RECEIVED:  T:230.0 /230.0 B:93.6 /95.0 B@:127 @:73
RECEIVED:  T:230.1 /230.0 B:93.8 /95.0 B@:127 @:71
RECEIVED:  T:230.2 /230.0 B:93.8 /95.0 B@:127 @:68
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:230.0 /230.0 B:93.8 /95.0 B@:127 @:73
RECEIVED:  T:230.4 /230.0 B:93.9 /95.0 B@:127 @:61
RECEIVED:  T:230.5 /230.0 B:93.9 /95.0 B@:127 @:58
RECEIVED:  T:230.5 /230.0 B:94.1 /95.0 B@:127 @:56
RECEIVED:  T:230.5 /230.0 B:94.1 /95.0 B@:127 @:55
RECEIVED:  T:230.6 /230.0 B:94.1 /95.0 B@:127 @:52
RECEIVED:  T:230.3 /230.0 B:94.2 /95.0 B@:127 @:61
RECEIVED:  T:230.2 /230.0 B:94.2 /95.0 B@:127 @:63
RECEIVED:  T:230.0 /230.0 B:94.3 /95.0 B@:125 @:69
RECEIVED:  T:230.0 /230.0 B:94.3 /95.0 B@:127 @:68
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:230.0 /230.0 B:94.4 /95.0 B@:115 @:67
RECEIVED:  T:230.0 /230.0 B:94.5 /95.0 B@:124 @:67
RECEIVED:  T:230.0 /230.0 B:94.5 /95.0 B@:127 @:66
RECEIVED:  T:230.0 /230.0 B:94.6 /95.0 B@:111 @:66
RECEIVED:  T:230.0 /230.0 B:94.6 /95.0 B@:115 @:66
RECEIVED:  T:230.0 /230.0 B:94.6 /95.0 B@:127 @:66
RECEIVED:  T:230.0 /230.0 B:94.7 /95.0 B@:107 @:65
RECEIVED:  T:230.0 /230.0 B:94.7 /95.0 B@:113 @:65
RECEIVED:  T:230.0 /230.0 B:94.7 /95.0 B@:127 @:65
RECEIVED:  T:230.0 /230.0 B:94.8 /95.0 B@:105 @:65
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:230.0 /230.0 B:94.9 /95.0 B@:106 @:65
RECEIVED:  T:230.0 /230.0 B:94.9 /95.0 B@:111 @:65
RECEIVED:  T:229.9 /230.0 B:94.9 /95.0 B@:117 @:67
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:96 @:65
RECEIVED: ok
SENT: M105
SENT: M104 S230 T0
SENT: M109 S230 T0
RECEIVED: ok T:229.9 /230.0 B:95.0 /95.0 B@:95 @:69
RECEIVED: ok
RECEIVED:  T:229.9 /230.0 B:95.0 /95.0 B@:95 @:69 W:?
RECEIVED:  T:229.8 /230.0 B:95.0 /95.0 B@:95 @:73 W:?
RECEIVED:  T:229.6 /230.0 B:95.0 /95.0 B@:96 @:77 W:?
RECEIVED:  T:229.8 /230.0 B:95.0 /95.0 B@:92 @:72 W:?
RECEIVED:  T:229.3 /230.0 B:95.0 /95.0 B@:95 @:88 W:?
RECEIVED:  T:229.5 /230.0 B:95.0 /95.0 B@:95 @:81 W:?
RECEIVED:  T:229.6 /230.0 B:95.0 /95.0 B@:92 @:77 W:?
RECEIVED:  T:229.7 /230.0 B:95.0 /95.0 B@:94 @:76 W:?
RECEIVED:  T:229.9 /230.0 B:95.0 /95.0 B@:91 @:71 W:?
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:229.9 /230.0 B:95.0 /95.0 B@:93 @:70 W:?
RECEIVED:  T:230.0 /230.0 B:95.1 /95.0 B@:86 @:69 W:?
RECEIVED:  T:230.1 /230.0 B:95.0 /95.0 B@:91 @:67 W:?
RECEIVED:  T:230.0 /230.0 B:95.1 /95.0 B@:84 @:70 W:?
RECEIVED:  T:229.9 /230.0 B:95.0 /95.0 B@:89 @:72 W:?
RECEIVED:  T:230.0 /230.0 B:95.1 /95.0 B@:79 @:70 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:86 @:70 W:?
RECEIVED:  T:230.0 /230.0 B:95.1 /95.0 B@:79 @:71 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:79 @:71 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:83 @:71 W:?
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:81 @:71 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:83 @:71 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:84 @:71 W:?
RECEIVED:  T:230.1 /230.0 B:95.0 /95.0 B@:84 @:69 W:?
RECEIVED:  T:230.1 /230.0 B:95.0 /95.0 B@:83 @:68 W:?
RECEIVED:  T:230.2 /230.0 B:95.0 /95.0 B@:83 @:64 W:?
RECEIVED:  T:230.4 /230.0 B:95.0 /95.0 B@:83 @:59 W:?
RECEIVED:  T:230.1 /230.0 B:95.0 /95.0 B@:85 @:68 W:?
RECEIVED:  T:230.2 /230.0 B:95.0 /95.0 B@:82 @:66 W:?
RECEIVED:  T:230.5 /230.0 B:95.0 /95.0 B@:84 @:53 W:?
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:230.2 /230.0 B:95.0 /95.0 B@:84 @:63 W:?
RECEIVED:  T:230.3 /230.0 B:95.0 /95.0 B@:84 @:60 W:?
RECEIVED:  T:230.3 /230.0 B:95.0 /95.0 B@:84 @:60 W:?
RECEIVED:  T:230.3 /230.0 B:95.0 /95.0 B@:81 @:59 W:?
RECEIVED:  T:230.2 /230.0 B:95.0 /95.0 B@:83 @:63 W:?
RECEIVED:  T:230.1 /230.0 B:95.0 /95.0 B@:83 @:65 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:83 @:67 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:83 @:67 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:85 @:66 W:?
RECEIVED:  T:229.9 /230.0 B:95.0 /95.0 B@:83 @:68 W:?
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:81 @:65 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:83 @:65 W:?
RECEIVED:  T:229.9 /230.0 B:95.0 /95.0 B@:83 @:67 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:80 @:65 W:?
RECEIVED:  T:229.9 /230.0 B:95.0 /95.0 B@:78 @:67 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:80 @:65 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:80 @:65 W:?
RECEIVED:  T:229.9 /230.0 B:95.0 /95.0 B@:80 @:67 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:79 @:65 W:?
RECEIVED:  T:229.7 /230.0 B:95.0 /95.0 B@:79 @:74 W:?
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:229.8 /230.0 B:95.0 /95.0 B@:79 @:70 W:?
RECEIVED:  T:229.8 /230.0 B:95.0 /95.0 B@:77 @:70 W:?
RECEIVED:  T:229.4 /230.0 B:95.0 /95.0 B@:81 @:84 W:?
RECEIVED:  T:229.6 /230.0 B:95.0 /95.0 B@:81 @:77 W:?
RECEIVED:  T:229.5 /230.0 B:95.0 /95.0 B@:81 @:81 W:?
RECEIVED:  T:229.8 /230.0 B:95.0 /95.0 B@:78 @:72 W:?
RECEIVED:  T:229.7 /230.0 B:95.0 /95.0 B@:80 @:76 W:?
RECEIVED:  T:229.9 /230.0 B:95.0 /95.0 B@:81 @:69 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:83 @:68 W:?
RECEIVED:  T:230.0 /230.0 B:95.0 /95.0 B@:81 @:68 W:?
RECEIVED: echo:busy: processing
busy: processing

[Blue-Marlin]

Thank you for your report about RC5.
Should already be fixed in RC6 and RCBugFIX. Another test with one of these would be appreciated.

[edwilliams16]

It still hangs with RC6 - but in a slightly different way.

SENT: G90
SENT: M82
SENT: M106 S0
SENT: M140 S95
SENT: M190 S95
RECEIVED: ok
RECEIVED: ok
RECEIVED: ok
RECEIVED: ok
RECEIVED:  T:231.3 /230.0 B:57.7 /95.0 B@:127 @:37
RECEIVED:  T:231.3 /230.0 B:57.7 /95.0 B@:127 @:36
...
...
...
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:230.0 /230.0 B:94.9 /95.0 B@:127 @:65
RECEIVED:  T:230.0 /230.0 B:94.9 /95.0 B@:127 @:65
RECEIVED: ok
SENT: M105
RECEIVED: ok T:230.0 /230.0 B:95.0 /95.0 B@:127 @:65
       hangs here, with no further output and unresponsive to input.

[edwilliams16]

I accidentally closed this.

[edwilliams16]

Here's from the log of a cold start. It looks like the problem is when the extruder is already preheated to temperature. From a cold start, the bed is heated first and the W:? countdown is initialized. When the extruder gets to temperature W: counts down and the print starts OK.
In the log above when bed reaches the target, and the extruder is already on temperature the countdown isn't triggered.

RECEIVED:  T:27.0 /0.0 B:94.3 /95.0 B@:127 @:0
RECEIVED:  T:27.0 /0.0 B:94.3 /95.0 B@:127 @:0
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:27.0 /0.0 B:94.5 /95.0 B@:127 @:0
RECEIVED:  T:27.0 /0.0 B:94.5 /95.0 B@:127 @:0
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:27.0 /0.0 B:94.5 /95.0 B@:127 @:0
RECEIVED:  T:27.0 /0.0 B:94.6 /95.0 B@:127 @:0
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:27.0 /0.0 B:94.6 /95.0 B@:127 @:0
RECEIVED:  T:27.0 /0.0 B:94.6 /95.0 B@:127 @:0
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:27.0 /0.0 B:94.7 /95.0 B@:127 @:0
RECEIVED:  T:27.1 /0.0 B:94.7 /95.0 B@:127 @:0
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:27.0 /0.0 B:94.9 /95.0 B@:127 @:0
RECEIVED:  T:27.0 /0.0 B:94.9 /95.0 B@:127 @:0
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:27.1 /0.0 B:94.9 /95.0 B@:127 @:0
RECEIVED: ok
SENT: M105
RECEIVED: ok T:27.2 /0.0 B:95.0 /95.0 B@:127 @:0
RECEIVED: ok T:27.2 /0.0 B:95.0 /95.0 B@:127 @:0
SENT: M104 S230 T0
SENT: M109 S230 T0
RECEIVED: ok
RECEIVED:  T:27.2 /230.0 B:95.0 /95.0 B@:127 @:0 W:?
RECEIVED:  T:27.2 /230.0 B:95.0 /95.0 B@:127 @:127 W:?
RECEIVED:  T:27.5 /230.0 B:95.1 /95.0 B@:0 @:127 W:?
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:27.5 /230.0 B:95.1 /95.0 B@:0 @:127 W:?
RECEIVED:  T:28.0 /230.0 B:95.0 /95.0 B@:0 @:127 W:?
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:28.5 /230.0 B:94.8 /95.0 B@:0 @:127 W:?
RECEIVED:  T:29.1 /230.0 B:94.6 /95.0 B@:0 @:127 W:?
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:30.0 /230.0 B:94.3 /95.0 B@:127 @:127 W:?
RECEIVED:  T:31.0 /230.0 B:94.1 /95.0 B@:127 @:127 W:?
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:32.1 /230.0 B:93.9 /95.0 B@:127 @:127 W:?
RECEIVED:  T:33.1 /230.0 B:94.1 /95.0 B@:127 @:127 W:?
RECEIVED: echo:busy: processing
busy: processing
...
...
...
RECEIVED:  T:227.0 /230.0 B:95.4 /95.0 B@:0 @:90 W:?
RECEIVED:  T:228.0 /230.0 B:95.2 /95.0 B@:0 @:73 W:?
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:228.3 /230.0 B:95.0 /95.0 B@:0 @:77 W:?
RECEIVED:  T:229.0 /230.0 B:94.8 /95.0 B@:0 @:65 W:?
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:229.1 /230.0 B:94.6 /95.0 B@:0 @:70 W:9
RECEIVED:  T:230.0 /230.0 B:94.3 /95.0 B@:0 @:50 W:8
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:230.0 /230.0 B:94.1 /95.0 B@:0 @:59 W:7
RECEIVED:  T:230.0 /230.0 B:93.9 /95.0 B@:127 @:64 W:6
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:230.1 /230.0 B:93.7 /95.0 B@:127 @:65 W:5
RECEIVED:  T:231.3 /230.0 B:93.6 /95.0 B@:127 @:32 W:4
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:231.3 /230.0 B:93.6 /95.0 B@:127 @:34 W:3
RECEIVED:  T:231.3 /230.0 B:93.8 /95.0 B@:127 @:36 W:2
RECEIVED: echo:busy: processing
busy: processing
RECEIVED:  T:231.3 /230.0 B:93.9 /95.0 B@:127 @:37 W:1
RECEIVED:  T:231.3 /230.0 B:94.1 /95.0 B@:127 @:37 W:0
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: ok
SENT: M105
SENT: G28 
SENT: G92 E0
SENT: G1 E-1.0000 F1800
SENT: G1 Z0.180 F1000
SENT: T0
RECEIVED: ok T:231.3 /230.0 B:94.2 /95.0 B@:127 @:37
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: echo:busy: processing
busy: processing
RECEIVED: X:0.00 Y:0.00 Z:0.00 E:0.00 Count X: 0 Y:0 Z:0
RECEIVED: ok
SENT: M105
RECEIVED: ok
RECEIVED: ok
SENT: G1 X98.712 Y85.785 F4800
RECEIVED: ok
SENT: G1 E0.0000 F540
SENT: G92 E0
RECEIVED: echo:Active Extruder: 0
Active Extruder: 0
RECEIVED: ok
RECEIVED: ok T:230.9 /230.0 B:94.9 /95.0 B@:0 @:47
RECEIVED: ok
SENT: G1 X99.697 Y84.801 E0.0589 F1800
RECEIVED: ok
RECEIVED: ok
SENT: G1 X121.088 Y84.801 E0.9639
RECEIVED: ok
SENT: G1 X121.167 Y84.880 E0.9686

[Blue-Marlin]

Are you sure you are on RC6 or newer?
Your M190 does not display the "W:" at all.
What we see with "W:" is M109.
Your bed now is in bang-bang mode - not in PID anymore.
My tests are ok for all 6 cases with today's RCBugFix

01:07:58.520 : N77 M105*23
01:07:58.536 : ok T:21.9 /0.0 B:75.0 /75.0 B@:37 @:0
01:08:07.253 : N78 M190 R75*100      // same temperature R
01:08:07.268 : T:22.1 /0.0 B:75.0 /75.0 B@:37 @:0 W:?
01:08:08.268 : T:22.1 /0.0 B:75.0 /75.0 B@:37 @:0 W:9
01:08:09.268 : T:22.0 /0.0 B:75.0 /75.0 B@:37 @:0 W:8
01:08:09.268 : echo:busy: processing
01:08:10.268 : T:22.0 /0.0 B:75.0 /75.0 B@:37 @:0 W:7
01:08:11.267 : T:22.1 /0.0 B:75.0 /75.0 B@:40 @:0 W:6
01:08:11.267 : echo:busy: processing
01:08:12.265 : T:22.1 /0.0 B:75.0 /75.0 B@:36 @:0 W:5
01:08:13.265 : T:22.2 /0.0 B:75.0 /75.0 B@:36 @:0 W:4
01:08:13.265 : echo:busy: processing
01:08:14.264 : T:22.1 /0.0 B:75.0 /75.0 B@:36 @:0 W:3
01:08:15.264 : T:22.1 /0.0 B:75.0 /75.0 B@:40 @:0 W:2
01:08:15.264 : echo:busy: processing
01:08:16.263 : T:22.1 /0.0 B:75.0 /75.0 B@:36 @:0 W:1
01:08:17.262 : T:22.1 /0.0 B:75.0 /75.0 B@:36 @:0 W:0
01:08:17.262 : echo:busy: processing
01:08:17.262 : ok N78 P15 B3
01:08:17.264 : N79 M105*25
01:08:17.279 : ok T:22.1 /0.0 B:75.0 /75.0 B@:36 @:0
01:08:18.611 : N80 M105*31
01:08:18.629 : ok T:22.4 /0.0 B:75.0 /75.0 B@:40 @:0
01:08:21.149 : N81 M190 S75*99      // same temperature S
01:08:21.165 : T:22.3 /0.0 B:75.0 /75.0 B@:37 @:0 W:?
01:08:22.164 : T:22.3 /0.0 B:75.0 /75.0 B@:37 @:0 W:9
01:08:23.164 : T:22.3 /0.0 B:75.0 /75.0 B@:37 @:0 W:8
01:08:23.164 : echo:busy: processing
01:08:24.164 : T:22.3 /0.0 B:75.0 /75.0 B@:43 @:0 W:7
01:08:25.164 : T:22.2 /0.0 B:75.0 /75.0 B@:36 @:0 W:6
01:08:25.164 : echo:busy: processing
01:08:26.162 : T:22.3 /0.0 B:75.0 /75.0 B@:36 @:0 W:5
01:08:27.162 : T:22.4 /0.0 B:75.0 /75.0 B@:36 @:0 W:4
01:08:27.162 : echo:busy: processing
01:08:28.163 : T:22.3 /0.0 B:75.0 /75.0 B@:36 @:0 W:3
01:08:29.161 : T:22.4 /0.0 B:75.0 /75.0 B@:37 @:0 W:2
01:08:29.161 : echo:busy: processing
01:08:30.160 : T:22.4 /0.0 B:75.0 /75.0 B@:37 @:0 W:1
01:08:31.160 : T:22.3 /0.0 B:75.0 /75.0 B@:37 @:0 W:0
01:08:31.160 : echo:busy: processing
01:08:31.160 : ok N81 P15 B3
01:08:31.160 : N82 M105*29
01:08:31.175 : ok T:22.3 /0.0 B:75.0 /75.0 B@:37 @:0
01:08:37.501 : N83 M190 S72*102           // down 3° with S
01:08:37.505 : ok N83 P15 B3
01:08:38.705 : N84 M105*27
01:08:38.720 : ok T:22.4 /0.0 B:75.0 /72.0 B@:0 @:0
01:08:48.751 : N85 M105*26
01:08:48.767 : ok T:22.5 /0.0 B:74.5 /72.0 B@:0 @:0 
01:08:50.884 : N86 M190 R72*98           // down 2.5° with R
01:08:50.901 : T:22.5 /0.0 B:74.4 /72.0 B@:0 @:0 W:?
01:08:51.901 : T:22.5 /0.0 B:74.3 /72.0 B@:0 @:0 W:?
01:08:52.884 : echo:busy: processing
01:08:52.899 : T:22.5 /0.0 B:74.2 /72.0 B@:0 @:0 W:?
01:08:53.898 : T:22.5 /0.0 B:74.0 /72.0 B@:0 @:0 W:?
01:08:54.898 : T:22.5 /0.0 B:74.0 /72.0 B@:0 @:0 W:?
01:08:54.898 : echo:busy: processing
01:08:55.898 : T:22.5 /0.0 B:73.9 /72.0 B@:0 @:0 W:?
01:08:56.897 : T:22.5 /0.0 B:73.7 /72.0 B@:0 @:0 W:?
01:08:56.897 : echo:busy: processing
01:08:57.896 : T:22.5 /0.0 B:73.7 /72.0 B@:0 @:0 W:?
01:08:58.896 : T:22.5 /0.0 B:73.5 /72.0 B@:0 @:0 W:?
01:08:58.896 : echo:busy: processing
01:08:59.896 : T:22.5 /0.0 B:73.5 /72.0 B@:0 @:0 W:?
01:09:00.894 : T:22.5 /0.0 B:73.4 /72.0 B@:0 @:0 W:?
01:09:00.894 : echo:busy: processing
01:09:01.894 : T:22.5 /0.0 B:73.2 /72.0 B@:0 @:0 W:?
01:09:02.893 : T:22.5 /0.0 B:73.2 /72.0 B@:0 @:0 W:?
01:09:02.893 : echo:busy: processing
01:09:03.893 : T:22.5 /0.0 B:73.1 /72.0 B@:0 @:0 W:?
01:09:04.897 : T:22.5 /0.0 B:73.0 /72.0 B@:0 @:0 W:9
01:09:04.897 : echo:busy: processing
01:09:05.892 : T:22.5 /0.0 B:72.9 /72.0 B@:0 @:0 W:8
01:09:06.896 : T:22.5 /0.0 B:72.7 /72.0 B@:0 @:0 W:7
01:09:06.896 : echo:busy: processing
01:09:07.896 : T:22.5 /0.0 B:72.7 /72.0 B@:0 @:0 W:6
01:09:08.893 : T:22.5 /0.0 B:72.6 /72.0 B@:0 @:0 W:5
01:09:08.893 : echo:busy: processing
01:09:09.893 : T:22.5 /0.0 B:72.4 /72.0 B@:32 @:0 W:4
01:09:10.892 : T:22.5 /0.0 B:72.4 /72.0 B@:16 @:0 W:3
01:09:10.892 : echo:busy: processing
01:09:11.892 : T:22.5 /0.0 B:72.3 /72.0 B@:44 @:0 W:2
01:09:12.891 : T:22.5 /0.0 B:72.2 /72.0 B@:58 @:0 W:1
01:09:12.891 : echo:busy: processing
01:09:13.891 : T:22.5 /0.0 B:72.1 /72.0 B@:60 @:0 W:0
01:09:14.707 : ok N86 P15 B3
01:09:14.707 : N87 M105*24
01:09:14.721 : ok T:22.5 /0.0 B:72.1 /72.0 B@:49 @:0
01:09:18.045 : N88 M190 R75*107              // up 3° with R
01:09:18.063 : T:22.5 /0.0 B:71.9 /75.0 B@:61 @:0 W:?
01:09:19.059 : T:22.5 /0.0 B:71.9 /75.0 B@:127 @:0 W:?
01:09:20.059 : T:22.5 /0.0 B:71.9 /75.0 B@:127 @:0 W:?
01:09:20.059 : echo:busy: processing
01:09:21.058 : T:22.5 /0.0 B:71.9 /75.0 B@:127 @:0 W:?
01:09:22.046 : echo:busy: processing
01:09:22.061 : T:22.5 /0.0 B:71.9 /75.0 B@:127 @:0 W:?
01:09:23.061 : T:22.5 /0.0 B:72.1 /75.0 B@:127 @:0 W:?
01:09:24.045 : echo:busy: processing
01:09:24.060 : T:22.5 /0.0 B:72.1 /75.0 B@:127 @:0 W:?
01:09:25.060 : T:22.5 /0.0 B:72.3 /75.0 B@:127 @:0 W:?
01:09:26.044 : echo:busy: processing
01:09:26.061 : T:22.5 /0.0 B:72.4 /75.0 B@:127 @:0 W:?
01:09:27.058 : T:22.5 /0.0 B:72.4 /75.0 B@:127 @:0 W:?
01:09:28.043 : echo:busy: processing
01:09:28.058 : T:22.5 /0.0 B:72.6 /75.0 B@:127 @:0 W:?
01:09:29.058 : T:22.5 /0.0 B:72.7 /75.0 B@:127 @:0 W:?
01:09:30.045 : echo:busy: processing
01:09:30.056 : T:22.5 /0.0 B:72.9 /75.0 B@:127 @:0 W:?
01:09:31.056 : T:22.5 /0.0 B:73.1 /75.0 B@:127 @:0 W:?
01:09:32.045 : echo:busy: processing
01:09:32.055 : T:22.5 /0.0 B:73.3 /75.0 B@:127 @:0 W:?
01:09:33.056 : T:22.5 /0.0 B:73.5 /75.0 B@:127 @:0 W:?
01:09:34.054 : T:22.5 /0.0 B:73.7 /75.0 B@:121 @:0 W:?
01:09:34.054 : echo:busy: processing
01:09:35.054 : T:22.5 /0.0 B:73.9 /75.0 B@:103 @:0 W:?
01:09:36.053 : T:22.5 /0.0 B:74.0 /75.0 B@:90 @:0 W:9
01:09:36.053 : echo:busy: processing
01:09:37.053 : T:22.5 /0.0 B:74.2 /75.0 B@:69 @:0 W:8
01:09:38.051 : T:22.5 /0.0 B:74.5 /75.0 B@:16 @:0 W:7
01:09:38.051 : echo:busy: processing
01:09:39.051 : T:22.5 /0.0 B:74.7 /75.0 B@:0 @:0 W:6
01:09:40.051 : T:22.5 /0.0 B:74.8 /75.0 B@:0 @:0 W:5
01:09:40.051 : echo:busy: processing
01:09:41.052 : T:22.5 /0.0 B:75.0 /75.0 B@:0 @:0 W:4
01:09:42.048 : T:22.5 /0.0 B:75.0 /75.0 B@:0 @:0 W:3
01:09:42.048 : echo:busy: processing
01:09:43.052 : T:22.5 /0.0 B:75.2 /75.0 B@:0 @:0 W:2
01:09:44.048 : T:22.5 /0.0 B:75.3 /75.0 B@:0 @:0 W:1
01:09:44.048 : echo:busy: processing
01:09:45.050 : T:22.5 /0.0 B:75.3 /75.0 B@:0 @:0 W:0
01:09:45.564 : ok N88 P15 B3
01:09:45.564 : N89 M105*22
01:09:45.579 : ok T:22.5 /0.0 B:75.3 /75.0 B@:0 @:0
01:09:49.034 : N90 M105*30
01:09:49.048 : ok T:22.5 /0.0 B:75.3 /75.0 B@:0 @:0
01:09:49.973 : N91 M190 S77*97               // up 2° with S
01:09:49.991 : T:22.5 /0.0 B:75.3 /77.0 B@:0 @:0 W:?
01:09:50.989 : T:22.5 /0.0 B:75.3 /77.0 B@:127 @:0 W:?
01:09:51.974 : echo:busy: processing
01:09:51.989 : T:22.5 /0.0 B:75.2 /77.0 B@:127 @:0 W:?
01:09:52.988 : T:22.5 /0.0 B:75.2 /77.0 B@:127 @:0 W:?
01:09:53.988 : T:22.5 /0.0 B:75.2 /77.0 B@:127 @:0 W:?
01:09:53.988 : echo:busy: processing
01:09:54.986 : T:22.5 /0.0 B:75.2 /77.0 B@:127 @:0 W:?
01:09:55.987 : T:22.5 /0.0 B:75.3 /77.0 B@:127 @:0 W:?
01:09:55.987 : echo:busy: processing
01:09:56.986 : T:22.5 /0.0 B:75.3 /77.0 B@:127 @:0 W:?
01:09:57.987 : T:22.5 /0.0 B:75.4 /77.0 B@:127 @:0 W:?
01:09:57.987 : echo:busy: processing
01:09:58.985 : T:22.5 /0.0 B:75.5 /77.0 B@:127 @:0 W:?
01:09:59.985 : T:22.5 /0.0 B:75.6 /77.0 B@:127 @:0 W:?
01:09:59.985 : echo:busy: processing
01:10:00.983 : T:22.5 /0.0 B:75.7 /77.0 B@:127 @:0 W:?
01:10:01.983 : T:22.5 /0.0 B:75.8 /77.0 B@:127 @:0 W:?
01:10:01.983 : echo:busy: processing
01:10:02.982 : T:22.5 /0.0 B:75.9 /77.0 B@:127 @:0 W:?
01:10:03.982 : T:22.5 /0.0 B:76.1 /77.0 B@:127 @:0 W:9
01:10:03.982 : echo:busy: processing
01:10:04.983 : T:22.5 /0.0 B:76.2 /77.0 B@:124 @:0 W:8
01:10:05.981 : T:22.5 /0.0 B:76.4 /77.0 B@:101 @:0 W:7
01:10:05.981 : echo:busy: processing
01:10:06.980 : T:22.5 /0.0 B:76.5 /77.0 B@:79 @:0 W:6
01:10:07.980 : T:22.5 /0.0 B:76.7 /77.0 B@:54 @:0 W:5
01:10:07.980 : echo:busy: processing
01:10:08.978 : T:22.5 /0.0 B:76.8 /77.0 B@:31 @:0 W:4
01:10:09.978 : T:22.5 /0.0 B:77.1 /77.0 B@:0 @:0 W:3
01:10:09.978 : echo:busy: processing
01:10:10.976 : T:22.5 /0.0 B:77.1 /77.0 B@:0 @:0 W:2
01:10:11.982 : T:22.5 /0.0 B:77.3 /77.0 B@:0 @:0 W:1
01:10:11.982 : echo:busy: processing
01:10:12.976 : T:22.5 /0.0 B:77.4 /77.0 B@:0 @:0 W:0
01:10:13.272 : ok N91 P15 B3
01:10:13.272 : N92 M105*28
01:10:13.311 : ok T:22.5 /0.0 B:77.4 /77.0 B@:0 @:0
01:10:19.169 : N93 M105*29
01:10:19.184 : ok T:22.5 /0.0 B:77.4 /77.0 B@:0 @:0
01:10:24.713 : N94 M104 T0 S0*28

Also tested M109 and M109 with pre heated bed. All without problems.
Even switching the bed to bang-bang did not make a difference.

Or, maybe, you just copied your old config over to RC6?

[edwilliams16]

I'm on
Marlin 1.1.0-RC6 - 24 April 2016

I'm not sure how I switched back to bang-bang on the bed - missed a change on Configuration.h I presume. However, when I tried to do an autotune, I got:
SENT: M303 E-1 C5 S95
RECEIVED: PID Autotune failed! Bad extruder number

which puzzles me.

[edwilliams16]

I'll go back to PID on the bed and see what happens.

[Blue-Marlin]

If your bed is in bang-bang mode you can't tune PID for the bed.

[edwilliams16]

OK. I had failed to enable PID on the bed when I was editing Configuration.h. I'm testing now with it on.
Should I be concerned about this?

RECEIVED: echo:  M200 D0
  Testing plaintext communication protocol...
  Testing binary communication protocol...
RECEIVED: echo:SD init fail
RECEIVED: ok
  Connected to machine!
SENT: T0
WARNING: CRC mismatch detected

[Blue-Marlin]

A missing or 0 TEMP_BED_RESIDENCY_TIME would explain the missing "W:"