[57.808091] Initializing watchdogs
[57.808172]   /dev/watchdog0
[57.822273] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.826779] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.829663] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.833318] [001/133] (960s left) syncobj_timeline (single-wait-all-available-signaled)
[57.909038] Starting subtest: single-wait-all-available-signaled
[57.911441] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[58.016879] [002/133] (960s left) kms_big_fb (4-tiled-addfb)
[58.113740] Starting subtest: 4-tiled-addfb
[58.116086] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[58.198070] [003/133] (960s left) gem_exec_whisper (basic-contexts-all)
[58.256270] Starting subtest: basic-contexts-all
[70.904972] Subtest basic-contexts-all: SUCCESS (12.608s)
[71.087200] [004/133] (947s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[71.193580] Starting subtest: y-tiled-32bpp-rotate-270
[71.198096] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[71.276139] [005/133] (947s left) gem_pwrite (basic-random)
[71.329829] Subtest basic-random: SKIP (0.000s)
[71.394966] [006/133] (947s left) kms_frontbuffer_tracking (fbc-tiling-y)
[71.503761] Starting subtest: fbc-tiling-y
[71.508080] Subtest fbc-tiling-y: SKIP (0.000s)
[71.600064] [007/133] (946s left) dumb_buffer (invalid-bpp)
[71.654941] Starting subtest: invalid-bpp
[71.657449] Subtest invalid-bpp: SUCCESS (0.000s)
[71.755475] [008/133] (946s left) kms_plane_lowres (tiling-none)
[71.841082] Starting subtest: tiling-none
[71.843360] Starting dynamic subtest: pipe-A-eDP-1
[71.847874] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[72.137634] Starting dynamic subtest: pipe-B-eDP-1
[72.142344] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[72.150044] Starting dynamic subtest: pipe-C-eDP-1
[72.154799] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[72.163758] Starting dynamic subtest: pipe-D-eDP-1
[72.168499] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[72.172675] Subtest tiling-none: SKIP (0.295s)
[72.954666] [009/133] (945s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[73.026181] Starting subtest: x-tiled-to-vebox-y-tiled
[73.030725] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[73.217104] [010/133] (945s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[73.268684] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[73.371741] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[73.443139] [011/133] (945s left) kms_cursor_legacy (forked-bo)
[73.565524] Starting subtest: forked-bo
[73.567905] Starting dynamic subtest: pipe-A
[79.027894] Dynamic subtest pipe-A: SUCCESS (5.456s)
[79.039288] Starting dynamic subtest: pipe-B
[84.498172] Dynamic subtest pipe-B: SUCCESS (5.467s)
[84.508239] Starting dynamic subtest: pipe-C
[89.979873] Dynamic subtest pipe-C: SUCCESS (5.479s)
[89.987991] Starting dynamic subtest: pipe-D
[95.449913] Dynamic subtest pipe-D: SUCCESS (5.468s)
[95.459562] Starting dynamic subtest: all-pipes
[100.970635] Dynamic subtest all-pipes: SUCCESS (5.517s)
[100.973141] Subtest forked-bo: SUCCESS (27.392s)
[101.113647] [012/133] (917s left) gem_madvise (dontneed-after-mmap)
[101.155778] Starting subtest: dontneed-after-mmap
[101.174034] Subtest dontneed-after-mmap: SUCCESS (0.019s)
[101.269900] [013/133] (917s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[101.334855] Starting subtest: etime-multi-wait-all-submitted-signaled
[101.443057] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[101.515853] [014/133] (917s left) kms_flip (wf_vblank-ts-check-interruptible)
[101.623965] Starting subtest: wf_vblank-ts-check-interruptible
[101.626432] Starting dynamic subtest: A-eDP1
[110.512644] Dynamic subtest A-eDP1: SUCCESS (8.886s)
[110.523574] Starting dynamic subtest: B-eDP1
[119.443203] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[119.456920] Starting dynamic subtest: C-eDP1
[128.367465] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[128.375496] Starting dynamic subtest: D-eDP1
[137.209156] Dynamic subtest D-eDP1: SUCCESS (8.840s)
[137.214273] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.586s)
[138.434404] [015/133] (880s left) gem_spin_batch (spin-each)
[138.495909] Starting subtest: spin-each
[141.765177] Subtest spin-each: SUCCESS (3.264s)
[141.981181] [016/133] (876s left) kms_psr (fbc-psr2-sprite-blt)
[142.067678] Starting subtest: fbc-psr2-sprite-blt
[142.070033] Starting dynamic subtest: eDP-1
[142.074392] Dynamic subtest eDP-1: SKIP (0.000s)
[142.078748] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[142.136224] [017/133] (876s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[142.222086] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[142.251264] Starting dynamic subtest: pipe-A-plane-0
[142.540108] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[142.549653] Starting dynamic subtest: pipe-A-plane-3
[142.784719] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[142.794364] Starting dynamic subtest: pipe-A-plane-5
[142.798472] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[143.920143] Starting dynamic subtest: pipe-B-plane-0
[144.201590] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[144.211368] Starting dynamic subtest: pipe-B-plane-3
[144.435055] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[144.444829] Starting dynamic subtest: pipe-B-plane-5
[144.449071] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[144.769583] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.547s)
[145.594890] [018/133] (873s left) gem_workarounds (reset-context)
[145.663747] Starting subtest: reset-context
[145.824748] Subtest reset-context: SUCCESS (0.161s)
[145.933682] [019/133] (873s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[146.035187] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[146.039600] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[146.099302] [020/133] (872s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[146.187572] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[152.981737] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.798s)
[153.109170] [021/133] (865s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[153.204956] Starting subtest: primary-yf-tiled-reflect-x-0
[153.264847] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[153.369375] [022/133] (865s left) kms_chamelium_color (ctm-0-75)
[153.456339] Subtest ctm-0-75: SKIP (0.000s)
[153.498543] [023/133] (865s left) kms_content_protection (atomic)
[153.625716] Starting subtest: atomic
[153.630372] Subtest atomic: SKIP (0.000s)
[153.752029] [024/133] (865s left) gem_ctx_param (invalid-param-get)
[153.794514] Starting subtest: invalid-param-get
[153.797058] Subtest invalid-param-get: SUCCESS (0.001s)
[153.877859] [025/133] (865s left) syncobj_wait (wait-for-submit-delayed-submit)
[153.930255] Starting subtest: wait-for-submit-delayed-submit
[154.034131] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[154.129250] [026/133] (865s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[154.225785] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[154.228131] Starting dynamic subtest: pipe-A-eDP-1
[154.251742] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[154.262162] Starting dynamic subtest: pipe-B-eDP-1
[154.283284] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[154.291394] Starting dynamic subtest: pipe-C-eDP-1
[154.312204] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[154.322597] Starting dynamic subtest: pipe-D-eDP-1
[154.344418] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[154.348502] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[156.494143] [027/133] (862s left) gem_exec_balancer (semaphore)
[156.552188] Starting subtest: semaphore
[157.906633] Subtest semaphore: SUCCESS (1.352s)
[158.240259] [028/133] (861s left) gem_ctx_persistence (file)
[158.293127] Starting subtest: file
[158.403573] Subtest file: SUCCESS (0.110s)
[158.535123] [029/133] (860s left) kms_async_flips (test-time-stamp-atomic)
[158.623296] Starting subtest: test-time-stamp-atomic
[158.998934] Starting dynamic subtest: pipe-A-eDP-1
[159.797229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s)
[160.183043] Starting dynamic subtest: pipe-B-eDP-1
[160.940720] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[161.308798] Starting dynamic subtest: pipe-C-eDP-1
[162.071205] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[162.440119] Starting dynamic subtest: pipe-D-eDP-1
[163.195882] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.760s)
[163.198196] Subtest test-time-stamp-atomic: SUCCESS (4.570s)
[164.364618] [030/133] (855s left) kms_plane (planar-pixel-format-settings)
[164.461421] Starting subtest: planar-pixel-format-settings
[164.526979] Subtest planar-pixel-format-settings: SUCCESS (0.066s)
[164.643012] [031/133] (854s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[164.743047] Starting subtest: primary-4-tiled-reflect-x-0
[171.795663] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.054s)
[173.030810] [032/133] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[173.126362] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[173.130598] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[173.224510] [033/133] (846s left) gem_exec_reloc (basic-cpu-gtt)
[173.275599] Subtest basic-cpu-gtt: SKIP (0.000s)
[173.339808] [034/133] (846s left) kms_universal_plane (universal-plane-sanity)
[173.437472] Starting subtest: universal-plane-sanity
[173.439604] Starting dynamic subtest: pipe-A-eDP-1
[174.035661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[174.045751] Starting dynamic subtest: pipe-B-eDP-1
[175.234728] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.198s)
[175.244351] Starting dynamic subtest: pipe-C-eDP-1
[176.452603] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s)
[176.462736] Starting dynamic subtest: pipe-D-eDP-1
[177.676344] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[177.678761] Subtest universal-plane-sanity: SUCCESS (4.240s)
[178.535948] [035/133] (841s left) gem_mmap_offset (mmap-boundaries)
[178.589058] Starting subtest: mmap-boundaries
[178.590937] Starting dynamic subtest: smem0
[178.862064] Dynamic subtest smem0: SUCCESS (0.275s)
[178.864518] Subtest mmap-boundaries: SUCCESS (0.276s)
[178.981883] [036/133] (840s left) gem_wait (busy)
[179.054078] Starting subtest: busy
[179.056364] Starting dynamic subtest: all-engines
[180.886375] Dynamic subtest all-engines: SUCCESS (1.830s)
[180.898354] Starting dynamic subtest: rcs0
[181.430574] Dynamic subtest rcs0: SUCCESS (0.544s)
[181.443860] Starting dynamic subtest: bcs0
[181.969913] Dynamic subtest bcs0: SUCCESS (0.539s)
[181.980063] Starting dynamic subtest: vcs0
[183.894901] Dynamic subtest vcs0: SUCCESS (1.922s)
[183.905999] Starting dynamic subtest: vcs1
[185.941833] Dynamic subtest vcs1: SUCCESS (2.045s)
[185.952992] Starting dynamic subtest: vecs0
[187.927809] Dynamic subtest vecs0: SUCCESS (1.984s)
[187.941750] Starting dynamic subtest: ccs0
[188.470038] Dynamic subtest ccs0: SUCCESS (0.541s)
[188.473027] Subtest busy: SUCCESS (9.415s)
[188.667538] [037/133] (831s left) gem_create (create-valid-nonaligned)
[188.722075] Starting subtest: create-valid-nonaligned
[188.724330] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[188.923909] [038/133] (830s left) gem_media_fill (media-fill)
[188.983410] Subtest media-fill: SKIP (0.000s)
[189.084686] [039/133] (830s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[189.140285] Starting subtest: invalid-multi-wait-all-unsubmitted
[189.142282] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[189.234558] [040/133] (830s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[189.346317] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[189.348667] Starting dynamic subtest: pipe-A-eDP-1
[189.463748] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s)
[189.475243] Starting dynamic subtest: pipe-B-eDP-1
[190.618928] Dynamic subtest pipe-B-eDP-1: SKIP (1.153s)
[190.623488] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.276s)
[191.795660] [041/133] (828s left) gem_create (create-ext-placement-all)
[191.963342] Starting subtest: create-ext-placement-all
[191.965732] Subtest create-ext-placement-all: SUCCESS (0.000s)
[192.067993] [042/133] (827s left) i915_pm_freq_api (freq-reset)
[192.133647] Starting subtest: freq-reset
[192.136075] Starting dynamic subtest: gt0
[192.305817] Dynamic subtest gt0: SUCCESS (0.169s)
[192.315640] Starting dynamic subtest: gt1
[192.456105] Dynamic subtest gt1: SUCCESS (0.150s)
[192.459344] Subtest freq-reset: SUCCESS (0.321s)
[192.528323] [043/133] (827s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[192.614632] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[192.617091] Starting dynamic subtest: pipe-A-eDP-1
[193.458047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[193.470412] Starting dynamic subtest: pipe-B-eDP-1
[195.027134] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.567s)
[195.037780] Starting dynamic subtest: pipe-C-eDP-1
[196.532574] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.504s)
[196.542154] Starting dynamic subtest: pipe-D-eDP-1
[198.031750] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.499s)
[198.034072] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.410s)
[199.216289] [044/133] (820s left) kms_flip (dpms-off-confusion-interruptible)
[199.318158] Starting subtest: dpms-off-confusion-interruptible
[199.320504] Starting dynamic subtest: A-eDP1
[207.996231] Dynamic subtest A-eDP1: SUCCESS (8.676s)
[208.005061] Starting dynamic subtest: B-eDP1
[216.624872] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[216.633701] Starting dynamic subtest: C-eDP1
[225.238960] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[225.249119] Starting dynamic subtest: D-eDP1
[233.867830] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[233.873073] Subtest dpms-off-confusion-interruptible: SUCCESS (34.551s)
[235.041345] [045/133] (784s left) kms_chamelium_edid (hdmi-mode-timings)
[235.416056] Subtest hdmi-mode-timings: SKIP (0.000s)
[236.247704] [046/133] (783s left) gem_exec_reloc (basic-scanout)
[236.316982] Subtest basic-scanout: SKIP (0.000s)
[236.377386] [047/133] (783s left) api_intel_allocator (default-alignment)
[236.433897] Starting subtest: default-alignment
[236.436628] Subtest default-alignment: SUCCESS (0.003s)
[236.549772] [048/133] (783s left) gem_exec_schedule (u-independent)
[236.641089] Starting subtest: u-independent
[236.643090] Starting dynamic subtest: rcs0
[237.911599] Dynamic subtest rcs0: SUCCESS (1.278s)
[237.924236] Starting dynamic subtest: vcs0
[239.902748] Dynamic subtest vcs0: SUCCESS (1.989s)
[239.913917] Starting dynamic subtest: vcs1
[241.949630] Dynamic subtest vcs1: SUCCESS (2.045s)
[241.964292] Starting dynamic subtest: vecs0
[243.948606] Dynamic subtest vecs0: SUCCESS (1.998s)
[243.960154] Starting dynamic subtest: ccs0
[245.910770] Dynamic subtest ccs0: SUCCESS (1.960s)
[245.913819] Subtest u-independent: SUCCESS (9.278s)
[246.210000] [049/133] (773s left) gen7_exec_parse (cmd-crossing-page)
[246.273655] Subtest cmd-crossing-page: SKIP (0.000s)
[246.347636] [050/133] (773s left) kms_vblank (query-idle)
[246.452803] Starting subtest: query-idle
[246.454658] Starting dynamic subtest: pipe-A-eDP-1
[248.211714] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.758s)
[248.224606] Starting dynamic subtest: pipe-D-eDP-1
[250.605960] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.392s)
[250.608408] Subtest query-idle: SUCCESS (4.154s)
[251.443057] [051/133] (768s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[251.498378] Starting subtest: y-tiled-to-vebox-x-tiled
[251.502763] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[251.680189] [052/133] (768s left) gem_exec_balancer (hog)
[251.736500] Starting subtest: hog
[251.741149] Subtest hog: SKIP (0.000s)
[252.035774] [053/133] (768s left) kms_atomic_interruptible (legacy-pageflip)
[252.122696] Starting subtest: legacy-pageflip
[252.125111] Starting dynamic subtest: pipe-A-eDP-1
[259.552961] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.428s)
[259.555340] Subtest legacy-pageflip: SUCCESS (7.429s)
[260.376250] [054/133] (760s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[260.487565] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[260.491690] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[260.579412] [055/133] (759s left) gem_exec_params (invalid-flag)
[260.628413] Starting subtest: invalid-flag
[260.630706] Subtest invalid-flag: SUCCESS (0.000s)
[260.753756] [056/133] (759s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[260.842163] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[260.844312] Starting dynamic subtest: A-eDP1
[264.423634] Dynamic subtest A-eDP1: SUCCESS (3.578s)
[264.435782] Starting dynamic subtest: B-eDP1
[267.631640] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[267.640856] Starting dynamic subtest: C-eDP1
[270.831411] Dynamic subtest C-eDP1: SUCCESS (3.200s)
[270.843069] Starting dynamic subtest: D-eDP1
[273.952972] Dynamic subtest D-eDP1: SUCCESS (3.119s)
[273.954868] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.110s)
[274.743879] [057/133] (745s left) gen3_render_mixed_blits
[274.851433] [058/133] (745s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[274.905153] Starting subtest: invalid-smem-bo-on-discrete
[274.909717] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[275.045489] [059/133] (745s left) kms_flip (2x-flip-vs-rmfb)
[275.133231] Starting subtest: 2x-flip-vs-rmfb
[275.141147] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[275.230988] [060/133] (745s left) kms_dsc (dsc-fractional-bpp)
[275.328410] Starting subtest: dsc-fractional-bpp
[275.341782] Subtest dsc-fractional-bpp: SKIP (0.000s)
[275.398707] [061/133] (745s left) i915_drm_fdinfo (memory-info-idle)
[275.446768] Starting subtest: memory-info-idle
[275.449072] Starting dynamic subtest: smem0
[275.486913] Dynamic subtest smem0: SUCCESS (0.042s)
[275.489814] Subtest memory-info-idle: SUCCESS (0.042s)
[275.562640] [062/133] (745s left) perf_pmu (semaphore-wait-idle)
[275.598276] Starting subtest: semaphore-wait-idle
[275.600304] Starting dynamic subtest: rcs0
[276.112536] Dynamic subtest rcs0: SUCCESS (0.513s)
[276.122541] Starting dynamic subtest: bcs0
[276.625906] Dynamic subtest bcs0: SUCCESS (0.510s)
[276.635149] Starting dynamic subtest: vcs0
[277.142560] Dynamic subtest vcs0: SUCCESS (0.513s)
[277.152954] Starting dynamic subtest: vcs1
[277.656771] Dynamic subtest vcs1: SUCCESS (0.510s)
[277.671729] Starting dynamic subtest: vecs0
[278.171376] Dynamic subtest vecs0: SUCCESS (0.512s)
[278.182490] Starting dynamic subtest: ccs0
[278.686521] Dynamic subtest ccs0: SUCCESS (0.512s)
[278.689337] Subtest semaphore-wait-idle: SUCCESS (3.090s)
[279.918682] [063/133] (740s left) kms_psr (psr2-cursor-plane-onoff)
[280.022828] Starting subtest: psr2-cursor-plane-onoff
[280.024964] Starting dynamic subtest: eDP-1
[281.706644] Dynamic subtest eDP-1: SUCCESS (1.683s)
[281.709105] Subtest psr2-cursor-plane-onoff: SUCCESS (1.684s)
[282.504804] [064/133] (738s left) perf (blocking)
[282.634425] Starting subtest: blocking
[282.636679] Starting dynamic subtest: 0-rcs0
[292.662354] Dynamic subtest 0-rcs0: SUCCESS (10.027s)
[292.672040] Starting dynamic subtest: 1-vcs1
[302.683129] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[302.686051] Subtest blocking: SUCCESS (20.049s)
[302.731878] [065/133] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[302.846113] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[302.850178] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[302.938752] [066/133] (717s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[302.989652] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[302.991823] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[303.080474] [067/133] (717s left) kms_properties (connector-properties-atomic)
[303.166425] Starting subtest: connector-properties-atomic
[303.168747] Starting dynamic subtest: pipe-A-eDP-1
[310.933285] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.768s)
[310.942828] Starting dynamic subtest: pipe-None-DP-1
[310.947508] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[310.955855] Starting dynamic subtest: pipe-None-HDMI-A-1
[310.960171] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[310.968970] Starting dynamic subtest: pipe-None-DP-2
[310.973433] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[310.982365] Starting dynamic subtest: pipe-None-HDMI-A-2
[310.987084] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[310.996069] Starting dynamic subtest: pipe-None-DP-3
[311.000727] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[311.009520] Starting dynamic subtest: pipe-None-DP-4
[311.013845] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[311.015721] Subtest connector-properties-atomic: SUCCESS (7.779s)
[311.795371] [068/133] (709s left) perf (invalid-create-userspace-config)
[311.909150] Starting subtest: invalid-create-userspace-config
[311.911381] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[311.949313] [069/133] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[312.033958] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[312.038108] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[312.130835] [070/133] (708s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[312.234634] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[312.239067] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[312.329570] [071/133] (708s left) kms_invalid_mode (bad-htotal)
[312.416327] Starting subtest: bad-htotal
[312.418617] Starting dynamic subtest: pipe-A-eDP-1
[312.699943] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[312.709392] Starting dynamic subtest: pipe-B-eDP-1
[312.711391] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[312.720437] Starting dynamic subtest: pipe-C-eDP-1
[312.722759] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[312.731355] Starting dynamic subtest: pipe-D-eDP-1
[312.735792] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[312.738751] Subtest bad-htotal: SUCCESS (0.288s)
[313.528125] [072/133] (707s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[313.597424] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[313.599767] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[313.707540] [073/133] (707s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[313.803858] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[320.593026] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.791s)
[320.701052] [074/133] (700s left) kms_force_connector_basic (force-connector-state)
[320.785992] Starting subtest: force-connector-state
[321.395482] Subtest force-connector-state: SUCCESS (0.612s)
[322.315635] [075/133] (698s left) kms_plane_alpha_blend (alpha-transparent-fb)
[322.417763] Starting subtest: alpha-transparent-fb
[322.707760] Starting dynamic subtest: pipe-A-eDP-1
[323.319739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s)
[323.338306] Starting dynamic subtest: pipe-D-eDP-1
[324.688025] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.365s)
[324.690524] Subtest alpha-transparent-fb: SUCCESS (2.270s)
[325.487619] [076/133] (695s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[325.565951] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[325.570520] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[325.651584] [077/133] (695s left) gem_exec_schedule (preempt-contexts)
[325.740450] Starting subtest: preempt-contexts
[325.742493] Starting dynamic subtest: rcs0
[325.783219] Dynamic subtest rcs0: SUCCESS (0.051s)
[325.792074] Starting dynamic subtest: bcs0
[325.840972] Dynamic subtest bcs0: SUCCESS (0.057s)
[325.849956] Starting dynamic subtest: vcs0
[325.894449] Dynamic subtest vcs0: SUCCESS (0.052s)
[325.903354] Starting dynamic subtest: vcs1
[325.944219] Dynamic subtest vcs1: SUCCESS (0.050s)
[325.953051] Starting dynamic subtest: vecs0
[325.986105] Dynamic subtest vecs0: SUCCESS (0.041s)
[325.994909] Starting dynamic subtest: ccs0
[326.041154] Dynamic subtest ccs0: SUCCESS (0.055s)
[326.043459] Subtest preempt-contexts: SUCCESS (0.310s)
[327.027320] [078/133] (694s left) gem_busy (parallel)
[327.206021] Starting subtest: parallel
[327.208686] Starting dynamic subtest: rcs0
[328.855353] Dynamic subtest rcs0: SUCCESS (1.648s)
[328.866886] Starting dynamic subtest: bcs0
[330.904327] Dynamic subtest bcs0: SUCCESS (2.045s)
[330.916187] Starting dynamic subtest: vcs0
[332.887875] Dynamic subtest vcs0: SUCCESS (1.981s)
[332.899988] Starting dynamic subtest: vcs1
[334.871984] Dynamic subtest vcs1: SUCCESS (1.981s)
[334.884073] Starting dynamic subtest: vecs0
[336.919578] Dynamic subtest vecs0: SUCCESS (2.044s)
[336.932282] Starting dynamic subtest: ccs0
[338.903667] Dynamic subtest ccs0: SUCCESS (1.981s)
[338.907064] Subtest parallel: SUCCESS (11.697s)
[339.161189] [079/133] (682s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[339.267253] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[339.269608] Starting dynamic subtest: pipe-A
[339.287417] Dynamic subtest pipe-A: SKIP (0.017s)
[339.297259] Starting dynamic subtest: pipe-B
[339.317540] Dynamic subtest pipe-B: SKIP (0.029s)
[339.326770] Starting dynamic subtest: pipe-C
[339.347279] Dynamic subtest pipe-C: SKIP (0.029s)
[339.356156] Starting dynamic subtest: pipe-D
[339.377699] Dynamic subtest pipe-D: SKIP (0.029s)
[339.382228] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.107s)
[339.461248] [080/133] (681s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[339.565593] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[361.982163] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.419s)
[362.129701] [081/133] (659s left) gem_render_copy_redux (normal)
[362.199481] Starting subtest: normal
[362.491085] Subtest normal: SUCCESS (0.291s)
[362.601618] [082/133] (658s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[362.669980] Starting subtest: map-fixed-invalidate-overlap
[362.673769] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[362.822591] [083/133] (658s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[362.871227] Starting subtest: multi-wait-all-for-submit-unsubmitted
[362.979076] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[363.054330] [084/133] (658s left) kms_psr (fbc-psr-suspend)
[363.143689] Starting subtest: fbc-psr-suspend
[363.146102] Starting dynamic subtest: eDP-1
[363.150510] Dynamic subtest eDP-1: SKIP (0.000s)
[363.155081] Subtest fbc-psr-suspend: SKIP (0.001s)
[363.216657] [085/133] (658s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[363.312199] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[364.136726] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.825s)
[364.308656] [086/133] (657s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[364.415331] Starting subtest: psr-2p-primscrn-spr-indfb-move
[364.419794] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[364.513049] [087/133] (657s left) tools_test (tools_test)
[364.566776] Starting subtest: tools_test
[364.612225] Subtest tools_test: SUCCESS (0.063s)
[364.678347] [088/133] (657s left) kms_pm_rpm (basic-pci-d3-state)
[366.197538] Starting subtest: basic-pci-d3-state
[367.669151] Subtest basic-pci-d3-state: SUCCESS (1.471s)
[367.753091] [089/133] (654s left) kms_hdr (brightness-with-hdr)
[367.855797] Starting subtest: brightness-with-hdr
[367.862743] Subtest brightness-with-hdr: SKIP (0.001s)
[367.932371] [090/133] (653s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[367.994410] Subtest writes-after-reads: SKIP (0.000s)
[368.046924] [091/133] (653s left) gem_userptr_blits (stress-mm-invalidate-close)
[368.121084] Starting subtest: stress-mm-invalidate-close
[370.269992] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[370.419194] [092/133] (651s left) gem_exec_reloc (basic-write-read-active)
[370.482589] Subtest basic-write-read-active: SKIP (0.000s)
[370.554748] [093/133] (651s left) kms_color (ctm-signed)
[370.654935] Starting subtest: ctm-signed
[370.657133] Starting dynamic subtest: pipe-A-eDP-1
[372.730622] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s)
[372.740478] Starting dynamic subtest: pipe-B-eDP-1
[375.525815] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.795s)
[375.535095] Starting dynamic subtest: pipe-C-eDP-1
[378.287872] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.762s)
[378.297810] Starting dynamic subtest: pipe-D-eDP-1
[380.988371] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.698s)
[380.990638] Subtest ctm-signed: SUCCESS (10.333s)
[381.796291] [094/133] (640s left) gem_exec_create (forked)
[381.858996] Starting subtest: forked
[381.861378] Starting dynamic subtest: smem
[403.863962] Dynamic subtest smem: SUCCESS (22.005s)
[403.867266] Subtest forked: SUCCESS (22.007s)
[404.062975] [095/133] (617s left) i915_pm_rc6_residency (rc6-accuracy)
[404.121844] Starting subtest: rc6-accuracy
[404.124106] Starting dynamic subtest: gt0
[407.292641] Dynamic subtest gt0: SUCCESS (3.169s)
[407.303619] Starting dynamic subtest: gt1
[410.465666] Dynamic subtest gt1: SUCCESS (3.169s)
[410.468227] Subtest rc6-accuracy: SUCCESS (6.344s)
[410.536258] [096/133] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[410.638194] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[410.642180] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[410.731235] [097/133] (611s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[410.815909] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[410.818327] Starting dynamic subtest: pipe-A-eDP-1
[410.876437] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[411.182956] Starting dynamic subtest: pipe-B-eDP-1
[411.947739] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.774s)
[412.242151] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.428s)
[413.075416] [098/133] (609s left) perf (non-zero-reason)
[413.170286] Starting subtest: non-zero-reason
[413.172919] Starting dynamic subtest: 0-rcs0
[418.536067] Dynamic subtest 0-rcs0: SUCCESS (5.364s)
[418.548762] Starting dynamic subtest: 1-vcs1
[422.448295] Dynamic subtest 1-vcs1: SUCCESS (3.910s)
[422.451294] Subtest non-zero-reason: SUCCESS (9.276s)
[422.495418] [099/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[422.602122] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[422.606417] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[422.699070] [100/133] (599s left) i915_pm_rps (thresholds)
[422.762278] Starting subtest: thresholds
[422.766740] Subtest thresholds: SKIP (0.000s)
[422.859828] [101/133] (599s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[422.982726] Starting subtest: cursorA-vs-flipA-legacy
[434.096848] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.114s)
[434.970570] [102/133] (587s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[435.076216] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[435.080674] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[435.176707] [103/133] (587s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[435.219833] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[435.258561] [104/133] (587s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[435.351608] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[435.355764] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[435.450098] [105/133] (586s left) sysfs_heartbeat_interval (mixed)
[435.505960] Starting subtest: mixed
[435.507887] Starting dynamic subtest: vecs0
[440.734626] Dynamic subtest vecs0: SUCCESS (5.230s)
[440.746570] Starting dynamic subtest: ccs0
[445.917204] Dynamic subtest ccs0: SUCCESS (5.180s)
[445.928567] Starting dynamic subtest: vcs0
[451.141329] Dynamic subtest vcs0: SUCCESS (5.222s)
[451.152045] Starting dynamic subtest: bcs0
[456.351053] Dynamic subtest bcs0: SUCCESS (5.207s)
[456.362552] Starting dynamic subtest: rcs0
[461.555088] Dynamic subtest rcs0: SUCCESS (5.202s)
[461.565527] Starting dynamic subtest: vcs1
[466.758851] Dynamic subtest vcs1: SUCCESS (5.202s)
[466.761390] Subtest mixed: SUCCESS (31.255s)
[466.849992] [106/133] (555s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[467.149708] Starting subtest: cursor-rapid-movement-512x170
[467.154290] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[467.291025] [107/133] (555s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[467.384044] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[467.386196] Starting dynamic subtest: pipe-A-eDP-1
[467.407836] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[467.418458] Starting dynamic subtest: pipe-B-eDP-1
[467.439620] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[467.450161] Starting dynamic subtest: pipe-C-eDP-1
[467.471317] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[467.482200] Starting dynamic subtest: pipe-D-eDP-1
[467.503130] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.507091] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[469.685730] [108/133] (552s left) drm_read (empty-nonblock)
[469.829160] Starting subtest: empty-nonblock
[469.831518] Subtest empty-nonblock: SUCCESS (0.000s)
[469.965815] [109/133] (552s left) kms_prime (basic-crc-hybrid)
[470.041400] Subtest basic-crc-hybrid: SKIP (0.000s)
[470.211426] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[470.214823] [110/133] (552s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[470.347023] Starting subtest: basic-busy-flip-before-cursor-atomic
[470.351487] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[470.489758] [111/133] (552s left) kms_psr (fbc-psr-primary-mmap-gtt)
[470.576802] Starting subtest: fbc-psr-primary-mmap-gtt
[470.578958] Starting dynamic subtest: eDP-1
[470.583375] Dynamic subtest eDP-1: SKIP (0.000s)
[470.587670] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.002s)
[470.652528] [112/133] (552s left) gem_ctx_persistence (engines-mixed)
[470.711066] Starting subtest: engines-mixed
[470.712882] Starting dynamic subtest: rcs0
[470.804552] Dynamic subtest rcs0: SUCCESS (0.093s)
[470.815094] Starting dynamic subtest: bcs0
[470.854217] Dynamic subtest bcs0: SUCCESS (0.047s)
[470.863743] Starting dynamic subtest: vcs0
[470.899834] Dynamic subtest vcs0: SUCCESS (0.044s)
[470.911209] Starting dynamic subtest: vcs1
[470.963265] Dynamic subtest vcs1: SUCCESS (0.061s)
[470.976560] Starting dynamic subtest: vecs0
[471.019526] Dynamic subtest vecs0: SUCCESS (0.054s)
[471.030106] Starting dynamic subtest: ccs0
[471.079417] Dynamic subtest ccs0: SUCCESS (0.058s)
[471.081657] Subtest engines-mixed: SUCCESS (0.370s)
[471.158552] [113/133] (551s left) kms_cursor_edge_walk (256x256-left-edge)
[471.253120] Starting subtest: 256x256-left-edge
[471.254943] Starting dynamic subtest: pipe-A-eDP-1
[474.712643] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[474.722640] Starting dynamic subtest: pipe-D-eDP-1
[477.907173] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.193s)
[477.909505] Subtest 256x256-left-edge: SUCCESS (6.654s)
[478.772211] [114/133] (543s left) gem_exec_fence (submit3)
[478.965421] Starting subtest: submit3
[478.969557] Subtest submit3: SKIP (0.000s)
[481.003586] [115/133] (541s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[481.106270] Starting subtest: yf-tiled-32bpp-rotate-0
[481.110515] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[481.213604] [116/133] (541s left) kms_cursor_crc (cursor-offscreen-512x170)
[481.518668] Starting subtest: cursor-offscreen-512x170
[481.522953] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[481.659763] [117/133] (541s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[481.743174] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[488.362459] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.620s)
[488.479342] [118/133] (534s left) api_intel_bb (intel-bb-blit-x)
[488.532978] Starting subtest: intel-bb-blit-x
[491.919582] Subtest intel-bb-blit-x: SUCCESS (3.386s)
[492.021234] [119/133] (530s left) gem_exec_reloc (basic-gtt-read-active)
[492.078172] Subtest basic-gtt-read-active: SKIP (0.000s)
[492.142666] [120/133] (530s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[492.245666] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[492.249808] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[492.340081] [121/133] (530s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[492.431270] Starting subtest: yf-tiled-64bpp-rotate-180
[492.435741] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[492.562854] [122/133] (530s left) kms_chamelium_hpd (dp-hpd-fast)
[492.941232] Subtest dp-hpd-fast: SKIP (0.000s)
[493.762385] [123/133] (529s left) gem_exec_async (concurrent-writes)
[493.825319] Starting subtest: concurrent-writes
[493.827685] Starting dynamic subtest: rcs0
[493.840806] Dynamic subtest rcs0: SUCCESS (0.015s)
[493.851669] Starting dynamic subtest: bcs0
[493.854058] Dynamic subtest bcs0: SUCCESS (0.005s)
[493.862699] Starting dynamic subtest: vcs0
[493.864690] Dynamic subtest vcs0: SUCCESS (0.005s)
[493.873359] Starting dynamic subtest: vcs1
[493.875525] Dynamic subtest vcs1: SUCCESS (0.006s)
[493.884119] Starting dynamic subtest: vecs0
[493.886292] Dynamic subtest vecs0: SUCCESS (0.006s)
[493.895142] Starting dynamic subtest: ccs0
[493.897322] Dynamic subtest ccs0: SUCCESS (0.006s)
[493.899564] Subtest concurrent-writes: SUCCESS (0.046s)
[494.096633] [124/133] (529s left) prime_self_import (basic-with_two_bos)
[494.130650] Starting subtest: basic-with_two_bos
[494.144676] Subtest basic-with_two_bos: SUCCESS (0.016s)
[494.257955] [125/133] (528s left) perf_pmu (multi-client)
[494.301148] Starting subtest: multi-client
[494.303369] Starting dynamic subtest: rcs0
[495.361490] Dynamic subtest rcs0: SUCCESS (1.061s)
[495.373769] Starting dynamic subtest: bcs0
[496.413916] Dynamic subtest bcs0: SUCCESS (1.049s)
[496.426240] Starting dynamic subtest: vcs0
[497.466243] Dynamic subtest vcs0: SUCCESS (1.050s)
[497.476043] Starting dynamic subtest: vcs1
[498.892090] Dynamic subtest vcs1: SUCCESS (1.423s)
[498.904281] Starting dynamic subtest: vecs0
[500.943930] Dynamic subtest vecs0: SUCCESS (2.049s)
[500.955526] Starting dynamic subtest: ccs0
[502.926986] Dynamic subtest ccs0: SUCCESS (1.980s)
[502.929780] Subtest multi-client: SUCCESS (8.628s)
[503.059848] [126/133] (520s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[503.151052] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[503.153383] Starting dynamic subtest: pipe-A-default-mode
[505.873961] Dynamic subtest pipe-A-default-mode: SUCCESS (2.720s)
[505.876187] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.722s)
[506.672446] [127/133] (516s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[506.778127] Starting subtest: fbc-pr-cursor-mmap-cpu
[506.782654] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[506.860192] [128/133] (516s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[506.956277] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[506.958591] Starting dynamic subtest: pipe-A-eDP-1
[507.017651] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[507.026077] Starting dynamic subtest: pipe-B-eDP-1
[507.084309] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[507.094846] Starting dynamic subtest: pipe-C-eDP-1
[507.152699] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[507.162839] Starting dynamic subtest: pipe-D-eDP-1
[507.220698] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[507.225309] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[509.173132] [129/133] (514s left) kms_lease (lease-invalid-crtc)
[509.262741] Starting subtest: lease-invalid-crtc
[509.264933] Starting dynamic subtest: pipe-A-eDP-1
[509.267233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[509.276822] Starting dynamic subtest: pipe-B-eDP-1
[509.279072] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[509.287815] Starting dynamic subtest: pipe-C-eDP-1
[509.290138] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[509.298656] Starting dynamic subtest: pipe-D-eDP-1
[509.300789] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[509.302902] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[509.340614] [130/133] (514s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[509.448517] Starting subtest: x-tiled-8bpp-rotate-90
[509.470145] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[509.584101] [131/133] (513s left) gem_sync (basic-each)
[509.658278] Starting subtest: basic-each
[511.971317] Subtest basic-each: SUCCESS (2.323s)
[512.171875] [132/133] (511s left) syncobj_wait (multi-wait-submitted)
[512.240766] Starting subtest: multi-wait-submitted
[512.346986] Subtest multi-wait-submitted: SUCCESS (0.104s)
[512.429813] [133/133] (511s left) gem_exec_create (madvise)
[512.497990] Starting subtest: madvise
[512.500366] Starting dynamic subtest: smem
[533.968385] Dynamic subtest smem: SUCCESS (21.468s)
[533.970857] Subtest madvise: SUCCESS (21.469s)
[534.809303] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_pwrite
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: dumb_buffer
results: parsing output: 7/ for test: kms_plane_lowres
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_madvise
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: gem_workarounds
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: kms_chamelium_color
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: gem_ctx_persistence
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: kms_plane
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_universal_plane
results: parsing output: 34/ for test: gem_mmap_offset
results: parsing output: 35/ for test: gem_wait
results: parsing output: 36/ for test: gem_create
results: parsing output: 37/ for test: gem_media_fill
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: gem_create
results: parsing output: 41/ for test: i915_pm_freq_api
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_chamelium_edid
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: api_intel_allocator
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gen7_exec_parse
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gen3_render_mixed_blits
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_dsc
results: parsing output: 60/ for test: i915_drm_fdinfo
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_properties
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_invalid_mode
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_force_connector_basic
results: parsing output: 74/ for test: kms_plane_alpha_blend
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: gem_busy
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_render_copy_redux
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: tools_test
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: kms_hdr
results: parsing output: 89/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: gem_exec_create
results: parsing output: 94/ for test: i915_pm_rc6_residency
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_atomic_transition
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: i915_pm_rps
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_lmem_swapping
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: sysfs_heartbeat_interval
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: kms_prime
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_cursor_edge_walk
results: parsing output: 113/ for test: gem_exec_fence
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_chamelium_hpd
results: parsing output: 122/ for test: gem_exec_async
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_sync
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: gem_exec_create
Done.