Unable to upload prints SD card initialization fails as well

TopsideLLC · April 11, 2020, 2:21pm

What is the problem?
Went out to test cuts and was unable to pull up any files in the Printoid App, went inside to check and found that the web interface I was uploading the files to was stuck on "saving". All files disappeared and the free space/space total was now dashed.

What did you already try to solve it?
Rebooted Octoprint, restarted in safe mode. Shutdown system and reseated SD card.

Logs (octoprint.log, serial.log or output on terminal tab at a minimum, browser error console if UI issue ... no logs, no support!)

Connecting to: /dev/ttyACM0
Changing monitoring state from "Offline" to "Opening serial port"
Connected to: Serial<id=0x7167d330, open=True>(port='/dev/ttyACM0', baudrate=250000, bytesize=8, parity='N', stopbits=1, timeout=10.0, xonxoff=False, rtscts=False, dsrdtr=False), starting monitor
Changing monitoring state from "Opening serial port" to "Connecting"
Send: N0 M110 N0125
Recv: start
Recv: echo:Marlin 414 bugfix-2.0.x
Recv:
Recv: echo: Last Updated: 2019-10-18 | Author: (V1 Engineering, Ryan, 414)
Send: N0 M110 N0125
Recv: echo:Compiled: Dec 18 2019
Recv: echo: Free Memory: 3474 PlannerBufferBytes: 1472
Recv: echo:SD init fail
Recv: echo:Hardcoded Default Settings Loaded
Recv: echo: G21 ; Units in mm (mm)
Recv: echo: M149 C ; Units in Celsius
Recv:
Recv: echo:Filament settings: Disabled
Recv: echo: M200 D3.00
Recv: echo: M200 D0
Recv: echo:Steps per unit:
Recv: echo: M92 X100.00 Y100.00 Z400.00 E100.00
Recv: echo:Maximum feedrates (units/s):
Recv: echo: M203 X120.00 Y120.00 Z30.00 E25.00
Recv: echo:Maximum Acceleration (units/s2):
Recv: echo: M201 X400.00 Y400.00 Z100.00 E2000.00
Recv: echo:Acceleration (units/s2): P<print_accel> R<retract_accel> T<travel_accel>
Recv: echo: M204 P400.00 R3000.00 T400.00
Recv: echo:Advanced: B<min_segment_time_us> S<min_feedrate> T<min_travel_feedrate> J<junc_dev>
Recv: echo: M205 B20000.00 S0.00 T0.00 J0.10
Recv: echo:Home offset:
Recv: echo: M206 X0.00 Y0.00 Z0.00
Recv: echo:Material heatup parameters:
Recv: echo: M145 S0 H196 B92 F0
Recv: echo: M145 S1 H240 B110 F0
Recv: echo:PID settings:
Recv: echo: M301 P17.98 I0.98 D83.62
Recv: echo:Stepper motor currents:
Recv: echo: M907 X900 Z900 E900
Recv: ok
Send: N0 M110 N0125
Changing monitoring state from "Connecting" to "Operational"
Recv: echo:Unknown command: ""
Recv: ok
Send: N0 M110 N0125
Recv: ok
Send: N1 M115*39
Recv: FIRMWARE_NAME:Marlin 414 bugfix-2.0.x (GitHub) SOURCE_CODE_URL:https://github.com/MarlinFirmware/Marlin PROTOCOL_VERSION:1.0 MACHINE_TYPE:V1 E CNC EXTRUDER_COUNT:1 UUID:cede2a2f-41a2-4748-9b12-c55c62f367ff
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:0
Recv: Cap:Z_PROBE:0
Recv: Cap:LEVELING_DATA:0
Recv: Cap:BUILD_PERCENT:0
Recv: Cap:SOFTWARE_POWER:0
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:1
Recv: Cap:CHAMBER_TEMPERATURE:0
Recv: ok
Send: M21
Recv: echo:SD init fail
Recv: ok
Send: M155 S2
Recv: ok
Recv: T:170.00 /0.00 @:0
Recv: T:170.00 /0.00 @:0
Recv: T:170.00 /0.00 @:0
Recv: T:170.00 /0.00 @:0

Additional information about your setup (OctoPrint version, OctoPi version, printer, firmware, browser, operating system, ... as much data as possible) Octoprint 1.4.0 using a Marlin Mini-Rambo controlled MPCNC, Chrome Browser, Win10

TopsideLLC · April 14, 2020, 2:48pm

I've switched to a different Pi, and new SD card and still encountering the same issue. When I first start it up after being shutdown unplugged and started, it shows my files and shows the space available. As soon as I try to upload a file from a computer, it gets stuck on saving and lose access to the files on any other computer or the Printoid App on my Android device.

PrintedWeezl · April 15, 2020, 1:13am

Did you try it with your computer on a fresh install?
The printoid app could cause issues.

We need a octoprint.log of the time the error occurs.
I guess it should be on a fresh install because you might get a different output when it happens the second time.

foosel · April 15, 2020, 6:13am

And also a serial.log

TopsideLLC · April 25, 2020, 3:10pm

octoprint.log

2020-04-25 15:53:09,485 - octoprint.server.heartbeat - INFO - Server heartbeat <3
2020-04-25 15:53:09,510 - octoprint.server - INFO - --- Log roll over detected ---------------------------------------------------
2020-04-25 15:53:09,511 - octoprint.server - INFO - OctoPrint 1.4.0
2020-04-25 15:53:09,514 - octoprint.plugin.core - INFO - 15 plugin(s) registered with the system:
|  Action Command Prompt Support (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/action_command_prompt
|  Announcement Plugin (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/announcements
|  Anonymous Usage Tracking (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/tracking
|  Application Keys Plugin (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/appkeys
|  Backup & Restore (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/backup
|  Core Wizard (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/corewizard
|  Discovery (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/discovery
|  Error Tracking (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/errortracking
|  Logging (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/logging
|  Login UI (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/loginui
|  Pi Support Plugin (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/pi_support
|  Plugin Manager (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/pluginmanager
|  Printer Safety Check (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/printer_safety_check
|  Software Update (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/softwareupdate
|  Virtual Printer (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/virtual_printer
Prefix legend: ! = disabled, # = blacklisted, * = incompatible
2020-04-25 15:53:09,527 - octoprint.environment - INFO - Detected environment is Python 2.7.16 under Linux (linux2). Details:
|  hardware:
|      cores: 4
|      freq: 1200.0
|      ram: 917016576
|  os:
|      id: linux
|      platform: linux2
|  plugins:
|      pi_support:
|          model: Raspberry Pi 3 Model B Rev 1.2
|  python:
|      pip: 19.3.1
|      version: 2.7.16
|      virtualenv: /home/pi/oprint
2020-04-25 15:53:09,528 - octoprint.server - INFO - ------------------------------------------------------------------------------
2020-04-25 15:53:20,305 - octoprint.plugins.tracking - INFO - Sent tracking event pong, payload: {'plugins': u''}
2020-04-25 15:53:21,118 - octoprint.plugins.tracking - INFO - Sent tracking event ping, payload: {'octoprint_uptime': 22}
2020-04-25 15:53:25,147 - octoprint.server.preemptive_cache - INFO - ... done in 18.93s
2020-04-25 15:53:25,149 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://192.168.2.21:4080/'}
2020-04-25 15:53:27,819 - octoprint.server.preemptive_cache - INFO - ... done in 2.67s
2020-04-25 15:53:27,820 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://192.168.2.29:4080/'}
2020-04-25 15:53:30,501 - octoprint.server.preemptive_cache - INFO - ... done in 2.68s
2020-04-25 15:53:30,502 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://192.168.2.30:4080/'}
2020-04-25 15:53:33,280 - octoprint.server.preemptive_cache - INFO - ... done in 2.78s
2020-04-25 15:55:26,292 - octoprint.filemanager.analysis - INFO - Analysis of entry local:SLCValley_test.gcode finished, needed 152.94s
2020-04-25 15:55:44,236 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.2.16
2020-04-25 15:55:48,302 - octoprint.access.users - INFO - Logged in user: MPCNC
2020-04-25 15:55:48,308 - octoprint.server.api - INFO - Actively logging in user MPCNC from ::ffff:192.168.2.16
2020-04-25 15:55:48,381 - octoprint.server.util.flask - INFO - Passively logging in user MPCNC from ::ffff:192.168.2.16
2020-04-25 15:55:48,382 - octoprint.access.users - INFO - Logged in user: MPCNC
2020-04-25 15:55:48,423 - octoprint.server.util.flask.PreemptiveCache - INFO - Adding entry for / and {'query_string': u'l10n=en', 'path': u'/', u'_count': 1, u'_timestamp': 1587826548.423734, 'base_url': u'http://192.168.2.12:4080/'}
2020-04-25 15:55:50,577 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:192.168.2.16
2020-04-25 15:55:52,351 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.2.16
2020-04-25 15:55:52,485 - octoprint.server.util.flask - INFO - Passively logging in user MPCNC from ::ffff:192.168.2.16
2020-04-25 15:55:52,486 - octoprint.access.users - INFO - Logged in user: MPCNC
2020-04-25 15:55:53,983 - octoprint.plugins.announcements - INFO - Loaded channel _important from https://octoprint.org/feeds/important.xml in 0.74s
2020-04-25 15:55:55,203 - octoprint.plugins.announcements - INFO - Loaded channel _releases from https://octoprint.org/feeds/releases.xml in 0.92s
2020-04-25 15:55:56,995 - octoprint.plugins.announcements - INFO - Loaded channel _blog from https://octoprint.org/feeds/octoblog.xml in 0.77s
2020-04-25 15:55:57,988 - octoprint.plugins.announcements - INFO - Loaded channel _plugins from https://plugins.octoprint.org/feed.xml in 0.9s
2020-04-25 15:55:58,948 - octoprint.plugins.announcements - INFO - Loaded channel _octopi from https://octoprint.org/feeds/octopi.xml in 0.82s
2020-04-25 15:56:00,418 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from https://plugins.octoprint.org/plugins.json
2020-04-25 15:56:02,371 - octoprint.plugins.pluginmanager - INFO - Loaded plugin notices data from https://plugins.octoprint.org/notices.json
2020-04-25 15:56:03,380 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk
2020-04-25 15:56:03,461 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 69.58ms
2020-04-25 15:56:15,000 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 57.99ms
2020-04-25 15:56:16,449 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 32.27ms
2020-04-25 15:56:27,051 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 79.44ms
2020-04-25 15:56:28,614 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 48.49ms
2020-04-25 15:56:41,851 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 33.71ms
2020-04-25 15:57:02,775 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 33.52ms
2020-04-25 15:57:12,653 - tornado.access - ERROR - 500 GET /api/files?recursive=true&force=true (::ffff:192.168.2.16) 72.88ms
2020-04-25 15:57:30,894 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 82.07ms
2020-04-25 15:58:38,322 - octoprint.startup - INFO - ******************************************************************************
2020-04-25 15:58:38,325 - octoprint.startup - INFO - Starting OctoPrint 1.4.0
2020-04-25 15:58:38,325 - octoprint.startup - INFO - ******************************************************************************
2020-04-25 15:58:39,195 - octoprint.startup - INFO - We don't appear to be online, not fetching plugin blacklist
2020-04-25 15:58:39,347 - octoprint.plugin.core - INFO - Loading plugins from /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins, /home/pi/.octoprint/plugins and installed plugin packages...
2020-04-25 15:58:41,473 - octoprint.plugin.core - INFO - Found 15 plugin(s) providing 15 mixin implementations, 27 hook handlers
2020-04-25 15:58:41,741 - octoprint.server.heartbeat - INFO - Starting server heartbeat, 900.0s interval
2020-04-25 15:58:41,794 - octoprint.server - INFO - Intermediary server started
2020-04-25 15:58:41,795 - octoprint.plugin.core - INFO - Loading plugins from /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins, /home/pi/.octoprint/plugins and installed plugin packages...
2020-04-25 15:58:41,942 - octoprint.plugin.core - INFO - Found 15 plugin(s) providing 15 mixin implementations, 27 hook handlers
2020-04-25 15:58:41,982 - octoprint.filemanager.storage - INFO - Initializing the file metadata for /home/pi/.octoprint/uploads...
2020-04-25 15:58:41,990 - octoprint.filemanager.storage - INFO - Deleted 1 stale or invalid entries from metadata for path /home/pi/.octoprint/uploads
2020-04-25 15:58:43,311 - octoprint.filemanager.storage - INFO - ... file metadata for /home/pi/.octoprint/uploads initialized successfully.
2020-04-25 15:58:43,317 - octoprint.server - INFO - Added new permission from plugin action_command_prompt: PLUGIN_ACTION_COMMAND_PROMPT_INTERACT (needs: u"Need(method='role', value=u'plugin_action_command_prompt_interact')")
2020-04-25 15:58:43,318 - octoprint.server - INFO - Added new permission from plugin announcements: PLUGIN_ANNOUNCEMENTS_READ (needs: u"Need(method='role', value=u'plugin_announcements_read')")
2020-04-25 15:58:43,320 - octoprint.server - INFO - Added new permission from plugin announcements: PLUGIN_ANNOUNCEMENTS_MANAGE (needs: u"Need(method='role', value=u'plugin_announcements_manage'), Need(method='role', value=u'plugin_announcements_read')")
2020-04-25 15:58:43,322 - octoprint.server - INFO - Added new permission from plugin appkeys: PLUGIN_APPKEYS_ADMIN (needs: u"Need(method='role', value=u'plugin_appkeys_admin')")
2020-04-25 15:58:43,323 - octoprint.server - INFO - Added new permission from plugin backup: PLUGIN_BACKUP_ACCESS (needs: u"Need(method='role', value=u'plugin_backup_access')")
2020-04-25 15:58:43,324 - octoprint.server - INFO - Added new permission from plugin logging: PLUGIN_LOGGING_MANAGE (needs: u"Need(method='role', value=u'plugin_logging_manage')")
2020-04-25 15:58:43,327 - octoprint.server - INFO - Added new permission from plugin pi_support: PLUGIN_PI_SUPPORT_STATUS (needs: u"Need(method='role', value=u'plugin_pi_support_check')")
2020-04-25 15:58:43,329 - octoprint.server - INFO - Added new permission from plugin pluginmanager: PLUGIN_PLUGINMANAGER_MANAGE (needs: u"Need(method='role', value=u'plugin_pluginmanager_manage')")
2020-04-25 15:58:43,331 - octoprint.server - INFO - Added new permission from plugin pluginmanager: PLUGIN_PLUGINMANAGER_INSTALL (needs: u"Need(method='role', value=u'plugin_pluginmanager_install'), Need(method='role', value=u'plugin_pluginmanager_manage')")
2020-04-25 15:58:43,333 - octoprint.server - INFO - Added new permission from plugin printer_safety_check: PLUGIN_PRINTER_SAFETY_CHECK_DISPLAY (needs: u"Need(method='role', value=u'plugin_printer_safety_check_display')")
2020-04-25 15:58:43,335 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_CHECK (needs: u"Need(method='role', value=u'plugin_softwareupdate_check')")
2020-04-25 15:58:43,336 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_UPDATE (needs: u"Need(method='role', value=u'plugin_softwareupdate_update')")
2020-04-25 15:58:43,408 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk
2020-04-25 15:58:44,791 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip
2020-04-25 15:58:45,988 - octoprint.util.pip - INFO - Version of pip is 19.3.1
2020-04-25 15:58:45,991 - octoprint.util.pip - INFO - pip installs to /home/pi/oprint/lib/python2.7/site-packages (writable -> yes), --user flag needed -> no, virtual env -> yes
2020-04-25 15:58:45,991 - octoprint.util.pip - INFO - ==> pip ok -> yes
2020-04-25 15:58:45,998 - octoprint.plugin.core - INFO - Initialized 15 plugin implementation(s)
2020-04-25 15:58:46,012 - octoprint.plugin.core - INFO - 15 plugin(s) registered with the system:
|  Action Command Prompt Support (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/action_command_prompt
|  Announcement Plugin (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/announcements
|  Anonymous Usage Tracking (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/tracking
|  Application Keys Plugin (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/appkeys
|  Backup & Restore (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/backup
|  Core Wizard (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/corewizard
|  Discovery (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/discovery
|  Error Tracking (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/errortracking
|  Logging (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/logging
|  Login UI (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/loginui
|  Pi Support Plugin (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/pi_support
|  Plugin Manager (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/pluginmanager
|  Printer Safety Check (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/printer_safety_check
|  Software Update (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/softwareupdate
|  Virtual Printer (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/virtual_printer
Prefix legend: ! = disabled, # = blacklisted, * = incompatible
2020-04-25 15:58:46,030 - octoprint.environment - INFO - Detected environment is Python 2.7.16 under Linux (linux2). Details:
|  hardware:
|      cores: 4
|      freq: 1200.0
|      ram: 917016576
|  os:
|      id: linux
|      platform: linux2
|  plugins:
|      pi_support:
|          model: Raspberry Pi 3 Model B Rev 1.2
|  python:
|      pip: 19.3.1
|      version: 2.7.16
|      virtualenv: /home/pi/oprint
2020-04-25 15:58:46,072 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/webassets...
2020-04-25 15:58:46,095 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/.webassets-cache...
2020-04-25 15:58:47,130 - octoprint.server - INFO - Shutting down intermediary server...
2020-04-25 15:58:47,456 - octoprint.server - INFO - Intermediary server shut down
2020-04-25 15:58:47,459 - octoprint.events - INFO - Processing startup event, this is our first event
2020-04-25 15:58:47,461 - octoprint.events - INFO - Adding 0 events to queue that were held back before startup event
2020-04-25 15:58:47,463 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2020-04-25 15:58:47,464 - octoprint.server - INFO - Autoconnect on startup is configured, trying to connect to the printer...
2020-04-25 15:58:47,535 - octoprint.filemanager.analysis - INFO - Starting analysis of local:SLCValley_test.gcode
2020-04-25 15:58:47,538 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/pi/oprint/bin/python2 -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.01 --throttle-lines=100 /home/pi/.octoprint/uploads/SLCValley_test.gcode
2020-04-25 15:58:47,594 - octoprint.filemanager - INFO - Added 2 items from storage type "local" to analysis queue
2020-04-25 15:58:47,652 - octoprint.server - INFO - Trying to connect to configured serial port /dev/ttyACM0
2020-04-25 15:58:47,714 - octoprint.server.util.watchdog - INFO - Running initial scan on watched folder...
2020-04-25 15:58:47,724 - octoprint.util.comm - INFO - Changing monitoring state from "Offline" to "Opening serial port"
2020-04-25 15:58:47,737 - octoprint.util.comm - INFO - Changing monitoring state from "Opening serial port" to "Connecting"
2020-04-25 15:58:47,732 - octoprint.server.util.watchdog - INFO - ... initial scan done.
2020-04-25 15:58:47,744 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on v1pi' for _http._tcp
2020-04-25 15:58:47,748 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-04-25 15:58:47,765 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on v1pi' for _octoprint._tcp
2020-04-25 15:58:47,783 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on v1pi for SSDP
2020-04-25 15:58:47,832 - octoprint.server - INFO - Listening on http://127.0.0.1:5000
2020-04-25 15:58:47,885 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2020-04-25 15:58:48,928 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-04-25 15:58:49,352 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip
2020-04-25 15:58:49,354 - octoprint.util.pip - INFO - pip installs to /home/pi/oprint/lib/python2.7/site-packages (writable -> yes), --user flag needed -> no, virtual env -> yes
2020-04-25 15:58:49,374 - octoprint.util.pip - INFO - ==> pip ok -> yes
2020-04-25 15:58:49,446 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid
2020-04-25 15:58:53,576 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip
2020-04-25 15:58:56,237 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 41162), not sending a M-SEARCH reply
2020-04-25 15:58:56,824 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-04-25 15:58:56,830 - octoprint.util.comm - INFO - Changing monitoring state from "Connecting" to "Operational"
2020-04-25 15:58:56,842 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-04-25 15:58:56,873 - octoprint.util.comm - INFO - Printer reports firmware name "Marlin 414 bugfix-2.0.x (GitHub)"
2020-04-25 15:58:56,892 - octoprint.util.comm - INFO - Firmware states that it supports temperature autoreporting
2020-04-25 15:59:06,247 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 41162), not sending a M-SEARCH reply
2020-04-25 15:59:13,741 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 55723), not sending a M-SEARCH reply
2020-04-25 15:59:13,747 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 55723), not sending a M-SEARCH reply
2020-04-25 15:59:15,742 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 51043), not sending a M-SEARCH reply
2020-04-25 15:59:15,746 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 51043), not sending a M-SEARCH reply
2020-04-25 15:59:16,233 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 41162), not sending a M-SEARCH reply
2020-04-25 15:59:17,588 - octoprint.util.pip - INFO - pip installs to /home/pi/oprint/lib/python2.7/site-packages/ (writable -> yes), --user flag needed -> no, virtual env -> yes
2020-04-25 15:59:17,589 - octoprint.util.pip - INFO - ==> pip ok -> yes
2020-04-25 15:59:17,609 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk
2020-04-25 15:59:17,761 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 51491), not sending a M-SEARCH reply
2020-04-25 15:59:17,765 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 51491), not sending a M-SEARCH reply
2020-04-25 15:59:17,797 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://192.168.2.12:4080/'}
2020-04-25 15:59:26,272 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 41162), not sending a M-SEARCH reply
2020-04-25 15:59:35,233 - octoprint.server.preemptive_cache - INFO - ... done in 17.44s
2020-04-25 15:59:36,240 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 41162), not sending a M-SEARCH reply
2020-04-25 15:59:46,237 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 41162), not sending a M-SEARCH reply
2020-04-25 15:59:56,244 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 41162), not sending a M-SEARCH reply
2020-04-25 16:00:06,259 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 41162), not sending a M-SEARCH reply
2020-04-25 16:00:13,778 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 55910), not sending a M-SEARCH reply
2020-04-25 16:00:13,782 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 55910), not sending a M-SEARCH reply
2020-04-25 16:00:15,743 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 37387), not sending a M-SEARCH reply
2020-04-25 16:00:15,747 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 37387), not sending a M-SEARCH reply
2020-04-25 16:00:16,236 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 41162), not sending a M-SEARCH reply
2020-04-25 16:00:17,774 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 56202), not sending a M-SEARCH reply
2020-04-25 16:00:17,781 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 56202), not sending a M-SEARCH reply
2020-04-25 16:00:26,262 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 41162), not sending a M-SEARCH reply
2020-04-25 16:00:27,503 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.2.16
2020-04-25 16:00:32,204 - octoprint.access.users - INFO - Logged in user: MPCNC
2020-04-25 16:00:32,206 - octoprint.server.api - INFO - Actively logging in user MPCNC from ::ffff:192.168.2.16
2020-04-25 16:00:32,267 - octoprint.server.util.flask - INFO - Passively logging in user MPCNC from ::ffff:192.168.2.16
2020-04-25 16:00:32,268 - octoprint.access.users - INFO - Logged in user: MPCNC
2020-04-25 16:00:32,295 - octoprint.server.util.flask.PreemptiveCache - INFO - Adding entry for / and {'query_string': u'l10n=en', 'path': u'/', u'_count': 1, u'_timestamp': 1587826832.295436, 'base_url': u'http://169.254.55.97:4080/'}
2020-04-25 16:00:35,005 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:192.168.2.16
2020-04-25 16:00:36,348 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('192.168.2.15', 41162), not sending a M-SEARCH reply
2020-04-25 16:00:37,533 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.2.16
2020-04-25 16:00:37,616 - octoprint.server.util.flask - INFO - Passively logging in user MPCNC from ::ffff:192.168.2.16
2020-04-25 16:00:37,617 - octoprint.access.users - INFO - Logged in user: MPCNC
2020-04-25 16:00:43,328 - octoprint.server.util.sockjs - INFO - User MPCNC logged in on the socket from client ::ffff:192.168.2.16
2020-04-25 16:01:30,150 - octoprint.filemanager.analysis - INFO - Analysis of entry local:SLCValley_test.gcode finished, needed 153.06s
2020-04-25 16:01:31,168 - octoprint.filemanager.analysis - INFO - Starting analysis of local:SLCValley_1_1.gcode
2020-04-25 16:01:31,173 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/pi/oprint/bin/python2 -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.01 --throttle-lines=100 /home/pi/.octoprint/uploads/SLCValley_1_1.gcode
2020-04-25 16:02:31,053 - octoprint.server.util.flask - INFO - Passively logging in user MPCNC from ::ffff:192.168.2.16
2020-04-25 16:02:31,055 - octoprint.access.users - INFO - Logged in user: MPCNC
2020-04-25 16:02:33,712 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.2.16
2020-04-25 16:02:33,803 - octoprint.server.util.flask - INFO - Passively logging in user MPCNC from ::ffff:192.168.2.16
2020-04-25 16:02:33,805 - octoprint.access.users - INFO - Logged in user: MPCNC
2020-04-25 16:02:36,308 - octoprint.util.connectivity_checker - INFO - Connectivity changed from offline to online
2020-04-25 16:02:36,474 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2020-04-25 16:02:38,127 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid
2020-04-25 16:02:38,180 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk
2020-04-25 16:02:38,293 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 99.30ms
2020-04-25 16:05:02,456 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 108.67ms
2020-04-25 16:05:29,511 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 36.25ms
2020-04-25 16:05:35,605 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 83.96ms
2020-04-25 16:05:37,212 - tornado.access - ERROR - 500 GET /api/files?recursive=true (::ffff:192.168.2.16) 53.24ms

Serial.log

2020-04-25 15:58:47,707 - Connecting to: /dev/ttyACM0
2020-04-25 15:58:47,721 - Changing monitoring state from "Offline" to "Opening serial port"
2020-04-25 15:58:47,736 - Connected to: Serial<id=0x71663f30, open=True>(port='/dev/ttyACM0', baudrate=250000, bytesize=8, parity='N', stopbits=1, timeout=10.0, xonxoff=False, rtscts=False, dsrdtr=False), starting monitor
2020-04-25 15:58:47,737 - Changing monitoring state from "Opening serial port" to "Connecting"
2020-04-25 15:58:47,767 - Send: N0 M110 N0*125
2020-04-25 15:58:48,898 - Recv: start
2020-04-25 15:58:48,903 - Recv: echo:Marlin 414 bugfix-2.0.x
2020-04-25 15:58:48,905 - Recv: 
2020-04-25 15:58:48,907 - Recv: echo: Last Updated: 2019-10-18 | Author: (V1 Engineering, Ryan, 414)
2020-04-25 15:58:48,926 - Recv: echo:Compiled: Dec 18 2019
2020-04-25 15:58:48,930 - Recv: echo: Free Memory: 3474  PlannerBufferBytes: 1472
2020-04-25 15:58:48,977 - Send: N0 M110 N0*125
2020-04-25 15:58:56,536 - Recv: echo:SD init fail
2020-04-25 15:58:56,539 - Recv: echo:Hardcoded Default Settings Loaded
2020-04-25 15:58:56,541 - Recv: echo:  G21    ; Units in mm (mm)
2020-04-25 15:58:56,543 - Recv: echo:  M149 C ; Units in Celsius
2020-04-25 15:58:56,545 - Recv: 
2020-04-25 15:58:56,547 - Recv: echo:Filament settings: Disabled
2020-04-25 15:58:56,549 - Recv: echo:  M200 D3.00
2020-04-25 15:58:56,551 - Recv: echo:  M200 D0
2020-04-25 15:58:56,553 - Recv: echo:Steps per unit:
2020-04-25 15:58:56,555 - Recv: echo: M92 X100.00 Y100.00 Z400.00 E100.00
2020-04-25 15:58:56,557 - Recv: echo:Maximum feedrates (units/s):
2020-04-25 15:58:56,559 - Recv: echo:  M203 X120.00 Y120.00 Z30.00 E25.00
2020-04-25 15:58:56,561 - Recv: echo:Maximum Acceleration (units/s2):
2020-04-25 15:58:56,563 - Recv: echo:  M201 X400.00 Y400.00 Z100.00 E2000.00
2020-04-25 15:58:56,565 - Recv: echo:Acceleration (units/s2): P<print_accel> R<retract_accel> T<travel_accel>
2020-04-25 15:58:56,566 - Recv: echo:  M204 P400.00 R3000.00 T400.00
2020-04-25 15:58:56,568 - Recv: echo:Advanced: B<min_segment_time_us> S<min_feedrate> T<min_travel_feedrate> J<junc_dev>
2020-04-25 15:58:56,570 - Recv: echo:  M205 B20000.00 S0.00 T0.00 J0.10
2020-04-25 15:58:56,573 - Recv: echo:Home offset:
2020-04-25 15:58:56,575 - Recv: echo:  M206 X0.00 Y0.00 Z0.00
2020-04-25 15:58:56,576 - Recv: echo:Material heatup parameters:
2020-04-25 15:58:56,578 - Recv: echo:  M145 S0 H196 B92 F0
2020-04-25 15:58:56,580 - Recv: echo:  M145 S1 H240 B110 F0
2020-04-25 15:58:56,581 - Recv: echo:PID settings:
2020-04-25 15:58:56,583 - Recv: echo:  M301 P17.98 I0.98 D83.62
2020-04-25 15:58:56,584 - Recv: echo:Stepper motor currents:
2020-04-25 15:58:56,587 - Recv: echo:  M907 X900 Z900 E900
2020-04-25 15:58:56,820 - Recv: ok
2020-04-25 15:58:56,825 - Send: N0 M110 N0*125
2020-04-25 15:58:56,829 - Changing monitoring state from "Connecting" to "Operational"
2020-04-25 15:58:56,838 - Recv: echo:Unknown command: ""
2020-04-25 15:58:56,839 - Recv: ok
2020-04-25 15:58:56,844 - Send: N0 M110 N0*125
2020-04-25 15:58:56,855 - Recv: ok
2020-04-25 15:58:56,858 - Send: N1 M115*39
2020-04-25 15:58:56,871 - Recv: FIRMWARE_NAME:Marlin 414 bugfix-2.0.x (GitHub) SOURCE_CODE_URL:https://github.com/MarlinFirmware/Marlin PROTOCOL_VERSION:1.0 MACHINE_TYPE:V1 E CNC EXTRUDER_COUNT:1 UUID:cede2a2f-41a2-4748-9b12-c55c62f367ff
2020-04-25 15:58:56,878 - Recv: Cap:SERIAL_XON_XOFF:0
2020-04-25 15:58:56,882 - Recv: Cap:BINARY_FILE_TRANSFER:0
2020-04-25 15:58:56,884 - Recv: Cap:EEPROM:0
2020-04-25 15:58:56,887 - Recv: Cap:VOLUMETRIC:1
2020-04-25 15:58:56,891 - Recv: Cap:AUTOREPORT_TEMP:1
2020-04-25 15:58:56,895 - Recv: Cap:PROGRESS:0
2020-04-25 15:58:56,897 - Recv: Cap:PRINT_JOB:1
2020-04-25 15:58:56,900 - Recv: Cap:AUTOLEVEL:0
2020-04-25 15:58:56,902 - Recv: Cap:Z_PROBE:0
2020-04-25 15:58:56,904 - Recv: Cap:LEVELING_DATA:0
2020-04-25 15:58:56,906 - Recv: Cap:BUILD_PERCENT:0
2020-04-25 15:58:56,908 - Recv: Cap:SOFTWARE_POWER:0
2020-04-25 15:58:56,911 - Recv: Cap:TOGGLE_LIGHTS:0
2020-04-25 15:58:56,913 - Recv: Cap:CASE_LIGHT_BRIGHTNESS:0
2020-04-25 15:58:56,915 - Recv: Cap:EMERGENCY_PARSER:0
2020-04-25 15:58:56,917 - Recv: Cap:PROMPT_SUPPORT:0
2020-04-25 15:58:56,919 - Recv: Cap:AUTOREPORT_SD_STATUS:0
2020-04-25 15:58:56,921 - Recv: Cap:THERMAL_PROTECTION:1
2020-04-25 15:58:56,923 - Recv: Cap:MOTION_MODES:1
2020-04-25 15:58:56,926 - Recv: Cap:CHAMBER_TEMPERATURE:0
2020-04-25 15:58:56,928 - Recv: ok
2020-04-25 15:58:56,930 - Send: M21
2020-04-25 15:58:59,344 - Recv: echo:SD init fail
2020-04-25 15:58:59,347 - Recv: ok
2020-04-25 15:58:59,349 - Send: M155 S2
2020-04-25 15:58:59,357 - Recv: ok

TopsideLLC · April 25, 2020, 3:11pm

those are both as the file is stuck at saving on the web UI. None of my other files show up.

Ewald_Ikemann · April 25, 2020, 3:32pm

BTW: does printing from a SD card work?

TopsideLLC · April 25, 2020, 3:43pm

I don't have that option available to me. I've got a Mini-Rambo connected to the machine and USB to the RPi. I don't have an LCD/SD card attached.

TopsideLLC · April 25, 2020, 3:44pm

But running the machine from a computer hooked up to the USB works fine.

Ewald_Ikemann · April 25, 2020, 4:02pm

So, when you don't have a SD card reader attached to your printer board, SD card initialisation can't succeed.
Or are you mixing up uploading to OctoPrint's SD card?