[62.313356] Initializing watchdogs
[62.313418]   /dev/watchdog0
[62.333366] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.343681] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.347300] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.349514] [001/131] (960s left) kms_atomic (atomic-invalid-params)
[62.529370] Starting subtest: atomic-invalid-params
[62.531216] Starting dynamic subtest: pipe-A-DP-3
[63.177422] Dynamic subtest pipe-A-DP-3: SUCCESS (0.646s)
[63.178295] Subtest atomic-invalid-params: SUCCESS (0.647s)
[63.502512] [002/131] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[63.683273] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[63.684957] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[63.869786] [003/131] (959s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[64.045927] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[64.046800] Starting dynamic subtest: pipe-A-DP-3
[64.050052] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[64.057781] Starting dynamic subtest: pipe-B-DP-3
[64.061142] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[64.068786] Starting dynamic subtest: pipe-C-DP-3
[64.072175] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[64.079870] Starting dynamic subtest: pipe-D-DP-3
[64.083184] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[64.084846] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[64.494720] [004/131] (958s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[64.565149] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[64.670990] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[64.798537] [005/131] (958s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[64.983560] Starting subtest: x-tiled-16bpp-rotate-180
[66.789591] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.804s)
[67.162583] [006/131] (956s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[67.502163] Starting subtest: yf-tiled-32bpp-rotate-270
[67.504217] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[67.860572] [007/131] (955s left) kms_feature_discovery (psr1)
[68.076921] Starting subtest: psr1
[68.078589] Subtest psr1: SKIP (0.000s)
[68.247322] [008/131] (955s left) gen9_exec_parse (bb-start-out)
[68.328760] Subtest bb-start-out: SKIP (0.000s)
[68.380741] [009/131] (955s left) sw_sync (sync_merge_same)
[68.422602] Starting subtest: sync_merge_same
[68.423433] Subtest sync_merge_same: SUCCESS (0.000s)
[68.576546] [010/131] (954s left) kms_lease (lease-invalid-plane)
[68.751423] Starting subtest: lease-invalid-plane
[68.752302] Starting dynamic subtest: pipe-A-DP-3
[68.753191] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[68.761292] Starting dynamic subtest: pipe-B-DP-3
[68.762180] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[68.770217] Starting dynamic subtest: pipe-C-DP-3
[68.771442] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[68.779545] Starting dynamic subtest: pipe-D-DP-3
[68.780603] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[68.781609] Subtest lease-invalid-plane: SUCCESS (0.003s)
[68.903681] [011/131] (954s left) gem_pwrite (basic-random)
[68.973914] Subtest basic-random: SKIP (0.000s)
[69.077954] [012/131] (954s left) kms_psr (psr-sprite-mmap-cpu)
[69.255849] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[69.313564] [013/131] (954s left) i915_drm_fdinfo (busy)
[69.375014] Starting subtest: busy
[69.375961] Starting dynamic subtest: rcs0
[69.398174] Dynamic subtest rcs0: SKIP (0.022s)
[69.406617] Starting dynamic subtest: bcs0
[69.408478] Dynamic subtest bcs0: SKIP (0.000s)
[69.416808] Starting dynamic subtest: vcs0
[69.419142] Dynamic subtest vcs0: SKIP (0.000s)
[69.426942] Starting dynamic subtest: vcs1
[69.428901] Dynamic subtest vcs1: SKIP (0.000s)
[69.436939] Starting dynamic subtest: vecs0
[69.439427] Dynamic subtest vecs0: SKIP (0.000s)
[69.447612] Starting dynamic subtest: vecs1
[69.449805] Dynamic subtest vecs1: SKIP (0.000s)
[69.457702] Starting dynamic subtest: ccs0
[69.460053] Dynamic subtest ccs0: SKIP (0.000s)
[69.461955] Subtest busy: SKIP (0.025s)
[69.518658] [014/131] (954s left) gem_exec_whisper (basic-forked-all)
[69.604363] Starting subtest: basic-forked-all
[72.450773] Subtest basic-forked-all: SUCCESS (2.844s)
[72.733495] [015/131] (951s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[72.924049] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[72.925856] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[73.117808] [016/131] (950s left) kms_frontbuffer_tracking (psr-1p-rte)
[73.296866] Starting subtest: psr-1p-rte
[73.298426] Subtest psr-1p-rte: SKIP (0.000s)
[73.488467] [017/131] (950s left) kms_cursor_crc (cursor-random-max-size)
[73.989194] Starting subtest: cursor-random-max-size
[73.992803] Subtest cursor-random-max-size: SKIP (0.000s)
[74.254742] [018/131] (949s left) kms_getfb (getfb-handle-protection)
[74.440815] Starting subtest: getfb-handle-protection
[74.465499] Subtest getfb-handle-protection: SUCCESS (0.025s)
[74.669290] [019/131] (949s left) syncobj_timeline (wait-for-submit-delayed-submit)
[74.740065] Starting subtest: wait-for-submit-delayed-submit
[74.845110] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[75.020501] [020/131] (949s left) kms_vblank (query-forked-busy-hang)
[75.198913] Starting subtest: query-forked-busy-hang
[75.200888] Starting dynamic subtest: pipe-A-DP-3
[101.560394] Dynamic subtest pipe-A-DP-3: SUCCESS (26.354s)
[101.571015] Starting dynamic subtest: pipe-D-DP-3
[126.568283] Dynamic subtest pipe-D-DP-3: SUCCESS (25.003s)
[126.569216] Subtest query-forked-busy-hang: SUCCESS (51.362s)
[126.784948] [021/131] (897s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[126.963237] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[126.964934] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[127.153101] [022/131] (897s left) gem_ctx_shared (q-promotion)
[127.232997] Starting subtest: Q-promotion
[127.233963] Starting dynamic subtest: rcs0
[127.546016] Dynamic subtest rcs0: SUCCESS (0.313s)
[127.555658] Starting dynamic subtest: bcs0
[127.729725] Dynamic subtest bcs0: SUCCESS (0.184s)
[127.739077] Starting dynamic subtest: vcs0
[127.919112] Dynamic subtest vcs0: SUCCESS (0.189s)
[127.928489] Starting dynamic subtest: vcs1
[128.112668] Dynamic subtest vcs1: SUCCESS (0.193s)
[128.121880] Starting dynamic subtest: vecs0
[128.302427] Dynamic subtest vecs0: SUCCESS (0.189s)
[128.311674] Starting dynamic subtest: vecs1
[128.495088] Dynamic subtest vecs1: SUCCESS (0.192s)
[128.504435] Starting dynamic subtest: ccs0
[128.690445] Dynamic subtest ccs0: SUCCESS (0.195s)
[128.691360] Subtest Q-promotion: SUCCESS (1.457s)
[129.083579] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[129.085209] [023/131] (895s left) kms_flip (plain-flip-ts-check)
[129.269294] Starting subtest: plain-flip-ts-check
[129.273181] Starting dynamic subtest: A-DP3
[137.384515] Dynamic subtest A-DP3: SUCCESS (8.110s)
[137.396502] Starting dynamic subtest: B-DP3
[145.437906] Dynamic subtest B-DP3: SUCCESS (8.051s)
[145.449722] Starting dynamic subtest: C-DP3
[153.504145] Dynamic subtest C-DP3: SUCCESS (8.065s)
[153.513518] Starting dynamic subtest: D-DP3
[161.552348] Dynamic subtest D-DP3: SUCCESS (8.048s)
[161.554229] Subtest plain-flip-ts-check: SUCCESS (32.285s)
[161.860781] [024/131] (862s left) gem_ctx_persistence (engines-cleanup)
[161.943643] Starting subtest: engines-cleanup
[161.944527] Starting dynamic subtest: rcs0
[162.034343] Dynamic subtest rcs0: SUCCESS (0.090s)
[162.045240] Starting dynamic subtest: bcs0
[162.051254] Dynamic subtest bcs0: SUCCESS (0.017s)
[162.062789] Starting dynamic subtest: vcs0
[162.091536] Dynamic subtest vcs0: SUCCESS (0.040s)
[162.109488] Starting dynamic subtest: vcs1
[162.160256] Dynamic subtest vcs1: SUCCESS (0.067s)
[162.197150] Starting dynamic subtest: vecs0
[162.216572] Dynamic subtest vecs0: SUCCESS (0.056s)
[162.234420] Starting dynamic subtest: vecs1
[162.263517] Dynamic subtest vecs1: SUCCESS (0.046s)
[162.284136] Starting dynamic subtest: ccs0
[162.315090] Dynamic subtest ccs0: SUCCESS (0.051s)
[162.316667] Subtest engines-cleanup: SUCCESS (0.371s)
[162.528946] [025/131] (862s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[162.715515] Starting subtest: psr-shrfb-scaledprimary
[162.717261] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[162.886224] [026/131] (861s left) syncobj_timeline (signal)
[162.965979] Starting subtest: signal
[162.966972] Subtest signal: SUCCESS (0.000s)
[163.144890] [027/131] (861s left) kms_plane_scaling (invalid-num-scalers)
[163.328767] Starting subtest: invalid-num-scalers
[163.335532] Starting dynamic subtest: pipe-A-DP-3-invalid-num-scalers
[163.354849] Dynamic subtest pipe-A-DP-3-invalid-num-scalers: SUCCESS (0.019s)
[163.368959] Starting dynamic subtest: pipe-B-DP-3-invalid-num-scalers
[163.393594] Dynamic subtest pipe-B-DP-3-invalid-num-scalers: SUCCESS (0.032s)
[163.407901] Starting dynamic subtest: pipe-C-DP-3-invalid-num-scalers
[163.432737] Dynamic subtest pipe-C-DP-3-invalid-num-scalers: SUCCESS (0.032s)
[163.447174] Starting dynamic subtest: pipe-D-DP-3-invalid-num-scalers
[163.471982] Dynamic subtest pipe-D-DP-3-invalid-num-scalers: SUCCESS (0.032s)
[163.472711] Subtest invalid-num-scalers: SUCCESS (0.143s)
[163.618478] [028/131] (861s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[163.696154] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[163.798336] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[163.976118] [029/131] (860s left) gen3_render_linear_blits
[164.130738] [030/131] (860s left) gem_exec_schedule (in-order)
[164.227975] Starting subtest: in-order
[164.228914] Starting dynamic subtest: rcs0
[164.510152] Dynamic subtest rcs0: SUCCESS (0.283s)
[164.519222] Starting dynamic subtest: bcs0
[164.712781] Dynamic subtest bcs0: SUCCESS (0.202s)
[164.721773] Starting dynamic subtest: vcs0
[164.923147] Dynamic subtest vcs0: SUCCESS (0.210s)
[164.932073] Starting dynamic subtest: vcs1
[165.135589] Dynamic subtest vcs1: SUCCESS (0.212s)
[165.144560] Starting dynamic subtest: vecs0
[165.346384] Dynamic subtest vecs0: SUCCESS (0.210s)
[165.355378] Starting dynamic subtest: vecs1
[165.558692] Dynamic subtest vecs1: SUCCESS (0.212s)
[165.567586] Starting dynamic subtest: ccs0
[165.772846] Dynamic subtest ccs0: SUCCESS (0.214s)
[165.773991] Subtest in-order: SUCCESS (1.546s)
[166.160931] [031/131] (858s left) kms_big_fb (linear-16bpp-rotate-180)
[166.353555] Starting subtest: linear-16bpp-rotate-180
[168.249183] Subtest linear-16bpp-rotate-180: SUCCESS (1.895s)
[168.435548] [032/131] (856s left) i915_suspend (basic-s3-without-i915)
[168.480303] Starting subtest: basic-s3-without-i915
[189.922472] Subtest basic-s3-without-i915: SUCCESS (5.741s)
[190.055259] [033/131] (835s left) gem_tiled_pread_pwrite
[190.201790] [034/131] (834s left) gem_exec_params (cliprects-invalid)
[190.290101] Starting subtest: cliprects-invalid
[190.291006] Subtest cliprects-invalid: SUCCESS (0.000s)
[190.465323] [035/131] (834s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[190.556150] Starting subtest: single-wait-for-submit-unsubmitted
[190.658982] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[190.841546] [036/131] (834s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[191.041100] Starting subtest: y-tiled-16bpp-rotate-90
[191.042819] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[191.226749] [037/131] (834s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[191.416810] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[191.418465] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[191.610935] [038/131] (833s left) gem_spin_batch (legacy-resubmit)
[191.703041] Starting subtest: legacy-resubmit
[191.704901] Starting dynamic subtest: default
[191.742711] Dynamic subtest default: SUCCESS (0.038s)
[191.754699] Starting dynamic subtest: render
[191.755650] Dynamic subtest render: SUCCESS (0.003s)
[191.765801] Starting dynamic subtest: bsd
[191.766883] Dynamic subtest bsd: SUCCESS (0.002s)
[191.776968] Starting dynamic subtest: bsd1
[191.778094] Dynamic subtest bsd1: SUCCESS (0.002s)
[191.787698] Starting dynamic subtest: bsd2
[191.788578] Dynamic subtest bsd2: SUCCESS (0.001s)
[191.798473] Starting dynamic subtest: blt
[191.799598] Dynamic subtest blt: SUCCESS (0.002s)
[191.809266] Starting dynamic subtest: vebox
[191.810267] Dynamic subtest vebox: SUCCESS (0.003s)
[191.811401] Subtest legacy-resubmit: SUCCESS (0.056s)
[192.059877] [039/131] (833s left) perf_pmu (busy-start)
[192.131967] Starting subtest: busy-start
[192.132893] Starting dynamic subtest: rcs0
[194.711085] Dynamic subtest rcs0: SUCCESS (2.578s)
[194.725996] Starting dynamic subtest: bcs0
[197.259061] Dynamic subtest bcs0: SUCCESS (2.546s)
[197.274034] Starting dynamic subtest: vcs0
[199.807085] Dynamic subtest vcs0: SUCCESS (2.546s)
[199.822171] Starting dynamic subtest: vcs1
[202.354785] Dynamic subtest vcs1: SUCCESS (2.546s)
[202.370332] Starting dynamic subtest: vecs0
[204.903454] Dynamic subtest vecs0: SUCCESS (2.547s)
[204.918695] Starting dynamic subtest: vecs1
[207.451832] Dynamic subtest vecs1: SUCCESS (2.547s)
[207.495148] Starting dynamic subtest: ccs0
[210.000900] Dynamic subtest ccs0: SUCCESS (2.548s)
[210.002623] Subtest busy-start: SUCCESS (17.869s)
[210.162181] [040/131] (815s left) perf (invalid-oa-metric-set-id)
[210.562554] Starting subtest: invalid-oa-metric-set-id
[210.581273] Subtest invalid-oa-metric-set-id: SUCCESS (0.019s)
[210.667492] [041/131] (814s left) gem_exec_schedule (thriceslice)
[210.757320] Starting subtest: thriceslice
[210.758222] Starting dynamic subtest: rcs0
[210.809899] Dynamic subtest rcs0: SUCCESS (0.052s)
[210.823097] Starting dynamic subtest: bcs0
[210.865179] Dynamic subtest bcs0: SUCCESS (0.055s)
[210.885788] Starting dynamic subtest: vcs0
[210.901786] Dynamic subtest vcs0: SUCCESS (0.036s)
[210.922071] Starting dynamic subtest: vcs1
[210.961637] Dynamic subtest vcs1: SUCCESS (0.059s)
[210.977702] Starting dynamic subtest: vecs0
[210.997538] Dynamic subtest vecs0: SUCCESS (0.035s)
[211.009094] Starting dynamic subtest: vecs1
[211.050761] Dynamic subtest vecs1: SUCCESS (0.053s)
[211.074035] Starting dynamic subtest: ccs0
[211.113632] Dynamic subtest ccs0: SUCCESS (0.061s)
[211.115393] Subtest thriceslice: SUCCESS (0.356s)
[211.493506] [042/131] (814s left) gem_lmem_swapping (heavy-verify-random)
[214.127762] Starting subtest: heavy-verify-random
[214.128675] Starting dynamic subtest: lmem0
[230.006426] Dynamic subtest lmem0: SUCCESS (15.879s)
[230.007377] Subtest heavy-verify-random: SUCCESS (15.879s)
[231.841967] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[231.842911] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[231.844484] [043/131] (793s left) syncobj_wait (wait-all-snapshot)
[233.372959] Starting subtest: wait-all-snapshot
[233.455002] Subtest wait-all-snapshot: SUCCESS (0.082s)
[233.514579] [FACT syncobj_wait (wait-all-snapshot)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[233.516910] [FACT syncobj_wait (wait-all-snapshot)] new: kernel.kmod_is_loaded.i915: true
[233.519153] [044/131] (792s left) syncobj_timeline (wait-zero-handles)
[233.595109] Starting subtest: wait-zero-handles
[233.595960] Subtest wait-zero-handles: SUCCESS (0.000s)
[233.790480] [045/131] (792s left) kms_vblank (query-idle-hang)
[233.983688] Starting subtest: query-idle-hang
[233.984575] Starting dynamic subtest: pipe-A-DP-3
[260.235822] Dynamic subtest pipe-A-DP-3: SUCCESS (26.251s)
[260.249901] Starting dynamic subtest: pipe-D-DP-3
[285.242915] Dynamic subtest pipe-D-DP-3: SUCCESS (25.002s)
[285.243811] Subtest query-idle-hang: SUCCESS (51.259s)
[285.503765] [046/131] (740s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[285.700261] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[285.703066] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[285.852881] [047/131] (740s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[286.044958] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[288.790361] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.745s)
[289.037475] [048/131] (737s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[289.300128] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[289.447909] [049/131] (736s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[289.643694] Starting subtest: 4-tiled-64bpp-rotate-180
[291.461247] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.817s)
[291.673450] [050/131] (734s left) kms_fence_pin_leak
[291.953399] [051/131] (734s left) gem_tiling_max_stride
[292.102965] [052/131] (734s left) kms_invalid_mode (int-max-clock)
[292.297013] Starting subtest: int-max-clock
[292.297911] Starting dynamic subtest: pipe-A-DP-3
[292.366236] Dynamic subtest pipe-A-DP-3: SUCCESS (0.068s)
[292.377667] Starting dynamic subtest: pipe-B-DP-3
[292.378891] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[292.390043] Starting dynamic subtest: pipe-C-DP-3
[292.391100] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[292.402121] Starting dynamic subtest: pipe-D-DP-3
[292.403022] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[292.403935] Subtest int-max-clock: SUCCESS (0.075s)
[292.647472] [053/131] (733s left) i915_drm_fdinfo (virtual-idle)
[292.717587] Starting subtest: virtual-idle
[296.327704] Subtest virtual-idle: SUCCESS (3.608s)
[296.478275] [054/131] (729s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[296.551695] Starting subtest: multi-wait-all-for-submit-signaled
[296.552668] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[296.763888] [055/131] (729s left) gem_mmap_gtt (basic-small-copy)
[296.839541] Subtest basic-small-copy: SKIP (0.000s)
[296.906173] [056/131] (729s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[297.120469] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[297.136043] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s)
[297.302121] [057/131] (729s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[297.491225] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[297.539120] [058/131] (729s left) kms_psr (psr2-sprite-plane-onoff)
[297.728410] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[297.791034] [059/131] (728s left) kms_flip (2x-wf_vblank-ts-check)
[297.975972] Starting subtest: 2x-wf_vblank-ts-check
[297.991233] Subtest 2x-wf_vblank-ts-check: SKIP (0.015s)
[298.176381] [060/131] (728s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[298.370781] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[298.422953] [061/131] (728s left) kms_chamelium_color (ctm-max)
[298.606933] Subtest ctm-max: SKIP (0.000s)
[298.673650] [062/131] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[298.861045] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[298.862742] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[299.047499] [063/131] (727s left) kms_content_protection (legacy)
[299.305844] Starting subtest: legacy
[299.582361] Starting dynamic subtest: pipe-A-DP-3
[421.101543] Dynamic subtest pipe-A-DP-3: FAIL (121.250s)
[421.102649] Subtest legacy: FAIL (121.621s)
[421.266219] [064/131] (605s left) kms_psr (fbc-psr2-primary-render)
[421.447967] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[421.507712] [065/131] (605s left) kms_properties (colorop-properties-atomic)
[421.691745] Starting subtest: colorop-properties-atomic
[421.692681] Starting dynamic subtest: pipe-A-DP-3
[421.840085] Dynamic subtest pipe-A-DP-3: SUCCESS (0.148s)
[421.863567] Starting dynamic subtest: pipe-B-DP-3
[422.022292] Dynamic subtest pipe-B-DP-3: SUCCESS (0.180s)
[422.039026] Starting dynamic subtest: pipe-C-DP-3
[422.210686] Dynamic subtest pipe-C-DP-3: SUCCESS (0.186s)
[422.222919] Starting dynamic subtest: pipe-D-DP-3
[422.392627] Dynamic subtest pipe-D-DP-3: SUCCESS (0.182s)
[422.393508] Subtest colorop-properties-atomic: SUCCESS (0.702s)
[422.714737] [066/131] (604s left) gem_ringfill (engines-basic)
[423.149049] Starting subtest: engines-basic
[423.150741] Starting dynamic subtest: rcs0
[423.264844] Dynamic subtest rcs0: SUCCESS (0.118s)
[423.285291] Starting dynamic subtest: bcs0
[423.307847] Dynamic subtest bcs0: SUCCESS (0.042s)
[423.339787] Starting dynamic subtest: vcs0
[423.354507] Dynamic subtest vcs0: SUCCESS (0.045s)
[423.382208] Starting dynamic subtest: vcs1
[423.401088] Dynamic subtest vcs1: SUCCESS (0.045s)
[423.416922] Starting dynamic subtest: vecs0
[423.442041] Dynamic subtest vecs0: SUCCESS (0.040s)
[423.457770] Starting dynamic subtest: vecs1
[423.482910] Dynamic subtest vecs1: SUCCESS (0.040s)
[423.502034] Starting dynamic subtest: ccs0
[423.525198] Dynamic subtest ccs0: SUCCESS (0.041s)
[423.526309] Subtest engines-basic: SUCCESS (0.380s)
[423.710971] [067/131] (603s left) gem_watchdog (default-virtual)
[423.801810] Starting subtest: default-virtual
[430.884288] Subtest default-virtual: SUCCESS (7.082s)
[431.022688] [068/131] (596s left) kms_dp_aux_dev
[431.707280] [069/131] (595s left) kms_chamelium_edid (hdmi-edid-read)
[431.973710] Subtest hdmi-edid-read: SKIP (0.000s)
[432.110569] [070/131] (595s left) kms_fbcon_fbt (psr)
[432.190768] Starting subtest: psr
[432.192526] Subtest psr: SKIP (0.000s)
[432.412355] [071/131] (595s left) syncobj_timeline (invalid-transfer-illegal-handle)
[432.486653] Starting subtest: invalid-transfer-illegal-handle
[432.487556] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[432.681806] [072/131] (594s left) gem_exec_reloc (basic-write-cpu-noreloc)
[432.766956] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[432.843835] [073/131] (594s left) gem_workarounds (suspend-resume)
[432.940322] Starting subtest: suspend-resume
[451.628888] Subtest suspend-resume: SUCCESS (3.801s)
[451.804428] [074/131] (575s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[451.996334] Starting subtest: fbcpsr-tiling-4
[451.997923] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[452.202463] [075/131] (575s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[452.386398] Starting subtest: 2x-flip-vs-cursor-legacy
[452.389476] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.002s)
[452.551356] [076/131] (575s left) gem_ctx_persistence (idempotent)
[452.637703] Starting subtest: idempotent
[452.638664] Subtest idempotent: SUCCESS (0.000s)
[452.834497] [077/131] (575s left) kms_psr (psr2-cursor-blt)
[453.021412] Subtest psr2-cursor-blt: SKIP (0.000s)
[453.079267] [078/131] (574s left) kms_cursor_crc (cursor-offscreen-max-size)
[453.594626] Starting subtest: cursor-offscreen-max-size
[453.597539] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[453.850854] [079/131] (574s left) kms_force_connector_basic (prune-stale-modes)
[453.955290] Starting subtest: prune-stale-modes
[453.978117] Subtest prune-stale-modes: SUCCESS (0.023s)
[454.333023] [080/131] (573s left) kms_cursor_crc (cursor-suspend)
[454.590696] Starting subtest: cursor-suspend
[454.591633] Starting dynamic subtest: pipe-A-DP-3
[493.951812] Dynamic subtest pipe-A-DP-3: SUCCESS (7.719s)
[493.977725] Starting dynamic subtest: pipe-D-DP-3
[533.080748] Dynamic subtest pipe-D-DP-3: SUCCESS (7.688s)
[533.081682] Subtest cursor-suspend: SUCCESS (15.412s)
[533.878406] [081/131] (494s left) kms_plane_cursor (primary)
[534.068902] Starting subtest: primary
[534.070671] Starting dynamic subtest: pipe-A-DP-3-size-64
[537.256902] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.188s)
[537.320751] Starting dynamic subtest: pipe-A-DP-3-size-128
[540.424026] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.116s)
[540.486003] Starting dynamic subtest: pipe-A-DP-3-size-256
[543.605862] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.133s)
[543.763118] Starting dynamic subtest: pipe-B-DP-3-size-64
[546.896859] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.156s)
[546.942004] Starting dynamic subtest: pipe-B-DP-3-size-128
[550.046760] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.117s)
[550.091541] Starting dynamic subtest: pipe-B-DP-3-size-256
[553.246625] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.167s)
[553.352674] Starting dynamic subtest: pipe-C-DP-3-size-64
[556.536082] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.197s)
[556.580542] Starting dynamic subtest: pipe-C-DP-3-size-128
[559.652905] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.084s)
[559.702167] Starting dynamic subtest: pipe-C-DP-3-size-256
[562.819451] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.131s)
[562.935577] Starting dynamic subtest: pipe-D-DP-3-size-64
[566.054226] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.138s)
[566.099071] Starting dynamic subtest: pipe-D-DP-3-size-128
[569.219500] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.133s)
[569.271097] Starting dynamic subtest: pipe-D-DP-3-size-256
[572.369496] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.115s)
[572.460963] Subtest primary: SUCCESS (38.397s)
[572.796665] [082/131] (455s left) gem_exec_balancer (fairslice)
[572.882483] Starting subtest: fairslice
[578.426568] Subtest fairslice: SUCCESS (5.544s)
[578.869936] [083/131] (449s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[579.055991] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[579.056890] Starting dynamic subtest: pipe-A-DP-3
[579.065089] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[579.077824] Starting dynamic subtest: pipe-B-DP-3
[579.086101] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[579.098577] Starting dynamic subtest: pipe-C-DP-3
[579.106679] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[579.119194] Starting dynamic subtest: pipe-D-DP-3
[579.129537] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[579.131690] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[579.533476] [084/131] (449s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[579.718099] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[579.718982] Starting dynamic subtest: pipe-A-valid-mode
[579.789963] Dynamic subtest pipe-A-valid-mode: SKIP (0.071s)
[579.791773] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.073s)
[580.040325] [085/131] (448s left) syncobj_eventfd (invalid-bad-pad)
[580.121105] Starting subtest: invalid-bad-pad
[580.122059] Subtest invalid-bad-pad: SUCCESS (0.000s)
[580.322797] [086/131] (448s left) kms_psr (fbc-psr-sprite-blt)
[580.509330] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[580.568767] [087/131] (448s left) gem_exec_reloc (basic-concurrent16)
[580.656344] Subtest basic-concurrent16: SKIP (0.000s)
[580.759123] [088/131] (448s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[580.947850] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[580.949545] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[581.159736] [089/131] (447s left) syncobj_wait (wait-all-interrupted)
[581.236105] Starting subtest: wait-all-interrupted
[581.339049] Subtest wait-all-interrupted: SUCCESS (0.102s)
[581.515538] [090/131] (447s left) kms_flip (flip-vs-expired-vblank)
[581.702869] Starting subtest: flip-vs-expired-vblank
[581.706273] Starting dynamic subtest: A-DP3
[589.556649] Dynamic subtest A-DP3: SUCCESS (7.850s)
[589.573868] Starting dynamic subtest: B-DP3
[597.325935] Dynamic subtest B-DP3: SUCCESS (7.768s)
[597.341021] Starting dynamic subtest: C-DP3
[605.102034] Dynamic subtest C-DP3: SUCCESS (7.775s)
[605.117285] Starting dynamic subtest: D-DP3
[612.891499] Dynamic subtest D-DP3: SUCCESS (7.788s)
[612.893854] Subtest flip-vs-expired-vblank: SUCCESS (31.193s)
[613.243444] [091/131] (415s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[613.432993] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[613.433895] Starting dynamic subtest: pipe-A-DP-3
[613.454780] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[613.467613] Starting dynamic subtest: pipe-B-DP-3
[613.497149] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[613.510058] Starting dynamic subtest: pipe-C-DP-3
[613.535342] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[613.549566] Starting dynamic subtest: pipe-D-DP-3
[613.573581] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[613.575607] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.015s)
[613.919089] [092/131] (415s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[614.106122] Starting subtest: cursorB-vs-flipA-toggle
[614.107872] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[614.291665] [093/131] (415s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[614.928631] Starting subtest: syncobj-stationary-timeline-chain-engines
[615.091023] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.159s)
[615.470027] [094/131] (413s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[615.547914] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[615.648962] [095/131] (413s left) gem_softpin (evict-active-interruptible)
[615.737694] Starting subtest: evict-active-interruptible
[615.754865] Subtest evict-active-interruptible: SUCCESS (0.017s)
[615.952371] [096/131] (413s left) gem_render_copy (yf-tiled-ccs-to-linear)
[616.038274] Starting subtest: yf-tiled-ccs-to-linear
[616.040334] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[616.331819] [097/131] (413s left) device_reset (unbind-reset-rebind)
[616.413147] Starting subtest: unbind-reset-rebind
[618.912872] Subtest unbind-reset-rebind: SUCCESS (2.498s)
[618.969253] [098/131] (410s left) kms_pm_dc (dc5-dpms)
[620.164111] Starting subtest: dc5-dpms
[623.499755] Subtest dc5-dpms: FAIL (3.319s)
[623.694231] [099/131] (406s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[623.880680] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[623.883073] Starting dynamic subtest: pipe-A-DP-3
[623.891233] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[623.904263] Starting dynamic subtest: pipe-B-DP-3
[623.912722] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[623.925631] Starting dynamic subtest: pipe-C-DP-3
[623.933635] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[623.946784] Starting dynamic subtest: pipe-D-DP-3
[623.957499] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[623.959620] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[624.372443] [100/131] (405s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[624.566298] Starting subtest: yf-tiled-64bpp-rotate-90
[624.568127] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[624.781735] [101/131] (405s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[624.970886] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[624.972658] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[625.172948] [102/131] (404s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[625.364768] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[625.366482] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[625.573178] [103/131] (404s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[625.758178] Starting subtest: fbc-indfb-scaledprimary
[627.437494] Subtest fbc-indfb-scaledprimary: SUCCESS (1.679s)
[627.687976] [104/131] (402s left) vgem_basic (create)
[627.753757] Starting subtest: create
[627.754664] Subtest create: SUCCESS (0.000s)
[627.872671] [105/131] (402s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[628.060270] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[628.061932] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[628.272295] [106/131] (402s left) gem_exec_fence (basic-await)
[628.509480] Starting subtest: basic-await
[628.510809] Starting dynamic subtest: rcs0
[628.633298] Dynamic subtest rcs0: SUCCESS (0.125s)
[628.648961] Starting dynamic subtest: bcs0
[628.719830] Dynamic subtest bcs0: SUCCESS (0.085s)
[628.748658] Starting dynamic subtest: vcs0
[628.815485] Dynamic subtest vcs0: SUCCESS (0.094s)
[628.832369] Starting dynamic subtest: vcs1
[628.904178] Dynamic subtest vcs1: SUCCESS (0.087s)
[628.936571] Starting dynamic subtest: vecs0
[629.010451] Dynamic subtest vecs0: SUCCESS (0.104s)
[629.028016] Starting dynamic subtest: vecs1
[629.099780] Dynamic subtest vecs1: SUCCESS (0.088s)
[629.118025] Starting dynamic subtest: ccs0
[629.190309] Dynamic subtest ccs0: SUCCESS (0.089s)
[629.191238] Subtest basic-await: SUCCESS (0.685s)
[629.940781] [107/131] (400s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[630.128696] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[632.854050] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.726s)
[633.056957] [108/131] (397s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[633.241137] Starting subtest: bad-aux-stride-yf-tiled-ccs
[633.242005] Starting dynamic subtest: pipe-A-DP-3
[633.250241] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[633.263879] Starting dynamic subtest: pipe-B-DP-3
[633.272081] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[633.285355] Starting dynamic subtest: pipe-C-DP-3
[633.293410] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[633.306624] Starting dynamic subtest: pipe-D-DP-3
[633.317230] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[633.319093] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.007s)
[633.733243] [109/131] (396s left) gem_userptr_blits (create-destroy-unsync)
[633.822185] Subtest create-destroy-unsync: SKIP (0.000s)
[634.007388] [110/131] (396s left) kms_pm_rpm (universal-planes)
[635.708376] Starting subtest: universal-planes
[635.710219] Starting dynamic subtest: plane-33
[638.553477] Dynamic subtest plane-33: SUCCESS (2.846s)
[638.571693] Starting dynamic subtest: plane-63
[641.657278] Dynamic subtest plane-63: SUCCESS (3.099s)
[641.708768] Starting dynamic subtest: plane-93
[644.444413] Dynamic subtest plane-93: SUCCESS (2.782s)
[644.493463] Starting dynamic subtest: plane-123
[647.125016] Dynamic subtest plane-123: SUCCESS (2.676s)
[647.175865] Starting dynamic subtest: plane-133
[649.918378] Dynamic subtest plane-133: SUCCESS (2.788s)
[649.969390] Starting dynamic subtest: plane-143
[652.614824] Dynamic subtest plane-143: SUCCESS (2.691s)
[652.620457] Subtest universal-planes: SUCCESS (16.913s)
[653.063229] [111/131] (377s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[653.255142] Starting subtest: 2x-flip-vs-cursor-atomic
[653.258113] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[653.420206] [112/131] (377s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[653.608859] Starting subtest: psr-rgb565-draw-blt
[653.610572] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[653.816874] [113/131] (377s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[654.004766] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[654.006443] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[654.215904] [114/131] (376s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[654.402104] Starting subtest: plane-upscale-20x20-with-rotation
[654.402878] Starting dynamic subtest: pipe-A
[654.796416] Dynamic subtest pipe-A: SUCCESS (0.394s)
[654.831734] Starting dynamic subtest: pipe-B
[655.274230] Dynamic subtest pipe-B: SUCCESS (0.475s)
[655.290685] Starting dynamic subtest: pipe-C
[655.736105] Dynamic subtest pipe-C: SUCCESS (0.460s)
[655.757856] Starting dynamic subtest: pipe-D
[656.198241] Dynamic subtest pipe-D: SUCCESS (0.461s)
[656.199294] Subtest plane-upscale-20x20-with-rotation: SUCCESS (1.798s)
[656.562183] [115/131] (374s left) gem_busy (busy)
[656.652068] Starting subtest: busy
[656.652950] Starting dynamic subtest: all-engines
[656.749230] Dynamic subtest all-engines: SUCCESS (0.098s)
[656.765583] Starting dynamic subtest: rcs0
[656.882496] Dynamic subtest rcs0: SUCCESS (0.132s)
[656.898124] Starting dynamic subtest: bcs0
[656.938533] Dynamic subtest bcs0: SUCCESS (0.054s)
[656.965585] Starting dynamic subtest: vcs0
[656.978756] Dynamic subtest vcs0: SUCCESS (0.039s)
[657.004859] Starting dynamic subtest: vcs1
[657.019150] Dynamic subtest vcs1: SUCCESS (0.038s)
[657.035772] Starting dynamic subtest: vecs0
[657.058082] Dynamic subtest vecs0: SUCCESS (0.038s)
[657.072276] Starting dynamic subtest: vecs1
[657.097139] Dynamic subtest vecs1: SUCCESS (0.038s)
[657.111909] Starting dynamic subtest: ccs0
[657.136174] Dynamic subtest ccs0: SUCCESS (0.038s)
[657.137200] Subtest busy: SUCCESS (0.486s)
[657.550028] [116/131] (373s left) kms_legacy_colorkey (invalid-plane)
[657.732334] Starting subtest: invalid-plane
[657.733174] Starting dynamic subtest: zero-id
[657.734065] Dynamic subtest zero-id: SUCCESS (0.000s)
[657.748098] Starting dynamic subtest: outrange-id
[657.749357] Dynamic subtest outrange-id: SUCCESS (0.000s)
[657.750341] Subtest invalid-plane: SUCCESS (0.002s)
[657.919969] [117/131] (373s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[658.000785] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[658.094908] [118/131] (373s left) api_intel_bb (object-noreloc-keep-cache-simple)
[658.170186] Starting subtest: object-noreloc-keep-cache-simple
[658.199224] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.029s)
[658.410148] [119/131] (372s left) gem_close_race (multigpu-basic-process)
[658.529150] Starting subtest: multigpu-basic-process
[658.531302] Subtest multigpu-basic-process: SKIP (0.000s)
[658.892214] [120/131] (372s left) kms_flip (nonblocking-read)
[659.076047] Starting subtest: nonblocking-read
[659.076921] Subtest nonblocking-read: SUCCESS (0.000s)
[659.280061] [121/131] (372s left) intel_hwmon (hwmon-write)
[659.361284] Starting subtest: hwmon-write
[659.378011] Subtest hwmon-write: SUCCESS (0.017s)
[659.525634] [122/131] (372s left) gem_lmem_swapping (random)
[662.109817] Starting subtest: random
[662.110689] Starting dynamic subtest: lmem0
[663.061369] Dynamic subtest lmem0: SUCCESS (0.952s)
[663.062239] Subtest random: SUCCESS (0.953s)
[666.169851] [FACT gem_lmem_swapping (random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[666.170789] [FACT gem_lmem_swapping (random)] deleted: kernel.kmod_is_loaded.i915: true
[666.172443] [123/131] (365s left) kms_feature_discovery (display-2x)
[667.814722] Starting subtest: display-2x
[667.816463] Subtest display-2x: SKIP (0.000s)
[667.863457] [FACT kms_feature_discovery (display-2x)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[667.865783] [FACT kms_feature_discovery (display-2x)] new: kernel.kmod_is_loaded.i915: true
[667.869182] [124/131] (363s left) gem_mmap_gtt (basic-small-copy-xy)
[667.950927] Subtest basic-small-copy-XY: SKIP (0.000s)
[668.045147] [125/131] (363s left) perf (gen12-mi-rpc)
[668.454272] Starting subtest: gen12-mi-rpc
[668.455144] Starting dynamic subtest: rcs0
[668.520201] Dynamic subtest rcs0: SUCCESS (0.065s)
[668.521111] Subtest gen12-mi-rpc: SUCCESS (0.067s)
[668.587286] [126/131] (363s left) i915_pm_rc6_residency (rc6-fence)
[668.689851] Starting subtest: rc6-fence
[668.713250] Starting dynamic subtest: gt0
[693.234827] Dynamic subtest gt0: SUCCESS (24.520s)
[693.239584] Subtest rc6-fence: SUCCESS (24.546s)
[693.421927] [127/131] (338s left) kms_addfb_basic (basic)
[693.496292] Starting subtest: basic
[693.497170] Subtest basic: SUCCESS (0.000s)
[693.781819] [128/131] (338s left) gem_mmap_offset (clear)
[693.859205] Starting subtest: clear
[693.861736] Starting dynamic subtest: lmem0
[717.295467] Dynamic subtest lmem0: SUCCESS (23.434s)
[717.310732] Starting dynamic subtest: smem0
[742.167524] Dynamic subtest smem0: SUCCESS (24.872s)
[742.168863] Subtest clear: SUCCESS (48.309s)
[742.501040] [129/131] (289s left) gem_ctx_param (basic-default)
[742.653523] Starting subtest: basic-default
[742.654348] Subtest basic-default: SUCCESS (0.000s)
[742.772527] [130/131] (289s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[742.985231] Starting subtest: cursor-vs-flip-varying-size
[775.767700] Subtest cursor-vs-flip-varying-size: SUCCESS (32.782s)
[776.070223] [131/131] (256s left) api_intel_bb (blit-noreloc-purge-cache)
[776.145249] Starting subtest: blit-noreloc-purge-cache
[776.182369] Subtest blit-noreloc-purge-cache: SUCCESS (0.037s)
[776.419342] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_lease
results: parsing output: 10/ for test: gem_pwrite
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: i915_drm_fdinfo
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: gem_ctx_persistence
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gen3_render_linear_blits
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: i915_suspend
results: parsing output: 32/ for test: gem_tiled_pread_pwrite
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_spin_batch
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_fence_pin_leak
results: parsing output: 50/ for test: gem_tiling_max_stride
results: parsing output: 51/ for test: kms_invalid_mode
results: parsing output: 52/ for test: i915_drm_fdinfo
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_properties
results: parsing output: 65/ for test: gem_ringfill
results: parsing output: 66/ for test: gem_watchdog
results: parsing output: 67/ for test: kms_dp_aux_dev
results: parsing output: 68/ for test: kms_chamelium_edid
results: parsing output: 69/ for test: kms_fbcon_fbt
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_force_connector_basic
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_plane_cursor
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: syncobj_eventfd
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: device_reset
results: parsing output: 97/ for test: kms_pm_dc
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: gem_busy
results: parsing output: 115/ for test: kms_legacy_colorkey
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: gem_close_race
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: intel_hwmon
results: parsing output: 121/ for test: gem_lmem_swapping
results: parsing output: 122/ for test: kms_feature_discovery
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: api_intel_bb
Done.