I had this problem right after the last update for Octoprint. Before that been working great! Now I cannot connect to the printer it was connected to the entire time. I have looked at almost every post on this but can not seem to get it to work. I have tried the plugin mentioned above, I have tried the plug that lets you control your USB ports and nothing worked yet. I will attach my logs and stuff to see if someone smarter than me can find the issue. I have been trying to find a fix for two months now and nothing is working. I also rebuild Octopi to original settings no plugin just basic setup and still same thing happens.
Below is my setup:
Ender 3 Marlin v1.1.6 firmware
Octoprint 1.4.0
Raspbery pi 3 B+
serial.log (592 Bytes)
octoprint.log (208.3 KB)
dmesg output:
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 4.19.118-v7+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1311 SMP Mon Apr 27 14:21:24 BST 2020
[ 0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
[ 0.000000] CPU: div instructions available: patching division code
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[ 0.000000] OF: fdt: Machine model: Raspberry Pi 3 Model B Plus Rev 1.3
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] cma: Reserved 8 MiB at 0x37800000
[ 0.000000] On node 0 totalpages: 229376
[ 0.000000] Normal zone: 2016 pages used for memmap
[ 0.000000] Normal zone: 0 pages reserved
[ 0.000000] Normal zone: 229376 pages, LIFO batch:63
[ 0.000000] random: get_random_bytes called from start_kernel+0xac/0x4b4 with crng_init=0
[ 0.000000] percpu: Embedded 16 pages/cpu s36864 r8192 d20480 u65536
[ 0.000000] pcpu-alloc: s36864 r8192 d20480 u65536 alloc=16*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 227360
[ 0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 console=ttyS0,115200 console=tty1 root=PARTUUID=6c586e13-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Memory: 886284K/917504K available (8192K kernel code, 656K rwdata, 2232K rodata, 1024K init, 831K bss, 23028K reserved, 8192K cma-reserved)
[ 0.000000] Virtual kernel memory layout:
vector : 0xffff0000 - 0xffff1000 ( 4 kB)
fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
vmalloc : 0xb8800000 - 0xff800000 (1136 MB)
lowmem : 0x80000000 - 0xb8000000 ( 896 MB)
modules : 0x7f000000 - 0x80000000 ( 16 MB)
.text : 0x(ptrval) - 0x(ptrval) (9184 kB)
.init : 0x(ptrval) - 0x(ptrval) (1024 kB)
.data : 0x(ptrval) - 0x(ptrval) ( 657 kB)
.bss : 0x(ptrval) - 0x(ptrval) ( 832 kB)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[ 0.000000] ftrace: allocating 27093 entries in 80 pages
[ 0.000000] rcu: Hierarchical RCU implementation.
[ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[ 0.000000] arch_timer: cp15 timer(s) running at 19.20MHz (phys).
[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
[ 0.000007] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
[ 0.000023] Switching to timer-based delay loop, resolution 52ns
[ 0.000275] Console: colour dummy device 80x30
[ 0.000887] console [tty1] enabled
[ 0.000941] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
[ 0.000985] pid_max: default: 32768 minimum: 301
[ 0.001350] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.001386] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.002334] CPU: Testing write buffer coherency: ok
[ 0.002819] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[ 0.003493] Setting up static identity map for 0x100000 - 0x10003c
[ 0.003661] rcu: Hierarchical SRCU implementation.
[ 0.004491] smp: Bringing up secondary CPUs ...
[ 0.005404] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.006377] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[ 0.007288] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[ 0.007403] smp: Brought up 1 node, 4 CPUs
[ 0.007484] SMP: Total of 4 processors activated (153.60 BogoMIPS).
[ 0.007508] CPU: All CPU(s) started in HYP mode.
[ 0.007528] CPU: Virtualization extensions available.
[ 0.008516] devtmpfs: initialized
[ 0.021500] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
[ 0.021772] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.021822] futex hash table entries: 1024 (order: 4, 65536 bytes)
[ 0.022428] pinctrl core: initialized pinctrl subsystem
[ 0.023290] NET: Registered protocol family 16
[ 0.026301] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[ 0.031985] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[ 0.032021] hw-breakpoint: maximum watchpoint size is 8 bytes.
[ 0.032241] Serial: AMBA PL011 UART driver
[ 0.034590] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
[ 0.050028] raspberrypi-firmware soc:firmware: Attached to firmware from 2020-04-27 14:36, variant start_x
[ 0.060042] raspberrypi-firmware soc:firmware: Firmware hash is 3a8f1793b758d6fb7f375edaa260e069ecd34c88
[ 0.103013] bcm2835-dma 3f007000.dma: DMA legacy API manager at (ptrval), dmachans=0x1
[ 0.104688] SCSI subsystem initialized
[ 0.104925] usbcore: registered new interface driver usbfs
[ 0.105000] usbcore: registered new interface driver hub
[ 0.105119] usbcore: registered new device driver usb
[ 0.106647] clocksource: Switched to clocksource arch_sys_counter
[ 0.197084] VFS: Disk quotas dquot_6.6.0
[ 0.197195] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.197399] FS-Cache: Loaded
[ 0.197629] CacheFiles: Loaded
[ 0.207679] NET: Registered protocol family 2
[ 0.208541] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
[ 0.208606] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.208736] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[ 0.208941] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.209097] UDP hash table entries: 512 (order: 2, 16384 bytes)
[ 0.209167] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[ 0.209426] NET: Registered protocol family 1
[ 0.210031] RPC: Registered named UNIX socket transport module.
[ 0.210059] RPC: Registered udp transport module.
[ 0.210080] RPC: Registered tcp transport module.
[ 0.210102] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.211716] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
[ 0.214821] Initialise system trusted keyrings
[ 0.215031] workingset: timestamp_bits=14 max_order=18 bucket_order=4
[ 0.224999] FS-Cache: Netfs 'nfs' registered for caching
[ 0.225571] NFS: Registering the id_resolver key type
[ 0.225617] Key type id_resolver registered
[ 0.225639] Key type id_legacy registered
[ 0.225670] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[ 0.231197] Key type asymmetric registered
[ 0.231232] Asymmetric key parser 'x509' registered
[ 0.231307] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
[ 0.231507] io scheduler noop registered
[ 0.231531] io scheduler deadline registered (default)
[ 0.231751] io scheduler cfq registered
[ 0.231775] io scheduler mq-deadline registered (default)
[ 0.231799] io scheduler kyber registered
[ 0.234055] bcm2708_fb soc:fb: FB found 1 display(s)
[ 0.243360] Console: switching to colour frame buffer device 82x26
[ 0.250247] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 656x416
[ 0.256981] bcm2835-rng 3f104000.rng: hwrng registered
[ 0.259664] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
[ 0.264944] vc-sm: Videocore shared memory driver
[ 0.267777] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
[ 0.283531] brd: module loaded
[ 0.296193] loop: module loaded
[ 0.299293] Loading iSCSI transport class v2.0-870.
[ 0.302459] libphy: Fixed MDIO Bus: probed
[ 0.304963] usbcore: registered new interface driver lan78xx
[ 0.307445] usbcore: registered new interface driver smsc95xx
[ 0.309795] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[ 0.840023] dwc_otg 3f980000.usb: base=(ptrval)
[ 1.042651] Core Release: 2.80a
[ 1.045028] Setting default values for core params
[ 1.047500] Finished setting default values for core params
[ 1.250240] Using Buffer DMA mode
[ 1.252627] Periodic Transfer Interrupt Enhancement - disabled
[ 1.255049] Multiprocessor Interrupt Enhancement - disabled
[ 1.257436] OTG VER PARAM: 0, OTG VER FLAG: 0
[ 1.259779] Dedicated Tx FIFOs mode
[ 1.262468] WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = b7914000 dma = 0xf7914000 len=9024
[ 1.267066] FIQ FSM acceleration enabled for :
Non-periodic Split Transactions
Periodic Split Transactions
High-Speed Isochronous Endpoints
Interrupt/Control Split Transaction hack enabled
[ 1.277972] dwc_otg: Microframe scheduler enabled
[ 1.278029] WARN::hcd_init_fiq:457: FIQ on core 1
[ 1.280256] WARN::hcd_init_fiq:458: FIQ ASM at 8068fda0 length 36
[ 1.282470] WARN::hcd_init_fiq:497: MPHI regs_base at b8810000
[ 1.284730] dwc_otg 3f980000.usb: DWC OTG Controller
[ 1.287077] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
[ 1.289410] dwc_otg 3f980000.usb: irq 56, io mem 0x00000000
[ 1.291712] Init: Port Power? op_state=1
[ 1.293948] Init: Power Port (0)
[ 1.296363] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
[ 1.300892] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.303306] usb usb1: Product: DWC OTG Controller
[ 1.305670] usb usb1: Manufacturer: Linux 4.19.118-v7+ dwc_otg_hcd
[ 1.308114] usb usb1: SerialNumber: 3f980000.usb
[ 1.311057] hub 1-0:1.0: USB hub found
[ 1.313336] hub 1-0:1.0: 1 port detected
[ 1.316095] dwc_otg: FIQ enabled
[ 1.316101] dwc_otg: NAK holdoff enabled
[ 1.316106] dwc_otg: FIQ split-transaction FSM enabled
[ 1.316117] Module dwc_common_port init
[ 1.316391] usbcore: registered new interface driver usb-storage
[ 1.318881] mousedev: PS/2 mouse device common for all mice
[ 1.322018] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[ 1.324647] bcm2835-cpufreq: min=600000 max=1400000
[ 1.327492] sdhci: Secure Digital Host Controller Interface driver
[ 1.329905] sdhci: Copyright(c) Pierre Ossman
[ 1.332695] mmc-bcm2835 3f300000.mmcnr: could not get clk, deferring probe
[ 1.335618] sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe
[ 1.338330] sdhci-pltfm: SDHCI platform and OF driver helper
[ 1.342392] ledtrig-cpu: registered to indicate activity on CPUs
[ 1.345125] hidraw: raw HID events driver (C) Jiri Kosina
[ 1.347918] usbcore: registered new interface driver usbhid
[ 1.350548] usbhid: USB HID core driver
[ 1.353852] vchiq: vchiq_init_state: slot_zero = (ptrval), is_master = 0
[ 1.357948] [vc_sm_connected_init]: start
[ 1.366713] [vc_sm_connected_init]: end - returning 0
[ 1.370245] Initializing XFRM netlink socket
[ 1.372678] NET: Registered protocol family 17
[ 1.375175] Key type dns_resolver registered
[ 1.378007] Registering SWP/SWPB emulation handler
[ 1.381071] registered taskstats version 1
[ 1.383475] Loading compiled-in X.509 certificates
[ 1.392656] uart-pl011 3f201000.serial: cts_event_workaround enabled
[ 1.395194] 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 81, base_baud = 0) is a PL011 rev2
[ 1.401918] mmc-bcm2835 3f300000.mmcnr: mmc_debug:0 mmc_debug2:0
[ 1.404447] mmc-bcm2835 3f300000.mmcnr: DMA channel allocated
[ 1.433216] sdhost: log_buf @ (ptrval) (f7913000)
[ 1.470890] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[ 1.474870] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[ 1.478753] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[ 1.483759] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[ 1.487053] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[ 1.490448] of_cfs_init
[ 1.492539] of_cfs_init: OK
[ 1.495025] Waiting for root device PARTUUID=6c586e13-02...
[ 1.526768] Indeed it is in host mode hprt0 = 00021501
[ 1.598340] random: fast init done
[ 1.609398] mmc0: host does not support reading read-only switch, assuming write-enable
[ 1.616757] mmc0: new high speed SDXC card at address 0001
[ 1.620360] mmcblk0: mmc0:0001 GC2QT 59.6 GiB
[ 1.624873] mmcblk0: p1 p2
[ 1.644711] mmc1: new high speed SDIO card at address 0001
[ 1.671992] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[ 1.676247] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[ 1.687124] devtmpfs: mounted
[ 1.696565] Freeing unused kernel memory: 1024K
[ 1.707051] Run /sbin/init as init process
[ 1.736691] usb 1-1: new high-speed USB device number 2 using dwc_otg
[ 1.739317] Indeed it is in host mode hprt0 = 00001101
[ 1.976989] usb 1-1: New USB device found, idVendor=0424, idProduct=2514, bcdDevice= b.b3
[ 1.982255] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 1.985772] hub 1-1:1.0: USB hub found
[ 1.988736] hub 1-1:1.0: 4 ports detected
[ 2.306716] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
[ 2.330084] systemd[1]: System time before build time, advancing clock.
[ 2.446982] usb 1-1.1: New USB device found, idVendor=0424, idProduct=2514, bcdDevice= b.b3
[ 2.452505] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 2.456354] hub 1-1.1:1.0: USB hub found
[ 2.459375] hub 1-1.1:1.0: 3 ports detected
[ 2.471992] NET: Registered protocol family 10
[ 2.476053] Segment Routing with IPv6
[ 2.521648] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
[ 2.530911] systemd[1]: Detected architecture arm.
[ 2.559342] systemd[1]: Set hostname to .
[ 3.126704] usb 1-1.1.1: new high-speed USB device number 4 using dwc_otg
[ 3.257152] usb 1-1.1.1: New USB device found, idVendor=0424, idProduct=7800, bcdDevice= 3.00
[ 3.262596] usb 1-1.1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 3.512045] random: systemd: uninitialized urandom read (16 bytes read)
[ 3.526270] random: systemd: uninitialized urandom read (16 bytes read)
[ 3.529768] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[ 3.532683] lan78xx 1-1.1.1:1.0 (unnamed net_device) (uninitialized): No External EEPROM. Setting MAC Speed
[ 3.541798] libphy: lan78xx-mdiobus: probed
[ 3.547557] random: systemd: uninitialized urandom read (16 bytes read)
[ 3.550734] systemd[1]: Reached target Swap.
[ 3.558155] systemd[1]: Listening on Journal Socket.
[ 3.570987] lan78xx 1-1.1.1:1.0 (unnamed net_device) (uninitialized): int urb period 64
[ 3.574310] systemd[1]: Mounting Kernel Debug File System...
[ 3.589938] systemd[1]: Mounting POSIX Message Queue File System...
[ 3.612813] systemd[1]: Starting Load Kernel Modules...
[ 3.626432] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[ 4.520277] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[ 4.665418] systemd-journald[127]: Received request to flush runtime journal from PID 1
[ 5.507014] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[ 5.509563] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[ 5.509579] [vc_sm_connected_init]: start
[ 5.514968] [vc_sm_connected_init]: installed successfully
[ 5.520927] media: Linux media interface: v0.10
[ 5.555228] videodev: Linux video capture interface: v2.00
[ 5.588259] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[ 5.593854] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[ 5.605664] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[ 5.617723] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[ 5.664469] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[ 5.674712] bcm2835_audio soc:audio: card created with 8 channels
[ 5.852124] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[ 5.920054] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[ 5.996861] brcmfmac: F1 signature read @0x18000000=0x15264345
[ 6.004355] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[ 6.004765] usbcore: registered new interface driver brcmfmac
[ 6.234384] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[ 6.234452] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[ 6.239322] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[ 6.239849] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[ 6.239890] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[ 6.243254] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[ 6.243278] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[ 6.288820] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Mar 2 2020 23:30:41 version 7.45.202 (r724630 CY) FWID 01-72f6ece2
[ 7.229839] random: crng init done
[ 7.229853] random: 7 urandom warning(s) missed due to ratelimiting
[ 8.025393] uart-pl011 3f201000.serial: no DMA platform data
[ 8.048268] 8021q: 802.1Q VLAN Support v1.8
[ 8.162379] Adding 102396k swap on /var/swap. Priority:-2 extents:1 across:102396k SSFS
[ 8.435539] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 8.435559] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
[ 8.707811] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 8.707824] 8021q: adding VLAN 0 to HW filter on device eth0
[ 14.413024] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[ 15.013645] Bluetooth: Core ver 2.22
[ 15.013723] NET: Registered protocol family 31
[ 15.013727] Bluetooth: HCI device and connection manager initialized
[ 15.014571] Bluetooth: HCI socket layer initialized
[ 15.014586] Bluetooth: L2CAP socket layer initialized
[ 15.014628] Bluetooth: SCO socket layer initialized
[ 15.071447] Bluetooth: HCI UART driver ver 2.3
[ 15.071454] Bluetooth: HCI UART protocol H4 registered
[ 15.071519] Bluetooth: HCI UART protocol Three-wire (H5) registered
[ 15.072661] Bluetooth: HCI UART protocol Broadcom registered
[ 15.312268] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[ 15.312280] Bluetooth: BNEP filters: protocol multicast
[ 15.312296] Bluetooth: BNEP socket layer initialized