[184.715112] Initializing watchdogs
[184.715188]   /dev/watchdog0
[184.736800] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[184.748360] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[184.752468] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[184.754760] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[184.943495] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[184.945248] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[185.104493] [002/133] (960s left) gem_mmap_wc (bad-offset)
[185.178918] Subtest bad-offset: SKIP (0.000s)
[185.261516] [003/133] (960s left) kms_psr (fbc-pr-suspend)
[185.439383] Subtest fbc-pr-suspend: SKIP (0.000s)
[185.499368] [004/133] (959s left) api_intel_allocator (standalone)
[185.568403] Starting subtest: standalone
[185.617252] Subtest standalone: SUCCESS (0.049s)
[185.777798] [005/133] (959s left) syncobj_basic (bad-handle-to-fd)
[185.849979] Starting subtest: bad-handle-to-fd
[185.850909] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[186.033667] [006/133] (959s left) gem_exec_schedule (semaphore-codependency)
[186.124280] Starting subtest: semaphore-codependency
[186.169418] Subtest semaphore-codependency: SUCCESS (0.045s)
[186.569789] [007/133] (959s left) kms_big_fb (4-tiled-addfb-size-overflow)
[186.762229] Starting subtest: 4-tiled-addfb-size-overflow
[186.763180] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.001s)
[186.892411] [008/133] (958s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[186.972945] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[187.051543] [009/133] (958s left) kms_psr (pr-sprite-mmap-cpu)
[187.230085] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[187.282477] [010/133] (958s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[187.463560] Starting subtest: short-flip-before-cursor-toggle
[188.543165] Subtest short-flip-before-cursor-toggle: SUCCESS (1.078s)
[188.809587] [011/133] (957s left) gem_mmap_gtt (basic)
[188.882906] Subtest basic: SKIP (0.000s)
[188.947218] [012/133] (956s left) kms_atomic_interruptible (universal-setplane-cursor)
[189.125124] Starting subtest: universal-setplane-cursor
[189.125977] Starting dynamic subtest: pipe-A-DP-3
[195.469946] Dynamic subtest pipe-A-DP-3: SUCCESS (6.341s)
[195.471248] Subtest universal-setplane-cursor: SUCCESS (6.342s)
[195.712166] [013/133] (950s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[195.782209] Starting subtest: invalid-signal-one-illegal-handle
[195.783190] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[195.901663] [014/133] (950s left) kms_psr (psr-sprite-mmap-cpu)
[196.079624] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[196.140055] [015/133] (949s left) device_reset (unbind-cold-reset-rebind)
[196.219188] Starting subtest: unbind-cold-reset-rebind
[196.221154] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[196.317076] [016/133] (949s left) syncobj_eventfd (invalid-illegal-eventfd)
[196.390929] Starting subtest: invalid-illegal-eventfd
[196.391989] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[196.525882] [017/133] (949s left) kms_content_protection (dp-mst-lic-type-1)
[196.767943] Starting subtest: dp-mst-lic-type-1
[196.769584] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[196.936479] [018/133] (949s left) kms_vblank (query-forked)
[197.117960] Starting subtest: query-forked
[197.119938] Starting dynamic subtest: pipe-A-DP-3
[199.475568] Dynamic subtest pipe-A-DP-3: SUCCESS (2.356s)
[199.490290] Starting dynamic subtest: pipe-D-DP-3
[201.839304] Dynamic subtest pipe-D-DP-3: SUCCESS (2.360s)
[201.840226] Subtest query-forked: SUCCESS (4.721s)
[202.087016] [019/133] (944s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[202.272492] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[204.727539] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.456s)
[204.878625] [020/133] (941s left) gem_reg_read (bad-register)
[204.950224] Starting subtest: bad-register
[204.951166] Subtest bad-register: SUCCESS (0.000s)
[205.073203] [021/133] (941s left) perf (oa-formats)
[205.430871] Starting subtest: oa-formats
[205.431665] Starting dynamic subtest: 0-rcs0
[205.453483] Dynamic subtest 0-rcs0: SUCCESS (0.023s)
[205.454410] Subtest oa-formats: SUCCESS (0.024s)
[205.503878] [022/133] (941s left) gem_ctx_persistence (hang)
[205.582460] Starting subtest: hang
[205.584435] Subtest hang: SKIP (0.000s)
[205.760618] [023/133] (940s left) gem_exec_gttfill (multigpu-basic)
[205.948866] Starting subtest: multigpu-basic
[220.088010] Subtest multigpu-basic: SUCCESS (14.138s)
[220.191347] [024/133] (926s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[220.414695] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[220.416294] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[220.522551] [025/133] (926s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[220.772561] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[220.917683] [026/133] (925s left) kms_plane_multiple (tiling-x)
[221.095918] Starting subtest: tiling-x
[221.096827] Starting dynamic subtest: pipe-A-DP-3
[222.288162] Dynamic subtest pipe-A-DP-3: SUCCESS (1.191s)
[222.297855] Starting dynamic subtest: pipe-B-DP-3
[223.366857] Dynamic subtest pipe-B-DP-3: SUCCESS (1.078s)
[223.376274] Starting dynamic subtest: pipe-C-DP-3
[224.446288] Dynamic subtest pipe-C-DP-3: SUCCESS (1.079s)
[224.456027] Starting dynamic subtest: pipe-D-DP-3
[225.533336] Dynamic subtest pipe-D-DP-3: SUCCESS (1.086s)
[225.534200] Subtest tiling-x: SUCCESS (4.438s)
[225.809579] [027/133] (921s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[226.198389] Starting subtest: cursor-rapid-movement-128x42
[226.203018] Starting dynamic subtest: pipe-A-DP-3
[226.738472] Dynamic subtest pipe-A-DP-3: SUCCESS (0.535s)
[226.781108] Starting dynamic subtest: pipe-D-DP-3
[227.146999] Dynamic subtest pipe-D-DP-3: SUCCESS (0.374s)
[227.148076] Subtest cursor-rapid-movement-128x42: SUCCESS (0.948s)
[227.581054] [028/133] (919s left) syncobj_wait (reset-during-wait-for-submit)
[227.662368] Starting subtest: reset-during-wait-for-submit
[227.765113] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[227.900370] [029/133] (919s left) gem_linear_blits (interruptible)
[228.087412] Starting subtest: interruptible
[235.342059] Subtest interruptible: SUCCESS (7.254s)
[235.527252] [030/133] (911s left) syncobj_wait (wait-all-for-submit-snapshot)
[235.642599] Starting subtest: wait-all-for-submit-snapshot
[235.725845] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[235.860229] [031/133] (911s left) kms_lease (lease-invalid-connector)
[236.044447] Starting subtest: lease-invalid-connector
[236.045328] Starting dynamic subtest: pipe-A-DP-3
[236.046201] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[236.055627] Starting dynamic subtest: pipe-B-DP-3
[236.056485] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[236.066039] Starting dynamic subtest: pipe-C-DP-3
[236.067131] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[236.076623] Starting dynamic subtest: pipe-D-DP-3
[236.077497] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[236.078577] Subtest lease-invalid-connector: SUCCESS (0.004s)
[236.139849] [032/133] (910s left) sysfs_timeslice_duration (timeout)
[236.217089] Starting subtest: timeout
[236.218051] Starting dynamic subtest: vecs0
[237.953117] Dynamic subtest vecs0: SUCCESS (1.735s)
[237.963124] Starting dynamic subtest: ccs0
[239.722140] Dynamic subtest ccs0: SUCCESS (1.768s)
[239.731836] Starting dynamic subtest: vcs0
[241.393162] Dynamic subtest vcs0: SUCCESS (1.670s)
[241.402876] Starting dynamic subtest: bcs0
[242.472563] Dynamic subtest bcs0: SUCCESS (1.079s)
[242.482336] Starting dynamic subtest: vecs1
[244.194105] Dynamic subtest vecs1: SUCCESS (1.721s)
[244.203900] Starting dynamic subtest: rcs0
[245.849252] Dynamic subtest rcs0: SUCCESS (1.654s)
[245.859428] Starting dynamic subtest: vcs1
[247.466353] Dynamic subtest vcs1: SUCCESS (1.616s)
[247.467417] Subtest timeout: SUCCESS (11.249s)
[247.665446] [033/133] (899s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[247.848080] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[247.849005] Starting dynamic subtest: pipe-A-DP-3
[247.857302] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[247.866860] Starting dynamic subtest: pipe-B-DP-3
[247.875050] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[247.884457] Starting dynamic subtest: pipe-C-DP-3
[247.892734] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[247.902087] Starting dynamic subtest: pipe-D-DP-3
[247.912385] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[247.914387] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[248.305580] [034/133] (898s left) kms_prop_blob (blob-prop-core)
[248.378229] Starting subtest: blob-prop-core
[248.379160] Subtest blob-prop-core: SUCCESS (0.000s)
[248.497566] [035/133] (898s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[248.681872] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[248.683557] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[248.823373] [036/133] (898s left) kms_atomic (plane-invalid-params)
[248.998739] Starting subtest: plane-invalid-params
[249.000972] Starting dynamic subtest: pipe-A-DP-3
[249.855369] Dynamic subtest pipe-A-DP-3: SUCCESS (0.855s)
[249.856455] Subtest plane-invalid-params: SUCCESS (0.857s)
[250.136939] [037/133] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[250.318525] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[250.320187] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[250.489617] [038/133] (897s left) kms_properties (invalid-properties-atomic)
[250.674581] Starting subtest: invalid-properties-atomic
[251.185442] Subtest invalid-properties-atomic: SUCCESS (0.510s)
[251.307866] [039/133] (896s left) i915_query (hwconfig_table)
[251.376106] Starting subtest: hwconfig_table
[251.551802] Subtest hwconfig_table: SUCCESS (0.002s)
[251.620634] [040/133] (896s left) kms_plane (pixel-format-linear-modifier)
[251.795906] Starting subtest: pixel-format-linear-modifier
[251.824337] Starting dynamic subtest: pipe-A-plane-0
[258.224214] Dynamic subtest pipe-A-plane-0: SUCCESS (6.400s)
[258.235324] Starting dynamic subtest: pipe-A-plane-3
[261.024287] Dynamic subtest pipe-A-plane-3: SUCCESS (2.799s)
[261.034770] Starting dynamic subtest: pipe-A-plane-5
[261.274615] Dynamic subtest pipe-A-plane-5: SUCCESS (0.249s)
[261.531129] Starting dynamic subtest: pipe-B-plane-0
[267.179298] Dynamic subtest pipe-B-plane-0: SUCCESS (5.666s)
[267.189598] Starting dynamic subtest: pipe-B-plane-3
[270.429746] Dynamic subtest pipe-B-plane-3: SUCCESS (3.250s)
[270.440788] Starting dynamic subtest: pipe-B-plane-5
[270.680023] Dynamic subtest pipe-B-plane-5: SUCCESS (0.249s)
[270.820160] Subtest pixel-format-linear-modifier: SUCCESS (19.023s)
[271.095699] [041/133] (876s left) drm_read (invalid-buffer)
[271.347842] Starting subtest: invalid-buffer
[271.348951] Subtest invalid-buffer: SUCCESS (0.000s)
[271.557752] [042/133] (876s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[271.627202] Starting subtest: etime-multi-wait-for-submit-submitted
[271.740398] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[271.882684] [043/133] (876s left) i915_drm_fdinfo (busy)
[271.945322] Starting subtest: busy
[271.946245] Starting dynamic subtest: rcs0
[271.959281] Dynamic subtest rcs0: SKIP (0.013s)
[271.969234] Starting dynamic subtest: bcs0
[271.978901] Dynamic subtest bcs0: SKIP (0.011s)
[271.988868] Starting dynamic subtest: vcs0
[271.991054] Dynamic subtest vcs0: SKIP (0.000s)
[272.000925] Starting dynamic subtest: vcs1
[272.003351] Dynamic subtest vcs1: SKIP (0.000s)
[272.013183] Starting dynamic subtest: vecs0
[272.015548] Dynamic subtest vecs0: SKIP (0.000s)
[272.025520] Starting dynamic subtest: vecs1
[272.027928] Dynamic subtest vecs1: SKIP (0.000s)
[272.037814] Starting dynamic subtest: ccs0
[272.039839] Dynamic subtest ccs0: SKIP (0.000s)
[272.041762] Subtest busy: SKIP (0.030s)
[272.113222] [044/133] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[272.294796] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[272.296450] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[272.401810] [045/133] (875s left) gem_create (create-ext-placement-sanity-check)
[272.588729] Starting subtest: create-ext-placement-sanity-check
[272.589628] Subtest create-ext-placement-sanity-check: SUCCESS (0.003s)
[272.761200] [046/133] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[272.947973] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[272.949872] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[273.082378] [047/133] (875s left) gem_lmem_swapping (heavy-verify-random-ccs)
[275.776797] Starting subtest: heavy-verify-random-ccs
[275.777603] Starting dynamic subtest: lmem0
[285.696513] Dynamic subtest lmem0: SUCCESS (9.921s)
[285.697416] Subtest heavy-verify-random-ccs: SUCCESS (9.922s)
[286.975051] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[286.976709] [048/133] (861s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[288.700517] Starting subtest: plane-lut1d-ctm3x4
[288.927850] Starting dynamic subtest: pipe-A-plane-0
[289.140894] Dynamic subtest pipe-A-plane-0: SUCCESS (0.215s)
[289.171074] Starting dynamic subtest: pipe-A-plane-1
[289.323594] Dynamic subtest pipe-A-plane-1: SUCCESS (0.180s)
[289.360020] Starting dynamic subtest: pipe-A-plane-2
[289.522362] Dynamic subtest pipe-A-plane-2: SUCCESS (0.196s)
[289.888721] Starting dynamic subtest: pipe-B-plane-0
[290.067673] Dynamic subtest pipe-B-plane-0: SUCCESS (0.215s)
[290.102217] Starting dynamic subtest: pipe-B-plane-1
[290.268542] Dynamic subtest pipe-B-plane-1: SUCCESS (0.197s)
[290.302898] Starting dynamic subtest: pipe-B-plane-2
[290.468989] Dynamic subtest pipe-B-plane-2: SUCCESS (0.196s)
[290.857350] Starting dynamic subtest: pipe-C-plane-0
[291.025862] Dynamic subtest pipe-C-plane-0: SUCCESS (0.198s)
[291.058474] Starting dynamic subtest: pipe-C-plane-1
[291.224671] Dynamic subtest pipe-C-plane-1: SUCCESS (0.195s)
[291.234658] Starting dynamic subtest: pipe-C-plane-2
[291.408674] Dynamic subtest pipe-C-plane-2: SUCCESS (0.183s)
[291.779983] Starting dynamic subtest: pipe-D-plane-0
[291.965345] Dynamic subtest pipe-D-plane-0: SUCCESS (0.215s)
[291.987922] Starting dynamic subtest: pipe-D-plane-1
[292.165693] Dynamic subtest pipe-D-plane-1: SUCCESS (0.198s)
[292.198127] Starting dynamic subtest: pipe-D-plane-2
[292.381142] Dynamic subtest pipe-D-plane-2: SUCCESS (0.213s)
[292.440423] Subtest plane-lut1d-ctm3x4: SUCCESS (3.739s)
[292.749858] [FACT kms_color_pipeline (plane-lut1d-ctm3x4)] new: kernel.kmod_is_loaded.i915: true
[292.752712] [049/133] (855s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[292.941945] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[292.943616] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[293.063447] [050/133] (855s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[293.134327] Starting subtest: wait-all-for-submit-delayed-submit
[293.235652] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.101s)
[293.336506] [051/133] (855s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[293.527272] Starting subtest: y-tiled-32bpp-rotate-270
[293.529136] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[293.677911] [052/133] (854s left) fbdev (unaligned-write)
[293.733273] Starting subtest: unaligned-write
[294.116736] Subtest unaligned-write: SUCCESS (0.383s)
[294.192834] [053/133] (854s left) gem_mmap_gtt (coherency)
[294.268248] Subtest coherency: SKIP (0.000s)
[294.353226] [054/133] (854s left) kms_flip (basic-flip-vs-wf_vblank)
[294.533221] Starting subtest: basic-flip-vs-wf_vblank
[294.537780] Starting dynamic subtest: A-DP3
[295.682665] Dynamic subtest A-DP3: SUCCESS (1.145s)
[295.700917] Starting dynamic subtest: B-DP3
[296.742544] Dynamic subtest B-DP3: SUCCESS (1.058s)
[296.754464] Starting dynamic subtest: C-DP3
[297.797518] Dynamic subtest C-DP3: SUCCESS (1.054s)
[297.809198] Starting dynamic subtest: D-DP3
[298.852563] Dynamic subtest D-DP3: SUCCESS (1.054s)
[298.854908] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.321s)
[299.162785] [055/133] (849s left) gen9_exec_parse (batch-zero-length)
[299.245472] Subtest batch-zero-length: SKIP (0.000s)
[299.308291] [056/133] (849s left) kms_flip (wf_vblank-ts-check-interruptible)
[299.492219] Starting subtest: wf_vblank-ts-check-interruptible
[299.497155] Starting dynamic subtest: A-DP3
[307.626879] Dynamic subtest A-DP3: SUCCESS (8.129s)
[307.639977] Starting dynamic subtest: B-DP3
[315.660262] Dynamic subtest B-DP3: SUCCESS (8.030s)
[315.674338] Starting dynamic subtest: C-DP3
[323.689038] Dynamic subtest C-DP3: SUCCESS (8.024s)
[323.700966] Starting dynamic subtest: D-DP3
[331.722926] Dynamic subtest D-DP3: SUCCESS (8.032s)
[331.725212] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.232s)
[332.048186] [057/133] (816s left) kms_sequence (get-busy)
[332.227408] Starting subtest: get-busy
[332.228293] Starting dynamic subtest: pipe-A-DP-3
[334.803754] Dynamic subtest pipe-A-DP-3: SUCCESS (2.575s)
[334.816005] Starting dynamic subtest: pipe-B-DP-3
[337.293395] Dynamic subtest pipe-B-DP-3: SUCCESS (2.487s)
[337.304765] Starting dynamic subtest: pipe-C-DP-3
[339.768873] Dynamic subtest pipe-C-DP-3: SUCCESS (2.473s)
[339.780358] Starting dynamic subtest: pipe-D-DP-3
[342.245718] Dynamic subtest pipe-D-DP-3: SUCCESS (2.476s)
[342.246548] Subtest get-busy: SUCCESS (10.020s)
[342.527080] [058/133] (806s left) perf (invalid-oa-format-id)
[342.913498] Starting subtest: invalid-oa-format-id
[342.932105] Subtest invalid-oa-format-id: SUCCESS (0.019s)
[342.989677] [059/133] (805s left) perf_pmu (render-node-busy)
[343.087741] Starting subtest: render-node-busy
[343.088595] Starting dynamic subtest: rcs0
[343.698714] Dynamic subtest rcs0: SUCCESS (0.610s)
[343.711269] Starting dynamic subtest: bcs0
[344.256442] Dynamic subtest bcs0: SUCCESS (0.556s)
[344.271395] Starting dynamic subtest: vcs0
[344.816106] Dynamic subtest vcs0: SUCCESS (0.556s)
[344.831174] Starting dynamic subtest: vcs1
[345.378992] Dynamic subtest vcs1: SUCCESS (0.560s)
[345.393803] Starting dynamic subtest: vecs0
[345.939677] Dynamic subtest vecs0: SUCCESS (0.555s)
[345.954457] Starting dynamic subtest: vecs1
[346.498673] Dynamic subtest vecs1: SUCCESS (0.554s)
[346.513765] Starting dynamic subtest: ccs0
[347.060994] Dynamic subtest ccs0: SUCCESS (0.557s)
[347.066184] Subtest render-node-busy: SUCCESS (3.975s)
[347.190907] [060/133] (801s left) kms_cursor_crc (cursor-sliding-64x21)
[347.533386] Starting subtest: cursor-sliding-64x21
[347.538391] Starting dynamic subtest: pipe-A-DP-3
[351.941068] Dynamic subtest pipe-A-DP-3: SUCCESS (4.402s)
[351.988504] Starting dynamic subtest: pipe-D-DP-3
[356.436561] Dynamic subtest pipe-D-DP-3: SUCCESS (4.458s)
[356.437547] Subtest cursor-sliding-64x21: SUCCESS (8.903s)
[356.853758] [061/133] (792s left) gem_exec_await (wide-contexts)
[357.155109] Starting subtest: wide-contexts
[379.196239] Subtest wide-contexts: SUCCESS (22.041s)
[379.412636] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[379.415919] [062/133] (769s left) gem_eio (throttle)
[379.730448] Starting subtest: throttle
[380.198613] Subtest throttle: SUCCESS (0.468s)
[380.408982] [063/133] (768s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[380.607200] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[386.288378] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (5.682s)
[386.495366] [064/133] (762s left) kms_chamelium_frames (dp-crc-multiple)
[386.765221] Subtest dp-crc-multiple: SKIP (0.000s)
[386.916417] [065/133] (762s left) syncobj_wait (multi-wait-all-signaled)
[387.006222] Starting subtest: multi-wait-all-signaled
[387.007215] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[387.189522] [066/133] (762s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[387.378376] Starting subtest: plane-scaler-unity-scaling-with-rotation
[387.379146] Starting dynamic subtest: pipe-A
[387.740500] Dynamic subtest pipe-A: SUCCESS (0.363s)
[387.768587] Starting dynamic subtest: pipe-B
[388.219458] Dynamic subtest pipe-B: SUCCESS (0.477s)
[388.242364] Starting dynamic subtest: pipe-C
[388.700474] Dynamic subtest pipe-C: SUCCESS (0.479s)
[388.723837] Starting dynamic subtest: pipe-D
[389.181673] Dynamic subtest pipe-D: SUCCESS (0.479s)
[389.185334] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (1.806s)
[389.516886] [067/133] (760s left) gem_exec_balancer (invalid-balancer)
[389.607243] Starting subtest: invalid-balancer
[391.246990] Subtest invalid-balancer: SUCCESS (1.639s)
[391.647153] [068/133] (757s left) kms_cursor_crc (cursor-onscreen-max-size)
[392.160381] Starting subtest: cursor-onscreen-max-size
[392.163049] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[392.330898] [069/133] (757s left) gem_ctx_param (vm)
[392.411781] Starting subtest: vm
[392.502893] Subtest vm: SUCCESS (0.091s)
[392.691015] [070/133] (757s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[392.875777] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[392.876600] Starting dynamic subtest: pipe-A
[392.976904] Dynamic subtest pipe-A: SUCCESS (0.101s)
[392.991953] Starting dynamic subtest: pipe-B
[393.173773] Dynamic subtest pipe-B: SUCCESS (0.196s)
[393.193239] Starting dynamic subtest: pipe-C
[393.388092] Dynamic subtest pipe-C: SUCCESS (0.213s)
[393.413051] Starting dynamic subtest: pipe-D
[393.601858] Dynamic subtest pipe-D: SUCCESS (0.212s)
[393.602956] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.727s)
[393.919254] [071/133] (755s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[394.110429] Starting subtest: 2x-long-flip-vs-cursor-atomic
[394.112167] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[394.201978] [072/133] (755s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[394.401334] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[394.403152] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[394.531378] [073/133] (755s left) kms_flip (basic-flip-vs-modeset)
[394.719046] Starting subtest: basic-flip-vs-modeset
[394.723902] Starting dynamic subtest: A-DP3
[395.602156] Dynamic subtest A-DP3: SUCCESS (0.876s)
[395.628836] Starting dynamic subtest: B-DP3
[396.430339] Dynamic subtest B-DP3: SUCCESS (0.824s)
[396.454336] Starting dynamic subtest: C-DP3
[397.249589] Dynamic subtest C-DP3: SUCCESS (0.817s)
[397.271959] Starting dynamic subtest: D-DP3
[398.064567] Dynamic subtest D-DP3: SUCCESS (0.812s)
[398.067613] Subtest basic-flip-vs-modeset: SUCCESS (3.348s)
[398.351111] [074/133] (751s left) kms_psr (psr-cursor-mmap-gtt)
[398.547637] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[398.613432] [075/133] (751s left) i915_pm_rpm (sysfs-read)
[401.051133] Starting subtest: sysfs-read
[401.359417] Subtest sysfs-read: SUCCESS (0.311s)
[401.770122] [076/133] (748s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[401.965141] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[401.966864] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[402.170390] [077/133] (748s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[402.360083] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[402.429067] [078/133] (747s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[402.622159] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[402.623903] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[402.809915] [079/133] (747s left) core_auth (getclient-master-drop)
[402.858557] Starting subtest: getclient-master-drop
[402.905331] Subtest getclient-master-drop: SUCCESS (0.048s)
[403.111381] [080/133] (747s left) kms_pm_dc (dc6-dpms)
[404.305342] Starting subtest: dc6-dpms
[404.307222] Subtest dc6-dpms: SKIP (0.000s)
[404.407101] [081/133] (746s left) kms_async_flips (alternate-sync-async-flip-atomic)
[404.598292] Starting subtest: alternate-sync-async-flip-atomic
[404.831852] Starting dynamic subtest: pipe-A-DP-3
[407.117171] Dynamic subtest pipe-A-DP-3: SUCCESS (2.285s)
[407.365982] Starting dynamic subtest: pipe-B-DP-3
[409.490928] Dynamic subtest pipe-B-DP-3: SUCCESS (2.136s)
[409.758220] Starting dynamic subtest: pipe-C-DP-3
[411.876878] Dynamic subtest pipe-C-DP-3: SUCCESS (2.131s)
[412.121339] Starting dynamic subtest: pipe-D-DP-3
[414.236970] Dynamic subtest pipe-D-DP-3: SUCCESS (2.127s)
[414.237906] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.640s)
[414.687944] [082/133] (735s left) gem_exec_reloc (basic-write-cpu-noreloc)
[414.774528] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[414.864200] [083/133] (735s left) gem_exec_nop (basic-series)
[414.954419] Starting subtest: basic-series
[419.304168] Subtest basic-series: SUCCESS (4.348s)
[419.552045] [084/133] (731s left) kms_invalid_mode (bad-hsync-start)
[419.737320] Starting subtest: bad-hsync-start
[419.738231] Starting dynamic subtest: pipe-A-DP-3
[419.824950] Dynamic subtest pipe-A-DP-3: SUCCESS (0.086s)
[419.843112] Starting dynamic subtest: pipe-B-DP-3
[419.844263] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[419.860208] Starting dynamic subtest: pipe-C-DP-3
[419.861423] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[419.873980] Starting dynamic subtest: pipe-D-DP-3
[419.874923] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[419.875803] Subtest bad-hsync-start: SUCCESS (0.099s)
[420.075150] [085/133] (730s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[420.260423] Starting subtest: drrs-dirtyfb-ioctl
[420.265499] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[420.418173] [086/133] (730s left) syncobj_wait (single-wait-all-submitted)
[420.498437] Starting subtest: single-wait-all-submitted
[420.608454] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[420.770967] [087/133] (730s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[420.959331] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[420.960235] Starting dynamic subtest: pipe-A-DP-3
[420.963772] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[420.975679] Starting dynamic subtest: pipe-B-DP-3
[420.979156] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[420.991071] Starting dynamic subtest: pipe-C-DP-3
[420.994574] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[421.006152] Starting dynamic subtest: pipe-D-DP-3
[421.009624] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[421.011284] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[421.414945] [088/133] (729s left) syncobj_wait (single-wait-signaled)
[421.494433] Starting subtest: single-wait-signaled
[421.495339] Subtest single-wait-signaled: SUCCESS (0.000s)
[421.642944] [089/133] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[421.834201] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[421.835894] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[421.969936] [090/133] (729s left) gem_mmap_offset (mmap-boundaries)
[422.047941] Starting subtest: mmap-boundaries
[422.048890] Starting dynamic subtest: lmem0
[422.174245] Dynamic subtest lmem0: SUCCESS (0.127s)
[422.186457] Starting dynamic subtest: smem0
[423.524760] Dynamic subtest smem0: SUCCESS (1.349s)
[423.525614] Subtest mmap-boundaries: SUCCESS (1.479s)
[423.775375] [091/133] (727s left) gem_exec_schedule (wide)
[423.980178] Starting subtest: wide
[423.981176] Starting dynamic subtest: rcs0
[436.741115] Dynamic subtest rcs0: SUCCESS (12.760s)
[436.756042] Starting dynamic subtest: bcs0
[450.054711] Dynamic subtest bcs0: SUCCESS (13.312s)
[450.069266] Starting dynamic subtest: vcs0
[463.951512] Dynamic subtest vcs0: SUCCESS (13.895s)
[463.966783] Starting dynamic subtest: vcs1
[477.553366] Dynamic subtest vcs1: SUCCESS (13.589s)
[477.569477] Starting dynamic subtest: vecs0
[491.166263] Dynamic subtest vecs0: SUCCESS (13.608s)
[491.178747] Starting dynamic subtest: vecs1
[504.718235] Dynamic subtest vecs1: SUCCESS (13.550s)
[504.730819] Starting dynamic subtest: ccs0
[518.430520] Dynamic subtest ccs0: SUCCESS (13.711s)
[518.431453] Subtest wide: SUCCESS (94.449s)
[520.414657] [092/133] (630s left) gem_exec_balancer (sequential)
[520.509390] Starting subtest: sequential
[526.515388] Subtest sequential: SUCCESS (6.006s)
[526.922476] [093/133] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[527.113259] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[527.114932] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[527.254251] [094/133] (624s left) i915_query (query-garbage)
[527.334921] Starting subtest: query-garbage
[527.336098] Subtest query-garbage: SUCCESS (0.000s)
[527.526831] [095/133] (624s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[527.726266] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[527.727964] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[527.935608] [096/133] (623s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[528.021147] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[528.221340] [097/133] (623s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[528.428204] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[529.631549] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.203s)
[529.903823] [098/133] (621s left) syncobj_timeline (reset-signaled)
[529.983449] Starting subtest: reset-signaled
[529.984423] Subtest reset-signaled: SUCCESS (0.000s)
[530.184177] [099/133] (621s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[530.371441] Starting subtest: primary-y-tiled-reflect-x-180
[530.466238] Subtest primary-y-tiled-reflect-x-180: SKIP (0.095s)
[530.670665] [100/133] (621s left) template (b)
[530.755460] Starting subtest: B
[530.756516] Subtest B: SUCCESS (0.000s)
[530.911506] [101/133] (621s left) kms_draw_crc (draw-method-blt)
[531.109667] Starting subtest: draw-method-blt
[531.110554] Starting dynamic subtest: xrgb8888-untiled
[531.449216] Dynamic subtest xrgb8888-untiled: SUCCESS (0.339s)
[531.495116] Starting dynamic subtest: rgb565-untiled
[531.782538] Dynamic subtest rgb565-untiled: SUCCESS (0.328s)
[531.829453] Starting dynamic subtest: xrgb2101010-untiled
[532.115833] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.328s)
[532.157752] Starting dynamic subtest: xbgr16161616f-untiled
[532.449238] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.328s)
[532.497048] Starting dynamic subtest: xrgb8888-xtiled
[532.632585] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.178s)
[532.679187] Starting dynamic subtest: rgb565-xtiled
[532.816138] Dynamic subtest rgb565-xtiled: SUCCESS (0.178s)
[532.862701] Starting dynamic subtest: xrgb2101010-xtiled
[532.982549] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.161s)
[533.032214] Starting dynamic subtest: xbgr16161616f-xtiled
[533.149187] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.161s)
[533.195432] Starting dynamic subtest: xrgb8888-4tiled
[533.332546] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.178s)
[533.380906] Starting dynamic subtest: rgb565-4tiled
[533.517289] Dynamic subtest rgb565-4tiled: SUCCESS (0.179s)
[533.560081] Starting dynamic subtest: xrgb2101010-4tiled
[533.666040] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s)
[533.714618] Starting dynamic subtest: xbgr16161616f-4tiled
[533.832545] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.161s)
[533.835680] Subtest draw-method-blt: SUCCESS (2.726s)
[534.049325] [102/133] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[534.239156] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[534.240881] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[534.372043] [103/133] (617s left) prime_self_import (export-vs-gem_close-race)
[534.421157] Starting subtest: export-vs-gem_close-race
[539.514265] Subtest export-vs-gem_close-race: SUCCESS (5.092s)
[539.666863] [104/133] (612s left) gem_lmem_swapping (random)
[542.366575] Starting subtest: random
[542.367697] Starting dynamic subtest: lmem0
[543.349960] Dynamic subtest lmem0: SUCCESS (0.983s)
[543.350923] Subtest random: SUCCESS (0.984s)
[546.204493] [FACT gem_lmem_swapping (random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[546.205826] [FACT gem_lmem_swapping (random)] deleted: kernel.kmod_is_loaded.i915: true
[546.208234] [105/133] (606s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[547.942773] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[547.945066] Starting dynamic subtest: pipe-A-DP-3
[547.953822] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[547.964154] Starting dynamic subtest: pipe-B-DP-3
[547.972572] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[547.983492] Starting dynamic subtest: pipe-C-DP-3
[547.991827] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[548.002146] Starting dynamic subtest: pipe-D-DP-3
[548.012069] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[548.014150] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[548.441612] [FACT kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[548.444241] [FACT kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)] new: kernel.kmod_is_loaded.i915: true
[548.446900] [106/133] (604s left) kms_chamelium_audio (hdmi-audio-edid)
[548.724561] Subtest hdmi-audio-edid: SKIP (0.000s)
[548.878526] [107/133] (603s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[548.969582] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[548.971505] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[549.177164] [108/133] (603s left) gem_flink_basic (double-flink)
[549.258856] Starting subtest: double-flink
[549.259962] Subtest double-flink: SUCCESS (0.000s)
[549.375985] [109/133] (603s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[549.566431] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[549.567297] Starting dynamic subtest: pipe-A-valid-mode
[551.409426] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.840s)
[551.410836] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (1.844s)
[551.672338] [110/133] (601s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[551.875477] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[552.999077] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.123s)
[553.219914] [111/133] (599s left) gem_ctx_shared (q-in-order)
[553.316977] Starting subtest: Q-in-order
[553.317946] Starting dynamic subtest: rcs0
[553.580683] Dynamic subtest rcs0: SUCCESS (0.263s)
[553.592928] Starting dynamic subtest: bcs0
[553.763359] Dynamic subtest bcs0: SUCCESS (0.181s)
[553.775962] Starting dynamic subtest: vcs0
[553.954145] Dynamic subtest vcs0: SUCCESS (0.189s)
[553.966709] Starting dynamic subtest: vcs1
[554.146536] Dynamic subtest vcs1: SUCCESS (0.191s)
[554.158634] Starting dynamic subtest: vecs0
[554.337840] Dynamic subtest vecs0: SUCCESS (0.190s)
[554.350216] Starting dynamic subtest: vecs1
[554.529196] Dynamic subtest vecs1: SUCCESS (0.190s)
[554.541424] Starting dynamic subtest: ccs0
[554.717688] Dynamic subtest ccs0: SUCCESS (0.187s)
[554.718587] Subtest Q-in-order: SUCCESS (1.401s)
[555.057111] [112/133] (597s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[555.245288] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[555.247029] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[555.334985] [113/133] (597s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[555.526422] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[555.528220] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[555.620359] [114/133] (597s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[555.817172] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[555.818950] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[555.926773] [115/133] (597s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[556.113274] Starting subtest: cursorB-vs-flipA-legacy
[556.115011] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[556.292750] [116/133] (596s left) kms_psr (fbc-psr-cursor-blt)
[556.477620] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[556.545206] [117/133] (596s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[556.731825] Starting subtest: read-crc-frame-sequence
[556.734119] Starting dynamic subtest: pipe-A-DP-3
[557.406520] Dynamic subtest pipe-A-DP-3: SUCCESS (0.673s)
[557.421801] Starting dynamic subtest: pipe-B-DP-3
[557.964838] Dynamic subtest pipe-B-DP-3: SUCCESS (0.555s)
[557.989432] Starting dynamic subtest: pipe-C-DP-3
[558.570474] Dynamic subtest pipe-C-DP-3: SUCCESS (0.602s)
[558.585434] Starting dynamic subtest: pipe-D-DP-3
[559.138683] Dynamic subtest pipe-D-DP-3: SUCCESS (0.565s)
[559.139652] Subtest read-crc-frame-sequence: SUCCESS (2.407s)
[559.436151] [118/133] (593s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[559.624205] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[559.625951] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[559.770145] [119/133] (593s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[559.973426] Starting subtest: yf-tiled-8bpp-rotate-90
[559.975211] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[560.118623] [120/133] (593s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[560.304413] Starting subtest: cursor-vs-flip-varying-size
[593.852693] Subtest cursor-vs-flip-varying-size: SUCCESS (33.546s)
[594.105774] [121/133] (559s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[594.300165] Starting subtest: x-tiled-32bpp-rotate-180
[596.179953] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.879s)
[596.337334] [122/133] (557s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[597.026539] Starting subtest: syncobj-timeline-multiple-ext-nodes
[597.030359] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[597.316331] [123/133] (556s left) kms_psr (fbc-pr-cursor-blt)
[597.506662] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[597.559977] [124/133] (556s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[600.173216] Starting subtest: verify-pxp-stale-buf-optout-execution
[600.175613] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[600.317538] [125/133] (553s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[600.508415] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[600.509287] Starting dynamic subtest: pipe-A-DP-3
[600.530466] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[600.541787] Starting dynamic subtest: pipe-B-DP-3
[600.563619] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[600.575070] Starting dynamic subtest: pipe-C-DP-3
[600.599978] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[600.611306] Starting dynamic subtest: pipe-D-DP-3
[600.633348] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[600.635048] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.015s)
[600.980729] [126/133] (552s left) perf (gen12-group-concurrent-oa-buffer-read)
[601.371793] Starting subtest: gen12-group-concurrent-oa-buffer-read
[611.405069] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.033s)
[611.457757] [127/133] (542s left) prime_vgem (sync)
[611.560835] Starting subtest: sync
[611.561665] Starting dynamic subtest: rcs0
[611.619151] Dynamic subtest rcs0: SUCCESS (0.058s)
[611.633215] Starting dynamic subtest: bcs0
[611.670684] Dynamic subtest bcs0: SUCCESS (0.050s)
[611.688780] Starting dynamic subtest: vcs0
[611.710742] Dynamic subtest vcs0: SUCCESS (0.039s)
[611.729567] Starting dynamic subtest: vcs1
[611.752461] Dynamic subtest vcs1: SUCCESS (0.040s)
[611.771315] Starting dynamic subtest: vecs0
[611.792437] Dynamic subtest vecs0: SUCCESS (0.038s)
[611.811174] Starting dynamic subtest: vecs1
[611.833537] Dynamic subtest vecs1: SUCCESS (0.040s)
[611.852278] Starting dynamic subtest: ccs0
[611.875267] Dynamic subtest ccs0: SUCCESS (0.040s)
[611.876271] Subtest sync: SUCCESS (0.315s)
[612.052987] [128/133] (541s left) gem_spin_batch (spin-all-new)
[612.144983] Starting subtest: spin-all-new
[612.201569] Subtest spin-all-new: SUCCESS (0.057s)
[612.476767] [129/133] (541s left) i915_hangman (gt-error-state-capture)
[612.571576] Starting subtest: gt-error-state-capture
[612.572436] Starting dynamic subtest: rcs0
[622.109366] Dynamic subtest rcs0: SUCCESS (9.537s)
[622.123510] Starting dynamic subtest: bcs0
[632.039346] Dynamic subtest bcs0: SUCCESS (9.928s)
[632.053213] Starting dynamic subtest: vcs0
[641.077669] Dynamic subtest vcs0: SUCCESS (9.037s)
[641.091527] Starting dynamic subtest: vcs1
[651.064468] Dynamic subtest vcs1: SUCCESS (9.985s)
[651.078430] Starting dynamic subtest: vecs0
[661.051361] Dynamic subtest vecs0: SUCCESS (9.985s)
[661.064939] Starting dynamic subtest: vecs1
[671.103432] Dynamic subtest vecs1: SUCCESS (10.051s)
[671.117364] Starting dynamic subtest: ccs0
[681.104499] Dynamic subtest ccs0: SUCCESS (10.000s)
[681.105496] Subtest gt-error-state-capture: SUCCESS (68.532s)
[681.349552] [130/133] (472s left) kms_prime (d3hot)
[681.541567] Subtest D3hot: SKIP (0.000s)
[681.775245] [131/133] (472s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[681.968133] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[687.046835] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (5.078s)
[687.300493] [132/133] (467s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[687.491440] Starting subtest: cursorB-vs-flipB-atomic
[687.493176] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[687.581983] [133/133] (466s left) gem_exec_schedule (pi-ringfull)
[687.811711] Starting subtest: pi-ringfull
[687.815992] Starting dynamic subtest: rcs0
[687.856455] Dynamic subtest rcs0: SUCCESS (0.043s)
[687.870744] Starting dynamic subtest: bcs0
[687.889276] Dynamic subtest bcs0: SUCCESS (0.032s)
[687.903176] Starting dynamic subtest: vcs0
[687.922088] Dynamic subtest vcs0: SUCCESS (0.032s)
[687.936467] Starting dynamic subtest: vcs1
[687.953414] Dynamic subtest vcs1: SUCCESS (0.030s)
[687.967656] Starting dynamic subtest: vecs0
[687.985962] Dynamic subtest vecs0: SUCCESS (0.031s)
[688.000235] Starting dynamic subtest: vecs1
[688.020419] Dynamic subtest vecs1: SUCCESS (0.033s)
[688.034678] Starting dynamic subtest: ccs0
[688.053769] Dynamic subtest ccs0: SUCCESS (0.032s)
[688.054769] Subtest pi-ringfull: SUCCESS (0.243s)
[688.366317] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_wc
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: api_intel_allocator
results: parsing output: 4/ for test: syncobj_basic
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: kms_atomic_interruptible
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: device_reset
results: parsing output: 15/ for test: syncobj_eventfd
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: kms_vblank
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_reg_read
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: gem_exec_gttfill
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: kms_plane_multiple
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_linear_blits
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_lease
results: parsing output: 31/ for test: sysfs_timeslice_duration
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_prop_blob
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_atomic
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_properties
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: drm_read
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_create
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: fbdev
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gen9_exec_parse
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_sequence
results: parsing output: 57/ for test: perf
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: gem_exec_await
results: parsing output: 61/ for test: gem_eio
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_frames
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: gem_ctx_param
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: i915_pm_rpm
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: core_auth
results: parsing output: 79/ for test: kms_pm_dc
results: parsing output: 80/ for test: kms_async_flips
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_exec_nop
results: parsing output: 83/ for test: kms_invalid_mode
results: parsing output: 84/ for test: kms_dirtyfb
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_mmap_offset
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: i915_query
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_rotation_crc
results: parsing output: 99/ for test: template
results: parsing output: 100/ for test: kms_draw_crc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: prime_self_import
results: parsing output: 103/ for test: gem_lmem_swapping
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_chamelium_audio
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: gem_flink_basic
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_ctx_shared
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: prime_vgem
results: parsing output: 127/ for test: gem_spin_batch
results: parsing output: 128/ for test: i915_hangman
results: parsing output: 129/ for test: kms_prime
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: gem_exec_schedule
Done.