[57.243074] Initializing watchdogs
[57.243148]   /dev/watchdog0
[57.263779] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.275211] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[57.279247] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.282151] [001/131] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[57.482572] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[57.484215] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[57.613559] [002/131] (960s left) syncobj_timeline (reset-multiple-signaled)
[57.683397] Starting subtest: reset-multiple-signaled
[57.684316] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[57.844373] [003/131] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[58.040490] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[58.042168] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[58.187430] [004/131] (959s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[58.374533] Starting subtest: flip-vs-cursor-crc-legacy
[58.965975] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.592s)
[59.229260] [005/131] (958s left) gem_eio (kms)
[59.598045] Starting subtest: kms
[76.973587] Subtest kms: SUCCESS (17.396s)
[77.322940] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[77.325165] [006/131] (940s left) gem_mmap_gtt (basic-wc)
[77.410222] Subtest basic-wc: SKIP (0.000s)
[77.472927] [007/131] (940s left) gem_exec_schedule (manyslice)
[77.561692] Starting subtest: manyslice
[77.562580] Starting dynamic subtest: rcs0
[83.023055] Dynamic subtest rcs0: SUCCESS (5.460s)
[83.041580] Starting dynamic subtest: bcs0
[89.478993] Dynamic subtest bcs0: SUCCESS (6.454s)
[89.488035] Starting dynamic subtest: vcs0
[95.703376] Dynamic subtest vcs0: SUCCESS (6.223s)
[95.717164] Starting dynamic subtest: vcs1
[101.924576] Dynamic subtest vcs1: SUCCESS (6.220s)
[101.933443] Starting dynamic subtest: vecs0
[108.147772] Dynamic subtest vecs0: SUCCESS (6.222s)
[108.159120] Starting dynamic subtest: vecs1
[113.859117] Dynamic subtest vecs1: SUCCESS (5.708s)
[113.868764] Starting dynamic subtest: ccs0
[119.805916] Dynamic subtest ccs0: SUCCESS (5.946s)
[119.807056] Subtest manyslice: SUCCESS (42.246s)
[120.136277] [008/131] (898s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[120.353190] Starting subtest: y-tiled-8bpp-rotate-270
[120.355037] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[120.481601] [009/131] (897s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[122.095664] Starting subtest: dpms-mode-unset-non-lpsp
[123.490232] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.395s)
[123.894230] [010/131] (894s left) gem_exec_fence (syncobj-timeline-chain-engines)
[124.547401] Starting subtest: syncobj-timeline-chain-engines
[124.703782] Subtest syncobj-timeline-chain-engines: SUCCESS (0.156s)
[125.022123] [011/131] (893s left) gem_mmap_gtt (basic-read-write-distinct)
[125.103180] Subtest basic-read-write-distinct: SKIP (0.000s)
[125.200290] [012/131] (893s left) gem_mmap_wc (write)
[125.285194] Subtest write: SKIP (0.000s)
[125.353375] [013/131] (893s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[125.554993] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[125.556819] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[125.701778] [014/131] (892s left) kms_chamelium_hpd (hdmi-hpd-fast)
[125.983900] Subtest hdmi-hpd-fast: SKIP (0.000s)
[126.146627] [015/131] (892s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[126.346942] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[126.348626] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[126.498789] [016/131] (892s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[126.702035] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[126.703881] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[126.849557] [017/131] (892s left) prime_vgem (basic-fence-read)
[126.937847] Starting subtest: basic-fence-read
[126.943629] Subtest basic-fence-read: SKIP (0.005s)
[127.102544] [018/131] (891s left) kms_addfb_basic (basic-y-tiled-legacy)
[127.179616] Starting subtest: basic-y-tiled-legacy
[127.181323] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[127.417384] [019/131] (891s left) prime_mmap (test_invalid_sync_flags)
[127.496590] Starting subtest: test_invalid_sync_flags
[127.497453] Starting dynamic subtest: test_invalid_sync_flags-smem
[127.498385] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[127.507802] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[127.509011] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[127.510178] Subtest test_invalid_sync_flags: SUCCESS (0.002s)
[127.653213] [020/131] (891s left) syncobj_timeline (wait-for-submit-delayed-submit)
[127.730577] Starting subtest: wait-for-submit-delayed-submit
[127.831921] Subtest wait-for-submit-delayed-submit: SUCCESS (0.101s)
[127.967109] [021/131] (891s left) gem_ctx_persistence (legacy-engines-mixed-process)
[128.053916] Starting subtest: legacy-engines-mixed-process
[128.054874] Starting dynamic subtest: render
[129.846810] Dynamic subtest render: SUCCESS (1.792s)
[129.857949] Starting dynamic subtest: bsd1
[131.911312] Dynamic subtest bsd1: SUCCESS (2.063s)
[131.923817] Starting dynamic subtest: bsd2
[133.883810] Dynamic subtest bsd2: SUCCESS (1.971s)
[133.895202] Starting dynamic subtest: blt
[135.866031] Dynamic subtest blt: SUCCESS (1.981s)
[135.877560] Starting dynamic subtest: vebox
[137.916063] Dynamic subtest vebox: SUCCESS (2.048s)
[137.917150] Subtest legacy-engines-mixed-process: SUCCESS (9.863s)
[138.019568] [022/131] (881s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[138.226380] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[138.229664] Starting dynamic subtest: A-DP3
[146.350300] Dynamic subtest A-DP3: SUCCESS (8.120s)
[146.362429] Starting dynamic subtest: B-DP3
[154.389388] Dynamic subtest B-DP3: SUCCESS (8.037s)
[154.400665] Starting dynamic subtest: C-DP3
[162.438437] Dynamic subtest C-DP3: SUCCESS (8.047s)
[162.449706] Starting dynamic subtest: D-DP3
[170.475666] Dynamic subtest D-DP3: SUCCESS (8.036s)
[170.477983] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.251s)
[170.813348] [023/131] (848s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[171.007592] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[171.010030] Starting dynamic subtest: pipe-A-valid-mode
[171.087854] Dynamic subtest pipe-A-valid-mode: SKIP (0.077s)
[171.089746] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.079s)
[171.294568] [024/131] (848s left) gem_exec_whisper (basic-queues-forked-all)
[171.383543] Starting subtest: basic-queues-forked-all
[194.840320] Subtest basic-queues-forked-all: SUCCESS (23.453s)
[195.050336] [025/131] (824s left) prime_mmap (test_errors)
[195.127899] Starting subtest: test_errors
[195.128785] Starting dynamic subtest: test_errors-smem
[195.273477] Dynamic subtest test_errors-smem: SUCCESS (0.145s)
[195.282689] Starting dynamic subtest: test_errors-lmem0
[195.863010] Dynamic subtest test_errors-lmem0: SUCCESS (0.588s)
[195.864043] Subtest test_errors: SUCCESS (0.735s)
[196.011557] [026/131] (823s left) gem_exec_fence (basic-busy)
[196.232518] Starting subtest: basic-busy
[196.234168] Starting dynamic subtest: rcs0
[196.357054] Dynamic subtest rcs0: SUCCESS (0.122s)
[196.398404] Starting dynamic subtest: bcs0
[196.426902] Dynamic subtest bcs0: SUCCESS (0.066s)
[196.449013] Starting dynamic subtest: vcs0
[196.483079] Dynamic subtest vcs0: SUCCESS (0.053s)
[196.522297] Starting dynamic subtest: vcs1
[196.541910] Dynamic subtest vcs1: SUCCESS (0.055s)
[196.559183] Starting dynamic subtest: vecs0
[196.592961] Dynamic subtest vecs0: SUCCESS (0.049s)
[196.624191] Starting dynamic subtest: vecs1
[196.651031] Dynamic subtest vecs1: SUCCESS (0.056s)
[196.676098] Starting dynamic subtest: ccs0
[196.705954] Dynamic subtest ccs0: SUCCESS (0.053s)
[196.707251] Subtest basic-busy: SUCCESS (0.475s)
[197.365226] [027/131] (822s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[197.568131] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[197.626813] [028/131] (822s left) kms_color (deep-color)
[197.825533] Starting subtest: deep-color
[201.198813] Starting dynamic subtest: pipe-A-DP-3-gamma
[207.123028] Dynamic subtest pipe-A-DP-3-gamma: SUCCESS (5.924s)
[207.136223] Starting dynamic subtest: pipe-A-DP-3-degamma
[213.244813] Dynamic subtest pipe-A-DP-3-degamma: SUCCESS (6.119s)
[213.259607] Starting dynamic subtest: pipe-A-DP-3-ctm
[219.390454] Dynamic subtest pipe-A-DP-3-ctm: SUCCESS (6.145s)
[222.707901] Starting dynamic subtest: pipe-B-DP-3-gamma
[228.816057] Dynamic subtest pipe-B-DP-3-gamma: SUCCESS (6.123s)
[228.827055] Starting dynamic subtest: pipe-B-DP-3-degamma
[234.923190] Dynamic subtest pipe-B-DP-3-degamma: SUCCESS (6.105s)
[234.936564] Starting dynamic subtest: pipe-B-DP-3-ctm
[241.068765] Dynamic subtest pipe-B-DP-3-ctm: SUCCESS (6.144s)
[244.473069] Starting dynamic subtest: pipe-C-DP-3-gamma
[250.562282] Dynamic subtest pipe-C-DP-3-gamma: SUCCESS (6.118s)
[250.576991] Starting dynamic subtest: pipe-C-DP-3-degamma
[256.678482] Dynamic subtest pipe-C-DP-3-degamma: SUCCESS (6.116s)
[256.693386] Starting dynamic subtest: pipe-C-DP-3-ctm
[262.807952] Dynamic subtest pipe-C-DP-3-ctm: SUCCESS (6.127s)
[266.089841] Starting dynamic subtest: pipe-D-DP-3-gamma
[272.196206] Dynamic subtest pipe-D-DP-3-gamma: SUCCESS (6.124s)
[272.208028] Starting dynamic subtest: pipe-D-DP-3-degamma
[278.311492] Dynamic subtest pipe-D-DP-3-degamma: SUCCESS (6.113s)
[278.325847] Starting dynamic subtest: pipe-D-DP-3-ctm
[284.448264] Dynamic subtest pipe-D-DP-3-ctm: SUCCESS (6.135s)
[284.449197] Subtest deep-color: SUCCESS (86.621s)
[284.713861] [029/131] (734s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[284.908567] Starting subtest: crc-primary-suspend-y-tiled-ccs
[284.911160] Starting dynamic subtest: pipe-A-DP-3
[284.914625] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[284.923924] Starting dynamic subtest: pipe-B-DP-3
[284.927382] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[284.936487] Starting dynamic subtest: pipe-C-DP-3
[284.940040] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[284.949082] Starting dynamic subtest: pipe-D-DP-3
[284.952622] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[284.954384] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.007s)
[285.388728] [030/131] (734s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[287.999860] Starting subtest: verify-pxp-key-change-after-suspend-resume
[288.001626] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[288.104051] [031/131] (731s left) gem_spin_batch (resubmit-new)
[288.193920] Starting subtest: resubmit-new
[288.194928] Starting dynamic subtest: rcs0
[288.228122] Dynamic subtest rcs0: SUCCESS (0.034s)
[288.239114] Starting dynamic subtest: bcs0
[288.240030] Dynamic subtest bcs0: SUCCESS (0.005s)
[288.249695] Starting dynamic subtest: vcs0
[288.250617] Dynamic subtest vcs0: SUCCESS (0.005s)
[288.259987] Starting dynamic subtest: vcs1
[288.260987] Dynamic subtest vcs1: SUCCESS (0.005s)
[288.270653] Starting dynamic subtest: vecs0
[288.271701] Dynamic subtest vecs0: SUCCESS (0.005s)
[288.281068] Starting dynamic subtest: vecs1
[288.282191] Dynamic subtest vecs1: SUCCESS (0.006s)
[288.291223] Starting dynamic subtest: ccs0
[288.292502] Dynamic subtest ccs0: SUCCESS (0.004s)
[288.293742] Subtest resubmit-new: SUCCESS (0.072s)
[288.564327] [032/131] (731s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[288.764976] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[288.766704] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[288.907771] [033/131] (731s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[289.104598] Starting subtest: disable-crc-after-crtc
[289.107161] Starting dynamic subtest: pipe-A-DP-3
[289.845650] Dynamic subtest pipe-A-DP-3: SUCCESS (0.739s)
[289.864597] Starting dynamic subtest: pipe-B-DP-3
[290.498689] Dynamic subtest pipe-B-DP-3: SUCCESS (0.650s)
[290.511383] Starting dynamic subtest: pipe-C-DP-3
[291.142022] Dynamic subtest pipe-C-DP-3: SUCCESS (0.640s)
[291.158348] Starting dynamic subtest: pipe-D-DP-3
[291.816569] Dynamic subtest pipe-D-DP-3: SUCCESS (0.672s)
[291.817533] Subtest disable-crc-after-crtc: SUCCESS (2.711s)
[292.095233] [034/131] (727s left) kms_sequence (get-forked)
[292.294528] Starting subtest: get-forked
[292.296894] Starting dynamic subtest: pipe-A-DP-3
[294.735420] Dynamic subtest pipe-A-DP-3: SUCCESS (2.440s)
[294.749625] Starting dynamic subtest: pipe-B-DP-3
[297.135182] Dynamic subtest pipe-B-DP-3: SUCCESS (2.397s)
[297.149317] Starting dynamic subtest: pipe-C-DP-3
[299.565544] Dynamic subtest pipe-C-DP-3: SUCCESS (2.428s)
[299.575238] Starting dynamic subtest: pipe-D-DP-3
[301.929148] Dynamic subtest pipe-D-DP-3: SUCCESS (2.362s)
[301.930057] Subtest get-forked: SUCCESS (9.634s)
[302.216074] [035/131] (717s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[302.417047] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[302.418784] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[302.562363] [036/131] (717s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[302.763165] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[302.764970] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[302.915742] [037/131] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[303.116056] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[303.117917] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[303.259069] [038/131] (717s left) perf (blocking-parameterized)
[303.642205] Starting subtest: blocking-parameterized
[323.675214] Subtest blocking-parameterized: SUCCESS (20.032s)
[323.730667] [039/131] (696s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[323.941254] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[323.943131] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[324.074868] [040/131] (696s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[324.272380] Starting subtest: short-busy-flip-before-cursor-toggle
[324.274137] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[324.378837] [041/131] (696s left) gem_exec_schedule (preempt-queue-chain)
[324.478052] Subtest preempt-queue-chain: SKIP (0.000s)
[324.838612] [042/131] (695s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[325.033519] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[325.035814] Starting dynamic subtest: pipe-A-DP-3
[325.044325] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[325.053723] Starting dynamic subtest: pipe-B-DP-3
[325.062205] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[325.071493] Starting dynamic subtest: pipe-C-DP-3
[325.079970] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[325.089518] Starting dynamic subtest: pipe-D-DP-3
[325.100755] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[325.102927] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[325.499848] [043/131] (695s left) gem_partial_pwrite_pread (reads-display)
[325.587209] Subtest reads-display: SKIP (0.000s)
[325.665799] [044/131] (695s left) gem_ccs (block-copy-uncompressed)
[325.752194] Starting subtest: block-copy-uncompressed
[325.754423] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[325.799181] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.046s)
[325.808555] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[325.815196] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[325.826422] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[325.926076] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.110s)
[325.935559] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[326.036131] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.109s)
[326.047199] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[326.052983] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[326.063916] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0
[326.068331] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[326.079464] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem
[326.179777] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.110s)
[326.189472] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0
[326.290165] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.109s)
[326.301262] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[326.306435] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[326.317362] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0
[326.321636] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[326.332608] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem
[326.433407] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.111s)
[326.444465] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0
[326.543073] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.109s)
[326.554158] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[326.560108] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[326.571058] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0
[326.575420] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[326.586387] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem
[326.686527] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.110s)
[326.697589] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0
[326.796624] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.109s)
[326.797454] Subtest block-copy-uncompressed: SUCCESS (1.045s)
[326.935949] [045/131] (693s left) kms_pipe_crc_basic (bad-source)
[327.138653] Starting subtest: bad-source
[327.139556] Subtest bad-source: SUCCESS (0.000s)
[327.245009] [046/131] (693s left) kms_hdr (invalid-metadata-sizes)
[327.442530] Starting subtest: invalid-metadata-sizes
[330.785513] Starting dynamic subtest: pipe-A-DP-3
[330.786476] Dynamic subtest pipe-A-DP-3: SUCCESS (0.001s)
[330.787453] Subtest invalid-metadata-sizes: SUCCESS (3.344s)
[331.064977] [047/131] (689s left) kms_cursor_crc (cursor-sliding-32x32)
[331.357365] Starting subtest: cursor-sliding-32x32
[331.413380] Subtest cursor-sliding-32x32: SKIP (0.054s)
[331.863273] [048/131] (689s left) i915_hangman (hangcheck-unterminated)
[331.960207] Starting subtest: hangcheck-unterminated
[342.159687] Subtest hangcheck-unterminated: SUCCESS (10.199s)
[342.305337] [049/131] (678s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[342.386427] Starting subtest: invalid-multi-wait-all-unsubmitted
[342.387332] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[342.549715] [050/131] (678s left) kms_plane_multiple (tiling-y)
[342.745560] Starting subtest: tiling-y
[342.747379] Subtest tiling-y: SKIP (0.000s)
[342.842394] [051/131] (678s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[343.049372] Starting subtest: x-tiled-addfb-size-offset-overflow
[343.050273] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[343.197211] [052/131] (678s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[343.403278] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[343.405160] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[343.510522] [053/131] (677s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[343.711247] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[343.801863] [054/131] (677s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[343.999553] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[344.001297] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[344.284826] [055/131] (677s left) kms_flip (2x-plain-flip-ts-check)
[344.480014] Starting subtest: 2x-plain-flip-ts-check
[344.495031] Subtest 2x-plain-flip-ts-check: SKIP (0.014s)
[344.603758] [056/131] (677s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[344.803563] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[344.806033] Starting dynamic subtest: pipe-A-DP-3
[344.815718] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[344.825029] Starting dynamic subtest: pipe-B-DP-3
[344.834582] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[344.843787] Starting dynamic subtest: pipe-C-DP-3
[344.853129] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[344.862266] Starting dynamic subtest: pipe-D-DP-3
[344.874439] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[344.876480] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[345.294444] [057/131] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[345.496206] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[345.497882] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[345.642196] [058/131] (676s left) fbdev (nullptr)
[345.695092] Starting subtest: nullptr
[345.696047] Subtest nullptr: SUCCESS (0.000s)
[345.795249] [059/131] (676s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[345.992526] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[345.993413] Starting dynamic subtest: pipe-A
[346.527329] Dynamic subtest pipe-A: SUCCESS (0.534s)
[346.543201] Starting dynamic subtest: pipe-B
[347.193518] Dynamic subtest pipe-B: SUCCESS (0.665s)
[347.213587] Starting dynamic subtest: pipe-C
[347.843837] Dynamic subtest pipe-C: SUCCESS (0.649s)
[347.857330] Starting dynamic subtest: pipe-D
[348.497289] Dynamic subtest pipe-D: SUCCESS (0.652s)
[348.498560] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.506s)
[348.831378] [060/131] (673s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[349.027516] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[349.029827] Starting dynamic subtest: pipe-A-DP-3
[349.038242] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[349.047784] Starting dynamic subtest: pipe-B-DP-3
[349.056260] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[349.065517] Starting dynamic subtest: pipe-C-DP-3
[349.073829] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[349.083283] Starting dynamic subtest: pipe-D-DP-3
[349.091872] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[349.094120] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[349.515208] [061/131] (672s left) api_intel_allocator (reserve-simple)
[349.595409] Starting subtest: reserve-simple
[349.623422] Subtest reserve-simple: SUCCESS (0.028s)
[349.816710] [062/131] (672s left) kms_flip (flip-vs-dpms-on-nop)
[350.013066] Starting subtest: flip-vs-dpms-on-nop
[350.017606] Starting dynamic subtest: A-DP3
[351.153687] Dynamic subtest A-DP3: SUCCESS (1.136s)
[351.171926] Starting dynamic subtest: B-DP3
[352.219440] Dynamic subtest B-DP3: SUCCESS (1.064s)
[352.231447] Starting dynamic subtest: C-DP3
[353.276663] Dynamic subtest C-DP3: SUCCESS (1.056s)
[353.288207] Starting dynamic subtest: D-DP3
[354.351410] Dynamic subtest D-DP3: SUCCESS (1.073s)
[354.353821] Subtest flip-vs-dpms-on-nop: SUCCESS (4.340s)
[354.689977] [063/131] (667s left) kms_busy (extended-modeset-hang-oldfb)
[354.896522] Starting subtest: extended-modeset-hang-oldfb
[354.899050] Starting dynamic subtest: pipe-A
[362.971268] Dynamic subtest pipe-A: SUCCESS (8.073s)
[362.986834] Starting dynamic subtest: pipe-D
[371.052860] Dynamic subtest pipe-D: SUCCESS (8.076s)
[371.053873] Subtest extended-modeset-hang-oldfb: SUCCESS (16.157s)
[371.376386] [064/131] (650s left) kms_psr (fbc-pr-sprite-plane-onoff)
[371.577275] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[371.634861] [065/131] (650s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[371.836986] Starting subtest: cursorB-vs-flipB-atomic-transitions
[371.838869] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[371.955055] [066/131] (650s left) kms_chamelium_color (ctm-limited-range)
[372.150132] Subtest ctm-limited-range: SKIP (0.000s)
[372.218755] [067/131] (650s left) kms_prime (d3hot)
[372.417998] Subtest D3hot: SKIP (0.000s)
[372.556823] [068/131] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[372.754162] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[372.755902] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[372.872472] [069/131] (649s left) i915_hangman (engine-engine-hang)
[372.964452] Starting subtest: engine-engine-hang
[372.965371] Starting dynamic subtest: rcs0
[373.759571] Dynamic subtest rcs0: SUCCESS (0.795s)
[373.771848] Starting dynamic subtest: bcs0
[374.468399] Dynamic subtest bcs0: SUCCESS (0.707s)
[374.478447] Starting dynamic subtest: vcs0
[375.172466] Dynamic subtest vcs0: SUCCESS (0.703s)
[375.183880] Starting dynamic subtest: vcs1
[375.883461] Dynamic subtest vcs1: SUCCESS (0.710s)
[375.895151] Starting dynamic subtest: vecs0
[376.606402] Dynamic subtest vecs0: SUCCESS (0.722s)
[376.621027] Starting dynamic subtest: vecs1
[377.320337] Dynamic subtest vecs1: SUCCESS (0.713s)
[377.330258] Starting dynamic subtest: ccs0
[378.067391] Dynamic subtest ccs0: SUCCESS (0.746s)
[378.068297] Subtest engine-engine-hang: SUCCESS (5.104s)
[378.209513] [070/131] (644s left) gem_pread (snoop)
[378.292388] Subtest snoop: SKIP (0.000s)
[378.371998] [071/131] (644s left) kms_cursor_crc (cursor-onscreen-32x10)
[378.683274] Starting subtest: cursor-onscreen-32x10
[378.739250] Subtest cursor-onscreen-32x10: SKIP (0.053s)
[379.143090] [072/131] (643s left) gem_mmap_gtt (cpuset-big-copy-xy)
[379.222233] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[379.310387] [073/131] (643s left) kms_flip (flip-vs-modeset-vs-hang)
[379.508997] Starting subtest: flip-vs-modeset-vs-hang
[379.511427] Starting dynamic subtest: A-DP3
[430.516169] Dynamic subtest A-DP3: SUCCESS (51.003s)
[430.526195] Starting dynamic subtest: D-DP3
[480.490102] Dynamic subtest D-DP3: SUCCESS (49.971s)
[480.491116] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.980s)
[480.740213] [074/131] (542s left) gem_exec_params (no-vebox)
[480.825634] Starting subtest: no-vebox
[480.828066] Subtest no-vebox: SUCCESS (0.001s)
[480.966157] [075/131] (542s left) kms_psr (fbc-psr-sprite-plane-move)
[481.162037] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[481.223253] [076/131] (541s left) gem_mmap (big-bo)
[481.309292] Subtest big-bo: SKIP (0.000s)
[481.394712] [077/131] (541s left) kms_vblank (wait-forked-busy-hang)
[481.590540] Starting subtest: wait-forked-busy-hang
[481.592985] Starting dynamic subtest: pipe-A-DP-3
[508.554788] Dynamic subtest pipe-A-DP-3: SUCCESS (26.961s)
[508.567496] Starting dynamic subtest: pipe-D-DP-3
[533.552930] Dynamic subtest pipe-D-DP-3: SUCCESS (24.995s)
[533.553874] Subtest wait-forked-busy-hang: SUCCESS (51.962s)
[533.815551] [078/131] (489s left) kms_psr (psr-suspend)
[534.011262] Subtest psr-suspend: SKIP (0.000s)
[534.069796] [079/131] (489s left) gem_softpin (invalid)
[534.153812] Starting subtest: invalid
[534.165614] Subtest invalid: SUCCESS (0.012s)
[534.353621] [080/131] (489s left) kms_psr (psr-cursor-mmap-gtt)
[534.557235] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[534.620397] [081/131] (488s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[534.818955] Starting subtest: basic-flip-after-cursor-legacy
[535.827288] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.008s)
[536.085938] [082/131] (487s left) kms_pwrite_crc
[537.204137] [083/131] (486s left) gen7_exec_parse (bitmasks)
[537.289162] Subtest bitmasks: SKIP (0.000s)
[537.397762] [084/131] (486s left) gem_userptr_blits (coherency-sync)
[537.492417] Starting subtest: coherency-sync
[537.867139] Subtest coherency-sync: SKIP (0.359s)
[538.050659] [085/131] (485s left) gem_exec_reloc (basic-gtt-read-noreloc)
[538.179199] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[538.263981] [086/131] (485s left) gen9_exec_parse (bb-oversize)
[538.349217] Subtest bb-oversize: SKIP (0.000s)
[538.436783] [087/131] (485s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[538.642124] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[538.643900] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[538.777496] [088/131] (485s left) kms_async_flips (invalid-async-flip)
[538.978699] Starting subtest: invalid-async-flip
[538.980420] Subtest invalid-async-flip: SKIP (0.000s)
[539.407964] [089/131] (484s left) perf (missing-sample-flags)
[539.646725] Starting subtest: missing-sample-flags
[539.647747] Subtest missing-sample-flags: SUCCESS (0.000s)
[539.707327] [090/131] (484s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format)
[539.905510] Starting subtest: plane-downscale-factor-0-25-with-pixel-format
[539.906379] Starting dynamic subtest: pipe-A
[540.797325] Dynamic subtest pipe-A: SKIP (0.889s)
[540.807493] Starting dynamic subtest: pipe-B
[542.147057] Dynamic subtest pipe-B: SKIP (1.349s)
[542.157264] Starting dynamic subtest: pipe-C
[543.496692] Dynamic subtest pipe-C: SKIP (1.348s)
[543.507175] Starting dynamic subtest: pipe-D
[544.846817] Dynamic subtest pipe-D: SKIP (1.348s)
[544.848301] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (4.939s)
[544.976062] [091/131] (479s left) i915_pm_rpm (system-suspend)
[547.055852] Starting subtest: system-suspend
[567.175317] Subtest system-suspend: SUCCESS (5.001s)
[605.593796] [092/131] (456s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[605.803409] Starting subtest: 4-tiled-16bpp-rotate-90
[605.865901] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.061s)
[606.071060] [093/131] (456s left) gem_ctx_engines (execute-allforone)
[606.160192] Starting subtest: execute-allforone
[606.202693] Subtest execute-allforone: SUCCESS (0.042s)
[606.462617] [094/131] (455s left) gem_lmem_swapping (heavy-verify-random-ccs)
[609.623928] Starting subtest: heavy-verify-random-ccs
[609.625276] Starting dynamic subtest: lmem0
[619.934724] Dynamic subtest lmem0: SUCCESS (10.251s)
[619.935661] Subtest heavy-verify-random-ccs: SUCCESS (10.252s)
[621.794573] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[621.795706] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[621.797693] [095/131] (440s left) syncobj_timeline (transfer-timeline-point)
[623.358432] Starting subtest: transfer-timeline-point
[623.359305] Subtest transfer-timeline-point: SUCCESS (0.000s)
[623.434714] [FACT syncobj_timeline (transfer-timeline-point)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[623.438552] [FACT syncobj_timeline (transfer-timeline-point)] new: kernel.kmod_is_loaded.i915: true
[623.441611] [096/131] (439s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[623.643246] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[623.644982] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[623.794925] [097/131] (438s left) syncobj_basic (bad-create-flags)
[623.872700] Starting subtest: bad-create-flags
[623.873569] Subtest bad-create-flags: SUCCESS (0.000s)
[624.055846] [098/131] (438s left) prime_vgem (coherency-blt)
[624.156281] Starting subtest: coherency-blt
[626.449767] Subtest coherency-blt: SUCCESS (2.289s)
[626.617929] [099/131] (436s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[626.695366] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[626.696348] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[626.859729] [100/131] (435s left) kms_cursor_crc (async-cursor-crc-position-change)
[627.115376] Starting subtest: async-cursor-crc-position-change
[627.116280] Starting dynamic subtest: pipe-A-DP-3
[627.628096] Dynamic subtest pipe-A-DP-3: SUCCESS (0.511s)
[627.645663] Starting dynamic subtest: pipe-D-DP-3
[628.059377] Dynamic subtest pipe-D-DP-3: SUCCESS (0.428s)
[628.060271] Subtest async-cursor-crc-position-change: SUCCESS (0.944s)
[628.635132] [101/131] (434s left) device_reset (cold-reset-bound)
[628.721091] Starting subtest: cold-reset-bound
[628.723143] Subtest cold-reset-bound: SKIP (0.000s)
[628.851133] [102/131] (434s left) kms_frontbuffer_tracking (fbc-2p-rte)
[629.051105] Starting subtest: fbc-2p-rte
[629.052876] Subtest fbc-2p-rte: SKIP (0.000s)
[629.181044] [103/131] (433s left) gem_exec_balancer (invalid-balancer)
[629.269525] Starting subtest: invalid-balancer
[630.867150] Subtest invalid-balancer: SUCCESS (1.595s)
[631.262408] [104/131] (431s left) kms_addfb_basic (invalid-set-prop)
[631.344821] Starting subtest: invalid-set-prop
[631.345710] Subtest invalid-set-prop: SUCCESS (0.000s)
[631.629372] [105/131] (431s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[631.838372] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[632.875438] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.036s)
[633.096234] [106/131] (430s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[633.295983] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[635.617666] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (2.319s)
[635.762131] [107/131] (427s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[635.846776] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[635.848787] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[636.050973] [108/131] (427s left) gem_exec_flush (basic-wb-rw-before-default)
[636.136172] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[636.237376] [109/131] (427s left) kms_fbcon_fbt (fbc-suspend)
[636.321419] Starting subtest: fbc-suspend
[688.795820] Subtest fbc-suspend: SUCCESS (21.257s)
[702.927303] [110/131] (374s left) perf (invalid-oa-metric-set-id)
[703.295100] Starting subtest: invalid-oa-metric-set-id
[703.314622] Subtest invalid-oa-metric-set-id: SUCCESS (0.019s)
[703.371770] [111/131] (374s left) gem_mmap_offset (clear-via-pagefault)
[703.454127] Starting subtest: clear-via-pagefault
[703.455139] Starting dynamic subtest: lmem0
[728.856040] Dynamic subtest lmem0: SUCCESS (25.286s)
[728.868275] Starting dynamic subtest: smem0
[753.628201] Dynamic subtest smem0: SUCCESS (24.770s)
[753.629115] Subtest clear-via-pagefault: SUCCESS (50.058s)
[753.921523] [112/131] (323s left) kms_dp_linktrain_fallback (dp-fallback)
[754.124585] Starting subtest: dp-fallback
[763.325809] Subtest dp-fallback: SUCCESS (9.198s)
[763.737377] [113/131] (313s left) gem_eio (in-flight-external)
[764.028596] Starting subtest: in-flight-external
[765.230834] Subtest in-flight-external: SUCCESS (1.202s)
[765.462908] [114/131] (312s left) gem_userptr_blits (unsync-overlap)
[765.554761] Subtest unsync-overlap: SKIP (0.000s)
[765.754655] [115/131] (312s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[765.835144] Starting subtest: etime-multi-wait-all-available-unsubmitted
[765.942766] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.107s)
[766.066942] [116/131] (311s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[766.266221] Starting subtest: primary-yf-tiled-reflect-x-0
[766.367974] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.099s)
[766.590864] [117/131] (311s left) gem_softpin (evict-single-offset)
[766.675532] Starting subtest: evict-single-offset
[800.445533] Subtest evict-single-offset: SUCCESS (33.758s)
[800.548380] [118/131] (277s left) kms_lease (master-vs-lease)
[800.779165] Starting subtest: master-vs-lease
[800.781931] Subtest master-vs-lease: SUCCESS (0.002s)
[800.910890] [119/131] (277s left) kms_psr (pr-sprite-plane-move)
[801.115886] Subtest pr-sprite-plane-move: SKIP (0.000s)
[801.174899] [120/131] (277s left) kms_big_fb (linear-8bpp-rotate-0)
[801.409282] Starting subtest: linear-8bpp-rotate-0
[803.028043] Subtest linear-8bpp-rotate-0: SUCCESS (1.618s)
[803.261330] [121/131] (275s left) gem_exec_flush (basic-uc-pro-default)
[803.346138] Subtest basic-uc-pro-default: SKIP (0.000s)
[803.452138] [122/131] (274s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[803.651942] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[803.653684] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[803.817309] [123/131] (274s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[804.016004] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[804.074607] [124/131] (274s left) gem_ctx_persistence (heartbeat-hang)
[804.161938] Starting subtest: heartbeat-hang
[804.163959] Subtest heartbeat-hang: SKIP (0.000s)
[804.340486] [125/131] (274s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[804.540076] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[804.541823] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[804.695254] [126/131] (273s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[804.895939] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[804.897748] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[805.056509] [127/131] (273s left) perf_pmu (busy-idle)
[805.129118] Starting subtest: busy-idle
[805.129989] Starting dynamic subtest: rcs0
[805.869961] Dynamic subtest rcs0: SUCCESS (0.741s)
[805.892076] Starting dynamic subtest: bcs0
[806.540073] Dynamic subtest bcs0: SUCCESS (0.665s)
[806.557525] Starting dynamic subtest: vcs0
[807.210895] Dynamic subtest vcs0: SUCCESS (0.666s)
[807.234072] Starting dynamic subtest: vcs1
[807.879659] Dynamic subtest vcs1: SUCCESS (0.664s)
[807.902273] Starting dynamic subtest: vecs0
[808.551780] Dynamic subtest vecs0: SUCCESS (0.667s)
[808.574215] Starting dynamic subtest: vecs1
[809.222731] Dynamic subtest vecs1: SUCCESS (0.666s)
[809.245197] Starting dynamic subtest: ccs0
[809.891684] Dynamic subtest ccs0: SUCCESS (0.664s)
[809.898318] Subtest busy-idle: SUCCESS (4.767s)
[810.083467] [128/131] (268s left) syncobj_wait (reset-multiple-signaled)
[810.181338] Starting subtest: reset-multiple-signaled
[810.182224] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[810.328245] [129/131] (268s left) kms_setmode (clone-exclusive-crtc)
[810.408477] Starting subtest: clone-exclusive-crtc
[810.411503] Subtest clone-exclusive-crtc: SKIP (0.000s)
[810.557764] [130/131] (268s left) gem_exec_schedule (u-lateslice)
[810.647206] Starting subtest: u-lateslice
[810.648095] Starting dynamic subtest: rcs0
[810.694924] Dynamic subtest rcs0: SUCCESS (0.047s)
[810.709743] Starting dynamic subtest: bcs0
[810.714935] Dynamic subtest bcs0: SUCCESS (0.019s)
[810.728925] Starting dynamic subtest: vcs0
[810.739482] Dynamic subtest vcs0: SUCCESS (0.023s)
[810.752981] Starting dynamic subtest: vcs1
[810.760304] Dynamic subtest vcs1: SUCCESS (0.020s)
[810.775289] Starting dynamic subtest: vecs0
[810.781856] Dynamic subtest vecs0: SUCCESS (0.020s)
[810.795659] Starting dynamic subtest: vecs1
[810.805307] Dynamic subtest vecs1: SUCCESS (0.023s)
[810.820298] Starting dynamic subtest: ccs0
[810.826256] Dynamic subtest ccs0: SUCCESS (0.020s)
[810.827111] Subtest u-lateslice: SUCCESS (0.180s)
[811.251211] [131/131] (267s left) syncobj_wait (wait-all-for-submit-complex)
[811.335184] Starting subtest: wait-all-for-submit-complex
[811.553419] Subtest wait-all-for-submit-complex: SUCCESS (0.218s)
[811.693492] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_eio
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: gem_mmap_wc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: kms_addfb_basic
results: parsing output: 18/ for test: prime_mmap
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: prime_mmap
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_color
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_pxp
results: parsing output: 30/ for test: gem_spin_batch
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_pipe_crc_basic
results: parsing output: 33/ for test: kms_sequence
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: gem_ccs
results: parsing output: 44/ for test: kms_pipe_crc_basic
results: parsing output: 45/ for test: kms_hdr
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: i915_hangman
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_plane_multiple
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: fbdev
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: api_intel_allocator
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_busy
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_chamelium_color
results: parsing output: 66/ for test: kms_prime
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: i915_hangman
results: parsing output: 69/ for test: gem_pread
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: gem_mmap
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_pwrite_crc
results: parsing output: 82/ for test: gen7_exec_parse
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: gen9_exec_parse
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: i915_pm_rpm
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_ctx_engines
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_basic
results: parsing output: 97/ for test: prime_vgem
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: device_reset
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: kms_fbcon_fbt
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: gem_mmap_offset
results: parsing output: 111/ for test: kms_dp_linktrain_fallback
results: parsing output: 112/ for test: gem_eio
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_flush
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_setmode
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: syncobj_wait
Done.