[55.786569] Initializing watchdogs
[55.786617]   /dev/watchdog0
[55.798890] [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]
[55.803109] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.805135] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.808221] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[55.983400] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[60.765063] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.771s)
[60.892796] [002/130] (955s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[60.953840] Starting subtest: invalid-multi-wait-unsubmitted
[60.955796] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[61.044045] [003/130] (955s left) gem_exec_whisper (basic-fds-all)
[61.118764] Starting subtest: basic-fds-all
[72.267296] Subtest basic-fds-all: SUCCESS (11.133s)
[72.442504] [004/130] (943s left) perf_pmu (idle-no-semaphores)
[72.483593] Starting subtest: idle-no-semaphores
[72.485922] Starting dynamic subtest: rcs0
[73.042314] Dynamic subtest rcs0: SUCCESS (0.558s)
[73.051281] Starting dynamic subtest: bcs0
[73.576258] Dynamic subtest bcs0: SUCCESS (0.533s)
[73.586446] Starting dynamic subtest: vcs0
[74.098076] Dynamic subtest vcs0: SUCCESS (0.521s)
[74.107302] Starting dynamic subtest: vcs1
[74.626376] Dynamic subtest vcs1: SUCCESS (0.527s)
[74.636262] Starting dynamic subtest: vecs0
[75.143895] Dynamic subtest vecs0: SUCCESS (0.516s)
[75.153291] Starting dynamic subtest: ccs0
[75.670462] Dynamic subtest ccs0: SUCCESS (0.526s)
[75.673254] Subtest idle-no-semaphores: SUCCESS (3.185s)
[75.784570] [005/130] (940s left) gem_exec_reloc (basic-write-cpu-noreloc)
[75.845817] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[75.925914] [006/130] (940s left) kms_color (ctm-signed)
[76.026856] Starting subtest: ctm-signed
[76.029221] Starting dynamic subtest: pipe-A-eDP-1
[78.055938] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.026s)
[78.064997] Starting dynamic subtest: pipe-B-eDP-1
[80.772745] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.716s)
[80.780817] Starting dynamic subtest: pipe-C-eDP-1
[83.382274] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.610s)
[83.391534] Starting dynamic subtest: pipe-D-eDP-1
[86.051948] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.668s)
[86.054402] Subtest ctm-signed: SUCCESS (10.022s)
[86.889069] [007/130] (929s left) gem_exec_parallel (fds)
[86.955091] Starting subtest: fds
[86.957492] Starting dynamic subtest: rcs0
[89.374715] Dynamic subtest rcs0: SUCCESS (2.419s)
[89.384532] Starting dynamic subtest: bcs0
[92.915190] Dynamic subtest bcs0: SUCCESS (3.537s)
[92.927574] Starting dynamic subtest: vcs0
[97.116340] Dynamic subtest vcs0: SUCCESS (4.200s)
[97.126377] Starting dynamic subtest: vcs1
[101.145815] Dynamic subtest vcs1: SUCCESS (4.028s)
[101.155571] Starting dynamic subtest: vecs0
[105.154649] Dynamic subtest vecs0: SUCCESS (4.009s)
[105.162238] Starting dynamic subtest: ccs0
[108.352391] Dynamic subtest ccs0: SUCCESS (3.196s)
[108.355329] Subtest fds: SUCCESS (21.394s)
[108.533198] [008/130] (908s left) syncobj_timeline (32bits-limit)
[108.588137] Starting subtest: 32bits-limit
[108.590586] Subtest 32bits-limit: SUCCESS (0.001s)
[108.680833] [009/130] (907s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[108.789438] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[108.793651] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[108.861400] [010/130] (907s left) kms_joiner (basic-big-joiner)
[108.968049] Starting subtest: basic-big-joiner
[108.972216] Subtest basic-big-joiner: SKIP (0.000s)
[109.024037] [011/130] (907s left) kms_pm_dc (dc5-psr)
[110.129224] Starting subtest: dc5-psr
[113.103486] Subtest dc5-psr: SUCCESS (2.973s)
[113.910506] [012/130] (902s left) kms_getfb (getfb-handle-closed)
[113.972897] Starting subtest: getfb-handle-closed
[113.975450] Subtest getfb-handle-closed: SUCCESS (0.000s)
[114.076886] [013/130] (902s left) gem_mmap_gtt (basic-write)
[114.137818] Subtest basic-write: SKIP (0.000s)
[114.189914] [014/130] (902s left) gem_wait (wait)
[114.260735] Starting subtest: wait
[114.263066] Starting dynamic subtest: all-engines
[115.946225] Dynamic subtest all-engines: SUCCESS (1.683s)
[115.959668] Starting dynamic subtest: rcs0
[116.992329] Dynamic subtest rcs0: SUCCESS (1.048s)
[117.001104] Starting dynamic subtest: bcs0
[118.039483] Dynamic subtest bcs0: SUCCESS (1.047s)
[118.047614] Starting dynamic subtest: vcs0
[119.083654] Dynamic subtest vcs0: SUCCESS (1.043s)
[119.092985] Starting dynamic subtest: vcs1
[120.127549] Dynamic subtest vcs1: SUCCESS (1.043s)
[120.136075] Starting dynamic subtest: vecs0
[121.172462] Dynamic subtest vecs0: SUCCESS (1.044s)
[121.189307] Starting dynamic subtest: ccs0
[122.219867] Dynamic subtest ccs0: SUCCESS (1.047s)
[122.222610] Subtest wait: SUCCESS (7.959s)
[122.409318] [015/130] (894s left) gem_exec_params (no-blt)
[122.458718] Starting subtest: no-blt
[122.463687] Subtest no-blt: SUCCESS (0.003s)
[122.580841] [016/130] (894s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[122.688394] Starting subtest: 4-tiled-8bpp-rotate-180
[123.809874] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.123s)
[123.949398] [017/130] (892s left) gem_exec_balancer (nohangcheck)
[124.193952] Starting subtest: nohangcheck
[124.910243] Subtest nohangcheck: SUCCESS (0.715s)
[125.046254] [018/130] (891s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[125.160010] Starting subtest: yf-tiled-16bpp-rotate-90
[125.164340] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[125.265677] [019/130] (891s left) kms_flip (wf_vblank-ts-check)
[125.363100] Starting subtest: wf_vblank-ts-check
[125.365421] Starting dynamic subtest: A-eDP1
[134.256042] Dynamic subtest A-eDP1: SUCCESS (8.892s)
[134.265502] Starting dynamic subtest: B-eDP1
[143.183333] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[143.191733] Starting dynamic subtest: C-eDP1
[152.099573] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[152.108241] Starting dynamic subtest: D-eDP1
[161.029674] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[161.035158] Subtest wf_vblank-ts-check: SUCCESS (35.670s)
[162.242262] [020/130] (854s left) gem_exec_schedule (submit-late-slice)
[162.318411] Starting subtest: submit-late-slice
[162.320377] Starting dynamic subtest: rcs0
[162.341220] Dynamic subtest rcs0: SUCCESS (0.030s)
[162.351486] Starting dynamic subtest: bcs0
[162.367366] Dynamic subtest bcs0: SUCCESS (0.026s)
[162.374727] Starting dynamic subtest: vcs0
[162.398700] Dynamic subtest vcs0: SUCCESS (0.031s)
[162.407092] Starting dynamic subtest: vcs1
[162.428169] Dynamic subtest vcs1: SUCCESS (0.029s)
[162.435752] Starting dynamic subtest: vecs0
[162.456594] Dynamic subtest vecs0: SUCCESS (0.028s)
[162.464718] Starting dynamic subtest: ccs0
[162.487449] Dynamic subtest ccs0: SUCCESS (0.030s)
[162.489700] Subtest submit-late-slice: SUCCESS (0.176s)
[164.060870] [021/130] (852s left) kms_psr (psr2-sprite-blt)
[164.154131] Starting subtest: psr2-sprite-blt
[164.156328] Starting dynamic subtest: eDP-1
[165.829263] Dynamic subtest eDP-1: SUCCESS (1.673s)
[165.831547] Subtest psr2-sprite-blt: SUCCESS (1.673s)
[166.695147] [022/130] (850s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[166.798480] Starting subtest: fbc-farfromfence-mmap-gtt
[166.802949] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[166.905042] [023/130] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[167.005036] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[167.009159] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[167.098345] [024/130] (849s left) gem_basic (create-close)
[167.161874] Starting subtest: create-close
[167.166232] Subtest create-close: SUCCESS (0.000s)
[167.262905] [025/130] (849s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[167.352892] Starting subtest: sprite-rotation-90-pos-100-0
[167.357433] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[167.418175] [026/130] (849s left) gem_mmap_gtt (cpuset-big-copy-xy)
[167.477826] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[167.532045] [027/130] (849s left) gem_basic (create-fd-close)
[167.585357] Starting subtest: create-fd-close
[167.589918] Subtest create-fd-close: SUCCESS (0.000s)
[167.660132] [028/130] (849s left) kms_psr (fbc-psr-dpms)
[167.751064] Starting subtest: fbc-psr-dpms
[167.753014] Starting dynamic subtest: eDP-1
[167.756483] Dynamic subtest eDP-1: SKIP (0.000s)
[167.759930] Subtest fbc-psr-dpms: SKIP (0.001s)
[167.816365] [029/130] (849s left) kms_pm_rpm (dpms-non-lpsp)
[170.061328] Starting subtest: dpms-non-lpsp
[170.066365] Subtest dpms-non-lpsp: SKIP (0.001s)
[170.409160] [030/130] (846s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[170.513422] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[175.009022] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.500s)
[175.109258] [031/130] (842s left) kms_plane_multiple (tiling-y)
[175.206047] Starting subtest: tiling-y
[175.210587] Subtest tiling-y: SKIP (0.000s)
[175.270698] [032/130] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[175.378531] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[175.382547] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[175.474350] [033/130] (841s left) gem_ctx_persistence (legacy-engines-queued)
[175.534085] Starting subtest: legacy-engines-queued
[175.536420] Starting dynamic subtest: render
[175.645735] Dynamic subtest render: SUCCESS (0.111s)
[175.656159] Starting dynamic subtest: bsd1
[176.906573] Dynamic subtest bsd1: SUCCESS (1.257s)
[176.915197] Starting dynamic subtest: bsd2
[178.887062] Dynamic subtest bsd2: SUCCESS (1.978s)
[178.897571] Starting dynamic subtest: blt
[178.968509] Dynamic subtest blt: SUCCESS (0.080s)
[178.978555] Starting dynamic subtest: vebox
[180.874036] Dynamic subtest vebox: SUCCESS (1.902s)
[180.876956] Subtest legacy-engines-queued: SUCCESS (5.338s)
[180.947333] [034/130] (836s left) kms_cursor_legacy (forked-move)
[181.083507] Starting subtest: forked-move
[181.085889] Starting dynamic subtest: pipe-A
[186.583621] Dynamic subtest pipe-A: SUCCESS (5.497s)
[186.595772] Starting dynamic subtest: pipe-B
[192.074022] Dynamic subtest pipe-B: SUCCESS (5.491s)
[192.083649] Starting dynamic subtest: pipe-C
[197.583762] Dynamic subtest pipe-C: SUCCESS (5.505s)
[197.595848] Starting dynamic subtest: pipe-D
[203.075303] Dynamic subtest pipe-D: SUCCESS (5.492s)
[203.085682] Starting dynamic subtest: all-pipes
[208.601032] Dynamic subtest all-pipes: SUCCESS (5.525s)
[208.603149] Subtest forked-move: SUCCESS (27.516s)
[208.725293] [035/130] (808s left) kms_flip (2x-wf_vblank-ts-check)
[208.830089] Starting subtest: 2x-wf_vblank-ts-check
[208.840908] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[208.958305] [036/130] (808s left) kms_addfb_basic (no-handle)
[209.021505] Starting subtest: no-handle
[209.023880] Subtest no-handle: SUCCESS (0.000s)
[209.174694] [037/130] (808s left) gen9_exec_parse (batch-without-end)
[209.237827] Subtest batch-without-end: SKIP (0.000s)
[209.306050] [038/130] (808s left) gem_mmap_gtt (basic-small-copy-xy)
[209.357510] Subtest basic-small-copy-XY: SKIP (0.000s)
[209.410352] [039/130] (808s left) kms_hdr (static-swap)
[209.501073] Starting subtest: static-swap
[209.507625] Subtest static-swap: SKIP (0.000s)
[209.567195] [040/130] (808s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[209.755256] Starting subtest: cursor-rapid-movement-128x128
[209.759943] Starting dynamic subtest: pipe-A-eDP-1
[210.311585] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[210.334363] Starting dynamic subtest: pipe-D-eDP-1
[211.566362] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[211.568775] Subtest cursor-rapid-movement-128x128: SUCCESS (1.810s)
[212.388621] [041/130] (805s left) i915_pm_rc6_residency (media-rc6-accuracy)
[212.449446] Starting subtest: media-rc6-accuracy
[212.453811] Subtest media-rc6-accuracy: SKIP (0.000s)
[212.553689] [042/130] (805s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[217.569152] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[217.573702] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.003s)
[218.396982] [043/130] (799s left) gem_ctx_persistence (engines-persistence)
[218.457770] Starting subtest: engines-persistence
[218.459937] Starting dynamic subtest: rcs0
[219.335358] Dynamic subtest rcs0: SUCCESS (0.876s)
[219.346294] Starting dynamic subtest: bcs0
[220.165237] Dynamic subtest bcs0: SUCCESS (0.829s)
[220.175510] Starting dynamic subtest: vcs0
[220.994788] Dynamic subtest vcs0: SUCCESS (0.828s)
[221.005080] Starting dynamic subtest: vcs1
[221.822086] Dynamic subtest vcs1: SUCCESS (0.825s)
[221.832699] Starting dynamic subtest: vecs0
[222.598770] Dynamic subtest vecs0: SUCCESS (0.776s)
[222.608540] Starting dynamic subtest: ccs0
[223.426025] Dynamic subtest ccs0: SUCCESS (0.825s)
[223.428830] Subtest engines-persistence: SUCCESS (4.968s)
[223.504428] [044/130] (794s left) perf_pmu (rc6)
[223.546400] Starting subtest: rc6
[223.548751] Starting dynamic subtest: gt0
[229.930837] Dynamic subtest gt0: SUCCESS (6.382s)
[229.941682] Starting dynamic subtest: runtime-pm-gt0
[237.659130] Dynamic subtest runtime-pm-gt0: SUCCESS (7.727s)
[237.669113] Starting dynamic subtest: runtime-pm-long-gt0
[250.101334] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.441s)
[250.111596] Starting dynamic subtest: other-idle-gt0
[256.444920] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[256.453796] Starting dynamic subtest: gt1
[262.786299] Dynamic subtest gt1: SUCCESS (6.340s)
[262.794237] Starting dynamic subtest: runtime-pm-gt1
[270.248197] Dynamic subtest runtime-pm-gt1: SUCCESS (7.459s)
[270.256058] Starting dynamic subtest: runtime-pm-long-gt1
[282.683445] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.433s)
[282.691354] Starting dynamic subtest: other-idle-gt1
[289.026869] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[289.029935] Subtest rc6: SUCCESS (65.477s)
[290.169682] [045/130] (727s left) gem_lmem_swapping (parallel-multi)
[290.213294] Subtest parallel-multi: SKIP (0.000s)
[290.252374] [046/130] (727s left) vgem_basic (second-client)
[290.359085] Starting subtest: second-client
[290.381281] Subtest second-client: SUCCESS (0.021s)
[290.409835] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[290.412628] [047/130] (727s left) kms_dp_linktrain_fallback (dsc-fallback)
[290.512165] Starting subtest: dsc-fallback
[290.518154] Subtest dsc-fallback: SKIP (0.000s)
[290.553595] [048/130] (727s left) sw_sync (alloc_fence_invalid_timeline)
[290.590780] Starting subtest: alloc_fence_invalid_timeline
[290.592864] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[290.623330] [049/130] (727s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[290.722928] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[290.726817] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[290.784639] [050/130] (727s left) kms_rotation_crc (cursor-rotation-180)
[290.883544] Starting subtest: cursor-rotation-180
[292.334258] Subtest cursor-rotation-180: SUCCESS (1.450s)
[293.512941] [051/130] (724s left) gem_reg_read (timestamp-monotonic)
[293.559681] Starting subtest: timestamp-monotonic
[298.229657] Subtest timestamp-monotonic: SUCCESS (4.670s)
[298.273794] [052/130] (719s left) api_intel_allocator (reopen)
[298.328547] Starting subtest: reopen
[298.333256] Subtest reopen: SUCCESS (0.005s)
[298.460231] [053/130] (719s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[298.569185] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[298.571392] Starting dynamic subtest: pipe-A-default-mode
[298.863412] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[298.868011] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.290s)
[299.638932] [054/130] (718s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[304.734515] Starting subtest: fbc-psr2-cursor-plane-update-sf
[304.736778] Starting dynamic subtest: pipe-A-eDP-1
[305.520981] Dynamic subtest pipe-A-eDP-1: SKIP (0.781s)
[305.528665] Starting dynamic subtest: pipe-B-eDP-1
[306.649844] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[306.654441] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.912s)
[307.802735] [055/130] (710s left) kms_content_protection (atomic)
[307.957583] Starting subtest: atomic
[311.350622] Subtest atomic: SKIP (3.390s)
[312.500239] [056/130] (705s left) core_getclient
[312.605301] [057/130] (705s left) kms_pipe_crc_basic (nonblocking-crc)
[312.700088] Starting subtest: nonblocking-crc
[312.702272] Starting dynamic subtest: pipe-A-eDP-1
[313.457455] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.756s)
[313.465287] Starting dynamic subtest: pipe-B-eDP-1
[314.808263] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.347s)
[314.816342] Starting dynamic subtest: pipe-C-eDP-1
[316.198319] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s)
[316.207650] Starting dynamic subtest: pipe-D-eDP-1
[317.531091] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[317.533644] Subtest nonblocking-crc: SUCCESS (4.829s)
[318.304994] [058/130] (699s left) gem_render_copy (yf-tiled-to-vebox-linear)
[318.366867] Starting subtest: yf-tiled-to-vebox-linear
[318.371650] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[318.519385] [059/130] (699s left) kms_cursor_crc (cursor-random-max-size)
[318.788536] Starting subtest: cursor-random-max-size
[318.795071] Subtest cursor-random-max-size: SKIP (0.000s)
[318.893566] [060/130] (699s left) gem_softpin (32b-excludes-last-page)
[318.961539] Starting subtest: 32b-excludes-last-page
[318.967723] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[319.068876] [061/130] (699s left) perf_pmu (busy-no-semaphores)
[319.108074] Starting subtest: busy-no-semaphores
[319.110417] Starting dynamic subtest: rcs0
[319.692450] Dynamic subtest rcs0: SUCCESS (0.586s)
[319.701910] Starting dynamic subtest: bcs0
[320.240294] Dynamic subtest bcs0: SUCCESS (0.545s)
[320.250867] Starting dynamic subtest: vcs0
[320.790412] Dynamic subtest vcs0: SUCCESS (0.547s)
[320.801040] Starting dynamic subtest: vcs1
[322.412590] Dynamic subtest vcs1: SUCCESS (1.620s)
[322.423264] Starting dynamic subtest: vecs0
[324.460733] Dynamic subtest vecs0: SUCCESS (2.045s)
[324.471192] Starting dynamic subtest: ccs0
[326.444651] Dynamic subtest ccs0: SUCCESS (1.981s)
[326.447350] Subtest busy-no-semaphores: SUCCESS (7.338s)
[326.556070] [062/130] (691s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[326.656049] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[327.834281] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.179s)
[327.982536] [063/130] (690s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[328.112820] Starting subtest: cursorA-vs-flipB-legacy
[328.117181] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[328.178778] [064/130] (690s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[328.294879] Starting subtest: x-tiled-16bpp-rotate-180
[329.715381] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.422s)
[329.842113] [065/130] (688s left) kms_lease (implicit-plane-lease)
[329.938351] Starting subtest: implicit-plane-lease
[329.940504] Subtest implicit-plane-lease: SUCCESS (0.003s)
[330.030883] [066/130] (688s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[330.130190] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[330.133761] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[330.210719] [067/130] (688s left) kms_busy (extended-pageflip-hang-oldfb)
[330.305639] Starting subtest: extended-pageflip-hang-oldfb
[330.307576] Starting dynamic subtest: pipe-A
[330.754706] Dynamic subtest pipe-A: SUCCESS (0.445s)
[330.763717] Starting dynamic subtest: pipe-D
[331.872846] Dynamic subtest pipe-D: SUCCESS (1.116s)
[331.875434] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.566s)
[332.666686] [068/130] (685s left) syncobj_eventfd (binary-wait)
[332.720431] Starting subtest: binary-wait
[332.728655] Subtest binary-wait: SUCCESS (0.010s)
[332.816408] [069/130] (685s left) kms_draw_crc (fill-fb)
[332.917860] Starting subtest: fill-fb
[333.365446] Subtest fill-fb: SUCCESS (0.449s)
[333.440969] [070/130] (685s left) gem_render_copy (x-tiled)
[333.492694] Starting subtest: x-tiled
[333.494951] Starting dynamic subtest: smem
[333.535935] Dynamic subtest smem: SUCCESS (0.043s)
[333.538246] Subtest x-tiled: SUCCESS (0.044s)
[333.750251] [071/130] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[333.864720] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[333.869072] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[333.965339] [072/130] (684s left) drm_fdinfo (busy-hang)
[334.004521] Starting subtest: busy-hang
[334.006795] Starting dynamic subtest: rcs0
[334.048818] Dynamic subtest rcs0: SKIP (0.043s)
[334.057106] Starting dynamic subtest: bcs0
[334.061046] Dynamic subtest bcs0: SKIP (0.001s)
[334.068865] Starting dynamic subtest: vcs0
[334.073125] Dynamic subtest vcs0: SKIP (0.001s)
[334.079989] Starting dynamic subtest: vcs1
[334.084074] Dynamic subtest vcs1: SKIP (0.000s)
[334.090846] Starting dynamic subtest: vecs0
[334.095073] Dynamic subtest vecs0: SKIP (0.000s)
[334.101791] Starting dynamic subtest: ccs0
[334.106068] Dynamic subtest ccs0: SKIP (0.000s)
[334.110165] Subtest busy-hang: SKIP (0.049s)
[334.138643] [073/130] (684s left) gem_exec_fence (syncobj-timeline-signal)
[334.701793] Starting subtest: syncobj-timeline-signal
[334.708119] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[336.002834] [074/130] (682s left) kms_psr (pr-cursor-mmap-cpu)
[336.110385] Starting subtest: pr-cursor-mmap-cpu
[336.115064] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[336.151472] [075/130] (682s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[336.218076] Subtest no-spare-fences-busy: SKIP (0.000s)
[336.278506] [076/130] (682s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[336.372043] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[336.374288] Starting dynamic subtest: pipe-A-eDP-1
[336.382864] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[336.390585] Starting dynamic subtest: pipe-B-eDP-1
[336.399811] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[336.409260] Starting dynamic subtest: pipe-C-eDP-1
[336.417708] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[336.424994] Starting dynamic subtest: pipe-D-eDP-1
[336.433438] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[336.437605] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[338.507719] [077/130] (680s left) syncobj_timeline (signal-array)
[338.553583] Starting subtest: signal-array
[338.555602] Subtest signal-array: SUCCESS (0.000s)
[338.627434] [078/130] (680s left) kms_universal_plane (cursor-fb-leak)
[338.735103] Starting subtest: cursor-fb-leak
[338.737021] Starting dynamic subtest: pipe-A-eDP-1
[339.052596] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.316s)
[339.060480] Starting dynamic subtest: pipe-B-eDP-1
[340.425329] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.374s)
[340.434887] Starting dynamic subtest: pipe-C-eDP-1
[341.736389] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.308s)
[341.744444] Starting dynamic subtest: pipe-D-eDP-1
[343.065769] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[343.067693] Subtest cursor-fb-leak: SUCCESS (4.331s)
[344.214319] [079/130] (674s left) gem_ctx_param (root-set)
[344.281904] Starting subtest: root-set
[344.284323] Subtest root-set: SUCCESS (0.001s)
[344.370243] [080/130] (674s left) gem_pxp (create-regular-buffer)
[344.497078] Starting subtest: create-regular-buffer
[344.499423] Subtest create-regular-buffer: SUCCESS (0.000s)
[344.573905] [081/130] (674s left) prime_vgem (fence-write-hang)
[344.675445] Subtest fence-write-hang: SKIP (0.000s)
[344.763822] [082/130] (674s left) kms_async_flips (test-cursor-atomic)
[344.863384] Starting subtest: test-cursor-atomic
[344.867868] Subtest test-cursor-atomic: SKIP (0.000s)
[346.038975] [083/130] (672s left) gem_mmap_offset (pf-nonblock)
[346.098160] Starting subtest: pf-nonblock
[346.102667] Subtest pf-nonblock: SUCCESS (0.007s)
[346.210801] [084/130] (672s left) gem_ctx_exec (basic-invalid-context)
[346.269759] Starting subtest: basic-invalid-context
[346.274068] Subtest basic-invalid-context: SUCCESS (0.004s)
[346.393406] [085/130] (672s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[346.496185] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[347.493747] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.999s)
[347.609029] [086/130] (671s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[352.625017] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[352.630131] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[353.440588] [087/130] (665s left) gem_exec_reloc (basic-range-active)
[353.501095] Subtest basic-range-active: SKIP (0.000s)
[353.572307] [088/130] (665s left) kms_flip (basic-flip-vs-wf_vblank)
[353.674889] Starting subtest: basic-flip-vs-wf_vblank
[353.677182] Starting dynamic subtest: A-eDP1
[355.611916] Dynamic subtest A-eDP1: SUCCESS (1.936s)
[355.621890] Starting dynamic subtest: B-eDP1
[357.541879] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[357.553568] Starting dynamic subtest: C-eDP1
[359.458580] Dynamic subtest C-eDP1: SUCCESS (1.914s)
[359.467186] Starting dynamic subtest: D-eDP1
[361.383083] Dynamic subtest D-eDP1: SUCCESS (1.924s)
[361.385397] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.712s)
[362.571923] [089/130] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[362.670362] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[367.818685] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (5.152s)
[367.926554] [090/130] (651s left) kms_psr (fbc-pr-primary-blt)
[368.028335] Starting subtest: fbc-pr-primary-blt
[368.032799] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[368.071187] [091/130] (651s left) sysfs_preempt_timeout (idempotent)
[368.138502] Starting subtest: idempotent
[368.140846] Starting dynamic subtest: vecs0
[368.143072] Dynamic subtest vecs0: SUCCESS (0.000s)
[368.150653] Starting dynamic subtest: ccs0
[368.152942] Dynamic subtest ccs0: SUCCESS (0.000s)
[368.160423] Starting dynamic subtest: vcs0
[368.162688] Dynamic subtest vcs0: SUCCESS (0.000s)
[368.169801] Starting dynamic subtest: bcs0
[368.172072] Dynamic subtest bcs0: SUCCESS (0.000s)
[368.179112] Starting dynamic subtest: rcs0
[368.181416] Dynamic subtest rcs0: SUCCESS (0.000s)
[368.189166] Starting dynamic subtest: vcs1
[368.191512] Dynamic subtest vcs1: SUCCESS (0.000s)
[368.193826] Subtest idempotent: SUCCESS (0.005s)
[368.225597] [092/130] (651s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[368.323978] Starting subtest: addfb25-y-tiled-small-legacy
[368.328262] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[368.390381] [093/130] (650s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[368.509342] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[376.642069] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.133s)
[377.458755] [094/130] (641s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[377.567112] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[377.571573] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[377.631888] [095/130] (641s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[377.726400] Starting subtest: fbc-1p-pri-indfb-multidraw
[389.731723] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.009s)
[389.840405] [096/130] (629s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[389.936837] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[389.938719] Starting dynamic subtest: pipe-A
[389.949698] Dynamic subtest pipe-A: SKIP (0.007s)
[389.957178] Starting dynamic subtest: pipe-B
[389.964504] Dynamic subtest pipe-B: SKIP (0.016s)
[389.971566] Starting dynamic subtest: pipe-C
[389.981703] Dynamic subtest pipe-C: SKIP (0.016s)
[389.988743] Starting dynamic subtest: pipe-D
[389.998485] Dynamic subtest pipe-D: SKIP (0.016s)
[390.001571] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.057s)
[390.083915] [097/130] (629s left) gem_exec_params (readonly)
[390.133112] Starting subtest: readonly
[390.134645] Subtest readonly: SUCCESS (0.002s)
[390.239736] [098/130] (629s left) kms_frontbuffer_tracking (psr-2p-rte)
[390.337181] Starting subtest: psr-2p-rte
[390.340700] Subtest psr-2p-rte: SKIP (0.000s)
[390.401854] [099/130] (629s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[390.529554] Starting subtest: basic-flip-after-cursor-varying-size
[391.447667] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.918s)
[392.212290] [100/130] (627s left) gem_exec_schedule (semaphore-noskip)
[392.283259] Starting subtest: semaphore-noskip
[392.679281] Subtest semaphore-noskip: SUCCESS (0.400s)
[392.996975] [101/130] (626s left) gem_bad_reloc (negative-reloc-lut)
[393.062251] Subtest negative-reloc-lut: SKIP (0.000s)
[393.154034] [102/130] (626s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[393.550543] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[394.333956] [103/130] (625s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[394.432696] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[394.444516] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[394.527906] [104/130] (625s left) kms_psr (psr-sprite-mmap-cpu)
[394.616296] Starting subtest: psr-sprite-mmap-cpu
[394.618625] Starting dynamic subtest: eDP-1
[396.361116] Dynamic subtest eDP-1: SUCCESS (1.744s)
[396.363482] Subtest psr-sprite-mmap-cpu: SUCCESS (1.744s)
[397.195404] [105/130] (622s left) gem_exec_basic (basic)
[397.254108] Starting subtest: basic
[397.256455] Starting dynamic subtest: rcs0-smem
[397.258669] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[397.267436] Starting dynamic subtest: bcs0-smem
[397.269781] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[397.277288] Starting dynamic subtest: vcs0-smem
[397.279498] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[397.286925] Starting dynamic subtest: vcs1-smem
[397.289203] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[397.296335] Starting dynamic subtest: vecs0-smem
[397.298541] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[397.305665] Starting dynamic subtest: ccs0-smem
[397.307907] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[397.310124] Subtest basic: SUCCESS (0.014s)
[398.959811] [106/130] (620s left) syncobj_timeline (wait-all-delayed-signal)
[399.015372] Starting subtest: wait-all-delayed-signal
[399.120687] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[399.167391] [107/130] (620s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[399.265074] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[399.267215] Starting dynamic subtest: pipe-A-eDP-1
[399.289327] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.298405] Starting dynamic subtest: pipe-B-eDP-1
[399.320191] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.328068] Starting dynamic subtest: pipe-C-eDP-1
[399.349955] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.358678] Starting dynamic subtest: pipe-D-eDP-1
[399.380665] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[399.384725] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[401.442681] [108/130] (618s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[401.550871] Starting subtest: y-tiled-32bpp-rotate-180
[401.555193] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[401.627883] [109/130] (618s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[401.731296] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[401.735379] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[401.802927] [110/130] (618s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[401.908786] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[401.912885] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[401.978237] [111/130] (617s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[402.360220] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[403.162272] [112/130] (616s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[403.258085] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[403.260377] Starting dynamic subtest: pipe-A-eDP-1
[404.125165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.857s)
[404.133040] Starting dynamic subtest: pipe-B-eDP-1
[405.593329] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.467s)
[405.602279] Starting dynamic subtest: pipe-C-eDP-1
[407.100856] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.505s)
[407.109969] Starting dynamic subtest: pipe-D-eDP-1
[408.525267] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.423s)
[408.527464] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.257s)
[409.672150] [113/130] (610s left) core_hotunplug (unbind-rebind)
[409.750354] Starting subtest: unbind-rebind
[415.764214] Subtest unbind-rebind: SUCCESS (6.013s)
[415.794081] [114/130] (604s left) gem_mmap_wc (write)
[416.911519] Subtest write: SKIP (0.000s)
[417.003470] [115/130] (603s left) gem_exec_reloc (basic-gtt-wc-active)
[417.061863] Subtest basic-gtt-wc-active: SKIP (0.000s)
[417.131435] [116/130] (602s left) dumb_buffer (map-uaf)
[417.188149] Starting subtest: map-uaf
[417.200451] Subtest map-uaf: SUCCESS (0.015s)
[417.294606] [117/130] (602s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[419.024693] Starting subtest: gem-execbuf-stress-pc8
[419.066388] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[419.503542] [118/130] (600s left) gem_userptr_blits (huge-split)
[419.582866] Starting subtest: huge-split
[419.589865] Subtest huge-split: SUCCESS (0.007s)
[419.711163] [119/130] (600s left) kms_feature_discovery (display-2x)
[419.811054] Starting subtest: display-2x
[419.815185] Subtest display-2x: SKIP (0.000s)
[419.851334] [120/130] (600s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[419.955056] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[419.957299] Starting dynamic subtest: pipe-A-eDP-1
[421.220494] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.265s)
[421.229956] Starting dynamic subtest: pipe-B-eDP-1
[423.561737] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.339s)
[423.572538] Starting dynamic subtest: pipe-C-eDP-1
[425.886956] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.324s)
[425.895784] Starting dynamic subtest: pipe-D-eDP-1
[428.193128] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.305s)
[428.195482] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.238s)
[429.304892] [121/130] (590s left) kms_vrr (flip-basic)
[429.395278] Starting subtest: flip-basic
[429.401687] Subtest flip-basic: SKIP (0.000s)
[429.440189] [122/130] (590s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[429.495653] Starting subtest: multi-wait-available-unsubmitted-signaled
[429.497815] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[429.570875] [123/130] (590s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[429.677440] Starting subtest: psr-modesetfrombusy
[433.729544] Subtest psr-modesetfrombusy: SUCCESS (4.058s)
[433.873512] [124/130] (586s left) gem_linear_blits (normal)
[434.387456] Starting subtest: normal
[437.775031] Subtest normal: SUCCESS (3.386s)
[437.910857] [125/130] (582s left) kms_scaling_modes (scaling-mode-full)
[438.037259] Starting subtest: scaling-mode-full
[438.042590] Starting dynamic subtest: pipe-A-eDP-1
[438.154459] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.116s)
[438.165820] Starting dynamic subtest: pipe-B-eDP-1
[439.336853] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.181s)
[439.346697] Starting dynamic subtest: pipe-C-eDP-1
[440.432977] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.096s)
[440.442961] Starting dynamic subtest: pipe-D-eDP-1
[441.553410] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s)
[441.555723] Subtest scaling-mode-full: SUCCESS (3.516s)
[442.684436] [126/130] (577s left) gem_userptr_blits (invalid-null-pointer)
[442.759945] Starting subtest: invalid-null-pointer
[442.762311] Subtest invalid-null-pointer: SUCCESS (0.001s)
[442.880990] [127/130] (577s left) perf (oa-formats)
[442.988302] Starting subtest: oa-formats
[442.990167] Starting dynamic subtest: 0-rcs0
[443.006320] Dynamic subtest 0-rcs0: SUCCESS (0.020s)
[443.015267] Starting dynamic subtest: 1-vecs0
[443.046072] Dynamic subtest 1-vecs0: SUCCESS (0.039s)
[443.048422] Subtest oa-formats: SUCCESS (0.061s)
[443.092761] [128/130] (577s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[443.190160] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[447.740967] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.554s)
[447.837196] [129/130] (572s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[447.941470] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[447.945592] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[448.018900] [130/130] (572s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[448.082553] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[448.190528] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[448.232366] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: gem_exec_parallel
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_joiner
results: parsing output: 10/ for test: kms_pm_dc
results: parsing output: 11/ for test: kms_getfb
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: gem_wait
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_basic
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: gem_basic
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_plane_multiple
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gen9_exec_parse
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_hdr
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: i915_pm_rc6_residency
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: kms_dp_linktrain_fallback
results: parsing output: 47/ for test: sw_sync
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_rotation_crc
results: parsing output: 50/ for test: gem_reg_read
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: core_getclient
results: parsing output: 56/ for test: kms_pipe_crc_basic
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: gem_softpin
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_busy
results: parsing output: 67/ for test: syncobj_eventfd
results: parsing output: 68/ for test: kms_draw_crc
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: drm_fdinfo
results: parsing output: 72/ for test: gem_exec_fence
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_fenced_exec_thrash
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_universal_plane
results: parsing output: 78/ for test: gem_ctx_param
results: parsing output: 79/ for test: gem_pxp
results: parsing output: 80/ for test: prime_vgem
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: gem_mmap_offset
results: parsing output: 83/ for test: gem_ctx_exec
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: sysfs_preempt_timeout
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: gem_bad_reloc
results: parsing output: 101/ for test: kms_chamelium_edid
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: gem_exec_basic
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_chamelium_frames
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: core_hotunplug
results: parsing output: 113/ for test: gem_mmap_wc
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: dumb_buffer
results: parsing output: 116/ for test: i915_pm_rpm
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_feature_discovery
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_vrr
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_linear_blits
results: parsing output: 124/ for test: kms_scaling_modes
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
Done.