[56.874669] Initializing watchdogs
[56.874795]   /dev/watchdog0
[56.889659] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.894187] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.896873] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.899955] [001/133] (960s left) gem_exec_reloc (basic-gtt)
[56.984097] Subtest basic-gtt: SKIP (0.000s)
[57.054274] [002/133] (960s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[57.191681] Starting subtest: basic-flip-after-cursor-legacy
[58.170384] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.977s)
[58.977737] [003/133] (958s left) sysfs_timeslice_duration (duration)
[59.042496] Starting subtest: duration
[59.044820] Starting dynamic subtest: vecs0
[72.883569] Dynamic subtest vecs0: SUCCESS (13.841s)
[72.892387] Starting dynamic subtest: ccs0
[86.023270] Dynamic subtest ccs0: SUCCESS (13.139s)
[86.032442] Starting dynamic subtest: vcs0
[99.826798] Dynamic subtest vcs0: SUCCESS (13.800s)
[99.837268] Starting dynamic subtest: bcs0
[112.967815] Dynamic subtest bcs0: SUCCESS (13.141s)
[112.977626] Starting dynamic subtest: rcs0
[126.123329] Dynamic subtest rcs0: SUCCESS (13.153s)
[126.133284] Starting dynamic subtest: vcs1
[139.826650] Dynamic subtest vcs1: SUCCESS (13.701s)
[139.829613] Subtest duration: SUCCESS (80.784s)
[139.915682] [004/133] (877s left) kms_vblank (ts-continuation-dpms-rpm)
[140.014862] Starting subtest: ts-continuation-dpms-rpm
[140.017375] Starting dynamic subtest: pipe-A-eDP-1
[142.556055] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.538s)
[142.569116] Starting dynamic subtest: pipe-D-eDP-1
[144.812867] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s)
[144.814996] Subtest ts-continuation-dpms-rpm: SUCCESS (4.795s)
[145.709698] [005/133] (871s left) api_intel_bb (reset-flags)
[145.761679] Starting subtest: reset-flags
[145.767669] Subtest reset-flags: SUCCESS (0.008s)
[145.875089] [006/133] (871s left) gem_exec_balancer (parallel-balancer)
[146.141196] Starting subtest: parallel-balancer
[147.074277] Subtest parallel-balancer: SUCCESS (0.933s)
[147.176888] [007/133] (870s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[147.268807] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[147.271166] Starting dynamic subtest: pipe-A
[147.330774] Dynamic subtest pipe-A: SUCCESS (0.064s)
[147.339659] Starting dynamic subtest: pipe-B
[148.522654] Dynamic subtest pipe-B: SUCCESS (1.189s)
[148.532711] Starting dynamic subtest: pipe-C
[149.638687] Dynamic subtest pipe-C: SUCCESS (1.118s)
[149.647683] Starting dynamic subtest: pipe-D
[150.761468] Dynamic subtest pipe-D: SUCCESS (1.123s)
[150.763868] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.495s)
[151.925876] [008/133] (865s left) gem_userptr_blits (sync-unmap-after-close)
[151.999669] Starting subtest: sync-unmap-after-close
[152.009705] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[152.158156] [009/133] (865s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[152.265602] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[152.267975] Starting dynamic subtest: pipe-A-default-mode
[155.008961] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[155.011222] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.742s)
[155.838230] [010/133] (861s left) gem_exec_reloc (basic-concurrent0)
[155.895406] Subtest basic-concurrent0: SKIP (0.000s)
[155.960043] [011/133] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[156.070592] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[156.075027] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[156.161639] [012/133] (861s left) kms_properties (invalid-properties-atomic)
[156.253088] Starting subtest: invalid-properties-atomic
[156.562812] Subtest invalid-properties-atomic: SUCCESS (0.310s)
[156.644347] [013/133] (861s left) kms_flip (modeset-vs-vblank-race-interruptible)
[156.740268] Starting subtest: modeset-vs-vblank-race-interruptible
[156.742648] Starting dynamic subtest: A-eDP1
[161.456586] Dynamic subtest A-eDP1: SUCCESS (4.715s)
[161.466700] Starting dynamic subtest: B-eDP1
[166.105915] Dynamic subtest B-eDP1: SUCCESS (4.647s)
[166.115824] Starting dynamic subtest: C-eDP1
[170.652805] Dynamic subtest C-eDP1: SUCCESS (4.545s)
[170.661445] Starting dynamic subtest: D-eDP1
[175.179808] Dynamic subtest D-eDP1: SUCCESS (4.525s)
[175.185826] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.443s)
[176.343447] [014/133] (841s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[176.454053] Starting subtest: y-tiled-8bpp-rotate-0
[176.458387] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[176.534918] [015/133] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[176.649324] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[176.653809] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[176.739230] [016/133] (841s left) gem_exec_flush (basic-wb-set-default)
[176.804556] Starting subtest: basic-wb-set-default
[182.258257] Subtest basic-wb-set-default: SUCCESS (5.454s)
[182.453719] [017/133] (835s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[182.561028] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[186.455042] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.902s)
[187.662403] [018/133] (830s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[187.724186] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[187.833270] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[187.907021] [019/133] (830s left) prime_vgem (coherency-blt)
[188.023300] Starting subtest: coherency-blt
[189.113803] Subtest coherency-blt: SUCCESS (1.092s)
[189.252097] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[189.255555] [020/133] (828s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[189.349466] Starting subtest: fbc-modesetfrombusy
[193.205057] Subtest fbc-modesetfrombusy: SUCCESS (3.860s)
[194.394589] [021/133] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[194.492666] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[194.496827] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[194.598342] [022/133] (823s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[194.703974] Starting subtest: fbcpsr-rgb565-draw-blt
[201.703415] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.003s)
[201.840306] [023/133] (816s left) kms_properties (connector-properties-atomic)
[201.936018] Starting subtest: connector-properties-atomic
[201.938219] Starting dynamic subtest: pipe-A-eDP-1
[209.911772] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.974s)
[209.920674] Starting dynamic subtest: pipe-None-DP-1
[209.924904] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[209.931957] Starting dynamic subtest: pipe-None-HDMI-A-1
[209.936150] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[209.943293] Starting dynamic subtest: pipe-None-DP-2
[209.947203] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[209.953776] Starting dynamic subtest: pipe-None-HDMI-A-2
[209.957834] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[209.964519] Starting dynamic subtest: pipe-None-DP-3
[209.968621] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[209.975607] Starting dynamic subtest: pipe-None-DP-4
[209.980062] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[209.982360] Subtest connector-properties-atomic: SUCCESS (7.984s)
[210.768135] [024/133] (807s left) kms_big_fb (linear-16bpp-rotate-270)
[210.866889] Starting subtest: linear-16bpp-rotate-270
[210.886908] Subtest linear-16bpp-rotate-270: SKIP (0.020s)
[210.998432] [025/133] (807s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[211.099314] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[211.103620] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[211.201904] [026/133] (807s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[211.298682] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[215.872965] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.578s)
[217.078732] [027/133] (801s left) vgem_basic (mmap)
[217.132647] Starting subtest: mmap
[217.152865] Subtest mmap: SUCCESS (0.022s)
[217.209118] [028/133] (801s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[217.306677] Starting subtest: psr-rgb101010-draw-mmap-wc
[224.351235] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.048s)
[224.456556] [029/133] (794s left) kms_pm_backlight (fade)
[224.550664] Starting subtest: fade
[224.595835] Starting dynamic subtest: eDP-1
[227.075312] Dynamic subtest eDP-1: SUCCESS (2.477s)
[227.077606] Subtest fade: SUCCESS (2.526s)
[227.932360] [030/133] (790s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[228.030570] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[235.442198] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.414s)
[235.578255] [031/133] (783s left) perf (non-zero-reason)
[235.708975] Starting subtest: non-zero-reason
[235.711308] Starting dynamic subtest: 0-rcs0
[241.128405] Dynamic subtest 0-rcs0: SUCCESS (5.417s)
[241.140687] Starting dynamic subtest: 1-vecs0
[245.050394] Dynamic subtest 1-vecs0: SUCCESS (3.921s)
[245.053569] Subtest non-zero-reason: SUCCESS (9.340s)
[245.119127] [032/133] (773s left) gem_ccs (ctrl-surf-copy-new-ctx)
[245.181445] Starting subtest: ctrl-surf-copy-new-ctx
[245.186083] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[245.281142] [033/133] (773s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[245.399640] Starting subtest: 2x-long-cursor-vs-flip-atomic
[245.403921] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[245.546960] [034/133] (773s left) kms_chamelium_edid (hdmi-edid-read)
[245.928823] Subtest hdmi-edid-read: SKIP (0.000s)
[246.744461] [035/133] (772s left) perf_pmu (init-busy)
[246.791782] Starting subtest: init-busy
[246.794025] Starting dynamic subtest: rcs0
[246.796149] Dynamic subtest rcs0: SUCCESS (0.001s)
[246.804607] Starting dynamic subtest: bcs0
[246.806733] Dynamic subtest bcs0: SUCCESS (0.000s)
[246.814081] Starting dynamic subtest: vcs0
[246.816234] Dynamic subtest vcs0: SUCCESS (0.000s)
[246.823488] Starting dynamic subtest: vcs1
[246.825627] Dynamic subtest vcs1: SUCCESS (0.001s)
[246.832877] Starting dynamic subtest: vecs0
[246.834728] Dynamic subtest vecs0: SUCCESS (0.001s)
[246.842237] Starting dynamic subtest: ccs0
[246.844421] Dynamic subtest ccs0: SUCCESS (0.000s)
[246.846610] Subtest init-busy: SUCCESS (0.007s)
[246.886667] [036/133] (771s left) kms_plane (plane-position-hole-dpms)
[246.988239] Starting subtest: plane-position-hole-dpms
[247.523460] Starting dynamic subtest: pipe-A-plane-1
[249.966742] Dynamic subtest pipe-A-plane-1: SUCCESS (2.444s)
[249.975825] Starting dynamic subtest: pipe-A-plane-2
[252.322504] Dynamic subtest pipe-A-plane-2: SUCCESS (2.356s)
[252.331859] Starting dynamic subtest: pipe-A-plane-3
[254.701516] Dynamic subtest pipe-A-plane-3: SUCCESS (2.376s)
[254.709190] Starting dynamic subtest: pipe-A-plane-4
[257.064620] Dynamic subtest pipe-A-plane-4: SUCCESS (2.364s)
[257.073596] Starting dynamic subtest: pipe-A-plane-5
[257.091257] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[258.248303] Starting dynamic subtest: pipe-B-plane-1
[260.668849] Dynamic subtest pipe-B-plane-1: SUCCESS (2.425s)
[260.676646] Starting dynamic subtest: pipe-B-plane-2
[263.075734] Dynamic subtest pipe-B-plane-2: SUCCESS (2.406s)
[263.088249] Starting dynamic subtest: pipe-B-plane-3
[265.508493] Dynamic subtest pipe-B-plane-3: SUCCESS (2.434s)
[265.518071] Starting dynamic subtest: pipe-B-plane-4
[267.908502] Dynamic subtest pipe-B-plane-4: SUCCESS (2.396s)
[267.915833] Starting dynamic subtest: pipe-B-plane-5
[267.931809] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[267.934044] Subtest plane-position-hole-dpms: SUCCESS (20.944s)
[268.782986] [037/133] (750s left) kms_psr (fbc-psr-sprite-plane-move)
[268.876755] Starting subtest: fbc-psr-sprite-plane-move
[268.879067] Starting dynamic subtest: eDP-1
[268.883110] Dynamic subtest eDP-1: SKIP (0.000s)
[268.887130] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[268.950982] [038/133] (749s left) sw_sync (sync_busy_fork_unixsocket)
[268.990837] Starting subtest: sync_busy_fork_unixsocket
[268.998070] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[269.051702] [039/133] (749s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[269.152098] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[269.156066] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[269.244136] [040/133] (749s left) gem_exec_schedule (implicit-write-read)
[269.316383] Starting subtest: implicit-write-read
[269.318305] Starting dynamic subtest: rcs0
[269.428566] Dynamic subtest rcs0: SUCCESS (0.119s)
[269.440029] Starting dynamic subtest: vcs0
[269.509199] Dynamic subtest vcs0: SUCCESS (0.080s)
[269.520671] Starting dynamic subtest: vcs1
[269.591500] Dynamic subtest vcs1: SUCCESS (0.082s)
[269.601972] Starting dynamic subtest: vecs0
[269.668803] Dynamic subtest vecs0: SUCCESS (0.076s)
[269.681421] Starting dynamic subtest: ccs0
[269.750862] Dynamic subtest ccs0: SUCCESS (0.082s)
[269.753031] Subtest implicit-write-read: SUCCESS (0.442s)
[271.026483] [041/133] (747s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[271.079177] Starting subtest: saturated-hostile-nopreempt
[271.081082] Starting dynamic subtest: rcs0
[271.114737] Dynamic subtest rcs0: SKIP (0.033s)
[271.122272] Starting dynamic subtest: bcs0
[271.148378] Dynamic subtest bcs0: SKIP (0.033s)
[271.155739] Starting dynamic subtest: vcs0
[271.162667] Dynamic subtest vcs0: SKIP (0.011s)
[271.169923] Starting dynamic subtest: vcs1
[271.174799] Dynamic subtest vcs1: SKIP (0.012s)
[271.182440] Starting dynamic subtest: vecs0
[271.193705] Dynamic subtest vecs0: SKIP (0.019s)
[271.202157] Starting dynamic subtest: ccs0
[271.208894] Dynamic subtest ccs0: SKIP (0.014s)
[271.213261] Subtest saturated-hostile-nopreempt: SKIP (0.128s)
[271.281622] [042/133] (747s left) kms_content_protection (mei-interface)
[271.442563] Starting subtest: mei-interface
[271.447262] Subtest mei-interface: SKIP (0.002s)
[271.561058] [043/133] (747s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[271.693159] Starting subtest: 2x-flip-vs-cursor-legacy
[271.701444] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.003s)
[271.847173] [044/133] (747s left) gem_exec_whisper (basic-contexts-forked)
[271.908814] Starting subtest: basic-contexts-forked
[295.685914] Subtest basic-contexts-forked: SUCCESS (23.771s)
[295.870610] [045/133] (723s left) gem_exec_balancer (sequential)
[295.944146] Starting subtest: sequential
[299.056540] Subtest sequential: SUCCESS (3.112s)
[299.370199] [046/133] (719s left) gem_basic (bad-close)
[299.418990] Starting subtest: bad-close
[299.423413] Subtest bad-close: SUCCESS (0.000s)
[299.530630] [047/133] (719s left) syncobj_timeline (wait-all-delayed-signal)
[299.603589] Starting subtest: wait-all-delayed-signal
[299.702276] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[299.785046] [048/133] (719s left) kms_psr (psr2-primary-page-flip)
[299.891785] Starting subtest: psr2-primary-page-flip
[299.894095] Starting dynamic subtest: eDP-1
[301.584177] Dynamic subtest eDP-1: SUCCESS (1.691s)
[301.586312] Subtest psr2-primary-page-flip: SUCCESS (1.692s)
[302.461776] [049/133] (716s left) kms_cursor_crc (cursor-onscreen-128x42)
[302.687252] Starting subtest: cursor-onscreen-128x42
[302.733744] Subtest cursor-onscreen-128x42: SKIP (0.043s)
[302.938560] [050/133] (716s left) gem_mmap (big-bo)
[302.995612] Subtest big-bo: SKIP (0.000s)
[303.051533] [051/133] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[303.145519] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[303.149887] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[303.257116] [052/133] (716s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[303.354429] Starting subtest: bad-aux-stride-yf-tiled-ccs
[303.356671] Starting dynamic subtest: pipe-A-eDP-1
[303.379178] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[303.388887] Starting dynamic subtest: pipe-B-eDP-1
[303.407167] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[303.414278] Starting dynamic subtest: pipe-C-eDP-1
[303.432866] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[303.439999] Starting dynamic subtest: pipe-D-eDP-1
[303.457787] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[303.461263] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[305.618696] [053/133] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[305.723073] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[305.727212] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[305.837398] [054/133] (713s left) kms_cursor_edge_walk (256x256-top-edge)
[305.940476] Starting subtest: 256x256-top-edge
[305.942937] Starting dynamic subtest: pipe-A-eDP-1
[309.392855] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.450s)
[309.401798] Starting dynamic subtest: pipe-D-eDP-1
[312.504603] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[312.506904] Subtest 256x256-top-edge: SUCCESS (6.564s)
[313.326126] [055/133] (706s left) syncobj_timeline (device-signal-unordered)
[313.384830] Starting subtest: device-signal-unordered
[313.387125] Subtest device-signal-unordered: SUCCESS (0.000s)
[313.494205] [056/133] (706s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[313.594056] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[313.598421] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[313.668024] [057/133] (705s left) gem_lmem_swapping (parallel-multi)
[313.713712] Subtest parallel-multi: SKIP (0.000s)
[313.752621] [058/133] (705s left) i915_suspend (basic-s2idle-without-i915)
[313.796332] Starting subtest: basic-s2idle-without-i915
[333.926688] Subtest basic-s2idle-without-i915: SUCCESS (4.562s)
[342.056258] [059/133] (685s left) kms_lease (empty-lease)
[342.177675] Starting subtest: empty-lease
[342.180014] Starting dynamic subtest: pipe-A-eDP-1
[342.182384] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[342.190437] Starting dynamic subtest: pipe-B-eDP-1
[342.192283] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[342.200088] Starting dynamic subtest: pipe-C-eDP-1
[342.202224] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[342.209804] Starting dynamic subtest: pipe-D-eDP-1
[342.211890] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[342.214040] Subtest empty-lease: SUCCESS (0.010s)
[342.299200] [060/133] (685s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[342.418462] Starting subtest: cursor-vs-flip-varying-size
[373.423536] Subtest cursor-vs-flip-varying-size: SUCCESS (30.994s)
[374.278609] [061/133] (653s left) gem_exec_flush (basic-wb-ro-default)
[374.350501] Starting subtest: basic-wb-ro-default
[379.810007] Subtest basic-wb-ro-default: SUCCESS (5.459s)
[379.999207] [062/133] (647s left) gem_vm_create (create-ext)
[380.059322] Starting subtest: create-ext
[380.067772] Subtest create-ext: SUCCESS (0.009s)
[380.185070] [063/133] (647s left) kms_pwrite_crc
[381.807296] [064/133] (646s left) kms_addfb_basic (addfb25-4-tiled)
[381.908619] Starting subtest: addfb25-4-tiled
[381.910586] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[382.023228] [065/133] (645s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[382.078708] Starting subtest: invalid-bsd2-flag-on-vebox
[382.081107] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[382.185796] [066/133] (645s left) syncobj_wait (wait-for-submit-delayed-submit)
[382.241158] Starting subtest: wait-for-submit-delayed-submit
[382.343835] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[382.422345] [067/133] (645s left) gem_shrink (reclaim)
[382.484450] Starting subtest: reclaim
[384.882303] Subtest reclaim: SUCCESS (2.397s)
[385.018948] [068/133] (643s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[385.121205] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[385.123414] Starting dynamic subtest: pipe-A-eDP-1
[385.217460] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[385.227605] Starting dynamic subtest: pipe-B-eDP-1
[386.385993] Dynamic subtest pipe-B-eDP-1: SKIP (1.167s)
[386.390354] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.269s)
[387.571478] [069/133] (640s left) kms_pipe_crc_basic (suspend-read-crc)
[387.679805] Starting subtest: suspend-read-crc
[387.682021] Starting dynamic subtest: pipe-A-eDP-1
[405.394085] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.974s)
[405.403473] Starting dynamic subtest: pipe-B-eDP-1
[424.384079] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.525s)
[424.396637] Starting dynamic subtest: pipe-C-eDP-1
[443.378435] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.477s)
[443.389066] Starting dynamic subtest: pipe-D-eDP-1
[462.354082] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.444s)
[462.356370] Subtest suspend-read-crc: SUCCESS (13.427s)
[472.196787] [070/133] (565s left) kms_psr (pr-cursor-blt)
[472.299365] Starting subtest: pr-cursor-blt
[472.303731] Subtest pr-cursor-blt: SKIP (0.000s)
[472.370968] [071/133] (564s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[472.473108] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[472.475341] Starting dynamic subtest: pipe-A-eDP-1
[472.497200] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[472.506956] Starting dynamic subtest: pipe-B-eDP-1
[472.526718] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[472.534146] Starting dynamic subtest: pipe-C-eDP-1
[472.554797] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[472.562214] Starting dynamic subtest: pipe-D-eDP-1
[472.583643] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[472.587782] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[474.739149] [072/133] (562s left) gem_ctx_persistence (engines-mixed)
[474.793847] Starting subtest: engines-mixed
[474.796097] Starting dynamic subtest: rcs0
[474.870474] Dynamic subtest rcs0: SUCCESS (0.079s)
[474.881422] Starting dynamic subtest: bcs0
[474.940544] Dynamic subtest bcs0: SUCCESS (0.068s)
[474.951796] Starting dynamic subtest: vcs0
[475.003425] Dynamic subtest vcs0: SUCCESS (0.061s)
[475.014387] Starting dynamic subtest: vcs1
[475.067409] Dynamic subtest vcs1: SUCCESS (0.062s)
[475.079410] Starting dynamic subtest: vecs0
[475.099971] Dynamic subtest vecs0: SUCCESS (0.031s)
[475.109069] Starting dynamic subtest: ccs0
[475.182238] Dynamic subtest ccs0: SUCCESS (0.081s)
[475.184785] Subtest engines-mixed: SUCCESS (0.392s)
[475.273921] [073/133] (562s left) kms_frontbuffer_tracking (fbc-stridechange)
[475.366991] Starting subtest: fbc-stridechange
[478.642066] Subtest fbc-stridechange: SUCCESS (3.274s)
[479.748743] [074/133] (557s left) kms_psr (psr-cursor-render)
[479.856798] Starting subtest: psr-cursor-render
[479.859136] Starting dynamic subtest: eDP-1
[481.540022] Dynamic subtest eDP-1: SUCCESS (1.683s)
[481.542365] Subtest psr-cursor-render: SUCCESS (1.684s)
[482.402280] [075/133] (555s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[482.518197] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[482.520570] Starting dynamic subtest: pipe-A-eDP-1
[482.540732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[482.549858] Starting dynamic subtest: pipe-B-eDP-1
[482.569452] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[482.578065] Starting dynamic subtest: pipe-C-eDP-1
[482.597074] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[482.607520] Starting dynamic subtest: pipe-D-eDP-1
[482.627056] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[482.629250] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[484.773346] [076/133] (552s left) kms_debugfs (display-off-read-all)
[484.883048] Starting subtest: display-off-read-all
[485.182039] Subtest display-off-read-all: SUCCESS (0.299s)
[485.996500] [077/133] (551s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[486.079573] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[486.081873] Starting dynamic subtest: pipe-A-eDP-1
[487.441955] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.360s)
[487.733197] Starting dynamic subtest: pipe-B-eDP-1
[488.780183] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[489.054012] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.974s)
[489.883598] [078/133] (547s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[489.983485] Starting subtest: psr-farfromfence-mmap-gtt
[489.987586] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[490.097432] [079/133] (547s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[490.185691] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[490.187913] Starting dynamic subtest: pipe-A-eDP-1
[490.243827] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[490.253454] Starting dynamic subtest: pipe-B-eDP-1
[490.308488] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[490.318695] Starting dynamic subtest: pipe-C-eDP-1
[490.375806] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[490.385891] Starting dynamic subtest: pipe-D-eDP-1
[490.443737] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[490.447992] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[492.661126] [080/133] (544s left) kms_feature_discovery (psr1)
[492.760381] Starting subtest: psr1
[492.762635] Subtest psr1: SUCCESS (0.000s)
[492.857694] [081/133] (544s left) core_setmaster (master-drop-set-root)
[492.925390] Starting subtest: master-drop-set-root
[492.950618] Subtest master-drop-set-root: SUCCESS (0.025s)
[493.000243] [082/133] (544s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[493.097196] Starting subtest: 4-tiled-addfb-size-offset-overflow
[493.099521] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[493.192497] [083/133] (544s left) kms_vblank (crtc-id)
[493.283871] Starting subtest: crtc-id
[493.286052] Starting dynamic subtest: pipe-A-eDP-1
[493.740062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s)
[493.754365] Starting dynamic subtest: pipe-D-eDP-1
[494.905131] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.163s)
[494.907496] Subtest crtc-id: SUCCESS (1.623s)
[495.739188] [084/133] (542s left) gem_mmap_gtt (cpuset-big-copy-xy)
[495.808490] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[495.874751] [085/133] (541s left) gem_mmap_offset (open-flood)
[495.922194] Starting subtest: open-flood
[517.415716] Subtest open-flood: SUCCESS (21.489s)
[517.523508] [086/133] (520s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[517.583344] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[517.639467] [087/133] (520s left) api_intel_allocator (open-vm)
[517.690510] Starting subtest: open-vm
[517.694386] Subtest open-vm: SUCCESS (0.004s)
[517.823298] [088/133] (520s left) i915_drm_fdinfo (busy)
[517.860747] Starting subtest: busy
[517.862384] Starting dynamic subtest: rcs0
[517.884005] Dynamic subtest rcs0: SKIP (0.023s)
[517.895513] Starting dynamic subtest: bcs0
[517.899547] Dynamic subtest bcs0: SKIP (0.000s)
[517.908009] Starting dynamic subtest: vcs0
[517.911867] Dynamic subtest vcs0: SKIP (0.000s)
[517.922331] Starting dynamic subtest: vcs1
[517.925983] Dynamic subtest vcs1: SKIP (0.000s)
[517.934192] Starting dynamic subtest: vecs0
[517.937772] Dynamic subtest vecs0: SKIP (0.000s)
[517.945805] Starting dynamic subtest: ccs0
[517.949321] Dynamic subtest ccs0: SKIP (0.000s)
[517.952893] Subtest busy: SKIP (0.027s)
[517.999926] [089/133] (519s left) gem_spin_batch (legacy-resubmit)
[518.051049] Starting subtest: legacy-resubmit
[518.053042] Starting dynamic subtest: default
[518.060977] Dynamic subtest default: SUCCESS (0.009s)
[518.070727] Starting dynamic subtest: render
[518.073459] Dynamic subtest render: SUCCESS (0.002s)
[518.082255] Starting dynamic subtest: bsd
[518.084299] Dynamic subtest bsd: SUCCESS (0.003s)
[518.092373] Starting dynamic subtest: bsd1
[518.094318] Dynamic subtest bsd1: SUCCESS (0.003s)
[518.102415] Starting dynamic subtest: bsd2
[518.104477] Dynamic subtest bsd2: SUCCESS (0.001s)
[518.112454] Starting dynamic subtest: blt
[518.114358] Dynamic subtest blt: SUCCESS (0.005s)
[518.122369] Starting dynamic subtest: vebox
[518.124316] Dynamic subtest vebox: SUCCESS (0.004s)
[518.126194] Subtest legacy-resubmit: SUCCESS (0.032s)
[518.307834] [090/133] (519s left) kms_cursor_crc (cursor-random-512x512)
[518.568083] Starting subtest: cursor-random-512x512
[518.571841] Subtest cursor-random-512x512: SKIP (0.001s)
[518.715846] [091/133] (519s left) gem_ctx_engines (execute-oneforall)
[518.785854] Starting subtest: execute-oneforall
[519.317099] Subtest execute-oneforall: SUCCESS (0.531s)
[520.847888] [092/133] (517s left) gem_ctx_sseu (invalid-sseu)
[520.901367] Subtest invalid-sseu: SKIP (0.000s)
[520.970912] [093/133] (517s left) gen7_exec_parse (chained-batch)
[521.029227] Subtest chained-batch: SKIP (0.000s)
[521.098308] [094/133] (517s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[521.221327] Starting subtest: cursorA-vs-flipA-toggle
[532.363963] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.137s)
[533.186251] [095/133] (505s left) kms_atomic_transition (plane-toggle-modeset-transition)
[533.290846] Starting subtest: plane-toggle-modeset-transition
[533.293055] Starting dynamic subtest: pipe-A-eDP-1
[546.051417] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.758s)
[546.064197] Starting dynamic subtest: pipe-B-eDP-1
[558.501492] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.443s)
[558.503845] Subtest plane-toggle-modeset-transition: SUCCESS (25.206s)
[559.316959] [096/133] (478s left) syncobj_basic (bad-flags-fd-to-handle)
[559.375195] Starting subtest: bad-flags-fd-to-handle
[559.377494] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[559.495765] [097/133] (478s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[559.583595] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[559.585836] Starting dynamic subtest: pipe-A-eDP-1
[560.478311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.887s)
[560.487594] Starting dynamic subtest: pipe-B-eDP-1
[562.138454] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.657s)
[562.150943] Starting dynamic subtest: pipe-C-eDP-1
[563.648238] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.506s)
[563.657935] Starting dynamic subtest: pipe-D-eDP-1
[565.186914] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.537s)
[565.189257] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.593s)
[566.361459] [098/133] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[566.482468] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[566.486654] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[566.589245] [099/133] (471s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[566.686626] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[566.690676] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[566.759902] [100/133] (471s left) i915_pm_rpm (gem-execbuf)
[568.885910] Starting subtest: gem-execbuf
[568.888903] Starting dynamic subtest: smem0
[570.907073] Dynamic subtest smem0: SUCCESS (2.020s)
[570.909462] Subtest gem-execbuf: SUCCESS (2.022s)
[570.992300] [101/133] (467s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[571.066754] Starting subtest: y-tiled-to-vebox-yf-tiled
[571.071217] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[571.251045] [102/133] (467s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[571.349011] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[571.353422] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[571.445376] [103/133] (467s left) kms_color (gamma)
[571.543778] Starting subtest: gamma
[571.545663] Starting dynamic subtest: pipe-A-eDP-1
[572.261916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[572.271769] Starting dynamic subtest: pipe-B-eDP-1
[573.673070] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[573.683277] Starting dynamic subtest: pipe-C-eDP-1
[575.037946] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[575.047888] Starting dynamic subtest: pipe-D-eDP-1
[576.371160] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[576.373568] Subtest gamma: SUCCESS (4.832s)
[577.183730] [104/133] (461s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[577.313767] Starting subtest: protected-encrypted-src-copy-not-readible
[577.438887] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.127s)
[577.568428] [105/133] (461s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[577.613600] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[577.615933] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[577.710773] [106/133] (461s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[577.814683] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[577.818665] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[577.885753] [107/133] (460s left) i915_hangman (engine-engine-hang)
[577.944288] Starting subtest: engine-engine-hang
[577.946638] Starting dynamic subtest: rcs0
[579.712886] Dynamic subtest rcs0: SUCCESS (1.769s)
[579.725283] Starting dynamic subtest: bcs0
[581.695427] Dynamic subtest bcs0: SUCCESS (1.980s)
[581.707387] Starting dynamic subtest: vcs0
[583.679754] Dynamic subtest vcs0: SUCCESS (1.982s)
[583.691850] Starting dynamic subtest: vcs1
[585.663418] Dynamic subtest vcs1: SUCCESS (1.982s)
[585.675071] Starting dynamic subtest: vecs0
[587.647905] Dynamic subtest vecs0: SUCCESS (1.982s)
[587.660048] Starting dynamic subtest: ccs0
[589.631866] Dynamic subtest ccs0: SUCCESS (1.981s)
[589.634739] Subtest engine-engine-hang: SUCCESS (11.692s)
[589.713702] [108/133] (449s left) kms_invalid_mode (zero-clock)
[589.808974] Starting subtest: zero-clock
[589.811314] Starting dynamic subtest: pipe-A-eDP-1
[590.091483] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[590.101585] Starting dynamic subtest: pipe-B-eDP-1
[590.103757] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[590.111857] Starting dynamic subtest: pipe-C-eDP-1
[590.114302] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[590.122991] Starting dynamic subtest: pipe-D-eDP-1
[590.125489] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[590.127927] Subtest zero-clock: SUCCESS (0.292s)
[590.922257] [109/133] (447s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[591.024873] Starting subtest: plane-primary-overlay-mutable-zpos
[594.459623] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.435s)
[595.646856] [110/133] (443s left) gem_exec_schedule (smoketest)
[595.828228] Starting subtest: smoketest
[595.831021] Starting dynamic subtest: rcs0
[601.368520] Dynamic subtest rcs0: SUCCESS (5.491s)
[601.388361] Starting dynamic subtest: bcs0
[606.897089] Dynamic subtest bcs0: SUCCESS (5.521s)
[606.914169] Starting dynamic subtest: vcs0
[612.394842] Dynamic subtest vcs0: SUCCESS (5.497s)
[612.405985] Starting dynamic subtest: vcs1
[617.904620] Dynamic subtest vcs1: SUCCESS (5.491s)
[617.915594] Starting dynamic subtest: vecs0
[623.388135] Dynamic subtest vecs0: SUCCESS (5.501s)
[623.399612] Starting dynamic subtest: ccs0
[628.901604] Dynamic subtest ccs0: SUCCESS (5.511s)
[628.903622] Subtest smoketest: SUCCESS (33.023s)
[629.036798] [111/133] (409s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[629.101618] Starting subtest: invalid-single-wait-all-unsubmitted
[629.103825] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[629.215344] [112/133] (409s left) kms_flip (2x-blocking-wf_vblank)
[629.325814] Starting subtest: 2x-blocking-wf_vblank
[629.335002] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[629.417930] [113/133] (409s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[629.502716] Starting subtest: plane-all-modeset-transition-fencing
[629.506964] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[629.576467] [114/133] (409s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[629.671852] Starting subtest: x-tiled-8bpp-rotate-270
[629.693097] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[629.816591] [115/133] (409s left) syncobj_wait (invalid-reset-one-illegal-handle)
[629.873133] Starting subtest: invalid-reset-one-illegal-handle
[629.875158] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[629.999333] [116/133] (409s left) kms_universal_plane (universal-plane-sanity)
[630.087909] Starting subtest: universal-plane-sanity
[630.089664] Starting dynamic subtest: pipe-A-eDP-1
[630.688205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[630.697288] Starting dynamic subtest: pipe-B-eDP-1
[631.974242] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.282s)
[631.984097] Starting dynamic subtest: pipe-C-eDP-1
[633.180576] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.204s)
[633.190144] Starting dynamic subtest: pipe-D-eDP-1
[634.401574] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[634.403919] Subtest universal-plane-sanity: SUCCESS (4.314s)
[635.257260] [117/133] (403s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[635.354993] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[635.357364] Starting dynamic subtest: pipe-A-default-mode
[638.094035] Dynamic subtest pipe-A-default-mode: SUCCESS (2.739s)
[638.096507] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.741s)
[638.961488] [118/133] (400s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[639.050415] Starting subtest: fbc-pr-sprite-mmap-cpu
[639.054761] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[639.126950] [119/133] (400s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[639.227845] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[640.043109] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[640.214304] [120/133] (399s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[641.849509] Starting subtest: modeset-non-lpsp-stress-no-wait
[641.898470] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.050s)
[642.498322] [121/133] (396s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[642.592092] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[646.876045] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.287s)
[647.994798] [122/133] (391s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[648.090865] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[648.094812] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[648.188208] [123/133] (391s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[648.596489] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[649.398313] [124/133] (390s left) gem_exec_fence (syncobj-timeline-chain-engines)
[650.017473] Starting subtest: syncobj-timeline-chain-engines
[650.123453] Subtest syncobj-timeline-chain-engines: SUCCESS (0.106s)
[651.825613] [125/133] (387s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[651.920971] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[659.389563] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.470s)
[659.503876] [126/133] (380s left) kms_chamelium_color (ctm-0-50)
[659.599820] Subtest ctm-0-50: SKIP (0.000s)
[659.647140] [127/133] (379s left) gem_ppgtt (shrink-vs-evict-pinned)
[659.699582] Starting subtest: shrink-vs-evict-pinned
[666.743447] Subtest shrink-vs-evict-pinned: SUCCESS (7.040s)
[666.862488] [128/133] (372s left) syncobj_basic (bad-pad-fd-to-handle)
[666.922196] Starting subtest: bad-pad-fd-to-handle
[666.924186] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[667.019730] [129/133] (372s left) gem_ctx_bad_destroy (invalid-ctx)
[667.068018] Starting subtest: invalid-ctx
[667.070331] Subtest invalid-ctx: SUCCESS (0.000s)
[667.144905] [130/133] (372s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[667.251852] Starting subtest: psr2-overlay-plane-update-continuous-sf
[667.254073] Starting dynamic subtest: pipe-A-eDP-1
[668.375650] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.126s)
[668.385117] Starting dynamic subtest: pipe-B-eDP-1
[670.124960] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.750s)
[670.127411] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.879s)
[670.920908] [131/133] (368s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[671.038065] Starting subtest: cursorA-vs-flipB-atomic-transitions
[671.042608] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[671.183356] [132/133] (368s left) gem_pread (uncached)
[671.232735] Subtest uncached: SKIP (0.000s)
[671.292773] [133/133] (368s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[671.356151] Starting subtest: invalid-bsd2-flag-on-blt
[671.358727] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[671.462468] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: sysfs_timeslice_duration
results: parsing output: 3/ for test: kms_vblank
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_properties
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_flush
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: prime_vgem
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_properties
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: vgem_basic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_pm_backlight
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_ccs
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_chamelium_edid
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: sw_sync
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: kms_content_protection
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: gem_basic
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: gem_mmap
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: i915_suspend
results: parsing output: 58/ for test: kms_lease
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: gem_exec_flush
results: parsing output: 61/ for test: gem_vm_create
results: parsing output: 62/ for test: kms_pwrite_crc
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: gem_exec_params
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: gem_shrink
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_pipe_crc_basic
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_debugfs
results: parsing output: 76/ for test: kms_atomic_transition
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_feature_discovery
results: parsing output: 80/ for test: core_setmaster
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: kms_pipe_b_c_ivb
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: gem_ctx_engines
results: parsing output: 91/ for test: gem_ctx_sseu
results: parsing output: 92/ for test: gen7_exec_parse
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_atomic_transition
results: parsing output: 95/ for test: syncobj_basic
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: i915_pm_rpm
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_color
results: parsing output: 103/ for test: gem_pxp
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: i915_hangman
results: parsing output: 107/ for test: kms_invalid_mode
results: parsing output: 108/ for test: kms_atomic
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_atomic_transition
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_universal_plane
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_pm_rpm
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_color
results: parsing output: 126/ for test: gem_ppgtt
results: parsing output: 127/ for test: syncobj_basic
results: parsing output: 128/ for test: gem_ctx_bad_destroy
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: gem_pread
results: parsing output: 132/ for test: gem_exec_params
Done.