[58.458295] Initializing watchdogs [58.458365] /dev/watchdog0 [58.472790] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [58.476638] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.478735] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.482393] [001/133] (960s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [58.593603] Starting subtest: primary-y-tiled-reflect-x-90 [58.597525] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [58.664195] [002/133] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [58.741601] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [58.743986] Starting dynamic subtest: pipe-A-eDP-1 [58.864156] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s) [58.871623] Starting dynamic subtest: pipe-B-eDP-1 [59.993260] Dynamic subtest pipe-B-eDP-1: SKIP (1.117s) [59.997992] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.243s) [61.181114] [003/133] (957s left) syncobj_timeline (invalid-signal-illegal-handle) [61.241635] Starting subtest: invalid-signal-illegal-handle [61.244004] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [61.327447] [004/133] (957s left) gem_mmap_gtt (big-bo-tiledy) [61.391315] Subtest big-bo-tiledY: SKIP (0.000s) [61.445289] [005/133] (957s left) kms_plane (pixel-format-y-tiled-modifier) [61.518777] Starting subtest: pixel-format-y-tiled-modifier [61.523112] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s) [61.585637] [006/133] (957s left) gen9_exec_parse (batch-invalid-length) [61.641611] Subtest batch-invalid-length: SKIP (0.000s) [61.709255] [007/133] (957s left) kms_psr (fbc-psr2-cursor-plane-move) [61.785110] Starting subtest: fbc-psr2-cursor-plane-move [61.787436] Starting dynamic subtest: eDP-1 [61.791786] Dynamic subtest eDP-1: SKIP (0.000s) [61.796182] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s) [61.853741] [008/133] (957s left) i915_query (query-topology-garbage-items) [61.908745] Starting subtest: query-topology-garbage-items [61.911133] Subtest query-topology-garbage-items: SUCCESS (0.000s) [62.026163] [009/133] (957s left) gem_exec_reloc (basic-wc-cpu-noreloc) [62.086576] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [62.153130] [010/133] (957s left) i915_drm_fdinfo (busy) [62.188898] Starting subtest: busy [62.190617] Starting dynamic subtest: rcs0 [62.219102] Dynamic subtest rcs0: SKIP (0.029s) [62.228554] Starting dynamic subtest: bcs0 [62.232209] Dynamic subtest bcs0: SKIP (0.000s) [62.240254] Starting dynamic subtest: vcs0 [62.243817] Dynamic subtest vcs0: SKIP (0.000s) [62.250895] Starting dynamic subtest: vcs1 [62.254541] Dynamic subtest vcs1: SKIP (0.000s) [62.261156] Starting dynamic subtest: vecs0 [62.264516] Dynamic subtest vecs0: SKIP (0.000s) [62.271104] Starting dynamic subtest: ccs0 [62.274433] Dynamic subtest ccs0: SKIP (0.000s) [62.277776] Subtest busy: SKIP (0.032s) [62.312278] [011/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [62.384164] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [62.387247] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [62.474797] [012/133] (956s left) kms_flip (dpms-off-confusion) [62.561481] Starting subtest: dpms-off-confusion [62.563549] Starting dynamic subtest: A-eDP1 [71.215722] Dynamic subtest A-eDP1: SUCCESS (8.627s) [71.225243] Starting dynamic subtest: B-eDP1 [79.891793] Dynamic subtest B-eDP1: SUCCESS (8.665s) [79.904068] Starting dynamic subtest: C-eDP1 [88.596637] Dynamic subtest C-eDP1: SUCCESS (8.699s) [88.604296] Starting dynamic subtest: D-eDP1 [97.228287] Dynamic subtest D-eDP1: SUCCESS (8.628s) [97.233205] Subtest dpms-off-confusion: SUCCESS (34.630s) [98.405193] [013/133] (921s left) kms_big_fb (linear-32bpp-rotate-0) [98.490909] Starting subtest: linear-32bpp-rotate-0 [99.924779] Subtest linear-32bpp-rotate-0: SUCCESS (1.434s) [100.099519] [014/133] (919s left) kms_async_flips (crc) [100.170852] Starting subtest: crc [100.543839] Starting dynamic subtest: pipe-A-eDP-1 [103.421740] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.876s) [103.798163] Starting dynamic subtest: pipe-B-eDP-1 [106.747152] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.958s) [107.133189] Starting dynamic subtest: pipe-C-eDP-1 [110.054637] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.929s) [110.416610] Starting dynamic subtest: pipe-D-eDP-1 [113.282682] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.873s) [113.284935] Subtest crc: SUCCESS (13.111s) [114.454115] [015/133] (905s left) kms_setmode (clone-exclusive-crtc) [114.514048] Starting subtest: clone-exclusive-crtc [114.520742] Subtest clone-exclusive-crtc: SKIP (0.000s) [114.623375] [016/133] (904s left) kms_psr (psr2-sprite-plane-onoff) [114.704848] Starting subtest: psr2-sprite-plane-onoff [114.707237] Starting dynamic subtest: eDP-1 [116.446729] Dynamic subtest eDP-1: SUCCESS (1.742s) [116.449020] Subtest psr2-sprite-plane-onoff: SUCCESS (1.743s) [117.294992] [017/133] (902s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [117.377040] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [117.381380] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [117.480051] [018/133] (902s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [117.551756] Starting subtest: plane-all-modeset-transition-internal-panels [117.554055] Starting dynamic subtest: pipe-A-eDP-1 [118.847342] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.295s) [119.129026] Starting dynamic subtest: pipe-B-eDP-1 [120.174768] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s) [120.443645] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.893s) [121.283667] [019/133] (898s left) kms_psr2_su (page_flip-xrgb8888) [121.344230] Subtest page_flip-XRGB8888: SKIP (0.000s) [121.401162] [020/133] (898s left) kms_chamelium_audio (dp-audio-edid) [121.772827] Subtest dp-audio-edid: SKIP (0.000s) [122.589659] [021/133] (897s left) kms_addfb_basic (bad-pitch-32) [122.647875] Starting subtest: bad-pitch-32 [122.650132] Subtest bad-pitch-32: SUCCESS (0.000s) [122.769193] [022/133] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [122.849968] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [122.854122] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [122.928469] [023/133] (896s left) kms_hdr (brightness-with-hdr) [123.004676] Starting subtest: brightness-with-hdr [123.010901] Subtest brightness-with-hdr: SKIP (0.000s) [123.072425] [024/133] (896s left) syncobj_wait (invalid-reset-zero-handles) [123.128645] Starting subtest: invalid-reset-zero-handles [123.130534] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [123.238211] [025/133] (896s left) kms_psr (fbc-psr-sprite-render) [123.315060] Starting subtest: fbc-psr-sprite-render [123.317440] Starting dynamic subtest: eDP-1 [123.321789] Dynamic subtest eDP-1: SKIP (0.000s) [123.326271] Subtest fbc-psr-sprite-render: SKIP (0.000s) [123.388884] [026/133] (896s left) gem_exec_reloc (basic-write-gtt-noreloc) [123.442066] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [123.517947] [027/133] (896s left) gem_exec_fence (basic-wait) [123.701099] Starting subtest: basic-wait [123.703576] Starting dynamic subtest: rcs0 [123.786483] Dynamic subtest rcs0: SUCCESS (0.088s) [123.796115] Starting dynamic subtest: bcs0 [123.846573] Dynamic subtest bcs0: SUCCESS (0.059s) [123.856688] Starting dynamic subtest: vcs0 [123.901099] Dynamic subtest vcs0: SUCCESS (0.054s) [123.910720] Starting dynamic subtest: vcs1 [123.956055] Dynamic subtest vcs1: SUCCESS (0.054s) [123.966326] Starting dynamic subtest: vecs0 [124.026258] Dynamic subtest vecs0: SUCCESS (0.063s) [124.035712] Starting dynamic subtest: ccs0 [124.084569] Dynamic subtest ccs0: SUCCESS (0.054s) [124.086967] Subtest basic-wait: SUCCESS (0.378s) [126.295607] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true [126.298722] [028/133] (893s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [126.390716] Starting subtest: fbc-rgb565-draw-mmap-cpu [130.435490] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.050s) [131.619416] [029/133] (888s left) kms_plane_cursor (primary) [131.714611] Starting subtest: primary [131.719780] Starting dynamic subtest: pipe-A-eDP-1-size-64 [134.371539] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.655s) [134.395212] Starting dynamic subtest: pipe-A-eDP-1-size-128 [136.927655] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.539s) [136.952750] Starting dynamic subtest: pipe-A-eDP-1-size-256 [139.507043] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.561s) [139.829064] Starting dynamic subtest: pipe-B-eDP-1-size-64 [143.065638] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.246s) [143.089645] Starting dynamic subtest: pipe-B-eDP-1-size-128 [145.722051] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.638s) [145.746147] Starting dynamic subtest: pipe-B-eDP-1-size-256 [148.312756] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.574s) [148.633956] Starting dynamic subtest: pipe-C-eDP-1-size-64 [151.546281] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.922s) [151.571874] Starting dynamic subtest: pipe-C-eDP-1-size-128 [153.757467] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s) [153.782807] Starting dynamic subtest: pipe-C-eDP-1-size-256 [155.957383] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s) [156.276682] Starting dynamic subtest: pipe-D-eDP-1-size-64 [159.206210] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.939s) [159.231570] Starting dynamic subtest: pipe-D-eDP-1-size-128 [161.440626] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s) [161.465682] Starting dynamic subtest: pipe-D-eDP-1-size-256 [163.662367] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.203s) [163.974659] Subtest primary: SUCCESS (32.257s) [164.825575] [030/133] (855s left) kms_big_fb (y-tiled-8bpp-rotate-90) [164.906879] Starting subtest: y-tiled-8bpp-rotate-90 [164.911420] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [165.009029] [031/133] (855s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [165.078987] Starting subtest: fbcpsr-slowdraw [190.395893] Subtest fbcpsr-slowdraw: SUCCESS (25.318s) [190.530920] [032/133] (829s left) gem_exec_reloc (basic-wc-read-active) [190.587542] Subtest basic-wc-read-active: SKIP (0.000s) [190.661931] [033/133] (829s left) kms_plane_alpha_blend (alpha-7efc) [190.745097] Starting subtest: alpha-7efc [191.030379] Starting dynamic subtest: pipe-A-eDP-1 [191.632832] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s) [191.661365] Starting dynamic subtest: pipe-D-eDP-1 [192.977088] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s) [192.979352] Subtest alpha-7efc: SUCCESS (2.233s) [193.813761] [034/133] (826s left) perf (gen12-unprivileged-single-ctx-counters) [193.934328] Starting subtest: gen12-unprivileged-single-ctx-counters [193.936564] Starting dynamic subtest: rcs0 [193.972794] Dynamic subtest rcs0: SUCCESS (0.039s) [193.975174] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.041s) [194.024464] [035/133] (826s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [194.130998] Starting subtest: bad-rotation-90-y-tiled-ccs [194.133293] Starting dynamic subtest: pipe-A-eDP-1 [194.156137] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [194.166080] Starting dynamic subtest: pipe-B-eDP-1 [194.188070] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [194.195649] Starting dynamic subtest: pipe-C-eDP-1 [194.216314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [194.224075] Starting dynamic subtest: pipe-D-eDP-1 [194.245430] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [194.249510] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s) [196.386787] [036/133] (823s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [196.464058] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [196.469067] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [196.652137] [037/133] (823s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt) [196.736578] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt [196.740758] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [196.843469] [038/133] (823s left) kms_setmode (invalid-clone-exclusive-crtc) [196.907118] Starting subtest: invalid-clone-exclusive-crtc [196.913772] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [197.022630] [039/133] (823s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [197.108357] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [198.220742] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.112s) [198.319511] [040/133] (822s left) kms_big_fb (yf-tiled-addfb-size-overflow) [198.409528] Starting subtest: yf-tiled-addfb-size-overflow [198.417502] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [198.515310] [041/133] (822s left) syncobj_basic (bad-create-flags) [198.566578] Starting subtest: bad-create-flags [198.568341] Subtest bad-create-flags: SUCCESS (0.000s) [198.647538] [042/133] (821s left) gem_lmem_swapping (verify-random) [198.692102] Subtest verify-random: SKIP (0.000s) [198.736108] [043/133] (821s left) kms_cursor_legacy (torture-bo) [198.836194] Starting subtest: torture-bo [198.838055] Starting dynamic subtest: pipe-A [204.831489] Dynamic subtest pipe-A: SUCCESS (5.990s) [204.844583] Starting dynamic subtest: pipe-B [211.728263] Dynamic subtest pipe-B: SUCCESS (6.896s) [211.741177] Starting dynamic subtest: pipe-C [217.787923] Dynamic subtest pipe-C: SUCCESS (6.058s) [217.797320] Starting dynamic subtest: pipe-D [225.093096] Dynamic subtest pipe-D: SUCCESS (7.302s) [225.104061] Starting dynamic subtest: all-pipes [231.685927] Dynamic subtest all-pipes: SUCCESS (6.589s) [231.688189] Subtest torture-bo: SUCCESS (32.845s) [231.841492] [044/133] (788s left) sysfs_preempt_timeout (timeout) [231.912629] Starting subtest: timeout [231.914907] Starting dynamic subtest: vecs0 [241.203933] Dynamic subtest vecs0: SUCCESS (9.286s) [241.214925] Starting dynamic subtest: ccs0 [242.526609] Dynamic subtest ccs0: SUCCESS (1.322s) [242.537599] Starting dynamic subtest: vcs0 [252.218914] Dynamic subtest vcs0: SUCCESS (9.688s) [252.229906] Starting dynamic subtest: bcs0 [253.504712] Dynamic subtest bcs0: SUCCESS (1.284s) [253.514699] Starting dynamic subtest: rcs0 [254.742774] Dynamic subtest rcs0: SUCCESS (1.237s) [254.753883] Starting dynamic subtest: vcs1 [264.246563] Dynamic subtest vcs1: SUCCESS (9.501s) [264.249090] Subtest timeout: SUCCESS (32.332s) [264.321372] [045/133] (756s left) gem_userptr_blits (create-destroy-unsync) [264.397083] Subtest create-destroy-unsync: SKIP (0.000s) [264.519406] [046/133] (756s left) gem_exec_balancer (full-pulse) [264.574256] Starting subtest: full-pulse [269.072993] Subtest full-pulse: SUCCESS (4.498s) [269.411948] [047/133] (751s left) kms_vblank (query-forked-hang) [269.501072] Starting subtest: query-forked-hang [269.503429] Starting dynamic subtest: pipe-A-eDP-1 [296.070266] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.566s) [296.083894] Starting dynamic subtest: pipe-D-eDP-1 [320.960651] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.886s) [320.963057] Subtest query-forked-hang: SUCCESS (51.456s) [321.817993] [048/133] (698s left) gem_exec_fence (syncobj-unused-fence) [322.263885] Starting subtest: syncobj-unused-fence [322.269163] Subtest syncobj-unused-fence: SUCCESS (0.004s) [323.301073] [049/133] (697s left) kms_cursor_crc (cursor-sliding-32x32) [323.439718] Starting subtest: cursor-sliding-32x32 [323.482712] Subtest cursor-sliding-32x32: SKIP (0.040s) [323.753620] [050/133] (697s left) prime_mmap_kms (buffer-sharing) [323.822101] Starting subtest: buffer-sharing [324.269726] Subtest buffer-sharing: SUCCESS (0.446s) [325.062183] [051/133] (695s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [325.146311] Starting subtest: fbcpsr-farfromfence-mmap-gtt [325.150719] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [325.234223] [052/133] (695s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [325.325743] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [328.979252] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.658s) [330.167663] [053/133] (690s left) gem_exec_reloc (basic-write-wc-active) [330.240924] Subtest basic-write-wc-active: SKIP (0.000s) [330.309467] [054/133] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [330.385587] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [330.389911] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [330.508642] [055/133] (690s left) syncobj_timeline (multi-wait-signaled) [330.564783] Starting subtest: multi-wait-signaled [330.567100] Subtest multi-wait-signaled: SUCCESS (0.001s) [330.667849] [056/133] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [330.750098] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [330.754433] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [330.840815] [057/133] (690s left) kms_chamelium_frames (dp-frame-dump) [331.196149] Subtest dp-frame-dump: SKIP (0.000s) [331.971515] [058/133] (689s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [332.062602] Starting subtest: psr-rgb565-draw-mmap-wc [338.860575] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.801s) [338.972026] [059/133] (682s left) kms_psr (psr-dpms) [339.057877] Starting subtest: psr-dpms [339.060152] Starting dynamic subtest: eDP-1 [342.047917] Dynamic subtest eDP-1: SUCCESS (2.988s) [342.050104] Subtest psr-dpms: SUCCESS (2.990s) [342.915459] [060/133] (678s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [342.993941] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [342.998427] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [343.088532] [061/133] (678s left) gem_spin_batch (spin-all-new) [343.138885] Starting subtest: spin-all-new [343.155441] Subtest spin-all-new: SUCCESS (0.016s) [344.310411] [062/133] (677s left) kms_setmode (invalid-clone-single-crtc-stealing) [344.377680] Starting subtest: invalid-clone-single-crtc-stealing [344.384481] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [344.476161] [063/133] (676s left) gem_eio (execbuf) [344.689120] Starting subtest: execbuf [345.001952] Subtest execbuf: SUCCESS (0.315s) [345.154654] [064/133] (676s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [345.241868] Starting subtest: fbc-rgb101010-draw-mmap-gtt [345.246079] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [345.336099] [065/133] (676s left) gem_exec_schedule (out-order) [345.411866] Starting subtest: out-order [345.413737] Starting dynamic subtest: rcs0 [345.504498] Dynamic subtest rcs0: SUCCESS (0.097s) [345.516387] Starting dynamic subtest: vcs0 [345.590236] Dynamic subtest vcs0: SUCCESS (0.085s) [345.599285] Starting dynamic subtest: vcs1 [345.669435] Dynamic subtest vcs1: SUCCESS (0.077s) [345.681585] Starting dynamic subtest: vecs0 [345.749856] Dynamic subtest vecs0: SUCCESS (0.079s) [345.759411] Starting dynamic subtest: ccs0 [345.849224] Dynamic subtest ccs0: SUCCESS (0.098s) [345.851353] Subtest out-order: SUCCESS (0.443s) [347.292075] [066/133] (674s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [347.351814] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [347.458949] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s) [347.535112] [067/133] (674s left) kms_addfb_basic (tile-pitch-mismatch) [347.601343] Starting subtest: tile-pitch-mismatch [347.605776] Subtest tile-pitch-mismatch: SKIP (0.000s) [347.725149] [068/133] (673s left) gem_exercise_blt (fast-copy) [347.786726] Starting subtest: fast-copy [347.788593] Starting dynamic subtest: linear-smem-smem [347.809842] Dynamic subtest linear-smem-smem: SUCCESS (0.024s) [347.821118] Starting dynamic subtest: xmajor-smem-smem [347.827290] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s) [347.836266] Starting dynamic subtest: tile4-smem-smem [347.843505] Dynamic subtest tile4-smem-smem: SUCCESS (0.015s) [347.852620] Starting dynamic subtest: tile64-smem-smem [347.861778] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s) [347.863894] Subtest fast-copy: SUCCESS (0.077s) [347.976812] [069/133] (673s left) kms_universal_plane (cursor-fb-leak) [348.060847] Starting subtest: cursor-fb-leak [348.063051] Starting dynamic subtest: pipe-A-eDP-1 [348.392644] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.330s) [348.405551] Starting dynamic subtest: pipe-B-eDP-1 [349.735613] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.341s) [349.751011] Starting dynamic subtest: pipe-C-eDP-1 [351.051318] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.313s) [351.062887] Starting dynamic subtest: pipe-D-eDP-1 [352.378375] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s) [352.380724] Subtest cursor-fb-leak: SUCCESS (4.318s) [353.556221] [070/133] (668s left) kms_atomic (test-only) [353.635837] Starting subtest: test-only [353.685446] Starting dynamic subtest: pipe-A-eDP-1 [356.235542] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.552s) [356.238116] Subtest test-only: SUCCESS (2.602s) [357.111827] [071/133] (664s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [357.193753] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [357.196115] Starting dynamic subtest: pipe-A-eDP-1 [357.630194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.404s) [357.640897] Starting dynamic subtest: pipe-B-eDP-1 [359.017282] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s) [359.026927] Starting dynamic subtest: pipe-C-eDP-1 [360.410715] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s) [360.421049] Starting dynamic subtest: pipe-D-eDP-1 [361.733097] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s) [361.735055] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.514s) [362.942112] [072/133] (658s left) kms_cursor_crc (cursor-dpms) [363.069972] Starting subtest: cursor-dpms [363.072263] Starting dynamic subtest: pipe-A-eDP-1 [366.116963] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.043s) [366.126652] Starting dynamic subtest: pipe-D-eDP-1 [369.695462] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.578s) [369.697781] Subtest cursor-dpms: SUCCESS (6.624s) [370.532926] [073/133] (651s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [370.612195] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [370.614464] Starting dynamic subtest: pipe-A [371.661630] Dynamic subtest pipe-A: SUCCESS (1.051s) [371.670683] Starting dynamic subtest: pipe-B [373.772062] Dynamic subtest pipe-B: SUCCESS (2.110s) [373.781147] Starting dynamic subtest: pipe-C [374.954728] Dynamic subtest pipe-C: SUCCESS (1.181s) [374.964482] Starting dynamic subtest: pipe-D [376.082703] Dynamic subtest pipe-D: SUCCESS (1.127s) [376.085083] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.472s) [377.289062] [074/133] (644s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [377.368325] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [377.372327] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [377.476458] [075/133] (644s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [377.554196] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [377.558558] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [377.656308] [076/133] (644s left) kms_color (gamma) [377.723995] Starting subtest: gamma [377.726191] Starting dynamic subtest: pipe-A-eDP-1 [378.463730] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s) [378.474710] Starting dynamic subtest: pipe-B-eDP-1 [379.897749] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s) [379.907067] Starting dynamic subtest: pipe-C-eDP-1 [381.273502] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s) [381.283386] Starting dynamic subtest: pipe-D-eDP-1 [382.625697] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s) [382.628049] Subtest gamma: SUCCESS (4.901s) [383.436741] [077/133] (638s left) kms_big_fb (4-tiled-32bpp-rotate-180) [383.517167] Starting subtest: 4-tiled-32bpp-rotate-180 [384.905863] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.389s) [385.038689] [078/133] (637s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [385.127466] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [385.131257] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [386.251939] [079/133] (635s left) kms_flip (flip-vs-dpms-on-nop) [386.327801] Starting subtest: flip-vs-dpms-on-nop [386.330125] Starting dynamic subtest: A-eDP1 [388.149838] Dynamic subtest A-eDP1: SUCCESS (1.824s) [388.161198] Starting dynamic subtest: B-eDP1 [389.983486] Dynamic subtest B-eDP1: SUCCESS (1.832s) [389.996330] Starting dynamic subtest: C-eDP1 [391.810743] Dynamic subtest C-eDP1: SUCCESS (1.824s) [391.821462] Starting dynamic subtest: D-eDP1 [393.642458] Dynamic subtest D-eDP1: SUCCESS (1.831s) [393.647330] Subtest flip-vs-dpms-on-nop: SUCCESS (7.322s) [394.806954] [080/133] (627s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [394.872080] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [394.874377] Starting dynamic subtest: pipe-A-default-mode [396.065371] Dynamic subtest pipe-A-default-mode: SKIP (1.190s) [396.069677] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.192s) [396.220073] [081/133] (625s left) gem_eio (hibernate) [396.442893] Starting subtest: hibernate [410.821506] Subtest hibernate: SUCCESS (14.377s) [418.968868] [082/133] (611s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [419.069257] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [419.071447] Starting dynamic subtest: pipe-A-eDP-1 [419.091798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [419.104219] Starting dynamic subtest: pipe-B-eDP-1 [419.123045] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [419.133041] Starting dynamic subtest: pipe-C-eDP-1 [419.151973] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [419.162326] Starting dynamic subtest: pipe-D-eDP-1 [419.182158] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [419.184079] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s) [421.346686] [083/133] (608s left) kms_atomic_interruptible (legacy-dpms) [421.420186] Starting subtest: legacy-dpms [421.422415] Starting dynamic subtest: pipe-A-eDP-1 [428.863232] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.441s) [428.865485] Subtest legacy-dpms: SUCCESS (7.442s) [429.723872] [084/133] (600s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [431.428774] Starting subtest: dpms-mode-unset-non-lpsp [432.571352] Subtest dpms-mode-unset-non-lpsp: SKIP (1.145s) [432.964787] [085/133] (597s left) kms_pm_rpm (system-suspend-idle) [434.467320] Starting subtest: system-suspend-idle [453.785762] Subtest system-suspend-idle: SUCCESS (4.352s) [454.156178] [086/133] (576s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [454.260006] Starting subtest: yf-tiled-32bpp-rotate-180 [454.265306] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [454.363686] [087/133] (576s left) kms_flip (blocking-wf_vblank) [454.447090] Starting subtest: blocking-wf_vblank [454.449879] Starting dynamic subtest: A-eDP1 [463.387088] Dynamic subtest A-eDP1: SUCCESS (8.942s) [463.397600] Starting dynamic subtest: B-eDP1 [472.309886] Dynamic subtest B-eDP1: SUCCESS (8.920s) [472.320127] Starting dynamic subtest: C-eDP1 [481.241346] Dynamic subtest C-eDP1: SUCCESS (8.926s) [481.252138] Starting dynamic subtest: D-eDP1 [502.024699] Dynamic subtest D-eDP1: SUCCESS (20.665s) [502.029984] Subtest blocking-wf_vblank: SUCCESS (47.467s) [503.163283] [088/133] (527s left) template (b) [503.218270] Starting subtest: B [503.221046] Subtest B: SUCCESS (0.000s) [503.317022] [089/133] (527s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [503.393699] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [503.401174] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.007s) [503.502787] [090/133] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [503.588961] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [510.063024] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.469s) [510.178064] [091/133] (520s left) prime_vgem (wait) [510.262180] Starting subtest: wait [510.265274] Starting dynamic subtest: rcs0 [510.298829] Dynamic subtest rcs0: SUCCESS (0.036s) [510.311009] Starting dynamic subtest: bcs0 [510.351022] Dynamic subtest bcs0: SUCCESS (0.051s) [510.361044] Starting dynamic subtest: vcs0 [510.395237] Dynamic subtest vcs0: SUCCESS (0.044s) [510.405467] Starting dynamic subtest: vcs1 [510.443078] Dynamic subtest vcs1: SUCCESS (0.047s) [510.453227] Starting dynamic subtest: vecs0 [510.489097] Dynamic subtest vecs0: SUCCESS (0.045s) [510.499324] Starting dynamic subtest: ccs0 [510.536953] Dynamic subtest ccs0: SUCCESS (0.047s) [510.539266] Subtest wait: SUCCESS (0.275s) [510.664480] [092/133] (520s left) kms_rotation_crc (primary-rotation-180) [510.737002] Starting subtest: primary-rotation-180 [517.903242] Subtest primary-rotation-180: SUCCESS (7.162s) [519.068541] [093/133] (511s left) syncobj_basic (bad-destroy) [519.126457] Starting subtest: bad-destroy [519.129301] Subtest bad-destroy: SUCCESS (0.000s) [519.241016] [094/133] (511s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [519.326958] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [519.331922] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [519.424854] [095/133] (511s left) kms_dsc (dsc-with-output-formats) [519.500051] Starting subtest: dsc-with-output-formats [519.525394] Subtest dsc-with-output-formats: SKIP (0.001s) [519.574190] [096/133] (511s left) syncobj_wait (single-wait-all-submitted) [519.630308] Starting subtest: single-wait-all-submitted [519.741125] Subtest single-wait-all-submitted: SUCCESS (0.108s) [519.829194] [097/133] (511s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [519.901686] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [519.907426] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [519.991488] [098/133] (510s left) kms_lease (invalid-create-leases) [520.064397] Starting subtest: invalid-create-leases [520.069009] Subtest invalid-create-leases: SUCCESS (0.005s) [520.168884] [099/133] (510s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [520.236253] Starting subtest: multi-wait-all-for-submit-submitted-signaled [520.340612] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s) [520.417518] [100/133] (510s left) gem_exec_schedule (thriceslice) [520.486176] Starting subtest: thriceslice [520.488342] Starting dynamic subtest: rcs0 [520.529728] Dynamic subtest rcs0: SUCCESS (0.053s) [520.544317] Starting dynamic subtest: bcs0 [520.585177] Dynamic subtest bcs0: SUCCESS (0.053s) [520.598445] Starting dynamic subtest: vcs0 [520.620100] Dynamic subtest vcs0: SUCCESS (0.031s) [520.630347] Starting dynamic subtest: vcs1 [520.650041] Dynamic subtest vcs1: SUCCESS (0.029s) [520.660365] Starting dynamic subtest: vecs0 [520.681726] Dynamic subtest vecs0: SUCCESS (0.030s) [520.692013] Starting dynamic subtest: ccs0 [520.736634] Dynamic subtest ccs0: SUCCESS (0.054s) [520.739522] Subtest thriceslice: SUCCESS (0.261s) [522.274300] [101/133] (508s left) i915_pm_rpm (gem-pread) [524.379113] Starting subtest: gem-pread [526.089055] Subtest gem-pread: SUCCESS (1.712s) [526.180770] [102/133] (504s left) gem_ctx_shared (disjoint-timelines) [526.241443] Starting subtest: disjoint-timelines [526.263482] Subtest disjoint-timelines: SUCCESS (0.022s) [526.497705] [103/133] (504s left) gem_exec_whisper (basic-contexts-priority) [526.562432] Starting subtest: basic-contexts-priority [550.629946] Subtest basic-contexts-priority: SUCCESS (24.052s) [550.830377] [104/133] (480s left) kms_cursor_crc (cursor-rapid-movement-max-size) [551.095162] Starting subtest: cursor-rapid-movement-max-size [551.102742] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [551.210664] [105/133] (480s left) gem_exec_fence (syncobj-timeline-invalid-wait) [551.790993] Starting subtest: syncobj-timeline-invalid-wait [551.793510] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [553.294571] [106/133] (478s left) gem_ctx_engines (execute-one) [553.357126] Starting subtest: execute-one [556.587830] Subtest execute-one: SUCCESS (3.229s) [556.778016] [107/133] (474s left) kms_invalid_mode (zero-vdisplay) [556.855716] Starting subtest: zero-vdisplay [556.858090] Starting dynamic subtest: pipe-A-eDP-1 [557.155670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s) [557.166102] Starting dynamic subtest: pipe-B-eDP-1 [557.168184] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [557.178139] Starting dynamic subtest: pipe-C-eDP-1 [557.180444] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [557.190287] Starting dynamic subtest: pipe-D-eDP-1 [557.192627] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [557.194980] Subtest zero-vdisplay: SUCCESS (0.306s) [557.989144] [108/133] (473s left) gem_userptr_blits (coherency-sync) [558.051453] Starting subtest: coherency-sync [558.484284] Subtest coherency-sync: SKIP (0.383s) [558.576540] [109/133] (472s left) core_auth (getclient-master-drop) [558.658248] Starting subtest: getclient-master-drop [558.672385] Subtest getclient-master-drop: SUCCESS (0.015s) [558.790469] [110/133] (472s left) gem_mmap_gtt (zero-extend) [558.846231] Subtest zero-extend: SKIP (0.000s) [558.899954] [111/133] (472s left) syncobj_timeline (signal) [558.968970] Starting subtest: signal [558.971240] Subtest signal: SUCCESS (0.000s) [559.072684] [112/133] (472s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [559.165203] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [559.170475] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [559.262130] [113/133] (472s left) gem_pxp (create-regular-context-1) [559.389306] Starting subtest: create-regular-context-1 [559.392457] Subtest create-regular-context-1: SUCCESS (0.002s) [559.497815] [114/133] (472s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [559.558590] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [559.563343] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [559.740434] [115/133] (471s left) gem_ctx_persistence (heartbeat-many) [559.804166] Starting subtest: heartbeat-many [559.809871] Subtest heartbeat-many: SKIP (0.000s) [559.920048] [116/133] (471s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [560.002173] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [560.032334] Starting dynamic subtest: pipe-A-plane-0 [560.343176] Dynamic subtest pipe-A-plane-0: SUCCESS (0.311s) [560.357241] Starting dynamic subtest: pipe-A-plane-3 [560.576427] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s) [560.588240] Starting dynamic subtest: pipe-A-plane-5 [560.593461] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [561.672207] Starting dynamic subtest: pipe-B-plane-0 [561.949180] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s) [561.960646] Starting dynamic subtest: pipe-B-plane-3 [562.216103] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s) [562.227500] Starting dynamic subtest: pipe-B-plane-5 [562.232800] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [562.527325] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.520s) [563.344480] [117/133] (468s left) api_intel_allocator (reloc-allocator) [563.400360] Starting subtest: reloc-allocator [563.403314] Starting dynamic subtest: basic [563.406263] Dynamic subtest basic: SUCCESS (0.003s) [563.419625] Starting dynamic subtest: parallel-one [563.422435] Dynamic subtest parallel-one: SUCCESS (0.006s) [563.433345] Starting dynamic subtest: print [563.435923] Dynamic subtest print: SUCCESS (0.000s) [563.446144] Starting dynamic subtest: reuse [563.448488] Dynamic subtest reuse: SUCCESS (0.000s) [563.459309] Starting dynamic subtest: fork-reopen-allocator [563.461895] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [563.464266] Subtest reloc-allocator: SUCCESS (0.024s) [563.543257] [118/133] (468s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [563.622807] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [572.262100] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.637s) [572.363120] [119/133] (459s left) gem_exec_reloc (basic-gtt-cpu) [572.420308] Subtest basic-gtt-cpu: SKIP (0.000s) [572.485777] [120/133] (459s left) kms_chamelium_hpd (dp-hpd-fast) [572.856636] Subtest dp-hpd-fast: SKIP (0.000s) [573.693911] [121/133] (458s left) kms_content_protection (legacy) [573.819442] Starting subtest: legacy [573.824768] Subtest legacy: SKIP (0.000s) [573.935135] [122/133] (458s left) kms_atomic_transition (plane-all-transition-fencing) [574.005004] Starting subtest: plane-all-transition-fencing [574.007332] Starting dynamic subtest: pipe-A-eDP-1 [576.500158] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [576.809105] Starting dynamic subtest: pipe-B-eDP-1 [580.037624] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.242s) [580.343466] Subtest plane-all-transition-fencing: SUCCESS (6.336s) [581.154607] [123/133] (450s left) kms_properties (connector-properties-legacy) [581.232240] Starting subtest: connector-properties-legacy [581.234977] Starting dynamic subtest: pipe-A-eDP-1 [589.172131] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.948s) [589.183653] Starting dynamic subtest: pipe-None-DP-1 [589.188596] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [589.199477] Starting dynamic subtest: pipe-None-DP-2 [589.204468] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [589.215136] Starting dynamic subtest: pipe-None-DP-3 [589.220140] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [589.230368] Starting dynamic subtest: pipe-None-DP-4 [589.235093] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [589.245291] Starting dynamic subtest: pipe-None-DP-5 [589.250341] Dynamic subtest pipe-None-DP-5: SUCCESS (0.001s) [589.253057] Subtest connector-properties-legacy: SUCCESS (7.957s) [590.046701] [124/133] (442s left) drm_mm (drm_mm) [590.085853] Starting subtest: drm_mm [590.107435] Starting dynamic subtest: drm_test_mm_init [590.201001] Dynamic subtest drm_test_mm_init: SUCCESS (0.093s) [590.211330] Starting dynamic subtest: drm_test_mm_debug [590.291177] Dynamic subtest drm_test_mm_debug: SUCCESS (0.090s) [590.301968] Starting dynamic subtest: drm_test_mm_align32 [590.375147] Dynamic subtest drm_test_mm_align32: SUCCESS (0.080s) [590.385801] Starting dynamic subtest: drm_test_mm_align64 [590.467237] Dynamic subtest drm_test_mm_align64: SUCCESS (0.090s) [590.478213] Starting dynamic subtest: drm_test_mm_lowest [590.560745] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.095s) [590.571453] Starting dynamic subtest: drm_test_mm_highest [590.652924] Dynamic subtest drm_test_mm_highest: SUCCESS (0.088s) [590.655454] Subtest drm_mm: SUCCESS (0.565s) [590.796165] [125/133] (441s left) gem_ctx_persistence (engines-persistence) [590.856215] Starting subtest: engines-persistence [590.858882] Starting dynamic subtest: rcs0 [591.671840] Dynamic subtest rcs0: SUCCESS (0.818s) [591.686130] Starting dynamic subtest: bcs0 [592.433838] Dynamic subtest bcs0: SUCCESS (0.760s) [592.447965] Starting dynamic subtest: vcs0 [593.197724] Dynamic subtest vcs0: SUCCESS (0.762s) [593.212285] Starting dynamic subtest: vcs1 [593.974729] Dynamic subtest vcs1: SUCCESS (0.775s) [593.989463] Starting dynamic subtest: vecs0 [594.751714] Dynamic subtest vecs0: SUCCESS (0.775s) [594.765601] Starting dynamic subtest: ccs0 [595.510744] Dynamic subtest ccs0: SUCCESS (0.757s) [595.513491] Subtest engines-persistence: SUCCESS (4.661s) [595.592697] [126/133] (436s left) perf_pmu (pmu-read) [595.635356] Starting subtest: pmu-read [595.638012] Subtest pmu-read: SUCCESS (0.002s) [595.724966] [127/133] (436s left) kms_psr (fbc-psr-primary-page-flip) [595.794271] Starting subtest: fbc-psr-primary-page-flip [595.796758] Starting dynamic subtest: eDP-1 [595.801384] Dynamic subtest eDP-1: SKIP (0.000s) [595.806307] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [595.868153] [128/133] (436s left) i915_drm_fdinfo (virtual-busy-hang-all) [595.908274] Starting subtest: virtual-busy-hang-all [595.913870] Subtest virtual-busy-hang-all: SKIP (0.000s) [595.981993] [129/133] (436s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [596.073220] Starting subtest: cursorA-vs-flipA-legacy [607.188696] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.116s) [608.053489] [130/133] (424s left) gem_userptr_blits (huge-split) [608.125977] Starting subtest: huge-split [608.132141] Subtest huge-split: SUCCESS (0.006s) [608.246756] [131/133] (424s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [608.299775] Starting subtest: etime-single-wait-for-submit-unsubmitted [608.404708] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.105s) [608.484754] [132/133] (423s left) gem_busy (parallel) [608.670341] Starting subtest: parallel [608.672875] Starting dynamic subtest: rcs0 [610.231859] Dynamic subtest rcs0: SUCCESS (1.563s) [610.246474] Starting dynamic subtest: bcs0 [612.216716] Dynamic subtest bcs0: SUCCESS (1.982s) [612.230985] Starting dynamic subtest: vcs0 [614.199874] Dynamic subtest vcs0: SUCCESS (1.981s) [614.213997] Starting dynamic subtest: vcs1 [616.184320] Dynamic subtest vcs1: SUCCESS (1.981s) [616.200384] Starting dynamic subtest: vecs0 [618.168677] Dynamic subtest vecs0: SUCCESS (1.981s) [618.185140] Starting dynamic subtest: ccs0 [620.216741] Dynamic subtest ccs0: SUCCESS (2.046s) [620.219800] Subtest parallel: SUCCESS (11.551s) [620.452315] [133/133] (412s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [620.543624] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [620.548775] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [620.638265] Closing watchdogs results: parsing output: 0/ for test: kms_rotation_crc results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: gem_mmap_gtt results: parsing output: 4/ for test: kms_plane results: parsing output: 5/ for test: gen9_exec_parse results: parsing output: 6/ for test: kms_psr results: parsing output: 7/ for test: i915_query results: parsing output: 8/ for test: gem_exec_reloc results: parsing output: 9/ for test: i915_drm_fdinfo results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_flip results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: kms_async_flips results: parsing output: 14/ for test: kms_setmode results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: kms_atomic_transition results: parsing output: 18/ for test: kms_psr2_su results: parsing output: 19/ for test: kms_chamelium_audio results: parsing output: 20/ for test: kms_addfb_basic results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_hdr results: parsing output: 23/ for test: syncobj_wait results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: gem_exec_reloc results: parsing output: 26/ for test: gem_exec_fence results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_plane_cursor results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_exec_reloc results: parsing output: 32/ for test: kms_plane_alpha_blend results: parsing output: 33/ for test: perf results: parsing output: 34/ for test: kms_ccs results: parsing output: 35/ for test: gem_render_copy results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_setmode results: parsing output: 38/ for test: kms_big_fb results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: syncobj_basic results: parsing output: 41/ for test: gem_lmem_swapping results: parsing output: 42/ for test: kms_cursor_legacy results: parsing output: 43/ for test: sysfs_preempt_timeout results: parsing output: 44/ for test: gem_userptr_blits results: parsing output: 45/ for test: gem_exec_balancer results: parsing output: 46/ for test: kms_vblank results: parsing output: 47/ for test: gem_exec_fence results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: prime_mmap_kms results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_exec_reloc results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_chamelium_frames results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_spin_batch results: parsing output: 61/ for test: kms_setmode results: parsing output: 62/ for test: gem_eio results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_exec_schedule results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: gem_exercise_blt results: parsing output: 68/ for test: kms_universal_plane results: parsing output: 69/ for test: kms_atomic results: parsing output: 70/ for test: kms_ccs results: parsing output: 71/ for test: kms_cursor_crc results: parsing output: 72/ for test: kms_plane_scaling results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_color results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: kms_flip results: parsing output: 79/ for test: kms_flip_scaled_crc results: parsing output: 80/ for test: gem_eio results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: kms_atomic_interruptible results: parsing output: 83/ for test: kms_pm_rpm results: parsing output: 84/ for test: kms_pm_rpm results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: template results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: prime_vgem results: parsing output: 91/ for test: kms_rotation_crc results: parsing output: 92/ for test: syncobj_basic results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_dsc results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: kms_psr2_sf results: parsing output: 97/ for test: kms_lease results: parsing output: 98/ for test: syncobj_wait results: parsing output: 99/ for test: gem_exec_schedule results: parsing output: 100/ for test: i915_pm_rpm results: parsing output: 101/ for test: gem_ctx_shared results: parsing output: 102/ for test: gem_exec_whisper results: parsing output: 103/ for test: kms_cursor_crc results: parsing output: 104/ for test: gem_exec_fence results: parsing output: 105/ for test: gem_ctx_engines results: parsing output: 106/ for test: kms_invalid_mode results: parsing output: 107/ for test: gem_userptr_blits results: parsing output: 108/ for test: core_auth results: parsing output: 109/ for test: gem_mmap_gtt results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_pxp results: parsing output: 113/ for test: gem_render_copy results: parsing output: 114/ for test: gem_ctx_persistence results: parsing output: 115/ for test: kms_plane results: parsing output: 116/ for test: api_intel_allocator results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_exec_reloc results: parsing output: 119/ for test: kms_chamelium_hpd results: parsing output: 120/ for test: kms_content_protection results: parsing output: 121/ for test: kms_atomic_transition results: parsing output: 122/ for test: kms_properties results: parsing output: 123/ for test: drm_mm results: parsing output: 124/ for test: gem_ctx_persistence results: parsing output: 125/ for test: perf_pmu results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: i915_drm_fdinfo results: parsing output: 128/ for test: kms_cursor_legacy results: parsing output: 129/ for test: gem_userptr_blits results: parsing output: 130/ for test: syncobj_timeline results: parsing output: 131/ for test: gem_busy results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.