Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

[BUG]: With Prusa MK4 connected , the plugin fails to detect idle state and doesnt turn off the plug. #336

Closed
kevman28 opened this issue Jun 2, 2023 · 21 comments
Labels
enhancement New feature or request solved workaround documented or fix applied

Comments

@kevman28
Copy link

kevman28 commented Jun 2, 2023

Describe the bug
With Prusa MK4 connected , the plugin fails to detect idle state and doesn't turn off the plug.

@jneilliii
Copy link
Owner

Please share screenshots of your overall settings and the individual plug's settings. Typically this is because you didn't enable the plug settings to turn off on idle.

@kevman28
Copy link
Author

kevman28 commented Jun 2, 2023

Please share screenshots of your overall settings and the individual plug's settings. Typically this is because you didn't enable the plug settings to turn off on idle.

2023-06-02 19_21_26-OctoPrint
2023-06-02 19_21_12-OctoPrint

@jneilliii
Copy link
Owner

great, wasn't what I thought. If you don't mind, I see you have debug logging enabled and as long as OctoPrint was restarted after enabling that you should see a file plugin_tplinksmartplug_debug.log in the logging section of OctoPrint's settings. just to double-check use the icon to power off/on the printer and after the amount of time has elapsed for the idle timeout to trigger, let's see what's in that file.

@kevman28
Copy link
Author

kevman28 commented Jun 3, 2023

[2023-06-03 11:41:16,284] DEBUG: IP 192.168.1.196 is valid.
[2023-06-03 11:41:16,290] DEBUG: IP 192.168.1.196 is valid.
[2023-06-03 11:41:16,336] DEBUG: TIM
[2023-06-03 11:41:46,506] DEBUG: Turning on 192.168.1.196/3.
[2023-06-03 11:41:46,509] DEBUG: {'autoConnect': True, 'autoConnectDelay': '14', 'autoDisconnect': True, 'autoDisconnectDelay': 0, 'automaticShutdownEnabled': True, 'btnColor': '#808080', 'countdownOffDelay': 1, 'countdownOnDelay': 1, 'currentState': 'on', 'displayWarning': True, 'emeter': {'get_realtime': {}}, 'event_on_disconnect': False, 'event_on_error': False, 'event_on_shutdown': False, 'event_on_startup': False, 'event_on_upload': True, 'gcodeCmdOff': False, 'gcodeCmdOn': False, 'gcodeEnabled': False, 'gcodeOffDelay': 0, 'gcodeOnDelay': 0, 'gcodeRunCmdOff': '', 'gcodeRunCmdOn': '', 'icon': 'icon-bolt', 'ip': '192.168.1.196/3', 'label': 'Mk4', 'sysCmdOff': False, 'sysCmdOffDelay': 0, 'sysCmdOn': False, 'sysCmdOnDelay': 0, 'sysRunCmdOff': '', 'sysRunCmdOn': '', 'thermal_runaway': False, 'useCountdownRules': False, 'warnPrinting': False}
[2023-06-03 11:41:46,509] DEBUG: IP 192.168.1.196 is valid.
[2023-06-03 11:41:46,526] DEBUG: IP 192.168.1.196 is valid.
[2023-06-03 11:41:46,569] DEBUG: «-ý"system":{"set_relay_state":{"err_code":0}}}
[2023-06-03 11:41:46,570] DEBUG: 0
[2023-06-03 11:41:46,571] DEBUG: Resetting idle timer since plug 192.168.1.196/3 was just turned on.
[2023-06-03 11:41:46,571] DEBUG: Checking status of 192.168.1.196/3.
[2023-06-03 11:41:46,572] DEBUG: IP 192.168.1.196 is valid.
[2023-06-03 11:41:46,581] DEBUG: IP 192.168.1.196 is valid.
[2023-06-03 11:41:46,629] DEBUG: TIM
[2023-06-03 11:43:00,804] DEBUG: Idle timeout reached after 1 minute(s). Turning heaters off prior to powering off plugs.
[2023-06-03 11:43:00,805] DEBUG: Heater tool0 already off.
[2023-06-03 11:43:00,805] DEBUG: Heater bed already off.
[2023-06-03 11:43:00,806] DEBUG: Turning off heater: X

@jneilliii
Copy link
Owner

jneilliii commented Jun 3, 2023

Turning off heater: X

This is a new one. If you go to your terminal tab in OctoPrint, please share a temperature report line. It appears they may have added something that option is trying to turn off and can't maybe.

The rest issue timer happens when you connect to the web interface, so that's kind of expected.

@kevman28
Copy link
Author

kevman28 commented Jun 4, 2023

Recv: FIRMWARE_NAME:Prusa-Firmware-Buddy 5.0.0-ALPHA1+11007 (Github) SOURCE_CODE_URL:https://github.com/prusa3d/Prusa-Firmware-Buddy PROTOCOL_VERSION:1.0 MACHINE_TYPE:Prusa-mini EXTRUDER_COUNT:5 UUID:
Recv: Cap:SERIAL_XON_XOFF:0
Recv: Cap:BINARY_FILE_TRANSFER:0
Recv: Cap:EEPROM:0
Recv: Cap:VOLUMETRIC:1
Recv: Cap:AUTOREPORT_TEMP:1
Recv: Cap:PROGRESS:0
Recv: Cap:PRINT_JOB:1
Recv: Cap:AUTOLEVEL:1
Recv: Cap:Z_PROBE:1
Recv: Cap:LEVELING_DATA:1
Recv: Cap:BUILD_PERCENT:0
Recv: Cap:SOFTWARE_POWER:1
Recv: Cap:TOGGLE_LIGHTS:0
Recv: Cap:CASE_LIGHT_BRIGHTNESS:0
Recv: Cap:EMERGENCY_PARSER:0
Recv: Cap:PROMPT_SUPPORT:0
Recv: Cap:AUTOREPORT_SD_STATUS:0
Recv: Cap:THERMAL_PROTECTION:1
Recv: Cap:MOTION_MODES:0
Recv: Cap:CHAMBER_TEMPERATURE:0
Recv: ok
Recv: ok
Send: M155 S2
Recv: ok
Recv: T:25.00/0.00 B:24.49/0.00 X:24.72/36.00 A:26.51/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.49/0.00 X:24.70/36.00 A:26.64/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.55/0.00 X:24.72/36.00 A:26.80/0.00 @:0 B@:0 HBR@:0
Recv: T:25.19/0.00 B:24.61/0.00 X:24.70/36.00 A:26.98/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.61/0.00 X:24.73/36.00 A:27.16/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.55/0.00 X:24.72/36.00 A:27.19/0.00 @:0 B@:0 HBR@:0
Recv: T:25.09/0.00 B:24.55/0.00 X:24.71/36.00 A:27.45/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.61/0.00 X:24.74/36.00 A:27.50/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.49/0.00 X:24.71/36.00 A:27.60/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.37/0.00 X:24.71/36.00 A:27.71/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.40/0.00 X:24.70/36.00 A:27.97/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.43/0.00 X:24.70/36.00 A:28.02/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.55/0.00 X:24.71/36.00 A:28.07/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.61/0.00 X:24.72/36.00 A:28.10/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.58/0.00 X:24.74/36.00 A:28.23/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.58/0.00 X:24.72/36.00 A:28.39/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.52/0.00 X:24.72/36.00 A:28.52/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.52/0.00 X:24.72/36.00 A:28.57/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.55/0.00 X:24.71/36.00 A:28.72/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.55/0.00 X:24.71/36.00 A:28.80/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.55/0.00 X:24.71/36.00 A:28.83/0.00 @:0 B@:0 HBR@:0
Recv: T:25.09/0.00 B:24.58/0.00 X:24.74/36.00 A:28.96/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.67/0.00 X:24.72/36.00 A:29.01/0.00 @:0 B@:0 HBR@:0
Recv: T:25.75/0.00 B:24.58/0.00 X:24.73/36.00 A:29.19/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.61/0.00 X:24.73/36.00 A:29.11/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.61/0.00 X:24.73/36.00 A:29.22/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.52/0.00 X:24.74/36.00 A:29.27/0.00 @:0 B@:0 HBR@:0
Recv: T:25.09/0.00 B:24.43/0.00 X:24.73/36.00 A:29.43/0.00 @:0 B@:0 HBR@:0
Recv: T:25.09/0.00 B:24.61/0.00 X:24.74/36.00 A:29.51/0.00 @:0 B@:0 HBR@:0
Recv: T:26.22/0.00 B:24.64/0.00 X:24.73/36.00 A:29.56/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.61/0.00 X:24.73/36.00 A:29.66/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.61/0.00 X:24.73/36.00 A:29.66/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.67/0.00 X:24.74/36.00 A:29.79/0.00 @:0 B@:0 HBR@:0
Recv: T:25.47/0.00 B:24.49/0.00 X:24.73/36.00 A:29.84/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.52/0.00 X:24.74/36.00 A:29.92/0.00 @:0 B@:0 HBR@:0
Recv: T:25.09/0.00 B:24.52/0.00 X:24.74/36.00 A:29.95/0.00 @:0 B@:0 HBR@:0
Recv: T:25.47/0.00 B:24.64/0.00 X:24.75/36.00 A:30.04/0.00 @:0 B@:0 HBR@:0
Recv: T:25.47/0.00 B:24.55/0.00 X:24.73/36.00 A:30.04/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.55/0.00 X:24.73/36.00 A:30.02/0.00 @:0 B@:0 HBR@:0
Recv: T:25.19/0.00 B:24.55/0.00 X:24.74/36.00 A:30.17/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.55/0.00 X:24.70/36.00 A:30.15/0.00 @:0 B@:0 HBR@:0
Recv: T:25.19/0.00 B:24.49/0.00 X:24.72/36.00 A:30.21/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.52/0.00 X:24.73/36.00 A:30.27/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.58/0.00 X:24.75/36.00 A:30.31/0.00 @:0 B@:0 HBR@:0
Recv: T:25.56/0.00 B:24.58/0.00 X:24.75/36.00 A:30.40/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.58/0.00 X:24.73/36.00 A:30.35/0.00 @:0 B@:0 HBR@:0
Recv: T:25.75/0.00 B:24.52/0.00 X:24.73/36.00 A:30.44/0.00 @:0 B@:0 HBR@:0
Recv: T:26.03/0.00 B:24.52/0.00 X:24.74/36.00 A:30.48/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.55/0.00 X:24.75/36.00 A:30.56/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.55/0.00 X:24.74/36.00 A:30.62/0.00 @:0 B@:0 HBR@:0
Recv: T:25.19/0.00 B:24.55/0.00 X:24.75/36.00 A:30.62/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.58/0.00 X:24.74/36.00 A:30.71/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.58/0.00 X:24.74/36.00 A:30.69/0.00 @:0 B@:0 HBR@:0
Recv: T:25.09/0.00 B:24.58/0.00 X:24.75/36.00 A:30.75/0.00 @:0 B@:0 HBR@:0
Recv: T:25.00/0.00 B:24.52/0.00 X:24.73/36.00 A:30.81/0.00 @:0 B@:0 HBR@:0
Sen

@jneilliii
Copy link
Owner

Do you happen to know what X is in that report?

@jneilliii
Copy link
Owner

and A for that matter.

@kevman28
Copy link
Author

kevman28 commented Jun 6, 2023

haha no idea...this is a prusa Mk4 so its different I guess?

@jneilliii
Copy link
Owner

Yeah, it's new and the idle timer keeps getting reset because the "target" is never able to be turned off. @kantlivelong will probably want to know about this as well, as I borrowed that idle timer code from PSU Control.

@kantlivelong
Copy link

kantlivelong commented Jun 8, 2023

Going to need full logs rather than snippets. Requested a new ticket be opened in the core plugin repo supplying all info.

Edit: As mentioned in the ticket, if you're not actually using PSUControl then instead supply full debug logs for TPLinkSmartplug.

@github-actions
Copy link

This issue has been automatically marked as stale because it has not had activity in 14 days. It will be closed if no further activity occurs in 7 days

@github-actions github-actions bot added the stale issues without activity label Jun 23, 2023
@github-actions github-actions bot closed this as not planned Won't fix, can't repro, duplicate, stale Jul 1, 2023
@jneilliii jneilliii added enhancement New feature or request and removed stale issues without activity labels Jul 1, 2023
@jneilliii jneilliii reopened this Jul 1, 2023
@jneilliii
Copy link
Owner

re-opening this request @kevman28 as it is possible for me to work around this issue, just odd that Prusa is sending those additional temperatures.

@jneilliii
Copy link
Owner

I've added a setting in the latest 1.0.4rc2 release that allows for setting heaters to be ignored coming from that temperature report. You should be able to add X to that setting to allow it to be ignored and the idle timeout work again.

image

You can change the plugin's release channel in OctoPrint's Software Update settings to Release Candidate and upgrade when prompted to get the change and validate it's working again with the above setting.

If it does work, please report back here and to the Prusa Forum post about OctoPrint compatibility that I saw you mentioning this issue as well.

@jneilliii jneilliii added the solved workaround documented or fix applied label Jul 1, 2023
@kevman28
Copy link
Author

kevman28 commented Jul 2, 2023

Thank you! I will test this out today and report back.

EDIT2: it works somewhat I think , after a cancelled job it did exactly what it was setup for. However when I turn on thej printer and let it sit without any jobs it tends to stay on. not sure if this is by design or something else is missed in the output

Here is my log - it turned off after a cancelled print

[2023-07-02 09:19:40,041] DEBUG: Print cancelled, resetting job_power to 0
[2023-07-02 09:20:44,701] DEBUG: Idle timeout reached after 1 minute(s). Turning heaters off prior to powering off plugs.
[2023-07-02 09:20:44,704] DEBUG: Heater tool0 already off.
[2023-07-02 09:20:44,705] DEBUG: Heater bed already off.
[2023-07-02 09:20:44,705] DEBUG: Heater A already off.
[2023-07-02 09:20:44,706] DEBUG: Heater tool0 = 190.67C
....
[2023-07-02 09:29:25,586] DEBUG: Heater tool0 = 50.04C
[2023-07-02 09:29:25,587] DEBUG: Waiting for heaters(tool0) before shutting power off...
[2023-07-02 09:29:30,594] DEBUG: Heater tool0 = 49.06C
[2023-07-02 09:29:30,597] DEBUG: Heaters below temperature.
[2023-07-02 09:29:30,598] DEBUG: Checking for timelapse running.
[2023-07-02 09:29:30,598] DEBUG: Checking timelapse status before shutting off power...
[2023-07-02 09:29:30,599] DEBUG: Starting abort power off timer.
[2023-07-02 09:30:00,641] DEBUG: Automatically powering off enabled plugs.
[2023-07-02 09:30:00,644] DEBUG: Turning off 192.168.1.196/3.
[2023-07-02 09:30:00,645] INFO: Turning off 192.168.1.196/3 at 2023-07-02 09:30:00.644158
[2023-07-02 09:30:00,648] DEBUG: {'autoConnect': True, 'autoConnectDelay': '14', 'autoDisconnect': True, 'autoDisconnectDelay': 0, 'automaticShutdownEnabled': True, 'btnColor': '#808080', 'countdownOffDelay': 1, 'countdownOnDelay': 1, 'currentState': 'on', 'displayWarning': True, 'emeter': {'get_realtime': {}}, 'event_on_disconnect': False, 'event_on_error': False, 'event_on_shutdown': False, 'event_on_startup': False, 'event_on_upload': True, 'gcodeCmdOff': False, 'gcodeCmdOn': False, 'gcodeEnabled': False, 'gcodeOffDelay': 0, 'gcodeOnDelay': 0, 'gcodeRunCmdOff': '', 'gcodeRunCmdOn': '', 'icon': 'icon-bolt', 'ip': '192.168.1.196/3', 'label': 'Mk4', 'sysCmdOff': False, 'sysCmdOffDelay': 0, 'sysCmdOn': False, 'sysCmdOnDelay': 0, 'sysRunCmdOff': '', 'sysRunCmdOn': '', 'thermal_runaway': False, 'useCountdownRules': False, 'warnPrinting': False}

@kevman28 kevman28 closed this as completed Jul 2, 2023
@jneilliii jneilliii reopened this Jul 2, 2023
@jneilliii
Copy link
Owner

please share updated log after upgrading to debug why it's still not working as anticipated.

@kevman28
Copy link
Author

kevman28 commented Jul 2, 2023

I'm happy to report that this is resolved completely with the MK4 in the release candidate. Thank you for your great efforts here.

@ScottWell1
Copy link

I know this is closed but wanted to add some info about the MK4 temperature report format in case someone comes across it when searching.

The "X:" is the heatbreak temperature (actual / target). Heatbreak target is set with "M142 Snn". The firmware controls the heatbreak fan speed in an attempt to keep it at or below the target temp.

The "A:" is the controller board (MK4 "buddy board") temperature. If Prusa followed the same design as for their MINI model, the thermistor is located adjacent to the high-load connection for the heated bed - but I do not have confirmation of that yet. Only actual temp is reported (target is always 0).

@timur-tabi
Copy link

I think this problem might affect MK3 as well. My printer also no longer turns off on idle. Here's what the terminal outputs:

Recv: T:28.1 /0.0 B:27.9 /0.0 T0:28.1 /0.0 @:0 B@:0 P:28.8 A:34.8
Recv: T:27.9 /0.0 B:27.9 /0.0 T0:27.9 /0.0 @:0 B@:0 P:29.0 A:33.9
Recv: T:27.9 /0.0 B:27.6 /0.0 T0:27.9 /0.0 @:0 B@:0 P:29.0 A:34.4
Recv: T:28.0 /0.0 B:28.0 /0.0 T0:28.0 /0.0 @:0 B@:0 P:29.1 A:34.6

@jneilliii
Copy link
Owner

jneilliii commented Nov 6, 2023

Looks like you will probably need the release candidate as well and add the P,A to the ignore heaters line.

@timur-tabi
Copy link

I take that back. My printer just turned off by itself. I guess I just didn't wait as long as I thought I did.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
enhancement New feature or request solved workaround documented or fix applied
Projects
None yet
Development

No branches or pull requests

5 participants