[92.243510] Initializing watchdogs
[92.243681]   /dev/watchdog0
[92.285994] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[92.301403] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[92.309377] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[92.317775] [001/133] (960s left) kms_prop_blob (invalid-set-prop-any)
[92.439077] Starting subtest: invalid-set-prop-any
[92.442673] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[92.600278] [002/133] (960s left) gem_ctx_persistence (heartbeat-hang)
[92.721712] Starting subtest: heartbeat-hang
[93.887414] Subtest heartbeat-hang: SUCCESS (1.167s)
[94.059389] [003/133] (958s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[94.247493] Starting subtest: basic-flip-before-cursor-legacy
[95.665910] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.415s)
[95.969223] [004/133] (957s left) kms_flip (2x-flip-vs-panning-vs-hang)
[96.162779] Starting subtest: 2x-flip-vs-panning-vs-hang
[96.166765] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[109.209778] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (13.041s)
[109.213543] Subtest 2x-flip-vs-panning-vs-hang: SUCCESS (13.046s)
[109.654182] [005/133] (943s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[110.201980] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[110.451803] [006/133] (942s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[110.638279] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[110.642461] Starting dynamic subtest: pipe-A
[110.978762] Dynamic subtest pipe-A: SUCCESS (0.338s)
[111.075520] Starting dynamic subtest: pipe-B
[111.358667] Dynamic subtest pipe-B: SUCCESS (0.378s)
[111.386285] Starting dynamic subtest: pipe-C
[111.440035] Dynamic subtest pipe-C: SUCCESS (0.081s)
[111.444376] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.800s)
[111.924256] [007/133] (941s left) kms_psr (fbc-pr-sprite-plane-move)
[112.116338] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[112.223779] [008/133] (941s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[112.435918] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[112.443826] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[112.607993] [009/133] (940s left) gem_exec_fence (syncobj-timeline-wait)
[113.372396] Starting subtest: syncobj-timeline-wait
[113.400958] Subtest syncobj-timeline-wait: SUCCESS (0.034s)
[113.666093] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[113.672798] [010/133] (939s left) kms_joiner (invalid-modeset-big-joiner)
[113.859273] Starting subtest: invalid-modeset-big-joiner
[113.866215] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[114.036184] [011/133] (939s left) gem_exec_schedule (thriceslice)
[114.179329] Starting subtest: thriceslice
[114.182585] Starting dynamic subtest: rcs0
[114.191956] Dynamic subtest rcs0: SUCCESS (0.012s)
[114.215501] Starting dynamic subtest: bcs0
[114.218784] Dynamic subtest bcs0: SUCCESS (0.016s)
[114.242157] Starting dynamic subtest: vcs0
[114.246753] Dynamic subtest vcs0: SUCCESS (0.026s)
[114.270355] Starting dynamic subtest: vecs0
[114.274439] Dynamic subtest vecs0: SUCCESS (0.020s)
[114.278612] Subtest thriceslice: SUCCESS (0.084s)
[114.670287] [012/133] (939s left) gem_mmap (bad-offset)
[114.780908] Starting subtest: bad-offset
[114.784155] Subtest bad-offset: SUCCESS (0.001s)
[114.951402] [013/133] (938s left) sysfs_preempt_timeout (idempotent)
[115.063950] Starting subtest: idempotent
[115.067972] Starting dynamic subtest: vecs0
[115.071482] Dynamic subtest vecs0: SUCCESS (0.002s)
[115.090215] Starting dynamic subtest: vcs0
[115.093558] Dynamic subtest vcs0: SUCCESS (0.003s)
[115.113448] Starting dynamic subtest: bcs0
[115.117560] Dynamic subtest bcs0: SUCCESS (0.002s)
[115.136254] Starting dynamic subtest: rcs0
[115.140293] Dynamic subtest rcs0: SUCCESS (0.002s)
[115.143555] Subtest idempotent: SUCCESS (0.014s)
[115.236089] [014/133] (938s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[115.424224] Starting subtest: cursorA-vs-flipB-atomic
[126.750619] Subtest cursorA-vs-flipB-atomic: SUCCESS (11.319s)
[127.084525] [015/133] (927s left) gem_ctx_persistence (engines-persistence)
[127.206107] Starting subtest: engines-persistence
[127.209444] Starting dynamic subtest: rcs0
[127.940032] Dynamic subtest rcs0: SUCCESS (0.733s)
[127.959817] Starting dynamic subtest: bcs0
[128.712032] Dynamic subtest bcs0: SUCCESS (0.768s)
[128.731406] Starting dynamic subtest: vcs0
[129.479714] Dynamic subtest vcs0: SUCCESS (0.769s)
[129.499339] Starting dynamic subtest: vecs0
[130.234179] Dynamic subtest vecs0: SUCCESS (0.748s)
[130.238335] Subtest engines-persistence: SUCCESS (3.026s)
[130.429373] [016/133] (923s left) gem_eio (banned)
[130.568078] Starting subtest: banned
[130.752897] Subtest banned: SUCCESS (0.187s)
[131.025227] [017/133] (923s left) kms_draw_crc (fill-fb)
[131.202753] Starting subtest: fill-fb
[131.771648] Subtest fill-fb: SUCCESS (0.567s)
[132.047657] [018/133] (922s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[132.235577] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[132.284538] Starting dynamic subtest: pipe-A-valid-mode
[133.205380] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.965s)
[133.260281] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (0.968s)
[133.557733] [019/133] (921s left) gem_watchdog (default-virtual)
[133.696924] Starting subtest: default-virtual
[134.718764] Subtest default-virtual: SUCCESS (1.028s)
[134.854257] [020/133] (919s left) kms_color (ctm-max)
[135.032686] Starting subtest: ctm-max
[135.035937] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.000754] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.965s)
[136.036026] Starting dynamic subtest: pipe-A-HDMI-A-2
[136.672556] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.669s)
[136.692236] Starting dynamic subtest: pipe-B-HDMI-A-1
[137.346887] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.674s)
[137.367275] Starting dynamic subtest: pipe-B-HDMI-A-2
[138.017963] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.669s)
[138.056823] Starting dynamic subtest: pipe-C-HDMI-A-1
[138.675298] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.656s)
[138.695440] Starting dynamic subtest: pipe-C-HDMI-A-2
[139.338434] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.660s)
[139.342485] Subtest ctm-max: SUCCESS (4.301s)
[139.662478] [021/133] (915s left) kms_psr (psr-cursor-mmap-cpu)
[139.855435] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[139.979825] [022/133] (914s left) syncobj_timeline (invalid-signal-illegal-handle)
[140.107548] Starting subtest: invalid-signal-illegal-handle
[140.111648] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[140.277080] [023/133] (914s left) kms_cursor_edge_walk (256x256-top-bottom)
[140.466665] Starting subtest: 256x256-top-bottom
[140.521308] Starting dynamic subtest: pipe-A-HDMI-A-1
[144.331599] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.862s)
[144.354085] Starting dynamic subtest: pipe-C-HDMI-A-1
[147.808692] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.425s)
[147.817031] Subtest 256x256-top-bottom: SUCCESS (7.296s)
[148.090546] [024/133] (906s left) gem_ctx_param (set-priority-range)
[148.206499] Starting subtest: set-priority-range
[148.260556] Subtest set-priority-range: SUCCESS (0.057s)
[148.455449] [025/133] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[148.638228] Starting subtest: basic-busy-flip-before-cursor-legacy
[148.644631] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[148.862258] [026/133] (906s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[149.069856] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[149.076434] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[149.253917] [027/133] (906s left) kms_flip (flip-vs-expired-vblank-interruptible)
[149.442298] Starting subtest: flip-vs-expired-vblank-interruptible
[149.445842] Starting dynamic subtest: A-HDMI-A1
[155.074272] Dynamic subtest A-HDMI-A1: SUCCESS (5.628s)
[155.095837] Starting dynamic subtest: B-HDMI-A1
[160.447135] Dynamic subtest B-HDMI-A1: SUCCESS (5.370s)
[160.467785] Starting dynamic subtest: C-HDMI-A1
[165.827137] Dynamic subtest C-HDMI-A1: SUCCESS (5.380s)
[165.847686] Starting dynamic subtest: A-HDMI-A2
[171.216923] Dynamic subtest A-HDMI-A2: SUCCESS (5.388s)
[171.238060] Starting dynamic subtest: B-HDMI-A2
[176.584956] Dynamic subtest B-HDMI-A2: SUCCESS (5.366s)
[176.607189] Starting dynamic subtest: C-HDMI-A2
[181.968048] Dynamic subtest C-HDMI-A2: SUCCESS (5.379s)
[181.971650] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (32.532s)
[182.468432] [028/133] (873s left) gem_ctx_param (invalid-size-set)
[182.577225] Starting subtest: invalid-size-set
[182.580903] Subtest invalid-size-set: SUCCESS (0.000s)
[182.749268] [029/133] (872s left) gem_flink_race (flink_name)
[182.849073] Starting subtest: flink_name
[188.225340] Subtest flink_name: SUCCESS (5.375s)
[188.398413] [030/133] (867s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[188.609890] Starting subtest: y-tiled-64bpp-rotate-180
[193.602047] Subtest y-tiled-64bpp-rotate-180: SUCCESS (4.989s)
[194.195950] [031/133] (861s left) gem_exec_parallel (fds)
[194.339300] Starting subtest: fds
[194.342853] Starting dynamic subtest: rcs0
[199.158721] Dynamic subtest rcs0: SUCCESS (4.826s)
[199.179253] Starting dynamic subtest: bcs0
[204.354388] Dynamic subtest bcs0: SUCCESS (5.195s)
[204.376821] Starting dynamic subtest: vcs0
[209.067779] Dynamic subtest vcs0: SUCCESS (4.711s)
[209.088797] Starting dynamic subtest: vecs0
[214.377240] Dynamic subtest vecs0: SUCCESS (5.307s)
[214.380956] Subtest fds: SUCCESS (20.048s)
[214.657804] [032/133] (841s left) gem_mmap_wc (invalid-flags)
[214.763591] Starting subtest: invalid-flags
[214.766759] Subtest invalid-flags: SUCCESS (0.001s)
[214.948500] [033/133] (841s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[215.164277] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[215.172445] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[215.346498] [034/133] (840s left) gem_exec_capture (userptr)
[215.490170] Starting subtest: userptr
[216.786038] Subtest userptr: SUCCESS (1.294s)
[216.982635] [035/133] (839s left) gem_lmem_swapping (parallel-multi)
[217.101054] Subtest parallel-multi: SKIP (0.000s)
[217.220310] [036/133] (839s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[217.332476] Starting subtest: no-spare-fences-interruptible
[219.516829] Subtest no-spare-fences-interruptible: SUCCESS (2.172s)
[219.693505] [037/133] (836s left) kms_psr (psr-dpms)
[219.900404] Subtest psr-dpms: SKIP (0.000s)
[220.007899] [038/133] (836s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[220.131315] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[220.139532] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[220.408789] [039/133] (836s left) gem_exec_fence (invalid-fence-array)
[220.975932] Starting subtest: invalid-fence-array
[220.985669] Subtest invalid-fence-array: SUCCESS (0.007s)
[221.414301] [040/133] (835s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[221.597791] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[221.616133] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[221.779526] [041/133] (835s left) kms_cursor_crc (cursor-onscreen-128x42)
[221.966076] Starting subtest: cursor-onscreen-128x42
[222.013875] Starting dynamic subtest: pipe-A-HDMI-A-1
[224.684264] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.672s)
[224.770183] Starting dynamic subtest: pipe-C-HDMI-A-1
[227.168300] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.412s)
[227.174360] Subtest cursor-onscreen-128x42: SUCCESS (5.199s)
[227.503996] [042/133] (829s left) kms_plane_lowres (tiling-4)
[227.698792] Starting subtest: tiling-4
[227.706233] Subtest tiling-4: SKIP (0.000s)
[227.865724] [043/133] (829s left) kms_pm_rpm (dpms-lpsp)
[229.791332] Starting subtest: dpms-lpsp
[229.845228] Subtest dpms-lpsp: SKIP (0.001s)
[230.173782] [044/133] (827s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[230.372861] Starting subtest: cursor-rapid-movement-512x170
[230.380407] Subtest cursor-rapid-movement-512x170: SKIP (0.003s)
[230.559690] [045/133] (826s left) kms_sequence (get-forked)
[230.741939] Starting subtest: get-forked
[230.745302] Starting dynamic subtest: pipe-A-HDMI-A-1
[233.472347] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.692s)
[233.513331] Starting dynamic subtest: pipe-A-HDMI-A-2
[235.931300] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.488s)
[235.964587] Starting dynamic subtest: pipe-B-HDMI-A-1
[238.374048] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.441s)
[238.440517] Starting dynamic subtest: pipe-B-HDMI-A-2
[240.823336] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.445s)
[240.867485] Starting dynamic subtest: pipe-C-HDMI-A-1
[243.259644] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.433s)
[243.298428] Starting dynamic subtest: pipe-C-HDMI-A-2
[245.699064] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.429s)
[245.702405] Subtest get-forked: SUCCESS (14.956s)
[246.028023] [046/133] (811s left) gem_busy (parallel)
[246.293720] Starting subtest: parallel
[246.297993] Starting dynamic subtest: rcs0
[246.331779] Dynamic subtest rcs0: SUCCESS (0.034s)
[246.354470] Starting dynamic subtest: bcs0
[246.364021] Dynamic subtest bcs0: SUCCESS (0.031s)
[246.385573] Starting dynamic subtest: vcs0
[246.399789] Dynamic subtest vcs0: SUCCESS (0.032s)
[246.420201] Starting dynamic subtest: vecs0
[246.433446] Dynamic subtest vecs0: SUCCESS (0.030s)
[246.437028] Subtest parallel: SUCCESS (0.140s)
[246.747823] [047/133] (810s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[246.922905] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[246.929375] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[247.625238] [048/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[247.844696] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[247.851038] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[248.021520] [049/133] (809s left) gem_exec_whisper (basic-fds-priority)
[248.148074] Starting subtest: basic-fds-priority
[260.378166] Subtest basic-fds-priority: SUCCESS (12.229s)
[260.657755] [050/133] (797s left) kms_plane_alpha_blend (alpha-7efc)
[260.850050] Starting subtest: alpha-7efc
[261.052737] Starting dynamic subtest: pipe-A-HDMI-A-1
[262.019446] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.964s)
[262.131371] Starting dynamic subtest: pipe-C-HDMI-A-1
[263.047428] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.951s)
[263.052540] Subtest alpha-7efc: SUCCESS (2.194s)
[263.409694] [051/133] (794s left) gem_exec_balancer (full-late)
[263.552504] Starting subtest: full-late
[268.167349] Subtest full-late: SUCCESS (4.617s)
[268.476156] [052/133] (789s left) gem_spin_batch (spin-all-new)
[268.603342] Starting subtest: spin-all-new
[268.631924] Subtest spin-all-new: SUCCESS (0.026s)
[268.943768] [053/133] (789s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[269.133827] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[269.139487] Starting dynamic subtest: pipe-A-HDMI-A-1
[269.270038] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[269.291753] Starting dynamic subtest: pipe-A-HDMI-A-2
[269.326186] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[269.349450] Starting dynamic subtest: pipe-B-HDMI-A-1
[269.381769] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[269.403936] Starting dynamic subtest: pipe-B-HDMI-A-2
[269.436190] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[269.458211] Starting dynamic subtest: pipe-C-HDMI-A-1
[269.492763] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[269.514682] Starting dynamic subtest: pipe-C-HDMI-A-2
[269.546197] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[269.552553] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.035s)
[270.140903] [054/133] (788s left) kms_content_protection (atomic)
[270.339067] Starting subtest: atomic
[270.372981] Subtest atomic: SKIP (0.027s)
[270.557699] [055/133] (787s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[270.773179] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[270.789078] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[270.940203] [056/133] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[271.153282] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[271.160889] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[271.338446] [057/133] (787s left) kms_vrr (max-min)
[271.524251] Starting subtest: max-min
[271.538263] Subtest max-min: SKIP (0.000s)
[271.706553] [058/133] (786s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[271.886757] Starting subtest: cursor-vs-flip-toggle
[317.720655] Subtest cursor-vs-flip-toggle: SUCCESS (45.834s)
[318.081233] [059/133] (740s left) kms_chamelium_color (ctm-negative)
[318.280785] Subtest ctm-negative: SKIP (0.000s)
[318.408656] [060/133] (740s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[318.611501] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[318.742827] [061/133] (740s left) kms_prime (basic-crc-hybrid)
[318.967546] Subtest basic-crc-hybrid: SKIP (0.000s)
[319.161437] [062/133] (739s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[319.376834] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[322.232365] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.855s)
[322.469597] [063/133] (736s left) kms_vblank (wait-idle)
[322.663470] Starting subtest: wait-idle
[322.666876] Starting dynamic subtest: pipe-A-HDMI-A-1
[325.349917] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.679s)
[325.403414] Starting dynamic subtest: pipe-A-HDMI-A-2
[327.771628] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.412s)
[327.826769] Starting dynamic subtest: pipe-C-HDMI-A-1
[330.178240] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.398s)
[330.201208] Starting dynamic subtest: pipe-C-HDMI-A-2
[332.638188] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.401s)
[332.644778] Subtest wait-idle: SUCCESS (9.925s)
[332.921295] [064/133] (726s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[333.139036] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[334.353045] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.214s)
[334.704489] [065/133] (724s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[334.906397] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[337.289837] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (2.390s)
[337.603260] [066/133] (721s left) gem_exec_nop (basic-sequential)
[337.742580] Starting subtest: basic-sequential
[340.826361] Subtest basic-sequential: SUCCESS (3.094s)
[341.137882] [067/133] (718s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[341.349213] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[341.356089] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[341.535717] [068/133] (718s left) i915_pm_rps (min-max-config-idle)
[341.656366] Starting subtest: min-max-config-idle
[342.030230] Subtest min-max-config-idle: SUCCESS (0.372s)
[342.220285] [069/133] (717s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[342.416449] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[342.538400] [070/133] (717s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[342.653059] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[342.656504] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[342.837802] [071/133] (717s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[343.042378] Starting subtest: x-tiled-32bpp-rotate-180
[346.751617] Subtest x-tiled-32bpp-rotate-180: SUCCESS (3.711s)
[347.251245] [072/133] (712s left) gem_basic (create-close)
[347.360793] Starting subtest: create-close
[347.369762] Subtest create-close: SUCCESS (0.000s)
[347.536927] [073/133] (712s left) gem_caching (reads)
[347.661574] Starting subtest: reads
[354.442827] Subtest reads: SUCCESS (6.787s)
[354.637831] [074/133] (705s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[354.870650] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[354.880924] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[355.509360] [075/133] (704s left) gem_ctx_shared (exec-shared-gtt)
[355.636250] Starting subtest: exec-shared-gtt
[355.639562] Starting dynamic subtest: rcs0
[355.650820] Dynamic subtest rcs0: SUCCESS (0.011s)
[355.690863] Starting dynamic subtest: bcs0
[355.695626] Dynamic subtest bcs0: SUCCESS (0.011s)
[355.733700] Starting dynamic subtest: vcs0
[355.738252] Dynamic subtest vcs0: SUCCESS (0.008s)
[355.763826] Starting dynamic subtest: vecs0
[355.767959] Dynamic subtest vecs0: SUCCESS (0.009s)
[355.772479] Subtest exec-shared-gtt: SUCCESS (0.051s)
[356.002522] [076/133] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[356.200037] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[356.206496] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[356.390479] [077/133] (704s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[356.502961] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[356.620966] [078/133] (704s left) gen7_exec_parse (basic-offset)
[356.749904] Subtest basic-offset: SKIP (0.000s)
[356.941157] [079/133] (704s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[357.350386] Starting subtest: bad-pixel-format-y-tiled-ccs
[357.419372] Starting dynamic subtest: pipe-A-HDMI-A-1
[358.094485] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[358.161416] Starting dynamic subtest: pipe-A-HDMI-A-2
[358.410564] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[358.460427] Starting dynamic subtest: pipe-B-HDMI-A-1
[358.497193] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[358.542847] Starting dynamic subtest: pipe-B-HDMI-A-2
[358.579297] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[358.603262] Starting dynamic subtest: pipe-C-HDMI-A-1
[358.644562] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[358.687444] Starting dynamic subtest: pipe-C-HDMI-A-2
[358.727550] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[358.731590] Subtest bad-pixel-format-y-tiled-ccs: SUCCESS (0.036s)
[358.861451] [080/133] (702s left) kms_hdmi_inject (inject-4k)
[359.388080] Starting subtest: inject-4k
[359.628098] Subtest inject-4k: SUCCESS (0.243s)
[360.061316] [081/133] (701s left) kms_lease (implicit-plane-lease)
[360.249310] Starting subtest: implicit-plane-lease
[360.253596] Subtest implicit-plane-lease: SUCCESS (0.005s)
[360.430296] [082/133] (700s left) syncobj_wait (invalid-reset-one-illegal-handle)
[360.545951] Starting subtest: invalid-reset-one-illegal-handle
[360.550059] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.001s)
[360.724274] [083/133] (700s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[360.938272] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[360.944919] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[361.136706] [084/133] (700s left) kms_psr (pr-cursor-mmap-gtt)
[361.324763] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[361.445777] [085/133] (700s left) gem_exec_params (no-bsd)
[361.570843] Starting subtest: no-bsd
[361.574497] Subtest no-bsd: SUCCESS (0.003s)
[361.761335] [086/133] (700s left) gem_pwrite_snooped
[362.060919] [087/133] (699s left) kms_psr (fbc-psr2-sprite-plane-move)
[362.261308] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[362.388915] [088/133] (699s left) api_intel_allocator (reloc-allocator)
[362.499117] Starting subtest: reloc-allocator
[362.502874] Starting dynamic subtest: basic
[362.507407] Dynamic subtest basic: SUCCESS (0.008s)
[362.534721] Starting dynamic subtest: parallel-one
[362.539072] Dynamic subtest parallel-one: SUCCESS (0.015s)
[362.563128] Starting dynamic subtest: print
[362.566358] Dynamic subtest print: SUCCESS (0.000s)
[362.590034] Starting dynamic subtest: reuse
[362.594316] Dynamic subtest reuse: SUCCESS (0.000s)
[362.629355] Starting dynamic subtest: fork-reopen-allocator
[362.633737] Dynamic subtest fork-reopen-allocator: SUCCESS (0.038s)
[362.638409] Subtest reloc-allocator: SUCCESS (0.084s)
[362.762330] [089/133] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[362.973703] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[362.979252] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[363.141649] [090/133] (699s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[363.347053] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[364.591957] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.243s)
[364.942710] [091/133] (697s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[365.132389] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[370.950981] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (5.814s)
[371.290086] [092/133] (691s left) gem_exec_reloc (basic-gtt-cpu)
[371.416939] Starting subtest: basic-gtt-cpu
[371.439398] Subtest basic-gtt-cpu: SUCCESS (0.022s)
[371.721604] [093/133] (690s left) kms_addfb_basic (bad-pitch-128)
[371.835241] Starting subtest: bad-pitch-128
[371.838152] Subtest bad-pitch-128: SUCCESS (0.000s)
[372.107916] [094/133] (690s left) kms_setmode (invalid-clone-exclusive-crtc)
[372.243457] Starting subtest: invalid-clone-exclusive-crtc
[372.757234] Subtest invalid-clone-exclusive-crtc: SKIP (0.533s)
[373.094526] [095/133] (689s left) gem_readwrite (read-bad-handle)
[373.220576] Starting subtest: read-bad-handle
[373.228096] Subtest read-bad-handle: SUCCESS (0.000s)
[373.411223] [096/133] (689s left) gem_exec_schedule (preempt-queue-contexts)
[373.570164] Starting subtest: preempt-queue-contexts
[373.573466] Starting dynamic subtest: rcs0
[374.450040] Dynamic subtest rcs0: SUCCESS (0.880s)
[374.511779] Starting dynamic subtest: bcs0
[375.218051] Dynamic subtest bcs0: SUCCESS (0.758s)
[375.249457] Starting dynamic subtest: vcs0
[375.940342] Dynamic subtest vcs0: SUCCESS (0.722s)
[375.989716] Starting dynamic subtest: vecs0
[376.677325] Dynamic subtest vecs0: SUCCESS (0.728s)
[376.682042] Subtest preempt-queue-contexts: SUCCESS (3.107s)
[377.094456] [097/133] (685s left) kms_flip (2x-flip-vs-dpms-on-nop)
[377.274242] Starting subtest: 2x-flip-vs-dpms-on-nop
[377.277861] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[378.979670] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.701s)
[379.010429] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[380.671086] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.682s)
[380.697107] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[382.319548] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.641s)
[382.323237] Subtest 2x-flip-vs-dpms-on-nop: SUCCESS (5.049s)
[382.927270] [098/133] (680s left) kms_cursor_legacy (single-move)
[383.121844] Starting subtest: single-move
[383.125118] Starting dynamic subtest: pipe-A
[388.535126] Dynamic subtest pipe-A: SUCCESS (5.401s)
[388.558810] Starting dynamic subtest: pipe-B
[393.940114] Dynamic subtest pipe-B: SUCCESS (5.406s)
[393.970956] Starting dynamic subtest: pipe-C
[399.350332] Dynamic subtest pipe-C: SUCCESS (5.406s)
[399.419915] Starting dynamic subtest: all-pipes
[404.759601] Dynamic subtest all-pipes: SUCCESS (5.405s)
[404.763030] Subtest single-move: SUCCESS (21.637s)
[404.945388] [099/133] (658s left) i915_module_load (resize-bar)
[405.049710] Starting subtest: resize-bar
[405.066505] Subtest resize-bar: SKIP (0.016s)
[405.191814] [100/133] (658s left) prime_busy (hang)
[405.309781] Starting subtest: hang
[405.313129] Starting dynamic subtest: rcs0
[411.641325] Dynamic subtest rcs0: SUCCESS (6.327s)
[411.665498] Starting dynamic subtest: bcs0
[418.684846] Dynamic subtest bcs0: SUCCESS (7.036s)
[418.708421] Starting dynamic subtest: vcs0
[425.657434] Dynamic subtest vcs0: SUCCESS (6.974s)
[425.685692] Starting dynamic subtest: vecs0
[432.635879] Dynamic subtest vecs0: SUCCESS (6.972s)
[432.639511] Subtest hang: SUCCESS (27.322s)
[432.808435] [101/133] (630s left) i915_suspend (debugfs-reader)
[432.912233] Starting subtest: debugfs-reader
[451.807238] Subtest debugfs-reader: SUCCESS (3.465s)
[460.024258] [102/133] (611s left) gem_exec_reloc (basic-gtt-wc-active)
[460.153351] Starting subtest: basic-gtt-wc-active
[460.296103] Subtest basic-gtt-wc-active: SUCCESS (0.137s)
[460.561204] [103/133] (611s left) kms_flip (nonexisting-fb)
[460.754019] Starting subtest: nonexisting-fb
[460.758453] Starting dynamic subtest: A-HDMI-A1
[461.433283] Dynamic subtest A-HDMI-A1: SUCCESS (0.655s)
[461.462065] Starting dynamic subtest: B-HDMI-A1
[461.838443] Dynamic subtest B-HDMI-A1: SUCCESS (0.389s)
[461.883726] Starting dynamic subtest: C-HDMI-A1
[462.277382] Dynamic subtest C-HDMI-A1: SUCCESS (0.420s)
[462.331060] Starting dynamic subtest: A-HDMI-A2
[462.704166] Dynamic subtest A-HDMI-A2: SUCCESS (0.413s)
[462.761924] Starting dynamic subtest: B-HDMI-A2
[463.132331] Dynamic subtest B-HDMI-A2: SUCCESS (0.411s)
[463.160530] Starting dynamic subtest: C-HDMI-A2
[463.548212] Dynamic subtest C-HDMI-A2: SUCCESS (0.401s)
[463.551584] Subtest nonexisting-fb: SUCCESS (2.723s)
[464.125551] [104/133] (607s left) gem_mmap_offset (mmap-boundaries)
[464.241496] Starting subtest: mmap-boundaries
[464.244817] Starting dynamic subtest: smem0
[465.157256] Dynamic subtest smem0: SUCCESS (0.894s)
[465.164963] Subtest mmap-boundaries: SUCCESS (0.898s)
[465.395967] [105/133] (606s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[465.583104] Starting subtest: cursorA-vs-flipA-atomic-transitions
[476.978760] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.287s)
[477.313826] [106/133] (594s left) gem_cs_tlb (engines)
[477.444737] Starting subtest: engines
[477.447867] Starting dynamic subtest: rcs0
[479.614200] Dynamic subtest rcs0: SUCCESS (2.156s)
[479.642793] Starting dynamic subtest: bcs0
[481.788791] Dynamic subtest bcs0: SUCCESS (2.158s)
[481.816883] Starting dynamic subtest: vcs0
[483.947510] Dynamic subtest vcs0: SUCCESS (2.154s)
[483.978638] Starting dynamic subtest: vecs0
[486.108210] Dynamic subtest vecs0: SUCCESS (2.155s)
[486.112673] Subtest engines: SUCCESS (8.638s)
[486.284661] [107/133] (585s left) gem_exec_fence (basic-busy)
[486.537053] Starting subtest: basic-busy
[486.540832] Starting dynamic subtest: rcs0
[486.561940] Dynamic subtest rcs0: SUCCESS (0.022s)
[486.589452] Starting dynamic subtest: bcs0
[486.598529] Dynamic subtest bcs0: SUCCESS (0.021s)
[486.625514] Starting dynamic subtest: vcs0
[486.635561] Dynamic subtest vcs0: SUCCESS (0.021s)
[486.662317] Starting dynamic subtest: vecs0
[486.670597] Dynamic subtest vecs0: SUCCESS (0.016s)
[486.674580] Subtest basic-busy: SUCCESS (0.096s)
[487.369287] [108/133] (584s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[487.484533] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[487.585168] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[487.752234] [109/133] (584s left) i915_drm_fdinfo (most-busy-check-all)
[487.864601] Starting subtest: most-busy-check-all
[487.867786] Starting dynamic subtest: rcs0
[488.392463] Dynamic subtest rcs0: SUCCESS (0.524s)
[488.420839] Starting dynamic subtest: bcs0
[488.922569] Dynamic subtest bcs0: SUCCESS (0.526s)
[488.950356] Starting dynamic subtest: vcs0
[489.451868] Dynamic subtest vcs0: SUCCESS (0.522s)
[489.491436] Starting dynamic subtest: vecs0
[489.973702] Dynamic subtest vecs0: SUCCESS (0.522s)
[489.978154] Subtest most-busy-check-all: SUCCESS (2.110s)
[490.158067] [110/133] (582s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[490.366811] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[490.373738] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[490.555900] [111/133] (582s left) core_getversion (basic)
[490.664219] Starting subtest: basic
[490.673089] Subtest basic: SUCCESS (0.000s)
[490.837537] [112/133] (581s left) syncobj_timeline (wait-all-for-submit-snapshot)
[490.947478] Starting subtest: wait-all-for-submit-snapshot
[491.036413] Subtest wait-all-for-submit-snapshot: SUCCESS (0.089s)
[491.228442] [113/133] (581s left) kms_async_flips (async-flip-suspend-resume)
[491.413716] Starting subtest: async-flip-suspend-resume
[491.993437] Starting dynamic subtest: pipe-A-HDMI-A-1