WIP: Turris 1x broken after migration
I started with TOS 3.11.23 - asked for the migration process to be run by updater. No special setup, only the NTFS formatted SD card installed, thus th system was before btrfs_migrate
.
Updater started with migration and first problem appeared.
2021-12-28 16:12:27 info updater[17062]: src/lib/logging.c:206 (log_subproc_open): Running postinst of libgcc
2021-12-28 16:12:27 info kernel[]: [ 282.537902] libgcc.postinst[18262]: unhandled signal 11 at fffffb34 nip b7f2a05c lr b7f196b0 code 30001
2021-12-28 16:12:27 info updater[17062]: src/lib/logging.c:206 (log_subproc_open): Running postinst of libc
2021-12-28 16:12:27 info kernel[]: [ 282.553791] libc.postinst[18263]: unhandled signal 11 at 00002b34 nip b7bcd05c lr b7bbc6b0 code 30001
2021-12-28 16:12:27 info updater[17062]: src/lib/logging.c:206 (log_subproc_open): Running postinst of tos3to4-earliest
2021-12-28 16:12:27 info kernel[]: [ 282.568037] tos3to4-earlies[18264]: unhandled signal 11 at ffff9b34 nip b7de405c lr b7dd36b0 code 30001
2021-12-28 16:12:27 info updater[17062]: src/lib/logging.c:206 (log_subproc_open): Running postinst of libjson-c
2021-12-28 16:12:27 info kernel[]: [ 282.583715] libjson-c.posti[18265]: unhandled signal 4 at b78b8060 nip b78b8060 lr b78a76b0 code 30001
2021-12-28 16:12:27 info updater[17062]: src/lib/logging.c:206 (log_subproc_open): Running postinst of libubox
2021-12-28 16:12:27 info kernel[]: [ 282.600724] libubox.postins[18266]: unhandled signal 11 at 00006b34 nip b7e3105c lr b7e206b0 code 30001
2021-12-28 16:12:27 info updater[17062]: src/lib/logging.c:206 (log_subproc_open): Running postinst of jsonfilter
2021-12-28 16:12:27 info kernel[]: [ 282.615858] jsonfilter.post[18268]: unhandled signal 11 at b7f0fbc8 nip b7f1505c lr b7f046b0 code 30002
2021-12-28 16:12:27 info updater[17062]: src/lib/logging.c:206 (log_subproc_open): Running postinst of busybox
2021-12-28 16:12:27 info kernel[]: [ 282.631217] busybox.postins[18269]: unhandled signal 11 at ffffab34 nip b7cd505c lr b7cc46b0 code 30001
2021-12-28 16:12:27 info updater[17062]: src/lib/logging.c:206 (log_subproc_open): Running postinst of ca-certificates
2021-12-28 16:12:27 info kernel[]: [ 282.646944] ca-certificates[18270]: unhandled signal 11 at 04008b34 nip b784105c lr b78306b0 code 30001
2021-12-28 16:12:27 info updater[17062]: src/lib/logging.c:206 (log_subproc_open): Running postinst of libopenssl
2021-12-28 16:12:28 info kernel[]: [ 282.662270] libopenssl.post[18271]: unhandled signal 11 at ffffcf50 nip b7d7705c lr b7d666b0 code 30001
2021-12-28 16:12:28 info updater[17062]: src/lib/logging.c:206 (log_subproc_open): Running postinst of libexpat
2021-12-28 16:12:28 info kernel[]: [ 282.678177] libexpat.postin[18272]: unhandled signal 4 at b7c79060 nip b7c79060 lr b7c686b0 code 30001
<output ommited>
2021-12-28 16:12:29 info updater-supervisor[]: pkgupdate exited with: -4
2021-12-28 16:12:29 info updater-supervisor[]: Notification creation failed.
2021-12-28 16:12:29 info updater-supervisor[5500]: Last message 'Notification creatio' repeated 1 times, suppressed by syslog-ng on turris
2021-12-28 16:12:29 info updater-supervisor[]: Notifier failed
2021-12-28 16:12:55 err foris-controller[16562]: ERROR:foris_controller_backends.uci:Uci transaction terminated.
2021-12-28 16:12:55 err foris-controller[16562]: ERROR:foris_controller.message_router:Internal error occured <class 'FileNotFoundError'>('[Errno 2] No such file or directory: 'uci''):
2021-12-28 16:12:55 warning kernel[]: [ 310.582492] _exception: 17 callbacks suppressed
2021-12-28 16:12:55 info kernel[]: [ 310.582506] list_notificati[18302]: unhandled signal 11 at 00001b34 nip b7fdc05c lr b7fcb6b0 code 30001
2021-12-28 16:12:55 err foris-controller[16562]: ERROR:foris_controller_backends.cmdline:Command ('/usr/bin/list_notifications', '-n') unexpected returncode (-11, expected 0).
2021-12-28 16:12:55 err foris-controller[16562]: ERROR:foris_controller.message_router:Internal error occured <class 'foris_controller.exceptions.BackendCommandFailed'>('Retval=-11 for ('/usr/bin/list_notifications', '-n')'):
which led to (after the reboot)
/etc/preinit: exec: line 5: /sbin/init: not found
[ 3.473140] Kernel panic - not syncing: Attempted to kill init! exitcode=0x00007f00
[ 3.473140]
[ 3.482286] CPU: 1 PID: 1 Comm: sh Not tainted 4.4.199-f90a52a6230ecb072f657fce5aebd444-1 #1
[ 3.490724] Call Trace:
[ 3.493174] [da843e60] [c04ed1f8] dump_stack+0x84/0xb0 (unreliable)
[ 3.499446] [da843e70] [c04e8d94] panic+0xe0/0x21c
[ 3.504240] [da843ed0] [c002e778] do_exit+0x430/0x84c
[ 3.509291] [da843f10] [c002ec18] do_group_exit+0x48/0xac
[ 3.514690] [da843f30] [c002ec90] __wake_up_parent+0x0/0x18
[ 3.520267] [da843f40] [c000e18c] ret_from_syscall+0x0/0x3c
[ 3.525841] --- interrupt: c01 at 0xb79a9214
[ 3.525841] LR = 0xb7a005b0
[ 3.533244] ---[ end Kernel panic - not syncing: Attempted to kill init! exitcode=0x00007f00
[ 3.533244]
After the factory reset, I upgraded to 3.11.23 again and tried a manual btrfs migration, which was partly successful.
root@turris:/# btrfs_migrate
Are you sure you want to lose everything on mmcblk0? (yes/no)
yes
11+0 records in
11+0 records out
Welcome to fdisk (util-linux 2.29.2).
Changes will remain in memory only, until you decide to write them.
Be careful before using the write command.
Device does not contain a recognized partition table.
Created a new DOS disklabel with disk identifier 0x24cb70dc.
Command (m for help): Created a new DOS disklabel with disk identifier 0x1f92cd7b.
Command (m for help): Partition type
p primary (0 primary, 0 extended, 4 free)
e extended (container for logical partitions)
Select (default p): Partition number (1-4, default 1): First sector (2048-31116287, default 2048): Last sector, +sectors or +size{K,M,G,T,P} (2048-31116287, default 31116287):
Created a new partition 1 of type 'Linux' and of size 100 MiB.
Command (m for help): Partition type
p primary (1 primary, 0 extended, 3 free)
e extended (container for logical partitions)
Select (default p): Partition number (2-4, default 2): First sector (206848-31116287, default 206848): Last sector, +sectors or +size{K,M,G,T,P} (206848-31116287, default 31116287):
Created a new partition 2 of type 'Linux' and of size 14.8 GiB.
Command (m for help): The partition table has been altered.
Calling ioctl() to re-read partition table.
Syncing disks.
mkfs.fat 3.0.28 (2015-05-16)
btrfs-progs v5.6
See http://btrfs.wiki.kernel.org for more information.
Detected a SSD, turning off metadata duplication. Mkfs with -m dup if you want to force metadata duplication.
Performing full device TRIM /dev/mmcblk0p2 (14.74GiB) ...
Warning, could not drop caches
Warning, could not drop caches
Label: (null)
UUID: 1aac0a75-1cf7-4ca6-9918-54d8379670fd
Node size: 16384
Sector size: 4096
Filesystem size: 14.74GiB
Block group profiles:
Data: single 8.00MiB
Metadata: single 8.00MiB
System: single 4.00MiB
SSD detected: yes
Incompat features: extref, skinny-metadata
Checksum: crc32c
Number of devices: 1
Devices:
ID SIZE PATH
1 14.74GiB /dev/mmcblk0p2
Warning, could not drop caches
Create subvolume '/tmp/btrfs-convert/target/@'
mount: unknown filesystem type 'vfat'
Can't mount fat
root@turris:/# reboot
root@turris:/# Stopping router Turris.
Next reboot was still from the NAND.
root@turris:/# mount
ubi0:rootfs on / type ubifs (rw,noatime,chk_data_crc)
The second attempt of btrfs migration was successful.
root@turris:/# btrfs_migrate
Are you sure you want to lose everything on mmcblk0? (yes/no)
yes
11+0 records in
11+0 records out
Welcome to fdisk (util-linux 2.29.2).
Changes will remain in memory only, until you decide to write them.
Be careful before using the write command.
Device does not contain a recognized partition table.
Created a new DOS disklabel with disk identifier 0x4fcec8a8.
Command (m for help): Created a new DOS disklabel with disk identifier 0x2c3ea739.
Command (m for help): Partition type
p primary (0 primary, 0 extended, 4 free)
e extended (container for logical partitions)
Select (default p): Partition number (1-4, default 1): First sector (2048-31116287, default 2048): Last sector, +sectors or +size{K,M,G,T,P} (2048-31116287, default 31116287):
Created a new partition 1 of type 'Linux' and of size 100 MiB.
Command (m for help): Partition type
p primary (1 primary, 0 extended, 3 free)
e extended (container for logical partitions)
Select (default p): Partition number (2-4, default 2): First sector (206848-31116287, default 206848): Last sector, +sectors or +size{K,M,G,T,P} (206848-31116287, default 31116287):
Created a new partition 2 of type 'Linux' and of size 14.8 GiB.
Command (m for help): The partition table has been altered.
Calling ioctl() to re-read partition table.
Syncing disks.
mkfs.fat 3.0.28 (2015-05-16)
btrfs-progs v5.6
See http://btrfs.wiki.kernel.org for more information.
Detected a SSD, turning off metadata duplication. Mkfs with -m dup if you want to force metadata duplication.
Performing full device TRIM /dev/mmcblk0p2 (14.74GiB) ...
Label: (null)
UUID: 7d8378ba-6656-4b73-984f-db2c52f7b28b
Node size: 16384
Sector size: 4096
Filesystem size: 14.74GiB
Block group profiles:
Data: single 8.00MiB
Metadata: single 8.00MiB
System: single 4.00MiB
SSD detected: yes
Incompat features: extref, skinny-metadata
Checksum: crc32c
Number of devices: 1
Devices:
ID SIZE PATH
1 14.74GiB /dev/mmcblk0p2
Create subvolume '/tmp/btrfs-convert/target/@'
Warning: Bad CRC, using default environment
Migration successful, please reboot!
root@turris:/#
###
BusyBox v1.29.3 () built-in shell (ash)
_______ _ _ _____ _____ _____ _____
|__ __|| | | || __ \ | __ \ |_ _| / ____|
| | | | | || |__) || |__) | | | | (___
| | | | | || _ / | _ / | | \___ \
| | | |__| || | \ \ | | \ \ _| |_ ____) |
|_| \____/ |_| \_\|_| \_\|_____||_____/
root@turris:/# mount
/dev/mmcblk0p2 on / type btrfs (rw,noatime,ssd,space_cache,commit=5,subvolid=257,subvol=/@)