[60.019175] Initializing watchdogs
[60.019222]   /dev/watchdog0
[60.034049] [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]
[60.038488] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.040701] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.042619] [001/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[60.144123] Starting subtest: x-tiled-8bpp-rotate-270
[60.181239] Subtest x-tiled-8bpp-rotate-270: SKIP (0.037s)
[60.272336] [002/133] (960s left) kms_prop_blob (basic)
[60.332164] Starting subtest: basic
[60.333087] Subtest basic: SUCCESS (0.000s)
[60.420498] [003/133] (960s left) gen9_exec_parse (bb-large)
[60.474728] Subtest bb-large: SKIP (0.000s)
[60.538998] [004/133] (960s left) prime_vgem (fence-read-hang)
[60.633987] Subtest fence-read-hang: SKIP (0.000s)
[60.719338] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[60.720978] [005/133] (959s left) gem_userptr_blits (readonly-unsync)
[60.770934] Subtest readonly-unsync: SKIP (0.000s)
[60.907281] [006/133] (959s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[60.991362] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[60.992353] Starting dynamic subtest: pipe-A
[62.180707] Dynamic subtest pipe-A: SUCCESS (1.195s)
[62.188751] Starting dynamic subtest: pipe-B
[64.403437] Dynamic subtest pipe-B: SUCCESS (2.231s)
[64.409095] Starting dynamic subtest: pipe-C
[65.592019] Dynamic subtest pipe-C: SUCCESS (1.191s)
[65.600128] Starting dynamic subtest: pipe-D
[66.813986] Dynamic subtest pipe-D: SUCCESS (1.224s)
[66.814902] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.844s)
[68.005771] [007/133] (952s left) kms_psr (fbc-pr-sprite-blt)
[68.171323] Starting subtest: fbc-pr-sprite-blt
[68.172970] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[68.242236] [008/133] (952s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[68.328701] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[68.329566] Starting dynamic subtest: pipe-A-eDP-1
[68.407698] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[68.416604] Starting dynamic subtest: pipe-B-eDP-1
[69.582675] Dynamic subtest pipe-B-eDP-1: SKIP (1.176s)
[69.584509] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.257s)
[70.763191] [009/133] (950s left) kms_flip (2x-plain-flip-ts-check)
[70.859929] Starting subtest: 2x-plain-flip-ts-check
[70.869958] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[70.944600] [010/133] (949s left) gem_spin_batch (engines)
[71.012325] Starting subtest: engines
[71.013336] Starting dynamic subtest: rcs0
[74.256772] Dynamic subtest rcs0: SUCCESS (3.237s)
[74.264771] Starting dynamic subtest: bcs0
[77.485759] Dynamic subtest bcs0: SUCCESS (3.238s)
[77.494887] Starting dynamic subtest: vcs0
[80.767357] Dynamic subtest vcs0: SUCCESS (3.236s)
[80.775865] Starting dynamic subtest: vcs1
[84.003286] Dynamic subtest vcs1: SUCCESS (3.235s)
[84.011845] Starting dynamic subtest: vecs0
[87.241073] Dynamic subtest vecs0: SUCCESS (3.236s)
[87.249797] Starting dynamic subtest: ccs0
[90.477364] Dynamic subtest ccs0: SUCCESS (3.235s)
[90.478650] Subtest engines: SUCCESS (19.423s)
[90.657704] [011/133] (930s left) syncobj_timeline (wait-zero-handles)
[90.723992] Starting subtest: wait-zero-handles
[90.725196] Subtest wait-zero-handles: SUCCESS (0.000s)
[90.833122] [012/133] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[90.927374] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[94.592460] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.664s)
[95.761072] [013/133] (925s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[95.856494] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[96.934576] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.079s)
[97.054678] [014/133] (923s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[97.141242] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[104.109554] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.967s)
[104.234965] [015/133] (916s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[104.281259] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[104.282220] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[104.375886] [016/133] (916s left) kms_big_fb (linear-16bpp-rotate-90)
[104.474657] Starting subtest: linear-16bpp-rotate-90
[104.493879] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[104.589609] [017/133] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[104.685243] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[112.544821] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.860s)
[112.650143] [018/133] (908s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[112.744437] Starting subtest: yf-tiled-64bpp-rotate-270
[112.746268] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[112.828257] [019/133] (908s left) perf (stress-open-close)
[112.955647] Starting subtest: stress-open-close
[112.956468] Starting dynamic subtest: 0-rcs0
[115.121383] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[115.128529] Starting dynamic subtest: 1-vecs0
[117.284947] Dynamic subtest 1-vecs0: SUCCESS (2.163s)
[117.285786] Subtest stress-open-close: SUCCESS (4.330s)
[117.319216] [020/133] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[117.410618] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[117.412536] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[117.504923] [021/133] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[117.596273] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[117.597943] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[117.685211] [022/133] (903s left) kms_psr (psr2-cursor-mmap-gtt)
[117.780327] Starting subtest: psr2-cursor-mmap-gtt
[117.781371] Starting dynamic subtest: eDP-1
[119.478568] Dynamic subtest eDP-1: SUCCESS (1.699s)
[119.479472] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.699s)
[120.347650] [023/133] (900s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[120.443330] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[120.445076] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[120.526645] [024/133] (900s left) kms_addfb_basic (bo-too-small)
[120.628177] Starting subtest: bo-too-small
[120.629017] Subtest bo-too-small: SUCCESS (0.000s)
[120.731797] [025/133] (900s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[120.823459] Starting subtest: bad-aux-stride-y-tiled-ccs
[120.824541] Starting dynamic subtest: pipe-A-eDP-1
[120.834531] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[120.844521] Starting dynamic subtest: pipe-B-eDP-1
[120.852604] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[120.858471] Starting dynamic subtest: pipe-C-eDP-1
[120.866184] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[120.872068] Starting dynamic subtest: pipe-D-eDP-1
[120.880044] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[120.881709] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s)
[123.110072] [026/133] (898s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[123.192620] Starting subtest: pr-primary-plane-update-sf-dmg-area
[123.194511] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[123.262719] [027/133] (898s left) gem_exec_whisper (basic-contexts-priority-all)
[123.322429] Starting subtest: basic-contexts-priority-all
[145.787450] Subtest basic-contexts-priority-all: SUCCESS (22.453s)
[145.958254] [028/133] (875s left) kms_cursor_crc (cursor-random-64x64)
[146.122405] Starting subtest: cursor-random-64x64
[146.125978] Starting dynamic subtest: pipe-A-eDP-1
[149.525412] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.400s)
[149.555540] Starting dynamic subtest: pipe-D-eDP-1
[153.545397] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.997s)
[153.546369] Subtest cursor-random-64x64: SUCCESS (7.423s)
[154.413979] [029/133] (867s left) kms_flip (2x-plain-flip-interruptible)
[154.503354] Starting subtest: 2x-plain-flip-interruptible
[154.514363] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[154.582660] [030/133] (866s left) kms_busy (extended-modeset-hang-oldfb)
[154.666429] Starting subtest: extended-modeset-hang-oldfb
[154.667382] Starting dynamic subtest: pipe-A
[166.357684] Dynamic subtest pipe-A: SUCCESS (11.689s)
[166.365991] Starting dynamic subtest: pipe-D
[178.635074] Dynamic subtest pipe-D: SUCCESS (12.275s)
[178.636046] Subtest extended-modeset-hang-oldfb: SUCCESS (23.968s)
[179.428457] [031/133] (842s left) gem_exec_flush (basic-wb-rw-default)
[179.484519] Starting subtest: basic-wb-rw-default
[184.935576] Subtest basic-wb-rw-default: SUCCESS (5.451s)
[185.116180] [032/133] (836s left) gem_exec_reloc (basic-scanout)
[185.164782] Subtest basic-scanout: SKIP (0.000s)
[185.223487] [033/133] (836s left) gem_partial_pwrite_pread (reads-uncached)
[185.276586] Subtest reads-uncached: SKIP (0.000s)
[185.348619] [034/133] (836s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[185.436059] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[185.437938] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[185.501542] [035/133] (836s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[187.018853] Starting subtest: gem-execbuf-stress-pc8
[187.056992] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[187.740075] [036/133] (833s left) syncobj_wait (reset-during-wait-for-submit)
[187.805931] Starting subtest: reset-during-wait-for-submit
[187.909980] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[187.981327] [037/133] (833s left) syncobj_wait (invalid-signal-zero-handles)
[188.037382] Starting subtest: invalid-signal-zero-handles
[188.038579] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[188.114490] [038/133] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[188.207665] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[188.209278] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[188.303335] [039/133] (833s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[188.383184] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[195.171588] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.789s)
[195.301396] [040/133] (826s left) kms_feature_discovery (dp-mst)
[195.391244] Starting subtest: dp-mst
[195.392919] Subtest dp-mst: SKIP (0.000s)
[195.458640] [041/133] (826s left) syncobj_timeline (reset-unsignaled)
[195.511665] Starting subtest: reset-unsignaled
[195.512589] Subtest reset-unsignaled: SUCCESS (0.000s)
[195.619677] [042/133] (826s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[195.700035] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[195.700949] Starting dynamic subtest: pipe-A-eDP-1
[195.709562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[195.718747] Starting dynamic subtest: pipe-B-eDP-1
[195.727825] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[195.735277] Starting dynamic subtest: pipe-C-eDP-1
[195.743832] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[195.750619] Starting dynamic subtest: pipe-D-eDP-1
[195.759175] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[195.760962] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[197.960071] [043/133] (823s left) kms_hdmi_inject (inject-4k)
[198.291350] Starting subtest: inject-4k
[198.608349] Subtest inject-4k: SUCCESS (0.317s)
[199.109194] [044/133] (822s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[199.189388] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[199.191102] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[199.259077] [045/133] (822s left) gem_mmap_gtt (fault-concurrent-y)
[199.308057] Subtest fault-concurrent-Y: SKIP (0.000s)
[199.361196] [046/133] (822s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[199.444271] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[199.445844] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[199.530830] [047/133] (822s left) gem_exec_balancer (parallel-contexts)
[199.790661] Starting subtest: parallel-contexts
[202.602170] Subtest parallel-contexts: SUCCESS (2.811s)
[202.707125] [048/133] (819s left) gem_exec_schedule (semaphore-resolve)
[202.773566] Starting subtest: semaphore-resolve
[202.842065] Subtest semaphore-resolve: SUCCESS (0.068s)
[203.182349] [049/133] (818s left) gem_ctx_engines (independent)
[203.241560] Starting subtest: independent
[203.242412] Starting dynamic subtest: rcs0
[203.455647] Dynamic subtest rcs0: SUCCESS (0.205s)
[203.465484] Starting dynamic subtest: bcs0
[203.684611] Dynamic subtest bcs0: SUCCESS (0.228s)
[203.694672] Starting dynamic subtest: vcs0
[203.895408] Dynamic subtest vcs0: SUCCESS (0.210s)
[203.905941] Starting dynamic subtest: vcs1
[204.117874] Dynamic subtest vcs1: SUCCESS (0.222s)
[204.127567] Starting dynamic subtest: vecs0
[204.341503] Dynamic subtest vecs0: SUCCESS (0.223s)
[204.350214] Starting dynamic subtest: ccs0
[204.549269] Dynamic subtest ccs0: SUCCESS (0.206s)
[204.564414] Starting dynamic subtest: all-engines
[205.386649] Dynamic subtest all-engines: SUCCESS (0.836s)
[205.387709] Subtest independent: SUCCESS (2.137s)
[206.922634] [050/133] (815s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[207.015168] Starting subtest: y-tiled-32bpp-rotate-0
[207.017180] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[207.108652] [051/133] (815s left) kms_async_flips (test-time-stamp)
[207.194477] Starting subtest: test-time-stamp
[207.574930] Starting dynamic subtest: pipe-A-eDP-1
[208.358344] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.782s)
[208.733559] Starting dynamic subtest: pipe-B-eDP-1
[209.564952] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.837s)
[209.947945] Starting dynamic subtest: pipe-C-eDP-1
[210.763699] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.820s)
[211.124361] Starting dynamic subtest: pipe-D-eDP-1
[211.955441] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.836s)
[211.956406] Subtest test-time-stamp: SUCCESS (4.762s)
[213.188283] [052/133] (809s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[213.276366] Starting subtest: plane-upscale-20x20-with-modifiers
[213.277255] Starting dynamic subtest: pipe-A
[213.613109] Dynamic subtest pipe-A: SUCCESS (0.338s)
[213.621695] Starting dynamic subtest: pipe-B
[215.049636] Dynamic subtest pipe-B: SUCCESS (1.435s)
[215.056802] Starting dynamic subtest: pipe-C
[216.449449] Dynamic subtest pipe-C: SUCCESS (1.399s)
[216.456700] Starting dynamic subtest: pipe-D
[217.851958] Dynamic subtest pipe-D: SUCCESS (1.401s)
[217.855099] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.578s)
[218.989777] [053/133] (803s left) gem_mmap (bad-object)
[219.046858] Subtest bad-object: SKIP (0.000s)
[219.097836] [054/133] (803s left) gem_exec_params (no-vebox)
[219.149745] Starting subtest: no-vebox
[219.152173] Subtest no-vebox: SUCCESS (0.002s)
[220.952239] [055/133] (801s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[221.035477] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[221.036497] Starting dynamic subtest: pipe-A-eDP-1
[221.045819] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[221.053333] Starting dynamic subtest: pipe-B-eDP-1
[221.062714] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[221.070547] Starting dynamic subtest: pipe-C-eDP-1
[221.079767] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[221.086759] Starting dynamic subtest: pipe-D-eDP-1
[221.096053] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[221.097616] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[223.283665] [056/133] (799s left) gem_workarounds (reset)
[223.353825] Starting subtest: reset
[223.528820] Subtest reset: SUCCESS (0.176s)
[223.665642] [057/133] (798s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[223.751258] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[223.752947] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[223.819281] [058/133] (798s left) kms_lease (page-flip-implicit-plane)
[223.899553] Starting subtest: page-flip-implicit-plane
[223.900530] Starting dynamic subtest: pipe-A-eDP-1
[224.387106] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.487s)
[224.395585] Starting dynamic subtest: pipe-B-eDP-1
[225.512597] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.123s)
[225.520084] Starting dynamic subtest: pipe-C-eDP-1
[226.691692] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.178s)
[226.699522] Starting dynamic subtest: pipe-D-eDP-1
[227.789815] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s)
[227.790717] Subtest page-flip-implicit-plane: SUCCESS (3.891s)
[228.598059] [059/133] (793s left) gem_exec_fence (syncobj-signal)
[229.074121] Starting subtest: syncobj-signal
[229.080215] Subtest syncobj-signal: SUCCESS (0.006s)
[230.946298] [060/133] (791s left) kms_async_flips (alternate-sync-async-flip)
[231.037351] Starting subtest: alternate-sync-async-flip
[231.409044] Starting dynamic subtest: pipe-A-eDP-1
[234.250891] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.842s)
[234.642076] Starting dynamic subtest: pipe-B-eDP-1
[237.442749] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.807s)
[237.814244] Starting dynamic subtest: pipe-C-eDP-1
[240.557970] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.750s)
[240.922881] Starting dynamic subtest: pipe-D-eDP-1
[243.746115] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.830s)
[243.747132] Subtest alternate-sync-async-flip: SUCCESS (12.710s)
[244.901226] [061/133] (777s left) gem_exec_params (invalid-ring2)
[244.954223] Starting subtest: invalid-ring2
[244.955094] Subtest invalid-ring2: SUCCESS (0.000s)
[245.042017] [062/133] (777s left) kms_plane_alpha_blend (coverage-7efc)
[245.135643] Starting subtest: coverage-7efc
[245.430395] Starting dynamic subtest: pipe-A-eDP-1
[245.998862] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[246.030499] Starting dynamic subtest: pipe-D-eDP-1
[247.282860] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s)
[247.283714] Subtest coverage-7efc: SUCCESS (2.147s)
[248.077353] [063/133] (774s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[248.183344] Starting subtest: psr-rgb101010-draw-mmap-gtt
[248.184987] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[248.284935] [064/133] (774s left) kms_flip (flip-vs-rmfb-interruptible)
[248.381438] Starting subtest: flip-vs-rmfb-interruptible
[248.383655] Starting dynamic subtest: A-eDP1
[257.045043] Dynamic subtest A-eDP1: SUCCESS (8.661s)
[257.055243] Starting dynamic subtest: B-eDP1
[265.656470] Dynamic subtest B-eDP1: SUCCESS (8.609s)
[265.666212] Starting dynamic subtest: C-eDP1
[274.332684] Dynamic subtest C-eDP1: SUCCESS (8.673s)
[274.343993] Starting dynamic subtest: D-eDP1
[282.929603] Dynamic subtest D-eDP1: SUCCESS (8.594s)
[282.932167] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.549s)
[284.078683] [065/133] (738s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[284.172521] Starting subtest: primary-4-tiled-reflect-x-0
[291.190349] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.018s)
[292.379253] [066/133] (730s left) i915_hangman (engine-error-state-capture)
[292.443557] Starting subtest: engine-error-state-capture
[292.444600] Starting dynamic subtest: rcs0
[295.868648] Dynamic subtest rcs0: SUCCESS (3.414s)
[295.878845] Starting dynamic subtest: bcs0
[301.885373] Dynamic subtest bcs0: SUCCESS (6.013s)
[301.896349] Starting dynamic subtest: vcs0
[307.836882] Dynamic subtest vcs0: SUCCESS (5.949s)
[307.845565] Starting dynamic subtest: vcs1
[312.827860] Dynamic subtest vcs1: SUCCESS (4.988s)
[312.838335] Starting dynamic subtest: vecs0
[317.884840] Dynamic subtest vecs0: SUCCESS (5.054s)
[317.895042] Starting dynamic subtest: ccs0
[323.900817] Dynamic subtest ccs0: SUCCESS (6.013s)
[323.902027] Subtest engine-error-state-capture: SUCCESS (31.447s)
[324.009940] [067/133] (698s left) kms_color (gamma)
[324.117908] Starting subtest: gamma
[324.118748] Starting dynamic subtest: pipe-A-eDP-1
[324.829643] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[324.837651] Starting dynamic subtest: pipe-B-eDP-1
[326.259059] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.428s)
[326.266583] Starting dynamic subtest: pipe-C-eDP-1
[327.603221] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.343s)
[327.615311] Starting dynamic subtest: pipe-D-eDP-1
[329.012347] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[329.013296] Subtest gamma: SUCCESS (4.895s)
[329.869336] [068/133] (692s left) template (b)
[329.929050] Starting subtest: B
[329.930039] Subtest B: SUCCESS (0.000s)
[330.043165] [069/133] (692s left) gem_ctx_isolation (nonpriv-switch)
[330.092643] Starting subtest: nonpriv-switch
[330.093671] Starting dynamic subtest: rcs0
[330.360959] Dynamic subtest rcs0: SUCCESS (0.268s)
[330.371728] Starting dynamic subtest: bcs0
[330.635324] Dynamic subtest bcs0: SUCCESS (0.273s)
[330.645479] Starting dynamic subtest: vcs0
[330.931908] Dynamic subtest vcs0: SUCCESS (0.296s)
[330.942685] Starting dynamic subtest: vcs1
[332.174087] Dynamic subtest vcs1: SUCCESS (1.241s)
[332.182555] Starting dynamic subtest: vecs0
[334.208606] Dynamic subtest vecs0: SUCCESS (2.033s)
[334.220128] Starting dynamic subtest: ccs0
[336.224973] Dynamic subtest ccs0: SUCCESS (2.016s)
[336.225935] Subtest nonpriv-switch: SUCCESS (6.132s)
[336.470748] [070/133] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[336.578301] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[336.580090] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[336.667241] [071/133] (686s left) gem_lmem_swapping (massive)
[336.699987] Subtest massive: SKIP (0.000s)
[336.740617] [072/133] (686s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[337.129042] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[337.945078] [073/133] (685s left) kms_content_protection (content-type-change)
[338.078330] Starting subtest: content-type-change
[338.080084] Subtest content-type-change: SKIP (0.000s)
[338.211616] [074/133] (684s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[338.266479] Subtest untiled-to-tiled: SKIP (0.000s)
[338.342462] [075/133] (684s left) kms_rotation_crc (primary-rotation-90)
[338.448084] Starting subtest: primary-rotation-90
[338.449738] Subtest primary-rotation-90: SKIP (0.001s)
[338.529544] [076/133] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[338.618547] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[345.359706] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.740s)
[345.514498] [077/133] (677s left) kms_vblank (query-forked-hang)
[345.614674] Starting subtest: query-forked-hang
[345.615616] Starting dynamic subtest: pipe-A-eDP-1
[371.670069] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.054s)
[371.679438] Starting dynamic subtest: pipe-D-eDP-1
[386.714930] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.042s)
[386.716076] Subtest query-forked-hang: SUCCESS (41.100s)
[387.568117] [078/133] (635s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[387.666203] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[387.667886] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[387.772206] [079/133] (635s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[387.828358] Starting subtest: y-tiled-to-vebox-yf-tiled
[387.830034] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[388.017328] [080/133] (635s left) gem_ctx_shared (exec-shared-gtt)
[388.068352] Starting subtest: exec-shared-gtt
[388.069265] Starting dynamic subtest: rcs0
[388.076743] Dynamic subtest rcs0: SUCCESS (0.008s)
[388.084519] Starting dynamic subtest: bcs0
[388.085380] Dynamic subtest bcs0: SUCCESS (0.005s)
[388.093162] Starting dynamic subtest: vcs0
[388.094042] Dynamic subtest vcs0: SUCCESS (0.008s)
[388.101807] Starting dynamic subtest: vcs1
[388.102724] Dynamic subtest vcs1: SUCCESS (0.007s)
[388.110307] Starting dynamic subtest: vecs0
[388.111141] Dynamic subtest vecs0: SUCCESS (0.008s)
[388.118323] Starting dynamic subtest: ccs0
[388.119155] Dynamic subtest ccs0: SUCCESS (0.006s)
[388.120044] Subtest exec-shared-gtt: SUCCESS (0.046s)
[388.293263] [081/133] (634s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[388.387729] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[388.389655] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[388.495207] [082/133] (634s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[388.599204] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[389.280393] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s)
[389.428525] [083/133] (633s left) gem_exec_flush (basic-wb-prw-default)
[389.497855] Starting subtest: basic-wb-prw-default
[394.994859] Subtest basic-wb-prw-default: SUCCESS (5.497s)
[395.183710] [084/133] (628s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[395.299266] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[395.301096] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[395.452461] [085/133] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[395.539420] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[395.540931] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[395.630882] [086/133] (627s left) kms_atomic_interruptible (legacy-pageflip)
[395.715284] Starting subtest: legacy-pageflip
[395.716123] Starting dynamic subtest: pipe-A-eDP-1
[403.171837] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.455s)
[403.172705] Subtest legacy-pageflip: SUCCESS (7.456s)
[403.967895] [087/133] (619s left) kms_pipe_crc_basic (bad-source)
[404.047359] Starting subtest: bad-source
[404.048124] Subtest bad-source: SUCCESS (0.000s)
[404.113891] [088/133] (619s left) kms_pm_rpm (cursor)
[406.033957] Starting subtest: cursor
[406.036472] Subtest cursor: SKIP (0.000s)
[406.414523] [089/133] (617s left) perf_pmu (init-busy)
[406.449908] Starting subtest: init-busy
[406.450717] Starting dynamic subtest: rcs0
[406.451513] Dynamic subtest rcs0: SUCCESS (0.001s)
[406.459376] Starting dynamic subtest: bcs0
[406.460264] Dynamic subtest bcs0: SUCCESS (0.001s)
[406.467764] Starting dynamic subtest: vcs0
[406.468614] Dynamic subtest vcs0: SUCCESS (0.001s)
[406.476186] Starting dynamic subtest: vcs1
[406.477027] Dynamic subtest vcs1: SUCCESS (0.001s)
[406.484143] Starting dynamic subtest: vecs0
[406.484972] Dynamic subtest vecs0: SUCCESS (0.001s)
[406.492066] Starting dynamic subtest: ccs0
[406.492937] Dynamic subtest ccs0: SUCCESS (0.000s)
[406.493808] Subtest init-busy: SUCCESS (0.010s)
[406.578191] [090/133] (617s left) kms_cursor_edge_walk (128x128-right-edge)
[406.660721] Starting subtest: 128x128-right-edge
[406.661626] Starting dynamic subtest: pipe-A-eDP-1
[410.117724] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.457s)
[410.127333] Starting dynamic subtest: pipe-D-eDP-1
[413.296498] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.177s)
[413.297349] Subtest 128x128-right-edge: SUCCESS (6.636s)
[414.175758] [091/133] (609s left) gem_ctx_param (non-root-set)
[414.227754] Starting subtest: non-root-set
[414.248640] Subtest non-root-set: SUCCESS (0.021s)
[414.334992] [092/133] (609s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[414.379306] Starting subtest: etime-single-wait-for-submit-unsubmitted
[414.481080] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[414.566973] [093/133] (609s left) gem_pxp (create-protected-buffer)
[414.676786] Starting subtest: create-protected-buffer
[414.678314] Subtest create-protected-buffer: SUCCESS (0.000s)
[414.804356] [094/133] (608s left) kms_psr (fbc-pr-no-drrs)
[414.900505] Starting subtest: fbc-pr-no-drrs
[414.902256] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[414.969463] [095/133] (608s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[415.017187] Starting subtest: invalid-single-wait-all-unsubmitted
[415.017984] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[415.121684] [096/133] (608s left) kms_psr (fbc-psr-sprite-plane-onoff)
[415.215048] Starting subtest: fbc-psr-sprite-plane-onoff
[415.215821] Starting dynamic subtest: eDP-1
[415.217445] Dynamic subtest eDP-1: SKIP (0.000s)
[415.218917] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[415.287016] [097/133] (608s left) kms_addfb_basic (no-handle)
[415.327071] Starting subtest: no-handle
[415.327841] Subtest no-handle: SUCCESS (0.000s)
[415.447462] [098/133] (608s left) kms_sequence (get-idle)
[415.539252] Starting subtest: get-idle
[415.540107] Starting dynamic subtest: pipe-A-eDP-1
[417.358187] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.818s)
[417.366439] Starting dynamic subtest: pipe-B-eDP-1
[419.821857] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.462s)
[419.829744] Starting dynamic subtest: pipe-C-eDP-1
[422.296667] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.474s)
[422.307277] Starting dynamic subtest: pipe-D-eDP-1
[424.786109] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.488s)
[424.786981] Subtest get-idle: SUCCESS (9.248s)
[425.658466] [099/133] (598s left) gem_exec_schedule (preempt-hang)
[425.849764] Starting subtest: preempt-hang
[425.850805] Starting dynamic subtest: rcs0
[426.073496] Dynamic subtest rcs0: SUCCESS (0.235s)
[426.086453] Starting dynamic subtest: bcs0
[426.306125] Dynamic subtest bcs0: SUCCESS (0.231s)
[426.316416] Starting dynamic subtest: vcs0
[426.540719] Dynamic subtest vcs0: SUCCESS (0.233s)
[426.548553] Starting dynamic subtest: vcs1
[426.768179] Dynamic subtest vcs1: SUCCESS (0.227s)
[426.777908] Starting dynamic subtest: vecs0
[426.990635] Dynamic subtest vecs0: SUCCESS (0.222s)
[426.999688] Starting dynamic subtest: ccs0
[427.219887] Dynamic subtest ccs0: SUCCESS (0.229s)
[427.220855] Subtest preempt-hang: SUCCESS (1.382s)
[428.017277] [100/133] (595s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[428.395938] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[429.234919] [101/133] (594s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[429.283335] Starting subtest: multi-wait-all-for-submit-submitted
[429.392214] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[429.465075] [102/133] (594s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[429.557250] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[436.264559] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.707s)
[436.374405] [103/133] (587s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[436.416138] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[436.520991] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[436.608717] [104/133] (587s left) i915_suspend (basic-s2idle-without-i915)
[436.640542] Starting subtest: basic-s2idle-without-i915
[458.264824] Subtest basic-s2idle-without-i915: SUCCESS (6.130s)
[463.429172] [105/133] (565s left) gem_lmem_swapping (random-engines)
[463.480194] Subtest random-engines: SKIP (0.000s)
[463.520263] [106/133] (565s left) syncobj_timeline (signal-array)
[463.573438] Starting subtest: signal-array
[463.574371] Subtest signal-array: SUCCESS (0.000s)
[463.693416] [107/133] (565s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[463.789703] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[463.791453] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[463.882844] [108/133] (565s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[463.972419] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[463.974207] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[464.039745] [109/133] (565s left) gem_userptr_blits (sync-unmap)
[464.096863] Starting subtest: sync-unmap
[464.118145] Subtest sync-unmap: SUCCESS (0.022s)
[464.223516] [110/133] (565s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[464.317239] Starting subtest: blocking-absolute-wf_vblank-interruptible
[464.321892] Starting dynamic subtest: A-eDP1
[473.006111] Dynamic subtest A-eDP1: SUCCESS (8.829s)
[473.016746] Starting dynamic subtest: B-eDP1
[481.671488] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[481.679172] Starting dynamic subtest: C-eDP1
[490.377428] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[490.386097] Starting dynamic subtest: D-eDP1
[499.061822] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[499.066163] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.999s)
[500.495949] [111/133] (528s left) gem_exec_balancer (parallel-balancer)
[500.759460] Starting subtest: parallel-balancer
[501.816269] Subtest parallel-balancer: SUCCESS (1.056s)
[501.900840] [112/133] (527s left) gem_mmap_gtt (basic-read)
[501.947452] Subtest basic-read: SKIP (0.000s)
[502.006054] [113/133] (527s left) gem_userptr_blits (stress-mm-invalidate-close)
[502.072780] Starting subtest: stress-mm-invalidate-close
[504.232311] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[504.347078] [114/133] (525s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[504.401599] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[504.403452] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[504.586788] [115/133] (524s left) kms_dirtyfb (default-dirtyfb-ioctl)
[504.667530] Starting subtest: default-dirtyfb-ioctl
[504.668297] Starting dynamic subtest: A-eDP-1
[506.286570] Dynamic subtest A-eDP-1: SUCCESS (1.618s)
[506.287356] Subtest default-dirtyfb-ioctl: SUCCESS (1.619s)
[507.142219] [116/133] (522s left) core_getclient (basic)
[507.191201] Starting subtest: basic
[507.192194] Subtest basic: SUCCESS (0.000s)
[507.299076] [117/133] (522s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[507.377797] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[507.378747] Starting dynamic subtest: pipe-A-eDP-1
[507.388547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[507.397452] Starting dynamic subtest: pipe-B-eDP-1
[507.405396] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[507.412637] Starting dynamic subtest: pipe-C-eDP-1
[507.419784] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[507.426961] Starting dynamic subtest: pipe-D-eDP-1
[507.434019] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[507.434828] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[509.615084] [118/133] (519s left) gem_userptr_blits (map-fixed-invalidate)
[509.679231] Starting subtest: map-fixed-invalidate
[509.680815] Subtest map-fixed-invalidate: SKIP (0.000s)
[509.807810] [119/133] (519s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[509.902551] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[509.913959] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[509.986691] [120/133] (519s left) syncobj_timeline (invalid-signal-illegal-handle)
[510.035048] Starting subtest: invalid-signal-illegal-handle
[510.035899] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[510.125140] [121/133] (519s left) kms_joiner (basic-big-joiner)
[510.226303] Starting subtest: basic-big-joiner
[510.228072] Subtest basic-big-joiner: SKIP (0.000s)
[510.291024] [122/133] (519s left) gem_tiled_pread_basic (basic)
[510.345384] Subtest basic: SKIP (0.000s)
[510.414932] [123/133] (519s left) kms_cursor_crc (cursor-offscreen-512x512)
[510.673187] Starting subtest: cursor-offscreen-512x512
[510.675150] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[510.825041] [124/133] (518s left) perf (global-sseu-config-invalid)
[510.946610] Starting subtest: global-sseu-config-invalid
[510.948386] Subtest global-sseu-config-invalid: SKIP (0.000s)
[510.990548] [125/133] (518s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[511.076956] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[518.681496] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.606s)
[518.792466] [126/133] (511s left) gem_ctx_persistence (smoketest)
[518.849083] Starting subtest: smoketest
[558.339214] Subtest smoketest: SUCCESS (39.489s)
[558.475288] [127/133] (471s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[558.577380] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[558.579152] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[558.677397] [128/133] (471s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[558.764989] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[558.765899] Starting dynamic subtest: pipe-A-eDP-1
[575.999207] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.799s)
[576.007246] Starting dynamic subtest: pipe-B-eDP-1
[594.015000] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.784s)
[594.023075] Starting dynamic subtest: pipe-C-eDP-1
[611.977764] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[611.985685] Starting dynamic subtest: pipe-D-eDP-1
[629.973001] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.741s)
[629.973974] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.091s)
[636.264862] [129/133] (398s left) gem_busy (busy)
[636.340442] Starting subtest: busy
[636.341533] Starting dynamic subtest: all-engines
[636.387827] Dynamic subtest all-engines: SUCCESS (0.047s)
[636.400952] Starting dynamic subtest: rcs0
[637.537507] Dynamic subtest rcs0: SUCCESS (1.167s)
[637.546829] Starting dynamic subtest: bcs0
[637.584001] Dynamic subtest bcs0: SUCCESS (0.050s)
[637.593216] Starting dynamic subtest: vcs0
[637.624198] Dynamic subtest vcs0: SUCCESS (0.040s)
[637.633031] Starting dynamic subtest: vcs1
[639.520583] Dynamic subtest vcs1: SUCCESS (1.939s)
[639.528846] Starting dynamic subtest: vecs0
[641.509066] Dynamic subtest vecs0: SUCCESS (2.029s)
[641.518453] Starting dynamic subtest: ccs0
[643.554279] Dynamic subtest ccs0: SUCCESS (2.079s)
[643.555244] Subtest busy: SUCCESS (7.361s)
[643.908935] [130/133] (391s left) kms_psr (pr-primary-mmap-gtt)
[644.002714] Starting subtest: pr-primary-mmap-gtt
[644.004328] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[644.084168] [131/133] (391s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[644.175888] Starting subtest: psr-shrfb-scaledprimary
[649.890987] Subtest psr-shrfb-scaledprimary: SUCCESS (5.771s)
[650.022290] [132/133] (385s left) dmabuf_sync_file (export-multiwait)
[650.065518] Starting subtest: export-multiwait
[650.067763] Subtest export-multiwait: SUCCESS (0.001s)
[650.119380] [133/133] (385s left) i915_drm_fdinfo (basics)
[650.154824] Starting subtest: basics
[650.155676] Subtest basics: SUCCESS (0.000s)
[650.215661] 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.