[43.879626] Initializing watchdogs
[43.879680]   /dev/watchdog0
[43.886098] [001/130] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[43.996573] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[43.998009] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[44.118755] [002/130] (960s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[44.225893] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[44.226674] Starting dynamic subtest: pipe-A-HDMI-A-2
[44.233503] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[44.238478] Starting dynamic subtest: pipe-B-HDMI-A-2
[44.245233] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[44.246512] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.001s)
[44.422449] [003/130] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[44.520383] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[44.521727] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[44.643683] [004/130] (959s left) i915_query (query-regions-sanity-check)
[44.688234] Starting subtest: query-regions-sanity-check
[44.701275] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[44.832933] [005/130] (959s left) gem_exec_schedule (thriceslice)
[44.890918] Starting subtest: thriceslice
[44.891652] Starting dynamic subtest: rcs0
[44.895186] Dynamic subtest rcs0: SUCCESS (0.004s)
[44.899859] Starting dynamic subtest: bcs0
[44.900528] Dynamic subtest bcs0: SUCCESS (0.004s)
[44.905136] Starting dynamic subtest: vcs0
[44.905818] Dynamic subtest vcs0: SUCCESS (0.003s)
[44.909997] Starting dynamic subtest: vecs0
[44.910812] Dynamic subtest vecs0: SUCCESS (0.004s)
[44.911462] Subtest thriceslice: SUCCESS (0.015s)
[45.202439] [006/130] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[45.307382] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[45.308697] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[45.397740] [007/130] (959s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[45.505579] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[45.507059] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.001s)
[45.611162] [008/130] (958s left) gem_mmap_gtt (basic-small-bo-tiledy)
[45.656884] Starting subtest: basic-small-bo-tiledY
[45.891156] Subtest basic-small-bo-tiledY: SUCCESS (0.235s)
[46.015944] [009/130] (958s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[46.151981] Starting subtest: primary-y-tiled-reflect-x-180
[55.850656] Subtest primary-y-tiled-reflect-x-180: SUCCESS (9.698s)
[56.073340] [010/130] (948s left) kms_prime (basic-crc-vgem)
[58.448295] Starting subtest: basic-crc-vgem
[58.448951] Starting dynamic subtest: second-to-first
[59.622375] Dynamic subtest second-to-first: SUCCESS (1.211s)
[59.623531] Subtest basic-crc-vgem: SUCCESS (1.211s)
[59.719556] [011/130] (944s left) gem_wait (busy)
[59.775907] Starting subtest: busy
[59.776773] Starting dynamic subtest: all-engines
[60.329339] Dynamic subtest all-engines: SUCCESS (0.568s)
[60.337836] Starting dynamic subtest: rcs0
[60.853790] Dynamic subtest rcs0: SUCCESS (0.538s)
[60.859381] Starting dynamic subtest: bcs0
[61.374805] Dynamic subtest bcs0: SUCCESS (0.533s)
[61.380282] Starting dynamic subtest: vcs0
[61.896821] Dynamic subtest vcs0: SUCCESS (0.533s)
[61.902760] Starting dynamic subtest: vecs0
[62.416742] Dynamic subtest vecs0: SUCCESS (0.530s)
[62.417418] Subtest busy: SUCCESS (2.703s)
[62.632458] [012/130] (941s left) gem_ctx_param (invalid-set-no-zeromap)
[62.677285] Starting subtest: invalid-set-no-zeromap
[62.677989] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[62.741554] [013/130] (941s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[62.848187] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[65.370100] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.562s)
[65.544833] [014/130] (938s left) gem_ctx_persistence (legacy-engines-persistence)
[65.589999] Starting subtest: legacy-engines-persistence
[65.590698] Starting dynamic subtest: render
[66.368340] Dynamic subtest render: SUCCESS (0.787s)
[66.376333] Starting dynamic subtest: bsd
[67.206504] Dynamic subtest bsd: SUCCESS (0.846s)
[67.214217] Starting dynamic subtest: blt
[68.041337] Dynamic subtest blt: SUCCESS (0.842s)
[68.049084] Starting dynamic subtest: vebox
[68.877260] Dynamic subtest vebox: SUCCESS (0.842s)
[68.878347] Subtest legacy-engines-persistence: SUCCESS (3.321s)
[68.954384] [015/130] (935s left) perf_pmu (semaphore-wait-idle)
[68.997379] Starting subtest: semaphore-wait-idle
[68.998089] Starting dynamic subtest: rcs0
[69.506421] Dynamic subtest rcs0: SUCCESS (0.512s)
[69.513805] Starting dynamic subtest: bcs0
[70.016389] Dynamic subtest bcs0: SUCCESS (0.513s)
[70.023972] Starting dynamic subtest: vcs0
[70.526460] Dynamic subtest vcs0: SUCCESS (0.513s)
[70.535831] Starting dynamic subtest: vecs0
[71.036589] Dynamic subtest vecs0: SUCCESS (0.513s)
[71.037818] Subtest semaphore-wait-idle: SUCCESS (2.053s)
[71.168416] [016/130] (933s left) perf_pmu (render-node-busy)
[71.209431] Starting subtest: render-node-busy
[71.210166] Starting dynamic subtest: rcs0
[71.792421] Dynamic subtest rcs0: SUCCESS (0.586s)
[71.801581] Starting dynamic subtest: bcs0
[72.328322] Dynamic subtest bcs0: SUCCESS (0.539s)
[72.338301] Starting dynamic subtest: vcs0
[72.858401] Dynamic subtest vcs0: SUCCESS (0.532s)
[72.868521] Starting dynamic subtest: vecs0
[73.409340] Dynamic subtest vecs0: SUCCESS (0.553s)
[73.410681] Subtest render-node-busy: SUCCESS (2.211s)
[73.481143] [017/130] (931s left) syncobj_eventfd (invalid-illegal-handle)
[73.522438] Starting subtest: invalid-illegal-handle
[73.523163] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[73.607279] [018/130] (930s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[73.646437] Starting subtest: etime-single-wait-for-submit-unsubmitted
[73.754484] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.109s)
[73.837183] [019/130] (930s left) gem_pxp (reject-modify-context-protection-off-2)
[194.812758] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[196.171509] Closing watchdogs
[196.175731] Initializing watchdogs
[196.175784]   /dev/watchdog0
[196.182034] [020/130] (808s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[196.285315] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[196.286635] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[196.410926] [021/130] (808s left) gem_busy (busy)
[196.454555] Starting subtest: busy
[196.455260] Starting dynamic subtest: all-engines
[196.495727] Dynamic subtest all-engines: SUCCESS (0.041s)
[196.500963] Starting dynamic subtest: rcs0
[196.561806] Dynamic subtest rcs0: SUCCESS (0.065s)
[196.579078] Starting dynamic subtest: bcs0
[196.636874] Dynamic subtest bcs0: SUCCESS (0.075s)
[196.655044] Starting dynamic subtest: vcs0
[196.664407] Dynamic subtest vcs0: SUCCESS (0.027s)
[196.675746] Starting dynamic subtest: vecs0
[196.687296] Dynamic subtest vecs0: SUCCESS (0.022s)
[196.688296] Subtest busy: SUCCESS (0.232s)
[197.078260] [022/130] (807s left) kms_vrr (seamless-rr-switch-vrr)
[197.174786] Starting subtest: seamless-rr-switch-vrr
[197.176746] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[197.249167] [023/130] (807s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[197.356222] Starting subtest: 2x-long-flip-vs-cursor-legacy
[197.358704] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[197.445959] [024/130] (807s left) perf_pmu (interrupts-sync)
[197.484611] Starting subtest: interrupts-sync
[198.585643] Subtest interrupts-sync: SUCCESS (1.100s)
[198.690717] [025/130] (805s left) kms_display_modes (mst-extended-mode-negative)
[198.792878] Starting subtest: mst-extended-mode-negative
[198.794236] Subtest mst-extended-mode-negative: SKIP (0.000s)
[198.823678] [026/130] (805s left) kms_sequence (get-busy)
[198.920787] Starting subtest: get-busy
[198.921458] Starting dynamic subtest: pipe-A-HDMI-A-2
[201.686729] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.765s)
[201.693578] Starting dynamic subtest: pipe-B-HDMI-A-2
[204.370828] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.683s)
[204.371569] Subtest get-busy: SUCCESS (5.449s)
[204.471013] [027/130] (800s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[204.574905] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[204.575624] Starting dynamic subtest: pipe-A-valid-mode
[205.428039] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.852s)
[205.429051] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.853s)
[205.604867] [028/130] (799s left) gem_exec_whisper (basic-queues-priority-all)
[205.650782] Starting subtest: basic-queues-priority-all
[208.507835] Subtest basic-queues-priority-all: SUCCESS (2.856s)
[208.691959] [029/130] (796s left) kms_atomic (plane-overlay-legacy)
[208.793947] Starting subtest: plane-overlay-legacy
[208.795471] Starting dynamic subtest: pipe-A-HDMI-A-2
[209.071892] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.276s)
[209.072860] Subtest plane-overlay-legacy: SUCCESS (0.278s)
[209.227832] [030/130] (795s left) gem_lmem_swapping (random)
[209.266787] Subtest random: SKIP (0.000s)
[209.287839] [031/130] (795s left) syncobj_timeline (invalid-signal-illegal-point)
[209.322549] Starting subtest: invalid-signal-illegal-point
[209.323238] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[209.407272] [032/130] (795s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[209.515233] Starting subtest: 4-tiled-8bpp-rotate-180
[209.516549] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[209.635212] [033/130] (795s left) gem_linear_blits (interruptible)
[209.781359] Starting subtest: interruptible
[212.840067] Subtest interruptible: SUCCESS (3.058s)
[212.970224] [034/130] (791s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[213.096398] Starting subtest: psr-2p-primscrn-cur-indfb-move
[213.097725] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[213.219193] [035/130] (791s left) syncobj_timeline (single-wait-all-signaled)
[213.261850] Starting subtest: single-wait-all-signaled
[213.262524] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[213.351960] [036/130] (791s left) drm_read (empty-block)
[213.488644] Starting subtest: empty-block
[214.490465] Subtest empty-block: SUCCESS (1.001s)
[214.654114] [037/130] (790s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[214.763548] Starting subtest: x-tiled-8bpp-rotate-0
[216.164514] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.401s)
[216.335081] [038/130] (788s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[216.445465] Starting subtest: cursor-rapid-movement-512x170
[216.446833] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[216.578042] [039/130] (788s left) gem_exec_reloc (basic-wc-gtt-active)
[216.617629] Subtest basic-wc-gtt-active: SKIP (0.000s)
[216.718249] [040/130] (788s left) gem_softpin (evict-active)
[216.762396] Starting subtest: evict-active
[216.770903] Subtest evict-active: SUCCESS (0.008s)
[216.939794] [041/130] (788s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[217.039368] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[217.040686] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[217.166453] [042/130] (787s left) kms_pipe_crc_basic (suspend-read-crc)
[217.262889] Starting subtest: suspend-read-crc
[217.263568] Starting dynamic subtest: pipe-A-HDMI-A-2
[238.925429] Dynamic subtest pipe-A-HDMI-A-2: FAIL (21.437s)
[238.942718] Starting dynamic subtest: pipe-B-HDMI-A-2
[256.946828] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (18.243s)
[256.947552] Subtest suspend-read-crc: FAIL (39.682s)
[263.063932] [043/130] (748s left) gem_madvise (dontneed-before-pwrite)
[263.102443] Starting subtest: dontneed-before-pwrite
[263.104424] Subtest dontneed-before-pwrite: SKIP (0.001s)
[263.154972] [044/130] (747s left) gem_exec_reloc (basic-concurrent0)
[263.193366] Subtest basic-concurrent0: SKIP (0.000s)
[263.272480] [045/130] (747s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[263.380838] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[263.381502] Starting dynamic subtest: pipe-A-HDMI-A-2
[263.388665] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[263.395097] Starting dynamic subtest: pipe-B-HDMI-A-2
[263.402172] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[263.403449] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.001s)
[263.597729] [046/130] (747s left) perf_pmu (interrupts)
[263.636879] Starting subtest: interrupts
[264.721297] Subtest interrupts: SUCCESS (1.084s)
[264.835735] [047/130] (746s left) gem_exec_fence (long-history)
[265.167466] Starting subtest: long-history
[271.031477] Subtest long-history: SUCCESS (5.863s)
[271.431320] [048/130] (739s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt)
[271.535497] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt
[271.536832] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[271.663757] [049/130] (739s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[271.761854] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[271.762539] Starting dynamic subtest: pipe-A
[271.855214] Dynamic subtest pipe-A: SUCCESS (0.093s)
[271.872889] Starting dynamic subtest: pipe-B
[271.990952] Dynamic subtest pipe-B: SUCCESS (0.135s)
[271.992397] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.229s)
[272.181797] [050/130] (739s left) kms_draw_crc (draw-method-mmap-gtt)
[272.280937] Starting subtest: draw-method-mmap-gtt
[272.281713] Starting dynamic subtest: xrgb8888-untiled
[272.601890] Dynamic subtest xrgb8888-untiled: SUCCESS (0.321s)
[272.621713] Starting dynamic subtest: rgb565-untiled
[272.943406] Dynamic subtest rgb565-untiled: SUCCESS (0.341s)
[272.963104] Starting dynamic subtest: xrgb2101010-untiled
[273.247097] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.303s)
[273.266108] Starting dynamic subtest: xrgb8888-xtiled
[273.417779] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.170s)
[273.437624] Starting dynamic subtest: rgb565-xtiled
[273.569528] Dynamic subtest rgb565-xtiled: SUCCESS (0.151s)
[273.589367] Starting dynamic subtest: xrgb2101010-xtiled
[273.721785] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.151s)
[273.741675] Starting dynamic subtest: xrgb8888-ytiled
[273.892152] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.169s)
[273.912076] Starting dynamic subtest: rgb565-ytiled
[274.063148] Dynamic subtest rgb565-ytiled: SUCCESS (0.170s)
[274.077976] Starting dynamic subtest: xrgb2101010-ytiled
[274.195806] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.131s)
[274.197154] Subtest draw-method-mmap-gtt: SUCCESS (1.916s)
[274.345636] [051/130] (736s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[274.442751] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[274.444102] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[274.563881] [052/130] (736s left) syncobj_wait (single-wait-all-for-submit-submitted)
[274.603910] Starting subtest: single-wait-all-for-submit-submitted
[274.707110] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[274.801521] [053/130] (736s left) gem_mmap_wc (bad-object)
[274.838090] Starting subtest: bad-object
[274.838798] Subtest bad-object: SUCCESS (0.000s)
[274.962280] [054/130] (736s left) kms_psr (fbc-pr-sprite-render)
[275.060719] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[275.077172] [055/130] (736s left) kms_hdr (static-toggle-suspend)
[275.173970] Starting subtest: static-toggle-suspend
[275.176036] Subtest static-toggle-suspend: SKIP (0.000s)
[275.255601] [056/130] (736s left) gen9_exec_parse (cmd-crossing-page)
[275.297415] Subtest cmd-crossing-page: SKIP (0.000s)
[275.324791] [057/130] (736s left) perf (invalid-remove-userspace-config)
[275.445899] Starting subtest: invalid-remove-userspace-config
[275.456490] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[275.479731] [058/130] (735s left) syncobj_wait (signal)
[275.516075] Starting subtest: signal
[275.516785] Subtest signal: SUCCESS (0.000s)
[275.597955] [059/130] (735s left) fbdev (pan)
[275.634136] Starting subtest: pan
[275.675834] Subtest pan: SUCCESS (0.041s)
[275.768433] [060/130] (735s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[275.866848] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[277.916932] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (2.051s)
[278.093748] [061/130] (733s left) kms_psr (psr2-cursor-plane-move)
[278.189595] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[278.207603] [062/130] (733s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[278.303736] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[278.322335] [063/130] (733s left) gem_exec_reloc (basic-wc-cpu)
[278.360174] Subtest basic-wc-cpu: SKIP (0.000s)
[278.470301] [064/130] (733s left) gem_tiled_fence_blits (normal)
[278.585238] Starting subtest: normal
[285.760876] Subtest normal: SUCCESS (7.176s)
[285.881494] [065/130] (725s left) gem_pxp (verify-pxp-stale-ctx-execution)
[301.042793] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[301.100607] [066/130] (710s left) gem_exec_balancer (fairslice)
[301.145884] Starting subtest: fairslice
[302.188946] Subtest fairslice: SUCCESS (1.043s)
[303.419587] [067/130] (708s left) gem_render_copy (y-tiled-to-vebox-linear)
[303.463031] Starting subtest: y-tiled-to-vebox-linear
[303.463741] Starting dynamic subtest: smem
[303.530579] Dynamic subtest smem: SUCCESS (0.067s)
[303.531286] Subtest y-tiled-to-vebox-linear: SUCCESS (0.068s)
[303.725997] [068/130] (707s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[303.771333] Starting subtest: multi-wait-all-for-submit-signaled
[303.772076] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[303.839812] [069/130] (707s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[303.873468] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[303.874966] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[303.964360] [070/130] (707s left) gem_exec_fence (syncobj-channel)
[304.298593] Starting subtest: syncobj-channel
[305.320396] Subtest syncobj-channel: SUCCESS (1.021s)
[305.648978] [071/130] (706s left) kms_big_fb (y-tiled-addfb)
[305.758986] Starting subtest: y-tiled-addfb
[305.759779] Subtest y-tiled-addfb: SUCCESS (0.000s)
[305.872046] [072/130] (705s left) kms_chamelium_hpd (vga-hpd-fast)
[306.029833] Subtest vga-hpd-fast: SKIP (0.000s)
[306.084838] [073/130] (705s left) gem_exec_schedule (preempt)
[306.136302] Starting subtest: preempt
[306.136998] Starting dynamic subtest: rcs0
[306.151645] Dynamic subtest rcs0: SUCCESS (0.015s)
[306.158345] Starting dynamic subtest: bcs0
[306.165743] Dynamic subtest bcs0: SUCCESS (0.014s)
[306.172268] Starting dynamic subtest: vcs0
[306.179353] Dynamic subtest vcs0: SUCCESS (0.013s)
[306.186031] Starting dynamic subtest: vecs0
[306.193903] Dynamic subtest vecs0: SUCCESS (0.014s)
[306.194604] Subtest preempt: SUCCESS (0.058s)
[306.519433] [074/130] (705s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[306.623044] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[306.624368] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[306.735863] [075/130] (705s left) kms_scaling_modes (scaling-mode-full)
[306.836099] Starting subtest: scaling-mode-full
[306.837557] Subtest scaling-mode-full: SKIP (0.000s)
[306.924770] [076/130] (704s left) dmabuf_sync_file (export-basic)
[306.965785] Starting subtest: export-basic
[306.967298] Subtest export-basic: SUCCESS (0.002s)
[307.033886] [077/130] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[307.135676] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[307.136986] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[307.268079] [078/130] (704s left) gem_exec_alignment (pi-isolated)
[307.306846] Starting subtest: pi-isolated
[365.181643] Subtest pi-isolated: SUCCESS (57.872s)
[365.310834] [079/130] (646s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[365.428998] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[365.429689] Starting dynamic subtest: pipe-A-valid-mode
[366.255712] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.825s)
[366.256383] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.826s)
[366.413801] [080/130] (645s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[366.514512] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[366.515837] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[366.642741] [081/130] (645s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[366.738046] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[366.738751] Starting dynamic subtest: pipe-A-HDMI-A-2
[366.741316] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[366.747862] Starting dynamic subtest: pipe-B-HDMI-A-2
[366.750443] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[366.751763] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s)
[366.952203] [082/130] (645s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[367.045083] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[367.046753] Starting dynamic subtest: pipe-A-HDMI-A-2
[367.053191] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[367.059838] Starting dynamic subtest: pipe-B-HDMI-A-2
[367.066272] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[367.067575] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[367.262606] [083/130] (644s left) kms_color (ctm-max)
[367.361109] Starting subtest: ctm-max
[367.361847] Starting dynamic subtest: pipe-A-HDMI-A-2
[367.880325] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.517s)
[367.890475] Starting dynamic subtest: pipe-B-HDMI-A-2
[368.329031] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.449s)
[368.329796] Subtest ctm-max: SUCCESS (0.967s)
[368.502332] [084/130] (643s left) kms_busy (extended-pageflip-hang-newfb)
[368.601078] Starting subtest: extended-pageflip-hang-newfb
[368.602856] Starting dynamic subtest: pipe-A
[394.920962] Dynamic subtest pipe-A: SUCCESS (26.318s)
[394.928372] Starting dynamic subtest: pipe-B
[408.713646] Dynamic subtest pipe-B: SUCCESS (13.791s)
[408.714341] Subtest extended-pageflip-hang-newfb: SUCCESS (40.111s)
[408.920184] [085/130] (603s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[409.019677] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[409.020969] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[409.110211] [086/130] (602s left) i915_pm_rpm (system-suspend)
[410.531263] Starting subtest: system-suspend
[427.579502] Subtest system-suspend: SUCCESS (17.048s)
[430.755244] [087/130] (584s left) kms_content_protection (srm)
[430.870432] Starting subtest: srm
[431.006290] Subtest srm: SKIP (0.133s)
[431.190744] [088/130] (583s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[431.285179] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[431.286791] Starting dynamic subtest: pipe-A-HDMI-A-2
[431.293376] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[431.300145] Starting dynamic subtest: pipe-B-HDMI-A-2
[431.306777] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[431.308105] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[431.500973] [089/130] (583s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[431.602526] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[431.633191] [090/130] (583s left) api_intel_bb (blit-noreloc-keep-cache)
[431.671145] Starting subtest: blit-noreloc-keep-cache
[431.675543] Subtest blit-noreloc-keep-cache: SUCCESS (0.005s)
[431.825028] [091/130] (583s left) kms_pm_rpm (fences)
[433.230782] Starting subtest: fences
[436.169408] Subtest fences: SUCCESS (2.939s)
[436.284614] [092/130] (578s left) kms_chamelium_frames (hdmi-crc-multiple)
[436.428550] Subtest hdmi-crc-multiple: SKIP (0.000s)
[436.508389] [093/130] (578s left) kms_flip (2x-flip-vs-wf_vblank)
[436.623575] Starting subtest: 2x-flip-vs-wf_vblank
[436.625916] Subtest 2x-flip-vs-wf_vblank: SKIP (0.001s)
[436.754941] [094/130] (578s left) i915_pm_rc6_residency (rc6-accuracy)
[436.792720] Starting subtest: rc6-accuracy
[436.793370] Starting dynamic subtest: gt0
[439.997993] Dynamic subtest gt0: FAIL (3.191s)
[439.999023] Subtest rc6-accuracy: FAIL (3.192s)
[440.065711] [095/130] (575s left) sw_sync (sync_merge_same)
[440.108027] Starting subtest: sync_merge_same
[440.108723] Subtest sync_merge_same: SUCCESS (0.000s)
[440.161226] [096/130] (575s left) kms_plane (pixel-format)
[440.261157] Starting subtest: pixel-format
[440.304484] Starting dynamic subtest: pipe-A-plane-0
[447.551894] Dynamic subtest pipe-A-plane-0: SUCCESS (7.247s)
[447.565100] Starting dynamic subtest: pipe-A-plane-3
[451.593401] Dynamic subtest pipe-A-plane-3: SUCCESS (4.039s)
[451.606267] Starting dynamic subtest: pipe-A-plane-5
[451.840055] Dynamic subtest pipe-A-plane-5: SUCCESS (0.244s)
[452.001222] Starting dynamic subtest: pipe-B-plane-0
[459.021247] Dynamic subtest pipe-B-plane-0: SUCCESS (7.038s)
[459.038570] Starting dynamic subtest: pipe-B-plane-3
[463.081369] Dynamic subtest pipe-B-plane-3: SUCCESS (4.057s)
[463.102929] Starting dynamic subtest: pipe-B-plane-5
[463.328120] Dynamic subtest pipe-B-plane-5: SUCCESS (0.245s)
[463.367811] Subtest pixel-format: SUCCESS (23.106s)
[463.521911] [097/130] (551s left) gem_exec_flush (basic-wb-rw-before-default)
[463.566451] Starting subtest: basic-wb-rw-before-default
[469.022719] Subtest basic-wb-rw-before-default: SUCCESS (5.456s)
[469.243572] [098/130] (546s left) gem_ctx_engines (independent)
[469.312480] Starting subtest: independent
[469.313174] Starting dynamic subtest: rcs0
[469.365106] Dynamic subtest rcs0: SUCCESS (0.052s)
[469.372099] Starting dynamic subtest: bcs0
[469.416909] Dynamic subtest bcs0: SUCCESS (0.051s)
[469.423938] Starting dynamic subtest: vcs0
[469.469074] Dynamic subtest vcs0: SUCCESS (0.051s)
[469.477121] Starting dynamic subtest: vecs0
[469.522944] Dynamic subtest vecs0: SUCCESS (0.053s)
[469.529810] Starting dynamic subtest: all-engines
[469.620735] Dynamic subtest all-engines: SUCCESS (0.097s)
[469.621427] Subtest independent: SUCCESS (0.308s)
[469.810424] [099/130] (545s left) api_intel_bb (render)
[469.850413] Starting subtest: render
[469.851088] Starting dynamic subtest: render-none-512
[469.927383] Dynamic subtest render-none-512: SUCCESS (0.077s)
[469.934231] Starting dynamic subtest: render-none-1024
[470.241920] Dynamic subtest render-none-1024: SUCCESS (0.314s)
[470.248724] Starting dynamic subtest: render-x-512
[470.309755] Dynamic subtest render-x-512: SUCCESS (0.067s)
[470.316472] Starting dynamic subtest: render-x-1024
[470.597483] Dynamic subtest render-x-1024: SUCCESS (0.287s)
[470.604272] Starting dynamic subtest: render-y-512
[470.666168] Dynamic subtest render-y-512: SUCCESS (0.068s)
[470.672937] Starting dynamic subtest: render-y-1024
[470.953896] Dynamic subtest render-y-1024: SUCCESS (0.287s)
[470.954602] Subtest render: SUCCESS (1.104s)
[471.084783] [100/130] (544s left) gem_tiled_fence_blits (basic)
[471.211971] Starting subtest: basic
[471.239591] Subtest basic: SUCCESS (0.028s)
[471.401803] [101/130] (544s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[471.537737] Starting subtest: cursorB-vs-flipB-legacy
[471.540200] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[471.624197] [102/130] (543s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[471.724309] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[471.725059] Starting dynamic subtest: pipe-A
[472.158491] Dynamic subtest pipe-A: SKIP (0.432s)
[472.165928] Starting dynamic subtest: pipe-B
[472.764643] Dynamic subtest pipe-B: SKIP (0.606s)
[472.765960] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (1.039s)
[472.872455] [103/130] (542s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[472.975857] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[473.389944] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.414s)
[473.556357] [104/130] (542s left) gem_lmem_swapping (verify-random)
[473.595848] Subtest verify-random: SKIP (0.000s)
[473.641036] [105/130] (541s left) gem_spin_batch (engines)
[473.684191] Starting subtest: engines
[473.684890] Starting dynamic subtest: rcs0
[477.000838] Dynamic subtest rcs0: SUCCESS (3.314s)
[477.013218] Starting dynamic subtest: bcs0
[480.318161] Dynamic subtest bcs0: SUCCESS (3.314s)
[480.327502] Starting dynamic subtest: vcs0
[483.636156] Dynamic subtest vcs0: SUCCESS (3.315s)
[483.645646] Starting dynamic subtest: vecs0
[486.953516] Dynamic subtest vecs0: SUCCESS (3.314s)
[486.954659] Subtest engines: SUCCESS (13.268s)
[487.129360] [106/130] (528s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[487.170704] Starting subtest: invalid-bsd1-flag-on-blt
[487.171377] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[487.281322] [107/130] (528s left) kms_psr (fbc-psr-sprite-blt)
[487.376575] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[487.403376] [108/130] (528s left) kms_lease (master-vs-lease)
[487.498842] Starting subtest: master-vs-lease
[487.501301] Subtest master-vs-lease: SUCCESS (0.002s)
[487.581468] [109/130] (528s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[487.682265] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[487.683588] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[487.810618] [110/130] (527s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[487.848029] Starting subtest: tiled-to-tiled
[487.849361] Subtest tiled-to-tiled: SKIP (0.000s)
[487.991085] [111/130] (527s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[488.089265] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[488.091391] Starting dynamic subtest: pipe-A-valid-mode
[488.711023] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.621s)
[488.711700] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.622s)
[488.896309] [112/130] (526s left) kms_psr (psr2-primary-page-flip)
[488.991451] Subtest psr2-primary-page-flip: SKIP (0.000s)
[489.031662] [113/130] (526s left) gem_ctx_bad_destroy (invalid-default-ctx)
[489.065780] Starting subtest: invalid-default-ctx
[489.066463] Subtest invalid-default-ctx: SUCCESS (0.000s)
[489.145054] [114/130] (526s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[489.250020] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[489.251323] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[489.391480] [115/130] (526s left) kms_flip (plain-flip-ts-check)
[489.487408] Starting subtest: plain-flip-ts-check
[489.489125] Starting dynamic subtest: A-HDMI-A2
[504.995930] Dynamic subtest A-HDMI-A2: SUCCESS (15.506s)
[505.006639] Starting dynamic subtest: B-HDMI-A2
[520.461718] Dynamic subtest B-HDMI-A2: SUCCESS (15.462s)
[520.465323] Subtest plain-flip-ts-check: SUCCESS (30.976s)
[520.615924] [116/130] (495s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[520.714764] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[520.716088] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[520.845222] [117/130] (495s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[520.945911] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[520.968236] [118/130] (494s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[521.066653] Starting subtest: psr-rgb101010-draw-blt
[521.067943] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[521.185870] [119/130] (494s left) kms_cursor_crc (cursor-random-max-size)
[521.287350] Starting subtest: cursor-random-max-size
[521.289316] Subtest cursor-random-max-size: SKIP (0.000s)
[521.394825] [120/130] (494s left) gem_mmap_wc (fault-concurrent)
[521.432482] Starting subtest: fault-concurrent
[521.508200] Subtest fault-concurrent: SUCCESS (0.076s)
[521.621989] [121/130] (494s left) gem_ctx_param (invalid-ctx-get)
[521.659478] Starting subtest: invalid-ctx-get
[521.660164] Subtest invalid-ctx-get: SUCCESS (0.000s)
[521.747854] [122/130] (494s left) vgem_basic (bad-handle)
[521.795062] Starting subtest: bad-handle
[521.795761] Subtest bad-handle: SUCCESS (0.000s)
[521.869220] [123/130] (494s left) kms_flip (2x-flip-vs-modeset)
[521.965391] Starting subtest: 2x-flip-vs-modeset
[521.966737] Subtest 2x-flip-vs-modeset: SKIP (0.001s)
[522.096740] [124/130] (494s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[522.192523] Starting subtest: flip-vs-cursor-crc-atomic
[522.712852] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.519s)
[522.877644] [125/130] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[522.977471] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[522.978890] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[523.105294] [126/130] (493s left) kms_vblank (wait-busy-hang)
[523.203428] Starting subtest: wait-busy-hang
[523.205269] Starting dynamic subtest: pipe-A-HDMI-A-2
[537.720140] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (14.514s)
[537.728595] Starting dynamic subtest: pipe-B-HDMI-A-2
[551.524265] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (13.802s)
[551.525021] Subtest wait-busy-hang: SUCCESS (28.320s)
[551.708897] [127/130] (464s left) perf (gen8-unprivileged-single-ctx-counters)
[551.833764] Starting subtest: gen8-unprivileged-single-ctx-counters
[551.835107] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[551.871357] [128/130] (464s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[551.972053] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[551.973374] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[552.097431] [129/130] (464s left) kms_flip (dpms-off-confusion-interruptible)
[552.206779] Starting subtest: dpms-off-confusion-interruptible
[552.208481] Starting dynamic subtest: A-HDMI-A2
[567.383092] Dynamic subtest A-HDMI-A2: SUCCESS (15.174s)
[567.396696] Starting dynamic subtest: B-HDMI-A2
[582.505987] Dynamic subtest B-HDMI-A2: SUCCESS (15.119s)
[582.507995] Subtest dpms-off-confusion-interruptible: SUCCESS (30.299s)
[582.678962] [130/130] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[582.780274] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[582.781733] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[582.907066] Closing watchdogs
Done.