[59.908375] Initializing watchdogs
[59.908427]   /dev/watchdog0
[59.924870] [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]
[59.929963] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.932200] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.935873] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[60.071390] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[60.075472] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.173808] [002/133] (960s left) kms_feature_discovery (display-1x)
[60.270584] Starting subtest: display-1x
[60.272454] Subtest display-1x: SUCCESS (0.000s)
[60.340208] [003/133] (960s left) kms_vrr (flipline)
[60.429088] Starting subtest: flipline
[60.435625] Subtest flipline: SKIP (0.000s)
[60.513952] [004/133] (960s left) sw_sync (sync_busy_fork_unixsocket)
[60.551167] Starting subtest: sync_busy_fork_unixsocket
[60.556424] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[60.611971] [005/133] (959s left) kms_rotation_crc (bad-tiling)
[60.707433] Starting subtest: bad-tiling
[60.711579] Subtest bad-tiling: SKIP (0.001s)
[60.774710] [006/133] (959s left) gem_exec_reloc (basic-cpu-active)
[60.845051] Subtest basic-cpu-active: SKIP (0.000s)
[60.930290] [007/133] (959s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[60.986992] Starting subtest: y-tiled-ccs-to-yf-tiled
[60.990568] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[61.162402] [008/133] (959s left) gem_exec_fence (basic-busy)
[61.335648] Starting subtest: basic-busy
[61.338131] Starting dynamic subtest: rcs0
[61.414901] Dynamic subtest rcs0: SUCCESS (0.082s)
[61.425780] Starting dynamic subtest: bcs0
[61.482475] Dynamic subtest bcs0: SUCCESS (0.066s)
[61.490769] Starting dynamic subtest: vcs0
[61.535368] Dynamic subtest vcs0: SUCCESS (0.052s)
[61.544574] Starting dynamic subtest: vcs1
[61.590299] Dynamic subtest vcs1: SUCCESS (0.054s)
[61.599986] Starting dynamic subtest: vecs0
[61.648205] Dynamic subtest vecs0: SUCCESS (0.057s)
[61.658322] Starting dynamic subtest: ccs0
[61.699696] Dynamic subtest ccs0: SUCCESS (0.050s)
[61.702863] Subtest basic-busy: SUCCESS (0.367s)
[63.399902] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[63.403070] [009/133] (957s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[63.504360] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[63.508756] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[63.595804] [010/133] (957s left) gem_caching (writes)
[63.657265] Subtest writes: SKIP (0.000s)
[63.720868] [011/133] (957s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[63.766947] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[63.769276] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[63.874835] [012/133] (956s left) syncobj_timeline (wait-all-for-submit-snapshot)
[63.933702] Starting subtest: wait-all-for-submit-snapshot
[64.015672] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[64.105256] [013/133] (956s left) kms_sequence (queue-busy)
[64.191626] Starting subtest: queue-busy
[64.193570] Starting dynamic subtest: pipe-A-eDP-1
[66.928566] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.732s)
[66.937849] Starting dynamic subtest: pipe-B-eDP-1
[69.064440] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.137s)
[69.073592] Starting dynamic subtest: pipe-C-eDP-1
[71.677099] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.610s)
[71.685943] Starting dynamic subtest: pipe-D-eDP-1
[74.210882] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.533s)
[74.213446] Subtest queue-busy: SUCCESS (10.017s)
[75.106602] [014/133] (945s left) core_getstats (basic)
[75.167310] Starting subtest: basic
[75.169321] Subtest basic: SUCCESS (0.000s)
[75.252017] [015/133] (945s left) gem_exec_schedule (timeslicing)
[75.320828] Starting subtest: timeslicing
[75.322926] Starting dynamic subtest: rcs0
[75.332855] Dynamic subtest rcs0: SUCCESS (0.023s)
[75.342440] Starting dynamic subtest: bcs0
[75.353420] Dynamic subtest bcs0: SUCCESS (0.020s)
[75.361218] Starting dynamic subtest: vcs0
[75.373635] Dynamic subtest vcs0: SUCCESS (0.020s)
[75.381178] Starting dynamic subtest: vcs1
[75.393418] Dynamic subtest vcs1: SUCCESS (0.020s)
[75.401330] Starting dynamic subtest: vecs0
[75.414245] Dynamic subtest vecs0: SUCCESS (0.020s)
[75.421913] Starting dynamic subtest: ccs0
[75.434265] Dynamic subtest ccs0: SUCCESS (0.020s)
[75.436563] Subtest timeslicing: SUCCESS (0.124s)
[77.355991] [016/133] (943s left) kms_plane_alpha_blend (constant-alpha-min)
[77.453196] Starting subtest: constant-alpha-min
[77.743098] Starting dynamic subtest: pipe-A-eDP-1
[78.559776] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[78.567781] Starting dynamic subtest: pipe-D-eDP-1
[80.076490] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.517s)
[80.078895] Subtest constant-alpha-min: SUCCESS (2.622s)
[80.944914] [017/133] (940s left) kms_addfb_basic (unused-modifier)
[81.009274] Starting subtest: unused-modifier
[81.011790] Subtest unused-modifier: SUCCESS (0.000s)
[81.142624] [018/133] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[81.244240] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[81.248391] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[81.333343] [019/133] (939s left) dmabuf (all-tests)
[81.368457] Starting subtest: all-tests
[81.372983] Subtest all-tests: SKIP (0.000s)
[81.419987] [020/133] (939s left) gem_ctx_engines (execute-oneforall)
[81.484803] Starting subtest: execute-oneforall
[81.984073] Subtest execute-oneforall: SUCCESS (0.499s)
[83.388450] [021/133] (937s left) kms_properties (crtc-properties-legacy)
[83.490333] Starting subtest: crtc-properties-legacy
[83.492501] Starting dynamic subtest: pipe-A-eDP-1
[83.960373] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.467s)
[83.970703] Starting dynamic subtest: pipe-B-eDP-1
[85.103945] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s)
[85.115810] Starting dynamic subtest: pipe-C-eDP-1
[86.239453] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.134s)
[86.250554] Starting dynamic subtest: pipe-D-eDP-1
[87.356681] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.115s)
[87.359056] Subtest crtc-properties-legacy: SUCCESS (3.864s)
[88.173675] [022/133] (933s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[88.276045] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[88.280308] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[88.373776] [023/133] (932s left) kms_addfb_basic (bad-pitch-256)
[88.435077] Starting subtest: bad-pitch-256
[88.437090] Subtest bad-pitch-256: SUCCESS (0.000s)
[88.566984] [024/133] (932s left) kms_big_fb (x-tiled-addfb-size-overflow)
[88.663074] Starting subtest: x-tiled-addfb-size-overflow
[88.665360] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[88.760584] [025/133] (932s left) gem_ctx_persistence (hang)
[88.814846] Starting subtest: hang
[88.819271] Subtest hang: SKIP (0.000s)
[88.934691] [026/133] (932s left) gem_mmap_wc (close)
[88.989627] Subtest close: SKIP (0.000s)
[89.051178] [027/133] (932s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[89.143170] Starting subtest: bad-rotation-90-yf-tiled-ccs
[89.145210] Starting dynamic subtest: pipe-A-eDP-1
[89.165176] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[89.175112] Starting dynamic subtest: pipe-B-eDP-1
[89.192825] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[89.200332] Starting dynamic subtest: pipe-C-eDP-1
[89.218222] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[89.226968] Starting dynamic subtest: pipe-D-eDP-1
[89.245683] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[89.249228] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[91.430173] [028/133] (930s left) sw_sync (alloc_fence)
[91.466231] Starting subtest: alloc_fence
[91.468932] Subtest alloc_fence: SUCCESS (0.000s)
[91.517777] [029/133] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[91.622543] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[91.626662] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[91.721533] [030/133] (929s left) i915_suspend (fence-restore-tiled2untiled)
[91.773577] Starting subtest: fence-restore-tiled2untiled
[91.777731] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[91.870540] [031/133] (929s left) i915_hangman (gt-engine-error)
[91.935228] Starting subtest: gt-engine-error
[91.937062] Starting dynamic subtest: rcs0
[93.287442] Dynamic subtest rcs0: SUCCESS (1.351s)
[93.297617] Starting dynamic subtest: bcs0
[97.251618] Dynamic subtest bcs0: SUCCESS (3.962s)
[97.262814] Starting dynamic subtest: vcs0
[99.236436] Dynamic subtest vcs0: SUCCESS (1.982s)
[99.247517] Starting dynamic subtest: vcs1
[101.220315] Dynamic subtest vcs1: SUCCESS (1.983s)
[101.230433] Starting dynamic subtest: vecs0
[103.267878] Dynamic subtest vecs0: SUCCESS (2.046s)
[103.280918] Starting dynamic subtest: ccs0
[105.251859] Dynamic subtest ccs0: SUCCESS (1.983s)
[105.254840] Subtest gt-engine-error: SUCCESS (13.316s)
[105.333894] [032/133] (916s left) kms_content_protection (dp-mst-type-1)
[105.483128] Starting subtest: dp-mst-type-1
[105.487399] Subtest dp-mst-type-1: SKIP (0.000s)
[105.623838] [033/133] (916s left) kms_big_fb (linear-32bpp-rotate-90)
[105.730857] Starting subtest: linear-32bpp-rotate-90
[105.749968] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[105.851159] [034/133] (915s left) kms_plane_cursor (primary)
[105.942192] Starting subtest: primary
[105.946703] Starting dynamic subtest: pipe-A-eDP-1-size-64
[108.508275] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.566s)
[108.527830] Starting dynamic subtest: pipe-A-eDP-1-size-128
[111.106593] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[111.130194] Starting dynamic subtest: pipe-A-eDP-1-size-256
[113.729564] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.605s)
[114.054309] Starting dynamic subtest: pipe-B-eDP-1-size-64
[117.324531] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.278s)
[117.349106] Starting dynamic subtest: pipe-B-eDP-1-size-128
[119.915106] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.572s)
[119.937777] Starting dynamic subtest: pipe-B-eDP-1-size-256
[122.504959] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.572s)
[122.819356] Starting dynamic subtest: pipe-C-eDP-1-size-64
[125.716279] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.907s)
[125.742546] Starting dynamic subtest: pipe-C-eDP-1-size-128
[128.005550] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.269s)
[128.031748] Starting dynamic subtest: pipe-C-eDP-1-size-256
[130.283320] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.258s)
[130.608848] Starting dynamic subtest: pipe-D-eDP-1-size-64
[133.572326] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.978s)
[133.598971] Starting dynamic subtest: pipe-D-eDP-1-size-128
[135.794521] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[135.821183] Starting dynamic subtest: pipe-D-eDP-1-size-256
[138.039388] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.225s)
[138.348244] Subtest primary: SUCCESS (32.406s)
[139.171827] [035/133] (882s left) kms_psr (fbc-pr-primary-render)
[139.263316] Starting subtest: fbc-pr-primary-render
[139.267677] Subtest fbc-pr-primary-render: SKIP (0.000s)
[139.346895] [036/133] (882s left) gem_lmem_swapping (parallel-random)
[139.391609] Subtest parallel-random: SKIP (0.000s)
[139.431734] [037/133] (882s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[139.481725] Starting subtest: invalid-multi-wait-unsubmitted
[139.484086] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[139.577276] [038/133] (882s left) kms_cursor_crc (cursor-random-64x21)
[139.762874] Starting subtest: cursor-random-64x21
[139.813671] Subtest cursor-random-64x21: SKIP (0.044s)
[140.048695] [039/133] (881s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[140.131127] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[140.132840] Starting dynamic subtest: pipe-A-eDP-1
[142.439300] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.309s)
[142.447110] Starting dynamic subtest: pipe-B-eDP-1
[144.911922] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.471s)
[144.920137] Starting dynamic subtest: pipe-C-eDP-1
[147.104573] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.191s)
[147.116882] Starting dynamic subtest: pipe-D-eDP-1
[149.344422] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.239s)
[149.346432] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.215s)
[150.508465] [040/133] (871s left) gem_caching (read-writes)
[150.561390] Subtest read-writes: SKIP (0.000s)
[150.637865] [041/133] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[150.726955] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[150.731328] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[150.819670] [042/133] (871s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[150.918684] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[155.466289] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.551s)
[156.632900] [043/133] (865s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[156.720545] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[164.130650] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.413s)
[164.278155] [044/133] (857s left) gem_ctx_persistence (engines-mixed)
[164.340409] Starting subtest: engines-mixed
[164.342811] Starting dynamic subtest: rcs0
[164.417650] Dynamic subtest rcs0: SUCCESS (0.077s)
[164.433765] Starting dynamic subtest: bcs0
[164.473734] Dynamic subtest bcs0: SUCCESS (0.053s)
[164.487498] Starting dynamic subtest: vcs0
[164.524800] Dynamic subtest vcs0: SUCCESS (0.049s)
[164.534508] Starting dynamic subtest: vcs1
[164.585368] Dynamic subtest vcs1: SUCCESS (0.058s)
[164.595816] Starting dynamic subtest: vecs0
[164.650981] Dynamic subtest vecs0: SUCCESS (0.064s)
[164.661776] Starting dynamic subtest: ccs0
[164.714226] Dynamic subtest ccs0: SUCCESS (0.060s)
[164.716897] Subtest engines-mixed: SUCCESS (0.374s)
[164.805321] [045/133] (857s left) gen7_exec_parse (basic-offset)
[164.873062] Subtest basic-offset: SKIP (0.000s)
[164.943588] [046/133] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[165.036659] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[165.040793] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[165.134330] [047/133] (857s left) gem_exec_whisper (basic-fds-forked-all)
[165.204113] Starting subtest: basic-fds-forked-all
[185.467540] Subtest basic-fds-forked-all: SUCCESS (20.261s)
[185.650974] [048/133] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[185.755666] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[185.759767] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[185.851155] [049/133] (836s left) kms_joiner (invalid-modeset-force-big-joiner)
[185.952770] Starting subtest: invalid-modeset-force-big-joiner
[185.956814] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[186.053134] [050/133] (836s left) gem_mmap_gtt (big-bo)
[186.119152] Subtest big-bo: SKIP (0.000s)
[186.184095] [051/133] (836s left) gem_exec_alignment (many)
[186.249695] Starting subtest: many
[209.958712] Subtest many: SUCCESS (23.706s)
[211.344184] [052/133] (811s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[211.456210] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[211.562086] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[211.639449] [053/133] (810s left) gem_render_copy (y-tiled)
[211.702520] Starting subtest: y-tiled
[211.707270] Subtest y-tiled: SKIP (0.000s)
[211.885492] [054/133] (810s left) gem_mmap_wc (write-wc-read-gtt)
[211.944978] Subtest write-wc-read-gtt: SKIP (0.000s)
[212.012143] [055/133] (810s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[212.119939] Starting subtest: fb-8bpc-vs-panel-6bpc
[212.122271] Starting dynamic subtest: pipe-A-eDP-1
[213.522857] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.401s)
[213.524806] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.402s)
[214.323461] [056/133] (808s left) kms_vblank (wait-forked-hang)
[214.414304] Starting subtest: wait-forked-hang
[214.416326] Starting dynamic subtest: pipe-A-eDP-1
[241.096290] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.678s)
[241.112696] Starting dynamic subtest: pipe-D-eDP-1
[256.072207] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.973s)
[256.074414] Subtest wait-forked-hang: SUCCESS (41.656s)
[256.883553] [057/133] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[257.002856] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[261.441476] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.444s)
[262.620470] [058/133] (760s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[262.727479] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[263.373727] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[263.550559] [059/133] (759s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[263.637267] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[267.752882] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.118s)
[268.912630] [060/133] (753s left) sw_sync (sync_merge_same)
[268.947066] Starting subtest: sync_merge_same
[268.949269] Subtest sync_merge_same: SUCCESS (0.000s)
[268.998198] [061/133] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[269.090080] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[269.094301] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[269.211052] [062/133] (753s left) kms_busy (basic)
[269.317353] Starting subtest: basic
[269.319497] Starting dynamic subtest: flip
[269.897891] Dynamic subtest flip: SUCCESS (0.579s)
[269.907883] Starting dynamic subtest: modeset
[273.327686] Dynamic subtest modeset: SUCCESS (3.428s)
[273.330078] Subtest basic: SUCCESS (4.010s)
[274.130701] [063/133] (748s left) gem_lmem_swapping (verify-random-ccs)
[274.183286] Subtest verify-random-ccs: SKIP (0.000s)
[274.225077] [064/133] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[274.319505] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[274.324058] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[274.431835] [065/133] (748s left) kms_prop_blob (blob-multiple)
[274.488400] Starting subtest: blob-multiple
[274.490773] Subtest blob-multiple: SUCCESS (0.002s)
[274.594213] [066/133] (748s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[274.681917] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[274.685975] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[274.755314] [067/133] (748s left) kms_psr (fbc-pr-primary-mmap-cpu)
[274.843212] Starting subtest: fbc-pr-primary-mmap-cpu
[274.847724] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[274.912583] [068/133] (748s left) gem_mmap_gtt (zero-extend)
[274.973697] Subtest zero-extend: SKIP (0.000s)
[275.034086] [069/133] (748s left) gem_exec_fence (syncobj-timeline-export)
[275.606971] Starting subtest: syncobj-timeline-export
[275.609125] Subtest syncobj-timeline-export: SUCCESS (0.006s)
[277.397310] [070/133] (745s left) kms_psr (fbc-psr-sprite-plane-onoff)
[277.494823] Starting subtest: fbc-psr-sprite-plane-onoff
[277.497100] Starting dynamic subtest: eDP-1
[277.501438] Dynamic subtest eDP-1: SKIP (0.000s)
[277.505796] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[277.568445] [071/133] (745s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[277.669285] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[277.671611] Starting dynamic subtest: pipe-A-eDP-1
[277.695779] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[277.707338] Starting dynamic subtest: pipe-B-eDP-1
[277.728412] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[277.737059] Starting dynamic subtest: pipe-C-eDP-1
[277.758485] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[277.766775] Starting dynamic subtest: pipe-D-eDP-1
[277.788391] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[277.792794] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[280.009225] [072/133] (743s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[280.126392] Starting subtest: cursorA-vs-flipA-legacy
[291.260802] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.133s)
[292.135503] [073/133] (731s left) kms_atomic_interruptible (legacy-setmode)
[292.225224] Starting subtest: legacy-setmode
[292.227365] Starting dynamic subtest: pipe-A-eDP-1
[299.139335] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.911s)
[299.141278] Subtest legacy-setmode: SUCCESS (6.912s)
[300.008775] [074/133] (723s left) i915_pm_rps (reset)
[300.078804] Starting subtest: reset
[308.540111] Subtest reset: SUCCESS (8.446s)
[308.646389] [075/133] (714s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[308.737987] Starting subtest: crc-primary-suspend-y-tiled-ccs
[308.740218] Starting dynamic subtest: pipe-A-eDP-1
[308.749267] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[308.761821] Starting dynamic subtest: pipe-B-eDP-1
[308.771600] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[308.780770] Starting dynamic subtest: pipe-C-eDP-1
[308.789179] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[308.797726] Starting dynamic subtest: pipe-D-eDP-1
[308.806672] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[308.810751] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[310.974548] [076/133] (712s left) kms_addfb_basic (small-bo)
[311.064043] Starting subtest: small-bo
[311.066270] Subtest small-bo: SUCCESS (0.000s)
[311.174567] [077/133] (712s left) kms_addfb_basic (invalid-get-prop-any)
[311.230874] Starting subtest: invalid-get-prop-any
[311.233334] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[311.392425] [078/133] (712s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[311.495866] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[311.507475] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.012s)
[311.594962] [079/133] (712s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[311.688970] Starting subtest: psr-indfb-scaledprimary
[317.451175] Subtest psr-indfb-scaledprimary: SUCCESS (5.764s)
[317.563675] [080/133] (706s left) gem_close (many-handles-one-vma)
[317.624591] Starting subtest: many-handles-one-vma
[317.649382] Subtest many-handles-one-vma: SUCCESS (0.025s)
[317.774100] [081/133] (705s left) kms_plane (plane-panning-bottom-right)
[317.867182] Starting subtest: plane-panning-bottom-right
[317.869420] Starting dynamic subtest: pipe-A
[319.548728] Dynamic subtest pipe-A: SUCCESS (1.680s)
[319.558227] Starting dynamic subtest: pipe-B
[321.931313] Dynamic subtest pipe-B: SUCCESS (2.383s)
[321.933849] Subtest plane-panning-bottom-right: SUCCESS (4.066s)
[322.820571] [082/133] (700s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[322.955466] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[322.960051] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[323.099937] [083/133] (700s left) kms_cursor_edge_walk (128x128-top-edge)
[323.185951] Starting subtest: 128x128-top-edge
[323.188317] Starting dynamic subtest: pipe-A-eDP-1
[326.695765] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.511s)
[326.704939] Starting dynamic subtest: pipe-D-eDP-1
[329.822304] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[329.824609] Subtest 128x128-top-edge: SUCCESS (6.638s)
[330.630605] [084/133] (693s left) gen7_exec_parse (chained-batch)
[330.689073] Subtest chained-batch: SKIP (0.000s)
[330.765899] [085/133] (693s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[330.856308] Starting subtest: primary-yf-tiled-reflect-x-180
[330.918356] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[331.019651] [086/133] (692s left) kms_frontbuffer_tracking (fbc-tiling-y)
[331.124672] Starting subtest: fbc-tiling-y
[331.128915] Subtest fbc-tiling-y: SKIP (0.000s)
[331.235193] [087/133] (692s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[331.296433] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[331.401386] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[331.478854] [088/133] (692s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[331.577583] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[331.581764] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[331.697222] [089/133] (692s left) kms_cursor_crc (cursor-onscreen-64x21)
[331.903847] Starting subtest: cursor-onscreen-64x21
[331.955718] Subtest cursor-onscreen-64x21: SKIP (0.047s)
[332.219224] [090/133] (691s left) kms_rmfb (close-fd)
[332.319972] Starting subtest: close-fd
[332.321919] Starting dynamic subtest: pipe-A-eDP-1
[332.427860] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[332.438014] Starting dynamic subtest: pipe-B-eDP-1
[333.579461] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.151s)
[333.590020] Starting dynamic subtest: pipe-C-eDP-1
[334.812350] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.230s)
[334.822929] Starting dynamic subtest: pipe-D-eDP-1
[335.941274] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[335.943457] Subtest close-fd: SUCCESS (3.622s)
[337.078283] [091/133] (687s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[337.195604] Starting subtest: 2x-long-cursor-vs-flip-legacy
[337.200147] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[337.345179] [092/133] (686s left) gem_softpin (evict-prime-sanity-check)
[337.396104] Starting subtest: evict-prime-sanity-check
[337.398453] Starting dynamic subtest: rcs0
[338.552074] Dynamic subtest rcs0: SUCCESS (1.156s)
[338.563827] Starting dynamic subtest: bcs0
[339.662836] Dynamic subtest bcs0: SUCCESS (1.110s)
[339.672278] Starting dynamic subtest: vcs0
[341.292056] Dynamic subtest vcs0: SUCCESS (1.626s)
[341.304639] Starting dynamic subtest: vcs1
[343.288514] Dynamic subtest vcs1: SUCCESS (1.994s)
[343.300549] Starting dynamic subtest: vecs0
[345.283654] Dynamic subtest vecs0: SUCCESS (1.992s)
[345.296047] Starting dynamic subtest: ccs0
[346.396765] Dynamic subtest ccs0: SUCCESS (1.112s)
[346.408995] Starting dynamic subtest: all
[347.527091] Dynamic subtest all: SUCCESS (1.129s)
[347.529665] Subtest evict-prime-sanity-check: SUCCESS (10.132s)
[347.610656] [093/133] (676s left) kms_psr (pr-basic)
[347.702857] Starting subtest: pr-basic
[347.706731] Subtest pr-basic: SKIP (0.000s)
[347.773621] [094/133] (676s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[347.835588] Starting subtest: multi-wait-all-for-submit-signaled
[347.837958] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[347.951279] [095/133] (676s left) i915_drm_fdinfo (busy-idle)
[347.990579] Starting subtest: busy-idle
[347.992767] Starting dynamic subtest: rcs0
[348.018966] Dynamic subtest rcs0: SKIP (0.028s)
[348.029135] Starting dynamic subtest: bcs0
[348.033194] Dynamic subtest bcs0: SKIP (0.000s)
[348.042635] Starting dynamic subtest: vcs0
[348.047086] Dynamic subtest vcs0: SKIP (0.000s)
[348.056060] Starting dynamic subtest: vcs1
[348.061317] Dynamic subtest vcs1: SKIP (0.000s)
[348.070141] Starting dynamic subtest: vecs0
[348.074116] Dynamic subtest vecs0: SKIP (0.000s)
[348.082781] Starting dynamic subtest: ccs0
[348.086699] Dynamic subtest ccs0: SKIP (0.000s)
[348.090672] Subtest busy-idle: SKIP (0.034s)
[348.127330] [096/133] (676s left) kms_plane_scaling (planes-downscale-factor-0-5)
[348.213149] Starting subtest: planes-downscale-factor-0-5
[348.215401] Starting dynamic subtest: pipe-A
[348.237631] Dynamic subtest pipe-A: SKIP (0.022s)
[348.247024] Starting dynamic subtest: pipe-B
[348.271465] Dynamic subtest pipe-B: SKIP (0.032s)
[348.280790] Starting dynamic subtest: pipe-C
[348.308527] Dynamic subtest pipe-C: SKIP (0.033s)
[348.318782] Starting dynamic subtest: pipe-D
[348.339209] Dynamic subtest pipe-D: SKIP (0.033s)
[348.342944] Subtest planes-downscale-factor-0-5: SKIP (0.124s)
[348.461466] [097/133] (675s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[348.560595] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[348.564360] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[348.674142] [098/133] (675s left) gem_ccs (large-ctrl-surf-copy)
[348.739062] Starting subtest: large-ctrl-surf-copy
[348.742852] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[348.857713] [099/133] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[348.956796] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[348.960257] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[349.053708] [100/133] (675s left) perf_pmu (invalid-open)
[349.092924] Starting subtest: invalid-open
[349.094600] Subtest invalid-open: SUCCESS (0.000s)
[349.199463] [101/133] (675s left) gem_exec_balancer (nop)
[349.262459] Starting subtest: nop
[396.061390] Subtest nop: SUCCESS (46.796s)
[396.374355] [102/133] (628s left) vgem_basic (bad-pad)
[396.422555] Starting subtest: bad-pad
[396.424795] Subtest bad-pad: SUCCESS (0.000s)
[396.486119] [103/133] (628s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[396.588333] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[396.590302] Starting dynamic subtest: pipe-A-eDP-1
[397.920371] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.332s)
[398.201694] Starting dynamic subtest: pipe-B-eDP-1
[399.243223] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s)
[399.516535] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.930s)
[400.359639] [104/133] (624s left) kms_atomic_transition (modeset-transition)
[400.441750] Starting subtest: modeset-transition
[400.444085] Starting dynamic subtest: 1x-outputs
[411.229191] Dynamic subtest 1x-outputs: SUCCESS (10.789s)
[411.231835] Subtest modeset-transition: SUCCESS (10.790s)
[412.090618] [105/133] (612s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[412.480469] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[413.294844] [106/133] (611s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[413.355819] Starting subtest: multi-wait-available-unsubmitted-submitted
[413.358041] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[413.445293] [107/133] (611s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[413.499213] Starting subtest: yf-tiled-ccs-to-x-tiled
[413.503525] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[413.684445] [108/133] (611s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[413.780600] Starting subtest: addfb25-y-tiled-legacy
[413.782643] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[413.888762] [109/133] (610s left) sw_sync (timeline_closed_signaled)
[413.923242] Starting subtest: timeline_closed_signaled
[413.925632] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[413.982884] [110/133] (610s left) kms_cdclk (mode-transition)
[414.084299] Starting subtest: mode-transition
[414.086461] Starting dynamic subtest: pipe-A-eDP-1
[414.396198] Dynamic subtest pipe-A-eDP-1: SKIP (0.309s)
[414.406063] Starting dynamic subtest: pipe-B-eDP-1
[414.410777] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[414.420671] Starting dynamic subtest: pipe-C-eDP-1
[414.425201] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[414.435359] Starting dynamic subtest: pipe-D-eDP-1
[414.439583] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[414.443686] Subtest mode-transition: SKIP (0.317s)
[415.236929] [111/133] (609s left) gem_exec_reloc (basic-wc-read)
[415.304416] Subtest basic-wc-read: SKIP (0.000s)
[415.394887] [112/133] (609s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[415.483972] Starting subtest: plane-lut1d-ctm3x4
[415.632137] Starting dynamic subtest: pipe-A-plane-0
[415.808587] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[415.818516] Starting dynamic subtest: pipe-A-plane-1
[415.998083] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[416.007922] Starting dynamic subtest: pipe-A-plane-2
[416.163389] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[417.394738] Starting dynamic subtest: pipe-B-plane-0
[417.564852] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[417.574619] Starting dynamic subtest: pipe-B-plane-1
[417.720401] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[417.730792] Starting dynamic subtest: pipe-B-plane-2
[417.887211] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[419.096105] Starting dynamic subtest: pipe-C-plane-0
[419.232368] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[419.242222] Starting dynamic subtest: pipe-C-plane-1
[419.398831] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[419.411237] Starting dynamic subtest: pipe-C-plane-2
[419.567039] Dynamic subtest pipe-C-plane-2: SUCCESS (0.165s)
[420.758127] Starting dynamic subtest: pipe-D-plane-0
[420.912817] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[420.922740] Starting dynamic subtest: pipe-D-plane-1
[421.068797] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[421.079430] Starting dynamic subtest: pipe-D-plane-2
[421.224929] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[421.515558] Subtest plane-lut1d-ctm3x4: SUCCESS (6.032s)
[422.391138] [113/133] (602s left) kms_pm_rpm (drm-resources-equal)
[424.523640] Starting subtest: drm-resources-equal
[429.560236] Subtest drm-resources-equal: SUCCESS (5.035s)
[429.657065] [114/133] (595s left) perf (i915-ref-count)
[429.742818] Starting subtest: i915-ref-count
[429.824115] Subtest i915-ref-count: SUCCESS (0.080s)
[429.890904] [115/133] (595s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[429.983910] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[436.864902] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.884s)
[436.980744] [116/133] (588s left) api_intel_bb (bb-with-allocator)
[437.042729] Starting subtest: bb-with-allocator
[437.048940] Subtest bb-with-allocator: SUCCESS (0.008s)
[437.172443] [117/133] (588s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[437.273162] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[437.277566] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[437.363118] [118/133] (587s left) gem_tiled_blits (normal)
[437.424798] Subtest normal: SKIP (0.000s)
[437.497816] [119/133] (587s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[437.592319] Starting subtest: pixel-format-y-tiled-ccs-modifier
[437.596721] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[437.677725] [120/133] (587s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[437.796861] Starting subtest: cursorA-vs-flipB-varying-size
[437.800734] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[437.940418] [121/133] (587s left) gem_mmap_wc (write-cpu-read-wc)
[437.989912] Subtest write-cpu-read-wc: SKIP (0.000s)
[438.058803] [122/133] (587s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[438.149856] Starting subtest: pr-plane-move-sf-dmg-area
[438.153509] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[438.219890] [123/133] (587s left) kms_legacy_colorkey (invalid-plane)
[438.325842] Starting subtest: invalid-plane
[438.327751] Starting dynamic subtest: zero-id
[438.329718] Dynamic subtest zero-id: SUCCESS (0.000s)
[438.339121] Starting dynamic subtest: outrange-id
[438.341065] Dynamic subtest outrange-id: SUCCESS (0.000s)
[438.342648] Subtest invalid-plane: SUCCESS (0.001s)
[438.398658] [124/133] (587s left) kms_properties (colorop-properties-legacy)
[438.500771] Starting subtest: colorop-properties-legacy
[438.502413] Starting dynamic subtest: pipe-A-eDP-1
[438.842776] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.340s)
[438.853579] Starting dynamic subtest: pipe-B-eDP-1
[439.881889] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.040s)
[439.892574] Starting dynamic subtest: pipe-C-eDP-1
[440.922461] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.037s)
[440.932607] Starting dynamic subtest: pipe-D-eDP-1
[441.948690] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.027s)
[441.951216] Subtest colorop-properties-legacy: SUCCESS (3.449s)
[442.756601] [125/133] (582s left) gem_create (create-valid-nonaligned)
[442.815043] Starting subtest: create-valid-nonaligned
[442.817269] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[443.001246] [126/133] (582s left) gem_render_copy_redux (flink-interruptible)
[443.057021] Starting subtest: flink-interruptible
[443.899225] Subtest flink-interruptible: SUCCESS (0.845s)
[444.018208] [127/133] (581s left) kms_psr (psr-basic)
[444.104473] Starting subtest: psr-basic
[444.106360] Starting dynamic subtest: eDP-1
[445.735691] Dynamic subtest eDP-1: SUCCESS (1.632s)
[445.738081] Subtest psr-basic: SUCCESS (1.633s)
[446.603493] [128/133] (579s left) kms_psr (psr-primary-render)
[446.696232] Starting subtest: psr-primary-render
[446.698481] Starting dynamic subtest: eDP-1
[448.410256] Dynamic subtest eDP-1: SUCCESS (1.714s)
[448.412503] Subtest psr-primary-render: SUCCESS (1.715s)
[449.259702] [129/133] (576s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[449.357903] Starting subtest: yf-tiled-64bpp-rotate-90
[449.362144] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[449.453386] [130/133] (576s left) gem_exec_schedule (pi-shared-iova)
[449.634263] Starting subtest: pi-shared-iova
[449.636542] Starting dynamic subtest: rcs0
[449.716464] Dynamic subtest rcs0: SUCCESS (0.083s)
[449.726552] Starting dynamic subtest: vcs0
[449.777358] Dynamic subtest vcs0: SUCCESS (0.060s)
[449.787455] Starting dynamic subtest: vcs1
[449.836256] Dynamic subtest vcs1: SUCCESS (0.059s)
[449.848452] Starting dynamic subtest: vecs0
[449.892061] Dynamic subtest vecs0: SUCCESS (0.055s)
[449.901544] Starting dynamic subtest: ccs0
[449.968900] Dynamic subtest ccs0: SUCCESS (0.074s)
[449.971395] Subtest pi-shared-iova: SUCCESS (0.337s)
[451.353353] [131/133] (574s left) gem_exec_reloc (basic-active)
[451.401633] Subtest basic-active: SKIP (0.000s)
[451.468484] [132/133] (574s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[451.847820] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[452.672044] [133/133] (573s left) prime_busy (hang-wait)
[452.734586] Starting subtest: hang-wait
[452.737090] Starting dynamic subtest: rcs0
[478.756593] Dynamic subtest rcs0: SUCCESS (26.016s)
[478.767560] Starting dynamic subtest: bcs0
[485.913829] Dynamic subtest bcs0: SUCCESS (7.156s)
[485.922900] Starting dynamic subtest: vcs0
[492.887341] Dynamic subtest vcs0: SUCCESS (6.972s)
[492.898040] Starting dynamic subtest: vcs1
[499.924081] Dynamic subtest vcs1: SUCCESS (7.036s)
[499.935731] Starting dynamic subtest: vecs0
[506.899824] Dynamic subtest vecs0: SUCCESS (6.974s)
[506.911446] Starting dynamic subtest: ccs0
[520.739795] Dynamic subtest ccs0: SUCCESS (13.839s)
[520.742180] Subtest hang-wait: SUCCESS (68.001s)
[520.871813] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_feature_discovery
results: parsing output: 2/ for test: kms_vrr
results: parsing output: 3/ for test: sw_sync
results: parsing output: 4/ for test: kms_rotation_crc
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_caching
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_sequence
results: parsing output: 13/ for test: core_getstats
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_plane_alpha_blend
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: dmabuf
results: parsing output: 19/ for test: gem_ctx_engines
results: parsing output: 20/ for test: kms_properties
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: gem_mmap_wc
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: sw_sync
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: i915_suspend
results: parsing output: 30/ for test: i915_hangman
results: parsing output: 31/ for test: kms_content_protection
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_plane_cursor
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_lmem_swapping
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_caching
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: gen7_exec_parse
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_whisper
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_joiner
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: gem_exec_alignment
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: gem_mmap_wc
results: parsing output: 54/ for test: kms_dither
results: parsing output: 55/ for test: kms_vblank
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: sw_sync
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_busy
results: parsing output: 62/ for test: gem_lmem_swapping
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_prop_blob
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: gem_exec_fence
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_atomic_interruptible
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_close
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_cursor_edge_walk
results: parsing output: 83/ for test: gen7_exec_parse
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_rmfb
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_softpin
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_ccs
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: vgem_basic
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: kms_atomic_transition
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: sw_sync
results: parsing output: 109/ for test: kms_cdclk
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_color_pipeline
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: gem_tiled_blits
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_legacy_colorkey
results: parsing output: 123/ for test: kms_properties
results: parsing output: 124/ for test: gem_create
results: parsing output: 125/ for test: gem_render_copy_redux
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_chamelium_edid
results: parsing output: 132/ for test: prime_busy
Done.