Installation failed twice (Install and pre-install logs attached)

Q&A
1

Hi my install failed twice, everything seemed fine, no obvious bugs until the install failed.

I did it once with the destructive install option while connected to the internet and once with the safe option, not connected to the internet. It got a lot further with the safe option.

Destructive install (online)

Install log

https://drive.google.com/file/d/1zEVw2yKwn2JuZlqF570uzKq5WXY4G0BG/view?usp=sharing

Safe install (offline)

Install log

https://drive.google.com/file/d/1qBX8CNaazAETC44oXo4y9HTzhyZ8v_5N/view?usp=sharing

This is the end of the safe offline install log.

2021/12/13 01:49:51 [DBG] { "type" : "progress", "currentStep" : 5, "totalSteps" : 9, "stepCompletion" : 100, "stepDescription" : "validate_fullfiles" },
2021/12/13 01:49:51 [DBG] Target OS: : Task validate_fullfiles completed
2021/12/13 01:49:51 [DBG] { "type" : "progress", "currentStep" : 6, "totalSteps" : 9, "stepCompletion" : 0, "stepDescription" : "download_fullfiles" },
2021/12/13 01:49:51 [DBG] Target OS: : Setting progress for task download_fullfiles
2021/12/13 01:49:51 [DBG] { "type" : "error", "msg" : "Failed to connect to update server: https://cdn.download.clearlinux.org/update" },
2021/12/13 01:49:51 [DBG] { "type" : "info", "msg" : "Possible solutions for this problem are: 	Check if your network connection is working 	Fix the system clock 	Run 'swupd info' to check if the urls are correct 	Check if the server SSL certificate is trusted by your system ('clrtrust generate' may help)" },
2021/12/13 01:49:51 [ERR] error decoding JSON: invalid character '\t' in string literal
2021/12/13 01:49:51 [DBG] { "type" : "error", "msg" : "Curl - Invalid parallel download handle" },
2021/12/13 01:49:51 [DBG] { "type" : "progress", "currentStep" : 6, "totalSteps" : 9, "stepCompletion" : 100, "stepDescription" : "download_fullfiles" },
2021/12/13 01:49:51 [DBG] Target OS: : Task download_fullfiles completed
2021/12/13 01:49:51 [DBG] { "type" : "progress", "currentStep" : 7, "totalSteps" : 9, "stepCompletion" : -1, "stepDescription" : "extract_fullfiles" },
2021/12/13 01:49:51 [DBG] Target OS: : Setting indeterminate progress for task extract_fullfiles
2021/12/13 01:49:51 [DBG] { "type" : "error", "msg" : "Unable to download necessary files for this OS release" },
2021/12/13 01:49:51 [DBG] { "type" : "info", "msg" : " Installation failed" },
2021/12/13 01:49:51 [DBG] { "type" : "progress", "currentStep" : 7, "totalSteps" : 9, "stepCompletion" : 100, "stepDescription" : "extract_fullfiles" },
2021/12/13 01:49:51 [DBG] Target OS: : Task extract_fullfiles completed
2021/12/13 01:49:51 [DBG] { "type" : "end", "section" : "os-install", "status" : 17 }
2021/12/13 01:49:51 [DBG] ]
2021/12/13 01:49:51 [ERR] An error occurred executing command: "swupd os-install --statedir-cache=/var/lib/clr-installer/offline-content --path=/tmp/install-097953070 --statedir=/tmp/install-097953070/var/lib/swupd -V 35000 --force --no-boot-update --json-output -B os-core-update,openssh-server,c-basic,desktop-autostart,git,vim,NetworkManager,sysadmin-basic,tzdata,kernel-native". Error: exit status 17
2021/12/13 01:49:51 [INF] Umounting rootDir: /tmp/install-097953070
2021/12/13 01:49:51 [DBG] Unmounted ok: /tmp/install-097953070/sys
2021/12/13 01:49:51 [DBG] Unmounted ok: /tmp/install-097953070/proc
2021/12/13 01:49:51 [DBG] Unmounted ok: /tmp/install-097953070/dev
2021/12/13 01:49:51 [DBG] Unmounted ok: /tmp/install-097953070/boot
2021/12/13 01:49:55 [DBG] Unmounted ok: /tmp/install-097953070
2021/12/13 01:49:55 [INF] Removing rootDir: /tmp/install-097953070
2021/12/13 01:49:55 [INF] Running post-image hooks
2021/12/13 01:49:55 [INF] Installation Steps Complete
2021/12/13 01:49:56 [DBG] timeout --kill-after=30s 30s curl --no-sessionid -o /tmp/clr-installer-yaml-305801360 -s -f https://cdn.download.clearlinux.org/releases/35000/clear/config/image/.data/post-gui-install-msg.yaml
2021/12/13 01:49:56 [DBG] sync user is PKEXEC_UID=#1000
2021/12/13 01:49:56 [DBG] Gnome Proxy Mode: none
2021/12/13 01:49:56 [DBG] [Previous line repeated 4 times]
2021/12/13 01:49:56 [DBG] cmd.Env: []
2021/12/13 01:49:56 [DBG] FetchRemoteConfigFile failed : "exit status 6"
2021/12/13 01:49:56 [DBG] Failed to download the Post-Installation message: exit status 6

And this is the end of destructive online install log. It had an error much sooner.

2021/12/13 01:15:36 [DBG] Writing superblocks and filesystem accounting information: 
2021/12/13 01:15:36 [DBG]    0/3725
2021/12/13 01:15:37 [DBG]  344/3725
2021/12/13 01:15:37 [DBG]          
2021/12/13 01:15:39 [DBG] done
2021/12/13 01:15:39 [DBG] blkid --probe /dev/sda2 --output export
2021/12/13 01:15:39 [DBG] sync user is PKEXEC_UID=#1000
2021/12/13 01:15:39 [DBG] Gnome Proxy Mode: none
2021/12/13 01:15:39 [DBG] [Previous line repeated 4 times]
2021/12/13 01:15:39 [DBG] cmd.Env: []
2021/12/13 01:15:39 [DBG] updatePartitionInfo: Updated /dev/sda2 LABEL: root
2021/12/13 01:15:39 [DBG] updatePartitionInfo: Updated /dev/sda2 UUID: 7dababa9-0358-4527-9f1c-175b88abf9e0
2021/12/13 01:15:39 [DBG] updatePartitionInfo: Ignoring unknown line: 
2021/12/13 01:15:39 [DBG] partprobe -s
2021/12/13 01:15:39 [DBG] sync user is PKEXEC_UID=#1000
2021/12/13 01:15:39 [DBG] Gnome Proxy Mode: none
2021/12/13 01:15:39 [DBG] [Previous line repeated 4 times]
2021/12/13 01:15:39 [DBG] cmd.Env: []
2021/12/13 01:15:39 [DBG] /dev/sda: gpt partitions 1 2
2021/12/13 01:15:39 [DBG] /dev/sdb: msdos partitions 1 2
2021/12/13 01:15:39 [DBG] udevadm settle --timeout 10
2021/12/13 01:15:39 [DBG] sync user is PKEXEC_UID=#1000
2021/12/13 01:15:39 [DBG] Gnome Proxy Mode: none
2021/12/13 01:15:39 [DBG] [Previous line repeated 4 times]
2021/12/13 01:15:39 [DBG] cmd.Env: []
2021/12/13 01:15:40 [DBG] lsblk --exclude 1,2,11 -J -b -O
2021/12/13 01:15:40 [DBG] sync user is PKEXEC_UID=#1000
2021/12/13 01:15:40 [DBG] Gnome Proxy Mode: none
2021/12/13 01:15:40 [DBG] [Previous line repeated 4 times]
2021/12/13 01:15:40 [DBG] cmd.Env: []
2021/12/13 01:15:40 [DBG] parted --machine --script -- /dev/loop0 unit B print free
2021/12/13 01:15:40 [DBG] sync user is PKEXEC_UID=#1000
2021/12/13 01:15:40 [DBG] Gnome Proxy Mode: none
2021/12/13 01:15:40 [DBG] [Previous line repeated 4 times]
2021/12/13 01:15:40 [DBG] cmd.Env: []
2021/12/13 01:15:40 [WRN] getPartitionTable() had an error reading partition table "Error: /dev/loop0: unrecognised disk label\nBYT;\n/dev/loop0:2894643200B:loopback:512:512:unknown:Loopback device:;\n"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is ""
2021/12/13 01:15:40 [DBG] parted --machine --script -- /dev/sda unit B print free
2021/12/13 01:15:40 [DBG] sync user is PKEXEC_UID=#1000
2021/12/13 01:15:40 [DBG] Gnome Proxy Mode: none
2021/12/13 01:15:40 [DBG] [Previous line repeated 4 times]
2021/12/13 01:15:40 [DBG] cmd.Env: []
2021/12/13 01:15:40 [DBG] setPartitionTable() line is "BYT"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is "/dev/sda:500107862016B:scsi:512:4096:gpt:ATA TOSHIBA MQ01ACF0:"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is "1:17408B:1048575B:1031168B:free"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is "1:1048576B:157286399B:156237824B:fat32:EFI:boot, esp"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is "2:157286400B:500106788863B:499949502464B:ext4:/:"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is "1:500106788864B:500107845119B:1056256B:free"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is ""
2021/12/13 01:15:40 [DBG] parted --machine --script -- /dev/sdb unit B print free
2021/12/13 01:15:40 [DBG] sync user is PKEXEC_UID=#1000
2021/12/13 01:15:40 [DBG] Gnome Proxy Mode: none
2021/12/13 01:15:40 [DBG] [Previous line repeated 4 times]
2021/12/13 01:15:40 [DBG] cmd.Env: []
2021/12/13 01:15:40 [DBG] setPartitionTable() line is "BYT"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is "/dev/sdb:30979129344B:scsi:512:512:msdos: USB Flash Memory:"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is "1:1024B:1048575B:1047552B:free"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is "1:1048576B:30945574911B:30944526336B:::boot"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is "2:30945574912B:30979129343B:33554432B:fat16::esp"
2021/12/13 01:15:40 [DBG] setPartitionTable() line is ""
2021/12/13 01:15:40 [INF] Mounting: /
2021/12/13 01:15:40 [INF] Running post-image hooks
2021/12/13 01:15:40 [INF] Installation Steps Complete
2021/12/13 01:15:40 [DBG] timeout --kill-after=30s 30s curl --no-sessionid -o /tmp/clr-installer-yaml-887754875 -s -f https://cdn.download.clearlinux.org/releases/35000/clear/config/image/.data/post-gui-install-msg.yaml
2021/12/13 01:15:40 [DBG] sync user is PKEXEC_UID=#1000
2021/12/13 01:15:40 [DBG] Gnome Proxy Mode: none
2021/12/13 01:15:40 [DBG] [Previous line repeated 4 times]
2021/12/13 01:15:40 [DBG] cmd.Env: []
2021/12/13 01:15:41 [DBG] Post-Installation has no message content
2

Pre install logs.

Safe, offline:


#clear-linux-config
#generated by clr-installer:2.7.2-2-g9eac32df5b82
#generated on: 2021-12-13_01:31:54_UTC
targetMedia:
- name: sda
  path: /dev/sda
  model: TOSHIBA MQ01ACF050
  majMin: "8:0"
  serial: 678HCJQGT
  size: "500107862016"
  ro: "false"
  rm: "false"
  type: disk
  state: running
  children:
  - name: sda1
    fstype: vfat
    mountpoint: /boot
    label: boot
    size: "157286400"
    ro: "false"
    rm: "false"
    type: part
  - name: sda2
    fstype: ext4
    mountpoint: /
    label: root
    size: "499950575616"
    ro: "false"
    rm: "false"
    type: part
keyboard: us
language: en_US.UTF-8
bundles: [c-basic, desktop-autostart, git, openssh-server, os-core, os-core-update,
  vim]
telemetry: false
timezone: Pacific/Auckland
users: [{login: am, username: am, password: $6$jDZfKGxPsNz78kk/$iGDcsOAyqlnszpNJ1vwXnxl6IFM.0AjDoZNZ7RydS9CAfB0Bl79OEhrqR2iUYVZC24Xu.hk48fZUcYiHIdREs.,
    admin: true}]
kernel: kernel-native
autoUpdate: true
copyNetwork: true
copySwupd: true
keepImage: true
preCheckDone: true
swapFileSize: 64MiB

Destructive, online:

#clear-linux-config
#generated by clr-installer:2.7.2-2-g9eac32df5b82
#generated on: 2021-12-13_01:15:18_UTC
targetMedia:
- name: sda
  path: /dev/sda
  model: TOSHIBA MQ01ACF050
  majMin: "8:0"
  serial: 678HCJQGT
  size: "500107862016"
  ro: "false"
  rm: "false"
  type: disk
  state: running
  children:
  - name: sda1
    fstype: vfat
    mountpoint: /boot
    label: boot
    size: "157286400"
    ro: "false"
    rm: "false"
    type: part
  - name: sda2
    fstype: ext4
    mountpoint: /
    label: root
    size: "499950575616"
    ro: "false"
    rm: "false"
    type: part
keyboard: us
language: en_US.UTF-8
bundles: [c-basic, desktop-autostart, git, openssh-server, os-core, os-core-update,
  vim]
telemetry: true
timezone: Pacific/Auckland
users: [{login: am, username: am, password: $6$QUCYCLaN6I9bOTrc$61QJSUavIGCTOMyFTcVd5nXPQVBZlirZvBvTMuH7.oNlHkz.gqGbBI8md87wuKCEAQaqp2bBhfuTuIaMiDi1i1,
    admin: true}]
kernel: kernel-native
autoUpdate: true
copyNetwork: true
copySwupd: true
keepImage: true
preCheckDone: true
swapFileSize: 64MiB
3

I think the destructive online one failed because it tried to mount the USB.

2021/12/13 01:15:40 [DBG] setPartitionTable() line is "/dev/sdb:30979129344B:scsi:512:512:msdos: USB Flash Memory:"

Perhaps the safe online one failed because it needed to connect to the internet.

2021/12/13 01:49:56 [DBG] FetchRemoteConfigFile failed : "exit status 6"

Both seem odd though, it didn’t complain about being offline, and the destructive online fail seems like a bug, right?

4

Good job on capturing the logs. That’s always helpful. Can you file an issue here? Someone on the installer team would likely be interested.

It would also be helpful to include what tool/steps you used to make the bootable USB