- {"dt": "2024-01-25T11:25:40.047264", "lvl": "info", "msg": "lava-dispatcher, installed at version: 2023.08"}
- {"dt": "2024-01-25T11:25:40.047371", "lvl": "info", "msg": "start: 0 validate"}
- {"dt": "2024-01-25T11:25:40.047448", "lvl": "info", "msg": "Start time: 2024-01-25 11:25:40.047443+00:00 (UTC)"}
- {"dt": "2024-01-25T11:25:40.048304", "lvl": "debug", "msg": "Validating that https://storage.tuxsuite.com/public/linaro/lkft/builds/2bHjk40p4iBVk4wj4jcVWOIXw5P/Image.gz exists"}
- {"dt": "2024-01-25T11:25:40.449566", "lvl": "debug", "msg": "Using GET because HEAD is not supported properly"}
- {"dt": "2024-01-25T11:25:41.378773", "lvl": "debug", "msg": "Validating that file:///home/anders/src/tmp/xfstests-artifacts/root_fs.arm64.ext4.xz exists"}
- {"dt": "2024-01-25T11:25:41.379065", "lvl": "debug", "msg": "Validating that https://storage.tuxsuite.com/public/linaro/lkft/builds/2bHjk40p4iBVk4wj4jcVWOIXw5P/modules.tar.xz exists"}
- {"dt": "2024-01-25T11:25:41.512690", "lvl": "debug", "msg": "Using GET because HEAD is not supported properly"}
- {"dt": "2024-01-25T11:25:42.270441", "lvl": "debug", "msg": "Validating that file:///home/anders/src/tmp/xfstests-artifacts/xfstests-arm64.tar.xz exists"}
- {"dt": "2024-01-25T11:25:42.281837", "lvl": "info", "msg": "qemu-system-arm, installed at version: 1:8.1.2+ds-1, host architecture: amd64"}
- {"dt": "2024-01-25T11:25:42.282061", "lvl": "warning", "msg": "Missing image arg for rootfs.modules"}
- {"dt": "2024-01-25T11:25:42.282148", "lvl": "warning", "msg": "Missing image arg for rootfs.overlay-00"}
- {"dt": "2024-01-25T11:25:42.282323", "lvl": "info", "msg": "validate duration: 2.23"}
- {"dt": "2024-01-25T11:25:42.282377", "lvl": "results", "msg": {"case": "validate", "definition": "lava", "result": "pass"}}
- {"dt": "2024-01-25T11:25:42.282489", "lvl": "info", "msg": "start: 1 deployimages (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.282560", "lvl": "debug", "msg": "start: 1.1 lava-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.282728", "lvl": "debug", "msg": "[common] Preparing overlay tarball in /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn"}
- {"dt": "2024-01-25T11:25:42.282867", "lvl": "debug", "msg": "makedir: /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin"}
- {"dt": "2024-01-25T11:25:42.282984", "lvl": "debug", "msg": "makedir: /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/tests"}
- {"dt": "2024-01-25T11:25:42.283096", "lvl": "debug", "msg": "makedir: /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/results"}
- {"dt": "2024-01-25T11:25:42.283181", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-add-keys"}
- {"dt": "2024-01-25T11:25:42.283391", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-add-sources"}
- {"dt": "2024-01-25T11:25:42.283688", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-background-process-start"}
- {"dt": "2024-01-25T11:25:42.283978", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-background-process-stop"}
- {"dt": "2024-01-25T11:25:42.284283", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-common-functions"}
- {"dt": "2024-01-25T11:25:42.284568", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-echo-ipv4"}
- {"dt": "2024-01-25T11:25:42.284853", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-install-packages"}
- {"dt": "2024-01-25T11:25:42.285134", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-installed-packages"}
- {"dt": "2024-01-25T11:25:42.285419", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-os-build"}
- {"dt": "2024-01-25T11:25:42.285699", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-probe-channel"}
- {"dt": "2024-01-25T11:25:42.285982", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-probe-ip"}
- {"dt": "2024-01-25T11:25:42.286263", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-target-ip"}
- {"dt": "2024-01-25T11:25:42.286544", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-target-mac"}
- {"dt": "2024-01-25T11:25:42.286827", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-target-storage"}
- {"dt": "2024-01-25T11:25:42.287134", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-test-case"}
- {"dt": "2024-01-25T11:25:42.287421", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-test-event"}
- {"dt": "2024-01-25T11:25:42.287699", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-test-feedback"}
- {"dt": "2024-01-25T11:25:42.287977", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-test-raise"}
- {"dt": "2024-01-25T11:25:42.288253", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-test-reference"}
- {"dt": "2024-01-25T11:25:42.288532", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-test-runner"}
- {"dt": "2024-01-25T11:25:42.288822", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-test-set"}
- {"dt": "2024-01-25T11:25:42.289104", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-test-shell"}
- {"dt": "2024-01-25T11:25:42.289397", "lvl": "debug", "msg": "Updating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-install-packages (oe)"}
- {"dt": "2024-01-25T11:25:42.289712", "lvl": "debug", "msg": "Updating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/bin/lava-installed-packages (oe)"}
- {"dt": "2024-01-25T11:25:42.289967", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/environment"}
- {"dt": "2024-01-25T11:25:42.290169", "lvl": "debug", "msg": "LAVA metadata"}
- {"dt": "2024-01-25T11:25:42.290285", "lvl": "debug", "msg": "- LAVA_JOB_ID=1"}
- {"dt": "2024-01-25T11:25:42.290407", "lvl": "debug", "msg": "- LAVA_DISPATCHER_IP=10.0.2.100"}
- {"dt": "2024-01-25T11:25:42.290607", "lvl": "debug", "msg": "start: 1.1.1 lava-vland-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.290719", "lvl": "debug", "msg": "skipped lava-vland-overlay"}
- {"dt": "2024-01-25T11:25:42.290870", "lvl": "debug", "msg": "end: 1.1.1 lava-vland-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.291042", "lvl": "debug", "msg": "start: 1.1.2 lava-multinode-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.291146", "lvl": "debug", "msg": "skipped lava-multinode-overlay"}
- {"dt": "2024-01-25T11:25:42.291290", "lvl": "debug", "msg": "end: 1.1.2 lava-multinode-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.291437", "lvl": "debug", "msg": "start: 1.1.3 test-definition (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.291560", "lvl": "info", "msg": "Loading test definitions"}
- {"dt": "2024-01-25T11:25:42.291716", "lvl": "debug", "msg": "start: 1.1.3.1 inline-repo-action (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.291830", "lvl": "debug", "msg": "Using /lava-1 at stage 0"}
- {"dt": "2024-01-25T11:25:42.292436", "lvl": "debug", "msg": "uuid=1_1.1.3.1 testdef=None"}
- {"dt": "2024-01-25T11:25:42.292586", "lvl": "debug", "msg": "end: 1.1.3.1 inline-repo-action (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.292735", "lvl": "debug", "msg": "start: 1.1.3.2 test-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.293560", "lvl": "debug", "msg": "end: 1.1.3.2 test-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.293677", "lvl": "results", "msg": {"case": "test-overlay", "definition": "lava", "duration": "0.00", "extra": {"from": "inline", "name": "commands", "path": "command", "uuid": "1_1.1.3.1"}, "level": "1.1.3.2", "namespace": "common", "result": "pass"}}
- {"dt": "2024-01-25T11:25:42.293944", "lvl": "debug", "msg": "start: 1.1.3.3 test-install-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.294957", "lvl": "debug", "msg": "end: 1.1.3.3 test-install-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.295077", "lvl": "results", "msg": {"case": "test-install-overlay", "definition": "lava", "duration": "0.00", "extra": {"from": "inline", "name": "commands", "path": "command", "skipped test-install-overlay": "1_1.1.3.1", "uuid": "1_1.1.3.1"}, "level": "1.1.3.3", "namespace": "common", "result": "pass"}}
- {"dt": "2024-01-25T11:25:42.295349", "lvl": "debug", "msg": "start: 1.1.3.4 test-runscript-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.298405", "lvl": "debug", "msg": "runner path: /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/0/tests/0_commands test_uuid 1_1.1.3.1"}
- {"dt": "2024-01-25T11:25:42.298836", "lvl": "debug", "msg": "end: 1.1.3.4 test-runscript-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.298976", "lvl": "results", "msg": {"case": "test-runscript-overlay", "definition": "lava", "duration": "0.00", "extra": {"filename": "/var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/0/tests/0_commands/run.sh", "from": "inline", "name": "commands", "path": "command", "uuid": "1_1.1.3.1"}, "level": "1.1.3.4", "namespace": "common", "result": "pass"}}
- {"dt": "2024-01-25T11:25:42.299207", "lvl": "info", "msg": "Creating lava-test-runner.conf files"}
- {"dt": "2024-01-25T11:25:42.299324", "lvl": "debug", "msg": "Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/lava-overlay-sev721sn/lava-1/0 for stage 0"}
- {"dt": "2024-01-25T11:25:42.299524", "lvl": "debug", "msg": "- 0_commands"}
- {"dt": "2024-01-25T11:25:42.299717", "lvl": "debug", "msg": "end: 1.1.3 test-definition (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.299866", "lvl": "debug", "msg": "start: 1.1.4 compress-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.311527", "lvl": "debug", "msg": "end: 1.1.4 compress-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.311707", "lvl": "debug", "msg": "start: 1.1.5 persistent-nfs-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.311872", "lvl": "debug", "msg": "end: 1.1.5 persistent-nfs-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.312030", "lvl": "debug", "msg": "end: 1.1 lava-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.312177", "lvl": "debug", "msg": "start: 1.2 apply-overlay-guest (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.312293", "lvl": "debug", "msg": "Overlay already applied"}
- {"dt": "2024-01-25T11:25:42.312441", "lvl": "debug", "msg": "end: 1.2 apply-overlay-guest (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.312577", "lvl": "debug", "msg": "start: 1.3 deploy-device-env (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.312712", "lvl": "debug", "msg": "end: 1.3 deploy-device-env (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:42.312847", "lvl": "debug", "msg": "start: 1.4 download-retry (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.312983", "lvl": "debug", "msg": "start: 1.4.1 http-download (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:25:42.313232", "lvl": "info", "msg": "downloading https://storage.tuxsuite.com/public/linaro/lkft/builds/2bHjk40p4iBVk4wj4jcVWOIXw5P/Image.gz"}
- {"dt": "2024-01-25T11:25:42.313354", "lvl": "debug", "msg": "saving as /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/kernel/Image"}
- {"dt": "2024-01-25T11:25:42.313473", "lvl": "debug", "msg": "total size: 17645645 (16\u202FMB)"}
- {"dt": "2024-01-25T11:25:42.313590", "lvl": "info", "msg": "Using gunzip to decompress gz"}
- {"dt": "2024-01-25T11:25:43.141097", "lvl": "debug", "msg": "progress   0\u202F% (0\u202FMB)"}
- {"dt": "2024-01-25T11:25:43.586487", "lvl": "debug", "msg": "progress   5\u202F% (0\u202FMB)"}
- {"dt": "2024-01-25T11:25:43.718347", "lvl": "debug", "msg": "progress  10\u202F% (1\u202FMB)"}
- {"dt": "2024-01-25T11:25:43.806926", "lvl": "debug", "msg": "progress  15\u202F% (2\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.038493", "lvl": "debug", "msg": "progress  20\u202F% (3\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.072787", "lvl": "debug", "msg": "progress  25\u202F% (4\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.098302", "lvl": "debug", "msg": "progress  30\u202F% (5\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.128717", "lvl": "debug", "msg": "progress  35\u202F% (5\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.210711", "lvl": "debug", "msg": "progress  40\u202F% (6\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.286627", "lvl": "debug", "msg": "progress  45\u202F% (7\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.362201", "lvl": "debug", "msg": "progress  50\u202F% (8\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.437587", "lvl": "debug", "msg": "progress  55\u202F% (9\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.513249", "lvl": "debug", "msg": "progress  60\u202F% (10\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.588821", "lvl": "debug", "msg": "progress  65\u202F% (10\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.661387", "lvl": "debug", "msg": "progress  70\u202F% (11\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.736956", "lvl": "debug", "msg": "progress  75\u202F% (12\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.812498", "lvl": "debug", "msg": "progress  80\u202F% (13\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.888056", "lvl": "debug", "msg": "progress  85\u202F% (14\u202FMB)"}
- {"dt": "2024-01-25T11:25:44.963602", "lvl": "debug", "msg": "progress  90\u202F% (15\u202FMB)"}
- {"dt": "2024-01-25T11:25:45.039054", "lvl": "debug", "msg": "progress  95\u202F% (16\u202FMB)"}
- {"dt": "2024-01-25T11:25:45.112049", "lvl": "debug", "msg": "progress 100\u202F% (16\u202FMB)"}
- {"dt": "2024-01-25T11:25:45.145184", "lvl": "info", "msg": "16\u202FMB downloaded in 2.83\u202Fs (5.94\u202FMB/s)"}
- {"dt": "2024-01-25T11:25:45.145420", "lvl": "debug", "msg": "end: 1.4.1 http-download (duration 00:00:03) [common]"}
- {"dt": "2024-01-25T11:25:45.145538", "lvl": "results", "msg": {"case": "http-download", "definition": "lava", "duration": "2.83", "extra": {"label": "kernel", "md5sum": "78255b2778c37d2c2979caa4461b81c6", "sha256sum": "8f5253251689b5bd98183843d42b829c9f831d2cdbbf8009631b1aaa5c0d6e6d", "sha512sum": "1eed0fd1d27af93260d0b3c5a0b02c7718665f022ef547e264b1062ca3b8bacda34cfb18ab5a822a822a1ce3639bffb217d51f96ca620e8fb01fd765f6336eb6", "size": ! "17645645"}, "level": "1.4.1", "namespace": "common", "result": "pass"}}
- {"dt": "2024-01-25T11:25:45.145779", "lvl": "debug", "msg": "end: 1.4 download-retry (duration 00:00:03) [common]"}
- {"dt": "2024-01-25T11:25:45.145909", "lvl": "debug", "msg": "start: 1.5 download-retry (timeout 00:04:57) [common]"}
- {"dt": "2024-01-25T11:25:45.146027", "lvl": "debug", "msg": "start: 1.5.1 file-download (timeout 00:04:57) [common]"}
- {"dt": "2024-01-25T11:25:45.146312", "lvl": "info", "msg": "downloading file:///home/anders/src/tmp/xfstests-artifacts/root_fs.arm64.ext4.xz"}
- {"dt": "2024-01-25T11:25:45.146448", "lvl": "debug", "msg": "saving as /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/rootfs/root_fs.arm64.ext4"}
- {"dt": "2024-01-25T11:25:45.146563", "lvl": "debug", "msg": "total size: 109690612 (104\u202FMB)"}
- {"dt": "2024-01-25T11:25:45.146676", "lvl": "info", "msg": "Using unxz to decompress xz"}
- {"dt": "2024-01-25T11:25:45.147500", "lvl": "debug", "msg": "progress   0\u202F% (0\u202FMB)"}
- {"dt": "2024-01-25T11:25:45.431151", "lvl": "debug", "msg": "progress   5\u202F% (5\u202FMB)"}
- {"dt": "2024-01-25T11:25:45.698740", "lvl": "debug", "msg": "progress  10\u202F% (10\u202FMB)"}
- {"dt": "2024-01-25T11:25:45.952479", "lvl": "debug", "msg": "progress  15\u202F% (15\u202FMB)"}
- {"dt": "2024-01-25T11:25:46.178187", "lvl": "debug", "msg": "progress  20\u202F% (20\u202FMB)"}
- {"dt": "2024-01-25T11:25:46.405926", "lvl": "debug", "msg": "progress  25\u202F% (26\u202FMB)"}
- {"dt": "2024-01-25T11:25:46.640873", "lvl": "debug", "msg": "progress  30\u202F% (31\u202FMB)"}
- {"dt": "2024-01-25T11:25:46.864197", "lvl": "debug", "msg": "progress  35\u202F% (36\u202FMB)"}
- {"dt": "2024-01-25T11:25:47.095575", "lvl": "debug", "msg": "progress  40\u202F% (41\u202FMB)"}
- {"dt": "2024-01-25T11:25:47.337103", "lvl": "debug", "msg": "progress  45\u202F% (47\u202FMB)"}
- {"dt": "2024-01-25T11:25:47.567745", "lvl": "debug", "msg": "progress  50\u202F% (52\u202FMB)"}
- {"dt": "2024-01-25T11:25:47.820545", "lvl": "debug", "msg": "progress  55\u202F% (57\u202FMB)"}
- {"dt": "2024-01-25T11:25:48.053249", "lvl": "debug", "msg": "progress  60\u202F% (62\u202FMB)"}
- {"dt": "2024-01-25T11:25:48.284401", "lvl": "debug", "msg": "progress  65\u202F% (68\u202FMB)"}
- {"dt": "2024-01-25T11:25:48.528600", "lvl": "debug", "msg": "progress  70\u202F% (73\u202FMB)"}
- {"dt": "2024-01-25T11:25:48.765404", "lvl": "debug", "msg": "progress  75\u202F% (78\u202FMB)"}
- {"dt": "2024-01-25T11:25:49.005188", "lvl": "debug", "msg": "progress  80\u202F% (83\u202FMB)"}
- {"dt": "2024-01-25T11:25:49.254717", "lvl": "debug", "msg": "progress  85\u202F% (88\u202FMB)"}
- {"dt": "2024-01-25T11:25:49.496405", "lvl": "debug", "msg": "progress  90\u202F% (94\u202FMB)"}
- {"dt": "2024-01-25T11:25:49.716999", "lvl": "debug", "msg": "progress  95\u202F% (99\u202FMB)"}
- {"dt": "2024-01-25T11:25:51.865425", "lvl": "debug", "msg": "progress 100\u202F% (104\u202FMB)"}
- {"dt": "2024-01-25T11:25:52.787938", "lvl": "info", "msg": "104\u202FMB downloaded in 7.64\u202Fs (13.69\u202FMB/s)"}
- {"dt": "2024-01-25T11:25:52.788240", "lvl": "debug", "msg": "end: 1.5.1 file-download (duration 00:00:08) [common]"}
- {"dt": "2024-01-25T11:25:52.788369", "lvl": "results", "msg": {"case": "file-download", "definition": "lava", "duration": "7.64", "extra": {"label": "rootfs", "md5sum": "32a4226c10d530e6ebc0800e8665c824", "sha256sum": "7fd9a7fa21675d9c6bdb8a4005505374acc4121ec66c82312c8873216e9c02bd", "sha512sum": "4a81be7aafe71573b50e84d182d639cc93086289545ff8e20a5f2c7c3dbdfe7f6859f2f5f2b76fc8dd542cea9892a1ed2d8a5e995c9135042018ee514920b97c", "size": ! "109690612"}, "level": "1.5.1", "namespace": "common", "result": "pass"}}
- {"dt": "2024-01-25T11:25:52.788627", "lvl": "debug", "msg": "start: 1.5.2 download-retry (timeout 00:04:49) [common]"}
- {"dt": "2024-01-25T11:25:52.788765", "lvl": "debug", "msg": "start: 1.5.2.1 http-download (timeout 00:04:49) [common]"}
- {"dt": "2024-01-25T11:25:52.789049", "lvl": "info", "msg": "downloading https://storage.tuxsuite.com/public/linaro/lkft/builds/2bHjk40p4iBVk4wj4jcVWOIXw5P/modules.tar.xz"}
- {"dt": "2024-01-25T11:25:52.789162", "lvl": "debug", "msg": "saving as /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/rootfs.modules/modules.tar"}
- {"dt": "2024-01-25T11:25:52.789261", "lvl": "debug", "msg": "total size: 11311756 (10\u202FMB)"}
- {"dt": "2024-01-25T11:25:52.789358", "lvl": "info", "msg": "Using unxz to decompress xz"}
- {"dt": "2024-01-25T11:25:53.722698", "lvl": "debug", "msg": "progress   0\u202F% (0\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.129776", "lvl": "debug", "msg": "progress   5\u202F% (0\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.230218", "lvl": "debug", "msg": "progress  10\u202F% (1\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.277969", "lvl": "debug", "msg": "progress  15\u202F% (1\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.332615", "lvl": "debug", "msg": "progress  20\u202F% (2\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.380360", "lvl": "debug", "msg": "progress  25\u202F% (2\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.427932", "lvl": "debug", "msg": "progress  30\u202F% (3\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.628776", "lvl": "debug", "msg": "progress  35\u202F% (3\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.652886", "lvl": "debug", "msg": "progress  40\u202F% (4\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.675794", "lvl": "debug", "msg": "progress  45\u202F% (4\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.723385", "lvl": "debug", "msg": "progress  50\u202F% (5\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.746697", "lvl": "debug", "msg": "progress  55\u202F% (5\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.773250", "lvl": "debug", "msg": "progress  60\u202F% (6\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.798061", "lvl": "debug", "msg": "progress  65\u202F% (7\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.833191", "lvl": "debug", "msg": "progress  70\u202F% (7\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.880748", "lvl": "debug", "msg": "progress  75\u202F% (8\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.930955", "lvl": "debug", "msg": "progress  80\u202F% (8\u202FMB)"}
- {"dt": "2024-01-25T11:25:54.978686", "lvl": "debug", "msg": "progress  85\u202F% (9\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.026247", "lvl": "debug", "msg": "progress  90\u202F% (9\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.073814", "lvl": "debug", "msg": "progress  95\u202F% (10\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.121594", "lvl": "debug", "msg": "progress 100\u202F% (10\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.123632", "lvl": "info", "msg": "10\u202FMB downloaded in 2.33\u202Fs (4.62\u202FMB/s)"}
- {"dt": "2024-01-25T11:25:55.123853", "lvl": "debug", "msg": "end: 1.5.2.1 http-download (duration 00:00:02) [common]"}
- {"dt": "2024-01-25T11:25:55.123978", "lvl": "results", "msg": {"case": "http-download", "definition": "lava", "duration": "2.34", "extra": {"label": "rootfs.modules", "md5sum": "46e2c4ed5939a2db40e1b1f4d39c9995", "sha256sum": "21cbf3ee881d4c34d63eae76345f27db2698f40d9b437cc6b00da152c4717177", "sha512sum": "d29b6778b9748eb504877ca5242646ae2c1827b01cc8b362788745a5d3c75690b4a8c9edcd178e727ff3ca10dd1fa4c7de759dbea3248f181c7e6194af139ca5", "size": ! "11311756"}, "level": "1.5.2.1", "namespace": "common", "result": "pass"}}
- {"dt": "2024-01-25T11:25:55.124218", "lvl": "debug", "msg": "end: 1.5.2 download-retry (duration 00:00:02) [common]"}
- {"dt": "2024-01-25T11:25:55.124352", "lvl": "debug", "msg": "start: 1.5.3 download-retry (timeout 00:04:47) [common]"}
- {"dt": "2024-01-25T11:25:55.124475", "lvl": "debug", "msg": "start: 1.5.3.1 file-download (timeout 00:04:47) [common]"}
- {"dt": "2024-01-25T11:25:55.124755", "lvl": "info", "msg": "downloading file:///home/anders/src/tmp/xfstests-artifacts/xfstests-arm64.tar.xz"}
- {"dt": "2024-01-25T11:25:55.124875", "lvl": "debug", "msg": "saving as /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/rootfs.overlay-00/xfstests-arm64.tar"}
- {"dt": "2024-01-25T11:25:55.124967", "lvl": "debug", "msg": "total size: 11890128 (11\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.125065", "lvl": "info", "msg": "Using unxz to decompress xz"}
- {"dt": "2024-01-25T11:25:55.125769", "lvl": "debug", "msg": "progress   0\u202F% (0\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.149803", "lvl": "debug", "msg": "progress   5\u202F% (0\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.175944", "lvl": "debug", "msg": "progress  10\u202F% (1\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.201212", "lvl": "debug", "msg": "progress  15\u202F% (1\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.225837", "lvl": "debug", "msg": "progress  20\u202F% (2\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.250677", "lvl": "debug", "msg": "progress  25\u202F% (2\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.274536", "lvl": "debug", "msg": "progress  30\u202F% (3\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.300200", "lvl": "debug", "msg": "progress  35\u202F% (4\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.326464", "lvl": "debug", "msg": "progress  40\u202F% (4\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.351338", "lvl": "debug", "msg": "progress  45\u202F% (5\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.377850", "lvl": "debug", "msg": "progress  50\u202F% (5\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.402925", "lvl": "debug", "msg": "progress  55\u202F% (6\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.429334", "lvl": "debug", "msg": "progress  60\u202F% (6\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.458216", "lvl": "debug", "msg": "progress  65\u202F% (7\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.486850", "lvl": "debug", "msg": "progress  70\u202F% (7\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.512696", "lvl": "debug", "msg": "progress  75\u202F% (8\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.544513", "lvl": "debug", "msg": "progress  80\u202F% (9\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.590270", "lvl": "debug", "msg": "progress  85\u202F% (9\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.615720", "lvl": "debug", "msg": "progress  90\u202F% (10\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.643553", "lvl": "debug", "msg": "progress  95\u202F% (10\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.670677", "lvl": "debug", "msg": "progress 100\u202F% (11\u202FMB)"}
- {"dt": "2024-01-25T11:25:55.676165", "lvl": "info", "msg": "11\u202FMB downloaded in 0.55\u202Fs (20.57\u202FMB/s)"}
- {"dt": "2024-01-25T11:25:55.676390", "lvl": "debug", "msg": "end: 1.5.3.1 file-download (duration 00:00:01) [common]"}
- {"dt": "2024-01-25T11:25:55.676510", "lvl": "results", "msg": {"case": "file-download", "definition": "lava", "duration": "0.55", "extra": {"label": "rootfs.overlay-00", "md5sum": "bac99584e6e37c90e62491fc5594b1aa", "sha256sum": "1186027f329e2d46b1331cdfd9c90b3bf08552a34cdee5599dd092a850d731d8", "sha512sum": "dafdbde97f01d0038fad88b7efd52fd39ec276e0fc06114eac0ac32f93aa1750d308ff50b9671940dae0ffbe0cf30f24b8e80977ab8fbe9ca653aeb54bf8c1c4", "size": ! "11890128"}, "level": "1.5.3.1", "namespace": "common", "result": "pass"}}
- {"dt": "2024-01-25T11:25:55.676756", "lvl": "debug", "msg": "end: 1.5.3 download-retry (duration 00:00:01) [common]"}
- {"dt": "2024-01-25T11:25:55.676883", "lvl": "debug", "msg": "start: 1.5.4 append-overlays (timeout 00:04:47) [common]"}
- {"dt": "2024-01-25T11:25:55.676987", "lvl": "info", "msg": "Modifying '/var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/rootfs/root_fs.arm64.ext4'"}
- {"dt": "2024-01-25T11:25:57.988737", "lvl": "debug", "msg": "Overlays:"}
- {"dt": "2024-01-25T11:25:57.989879", "lvl": "debug", "msg": "- rootfs.lava: '/var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/compress-overlay-zmz56h9d/overlay-1.1.4.tar.gz' to '/'"}
- {"dt": "2024-01-25T11:25:57.994718", "lvl": "debug", "msg": "- rootfs.modules: '/var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/rootfs.modules/modules.tar' to '/usr/'"}
- {"dt": "2024-01-25T11:25:58.200088", "lvl": "debug", "msg": "- rootfs.overlay-00: '/var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/rootfs.overlay-00/xfstests-arm64.tar' to '/tmp/'"}
- {"dt": "2024-01-25T11:25:58.942314", "lvl": "debug", "msg": "end: 1.5.4 append-overlays (duration 00:00:03) [common]"}
- {"dt": "2024-01-25T11:25:58.942851", "lvl": "debug", "msg": "end: 1.5 download-retry (duration 00:00:14) [common]"}
- {"dt": "2024-01-25T11:25:58.943067", "lvl": "info", "msg": "end: 1 deployimages (duration 00:00:17) [common]"}
- {"dt": "2024-01-25T11:25:58.943234", "lvl": "info", "msg": "start: 2 boot-image-retry (timeout 00:03:00) [common]"}
- {"dt": "2024-01-25T11:25:58.943395", "lvl": "debug", "msg": "start: 2.1 boot-qemu-image (timeout 00:03:00) [common]"}
- {"dt": "2024-01-25T11:25:58.943535", "lvl": "debug", "msg": "start: 2.1.1 execute-qemu (timeout 00:03:00) [common]"}
- {"dt": "2024-01-25T11:25:58.944029", "lvl": "info", "msg": "Boot command: /usr/bin/qemu-system-aarch64 -cpu max,pauth-impdef=on -machine virt,virtualization=on,gic-version=3,mte=on -nographic -nic none -m 4G -monitor none -no-reboot -smp 2 -kernel /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/kernel/Image -append \"console=ttyAMA0,115200 rootwait root=/dev/vda debug verbose console_msg_format=syslog systemd.log_level=warning rw earlycon\" -drive file=/var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/rootfs/root_fs.arm64.ext4,if=none,format=raw,id=hd0 -device virtio-blk-device,drive=hd0"}
- {"dt": "2024-01-25T11:25:58.948460", "lvl": "debug", "msg": "started a shell command"}
- {"dt": "2024-01-25T11:25:58.949011", "lvl": "debug", "msg": "end: 2.1.1 execute-qemu (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:58.949142", "lvl": "results", "msg": {"case": "execute-qemu", "definition": "lava", "duration": "0.01", "extra": {"host_arch": "amd64", "job_arch": "arm64", "qemu_version": "1:8.1.2+ds-1"}, "level": "2.1.1", "namespace": "common", "result": "pass"}}
- {"dt": "2024-01-25T11:25:58.949410", "lvl": "debug", "msg": "end: 2.1 boot-qemu-image (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:25:58.949549", "lvl": "debug", "msg": "start: 2.2 auto-login-action (timeout 00:03:00) [common]"}
- {"dt": "2024-01-25T11:25:58.949685", "lvl": "debug", "msg": "Setting prompt string to ['Linux version [0-9]']"}
- {"dt": "2024-01-25T11:25:58.949790", "lvl": "debug", "msg": "auto-login-action: Wait for prompt ['Linux version [0-9]'] (timeout 00:03:00)"}
- {"dt": "2024-01-25T11:25:59.196258", "lvl": "target", "msg": "[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]"}
- {"dt": "2024-01-25T11:25:59.196681", "lvl": "target", "msg": "[    0.000000] Linux version 6.8.0-rc1 (tuxmake@tuxmake) (aarch64-linux-gnu-gcc (Debian 13.2.0-7) 13.2.0, GNU ld (GNU Binutils for Debian) 2.41) #1 SMP PREEMPT @1705879347"}
- {"dt": "2024-01-25T11:25:59.196772", "lvl": "target", "msg": "[    0.000000] KASLR enabled"}
- {"dt": "2024-01-25T11:25:59.196854", "lvl": "target", "msg": "[    0.000000] random: crng init done"}
- {"dt": "2024-01-25T11:25:59.196956", "lvl": "target", "msg": "[    0.000000] Machine model: linux,dummy-virt"}
- {"dt": "2024-01-25T11:25:59.197054", "lvl": "target", "msg": "[    0.000000] efi: UEFI not found."}
- {"dt": "2024-01-25T11:25:59.197210", "lvl": "target", "msg": "[    0.000000] earlycon: pl11 at MMIO 0x0000000009000000 (options '')"}
- {"dt": "2024-01-25T11:25:59.197344", "lvl": "target", "msg": "[    0.000000] printk: legacy bootconsole [pl11] enabled"}
- {"dt": "2024-01-25T11:25:59.197622", "lvl": "debug", "msg": "start: 2.2.1 login-action (timeout 00:03:00) [common]"}
- {"dt": "2024-01-25T11:25:59.197687", "lvl": "debug", "msg": "Setting prompt string to []"}
- {"dt": "2024-01-25T11:25:59.197747", "lvl": "debug", "msg": "Setting prompt string to ['-\\\\[ cut here \\\\]', 'Unhandled fault', 'BUG: KCSAN:', 'BUG: KASAN:', 'BUG: KFENCE:', 'Oops(?: -|:)', 'WARNING:', '(kernel BUG at|BUG:)', 'invalid opcode:', 'Kernel panic - not syncing']"}
- {"dt": "2024-01-25T11:25:59.197805", "lvl": "debug", "msg": "Using line separator: #'\\n'#"}
- {"dt": "2024-01-25T11:25:59.197846", "lvl": "info", "msg": "Waiting for the login prompt"}
- {"dt": "2024-01-25T11:25:59.197888", "lvl": "info", "msg": "Parsing kernel messages"}
- {"dt": "2024-01-25T11:25:59.197924", "lvl": "debug", "msg": ["-\\[ cut here \\]", "Unhandled fault", "BUG: KCSAN:", "BUG: KASAN:", "BUG: KFENCE:", "Oops(?: -|:)", "WARNING:", "(kernel BUG at|BUG:)", "invalid opcode:", "Kernel panic - not syncing", "root@(.*):[/~]#", "login:", "Login incorrect"]}
- {"dt": "2024-01-25T11:25:59.198002", "lvl": "debug", "msg": "[login-action] Waiting for messages, (timeout 00:03:00)"}
- {"dt": "2024-01-25T11:25:59.200167", "lvl": "target", "msg": "[    0.000000] NUMA: No NUMA configuration found"}
- {"dt": "2024-01-25T11:25:59.200385", "lvl": "target", "msg": "[    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]"}
- {"dt": "2024-01-25T11:25:59.200887", "lvl": "target", "msg": "[    0.000000] NUMA: NODE_DATA [mem 0x13f5f19c0-0x13f5f3fff]"}
- {"dt": "2024-01-25T11:25:59.202643", "lvl": "target", "msg": "[    0.000000] Zone ranges:"}
- {"dt": "2024-01-25T11:25:59.203068", "lvl": "target", "msg": "[    0.000000]   DMA      [mem 0x0000000040000000-0x00000000ffffffff]"}
- {"dt": "2024-01-25T11:25:59.203186", "lvl": "target", "msg": "[    0.000000]   DMA32    empty"}
- {"dt": "2024-01-25T11:25:59.203388", "lvl": "target", "msg": "[    0.000000]   Normal   [mem 0x0000000100000000-0x000000013fffffff]"}
- {"dt": "2024-01-25T11:25:59.203518", "lvl": "target", "msg": "[    0.000000] Movable zone start for each node"}
- {"dt": "2024-01-25T11:25:59.203649", "lvl": "target", "msg": "[    0.000000] Early memory node ranges"}
- {"dt": "2024-01-25T11:25:59.203865", "lvl": "target", "msg": "[    0.000000]   node   0: [mem 0x0000000040000000-0x000000013fffffff]"}
- {"dt": "2024-01-25T11:25:59.204278", "lvl": "target", "msg": "[    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]"}
- {"dt": "2024-01-25T11:25:59.226944", "lvl": "target", "msg": "[    0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -1"}
- {"dt": "2024-01-25T11:25:59.227764", "lvl": "target", "msg": "[    0.000000] psci: probing for conduit method from DT."}
- {"dt": "2024-01-25T11:25:59.227996", "lvl": "target", "msg": "[    0.000000] psci: PSCIv1.1 detected in firmware."}
- {"dt": "2024-01-25T11:25:59.228107", "lvl": "target", "msg": "[    0.000000] psci: Using standard PSCI v0.2 function IDs"}
- {"dt": "2024-01-25T11:25:59.228350", "lvl": "target", "msg": "[    0.000000] psci: Trusted OS migration not required"}
- {"dt": "2024-01-25T11:25:59.228628", "lvl": "target", "msg": "[    0.000000] psci: SMC Calling Convention v1.0"}
- {"dt": "2024-01-25T11:25:59.230434", "lvl": "target", "msg": "[    0.000000] percpu: Embedded 32 pages/cpu s90216 r8192 d32664 u131072"}
- {"dt": "2024-01-25T11:25:59.231025", "lvl": "target", "msg": "[    0.000000] pcpu-alloc: s90216 r8192 d32664 u131072 alloc=32*4096"}
- {"dt": "2024-01-25T11:25:59.231214", "lvl": "target", "msg": "[    0.000000] pcpu-alloc: [0] 0 [0] 1 "}
- {"dt": "2024-01-25T11:25:59.232334", "lvl": "target", "msg": "[    0.000000] Detected PIPT I-cache on CPU0"}
- {"dt": "2024-01-25T11:25:59.233877", "lvl": "target", "msg": "[    0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)"}
- {"dt": "2024-01-25T11:25:59.234123", "lvl": "target", "msg": "[    0.000000] CPU features: detected: GIC system register CPU interface"}
- {"dt": "2024-01-25T11:25:59.234288", "lvl": "target", "msg": "[    0.000000] CPU features: detected: HCRX_EL2 register"}
- {"dt": "2024-01-25T11:25:59.234475", "lvl": "target", "msg": "[    0.000000] CPU features: detected: Virtualization Host Extensions"}
- {"dt": "2024-01-25T11:25:59.234706", "lvl": "target", "msg": "[    0.000000] CPU features: detected: Memory Tagging Extension"}
- {"dt": "2024-01-25T11:25:59.234844", "lvl": "target", "msg": "[    0.000000] CPU features: detected: Asymmetric MTE Tag Check Fault"}
- {"dt": "2024-01-25T11:25:59.235108", "lvl": "target", "msg": "[    0.000000] CPU features: detected: Spectre-v4"}
- {"dt": "2024-01-25T11:25:59.238036", "lvl": "target", "msg": "[    0.000000] alternatives: applying boot alternatives"}
- {"dt": "2024-01-25T11:25:59.241222", "lvl": "target", "msg": "[    0.000000] Kernel command line: console=ttyAMA0,115200 rootwait root=/dev/vda debug verbose console_msg_format=syslog systemd.log_level=warning rw earlycon"}
- {"dt": "2024-01-25T11:25:59.243232", "lvl": "target", "msg": "<5>[    0.000000] Unknown kernel command line parameters \\\"verbose\\\", will be passed to user space."}
- {"dt": "2024-01-25T11:25:59.247161", "lvl": "target", "msg": "<6>[    0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)"}
- {"dt": "2024-01-25T11:25:59.248411", "lvl": "target", "msg": "<6>[    0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)"}
- {"dt": "2024-01-25T11:25:59.249649", "lvl": "target", "msg": "<6>[    0.000000] Fallback order for Node 0: 0 "}
- {"dt": "2024-01-25T11:25:59.249733", "lvl": "target", "msg": "<6>[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1032192"}
- {"dt": "2024-01-25T11:25:59.249839", "lvl": "target", "msg": "<6>[    0.000000] Policy zone: Normal"}
- {"dt": "2024-01-25T11:25:59.250511", "lvl": "target", "msg": "<6>[    0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off"}
- {"dt": "2024-01-25T11:25:59.250757", "lvl": "target", "msg": "<6>[    0.000000] software IO TLB: area num 2."}
- {"dt": "2024-01-25T11:25:59.302150", "lvl": "target", "msg": "<6>[    0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)"}
- {"dt": "2024-01-25T11:25:59.316887", "lvl": "target", "msg": "<6>[    0.000000] Memory: 3954468K/4194304K available (22016K kernel code, 6302K rwdata, 13608K rodata, 14400K init, 703K bss, 207068K reserved, 32768K cma-reserved)"}
- {"dt": "2024-01-25T11:25:59.321418", "lvl": "target", "msg": "<6>[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1"}
- {"dt": "2024-01-25T11:25:59.322290", "lvl": "target", "msg": "<6>[    0.000000] ftrace: allocating 72056 entries in 282 pages"}
- {"dt": "2024-01-25T11:25:59.764358", "lvl": "target", "msg": "<6>[    0.000000] ftrace: allocated 282 pages with 4 groups"}
- {"dt": "2024-01-25T11:25:59.766715", "lvl": "target", "msg": "<6>[    0.000000] trace event string verifier disabled"}
- {"dt": "2024-01-25T11:25:59.772238", "lvl": "target", "msg": "<6>[    0.000000] rcu: Preemptible hierarchical RCU implementation."}
- {"dt": "2024-01-25T11:25:59.772363", "lvl": "target", "msg": "<6>[    0.000000] rcu: \tRCU event tracing is enabled."}
- {"dt": "2024-01-25T11:25:59.772472", "lvl": "target", "msg": "<6>[    0.000000] rcu: \tRCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=2."}
- {"dt": "2024-01-25T11:25:59.772831", "lvl": "target", "msg": "<6>[    0.000000] \tTrampoline variant of Tasks RCU enabled."}
- {"dt": "2024-01-25T11:25:59.772937", "lvl": "target", "msg": "<6>[    0.000000] \tRude variant of Tasks RCU enabled."}
- {"dt": "2024-01-25T11:25:59.773035", "lvl": "target", "msg": "<6>[    0.000000] \tTracing variant of Tasks RCU enabled."}
- {"dt": "2024-01-25T11:25:59.773316", "lvl": "target", "msg": "<6>[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies."}
- {"dt": "2024-01-25T11:25:59.773520", "lvl": "target", "msg": "<6>[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2"}
- {"dt": "2024-01-25T11:25:59.783744", "lvl": "target", "msg": "<6>[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0"}
- {"dt": "2024-01-25T11:25:59.788254", "lvl": "target", "msg": "<6>[    0.000000] GICv3: GIC: Using split EOI/Deactivate mode"}
- {"dt": "2024-01-25T11:25:59.788369", "lvl": "target", "msg": "<6>[    0.000000] GICv3: 256 SPIs implemented"}
- {"dt": "2024-01-25T11:25:59.788470", "lvl": "target", "msg": "<6>[    0.000000] GICv3: 0 Extended SPIs implemented"}
- {"dt": "2024-01-25T11:25:59.789892", "lvl": "target", "msg": "<6>[    0.000000] Root IRQ handler: gic_handle_irq"}
- {"dt": "2024-01-25T11:25:59.790021", "lvl": "target", "msg": "<6>[    0.000000] GICv3: GICv3 features: 16 PPIs"}
- {"dt": "2024-01-25T11:25:59.790675", "lvl": "target", "msg": "<6>[    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000"}
- {"dt": "2024-01-25T11:25:59.795084", "lvl": "target", "msg": "<6>[    0.000000] ITS [mem 0x08080000-0x0809ffff]"}
- {"dt": "2024-01-25T11:25:59.796003", "lvl": "target", "msg": "<6>[    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100210000 (indirect, esz 8, psz 64K, shr 1)"}
- {"dt": "2024-01-25T11:25:59.796242", "lvl": "target", "msg": "<6>[    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100220000 (flat, esz 8, psz 64K, shr 1)"}
- {"dt": "2024-01-25T11:25:59.796821", "lvl": "target", "msg": "<6>[    0.000000] GICv3: using LPI property table @0x0000000100230000"}
- {"dt": "2024-01-25T11:25:59.797647", "lvl": "target", "msg": "<6>[    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100240000"}
- {"dt": "2024-01-25T11:25:59.799387", "lvl": "target", "msg": "<6>[    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention."}
- {"dt": "2024-01-25T11:25:59.804549", "lvl": "target", "msg": "<6>[    0.000000] arch_timer: cp15 timer(s) running at 62.50MHz (phys)."}
- {"dt": "2024-01-25T11:25:59.805003", "lvl": "target", "msg": "<6>[    0.000000] clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x1cd42e208c, max_idle_ns: 881590405314 ns"}
- {"dt": "2024-01-25T11:25:59.805557", "lvl": "target", "msg": "<6>[    0.000054] sched_clock: 57 bits at 63MHz, resolution 16ns, wraps every 4398046511096ns"}
- {"dt": "2024-01-25T11:25:59.808169", "lvl": "target", "msg": "<6>[    0.002573] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)"}
- {"dt": "2024-01-25T11:25:59.820986", "lvl": "target", "msg": "<6>[    0.013760] Console: colour dummy device 80x25"}
- {"dt": "2024-01-25T11:25:59.824052", "lvl": "target", "msg": "<6>[    0.018124] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=250000)"}
- {"dt": "2024-01-25T11:25:59.824506", "lvl": "target", "msg": "<6>[    0.019111] pid_max: default: 32768 minimum: 301"}
- {"dt": "2024-01-25T11:25:59.826270", "lvl": "target", "msg": "<6>[    0.020556] LSM: initializing lsm=capability,integrity"}
- {"dt": "2024-01-25T11:25:59.829188", "lvl": "target", "msg": "<6>[    0.023630] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)"}
- {"dt": "2024-01-25T11:25:59.829350", "lvl": "target", "msg": "<6>[    0.023924] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)"}
- {"dt": "2024-01-25T11:25:59.853909", "lvl": "target", "msg": "<4>[    0.048367] cacheinfo: Unable to detect cache hierarchy for CPU 0"}
- {"dt": "2024-01-25T11:25:59.863249", "lvl": "target", "msg": "<6>[    0.057694] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1."}
- {"dt": "2024-01-25T11:25:59.864928", "lvl": "target", "msg": "<6>[    0.059399] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1."}
- {"dt": "2024-01-25T11:25:59.866657", "lvl": "target", "msg": "<6>[    0.061132] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1."}
- {"dt": "2024-01-25T11:25:59.868611", "lvl": "target", "msg": "<6>[    0.063091] rcu: Hierarchical SRCU implementation."}
- {"dt": "2024-01-25T11:25:59.868730", "lvl": "target", "msg": "<6>[    0.063277] rcu: \tMax phase no-delay instances is 1000."}
- {"dt": "2024-01-25T11:25:59.876228", "lvl": "target", "msg": "<6>[    0.070695] Platform MSI: its@8080000 domain created"}
- {"dt": "2024-01-25T11:25:59.876946", "lvl": "target", "msg": "<6>[    0.071278] PCI/MSI: /intc@8000000/its@8080000 domain created"}
- {"dt": "2024-01-25T11:25:59.877323", "lvl": "target", "msg": "<6>[    0.071902] fsl-mc MSI: its@8080000 domain created"}
- {"dt": "2024-01-25T11:25:59.879837", "lvl": "target", "msg": "<6>[    0.074309] EFI services will not be available."}
- {"dt": "2024-01-25T11:25:59.881322", "lvl": "target", "msg": "<6>[    0.075801] smp: Bringing up secondary CPUs ..."}
- {"dt": "2024-01-25T11:25:59.904342", "lvl": "target", "msg": "<6>[    0.083905] Detected PIPT I-cache on CPU1"}
- {"dt": "2024-01-25T11:25:59.904466", "lvl": "target", "msg": "<6>[    0.087404] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000"}
- {"dt": "2024-01-25T11:25:59.904581", "lvl": "target", "msg": "<6>[    0.089030] GICv3: CPU1: using allocated LPI pending table @0x0000000100250000"}
- {"dt": "2024-01-25T11:25:59.904772", "lvl": "target", "msg": "<6>[    0.092546] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]"}
- {"dt": "2024-01-25T11:25:59.904942", "lvl": "target", "msg": "<6>[    0.098788] smp: Brought up 1 node, 2 CPUs"}
- {"dt": "2024-01-25T11:25:59.905151", "lvl": "target", "msg": "<6>[    0.099752] SMP: Total of 2 processors activated."}
- {"dt": "2024-01-25T11:25:59.905308", "lvl": "target", "msg": "<6>[    0.099964] CPU: All CPU(s) started at EL2"}
- {"dt": "2024-01-25T11:25:59.905563", "lvl": "target", "msg": "<6>[    0.100155] CPU features: detected: Branch Target Identification"}
- {"dt": "2024-01-25T11:25:59.905782", "lvl": "target", "msg": "<6>[    0.100390] CPU features: detected: 32-bit EL0 Support"}
- {"dt": "2024-01-25T11:25:59.905976", "lvl": "target", "msg": "<6>[    0.100585] CPU features: detected: 32-bit EL1 Support"}
- {"dt": "2024-01-25T11:25:59.906183", "lvl": "target", "msg": "<6>[    0.100766] CPU features: detected: ARMv8.4 Translation Table Level"}
- {"dt": "2024-01-25T11:25:59.906486", "lvl": "target", "msg": "<6>[    0.100990] CPU features: detected: Data cache clean to the PoU not required for I/D coherence"}
- {"dt": "2024-01-25T11:25:59.906735", "lvl": "target", "msg": "<6>[    0.101305] CPU features: detected: Common not Private translations"}
- {"dt": "2024-01-25T11:25:59.906930", "lvl": "target", "msg": "<6>[    0.101523] CPU features: detected: CRC32 instructions"}
- {"dt": "2024-01-25T11:25:59.907360", "lvl": "target", "msg": "<6>[    0.101908] CPU features: detected: Data cache clean to Point of Deep Persistence"}
- {"dt": "2024-01-25T11:25:59.907576", "lvl": "target", "msg": "<6>[    0.102152] CPU features: detected: Data cache clean to Point of Persistence"}
- {"dt": "2024-01-25T11:25:59.907805", "lvl": "target", "msg": "<6>[    0.102367] CPU features: detected: Data independent timing control (DIT)"}
- {"dt": "2024-01-25T11:25:59.907943", "lvl": "target", "msg": "<6>[    0.102592] CPU features: detected: E0PD"}
- {"dt": "2024-01-25T11:25:59.908143", "lvl": "target", "msg": "<6>[    0.102736] CPU features: detected: Enhanced Privileged Access Never"}
- {"dt": "2024-01-25T11:25:59.908351", "lvl": "target", "msg": "<6>[    0.102936] CPU features: detected: Enhanced Virtualization Traps"}
- {"dt": "2024-01-25T11:25:59.908529", "lvl": "target", "msg": "<6>[    0.103142] CPU features: detected: Fine Grained Traps"}
- {"dt": "2024-01-25T11:25:59.908815", "lvl": "target", "msg": "<6>[    0.103362] CPU features: detected: Generic authentication (IMP DEF algorithm)"}
- {"dt": "2024-01-25T11:25:59.909284", "lvl": "target", "msg": "<6>[    0.103607] CPU features: detected: RCpc load-acquire (LDAPR)"}
- {"dt": "2024-01-25T11:25:59.909393", "lvl": "target", "msg": "<6>[    0.103893] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)"}
- {"dt": "2024-01-25T11:25:59.909543", "lvl": "target", "msg": "<6>[    0.104137] CPU features: detected: LSE atomic instructions"}
- {"dt": "2024-01-25T11:25:59.909770", "lvl": "target", "msg": "<6>[    0.104365] CPU features: detected: Privileged Access Never"}
- {"dt": "2024-01-25T11:25:59.909951", "lvl": "target", "msg": "<6>[    0.104563] CPU features: detected: RAS Extension Support"}
- {"dt": "2024-01-25T11:25:59.910122", "lvl": "target", "msg": "<6>[    0.104740] CPU features: detected: Random Number Generator"}
- {"dt": "2024-01-25T11:25:59.910315", "lvl": "target", "msg": "<6>[    0.104914] CPU features: detected: Speculation barrier (SB)"}
- {"dt": "2024-01-25T11:25:59.910499", "lvl": "target", "msg": "<6>[    0.105105] CPU features: detected: Stage-2 Force Write-Back"}
- {"dt": "2024-01-25T11:25:59.910723", "lvl": "target", "msg": "<6>[    0.105295] CPU features: detected: TLB range maintenance instructions"}
- {"dt": "2024-01-25T11:25:59.910960", "lvl": "target", "msg": "<6>[    0.105546] CPU features: detected: Scalable Matrix Extension"}
- {"dt": "2024-01-25T11:25:59.911322", "lvl": "target", "msg": "<6>[    0.105757] CPU features: detected: FA64"}
- {"dt": "2024-01-25T11:25:59.911479", "lvl": "target", "msg": "<6>[    0.106014] CPU features: detected: Speculative Store Bypassing Safe (SSBS)"}
- {"dt": "2024-01-25T11:25:59.911629", "lvl": "target", "msg": "<6>[    0.106239] CPU features: detected: Scalable Vector Extension"}
- {"dt": "2024-01-25T11:25:59.928873", "lvl": "target", "msg": "<6>[    0.121562] alternatives: applying system-wide alternatives"}
- {"dt": "2024-01-25T11:25:59.940888", "lvl": "target", "msg": "<6>[    0.134941] CPU features: detected: Hardware dirty bit management on CPU0-1"}
- {"dt": "2024-01-25T11:25:59.941171", "lvl": "target", "msg": "<6>[    0.135730] SVE: maximum available vector length 256 bytes per vector"}
- {"dt": "2024-01-25T11:25:59.941391", "lvl": "target", "msg": "<6>[    0.135970] SVE: default vector length 64 bytes per vector"}
- {"dt": "2024-01-25T11:25:59.942796", "lvl": "target", "msg": "<6>[    0.137259] SME: minimum available vector length 16 bytes per vector"}
- {"dt": "2024-01-25T11:25:59.942946", "lvl": "target", "msg": "<6>[    0.137481] SME: maximum available vector length 256 bytes per vector"}
- {"dt": "2024-01-25T11:25:59.943179", "lvl": "target", "msg": "<6>[    0.137697] SME: default vector length 32 bytes per vector"}
- {"dt": "2024-01-25T11:25:59.983892", "lvl": "target", "msg": "<6>[    0.178316] devtmpfs: initialized"}
- {"dt": "2024-01-25T11:26:00.018713", "lvl": "target", "msg": "<6>[    0.212663] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns"}
- {"dt": "2024-01-25T11:26:00.019838", "lvl": "target", "msg": "<6>[    0.214181] futex hash table entries: 512 (order: 3, 32768 bytes, linear)"}
- {"dt": "2024-01-25T11:26:00.030819", "lvl": "target", "msg": "<6>[    0.225238] pinctrl core: initialized pinctrl subsystem"}
- {"dt": "2024-01-25T11:26:00.048952", "lvl": "target", "msg": "<6>[    0.243378] DMI not present or invalid."}
- {"dt": "2024-01-25T11:26:00.066715", "lvl": "target", "msg": "<6>[    0.261046] NET: Registered PF_NETLINK/PF_ROUTE protocol family"}
- {"dt": "2024-01-25T11:26:00.101422", "lvl": "target", "msg": "<6>[    0.295485] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations"}
- {"dt": "2024-01-25T11:26:00.104578", "lvl": "target", "msg": "<6>[    0.298892] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations"}
- {"dt": "2024-01-25T11:26:00.107236", "lvl": "target", "msg": "<6>[    0.301575] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations"}
- {"dt": "2024-01-25T11:26:00.108236", "lvl": "target", "msg": "<6>[    0.302617] audit: initializing netlink subsys (disabled)"}
- {"dt": "2024-01-25T11:26:00.112452", "lvl": "target", "msg": "<5>[    0.306725] audit: type=2000 audit(0.276:1): state=initialized audit_enabled=0 res=1"}
- {"dt": "2024-01-25T11:26:00.126149", "lvl": "target", "msg": "<6>[    0.319090] thermal_sys: Registered thermal governor 'step_wise'"}
- {"dt": "2024-01-25T11:26:00.127392", "lvl": "target", "msg": "<6>[    0.320213] thermal_sys: Registered thermal governor 'power_allocator'"}
- {"dt": "2024-01-25T11:26:00.127499", "lvl": "target", "msg": "<6>[    0.321837] cpuidle: using governor menu"}
- {"dt": "2024-01-25T11:26:00.130597", "lvl": "target", "msg": "<6>[    0.325068] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers."}
- {"dt": "2024-01-25T11:26:00.132324", "lvl": "target", "msg": "<6>[    0.326793] ASID allocator initialised with 65536 entries"}
- {"dt": "2024-01-25T11:26:00.146682", "lvl": "target", "msg": "<6>[    0.341131] Serial: AMBA PL011 UART driver"}
- {"dt": "2024-01-25T11:26:00.279036", "lvl": "target", "msg": "<6>[    0.473450] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 14, base_baud = 0) is a PL011 rev1"}
- {"dt": "2024-01-25T11:26:00.280581", "lvl": "target", "msg": "<6>[    0.474919] printk: legacy console [ttyAMA0] enabled"}
- {"dt": "2024-01-25T11:26:00.280734", "lvl": "target", "msg": "<6>[    0.474919] printk: legacy console [ttyAMA0] enabled"}
- {"dt": "2024-01-25T11:26:00.280857", "lvl": "target", "msg": "<6>[    0.475430] printk: legacy bootconsole [pl11] disabled"}
- {"dt": "2024-01-25T11:26:00.280966", "lvl": "target", "msg": "<6>[    0.475430] printk: legacy bootconsole [pl11] disabled"}
- {"dt": "2024-01-25T11:26:00.322302", "lvl": "target", "msg": "<6>[    0.516228] Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL"}
- {"dt": "2024-01-25T11:26:00.323057", "lvl": "target", "msg": "<6>[    0.517369] Modules: 0 pages in range for non-PLT usage"}
- {"dt": "2024-01-25T11:26:00.333937", "lvl": "target", "msg": "<6>[    0.517495] Modules: 509984 pages in range for PLT usage"}
- {"dt": "2024-01-25T11:26:00.334185", "lvl": "target", "msg": "<6>[    0.528370] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages"}
- {"dt": "2024-01-25T11:26:00.334539", "lvl": "target", "msg": "<6>[    0.528995] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page"}
- {"dt": "2024-01-25T11:26:00.334941", "lvl": "target", "msg": "<6>[    0.529368] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages"}
- {"dt": "2024-01-25T11:26:00.335261", "lvl": "target", "msg": "<6>[    0.529731] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page"}
- {"dt": "2024-01-25T11:26:00.335613", "lvl": "target", "msg": "<6>[    0.530066] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages"}
- {"dt": "2024-01-25T11:26:00.335935", "lvl": "target", "msg": "<6>[    0.530409] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page"}
- {"dt": "2024-01-25T11:26:00.336299", "lvl": "target", "msg": "<6>[    0.530749] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages"}
- {"dt": "2024-01-25T11:26:00.336624", "lvl": "target", "msg": "<6>[    0.531100] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page"}
- {"dt": "2024-01-25T11:26:00.353025", "lvl": "target", "msg": "<6>[    0.547446] cryptd: max_cpu_qlen set to 1000"}
- {"dt": "2024-01-25T11:26:00.365207", "lvl": "target", "msg": "<6>[    0.559660] ACPI: Interpreter disabled."}
- {"dt": "2024-01-25T11:26:00.385942", "lvl": "target", "msg": "<6>[    0.580380] iommu: Default domain type: Translated"}
- {"dt": "2024-01-25T11:26:00.386090", "lvl": "target", "msg": "<6>[    0.580584] iommu: DMA domain TLB invalidation policy: strict mode"}
- {"dt": "2024-01-25T11:26:00.387919", "lvl": "target", "msg": "<5>[    0.582384] SCSI subsystem initialized"}
- {"dt": "2024-01-25T11:26:00.388844", "lvl": "target", "msg": "<7>[    0.583313] libata version 3.00 loaded."}
- {"dt": "2024-01-25T11:26:00.390669", "lvl": "target", "msg": "<6>[    0.585139] usbcore: registered new interface driver usbfs"}
- {"dt": "2024-01-25T11:26:00.391018", "lvl": "target", "msg": "<6>[    0.585593] usbcore: registered new interface driver hub"}
- {"dt": "2024-01-25T11:26:00.391449", "lvl": "target", "msg": "<6>[    0.585969] usbcore: registered new device driver usb"}
- {"dt": "2024-01-25T11:26:00.396652", "lvl": "target", "msg": "<6>[    0.591122] mc: Linux media interface: v0.10"}
- {"dt": "2024-01-25T11:26:00.397113", "lvl": "target", "msg": "<6>[    0.591483] videodev: Linux video capture interface: v2.00"}
- {"dt": "2024-01-25T11:26:00.397333", "lvl": "target", "msg": "<6>[    0.591933] pps_core: LinuxPPS API ver. 1 registered"}
- {"dt": "2024-01-25T11:26:00.397606", "lvl": "target", "msg": "<6>[    0.592119] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>"}
- {"dt": "2024-01-25T11:26:00.398015", "lvl": "target", "msg": "<6>[    0.592481] PTP clock support registered"}
- {"dt": "2024-01-25T11:26:00.399204", "lvl": "target", "msg": "<6>[    0.593674] EDAC MC: Ver: 3.0.0"}
- {"dt": "2024-01-25T11:26:00.402763", "lvl": "target", "msg": "<6>[    0.597146] scmi_core: SCMI protocol bus registered"}
- {"dt": "2024-01-25T11:26:00.408930", "lvl": "target", "msg": "<6>[    0.603375] FPGA manager framework"}
- {"dt": "2024-01-25T11:26:00.409710", "lvl": "target", "msg": "<6>[    0.604181] Advanced Linux Sound Architecture Driver Initialized."}
- {"dt": "2024-01-25T11:26:00.420024", "lvl": "target", "msg": "<6>[    0.614487] vgaarb: loaded"}
- {"dt": "2024-01-25T11:26:00.426150", "lvl": "target", "msg": "<6>[    0.620615] clocksource: Switched to clocksource arch_sys_counter"}
- {"dt": "2024-01-25T11:26:00.897113", "lvl": "target", "msg": "<5>[    1.091470] VFS: Disk quotas dquot_6.6.0"}
- {"dt": "2024-01-25T11:26:00.902279", "lvl": "target", "msg": "<6>[    1.096679] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)"}
- {"dt": "2024-01-25T11:26:00.905782", "lvl": "target", "msg": "<6>[    1.100290] pnp: PnP ACPI: disabled"}
- {"dt": "2024-01-25T11:26:00.951537", "lvl": "target", "msg": "<6>[    1.145975] NET: Registered PF_INET protocol family"}
- {"dt": "2024-01-25T11:26:00.953222", "lvl": "target", "msg": "<6>[    1.147652] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)"}
- {"dt": "2024-01-25T11:26:00.959446", "lvl": "target", "msg": "<6>[    1.153882] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)"}
- {"dt": "2024-01-25T11:26:00.959651", "lvl": "target", "msg": "<6>[    1.154211] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)"}
- {"dt": "2024-01-25T11:26:00.960083", "lvl": "target", "msg": "<6>[    1.154556] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)"}
- {"dt": "2024-01-25T11:26:00.960643", "lvl": "target", "msg": "<6>[    1.155205] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)"}
- {"dt": "2024-01-25T11:26:00.961484", "lvl": "target", "msg": "<6>[    1.155950] TCP: Hash tables configured (established 32768 bind 32768)"}
- {"dt": "2024-01-25T11:26:00.965518", "lvl": "target", "msg": "<6>[    1.159941] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear)"}
- {"dt": "2024-01-25T11:26:00.965960", "lvl": "target", "msg": "<6>[    1.160531] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)"}
- {"dt": "2024-01-25T11:26:00.966405", "lvl": "target", "msg": "<6>[    1.160968] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)"}
- {"dt": "2024-01-25T11:26:00.967853", "lvl": "target", "msg": "<6>[    1.162318] NET: Registered PF_UNIX/PF_LOCAL protocol family"}
- {"dt": "2024-01-25T11:26:00.971720", "lvl": "target", "msg": "<6>[    1.166179] RPC: Registered named UNIX socket transport module."}
- {"dt": "2024-01-25T11:26:00.971848", "lvl": "target", "msg": "<6>[    1.166397] RPC: Registered udp transport module."}
- {"dt": "2024-01-25T11:26:00.971963", "lvl": "target", "msg": "<6>[    1.166547] RPC: Registered tcp transport module."}
- {"dt": "2024-01-25T11:26:00.972091", "lvl": "target", "msg": "<6>[    1.166696] RPC: Registered tcp-with-tls transport module."}
- {"dt": "2024-01-25T11:26:00.972303", "lvl": "target", "msg": "<6>[    1.166886] RPC: Registered tcp NFSv4.1 backchannel transport module."}
- {"dt": "2024-01-25T11:26:00.972747", "lvl": "target", "msg": "<6>[    1.167280] PCI: CLS 0 bytes, default 64"}
- {"dt": "2024-01-25T11:26:00.974740", "lvl": "target", "msg": "<6>[    1.169205] kvm [1]: IPA Size Limit: 52 bits"}
- {"dt": "2024-01-25T11:26:00.975686", "lvl": "target", "msg": "<6>[    1.170159] kvm [1]: GICv3: no GICV resource entry"}
- {"dt": "2024-01-25T11:26:00.975804", "lvl": "target", "msg": "<6>[    1.170408] kvm [1]: disabling GICv2 emulation"}
- {"dt": "2024-01-25T11:26:00.976715", "lvl": "target", "msg": "<6>[    1.171188] kvm [1]: GIC system register CPU interface enabled"}
- {"dt": "2024-01-25T11:26:00.977661", "lvl": "target", "msg": "<6>[    1.172064] kvm [1]: vgic interrupt IRQ9"}
- {"dt": "2024-01-25T11:26:00.978692", "lvl": "target", "msg": "<6>[    1.173166] kvm [1]: VHE mode initialized successfully"}
- {"dt": "2024-01-25T11:26:00.986350", "lvl": "target", "msg": "<5>[    1.180758] Initialise system trusted keyrings"}
- {"dt": "2024-01-25T11:26:00.987925", "lvl": "target", "msg": "<6>[    1.182312] workingset: timestamp_bits=42 max_order=20 bucket_order=0"}
- {"dt": "2024-01-25T11:26:00.990339", "lvl": "target", "msg": "<6>[    1.184733] squashfs: version 4.0 (2009/01/31) Phillip Lougher"}
- {"dt": "2024-01-25T11:26:00.992112", "lvl": "target", "msg": "<5>[    1.186577] NFS: Registering the id_resolver key type"}
- {"dt": "2024-01-25T11:26:00.992309", "lvl": "target", "msg": "<5>[    1.186962] Key type id_resolver registered"}
- {"dt": "2024-01-25T11:26:00.992471", "lvl": "target", "msg": "<5>[    1.187126] Key type id_legacy registered"}
- {"dt": "2024-01-25T11:26:00.992919", "lvl": "target", "msg": "<6>[    1.187488] nfs4filelayout_init: NFSv4 File Layout Driver Registering..."}
- {"dt": "2024-01-25T11:26:00.993204", "lvl": "target", "msg": "<6>[    1.187770] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering..."}
- {"dt": "2024-01-25T11:26:00.994316", "lvl": "target", "msg": "<6>[    1.188791] 9p: Installing v9fs 9p2000 file system support"}
- {"dt": "2024-01-25T11:26:01.062030", "lvl": "target", "msg": "<6>[    1.256449] NET: Registered PF_ALG protocol family"}
- {"dt": "2024-01-25T11:26:01.062181", "lvl": "target", "msg": "<5>[    1.256814] Key type asymmetric registered"}
- {"dt": "2024-01-25T11:26:01.062417", "lvl": "target", "msg": "<5>[    1.257031] Asymmetric key parser 'x509' registered"}
- {"dt": "2024-01-25T11:26:01.063246", "lvl": "target", "msg": "<6>[    1.257701] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244)"}
- {"dt": "2024-01-25T11:26:01.063392", "lvl": "target", "msg": "<6>[    1.258005] io scheduler mq-deadline registered"}
- {"dt": "2024-01-25T11:26:01.063535", "lvl": "target", "msg": "<6>[    1.258199] io scheduler kyber registered"}
- {"dt": "2024-01-25T11:26:01.140246", "lvl": "target", "msg": "<6>[    1.334595] pl061_gpio 9030000.pl061: PL061 GPIO chip registered"}
- {"dt": "2024-01-25T11:26:01.155475", "lvl": "target", "msg": "<6>[    1.349844] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:"}
- {"dt": "2024-01-25T11:26:01.156298", "lvl": "target", "msg": "<6>[    1.350673] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000"}
- {"dt": "2024-01-25T11:26:01.156911", "lvl": "target", "msg": "<6>[    1.351426] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000"}
- {"dt": "2024-01-25T11:26:01.157307", "lvl": "target", "msg": "<6>[    1.351787] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000"}
- {"dt": "2024-01-25T11:26:01.158086", "lvl": "target", "msg": "<4>[    1.352554] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits"}
- {"dt": "2024-01-25T11:26:01.158948", "lvl": "target", "msg": "<6>[    1.353246] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]"}
- {"dt": "2024-01-25T11:26:01.160349", "lvl": "target", "msg": "<6>[    1.354821] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00"}
- {"dt": "2024-01-25T11:26:01.160565", "lvl": "target", "msg": "<6>[    1.355177] pci_bus 0000:00: root bus resource [bus 00-ff]"}
- {"dt": "2024-01-25T11:26:01.160822", "lvl": "target", "msg": "<6>[    1.355402] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]"}
- {"dt": "2024-01-25T11:26:01.161041", "lvl": "target", "msg": "<6>[    1.355620] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]"}
- {"dt": "2024-01-25T11:26:01.161255", "lvl": "target", "msg": "<6>[    1.355837] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]"}
- {"dt": "2024-01-25T11:26:01.162785", "lvl": "target", "msg": "<6>[    1.357249] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint"}
- {"dt": "2024-01-25T11:26:01.182129", "lvl": "target", "msg": "<6>[    1.376509] EINJ: ACPI disabled."}
- {"dt": "2024-01-25T11:26:01.419049", "lvl": "target", "msg": "<6>[    1.613411] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled"}
- {"dt": "2024-01-25T11:26:01.442956", "lvl": "target", "msg": "<6>[    1.637344] msm_serial: driver initialized"}
- {"dt": "2024-01-25T11:26:01.445283", "lvl": "target", "msg": "<6>[    1.639695] SuperH (H)SCI(F) driver initialized"}
- {"dt": "2024-01-25T11:26:01.446283", "lvl": "target", "msg": "<6>[    1.640697] STM32 USART driver initialized"}
- {"dt": "2024-01-25T11:26:01.510791", "lvl": "target", "msg": "<6>[    1.705181] loop: module loaded"}
- {"dt": "2024-01-25T11:26:01.511952", "lvl": "target", "msg": "<6>[    1.706250] virtio_blk virtio0: 1/0/0 default/read/poll queues"}
- {"dt": "2024-01-25T11:26:01.518645", "lvl": "target", "msg": "<5>[    1.713061] virtio_blk virtio0: [vda] 5480384 512-byte logical blocks (2.81 GB/2.61 GiB)"}
- {"dt": "2024-01-25T11:26:01.557307", "lvl": "target", "msg": "<6>[    1.751644] megasas: 07.727.03.00-rc1"}
- {"dt": "2024-01-25T11:26:01.577635", "lvl": "target", "msg": "<5>[    1.771901] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]"}
- {"dt": "2024-01-25T11:26:01.580220", "lvl": "target", "msg": "<6>[    1.774439] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000"}
- {"dt": "2024-01-25T11:26:01.581189", "lvl": "target", "msg": "<6>[    1.775600] Intel/Sharp Extended Query Table at 0x0031"}
- {"dt": "2024-01-25T11:26:01.582691", "lvl": "target", "msg": "<6>[    1.777113] Using buffer write method"}
- {"dt": "2024-01-25T11:26:01.583425", "lvl": "target", "msg": "<7>[    1.777863] erase region 0: offset=0x0,size=0x40000,blocks=256"}
- {"dt": "2024-01-25T11:26:01.584218", "lvl": "target", "msg": "<5>[    1.778530] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]"}
- {"dt": "2024-01-25T11:26:01.585544", "lvl": "target", "msg": "<6>[    1.779759] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000"}
- {"dt": "2024-01-25T11:26:01.586048", "lvl": "target", "msg": "<6>[    1.780522] Intel/Sharp Extended Query Table at 0x0031"}
- {"dt": "2024-01-25T11:26:01.587120", "lvl": "target", "msg": "<6>[    1.781557] Using buffer write method"}
- {"dt": "2024-01-25T11:26:01.587422", "lvl": "target", "msg": "<7>[    1.781870] erase region 0: offset=0x0,size=0x40000,blocks=256"}
- {"dt": "2024-01-25T11:26:01.587816", "lvl": "target", "msg": "<5>[    1.782321] Concatenating MTD devices:"}
- {"dt": "2024-01-25T11:26:01.588012", "lvl": "target", "msg": "<5>[    1.782607] (0): \\\"0.flash\\\""}
- {"dt": "2024-01-25T11:26:01.588237", "lvl": "target", "msg": "<5>[    1.782841] (1): \\\"0.flash\\\""}
- {"dt": "2024-01-25T11:26:01.588478", "lvl": "target", "msg": "<5>[    1.783050] into device \\\"0.flash\\\""}
- {"dt": "2024-01-25T11:26:01.651845", "lvl": "target", "msg": "<6>[    1.846261] thunder_xcv, ver 1.0"}
- {"dt": "2024-01-25T11:26:01.652248", "lvl": "target", "msg": "<6>[    1.846823] thunder_bgx, ver 1.0"}
- {"dt": "2024-01-25T11:26:01.652420", "lvl": "target", "msg": "<6>[    1.847094] nicpf, ver 1.0"}
- {"dt": "2024-01-25T11:26:01.660264", "lvl": "target", "msg": "<6>[    1.854726] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version"}
- {"dt": "2024-01-25T11:26:01.660404", "lvl": "target", "msg": "<6>[    1.854955] hns3: Copyright (c) 2017 Huawei Corporation."}
- {"dt": "2024-01-25T11:26:01.660841", "lvl": "target", "msg": "<6>[    1.855406] hclge is initializing"}
- {"dt": "2024-01-25T11:26:01.661085", "lvl": "target", "msg": "<6>[    1.855689] e1000: Intel(R) PRO/1000 Network Driver"}
- {"dt": "2024-01-25T11:26:01.661286", "lvl": "target", "msg": "<6>[    1.855858] e1000: Copyright (c) 1999-2006 Intel Corporation."}
- {"dt": "2024-01-25T11:26:01.661783", "lvl": "target", "msg": "<6>[    1.856296] e1000e: Intel(R) PRO/1000 Network Driver"}
- {"dt": "2024-01-25T11:26:01.661932", "lvl": "target", "msg": "<6>[    1.856517] e1000e: Copyright(c) 1999 - 2015 Intel Corporation."}
- {"dt": "2024-01-25T11:26:01.662379", "lvl": "target", "msg": "<6>[    1.856892] igb: Intel(R) Gigabit Ethernet Network Driver"}
- {"dt": "2024-01-25T11:26:01.662508", "lvl": "target", "msg": "<6>[    1.857095] igb: Copyright (c) 2007-2014 Intel Corporation."}
- {"dt": "2024-01-25T11:26:01.662975", "lvl": "target", "msg": "<6>[    1.857444] igbvf: Intel(R) Gigabit Virtual Function Network Driver"}
- {"dt": "2024-01-25T11:26:01.663106", "lvl": "target", "msg": "<6>[    1.857672] igbvf: Copyright (c) 2009 - 2012 Intel Corporation."}
- {"dt": "2024-01-25T11:26:01.665384", "lvl": "target", "msg": "<6>[    1.859862] sky2: driver version 1.30"}
- {"dt": "2024-01-25T11:26:01.665812", "lvl": "target", "msg": "<6>[    1.860345] QLogic FastLinQ 4xxxx Core Module qed"}
- {"dt": "2024-01-25T11:26:01.666045", "lvl": "target", "msg": "<6>[    1.860609] qede init: QLogic FastLinQ 4xxxx Ethernet Driver qede"}
- {"dt": "2024-01-25T11:26:01.674266", "lvl": "target", "msg": "<6>[    1.868727] usbcore: registered new interface driver asix"}
- {"dt": "2024-01-25T11:26:01.674483", "lvl": "target", "msg": "<6>[    1.869060] usbcore: registered new interface driver ax88179_178a"}
- {"dt": "2024-01-25T11:26:01.677251", "lvl": "target", "msg": "<6>[    1.871637] VFIO - User Level meta-driver version: 0.3"}
- {"dt": "2024-01-25T11:26:01.718513", "lvl": "target", "msg": "<6>[    1.912891] usbcore: registered new interface driver usb-storage"}
- {"dt": "2024-01-25T11:26:01.755699", "lvl": "target", "msg": "<6>[    1.950100] rtc-pl031 9010000.pl031: registered as rtc0"}
- {"dt": "2024-01-25T11:26:01.756610", "lvl": "target", "msg": "<6>[    1.950833] rtc-pl031 9010000.pl031: setting system clock to 2024-01-25T11:26:01 UTC (1706181961)"}
- {"dt": "2024-01-25T11:26:01.761140", "lvl": "target", "msg": "<6>[    1.955570] i2c_dev: i2c /dev entries driver"}
- {"dt": "2024-01-25T11:26:01.806614", "lvl": "target", "msg": "<6>[    2.001014] sdhci: Secure Digital Host Controller Interface driver"}
- {"dt": "2024-01-25T11:26:01.806754", "lvl": "target", "msg": "<6>[    2.001234] sdhci: Copyright(c) Pierre Ossman"}
- {"dt": "2024-01-25T11:26:01.810993", "lvl": "target", "msg": "<6>[    2.005414] Synopsys Designware Multimedia Card Interface Driver"}
- {"dt": "2024-01-25T11:26:01.816949", "lvl": "target", "msg": "<6>[    2.011378] sdhci-pltfm: SDHCI platform and OF driver helper"}
- {"dt": "2024-01-25T11:26:01.829340", "lvl": "target", "msg": "<6>[    2.023766] ledtrig-cpu: registered to indicate activity on CPUs"}
- {"dt": "2024-01-25T11:26:01.857592", "lvl": "target", "msg": "<6>[    2.051988] usbcore: registered new interface driver usbhid"}
- {"dt": "2024-01-25T11:26:01.857745", "lvl": "target", "msg": "<6>[    2.052342] usbhid: USB HID core driver"}
- {"dt": "2024-01-25T11:26:01.879514", "lvl": "target", "msg": "<6>[    2.073933] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available"}
- {"dt": "2024-01-25T11:26:01.887286", "lvl": "target", "msg": "<6>[    2.081702]  cs_system_cfg: CoreSight Configuration manager initialised"}
- {"dt": "2024-01-25T11:26:01.915496", "lvl": "target", "msg": "<6>[    2.109917] NET: Registered PF_INET6 protocol family"}
- {"dt": "2024-01-25T11:26:01.926871", "lvl": "target", "msg": "<6>[    2.121227] Segment Routing with IPv6"}
- {"dt": "2024-01-25T11:26:01.927398", "lvl": "target", "msg": "<6>[    2.121872] In-situ OAM (IOAM) with IPv6"}
- {"dt": "2024-01-25T11:26:01.929128", "lvl": "target", "msg": "<6>[    2.123521] NET: Registered PF_PACKET protocol family"}
- {"dt": "2024-01-25T11:26:01.932244", "lvl": "target", "msg": "<6>[    2.126674] 9pnet: Installing 9P2000 support"}
- {"dt": "2024-01-25T11:26:01.933206", "lvl": "target", "msg": "<5>[    2.127645] Key type dns_resolver registered"}
- {"dt": "2024-01-25T11:26:02.015184", "lvl": "target", "msg": "<6>[    2.209577] registered taskstats version 1"}
- {"dt": "2024-01-25T11:26:02.016313", "lvl": "target", "msg": "<5>[    2.210725] Loading compiled-in X.509 certificates"}
- {"dt": "2024-01-25T11:26:02.067284", "lvl": "target", "msg": "<6>[    2.261679] input: gpio-keys as /devices/platform/gpio-keys/input/input0"}
- {"dt": "2024-01-25T11:26:02.076038", "lvl": "target", "msg": "<6>[    2.270463] clk: Disabling unused clocks"}
- {"dt": "2024-01-25T11:26:02.076278", "lvl": "target", "msg": "<6>[    2.270932] ALSA device list:"}
- {"dt": "2024-01-25T11:26:02.076477", "lvl": "target", "msg": "<6>[    2.271111]   No soundcards found."}
- {"dt": "2024-01-25T11:26:02.115621", "lvl": "target", "msg": "<6>[    2.309394] EXT4-fs (vda): mounted filesystem bc85a55f-3ba4-4c03-81d5-f205be2e5ff5 r/w with ordered data mode. Quota mode: none."}
- {"dt": "2024-01-25T11:26:02.116647", "lvl": "target", "msg": "<6>[    2.311019] VFS: Mounted root (ext4 filesystem) on device 254:0."}
- {"dt": "2024-01-25T11:26:02.127012", "lvl": "target", "msg": "<6>[    2.321424] devtmpfs: mounted"}
- {"dt": "2024-01-25T11:26:02.197228", "lvl": "target", "msg": "<6>[    2.391595] Freeing unused kernel memory: 14400K"}
- {"dt": "2024-01-25T11:26:02.198520", "lvl": "target", "msg": "<6>[    2.392927] Run /sbin/init as init process"}
- {"dt": "2024-01-25T11:26:02.198652", "lvl": "target", "msg": "<7>[    2.393150]   with arguments:"}
- {"dt": "2024-01-25T11:26:02.198820", "lvl": "target", "msg": "<7>[    2.393297]     /sbin/init"}
- {"dt": "2024-01-25T11:26:02.199012", "lvl": "target", "msg": "<7>[    2.393426]     verbose"}
- {"dt": "2024-01-25T11:26:02.199209", "lvl": "target", "msg": "<7>[    2.393544]   with environment:"}
- {"dt": "2024-01-25T11:26:02.199380", "lvl": "target", "msg": "<7>[    2.393703]     HOME=/"}
- {"dt": "2024-01-25T11:26:02.199540", "lvl": "target", "msg": "<7>[    2.393827]     TERM=linux"}
- {"dt": "2024-01-25T11:26:02.745031", "lvl": "target", "msg": ""}
- {"dt": "2024-01-25T11:26:02.745602", "lvl": "target", "msg": "Welcome to [1mDebian GNU/Linux 12 (bookworm)[0m!"}
- {"dt": "2024-01-25T11:26:02.745724", "lvl": "target", "msg": ""}
- {"dt": "2024-01-25T11:26:03.315469", "lvl": "target", "msg": "<28>[    3.508913] systemd-fstab-generator[82]: x-systemd.device-timeout ignored for v_tmp"}
- {"dt": "2024-01-25T11:26:04.328484", "lvl": "target", "msg": "[[0;32m  OK  [0m] Created slice [0;1;39msystem-getty.slice[0m - Slice /system/getty."}
- {"dt": "2024-01-25T11:26:04.336958", "lvl": "target", "msg": "[[0;32m  OK  [0m] Created slice [0;1;39msystem-modpr\u2026lice[0m - Slice /system/modprobe."}
- {"dt": "2024-01-25T11:26:04.342957", "lvl": "target", "msg": "[[0;32m  OK  [0m] Created slice [0;1;39msystem-seria\u2026[0m - Slice /system/serial-getty."}
- {"dt": "2024-01-25T11:26:04.348705", "lvl": "target", "msg": "[[0;32m  OK  [0m] Created slice [0;1;39msystem-syste\u2026[0m - Slice /system/systemd-fsck."}
- {"dt": "2024-01-25T11:26:04.354955", "lvl": "target", "msg": "[[0;32m  OK  [0m] Created slice [0;1;39msystem-telne\u2026[0m - Slice /system/telnet-getty."}
- {"dt": "2024-01-25T11:26:04.360189", "lvl": "target", "msg": "[[0;32m  OK  [0m] Created slice [0;1;39muser.slice[0m - User and Session Slice."}
- {"dt": "2024-01-25T11:26:04.363398", "lvl": "target", "msg": "[[0;32m  OK  [0m] Started [0;1;39msystemd-ask-passwo\u2026quests to Console Directory Watch."}
- {"dt": "2024-01-25T11:26:04.365320", "lvl": "target", "msg": "[[0;32m  OK  [0m] Started [0;1;39msystemd-ask-passwo\u2026 Requests to Wall Directory Watch."}
- {"dt": "2024-01-25T11:26:04.367772", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mcryptsetup.\u2026get[0m - Local Encrypted Volumes."}
- {"dt": "2024-01-25T11:26:04.368581", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mintegrityse\u2026Local Integrity Protected Volumes."}
- {"dt": "2024-01-25T11:26:04.369893", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mnss-lookup.\u2026m - Host and Network Name Lookups."}
- {"dt": "2024-01-25T11:26:04.370875", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mpaths.target[0m - Path Units."}
- {"dt": "2024-01-25T11:26:04.371983", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mslices.target[0m - Slice Units."}
- {"dt": "2024-01-25T11:26:04.372987", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mswap.target[0m - Swaps."}
- {"dt": "2024-01-25T11:26:04.374221", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mveritysetup\u2026 - Local Verity Protected Volumes."}
- {"dt": "2024-01-25T11:26:04.377863", "lvl": "target", "msg": "[[0;32m  OK  [0m] Listening on [0;1;39mdm-event.sock\u2026 Device-mapper event daemon FIFOs."}
- {"dt": "2024-01-25T11:26:04.381706", "lvl": "target", "msg": "[[0;32m  OK  [0m] Listening on [0;1;39mlvm2-lvmpolld\u2026ket[0m - LVM2 poll daemon socket."}
- {"dt": "2024-01-25T11:26:04.548839", "lvl": "target", "msg": "[[0;32m  OK  [0m] Listening on [0;1;39mrpcbind.socke\u2026 RPCbind Server Activation Socket."}
- {"dt": "2024-01-25T11:26:04.556939", "lvl": "target", "msg": "[[0;32m  OK  [0m] Listening on [0;1;39msyslog.socket[0m - Syslog Socket."}
- {"dt": "2024-01-25T11:26:04.563494", "lvl": "target", "msg": "[[0;32m  OK  [0m] Listening on [0;1;39msystemd-fsckd\u2026sck to fsckd communication Socket."}
- {"dt": "2024-01-25T11:26:04.568183", "lvl": "target", "msg": "[[0;32m  OK  [0m] Listening on [0;1;39msystemd-initc\u2026 initctl Compatibility Named Pipe."}
- {"dt": "2024-01-25T11:26:04.577294", "lvl": "target", "msg": "[[0;32m  OK  [0m] Listening on [0;1;39msystemd-journ\u2026socket[0m - Journal Audit Socket."}
- {"dt": "2024-01-25T11:26:04.583913", "lvl": "target", "msg": "[[0;32m  OK  [0m] Listening on [0;1;39msystemd-journ\u2026t[0m - Journal Socket (/dev/log)."}
- {"dt": "2024-01-25T11:26:04.590123", "lvl": "target", "msg": "[[0;32m  OK  [0m] Listening on [0;1;39msystemd-journald.socket[0m - Journal Socket."}
- {"dt": "2024-01-25T11:26:04.596205", "lvl": "target", "msg": "[[0;32m  OK  [0m] Listening on [0;1;39msystemd-udevd\u2026.socket[0m - udev Control Socket."}
- {"dt": "2024-01-25T11:26:04.598966", "lvl": "target", "msg": "[[0;32m  OK  [0m] Listening on [0;1;39msystemd-udevd\u2026l.socket[0m - udev Kernel Socket."}
- {"dt": "2024-01-25T11:26:04.636165", "lvl": "target", "msg": "         Mounting [0;1;39mdev-hugepages.mount[0m - Huge Pages File System..."}
- {"dt": "2024-01-25T11:26:04.659709", "lvl": "target", "msg": "         Mounting [0;1;39mdev-mqueue.mount\u2026POSIX Message Queue File System..."}
- {"dt": "2024-01-25T11:26:04.682579", "lvl": "target", "msg": "         Mounting [0;1;39mproc-fs-nfsd.moun\u2026- NFSD configuration filesystem..."}
- {"dt": "2024-01-25T11:26:04.727647", "lvl": "target", "msg": "         Mounting [0;1;39msys-kernel-debug.mount[0m - /sys/kernel/debug..."}
- {"dt": "2024-01-25T11:26:04.811669", "lvl": "target", "msg": "         Mounting [0;1;39msys-kernel-tracin\u2026[0m - Kernel Trace File System..."}
- {"dt": "2024-01-25T11:26:04.816083", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39mblk-availability.\u2026m - Availability of block devices."}
- {"dt": "2024-01-25T11:26:04.840284", "lvl": "target", "msg": "         Starting [0;1;39mkmod-static-nodes\u2026ate List of Static Device Nodes..."}
- {"dt": "2024-01-25T11:26:04.862559", "lvl": "target", "msg": "         Starting [0;1;39mlvm2-monitor.serv\u2026ng dmeventd or progress polling..."}
- {"dt": "2024-01-25T11:26:04.912552", "lvl": "target", "msg": "         Starting [0;1;39mmodprobe@configfs\u2026m - Load Kernel Module configfs..."}
- {"dt": "2024-01-25T11:26:04.960148", "lvl": "target", "msg": "         Starting [0;1;39mmodprobe@dm_mod.s\u2026[0m - Load Kernel Module dm_mod..."}
- {"dt": "2024-01-25T11:26:04.992021", "lvl": "target", "msg": "         Starting [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm..."}
- {"dt": "2024-01-25T11:26:05.052798", "lvl": "target", "msg": "         Starting [0;1;39mmodprobe@efi_psto\u2026- Load Kernel Module efi_pstore..."}
- {"dt": "2024-01-25T11:26:05.098321", "lvl": "target", "msg": "<6>[    5.292622] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com"}
- {"dt": "2024-01-25T11:26:05.124854", "lvl": "target", "msg": "         Starting [0;1;39mmodprobe@fuse.ser\u2026e[0m - Load Kernel Module fuse..."}
- {"dt": "2024-01-25T11:26:05.196461", "lvl": "target", "msg": "         Starting [0;1;39mmodprobe@loop.ser\u2026e[0m - Load Kernel Module loop..."}
- {"dt": "2024-01-25T11:26:05.255549", "lvl": "target", "msg": "<6>[    5.449869] fuse: init (API version 7.39)"}
- {"dt": "2024-01-25T11:26:05.264963", "lvl": "target", "msg": "         Starting [0;1;39msystemd-journald.service[0m - Journal Service..."}
- {"dt": "2024-01-25T11:26:05.303880", "lvl": "target", "msg": "         Starting [0;1;39msystemd-modules-l\u2026rvice[0m - Load Kernel Modules..."}
- {"dt": "2024-01-25T11:26:05.339705", "lvl": "target", "msg": "         Starting [0;1;39msystemd-remount-f\u2026nt Root and Kernel File Systems..."}
- {"dt": "2024-01-25T11:26:05.405075", "lvl": "target", "msg": "         Starting [0;1;39msystemd-udev-trig\u2026[0m - Coldplug All udev Devices..."}
- {"dt": "2024-01-25T11:26:05.489937", "lvl": "target", "msg": "<44>[    5.683920] systemd-journald[110]: /etc/systemd/journald.conf.d/99-gce-xfstests.conf:4: Unknown key name 'ForwardToKmsg' in section 'Journal', ignoring."}
- {"dt": "2024-01-25T11:26:05.524149", "lvl": "target", "msg": "[[0;32m  OK  [0m] Mounted [0;1;39mdev-hugepages.mount[0m - Huge Pages File System."}
- {"dt": "2024-01-25T11:26:05.533187", "lvl": "target", "msg": "[[0;32m  OK  [0m] Mounted [0;1;39mdev-mqueue.mount[\u2026- POSIX Message Queue File System."}
- {"dt": "2024-01-25T11:26:05.544516", "lvl": "target", "msg": "<28>[    5.738953] systemd[1]: proc-fs-nfsd.mount: Failed with result 'exit-code'."}
- {"dt": "2024-01-25T11:26:05.558636", "lvl": "target", "msg": "<27>[    5.753080] systemd[1]: Failed to mount proc-fs-nfsd.mount - NFSD configuration filesystem."}
- {"dt": "2024-01-25T11:26:05.559456", "lvl": "target", "msg": "[[0;1;31mFAILED[0m] Failed to mount [0;1;39mproc-fs-nf\u2026m - NFSD configuration filesystem."}
- {"dt": "2024-01-25T11:26:05.562676", "lvl": "target", "msg": "See 'systemctl status proc-fs-nfsd.mount' for details."}
- {"dt": "2024-01-25T11:26:05.563930", "lvl": "target", "msg": "<28>[    5.758380] systemd[1]: Dependency failed for nfsdcld.service - NFSv4 Client Tracking Daemon."}
- {"dt": "2024-01-25T11:26:05.564904", "lvl": "target", "msg": "[[0;1;38;5;185mDEPEND[0m] Dependency failed for [0;1;39mnfsd\u20260m - NFSv4 Client Tracking Daemon."}
- {"dt": "2024-01-25T11:26:05.572509", "lvl": "target", "msg": "<28>[    5.766943] systemd[1]: Dependency failed for nfs-mountd.service - NFS Mount Daemon."}
- {"dt": "2024-01-25T11:26:05.573253", "lvl": "target", "msg": "[[0;1;38;5;185mDEPEND[0m] Dependency failed for [0;1;39mnfs-\u2026td.service[0m - NFS Mount Daemon."}
- {"dt": "2024-01-25T11:26:05.577938", "lvl": "target", "msg": "<28>[    5.772386] systemd[1]: Dependency failed for nfs-server.service - NFS server and services."}
- {"dt": "2024-01-25T11:26:05.578733", "lvl": "target", "msg": "[[0;1;38;5;185mDEPEND[0m] Dependency failed for [0;1;39mnfs-\u2026ice[0m - NFS server and services."}
- {"dt": "2024-01-25T11:26:05.579003", "lvl": "target", "msg": "<28>[    5.773525] systemd[1]: Dependency failed for nfs-idmapd.service - NFSv4 ID-name mapping service."}
- {"dt": "2024-01-25T11:26:05.579754", "lvl": "target", "msg": "[[0;1;38;5;185mDEPEND[0m] Dependency failed for [0;1;39mnfs-\u2026m - NFSv4 ID-name mapping service."}
- {"dt": "2024-01-25T11:26:05.588676", "lvl": "target", "msg": "[[0;32m  OK  [0m] Mounted [0;1;39msys-kernel-debug.mount[0m - /sys/kernel/debug."}
- {"dt": "2024-01-25T11:26:05.591555", "lvl": "target", "msg": "[[0;32m  OK  [0m] Mounted [0;1;39msys-kernel-tracing\u2026nt[0m - Kernel Trace File System."}
- {"dt": "2024-01-25T11:26:05.608167", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39mkmod-static-nodes\u2026reate List of Static Device Nodes."}
- {"dt": "2024-01-25T11:26:05.623329", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39mlvm2-monitor.serv\u2026sing dmeventd or progress polling."}
- {"dt": "2024-01-25T11:26:05.651034", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39mmodprobe@configfs\u2026[0m - Load Kernel Module configfs."}
- {"dt": "2024-01-25T11:26:05.683503", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39mmodprobe@dm_mod.s\u2026e[0m - Load Kernel Module dm_mod."}
- {"dt": "2024-01-25T11:26:05.686232", "lvl": "target", "msg": "<6>[    5.880607] EXT4-fs (vda): re-mounted bc85a55f-3ba4-4c03-81d5-f205be2e5ff5 r/w. Quota mode: none."}
- {"dt": "2024-01-25T11:26:05.706917", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm."}
- {"dt": "2024-01-25T11:26:05.743391", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39mmodprobe@efi_psto\u2026m - Load Kernel Module efi_pstore."}
- {"dt": "2024-01-25T11:26:05.768286", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse."}
- {"dt": "2024-01-25T11:26:05.786031", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39mmodprobe@loop.service[0m - Load Kernel Module loop."}
- {"dt": "2024-01-25T11:26:05.800187", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39msystemd-modules-l\u2026service[0m - Load Kernel Modules."}
- {"dt": "2024-01-25T11:26:05.815407", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39msystemd-remount-f\u2026ount Root and Kernel File Systems."}
- {"dt": "2024-01-25T11:26:05.827679", "lvl": "target", "msg": "[[0;32m  OK  [0m] Started [0;1;39msystemd-journald.service[0m - Journal Service."}
- {"dt": "2024-01-25T11:26:05.911889", "lvl": "target", "msg": "         Mounting [0;1;39msys-fs-fuse-conne\u2026[0m - FUSE Control File System..."}
- {"dt": "2024-01-25T11:26:05.939077", "lvl": "target", "msg": "         Mounting [0;1;39msys-kernel-config\u2026ernel Configuration File System..."}
- {"dt": "2024-01-25T11:26:06.011478", "lvl": "target", "msg": "         Starting [0;1;39msystemd-journal-f\u2026h Journal to Persistent Storage..."}
- {"dt": "2024-01-25T11:26:06.076365", "lvl": "target", "msg": "         Starting [0;1;39msystemd-random-se\u2026ice[0m - Load/Save Random Seed..."}
- {"dt": "2024-01-25T11:26:06.144193", "lvl": "target", "msg": "         Starting [0;1;39msystemd-sysctl.se\u2026ce[0m - Apply Kernel Variables..."}
- {"dt": "2024-01-25T11:26:06.208283", "lvl": "target", "msg": "         Starting [0;1;39msystemd-sysusers.\u2026rvice[0m - Create System Users..."}
- {"dt": "2024-01-25T11:26:06.350373", "lvl": "target", "msg": "[[0;32m  OK  [0m] Mounted [0;1;39msys-fs-fuse-connec\u2026nt[0m - FUSE Control File System."}
- {"dt": "2024-01-25T11:26:06.353192", "lvl": "target", "msg": "[[0;32m  OK  [0m] Mounted [0;1;39msys-kernel-config.\u2026 Kernel Configuration File System."}
- {"dt": "2024-01-25T11:26:06.378354", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39msystemd-random-se\u2026rvice[0m - Load/Save Random Seed."}
- {"dt": "2024-01-25T11:26:06.415762", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39msystemd-journal-f\u2026ush Journal to Persistent Storage."}
- {"dt": "2024-01-25T11:26:06.444457", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables."}
- {"dt": "2024-01-25T11:26:06.502970", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39msystemd-sysusers.service[0m - Create System Users."}
- {"dt": "2024-01-25T11:26:06.540857", "lvl": "target", "msg": "         Starting [0;1;39msystemd-tmpfiles-\u2026ate Static Device Nodes in /dev..."}
- {"dt": "2024-01-25T11:26:06.710109", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39msystemd-tmpfiles-\u2026reate Static Device Nodes in /dev."}
- {"dt": "2024-01-25T11:26:06.713110", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mlocal-fs-pr\u2026reparation for Local File Systems."}
- {"dt": "2024-01-25T11:26:06.749258", "lvl": "target", "msg": "         Mounting [0;1;39mtmp.mount[0m - /tmp..."}
- {"dt": "2024-01-25T11:26:06.807935", "lvl": "target", "msg": "         Mounting [0;1;39mvtmp.mount[0m - /vtmp..."}
- {"dt": "2024-01-25T11:26:06.835744", "lvl": "target", "msg": "         Starting [0;1;39msystemd-udevd.ser\u2026ger for Device Events and Files..."}
- {"dt": "2024-01-25T11:26:06.877498", "lvl": "target", "msg": "<3>[    7.071898] 9pnet_virtio: no channels available for device v_tmp"}
- {"dt": "2024-01-25T11:26:06.886342", "lvl": "target", "msg": "[[0;32m  OK  [0m] Mounted [0;1;39mtmp.mount[0m - /tmp."}
- {"dt": "2024-01-25T11:26:06.922651", "lvl": "target", "msg": "[[0;1;31mFAILED[0m] Failed to mount [0;1;39mvtmp.mount[0m - /vtmp."}
- {"dt": "2024-01-25T11:26:06.923426", "lvl": "target", "msg": "See 'systemctl status vtmp.mount' for details."}
- {"dt": "2024-01-25T11:26:07.223139", "lvl": "target", "msg": "[[0;32m  OK  [0m] Started [0;1;39msystemd-udevd.serv\u2026nager for Device Events and Files."}
- {"dt": "2024-01-25T11:26:09.234116", "lvl": "target", "msg": "[[0m[0;31m*     [0m] (1 of 6) Job systemd-udev-trigger.s\u2026vice/start running (4s / no limit)"}
- {"dt": "2024-01-25T11:26:09.249217", "lvl": "target", "msg": "M[K[[0;32m  OK  [0m] Finished [0;1;39msystemd-udev-trig\u2026e[0m - Coldplug All udev Devices."}
- {"dt": "2024-01-25T11:26:09.319018", "lvl": "target", "msg": "[K         Starting [0;1;39mifupdown-pre.serv\u2026ynchronize boot up for ifupdown..."}
- {"dt": "2024-01-25T11:26:09.439994", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39mifupdown-pre.serv\u2026 synchronize boot up for ifupdown."}
- {"dt": "2024-01-25T11:26:09.508817", "lvl": "target", "msg": "[[0;32m  OK  [0m] Found device [0;1;39mdev-ttyAMA0.device[0m - /dev/ttyAMA0."}
- {"dt": "2024-01-25T11:26:09.599100", "lvl": "target", "msg": "[[0;32m  OK  [0m] Found device [0;1;39mdev-ttyS1.device[0m - /dev/ttyS1."}
- {"dt": "2024-01-25T11:26:09.749061", "lvl": "target", "msg": "[[0;32m  OK  [0m] Found device [0;1;39mdev-ttyS3.device[0m - /dev/ttyS3."}
- {"dt": "2024-01-25T11:26:09.763216", "lvl": "target", "msg": "[[0;32m  OK  [0m] Found device [0;1;39mdev-ttyS2.device[0m - /dev/ttyS2."}
- {"dt": "2024-01-25T11:26:12.014817", "lvl": "target", "msg": "[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (7s / no limit)"}
- {"dt": "2024-01-25T11:26:12.599747", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (8s / no limit)"}
- {"dt": "2024-01-25T11:26:13.183288", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (8s / no limit)"}
- {"dt": "2024-01-25T11:26:13.766857", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (9s / no limit)"}
- {"dt": "2024-01-25T11:26:14.351686", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (10s / no limit)"}
- {"dt": "2024-01-25T11:26:14.934680", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (10s / no limit)"}
- {"dt": "2024-01-25T11:26:15.519258", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (11s / no limit)"}
- {"dt": "2024-01-25T11:26:16.103464", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (11s / no limit)"}
- {"dt": "2024-01-25T11:26:16.687363", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (12s / no limit)"}
- {"dt": "2024-01-25T11:26:17.271683", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (12s / no limit)"}
- {"dt": "2024-01-25T11:26:17.858928", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (13s / no limit)"}
- {"dt": "2024-01-25T11:26:18.443021", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (14s / no limit)"}
- {"dt": "2024-01-25T11:26:19.026593", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (14s / no limit)"}
- {"dt": "2024-01-25T11:26:19.610362", "lvl": "target", "msg": "M[K[[0m[0;31m*     [0m] Job dev-vdg.device/start running (15s / no limit)"}
- {"dt": "2024-01-25T11:26:20.185103", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (15s / no limit)"}
- {"dt": "2024-01-25T11:26:20.686150", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (16s / no limit)"}
- {"dt": "2024-01-25T11:26:21.185248", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (16s / no limit)"}
- {"dt": "2024-01-25T11:26:21.684890", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (17s / no limit)"}
- {"dt": "2024-01-25T11:26:22.184813", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (17s / no limit)"}
- {"dt": "2024-01-25T11:26:22.684987", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (18s / no limit)"}
- {"dt": "2024-01-25T11:26:23.184664", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (18s / no limit)"}
- {"dt": "2024-01-25T11:26:23.684855", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (19s / no limit)"}
- {"dt": "2024-01-25T11:26:24.184949", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (19s / no limit)"}
- {"dt": "2024-01-25T11:26:24.684899", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (20s / no limit)"}
- {"dt": "2024-01-25T11:26:25.185150", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (20s / no limit)"}
- {"dt": "2024-01-25T11:26:25.684896", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (21s / no limit)"}
- {"dt": "2024-01-25T11:26:26.184854", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (21s / no limit)"}
- {"dt": "2024-01-25T11:26:26.684852", "lvl": "target", "msg": "M[K[[0m[0;31m*     [0m] Job dev-vdg.device/start running (22s / no limit)"}
- {"dt": "2024-01-25T11:26:27.184889", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (22s / no limit)"}
- {"dt": "2024-01-25T11:26:27.684974", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (23s / no limit)"}
- {"dt": "2024-01-25T11:26:28.184943", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (23s / no limit)"}
- {"dt": "2024-01-25T11:26:28.684990", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (24s / no limit)"}
- {"dt": "2024-01-25T11:26:29.184263", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (24s / no limit)"}
- {"dt": "2024-01-25T11:26:29.684959", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (25s / no limit)"}
- {"dt": "2024-01-25T11:26:30.184465", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (25s / no limit)"}
- {"dt": "2024-01-25T11:26:30.684999", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (26s / no limit)"}
- {"dt": "2024-01-25T11:26:31.185029", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (26s / no limit)"}
- {"dt": "2024-01-25T11:26:31.684986", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (27s / no limit)"}
- {"dt": "2024-01-25T11:26:32.185210", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (27s / no limit)"}
- {"dt": "2024-01-25T11:26:32.685022", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (28s / no limit)"}
- {"dt": "2024-01-25T11:26:33.185069", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (28s / no limit)"}
- {"dt": "2024-01-25T11:26:33.684960", "lvl": "target", "msg": "M[K[[0m[0;31m*     [0m] Job dev-vdg.device/start running (29s / no limit)"}
- {"dt": "2024-01-25T11:26:34.184951", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (29s / no limit)"}
- {"dt": "2024-01-25T11:26:34.684919", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (30s / no limit)"}
- {"dt": "2024-01-25T11:26:35.184219", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (30s / no limit)"}
- {"dt": "2024-01-25T11:26:35.684999", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (31s / no limit)"}
- {"dt": "2024-01-25T11:26:36.185154", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (31s / no limit)"}
- {"dt": "2024-01-25T11:26:36.685057", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (32s / no limit)"}
- {"dt": "2024-01-25T11:26:37.185018", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (32s / no limit)"}
- {"dt": "2024-01-25T11:26:37.684916", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (33s / no limit)"}
- {"dt": "2024-01-25T11:26:38.185209", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (33s / no limit)"}
- {"dt": "2024-01-25T11:26:38.685216", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (34s / no limit)"}
- {"dt": "2024-01-25T11:26:39.184390", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (34s / no limit)"}
- {"dt": "2024-01-25T11:26:39.684246", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (35s / no limit)"}
- {"dt": "2024-01-25T11:26:40.184287", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (35s / no limit)"}
- {"dt": "2024-01-25T11:26:40.684590", "lvl": "target", "msg": "M[K[[0m[0;31m*     [0m] Job dev-vdg.device/start running (36s / no limit)"}
- {"dt": "2024-01-25T11:26:41.184665", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (36s / no limit)"}
- {"dt": "2024-01-25T11:26:41.684363", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (37s / no limit)"}
- {"dt": "2024-01-25T11:26:42.184472", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (37s / no limit)"}
- {"dt": "2024-01-25T11:26:42.684489", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (38s / no limit)"}
- {"dt": "2024-01-25T11:26:43.185065", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (38s / no limit)"}
- {"dt": "2024-01-25T11:26:43.684968", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (39s / no limit)"}
- {"dt": "2024-01-25T11:26:44.184211", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (39s / no limit)"}
- {"dt": "2024-01-25T11:26:44.684886", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (40s / no limit)"}
- {"dt": "2024-01-25T11:26:45.184982", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (40s / no limit)"}
- {"dt": "2024-01-25T11:26:45.685194", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (41s / no limit)"}
- {"dt": "2024-01-25T11:26:46.185055", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (41s / no limit)"}
- {"dt": "2024-01-25T11:26:46.685101", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (42s / no limit)"}
- {"dt": "2024-01-25T11:26:47.185128", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (42s / no limit)"}
- {"dt": "2024-01-25T11:26:47.684909", "lvl": "target", "msg": "M[K[[0m[0;31m*     [0m] Job dev-vdg.device/start running (43s / no limit)"}
- {"dt": "2024-01-25T11:26:48.184881", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (43s / no limit)"}
- {"dt": "2024-01-25T11:26:48.685061", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (44s / no limit)"}
- {"dt": "2024-01-25T11:26:49.185025", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (44s / no limit)"}
- {"dt": "2024-01-25T11:26:49.684953", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (45s / no limit)"}
- {"dt": "2024-01-25T11:26:50.185011", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (45s / no limit)"}
- {"dt": "2024-01-25T11:26:50.684101", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (46s / no limit)"}
- {"dt": "2024-01-25T11:26:51.185101", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (46s / no limit)"}
- {"dt": "2024-01-25T11:26:51.684896", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (47s / no limit)"}
- {"dt": "2024-01-25T11:26:52.184994", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (47s / no limit)"}
- {"dt": "2024-01-25T11:26:52.684951", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (48s / no limit)"}
- {"dt": "2024-01-25T11:26:53.185027", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (48s / no limit)"}
- {"dt": "2024-01-25T11:26:53.684994", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (49s / no limit)"}
- {"dt": "2024-01-25T11:26:54.184967", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (49s / no limit)"}
- {"dt": "2024-01-25T11:26:54.684951", "lvl": "target", "msg": "M[K[[0m[0;31m*     [0m] Job dev-vdg.device/start running (50s / no limit)"}
- {"dt": "2024-01-25T11:26:55.184830", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (50s / no limit)"}
- {"dt": "2024-01-25T11:26:55.684834", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (51s / no limit)"}
- {"dt": "2024-01-25T11:26:56.185134", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (51s / no limit)"}
- {"dt": "2024-01-25T11:26:56.685222", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (52s / no limit)"}
- {"dt": "2024-01-25T11:26:57.185178", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (52s / no limit)"}
- {"dt": "2024-01-25T11:26:57.684938", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (53s / no limit)"}
- {"dt": "2024-01-25T11:26:58.184861", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (53s / no limit)"}
- {"dt": "2024-01-25T11:26:58.684446", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (54s / no limit)"}
- {"dt": "2024-01-25T11:26:59.185132", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (54s / no limit)"}
- {"dt": "2024-01-25T11:26:59.684995", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (55s / no limit)"}
- {"dt": "2024-01-25T11:27:00.185189", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (55s / no limit)"}
- {"dt": "2024-01-25T11:27:00.684914", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (56s / no limit)"}
- {"dt": "2024-01-25T11:27:01.185080", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (56s / no limit)"}
- {"dt": "2024-01-25T11:27:01.684944", "lvl": "target", "msg": "M[K[[0m[0;31m*     [0m] Job dev-vdg.device/start running (57s / no limit)"}
- {"dt": "2024-01-25T11:27:02.184915", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (57s / no limit)"}
- {"dt": "2024-01-25T11:27:02.685207", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (58s / no limit)"}
- {"dt": "2024-01-25T11:27:03.185050", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (58s / no limit)"}
- {"dt": "2024-01-25T11:27:03.684914", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (59s / no limit)"}
- {"dt": "2024-01-25T11:27:04.184954", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (59s / no limit)"}
- {"dt": "2024-01-25T11:27:04.684946", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (1min / no limit)"}
- {"dt": "2024-01-25T11:27:05.184906", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (1min / no limit)"}
- {"dt": "2024-01-25T11:27:05.684887", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (1min 1s / no limit)"}
- {"dt": "2024-01-25T11:27:06.185073", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (1min 1s / no limit)"}
- {"dt": "2024-01-25T11:27:06.685074", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (1min 2s / no limit)"}
- {"dt": "2024-01-25T11:27:07.185143", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (1min 2s / no limit)"}
- {"dt": "2024-01-25T11:27:07.685046", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (1min 3s / no limit)"}
- {"dt": "2024-01-25T11:27:08.185038", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (1min 3s / no limit)"}
- {"dt": "2024-01-25T11:27:08.684920", "lvl": "target", "msg": "M[K[[0m[0;31m*     [0m] Job dev-vdg.device/start running (1min 4s / no limit)"}
- {"dt": "2024-01-25T11:27:09.185126", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (1min 4s / no limit)"}
- {"dt": "2024-01-25T11:27:09.685007", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (1min 5s / no limit)"}
- {"dt": "2024-01-25T11:27:10.185114", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (1min 5s / no limit)"}
- {"dt": "2024-01-25T11:27:10.684966", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (1min 6s / no limit)"}
- {"dt": "2024-01-25T11:27:11.185063", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (1min 6s / no limit)"}
- {"dt": "2024-01-25T11:27:11.685124", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (1min 7s / no limit)"}
- {"dt": "2024-01-25T11:27:12.185294", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (1min 7s / no limit)"}
- {"dt": "2024-01-25T11:27:12.685052", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (1min 8s / no limit)"}
- {"dt": "2024-01-25T11:27:13.185322", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (1min 8s / no limit)"}
- {"dt": "2024-01-25T11:27:13.684933", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (1min 9s / no limit)"}
- {"dt": "2024-01-25T11:27:14.184880", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (1min 9s / no limit)"}
- {"dt": "2024-01-25T11:27:14.684989", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (1min 10s / no limit)"}
- {"dt": "2024-01-25T11:27:15.185037", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (1min 10s / no limit)"}
- {"dt": "2024-01-25T11:27:15.684912", "lvl": "target", "msg": "M[K[[0m[0;31m*     [0m] Job dev-vdg.device/start running (1min 11s / no limit)"}
- {"dt": "2024-01-25T11:27:16.184934", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (1min 11s / no limit)"}
- {"dt": "2024-01-25T11:27:16.685101", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (1min 12s / no limit)"}
- {"dt": "2024-01-25T11:27:17.185200", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (1min 12s / no limit)"}
- {"dt": "2024-01-25T11:27:17.685000", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (1min 13s / no limit)"}
- {"dt": "2024-01-25T11:27:18.185059", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (1min 13s / no limit)"}
- {"dt": "2024-01-25T11:27:18.684880", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (1min 14s / no limit)"}
- {"dt": "2024-01-25T11:27:19.185023", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (1min 14s / no limit)"}
- {"dt": "2024-01-25T11:27:19.685127", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (1min 15s / no limit)"}
- {"dt": "2024-01-25T11:27:20.185134", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (1min 15s / no limit)"}
- {"dt": "2024-01-25T11:27:20.685074", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (1min 16s / no limit)"}
- {"dt": "2024-01-25T11:27:21.184798", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (1min 16s / no limit)"}
- {"dt": "2024-01-25T11:27:21.684878", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (1min 17s / no limit)"}
- {"dt": "2024-01-25T11:27:22.185094", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (1min 17s / no limit)"}
- {"dt": "2024-01-25T11:27:22.685029", "lvl": "target", "msg": "M[K[[0m[0;31m*     [0m] Job dev-vdg.device/start running (1min 18s / no limit)"}
- {"dt": "2024-01-25T11:27:23.185113", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (1min 18s / no limit)"}
- {"dt": "2024-01-25T11:27:23.685265", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (1min 19s / no limit)"}
- {"dt": "2024-01-25T11:27:24.184940", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (1min 19s / no limit)"}
- {"dt": "2024-01-25T11:27:24.685095", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (1min 20s / no limit)"}
- {"dt": "2024-01-25T11:27:25.185298", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (1min 20s / no limit)"}
- {"dt": "2024-01-25T11:27:25.684956", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (1min 21s / no limit)"}
- {"dt": "2024-01-25T11:27:26.185058", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (1min 21s / no limit)"}
- {"dt": "2024-01-25T11:27:26.684959", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (1min 22s / no limit)"}
- {"dt": "2024-01-25T11:27:27.185204", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (1min 22s / no limit)"}
- {"dt": "2024-01-25T11:27:27.685087", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (1min 23s / no limit)"}
- {"dt": "2024-01-25T11:27:28.185270", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (1min 23s / no limit)"}
- {"dt": "2024-01-25T11:27:28.684976", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (1min 24s / no limit)"}
- {"dt": "2024-01-25T11:27:29.185047", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (1min 24s / no limit)"}
- {"dt": "2024-01-25T11:27:29.684874", "lvl": "target", "msg": "M[K[[0m[0;31m*     [0m] Job dev-vdg.device/start running (1min 25s / no limit)"}
- {"dt": "2024-01-25T11:27:30.185013", "lvl": "target", "msg": "M[K[[0;1;31m*[0m[0;31m*    [0m] Job dev-vdg.device/start running (1min 25s / no limit)"}
- {"dt": "2024-01-25T11:27:30.685067", "lvl": "target", "msg": "M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] Job dev-vdg.device/start running (1min 26s / no limit)"}
- {"dt": "2024-01-25T11:27:31.185165", "lvl": "target", "msg": "M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] Job dev-vdg.device/start running (1min 26s / no limit)"}
- {"dt": "2024-01-25T11:27:31.685063", "lvl": "target", "msg": "M[K[  [0;31m*[0;1;31m*[0m[0;31m* [0m] Job dev-vdg.device/start running (1min 27s / no limit)"}
- {"dt": "2024-01-25T11:27:32.185117", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (1min 27s / no limit)"}
- {"dt": "2024-01-25T11:27:32.684977", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (1min 28s / no limit)"}
- {"dt": "2024-01-25T11:27:33.185221", "lvl": "target", "msg": "M[K[     [0;31m*[0m] Job dev-vdg.device/start running (1min 28s / no limit)"}
- {"dt": "2024-01-25T11:27:33.685036", "lvl": "target", "msg": "M[K[    [0;31m*[0;1;31m*[0m] Job dev-vdg.device/start running (1min 29s / no limit)"}
- {"dt": "2024-01-25T11:27:34.185263", "lvl": "target", "msg": "M[K[   [0;31m*[0;1;31m*[0m[0;31m*[0m] Job dev-vdg.device/start running (1min 29s / no limit)"}
- {"dt": "2024-01-25T11:27:34.437529", "lvl": "target", "msg": "M[K[[0;1;31m TIME [0m] Timed out waiting for device [0;1;39mdev-vdg.device[0m - /dev/vdg."}
- {"dt": "2024-01-25T11:27:34.439900", "lvl": "target", "msg": "[K[[0;1;38;5;185mDEPEND[0m] Dependency failed for [0;1;39msyst\u2026m - File System Check on /dev/vdg."}
- {"dt": "2024-01-25T11:27:34.442135", "lvl": "target", "msg": "[[0;1;38;5;185mDEPEND[0m] Dependency failed for [0;1;39mresults.mount[0m - /results."}
- {"dt": "2024-01-25T11:27:34.444890", "lvl": "target", "msg": "[[0;1;38;5;185mDEPEND[0m] Dependency failed for [0;1;39mloca\u2026s.target[0m - Local File Systems."}
- {"dt": "2024-01-25T11:27:34.464806", "lvl": "target", "msg": "[[0;32m  OK  [0m] Stopped [0;1;39msystemd-ask-passwo\u2026quests to Console Directory Watch."}
- {"dt": "2024-01-25T11:27:34.483802", "lvl": "target", "msg": "[[0;32m  OK  [0m] Stopped [0;1;39msystemd-ask-passwo\u2026 Requests to Wall Directory Watch."}
- {"dt": "2024-01-25T11:27:34.487681", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mtimers.target[0m - Timer Units."}
- {"dt": "2024-01-25T11:27:34.540349", "lvl": "target", "msg": "         Starting [0;1;39mnetworking.service[0m - Raise network interfaces..."}
- {"dt": "2024-01-25T11:27:34.553059", "lvl": "target", "msg": "[[0;32m  OK  [0m] Closed [0;1;39msyslog.socket[0m - Syslog Socket."}
- {"dt": "2024-01-25T11:27:34.561112", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mgetty.target[0m - Login Prompts."}
- {"dt": "2024-01-25T11:27:34.563875", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39msockets.target[0m - Socket Units."}
- {"dt": "2024-01-25T11:27:34.615244", "lvl": "target", "msg": "[[0;32m  OK  [0m] Started [0;1;39memergency.service[0m - Emergency Shell."}
- {"dt": "2024-01-25T11:27:34.617744", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39memergency.target[0m - Emergency Mode."}
- {"dt": "2024-01-25T11:27:34.640583", "lvl": "target", "msg": "         Starting [0;1;39msystemd-binfmt.se\u2026et Up Additional Binary Formats..."}
- {"dt": "2024-01-25T11:27:34.664124", "lvl": "target", "msg": "         Starting [0;1;39msystemd-tmpfiles-\u2026 Volatile Files and Directories..."}
- {"dt": "2024-01-25T11:27:34.808026", "lvl": "target", "msg": "[[0;1;31mFAILED[0m] Failed to start [0;1;39msystemd-bi\u2026 Set Up Additional Binary Formats."}
- {"dt": "2024-01-25T11:27:34.810393", "lvl": "target", "msg": "See 'systemctl status systemd-binfmt.service' for details."}
- {"dt": "2024-01-25T11:27:34.974565", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39msystemd-tmpfiles-\u2026te Volatile Files and Directories."}
- {"dt": "2024-01-25T11:27:35.035618", "lvl": "target", "msg": "         Mounting [0;1;39mrun-rpc_pipefs.mount[0m - RPC Pipe File System..."}
- {"dt": "2024-01-25T11:27:35.060409", "lvl": "target", "msg": "         Starting [0;1;39mrpcbind.service[0m - RPC bind portmap service..."}
- {"dt": "2024-01-25T11:27:35.087520", "lvl": "target", "msg": "         Starting [0;1;39msystemd-update-ut\u2026rd System Boot/Shutdown in UTMP..."}
- {"dt": "2024-01-25T11:27:35.144661", "lvl": "target", "msg": "[[0;32m  OK  [0m] Mounted [0;1;39mrun-rpc_pipefs.mount[0m - RPC Pipe File System."}
- {"dt": "2024-01-25T11:27:35.158557", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mrpc_pipefs.target[0m."}
- {"dt": "2024-01-25T11:27:35.208268", "lvl": "target", "msg": "         Starting [0;1;39mnfs-blkmap.servic\u2026NFS block layout mapping daemon..."}
- {"dt": "2024-01-25T11:27:35.210407", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mnfs-client.target[0m - NFS client services."}
- {"dt": "2024-01-25T11:27:35.222291", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39mnetworking.service[0m - Raise network interfaces."}
- {"dt": "2024-01-25T11:27:35.226739", "lvl": "target", "msg": "[[0;32m  OK  [0m] Started [0;1;39mrpcbind.service[0m - RPC bind portmap service."}
- {"dt": "2024-01-25T11:27:35.258158", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mnetwork.target[0m - Network."}
- {"dt": "2024-01-25T11:27:35.260336", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mnetwork-online.target[0m - Network is Online."}
- {"dt": "2024-01-25T11:27:35.261048", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mremote-fs-p\u2026eparation for Remote File Systems."}
- {"dt": "2024-01-25T11:27:35.266063", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mremote-fs.target[0m - Remote File Systems."}
- {"dt": "2024-01-25T11:27:35.267126", "lvl": "target", "msg": "[[0;32m  OK  [0m] Reached target [0;1;39mrpcbind.target[0m - RPC Port Mapper."}
- {"dt": "2024-01-25T11:27:35.303612", "lvl": "target", "msg": "         Starting [0;1;39mrpc-statd-notify.\u2026- Notify NFS peers of a restart..."}
- {"dt": "2024-01-25T11:27:35.323395", "lvl": "target", "msg": "         Starting [0;1;39mrpc-statd.service\u2026us monitor for NFSv2/3 locking...."}
- {"dt": "2024-01-25T11:27:35.346988", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39msystemd-update-ut\u2026cord System Boot/Shutdown in UTMP."}
- {"dt": "2024-01-25T11:27:35.357324", "lvl": "target", "msg": "[[0;32m  OK  [0m] Started [0;1;39mnfs-blkmap.service\u2026 pNFS block layout mapping daemon."}
- {"dt": "2024-01-25T11:27:35.367891", "lvl": "target", "msg": "[[0;32m  OK  [0m] Started [0;1;39mrpc-statd-notify.s\u2026m - Notify NFS peers of a restart."}
- {"dt": "2024-01-25T11:27:35.412937", "lvl": "target", "msg": "         Starting [0;1;39msystemd-update-ut\u2026 Record Runlevel Change in UTMP..."}
- {"dt": "2024-01-25T11:27:35.469152", "lvl": "target", "msg": "[[0;32m  OK  [0m] Started [0;1;39mrpc-statd.service\u2026atus monitor for NFSv2/3 locking.."}
- {"dt": "2024-01-25T11:27:35.523799", "lvl": "target", "msg": "[[0;32m  OK  [0m] Finished [0;1;39msystemd-update-ut\u2026 - Record Runlevel Change in UTMP."}
- {"dt": "2024-01-25T11:27:35.676793", "lvl": "target", "msg": "You are in emergency mode. After logging in, type \\\"journalctl -xb\\\" to view"}
- {"dt": "2024-01-25T11:27:35.677008", "lvl": "target", "msg": "system logs, \\\"systemctl reboot\\\" to reboot, \\\"systemctl default\\\" or \\\"exit\\\""}
- {"dt": "2024-01-25T11:27:35.677113", "lvl": "target", "msg": "to boot into default mode."}
- {"dt": "2024-01-25T11:27:35.746577", "lvl": "target", "msg": ""}
- {"dt": "2024-01-25T11:27:35.747042", "lvl": "target", "msg": "Cannot open access to console, the root account is locked."}
- {"dt": "2024-01-25T11:27:35.747459", "lvl": "target", "msg": "See sulogin(8) man page for more details."}
- {"dt": "2024-01-25T11:27:35.747554", "lvl": "target", "msg": ""}
- {"dt": "2024-01-25T11:27:35.747665", "lvl": "target", "msg": "Press Enter to continue."}
- {"dt": "2024-01-25T11:28:59.025430", "lvl": "exception", "msg": "wait for prompt timed out"}
- {"dt": "2024-01-25T11:28:59.025663", "lvl": "debug", "msg": "end: 2.2.1 login-action (duration 00:03:00) [common]"}
- {"dt": "2024-01-25T11:28:59.025783", "lvl": "results", "msg": {"case": "login-action", "definition": "lava", "duration": "179.83", "extra": {"fail": "wait for prompt timed out"}, "level": "2.2.1", "namespace": "common", "result": "fail"}}
- {"dt": "2024-01-25T11:28:59.026206", "lvl": "error", "msg": "auto-login-action failed: 1 of 1 attempts. 'wait for prompt timed out'"}
- {"dt": "2024-01-25T11:28:59.026270", "lvl": "exception", "msg": "wait for prompt timed out"}
- {"dt": "2024-01-25T11:28:59.026320", "lvl": "debug", "msg": "end: 2.2 auto-login-action (duration 00:03:00) [common]"}
- {"dt": "2024-01-25T11:28:59.026379", "lvl": "results", "msg": {"case": "auto-login-action", "definition": "lava", "duration": "180.08", "extra": {"fail": "wait for prompt timed out"}, "level": "2.2", "namespace": "common", "result": "fail"}}
- {"dt": "2024-01-25T11:28:59.026469", "lvl": "error", "msg": "boot-image-retry failed: 1 of 1 attempts. 'wait for prompt timed out'"}
- {"dt": "2024-01-25T11:28:59.026536", "lvl": "exception", "msg": "wait for prompt timed out"}
- {"dt": "2024-01-25T11:28:59.026583", "lvl": "info", "msg": "end: 2 boot-image-retry (duration 00:03:00) [common]"}
- {"dt": "2024-01-25T11:28:59.026630", "lvl": "results", "msg": {"case": "boot-image-retry", "definition": "lava", "duration": "180.08", "extra": {"fail": "wait for prompt timed out"}, "level": "2", "namespace": "common", "result": "fail"}}
- {"dt": "2024-01-25T11:28:59.026745", "lvl": "info", "msg": "Cleaning after the job"}
- {"dt": "2024-01-25T11:28:59.026839", "lvl": "debug", "msg": "Cleaning up download directory: /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/kernel"}
- {"dt": "2024-01-25T11:28:59.034762", "lvl": "debug", "msg": "Cleaning up download directory: /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/rootfs"}
- {"dt": "2024-01-25T11:28:59.034891", "lvl": "debug", "msg": "Cleaning up download directory: /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/rootfs.modules"}
- {"dt": "2024-01-25T11:28:59.044778", "lvl": "debug", "msg": "Cleaning up download directory: /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1/deployimages-h42pp5z0/rootfs.overlay-00"}
- {"dt": "2024-01-25T11:28:59.057008", "lvl": "debug", "msg": "start: 4.1 power-off (timeout 00:00:30) [common]"}
- {"dt": "2024-01-25T11:28:59.057087", "lvl": "debug", "msg": "end: 4.1 power-off (duration 00:00:00) [common]"}
- {"dt": "2024-01-25T11:28:59.057152", "lvl": "debug", "msg": "start: 4.2 read-feedback (timeout 00:05:00) [common]"}
- {"dt": "2024-01-25T11:28:59.057326", "lvl": "debug", "msg": "Listened to connection for namespace 'common' for up to 1s"}
- {"dt": "2024-01-25T11:29:00.058347", "lvl": "info", "msg": "Finalising connection for namespace 'common'"}
- {"dt": "2024-01-25T11:29:00.058567", "lvl": "input", "msg": "poweroff\n"}
- {"dt": "2024-01-25T11:29:00.158866", "lvl": "target", "msg": "poweroff"}
- {"dt": "2024-01-25T11:29:00.165810", "lvl": "feedback", "msg": ""}
- {"dt": "2024-01-25T11:29:00.166152", "lvl": "debug", "msg": "Already disconnected"}
- {"dt": "2024-01-25T11:29:00.366653", "lvl": "debug", "msg": "end: 4.2 read-feedback (duration 00:00:01) [common]"}
- {"dt": "2024-01-25T11:29:00.366885", "lvl": "info", "msg": "Root tmp directory removed at /var/lib/lava/dispatcher/tmp/tuxrun-cqbtqnpb-1"}
- {"dt": "2024-01-25T11:29:00.369166", "lvl": "error", "msg": "JobError: Your job cannot terminate cleanly."}
- {"dt": "2024-01-25T11:29:00.369288", "lvl": "results", "msg": {"case": "job", "definition": "lava", "error_msg": "wait for prompt timed out", "error_type": "Job", "result": "fail"}}
