[57.839314] Initializing watchdogs
[57.839357]   /dev/watchdog0
[57.852942] [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]
[57.857127] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.859363] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.862534] [001/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[58.004634] Starting subtest: x-tiled-8bpp-rotate-270
[58.039209] Subtest x-tiled-8bpp-rotate-270: SKIP (0.034s)
[58.158067] [002/133] (960s left) kms_prop_blob (basic)
[58.218781] Starting subtest: basic
[58.221018] Subtest basic: SUCCESS (0.000s)
[58.315380] [003/133] (960s left) gen9_exec_parse (bb-large)
[58.367850] Subtest bb-large: SKIP (0.000s)
[58.431422] [004/133] (960s left) prime_vgem (fence-read-hang)
[58.544447] Subtest fence-read-hang: SKIP (0.000s)
[58.638997] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[58.641738] [005/133] (959s left) gem_userptr_blits (readonly-unsync)
[58.694759] Subtest readonly-unsync: SKIP (0.000s)
[58.797910] [006/133] (959s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[58.892078] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[58.893992] Starting dynamic subtest: pipe-A
[60.058305] Dynamic subtest pipe-A: SUCCESS (1.173s)
[60.066086] Starting dynamic subtest: pipe-B
[62.244604] Dynamic subtest pipe-B: SUCCESS (2.194s)
[62.252489] Starting dynamic subtest: pipe-C
[63.453305] Dynamic subtest pipe-C: SUCCESS (1.211s)
[63.462031] Starting dynamic subtest: pipe-D
[64.686873] Dynamic subtest pipe-D: SUCCESS (1.236s)
[64.689306] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.815s)
[65.889667] [007/133] (952s left) kms_psr (fbc-pr-sprite-blt)
[65.989183] Starting subtest: fbc-pr-sprite-blt
[65.993743] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[66.057450] [008/133] (952s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[66.164596] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[66.166797] Starting dynamic subtest: pipe-A-eDP-1
[66.240543] Dynamic subtest pipe-A-eDP-1: SKIP (0.080s)
[66.249597] Starting dynamic subtest: pipe-B-eDP-1
[67.374516] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[67.379244] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.217s)
[68.963440] [009/133] (949s left) kms_flip (2x-plain-flip-ts-check)
[69.062341] Starting subtest: 2x-plain-flip-ts-check
[69.072821] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[69.190013] [010/133] (949s left) gem_spin_batch (engines)
[69.250411] Starting subtest: engines
[69.252530] Starting dynamic subtest: rcs0
[72.488107] Dynamic subtest rcs0: SUCCESS (3.237s)
[72.496860] Starting dynamic subtest: bcs0
[75.720136] Dynamic subtest bcs0: SUCCESS (3.233s)
[75.728998] Starting dynamic subtest: vcs0
[78.954967] Dynamic subtest vcs0: SUCCESS (3.234s)
[78.967213] Starting dynamic subtest: vcs1
[82.190625] Dynamic subtest vcs1: SUCCESS (3.235s)
[82.198179] Starting dynamic subtest: vecs0
[85.424780] Dynamic subtest vecs0: SUCCESS (3.232s)
[85.433903] Starting dynamic subtest: ccs0
[88.660537] Dynamic subtest ccs0: SUCCESS (3.235s)
[88.663092] Subtest engines: SUCCESS (19.413s)
[88.899975] [011/133] (929s left) syncobj_timeline (wait-zero-handles)
[88.953185] Starting subtest: wait-zero-handles
[88.955456] Subtest wait-zero-handles: SUCCESS (0.000s)
[89.040855] [012/133] (929s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[89.148111] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[92.724603] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.582s)
[93.847435] [013/133] (924s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[93.958989] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[95.035785] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.078s)
[95.144801] [014/133] (923s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[95.243337] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[102.181272] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.938s)
[102.327640] [015/133] (916s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[102.384088] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[102.386545] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[102.473293] [016/133] (916s left) kms_big_fb (linear-16bpp-rotate-90)
[102.571983] Starting subtest: linear-16bpp-rotate-90
[102.590889] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[102.700324] [017/133] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[102.809493] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[110.433990] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.629s)
[110.558036] [018/133] (908s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[110.675154] Starting subtest: yf-tiled-64bpp-rotate-270
[110.679159] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[110.781830] [019/133] (908s left) perf (stress-open-close)
[110.920755] Starting subtest: stress-open-close
[110.923022] Starting dynamic subtest: 0-rcs0
[113.086497] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[113.093505] Starting dynamic subtest: 1-vcs0
[115.247807] Dynamic subtest 1-vcs0: SUCCESS (2.161s)
[115.249623] Subtest stress-open-close: SUCCESS (4.328s)
[115.291795] [020/133] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[115.392930] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[115.396390] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[115.496291] [021/133] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[115.583387] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[115.586857] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[115.674175] [022/133] (903s left) kms_psr (psr2-cursor-mmap-gtt)
[115.759409] Starting subtest: psr2-cursor-mmap-gtt
[115.761288] Starting dynamic subtest: eDP-1
[117.468963] Dynamic subtest eDP-1: SUCCESS (1.711s)
[117.471369] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.711s)
[118.292142] [023/133] (900s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[118.396410] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[118.400593] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[118.499828] [024/133] (900s left) kms_addfb_basic (bo-too-small)
[118.589237] Starting subtest: bo-too-small
[118.591180] Subtest bo-too-small: SUCCESS (0.000s)
[118.686095] [025/133] (900s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[118.773638] Starting subtest: bad-aux-stride-y-tiled-ccs
[118.776031] Starting dynamic subtest: pipe-A-eDP-1
[118.799836] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[118.808679] Starting dynamic subtest: pipe-B-eDP-1
[118.829578] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[118.836886] Starting dynamic subtest: pipe-C-eDP-1
[118.858304] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[118.865697] Starting dynamic subtest: pipe-D-eDP-1
[118.887690] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[118.891749] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s)
[121.033754] [026/133] (898s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[121.132860] Starting subtest: pr-primary-plane-update-sf-dmg-area
[121.137294] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[121.200419] [027/133] (898s left) gem_exec_whisper (basic-contexts-priority-all)
[121.265718] Starting subtest: basic-contexts-priority-all
[143.935113] Subtest basic-contexts-priority-all: SUCCESS (22.667s)
[144.140140] [028/133] (875s left) kms_cursor_crc (cursor-random-64x64)
[144.317029] Starting subtest: cursor-random-64x64
[144.321745] Starting dynamic subtest: pipe-A-eDP-1
[147.709716] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.389s)
[147.738196] Starting dynamic subtest: pipe-D-eDP-1
[151.746877] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.013s)
[151.749084] Subtest cursor-random-64x64: SUCCESS (7.427s)
[152.572999] [029/133] (866s left) kms_flip (2x-plain-flip-interruptible)
[152.669608] Starting subtest: 2x-plain-flip-interruptible
[152.680786] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[152.779176] [030/133] (866s left) kms_busy (extended-modeset-hang-oldfb)
[152.887165] Starting subtest: extended-modeset-hang-oldfb
[152.889392] Starting dynamic subtest: pipe-A
[164.858291] Dynamic subtest pipe-A: SUCCESS (11.969s)
[164.867263] Starting dynamic subtest: pipe-D
[177.139728] Dynamic subtest pipe-D: SUCCESS (12.275s)
[177.142209] Subtest extended-modeset-hang-oldfb: SUCCESS (24.253s)
[177.922921] [031/133] (841s left) gem_exec_flush (basic-wb-rw-default)
[177.983412] Starting subtest: basic-wb-rw-default
[183.443053] Subtest basic-wb-rw-default: SUCCESS (5.461s)
[183.632981] [032/133] (835s left) gem_exec_reloc (basic-scanout)
[183.706173] Subtest basic-scanout: SKIP (0.000s)
[183.773965] [033/133] (835s left) gem_partial_pwrite_pread (reads-uncached)
[183.830081] Subtest reads-uncached: SKIP (0.000s)
[183.881426] [034/133] (835s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[183.987936] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[183.992075] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[184.058227] [035/133] (835s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[186.089599] Starting subtest: gem-execbuf-stress-pc8
[186.125831] Subtest gem-execbuf-stress-pc8: SKIP (0.038s)
[186.465175] [036/133] (833s left) syncobj_wait (reset-during-wait-for-submit)
[186.519924] Starting subtest: reset-during-wait-for-submit
[186.623524] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[186.711080] [037/133] (833s left) syncobj_wait (invalid-signal-zero-handles)
[186.766813] Starting subtest: invalid-signal-zero-handles
[186.769015] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[186.867856] [038/133] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[186.968224] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[186.972117] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[187.078468] [039/133] (832s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[187.174682] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[193.875432] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.703s)
[194.012294] [040/133] (825s left) kms_feature_discovery (dp-mst)
[194.104279] Starting subtest: dp-mst
[194.108403] Subtest dp-mst: SKIP (0.000s)
[194.176597] [041/133] (825s left) syncobj_timeline (reset-unsignaled)
[194.227460] Starting subtest: reset-unsignaled
[194.229822] Subtest reset-unsignaled: SUCCESS (0.000s)
[194.334315] [042/133] (825s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[194.424183] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[194.426563] Starting dynamic subtest: pipe-A-eDP-1
[194.449819] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.457964] Starting dynamic subtest: pipe-B-eDP-1
[194.479311] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.486967] Starting dynamic subtest: pipe-C-eDP-1
[194.508400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.516034] Starting dynamic subtest: pipe-D-eDP-1
[194.538058] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.542065] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[196.698124] [043/133] (823s left) kms_hdmi_inject (inject-4k)
[197.048551] Starting subtest: inject-4k
[197.360334] Subtest inject-4k: SUCCESS (0.315s)
[197.952117] [044/133] (822s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[198.042064] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[198.046386] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[198.115980] [045/133] (822s left) gem_mmap_gtt (fault-concurrent-y)
[198.170485] Subtest fault-concurrent-Y: SKIP (0.000s)
[198.225549] [046/133] (821s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[198.318689] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[198.323170] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[198.420409] [047/133] (821s left) gem_exec_balancer (parallel-contexts)
[198.684387] Starting subtest: parallel-contexts
[201.386947] Subtest parallel-contexts: SUCCESS (2.703s)
[202.084388] [048/133] (818s left) gem_exec_schedule (semaphore-resolve)
[202.147357] Starting subtest: semaphore-resolve
[202.204888] Subtest semaphore-resolve: SUCCESS (0.063s)
[202.563612] [049/133] (817s left) gem_ctx_engines (independent)
[202.630833] Starting subtest: independent
[202.633167] Starting dynamic subtest: rcs0
[202.843949] Dynamic subtest rcs0: SUCCESS (0.212s)
[202.854124] Starting dynamic subtest: bcs0
[203.045407] Dynamic subtest bcs0: SUCCESS (0.200s)
[203.053451] Starting dynamic subtest: vcs0
[203.246370] Dynamic subtest vcs0: SUCCESS (0.200s)
[203.254549] Starting dynamic subtest: vcs1
[203.443215] Dynamic subtest vcs1: SUCCESS (0.195s)
[203.453305] Starting dynamic subtest: vecs0
[203.676874] Dynamic subtest vecs0: SUCCESS (0.233s)
[203.687241] Starting dynamic subtest: ccs0
[204.040769] Dynamic subtest ccs0: SUCCESS (0.363s)
[204.051805] Starting dynamic subtest: all-engines
[205.347886] Dynamic subtest all-engines: SUCCESS (1.306s)
[205.350777] Subtest independent: SUCCESS (2.717s)
[206.981938] [050/133] (813s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[207.099814] Starting subtest: y-tiled-32bpp-rotate-0
[207.104576] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[207.207785] [051/133] (813s left) kms_async_flips (test-time-stamp)
[207.305021] Starting subtest: test-time-stamp
[207.677535] Starting dynamic subtest: pipe-A-eDP-1
[208.497599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s)
[208.889330] Starting dynamic subtest: pipe-B-eDP-1
[209.692168] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.812s)
[210.056765] Starting dynamic subtest: pipe-C-eDP-1
[210.892640] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.839s)
[211.254792] Starting dynamic subtest: pipe-D-eDP-1
[212.095087] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.845s)
[212.097537] Subtest test-time-stamp: SUCCESS (4.790s)
[213.310504] [052/133] (807s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[213.431075] Starting subtest: plane-upscale-20x20-with-modifiers
[213.433287] Starting dynamic subtest: pipe-A
[213.767333] Dynamic subtest pipe-A: SUCCESS (0.339s)
[213.775704] Starting dynamic subtest: pipe-B
[215.175233] Dynamic subtest pipe-B: SUCCESS (1.407s)
[215.184148] Starting dynamic subtest: pipe-C
[216.575646] Dynamic subtest pipe-C: SUCCESS (1.400s)
[216.584417] Starting dynamic subtest: pipe-D
[217.979174] Dynamic subtest pipe-D: SUCCESS (1.403s)
[217.981319] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.551s)
[219.128084] [053/133] (801s left) gem_mmap (bad-object)
[219.193720] Subtest bad-object: SKIP (0.000s)
[219.251897] [054/133] (801s left) gem_exec_params (no-vebox)
[219.315312] Starting subtest: no-vebox
[219.317841] Subtest no-vebox: SUCCESS (0.002s)
[220.948694] [055/133] (799s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[221.045457] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[221.047921] Starting dynamic subtest: pipe-A-eDP-1
[221.073793] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[221.084577] Starting dynamic subtest: pipe-B-eDP-1
[221.108033] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[221.116281] Starting dynamic subtest: pipe-C-eDP-1
[221.139661] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[221.147819] Starting dynamic subtest: pipe-D-eDP-1
[221.172127] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[221.176169] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[223.325896] [056/133] (797s left) gem_workarounds (reset)
[223.394345] Starting subtest: reset
[223.566287] Subtest reset: SUCCESS (0.170s)
[223.704974] [057/133] (796s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[223.801134] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[223.805590] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[223.870811] [058/133] (796s left) kms_lease (page-flip-implicit-plane)
[223.959992] Starting subtest: page-flip-implicit-plane
[223.962298] Starting dynamic subtest: pipe-A-eDP-1
[224.445065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.484s)
[224.455563] Starting dynamic subtest: pipe-B-eDP-1
[225.628587] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.182s)
[225.636731] Starting dynamic subtest: pipe-C-eDP-1
[226.719657] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.092s)
[226.729339] Starting dynamic subtest: pipe-D-eDP-1
[227.810970] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.089s)
[227.813466] Subtest page-flip-implicit-plane: SUCCESS (3.852s)
[228.609601] [059/133] (792s left) gem_exec_fence (syncobj-signal)
[229.082825] Starting subtest: syncobj-signal
[229.088670] Subtest syncobj-signal: SUCCESS (0.006s)
[231.017745] [060/133] (789s left) kms_async_flips (alternate-sync-async-flip)
[231.099954] Starting subtest: alternate-sync-async-flip
[231.472356] Starting dynamic subtest: pipe-A-eDP-1
[234.274073] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.802s)
[234.668490] Starting dynamic subtest: pipe-B-eDP-1
[237.467600] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.807s)
[237.838632] Starting dynamic subtest: pipe-C-eDP-1
[240.583297] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.752s)
[240.952999] Starting dynamic subtest: pipe-D-eDP-1
[243.773803] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.829s)
[243.775690] Subtest alternate-sync-async-flip: SUCCESS (12.677s)
[244.941426] [061/133] (775s left) gem_exec_params (invalid-ring2)
[245.015822] Starting subtest: invalid-ring2
[245.018129] Subtest invalid-ring2: SUCCESS (0.000s)
[245.122457] [062/133] (775s left) kms_plane_alpha_blend (coverage-7efc)
[245.219692] Starting subtest: coverage-7efc
[245.518107] Starting dynamic subtest: pipe-A-eDP-1
[246.069048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[246.095616] Starting dynamic subtest: pipe-D-eDP-1
[247.388548] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[247.390946] Subtest coverage-7efc: SUCCESS (2.171s)
[248.201974] [063/133] (772s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[248.291064] Starting subtest: psr-rgb101010-draw-mmap-gtt
[248.295622] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[248.384888] [064/133] (772s left) kms_flip (flip-vs-rmfb-interruptible)
[248.481992] Starting subtest: flip-vs-rmfb-interruptible
[248.484319] Starting dynamic subtest: A-eDP1
[257.180186] Dynamic subtest A-eDP1: SUCCESS (8.698s)
[257.198257] Starting dynamic subtest: B-eDP1
[265.775082] Dynamic subtest B-eDP1: SUCCESS (8.592s)
[265.786195] Starting dynamic subtest: C-eDP1
[274.372865] Dynamic subtest C-eDP1: SUCCESS (8.595s)
[274.391216] Starting dynamic subtest: D-eDP1
[283.065075] Dynamic subtest D-eDP1: SUCCESS (8.688s)
[283.069920] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.589s)
[284.313267] [065/133] (736s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[284.410360] Starting subtest: primary-4-tiled-reflect-x-0
[291.416955] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.008s)
[292.604302] [066/133] (728s left) i915_hangman (engine-error-state-capture)
[292.669674] Starting subtest: engine-error-state-capture
[292.671571] Starting dynamic subtest: rcs0
[295.859655] Dynamic subtest rcs0: SUCCESS (3.189s)
[295.871480] Starting dynamic subtest: bcs0
[301.875283] Dynamic subtest bcs0: SUCCESS (6.013s)
[301.887051] Starting dynamic subtest: vcs0
[307.826514] Dynamic subtest vcs0: SUCCESS (5.948s)
[307.838140] Starting dynamic subtest: vcs1
[312.819261] Dynamic subtest vcs1: SUCCESS (4.990s)
[312.831022] Starting dynamic subtest: vecs0
[317.811332] Dynamic subtest vecs0: SUCCESS (4.989s)
[317.823059] Starting dynamic subtest: ccs0
[322.867404] Dynamic subtest ccs0: SUCCESS (5.053s)
[322.870295] Subtest engine-error-state-capture: SUCCESS (30.198s)
[322.954201] [067/133] (698s left) kms_color (gamma)
[323.050930] Starting subtest: gamma
[323.053146] Starting dynamic subtest: pipe-A-eDP-1
[323.783505] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s)
[323.792878] Starting dynamic subtest: pipe-B-eDP-1
[325.183530] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[325.192796] Starting dynamic subtest: pipe-C-eDP-1
[326.535293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.351s)
[326.544229] Starting dynamic subtest: pipe-D-eDP-1
[327.944665] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.410s)
[327.947106] Subtest gamma: SUCCESS (4.896s)
[328.804634] [068/133] (692s left) template (b)
[328.866892] Starting subtest: B
[328.868866] Subtest B: SUCCESS (0.000s)
[328.968545] [069/133] (692s left) gem_ctx_isolation (nonpriv-switch)
[329.024879] Starting subtest: nonpriv-switch
[329.027296] Starting dynamic subtest: rcs0
[329.321871] Dynamic subtest rcs0: SUCCESS (0.296s)
[329.332054] Starting dynamic subtest: bcs0
[329.609192] Dynamic subtest bcs0: SUCCESS (0.286s)
[329.619725] Starting dynamic subtest: vcs0
[329.891847] Dynamic subtest vcs0: SUCCESS (0.282s)
[329.900152] Starting dynamic subtest: vcs1
[331.151183] Dynamic subtest vcs1: SUCCESS (1.258s)
[331.161791] Starting dynamic subtest: vecs0
[333.197257] Dynamic subtest vecs0: SUCCESS (2.045s)
[333.208494] Starting dynamic subtest: ccs0
[335.233339] Dynamic subtest ccs0: SUCCESS (2.035s)
[335.235717] Subtest nonpriv-switch: SUCCESS (6.209s)
[335.455765] [070/133] (685s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[335.559127] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[335.563311] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[335.675498] [071/133] (685s left) gem_lmem_swapping (massive)
[335.718098] Subtest massive: SKIP (0.000s)
[335.754952] [072/133] (685s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[336.131558] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[336.979427] [073/133] (684s left) kms_content_protection (content-type-change)
[337.125159] Starting subtest: content-type-change
[337.129750] Subtest content-type-change: SKIP (0.000s)
[337.246120] [074/133] (684s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[337.322077] Subtest untiled-to-tiled: SKIP (0.000s)
[337.399374] [075/133] (683s left) kms_rotation_crc (primary-rotation-90)
[337.492233] Starting subtest: primary-rotation-90
[337.496481] Subtest primary-rotation-90: SKIP (0.001s)
[337.575775] [076/133] (683s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[337.670499] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[344.368864] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.700s)
[344.516214] [077/133] (676s left) kms_vblank (query-forked-hang)
[344.607049] Starting subtest: query-forked-hang
[344.609190] Starting dynamic subtest: pipe-A-eDP-1
[370.644721] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.034s)
[370.659469] Starting dynamic subtest: pipe-D-eDP-1
[385.688628] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.043s)
[385.691000] Subtest query-forked-hang: SUCCESS (41.082s)
[386.496534] [078/133] (634s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[386.592628] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[386.596681] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[386.698947] [079/133] (634s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[386.768411] Starting subtest: y-tiled-to-vebox-yf-tiled
[386.773062] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[386.946932] [080/133] (634s left) gem_ctx_shared (exec-shared-gtt)
[386.999292] Starting subtest: exec-shared-gtt
[387.001805] Starting dynamic subtest: rcs0
[387.007061] Dynamic subtest rcs0: SUCCESS (0.007s)
[387.017070] Starting dynamic subtest: bcs0
[387.019234] Dynamic subtest bcs0: SUCCESS (0.006s)
[387.028068] Starting dynamic subtest: vcs0
[387.030472] Dynamic subtest vcs0: SUCCESS (0.007s)
[387.039209] Starting dynamic subtest: vcs1
[387.041179] Dynamic subtest vcs1: SUCCESS (0.006s)
[387.049671] Starting dynamic subtest: vecs0
[387.051868] Dynamic subtest vecs0: SUCCESS (0.006s)
[387.060382] Starting dynamic subtest: ccs0
[387.062641] Dynamic subtest ccs0: SUCCESS (0.006s)
[387.064871] Subtest exec-shared-gtt: SUCCESS (0.043s)
[387.227519] [081/133] (634s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[387.323661] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[387.327780] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[387.406842] [082/133] (634s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[387.517852] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[388.186131] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[388.353814] [083/133] (633s left) gem_exec_flush (basic-wb-prw-default)
[388.411589] Starting subtest: basic-wb-prw-default
[393.906631] Subtest basic-wb-prw-default: SUCCESS (5.497s)
[394.096769] [084/133] (627s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[394.213509] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[394.218196] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[394.358160] [085/133] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[394.467906] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[394.472308] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[394.565752] [086/133] (627s left) kms_atomic_interruptible (legacy-pageflip)
[394.654984] Starting subtest: legacy-pageflip
[394.657301] Starting dynamic subtest: pipe-A-eDP-1
[402.090523] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.436s)
[402.092723] Subtest legacy-pageflip: SUCCESS (7.438s)
[402.890982] [087/133] (618s left) kms_pipe_crc_basic (bad-source)
[402.985063] Starting subtest: bad-source
[402.987242] Subtest bad-source: SUCCESS (0.000s)
[403.056750] [088/133] (618s left) kms_pm_rpm (cursor)
[405.080489] Starting subtest: cursor
[405.086226] Subtest cursor: SKIP (0.000s)
[405.466110] [089/133] (616s left) perf_pmu (init-busy)
[405.502393] Starting subtest: init-busy
[405.504637] Starting dynamic subtest: rcs0
[405.506753] Dynamic subtest rcs0: SUCCESS (0.001s)
[405.515868] Starting dynamic subtest: bcs0
[405.518042] Dynamic subtest bcs0: SUCCESS (0.000s)
[405.526183] Starting dynamic subtest: vcs0
[405.528299] Dynamic subtest vcs0: SUCCESS (0.001s)
[405.536275] Starting dynamic subtest: vcs1
[405.538425] Dynamic subtest vcs1: SUCCESS (0.001s)
[405.546651] Starting dynamic subtest: vecs0
[405.548580] Dynamic subtest vecs0: SUCCESS (0.001s)
[405.556368] Starting dynamic subtest: ccs0
[405.558303] Dynamic subtest ccs0: SUCCESS (0.000s)
[405.560743] Subtest init-busy: SUCCESS (0.007s)
[405.627225] [090/133] (616s left) kms_cursor_edge_walk (128x128-right-edge)
[405.719779] Starting subtest: 128x128-right-edge
[405.722067] Starting dynamic subtest: pipe-A-eDP-1
[409.139936] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.421s)
[409.149428] Starting dynamic subtest: pipe-D-eDP-1
[412.331156] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.190s)
[412.333376] Subtest 128x128-right-edge: SUCCESS (6.613s)
[413.191772] [091/133] (608s left) gem_ctx_param (non-root-set)
[413.248918] Starting subtest: non-root-set
[413.270309] Subtest non-root-set: SUCCESS (0.022s)
[413.372621] [092/133] (608s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[413.425962] Starting subtest: etime-single-wait-for-submit-unsubmitted
[413.529159] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[413.608153] [093/133] (608s left) gem_pxp (create-protected-buffer)
[413.738096] Starting subtest: create-protected-buffer
[413.740328] Subtest create-protected-buffer: SUCCESS (0.000s)
[413.840374] [094/133] (608s left) kms_psr (fbc-pr-no-drrs)
[413.926757] Starting subtest: fbc-pr-no-drrs
[413.930987] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[414.024270] [095/133] (608s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[414.075567] Starting subtest: invalid-single-wait-all-unsubmitted
[414.077778] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[414.198126] [096/133] (608s left) kms_psr (fbc-psr-sprite-plane-onoff)
[414.290085] Starting subtest: fbc-psr-sprite-plane-onoff
[414.292575] Starting dynamic subtest: eDP-1
[414.297051] Dynamic subtest eDP-1: SKIP (0.000s)
[414.301477] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[414.360313] [097/133] (607s left) kms_addfb_basic (no-handle)
[414.410524] Starting subtest: no-handle
[414.412483] Subtest no-handle: SUCCESS (0.000s)
[414.541111] [098/133] (607s left) kms_sequence (get-idle)
[414.623187] Starting subtest: get-idle
[414.625091] Starting dynamic subtest: pipe-A-eDP-1
[416.472896] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.847s)
[416.482043] Starting dynamic subtest: pipe-B-eDP-1
[418.926622] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.452s)
[418.935363] Starting dynamic subtest: pipe-C-eDP-1
[421.427361] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.499s)
[421.436726] Starting dynamic subtest: pipe-D-eDP-1
[423.913817] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.488s)
[423.916199] Subtest get-idle: SUCCESS (9.291s)
[424.800188] [099/133] (597s left) gem_exec_schedule (preempt-hang)
[424.980155] Starting subtest: preempt-hang
[424.982884] Starting dynamic subtest: rcs0
[425.215995] Dynamic subtest rcs0: SUCCESS (0.236s)
[425.226458] Starting dynamic subtest: bcs0
[425.446134] Dynamic subtest bcs0: SUCCESS (0.228s)
[425.456807] Starting dynamic subtest: vcs0
[425.676712] Dynamic subtest vcs0: SUCCESS (0.230s)
[425.688302] Starting dynamic subtest: vcs1
[425.899411] Dynamic subtest vcs1: SUCCESS (0.221s)
[425.909230] Starting dynamic subtest: vecs0
[426.124118] Dynamic subtest vecs0: SUCCESS (0.225s)
[426.135819] Starting dynamic subtest: ccs0
[426.358496] Dynamic subtest ccs0: SUCCESS (0.232s)
[426.360722] Subtest preempt-hang: SUCCESS (1.378s)
[426.992088] [100/133] (595s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[427.395078] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[428.172217] [101/133] (594s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[428.227299] Starting subtest: multi-wait-all-for-submit-submitted
[428.328309] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[428.408118] [102/133] (594s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[428.507185] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[435.061057] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.555s)
[435.188574] [103/133] (587s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[435.255760] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[435.360878] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[435.442579] [104/133] (587s left) i915_suspend (basic-s2idle-without-i915)
[435.477956] Starting subtest: basic-s2idle-without-i915
[456.414353] Subtest basic-s2idle-without-i915: SUCCESS (5.742s)
[456.523816] [105/133] (566s left) gem_lmem_swapping (random-engines)
[456.584627] Subtest random-engines: SKIP (0.000s)
[456.634696] [106/133] (565s left) syncobj_timeline (signal-array)
[456.687620] Starting subtest: signal-array
[456.689892] Subtest signal-array: SUCCESS (0.000s)
[456.791679] [107/133] (565s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[456.893974] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[456.898274] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[457.002158] [108/133] (565s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[457.087867] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[457.091718] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[457.154813] [109/133] (565s left) gem_userptr_blits (sync-unmap)
[457.218556] Starting subtest: sync-unmap
[457.233689] Subtest sync-unmap: SUCCESS (0.016s)
[457.356694] [110/133] (565s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[457.451793] Starting subtest: blocking-absolute-wf_vblank-interruptible
[457.453655] Starting dynamic subtest: A-eDP1
[466.182541] Dynamic subtest A-eDP1: SUCCESS (8.831s)
[466.193837] Starting dynamic subtest: B-eDP1
[474.852086] Dynamic subtest B-eDP1: SUCCESS (8.702s)
[474.862490] Starting dynamic subtest: C-eDP1
[483.550459] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[483.559980] Starting dynamic subtest: D-eDP1
[492.280978] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[492.283610] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.985s)
[493.718195] [111/133] (529s left) gem_exec_balancer (parallel-balancer)
[493.989826] Starting subtest: parallel-balancer
[494.880650] Subtest parallel-balancer: SUCCESS (0.891s)
[494.990636] [112/133] (527s left) gem_mmap_gtt (basic-read)
[495.046951] Subtest basic-read: SKIP (0.000s)
[495.115155] [113/133] (527s left) gem_userptr_blits (stress-mm-invalidate-close)
[495.175295] Starting subtest: stress-mm-invalidate-close
[497.320783] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[497.432525] [114/133] (525s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[497.476819] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[497.481682] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[497.661989] [115/133] (525s left) kms_dirtyfb (default-dirtyfb-ioctl)
[497.755496] Starting subtest: default-dirtyfb-ioctl
[497.757696] Starting dynamic subtest: A-eDP-1
[499.362243] Dynamic subtest A-eDP-1: SUCCESS (1.604s)
[499.364687] Subtest default-dirtyfb-ioctl: SUCCESS (1.607s)
[500.159611] [116/133] (522s left) core_getclient (basic)
[500.216810] Starting subtest: basic
[500.219118] Subtest basic: SUCCESS (0.000s)
[500.321050] [117/133] (522s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[500.410002] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[500.412210] Starting dynamic subtest: pipe-A-eDP-1
[500.432475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[500.443145] Starting dynamic subtest: pipe-B-eDP-1
[500.462358] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[500.470046] Starting dynamic subtest: pipe-C-eDP-1
[500.489035] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[500.497250] Starting dynamic subtest: pipe-D-eDP-1
[500.516489] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[500.518397] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[502.718139] [118/133] (520s left) gem_userptr_blits (map-fixed-invalidate)
[502.790073] Starting subtest: map-fixed-invalidate
[502.794419] Subtest map-fixed-invalidate: SKIP (0.000s)
[502.902244] [119/133] (520s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[503.010587] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[503.022089] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[503.131136] [120/133] (520s left) syncobj_timeline (invalid-signal-illegal-handle)
[503.184131] Starting subtest: invalid-signal-illegal-handle
[503.186077] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[503.285016] [121/133] (519s left) kms_joiner (basic-big-joiner)
[503.376612] Starting subtest: basic-big-joiner
[503.380889] Subtest basic-big-joiner: SKIP (0.000s)
[503.443603] [122/133] (519s left) gem_tiled_pread_basic (basic)
[503.513115] Subtest basic: SKIP (0.000s)
[503.575820] [123/133] (519s left) kms_cursor_crc (cursor-offscreen-512x512)
[503.843136] Starting subtest: cursor-offscreen-512x512
[503.846740] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[504.003948] [124/133] (519s left) perf (global-sseu-config-invalid)
[504.131744] Starting subtest: global-sseu-config-invalid
[504.135607] Subtest global-sseu-config-invalid: SKIP (0.000s)
[504.169852] [125/133] (519s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[504.270784] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[511.556567] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.289s)
[511.682351] [126/133] (511s left) gem_ctx_persistence (smoketest)
[511.737178] Starting subtest: smoketest
[552.042474] Subtest smoketest: SUCCESS (40.318s)
[552.118787] [127/133] (471s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[552.239159] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[552.243603] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[552.349031] [128/133] (471s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[552.438987] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[552.441223] Starting dynamic subtest: pipe-A-eDP-1
[569.215558] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.406s)
[569.225031] Starting dynamic subtest: pipe-B-eDP-1
[586.205503] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.454s)
[586.214807] Starting dynamic subtest: pipe-C-eDP-1
[603.149192] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.413s)
[603.158154] Starting dynamic subtest: pipe-D-eDP-1
[620.155252] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.392s)
[620.157579] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.671s)
[621.292798] [129/133] (402s left) gem_busy (busy)
[621.363762] Starting subtest: busy
[621.365938] Starting dynamic subtest: all-engines
[621.421281] Dynamic subtest all-engines: SUCCESS (0.057s)
[621.429873] Starting dynamic subtest: rcs0
[623.311202] Dynamic subtest rcs0: SUCCESS (1.926s)
[623.321376] Starting dynamic subtest: bcs0
[623.359024] Dynamic subtest bcs0: SUCCESS (0.046s)
[623.367482] Starting dynamic subtest: vcs0
[623.397306] Dynamic subtest vcs0: SUCCESS (0.039s)
[623.405717] Starting dynamic subtest: vcs1
[625.357064] Dynamic subtest vcs1: SUCCESS (1.985s)
[625.366323] Starting dynamic subtest: vecs0
[627.342149] Dynamic subtest vecs0: SUCCESS (2.006s)
[627.351848] Starting dynamic subtest: ccs0
[629.326733] Dynamic subtest ccs0: SUCCESS (2.002s)
[629.329113] Subtest busy: SUCCESS (8.070s)
[629.677846] [130/133] (393s left) kms_psr (pr-primary-mmap-gtt)
[629.773841] Starting subtest: pr-primary-mmap-gtt
[629.778188] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[629.846361] [131/133] (393s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[629.944118] Starting subtest: psr-shrfb-scaledprimary
[635.698933] Subtest psr-shrfb-scaledprimary: SUCCESS (5.788s)
[635.810773] [132/133] (387s left) dmabuf_sync_file (export-multiwait)
[635.866147] Starting subtest: export-multiwait
[635.868051] Subtest export-multiwait: SUCCESS (0.000s)
[635.927914] [133/133] (387s left) i915_drm_fdinfo (basics)
[635.966895] Starting subtest: basics
[635.969030] Subtest basics: SUCCESS (0.000s)
[636.063489] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_prop_blob
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: prime_vgem
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: gem_spin_batch
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: perf
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_psr
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: gem_exec_whisper
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_busy
results: parsing output: 30/ for test: gem_exec_flush
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: i915_pm_rpm
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_feature_discovery
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_hdmi_inject
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gem_ctx_engines
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: gem_mmap
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_workarounds
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: kms_plane_alpha_blend
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: i915_hangman
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: template
results: parsing output: 68/ for test: gem_ctx_isolation
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: kms_chamelium_edid
results: parsing output: 72/ for test: kms_content_protection
results: parsing output: 73/ for test: gem_set_tiling_vs_blt
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_atomic_interruptible
results: parsing output: 86/ for test: kms_pipe_crc_basic
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_cursor_edge_walk
results: parsing output: 90/ for test: gem_ctx_param
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_sequence
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: i915_suspend
results: parsing output: 104/ for test: gem_lmem_swapping
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_dirtyfb
results: parsing output: 115/ for test: core_getclient
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_joiner
results: parsing output: 121/ for test: gem_tiled_pread_basic
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_busy
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: dmabuf_sync_file
results: parsing output: 132/ for test: i915_drm_fdinfo
Done.