search

procount / pinn

An enhanced Operating System installer for the Raspberry Pi
1.15k stars 124 forks source link

tmp/mnt/pinn_init.sh not found #756

Closed axalppro closed 1 year ago

axalppro commented 1 year ago

Hello, I am trying to recreate this : OS selection with jumper

First, thanks for all the hard work and support for this kind of project.

I have an SD card running PINN and two OS installed. I want to change the one that boots using a jumper similar to what has been done in the post above. I modified the config.txt and added the pinn_init.sh accordingly. When I try to boot I get the rainbow box and then a line that says : sh: /tmp/mnt/pinn_init.sh: not found

So I'm guessing it detects the pinn_init.sh script tries to mount it but fails and then can't run it.

Any idea where this error could be coming from.

PS: I modified the pinn_init.sh for my application so maybe I have an error in it but it didn't work better with the original pinn_init.sh povided in the article by Jim.

Here is my pinn_init.sh file : 

#!/bin/sh
# This function will export a GPIO number as an INPUT so it can be used
gpio_export()
{
    #arg1 = gpio number
    echo "$1" >/sys/class/gpio/export
    echo "in" >/sys/class/gpio/gpio$1/direction 
}

# This function will free up the GPIO for use elsewhere
gpio_unexport()
{
    echo "$1" >/sys/class/gpio/unexport
}

# This gets the value of the GPIO pin
gpio_value()
{
    #arg1 = gpio number
    cat /sys/class/gpio/gpio$1/value
}

# Initialise the partition number to 4
partition=4 # Start with a number that, when
        # incremented by two will hit each boot partition in turn

# Identify which OS we want to load by the first GPIO number that is set
# If more than one is set, the first one detected is selected.

n=27
#  Valid bootable partitions are the even numbered partitions beginning with partition 6
#  We start with $partition = 4 because we pre-increment
partition=`expr $partition + 2`     #  Increment partition number to next untested partition
gpio_export $n
value=$(gpio_value $n)
echo "exported pin $n returned a value of $value"

#  Test the returned value from each GPIO pin.
#  A selected pin will return "0" and will trigger the boot process
if [[ "$value" == "0" ]]; then
    echo "Jumper ON - rebootp $partition"   #  Display what's going to happen
    rebootp $partition      #  Force-boot the selected partition
    break               #  Never reach here unless testing
else    
    echo "Jumper OFF - rebootp $partition"  #  Display what's going to happen
    partition=`expr $partition + 2`     #  Increment partition number to next untested partition
    rebootp $partition      #  Force-boot the selected partition
    break
fi
gpio_unexport $n

echo "No O/S selected - booting PINN"

And my config.txt : 

gpio=27=ip,pu

gpu_mem=16
start_file=recovery.elf
fixup_file=fixup_rc.dat

[pi4]
start_file=recover4.elf
fixup_file=fixup4rc.dat
max_framebuffers=2

enable_uart=1
procount commented 1 year ago

Can you copy the output of /tmp/debug after this error has occurred? (See https://github.com/procount/pinn/wiki/Troubleshooting step 5)

axalppro commented 1 year ago

Here's debug.txt : 

Keyboard found: "/dev/input/event1" 
3.8.7 
Board revision is  13644052 
Found recovery.rfs at "mmcblk0p1" 
PINN drive: "/dev/mmcblk0" 
mount: /dev/mmcblk0 is already mounted or /mnt busy
Simulate OK 
CecListener thread started 
Looking for  "/mnt/cec_keys.json" 
CecListener done initializing 
Loading Mappings mappings from  ":/cec_keys.json" 
Shift detected 
New =  mainwindow ,  Main Menu 
setWindow  "mainwindow" 
setMenu  "Main Menu" 
Starting dbus 
Starting dhcpcd 
Default language is  "en" 
Default keyboard layout is  "gb" 
Default display mode is  "0" 
Number of bootables =  2 
New drive selected: "mmcblk0" 
Network up in 5.941 seconds 
current date is  QDate("Thu Jan 1 1970") 
Requesting current time 
Downloading "http://downloads.sourceforge.net/project/pinn/BUILD-DATA" to "BUILD|/tmp/BUILD-DATA" 
Downloading "http://downloads.sourceforge.net/project/pinn/README.md" to "README|/tmp/README.md" 
Downloading "http://raw.githubusercontent.com/procount/pinn-os/master/os/overrides.json" to "GROUP|/tmp/overrides.json" 
downloadRepoList:  "http://raw.githubusercontent.com/procount/pinn-os/master/os/repo_list.json" 
Time set to:  QDateTime("Wed Oct 11 06:27:47 2023") 
Redirection - Re-trying download from "https://raw.githubusercontent.com/procount/pinn-os/master/os/repo_list.json" 
downloadRepoList:  "https://raw.githubusercontent.com/procount/pinn-os/master/os/repo_list.json" 
Downloading "https://raw.githubusercontent.com/procount/pinn-os/master/os/overrides.json" to "GROUP|/tmp/overrides.json" 
"GROUP" 
Downloaded  "GROUP" : "/tmp/overrides.json" 
Number of bootables =  2 
Downloading "http://kumisystems.dl.sourceforge.net/project/pinn/BUILD-DATA" to "BUILD|/tmp/BUILD-DATA" 
Downloading "http://netcologne.dl.sourceforge.net/project/pinn/README.md" to "README|/tmp/README.md" 
Number of bootables =  2 
checking size of file:  "http://downloads.sourceforge.net/project/pinn/os_previous/recalbox7-rpi4/RECALBOX.tar.xz" 
Number of bootables =  2 
checking size of file:  "http://downloads.sourceforge.net/project/pinn/os/kali64/boot_kali.tar.xz" 
checking size of file:  "http://downloads.sourceforge.net/project/pinn/os/kali64/root_kali.tar.xz" 
"BUILD" 
Downloaded  "BUILD" : "/tmp/BUILD-DATA" 
"README" 
Downloaded  "README" : "/tmp/README.md" 
BUILD_IGNORE... 
BUILD_CURRENT... 
Version:  "PINN Version: v3.8.7" , "v3.8.7" 
BUILD_NEW... 
Version:  "PINN Version: v3.8.7" , "v3.8.7" 
Number of bootables =  2 
checking size of file:  "http://download.osmc.tv/installers/noobs/boot-rbp4.tar.xz" 
checking size of file:  "http://download.osmc.tv/installers/noobs/root-rbp4.tar.xz" 
checking size of file:  "http://altushost-swe.dl.sourceforge.net/project/pinn/os_previous/recalbox7-rpi4/RECALBOX.tar.xz" 
libpng warning: Unknown iTXt compression type or method
libpng warning: Unknown iTXt compression type or method
Number of bootables =  2 
checking size of file:  "http://nav.dl.sourceforge.net/project/pinn/os/kali64/boot_kali.tar.xz" 
checking size of file:  "http://deac-riga.dl.sourceforge.net/project/pinn/os/kali64/root_kali.tar.xz" 
Length: 753328276 files left:  4   "recalbox7-rpi4" 
checking size of file:  "http://ftp.halifax.rwth-aachen.de/osmc/osmc/download/installers/noobs/root-rbp4.tar.xz" 
checking size of file:  "http://mirrors.tuna.tsinghua.edu.cn/osmc/osmc/download/installers/noobs/boot-rbp4.tar.xz" 
Number of bootables =  2 
checking size of file:  "http://rpi.thinlinx.com/NOOBS/TLX_RPi/boot.xz" 
checking size of file:  "http://rpi.thinlinx.com/NOOBS/TLX_RPi/tfm.xz" 
checking size of file:  "http://rpi.thinlinx.com/NOOBS/TLX_RPi/root.xz" 
Number of bootables =  2 
libpng warning: Unknown iTXt compression type or method
libpng warning: Unknown iTXt compression type or method
libpng warning: Unknown iTXt compression type or method
Number of bootables =  2 
Length: 218640228 files left:  6   "OSMC_Pi4" 
checking size of file:  "http://downloads.sourceforge.net/project/pinn/os/kali64/root_kali.tar.xz?download&failedmirror=deac-riga.dl.sourceforge.net" 
Length: 31689316 files left:  5   "kali64" 
checking size of file:  "http://altushost-swe.dl.sourceforge.net/project/pinn/os/kali64/root_kali.tar.xz" 
Length: 2238806124 files left:  4   "kali64" 
Length: 734965856 files left:  3   "TLXOS" 
Length: 17285356 files left:  2   "TLXOS" 
Length: 10136708 files left:  1   "TLXOS" 
"filesize error checking http://mirrors.tuna.tsinghua.edu.cn/osmc/osmc/download/installers/noobs/boot-rbp4.tar.xz" 
Length: 3438 files left:  0   "OSMC_Pi4"

And here's dmesg.txt : 

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 5.10.103-rescue-v7l (kevin@ubuntu) (arm-buildroot-linux-uclibcgnueabi-gcc (Buildroot 2015.02-git-00004-g12062161-dirty) 4.9.2, GNU ld (GNU Binutils) 2.24) #6 SMP Sun Apr 16 16:21:55 BST 2023
[    0.000000] CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
[    0.000000] CPU: div instructions available: patching division code
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
[    0.000000] OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.4
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] Reserved memory: created CMA memory pool at 0x0000000029000000, size 64 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000000000-0x000000002fffffff]
[    0.000000]   Normal   empty
[    0.000000]   HighMem  [mem 0x0000000030000000-0x00000001ffffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x000000003e5fffff]
[    0.000000]   node   0: [mem 0x0000000040000000-0x00000000fbffffff]
[    0.000000]   node   0: [mem 0x0000000100000000-0x00000001ffffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000001ffffffff]
[    0.000000] On node 0 totalpages: 2074112
[    0.000000]   DMA zone: 1536 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 196608 pages, LIFO batch:63
[    0.000000]   HighMem zone: 1877504 pages, LIFO batch:63
[    0.000000] percpu: Embedded 15 pages/cpu s30848 r8192 d22400 u61440
[    0.000000] pcpu-alloc: s30848 r8192 d22400 u61440 alloc=15*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 2072576
[    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=1824 bcm2708_fb.fbheight=984 bcm2708_fb.fbdepth=16 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:CF:13:C4 vc_mem.mem_base=0x3f000000 vc_mem.mem_size=0x3f600000  quiet ramdisk_size=32768 root=/dev/ram0 init=/init vt.cur_default=1 elevator=deadline repo_list=http://raw.githubusercontent.com/procount/pinn-os/master/os/repo_list.json loglevel=2 sdhci.debug_quirks2=4 console=ttyS0,115200 console=tty1
[    0.000000] Kernel parameter elevator= does not have any effect anymore.
Please use sysfs to set IO scheduler for individual devices.
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] software IO TLB: mapped [mem 0x0000000021000000-0x0000000025000000] (64MB)
[    0.000000] Memory: 8053748K/8296448K available (8192K kernel code, 588K rwdata, 1728K rodata, 2048K init, 527K bss, 177164K reserved, 65536K cma-reserved, 7510016K highmem)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] rcu: Hierarchical RCU implementation.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.000000] GIC: Using split EOI/Deactivate mode
[    0.000000] random: get_random_bytes called from start_kernel+0x450/0x5e0 with crng_init=0
[    0.000007] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
[    0.000030] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
[    0.000081] bcm2835: system timer (irq = 25)
[    0.000644] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
[    0.000661] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
[    0.000678] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
[    0.000691] Switching to timer-based delay loop, resolution 18ns
[    0.000874] Console: colour dummy device 80x30
[    0.000924] printk: console [tty1] enabled
[    0.000952] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
[    0.000970] pid_max: default: 32768 minimum: 301
[    0.001109] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.001125] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.001642] CPU: Testing write buffer coherency: ok
[    0.001847] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.002216] Setting up static identity map for 0x200000 - 0x20003c
[    0.002293] rcu: Hierarchical SRCU implementation.
[    0.002547] smp: Bringing up secondary CPUs ...
[    0.003052] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.003644] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[    0.004214] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[    0.004316] smp: Brought up 1 node, 4 CPUs
[    0.004329] SMP: Total of 4 processors activated (432.00 BogoMIPS).
[    0.004337] CPU: All CPU(s) started in HYP mode.
[    0.004344] CPU: Virtualization extensions available.
[    0.004790] devtmpfs: initialized
[    0.014389] VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
[    0.014524] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.014542] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.016014] pinctrl core: initialized pinctrl subsystem
[    0.016542] NET: Registered protocol family 16
[    0.018458] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[    0.019272] thermal_sys: Registered thermal governor 'step_wise'
[    0.019406] cpuidle: using governor menu
[    0.020082] Serial: AMBA PL011 UART driver
[    0.033855] bcm2835-mbox fe00b880.mailbox: mailbox enabled
[    0.050708] raspberrypi-firmware soc:firmware: Attached to firmware from 2022-01-20T13:57:04, variant start_cd
[    0.060724] raspberrypi-firmware soc:firmware: Firmware hash is bd88f66f8952d34e4e0613a85c7a6d3da49e13e2
[    0.260914] raid6: int32x8  gen()   342 MB/s
[    0.430979] raid6: int32x8  xor()   184 MB/s
[    0.601083] raid6: int32x4  gen()   368 MB/s
[    0.771162] raid6: int32x4  xor()   193 MB/s
[    0.941273] raid6: int32x2  gen()   401 MB/s
[    1.111402] raid6: int32x2  xor()   196 MB/s
[    1.281499] raid6: int32x1  gen()   397 MB/s
[    1.451584] raid6: int32x1  xor()   170 MB/s
[    1.451593] raid6: using algorithm int32x2 gen() 401 MB/s
[    1.451601] raid6: .... xor() 196 MB/s, rmw enabled
[    1.451610] raid6: using intx1 recovery algorithm
[    1.451938] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
[    1.454017] vgaarb: loaded
[    1.454256] SCSI subsystem initialized
[    1.454402] usbcore: registered new interface driver usbfs
[    1.454443] usbcore: registered new interface driver hub
[    1.454482] usbcore: registered new device driver usb
[    1.455667] clocksource: Switched to clocksource arch_sys_counter
[    1.455815] VFS: Disk quotas dquot_6.6.0
[    1.455886] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    1.455968] FS-Cache: Loaded
[    1.456069] CacheFiles: Loaded
[    1.461701] NET: Registered protocol family 2
[    1.461865] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    1.462826] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
[    1.462846] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
[    1.462915] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    1.462984] TCP: Hash tables configured (established 8192 bind 8192)
[    1.463073] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
[    1.463099] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
[    1.463204] NET: Registered protocol family 1
[    1.464201] PCI: CLS 0 bytes, default 64
[    1.464365] Trying to unpack rootfs image as initramfs...
[    1.464467] rootfs image is not initramfs (invalid magic at start of compressed archive); looks like an initrd
[    1.552994] Freeing initrd memory: 31640K
[    1.554028] Initialise system trusted keyrings
[    1.554180] workingset: timestamp_bits=30 max_order=21 bucket_order=0
[    1.558327] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    1.558545] fuse: init (API version 7.32)
[    1.632372] xor: measuring software checksum speed
[    1.637852]    arm4regs        :  1805 MB/sec
[    1.646384]    8regs           :  1155 MB/sec
[    1.654928]    32regs          :  1151 MB/sec
[    1.654937] xor: using function: arm4regs (1805 MB/sec)
[    1.654949] Key type asymmetric registered
[    1.654958] Asymmetric key parser 'x509' registered
[    1.655023] bounce: pool size: 64 pages
[    1.655041] io scheduler mq-deadline registered
[    1.655050] io scheduler kyber registered
[    1.656825] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
[    1.656845] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
[    1.656876] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x063fffffff -> 0x00c0000000
[    1.656907] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000
[    1.717749] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
[    1.717917] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
[    1.717930] pci_bus 0000:00: root bus resource [bus 00-ff]
[    1.717944] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
[    1.717988] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
[    1.718076] pci 0000:00:00.0: PME# supported from D0 D3hot
[    1.720906] PCI: bus0: Fast back to back transfers disabled
[    1.721087] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
[    1.721173] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
[    1.721436] pci 0000:01:00.0: PME# supported from D0 D3hot
[    1.748271] PCI: bus1: Fast back to back transfers disabled
[    1.748308] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
[    1.748324] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
[    1.748347] pci 0000:00:00.0: PCI bridge to [bus 01]
[    1.748361] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
[    1.748645] bcm2708_fb soc:fb: FB found 2 display(s)
[    1.762741] Console: switching to colour frame buffer device 228x61
[    1.768859] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 1824x984
[    1.770798] bcm2708_fb soc:fb: Registered framebuffer for display 1, size 640x480
[    1.773208] vc-mem: phys_addr:0x00000000 mem_base=0x3f000000 mem_size:0x3f600000(1014 MiB)
[    1.773521] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
[    1.779902] brd: module loaded
[    1.784012] loop: module loaded
[    1.787252] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
[    1.895729] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
[    1.896583] usbcore: registered new interface driver brcmfmac
[    1.896624] usbcore: registered new interface driver mt7601u
[    1.896665] usbcore: registered new interface driver rt2500usb
[    1.896705] usbcore: registered new interface driver rt73usb
[    1.896745] usbcore: registered new interface driver rt2800usb
[    1.896783] usbcore: registered new interface driver r8152
[    1.896823] usbcore: registered new interface driver lan78xx
[    1.896867] usbcore: registered new interface driver asix
[    1.896898] usbcore: registered new interface driver dm9601
[    1.896938] usbcore: registered new interface driver smsc95xx
[    1.942669] pci 0000:00:00.0: enabling device (0140 -> 0142)
[    1.942784] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.942810] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
[    1.944144] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x00000e0000000890
[    1.944542] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
[    1.944555] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.944565] usb usb1: Product: xHCI Host Controller
[    1.944575] usb usb1: Manufacturer: Linux 5.10.103-rescue-v7l xhci-hcd
[    1.944584] usb usb1: SerialNumber: 0000:01:00.0
[    1.945027] hub 1-0:1.0: USB hub found
[    1.945090] hub 1-0:1.0: 1 port detected
[    1.945474] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.945493] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
[    1.945508] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
[    1.945725] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
[    1.945737] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.945747] usb usb2: Product: xHCI Host Controller
[    1.945757] usb usb2: Manufacturer: Linux 5.10.103-rescue-v7l xhci-hcd
[    1.945766] usb usb2: SerialNumber: 0000:01:00.0
[    1.946175] hub 2-0:1.0: USB hub found
[    1.946212] hub 2-0:1.0: 4 ports detected
[    1.947029] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.947129] dwc_otg: FIQ enabled
[    1.947137] dwc_otg: NAK holdoff enabled
[    1.947144] dwc_otg: FIQ split-transaction FSM enabled
[    1.947154] Module dwc_common_port init
[    1.947656] usbcore: registered new interface driver uas
[    1.947735] usbcore: registered new interface driver usb-storage
[    1.947866] mousedev: PS/2 mouse device common for all mice
[    1.947922] usbcore: registered new interface driver xpad
[    1.948733] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    1.949517] sdhci: Secure Digital Host Controller Interface driver
[    1.949525] sdhci: Copyright(c) Pierre Ossman
[    1.949850] mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
[    1.950067] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.952139] hid: raw HID events driver (C) Jiri Kosina
[    1.952768] usbcore: registered new interface driver usbhid
[    1.952777] usbhid: USB HID core driver
[    1.955701] NET: Registered protocol family 17
[    1.956140] Registering SWP/SWPB emulation handler
[    1.956258] Loading compiled-in X.509 certificates
[    1.957057] Btrfs loaded, crc32c=crc32c-generic
[    1.958657] uart-pl011 fe201000.serial: there is not valid maps for state default
[    1.958784] uart-pl011 fe201000.serial: cts_event_workaround enabled
[    1.958828] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
[    1.966003] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[    1.966309] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
[    1.966315] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
[    1.992078] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    1.993825] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    1.993966] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
[    1.993978] platform regulatory.0: Falling back to sysfs fallback for: regulatory.db
[    2.011336] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[    2.012877] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.014418] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.017179] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[    2.018720] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.033574] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
[    2.034219] RAMDISK: squashfs filesystem found at block 0
[    2.034231] RAMDISK: Loading 31637KiB [1 disk] into ram disk... |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-
[    2.056993] random: fast init done
[    2.057077] \|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\
[    2.068773] mmc0: new high speed SDHC card at address 59b4
[    2.068822] |/-\|
[    2.069198] mmcblk0: mmc0:59b4 SN32G 29.7 GiB
[    2.069262] /-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\
[    2.073961]  mmcblk0: p1 p2 < p5 p6 p7 p8 p9 >
[    2.074043] |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/
[    2.085233] mmc1: new high speed SDIO card at address 0001
[    2.085261] -\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/
[    2.089737] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[    2.089807] -\
[    2.089922] brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43455-sdio.bin failed with error -2
[    2.089930] brcmfmac mmc1:0001:1: Falling back to sysfs fallback for: brcm/brcmfmac43455-sdio.bin
[    2.090004] |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\
[    2.128832] |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\
[    2.162680] |/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/-\|/done.
[    2.225702] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    2.278295] VFS: Mounted root (squashfs filesystem) readonly on device 1:0.
[    2.278510] devtmpfs: mounted
[    2.279537] Freeing unused kernel memory: 2048K
[    2.345957] Run /init as init process
[    2.345965]   with arguments:
[    2.345973]     /init
[    2.345980]   with environment:
[    2.345988]     HOME=/
[    2.345995]     TERM=linux
[    2.346003]     repo_list=http://raw.githubusercontent.com/procount/pinn-os/master/os/repo_list.json
[    2.408348] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
[    2.408356] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    2.408362] usb 1-1: Product: USB2.0 Hub
[    2.411068] hub 1-1:1.0: USB hub found
[    2.411372] hub 1-1:1.0: 4 ports detected
[    2.735692] usb 1-1.3: new low-speed USB device number 3 using xhci_hcd
[    2.873995] usb 1-1.3: New USB device found, idVendor=413c, idProduct=301a, bcdDevice= 1.00
[    2.874008] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    2.874019] usb 1-1.3: Product: Dell MS116 USB Optical Mouse
[    2.874029] usb 1-1.3: Manufacturer: PixArt
[    2.882261] input: PixArt Dell MS116 USB Optical Mouse as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.0/0003:413C:301A.0001/input/input0
[    2.882616] hid-generic 0003:413C:301A.0001: input,hidraw0: USB HID v1.11 Mouse [PixArt Dell MS116 USB Optical Mouse] on usb-0000:01:00.0-1.3/input0
[    2.975687] usb 1-1.4: new low-speed USB device number 4 using xhci_hcd
[    3.113902] usb 1-1.4: New USB device found, idVendor=413c, idProduct=2107, bcdDevice= 1.04
[    3.113915] usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    3.113925] usb 1-1.4: Product: Dell USB Entry Keyboard
[    3.113935] usb 1-1.4: Manufacturer: DELL
[    3.123420] input: DELL Dell USB Entry Keyboard as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.0/0003:413C:2107.0002/input/input1
[    3.186255] hid-generic 0003:413C:2107.0002: input,hidraw1: USB HID v1.11 Keyboard [DELL Dell USB Entry Keyboard] on usb-0000:01:00.0-1.4/input0
[    3.574331] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[    4.451937] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Jan  4 2021 19:56:29 version 7.45.229 (617f1f5 CY) FWID 01-2dbd9d2e
[    5.449713] uart-pl011 fe201000.serial: no DMA platform data
[    6.532035] FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
[    7.235775] input: uinput-sample as /devices/virtual/input/input2
[    7.647695] EXT4-fs (mmcblk0p5): mounted filesystem with ordered data mode. Opts: (null)
[    8.968141] EXT4-fs (mmcblk0p5): mounted filesystem with ordered data mode. Opts: (null)
[    9.006416] random: dbus-uuidgen: uninitialized urandom read (12 bytes read)
[    9.006443] random: dbus-uuidgen: uninitialized urandom read (8 bytes read)
[    9.019334] random: dbus-daemon: uninitialized urandom read (12 bytes read)
[    9.210051] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
[    9.339584] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
[    9.339789] bcmgenet fd580000.ethernet eth0: Link is Down
[   11.445936] bcmgenet fd580000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx
[   11.454440] urandom_read: 2 callbacks suppressed
[   11.454445] random: dhcpcd: uninitialized urandom read (120 bytes read)
[   12.025730] random: dhcpcd: uninitialized urandom read (120 bytes read)
[   12.025869] random: dhcpcd: uninitialized urandom read (120 bytes read)
[   15.081560] urandom_read: 1 callbacks suppressed
[   15.081566] random: dhcpcd: uninitialized urandom read (120 bytes read)
[   15.149710] random: crng init done
[   32.485701] cam-dummy-reg: disabling
[   32.485717] cam1-reg: disabling
[  174.863384] FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
procount commented 1 year ago

There's nothing obvious in there. I will try to replicate it.

axalppro commented 1 year ago

Thanks !

Also I tried your savelog script. I get this error.

root@recovery:~# /mnt/savelog
find: /tmp/media: No such file or directory
root@recovery:~#

And just to make sure I understand the process right, pinn_init.sh is run before Pinn has booted meaning that using the rebootp command in the pinn_init script should prevent the Pinn GUI etc. to appear ?

procount commented 1 year ago

It should still have produced a /mnt/log file. It hust means you didn't have any USB drives connected.

Yes, pinn_init.sh is run from init, but as it can't be executed for some reason, init continues to boot PINN.

axalppro commented 1 year ago

Okay, I tried a new clean install on another hardware using a Compute Module 4, as I have to connect via VNC, I don't see the error but Pinn boots so I think the script isn't executed. I check the debug and dmesg files nothing seems suspicious.

Do you have any idea where I could look into next ?

procount commented 1 year ago

I think you might have DOS line endings for pinn_init.sh instead of UNIX line endings. Please check by going to PINN's command shell and type nano /mnt/pinn_init.sh If you see a ^M at the end of every line, you have DOS line endings and the ^Ms must be removed.

In linux, you can use the dos2unix tool to remove them. In Windows you can use notepad++ to change the line endings.

axalppro commented 1 year ago

That was it, now it works. So awesome to change OS with a jumper. Thanks for the support !