[68.939737] Initializing watchdogs
[68.939806]   /dev/watchdog0
[68.961094] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[68.972300] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.976227] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.978785] [001/156] (960s left) perf (stress-open-close)
[69.357559] Starting subtest: stress-open-close
[69.358492] Starting dynamic subtest: 0-rcs0
[71.602591] Dynamic subtest 0-rcs0: SUCCESS (2.243s)
[71.603520] Subtest stress-open-close: SUCCESS (2.244s)
[71.650463] [002/156] (957s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[73.157197] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[73.158135] Starting dynamic subtest: pipe-A
[73.256531] Dynamic subtest pipe-A: SUCCESS (0.099s)
[73.266293] Starting dynamic subtest: pipe-B
[73.433898] Dynamic subtest pipe-B: SUCCESS (0.177s)
[73.450990] Starting dynamic subtest: pipe-C
[73.593516] Dynamic subtest pipe-C: SUCCESS (0.159s)
[73.602650] Starting dynamic subtest: pipe-D
[73.735321] Dynamic subtest pipe-D: SUCCESS (0.141s)
[73.736334] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.578s)
[73.958730] [003/156] (955s left) kms_plane_lowres (tiling-yf)
[75.465778] Starting subtest: tiling-yf
[75.467459] Subtest tiling-yf: SKIP (0.000s)
[75.558779] [004/156] (954s left) gem_softpin (evict-single-offset)
[75.654366] Starting subtest: evict-single-offset
[110.930454] Subtest evict-single-offset: SUCCESS (35.269s)
[111.036314] [005/156] (918s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[112.587336] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[112.589149] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[112.714145] [006/156] (917s left) kms_dsc (dsc-with-output-formats)
[114.263423] Starting subtest: dsc-with-output-formats
[114.272048] Subtest dsc-with-output-formats: SKIP (0.001s)
[114.345756] [007/156] (915s left) kms_psr (pr-cursor-blt)
[115.861700] Subtest pr-cursor-blt: SKIP (0.000s)
[115.922724] [008/156] (913s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[117.436194] Starting subtest: addfb25-y-tiled-legacy
[117.437160] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[117.561652] [009/156] (912s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[119.107179] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[119.108934] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[119.277947] [010/156] (910s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[119.379383] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[119.490571] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[119.622881] [011/156] (910s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt)
[121.138140] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt
[121.139944] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[121.261201] [012/156] (908s left) api_intel_bb (purge-bb)
[121.360202] Starting subtest: purge-bb
[121.388656] Subtest purge-bb: SUCCESS (0.029s)
[121.550905] [013/156] (908s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render)
[123.062974] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render
[123.064770] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[123.197614] [014/156] (907s left) api_intel_allocator (two-level-inception)
[123.295987] Starting subtest: two-level-inception
[128.711437] Subtest two-level-inception: SUCCESS (5.415s)
[128.872121] [015/156] (901s left) i915_selftest (mock)
[129.931232] Starting subtest: mock
[129.932349] Starting dynamic subtest: sanitycheck
[130.798262] Dynamic subtest sanitycheck: SUCCESS (0.868s)
[130.809204] Starting dynamic subtest: shmem
[131.618755] Dynamic subtest shmem: SUCCESS (0.820s)
[131.641191] Starting dynamic subtest: fence
[140.015354] Dynamic subtest fence: SUCCESS (8.397s)
[140.026176] Starting dynamic subtest: scatterlist
[141.841735] Dynamic subtest scatterlist: SUCCESS (1.826s)
[141.850291] Starting dynamic subtest: syncmap
[144.677565] Dynamic subtest syncmap: SUCCESS (2.836s)
[144.687201] Starting dynamic subtest: uncore
[145.484407] Dynamic subtest uncore: SUCCESS (0.806s)
[145.507310] Starting dynamic subtest: ring
[146.310328] Dynamic subtest ring: SUCCESS (0.826s)
[146.321508] Starting dynamic subtest: engine
[147.118567] Dynamic subtest engine: SUCCESS (0.808s)
[147.141027] Starting dynamic subtest: timelines
[151.758882] Dynamic subtest timelines: SUCCESS (4.640s)
[151.768044] Starting dynamic subtest: requests
[154.514921] Dynamic subtest requests: SUCCESS (2.756s)
[154.523278] Starting dynamic subtest: objects
[155.429831] Dynamic subtest objects: SUCCESS (0.915s)
[155.439225] Starting dynamic subtest: phys
[156.385043] Dynamic subtest phys: SUCCESS (0.955s)
[156.393230] Starting dynamic subtest: dmabuf
[157.294019] Dynamic subtest dmabuf: SUCCESS (0.909s)
[157.302419] Starting dynamic subtest: vma
[165.440904] Dynamic subtest vma: SUCCESS (8.147s)
[165.450114] Starting dynamic subtest: evict
[167.245874] Dynamic subtest evict: SUCCESS (1.805s)
[167.255124] Starting dynamic subtest: gtt
[171.190157] Dynamic subtest gtt: SUCCESS (3.944s)
[171.199584] Starting dynamic subtest: hugepages
[172.287914] Dynamic subtest hugepages: SUCCESS (1.097s)
[172.297125] Starting dynamic subtest: memory_region
[175.697166] Dynamic subtest memory_region: SUCCESS (3.409s)
[175.698191] Subtest mock: SUCCESS (45.772s)
[175.726819] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[175.728345] [016/156] (854s left) perf_pmu (semaphore-busy)
[179.252896] Starting subtest: semaphore-busy
[179.255289] Starting dynamic subtest: rcs0
[180.958329] Dynamic subtest rcs0: SUCCESS (1.703s)
[180.972664] Starting dynamic subtest: bcs0
[182.598102] Dynamic subtest bcs0: SUCCESS (1.639s)
[182.612527] Starting dynamic subtest: vcs0
[184.242932] Dynamic subtest vcs0: SUCCESS (1.644s)
[184.254210] Starting dynamic subtest: vcs1
[185.886027] Dynamic subtest vcs1: SUCCESS (1.642s)
[185.897100] Starting dynamic subtest: vecs0
[187.525858] Dynamic subtest vecs0: SUCCESS (1.639s)
[187.537196] Starting dynamic subtest: vecs1
[189.168803] Dynamic subtest vecs1: SUCCESS (1.642s)
[189.179992] Starting dynamic subtest: ccs0
[190.809990] Dynamic subtest ccs0: SUCCESS (1.640s)
[190.811534] Subtest semaphore-busy: SUCCESS (11.556s)
[190.928709] [FACT perf_pmu (semaphore-busy)] new: kernel.kmod_is_loaded.i915: true
[190.930908] [017/156] (839s left) kms_flip (absolute-wf_vblank-interruptible)
[192.445376] Starting subtest: absolute-wf_vblank-interruptible
[192.451273] Starting dynamic subtest: A-HDMI-A3
[200.399711] Dynamic subtest A-HDMI-A3: SUCCESS (7.949s)
[200.412749] Starting dynamic subtest: B-HDMI-A3
[208.248554] Dynamic subtest B-HDMI-A3: SUCCESS (7.848s)
[208.261207] Starting dynamic subtest: C-HDMI-A3
[215.931398] Dynamic subtest C-HDMI-A3: SUCCESS (7.682s)
[215.942934] Starting dynamic subtest: D-HDMI-A3
[223.783249] Dynamic subtest D-HDMI-A3: SUCCESS (7.852s)
[223.784210] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.339s)
[224.041477] [018/156] (806s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[225.551997] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[225.553914] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[225.642044] [019/156] (804s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[227.168427] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[227.169385] Starting dynamic subtest: pipe-A-HDMI-A-3
[230.679297] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.495s)
[230.693687] Starting dynamic subtest: pipe-B-HDMI-A-3
[231.188235] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.505s)
[231.212552] Starting dynamic subtest: pipe-C-HDMI-A-3
[231.713701] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.522s)
[231.728037] Starting dynamic subtest: pipe-D-HDMI-A-3
[232.220984] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.504s)
[232.222899] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SUCCESS (5.037s)
[232.463531] [020/156] (798s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[233.976115] Starting subtest: psr-rgb101010-draw-pwrite
[233.977896] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[234.161222] [021/156] (796s left) gem_exec_flush (basic-batch-kernel-default-uc)
[234.255817] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[234.334896] [022/156] (796s left) syncobj_timeline (invalid-wait-illegal-handle)
[234.412026] Starting subtest: invalid-wait-illegal-handle
[234.413109] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[234.530838] [023/156] (796s left) kms_cursor_edge_walk (256x256-left-edge)
[236.037201] Starting subtest: 256x256-left-edge
[236.038151] Starting dynamic subtest: pipe-A-HDMI-A-3
[239.369140] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.331s)
[239.380373] Starting dynamic subtest: pipe-D-HDMI-A-3
[242.622539] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.253s)
[242.623398] Subtest 256x256-left-edge: SUCCESS (6.586s)
[242.837978] [024/156] (788s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[244.361208] Starting subtest: yf-tiled-64bpp-rotate-90
[244.363155] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[244.585040] [025/156] (786s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[246.101988] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[246.103826] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[246.239223] [026/156] (784s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[247.780869] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[247.782493] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.003696] [027/156] (783s left) kms_flip (nonblocking-read)
[249.518448] Starting subtest: nonblocking-read
[249.519341] Subtest nonblocking-read: SUCCESS (0.000s)
[249.619134] [028/156] (781s left) kms_plane_scaling (intel-max-src-size)
[251.143469] Starting subtest: intel-max-src-size
[251.149378] Subtest intel-max-src-size: SKIP (0.004s)
[251.368769] [029/156] (780s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[252.881102] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[252.894509] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.013s)
[253.015319] [030/156] (778s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[254.555054] Starting subtest: fbchdr-rgb101010-draw-render
[254.556961] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[254.690367] [031/156] (776s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[256.227458] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[256.229144] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[256.433334] [032/156] (775s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[257.955384] Starting subtest: x-tiled-16bpp-rotate-0
[259.769128] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.813s)
[259.978482] [033/156] (771s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[261.634711] Starting subtest: cursor-rapid-movement-64x64
[261.639280] Starting dynamic subtest: pipe-A-HDMI-A-3
[262.041954] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.403s)
[262.077173] Starting dynamic subtest: pipe-D-HDMI-A-3
[262.399126] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.332s)
[262.399998] Subtest cursor-rapid-movement-64x64: SUCCESS (0.764s)
[262.882124] [034/156] (768s left) kms_frontbuffer_tracking (hdr-2p-rte)
[264.398146] Starting subtest: hdr-2p-rte
[264.399994] Subtest hdr-2p-rte: SKIP (0.000s)
[264.590676] [035/156] (767s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move)
[266.115397] Starting subtest: hdr-2p-scndscrn-cur-indfb-move
[266.117195] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[266.266922] [036/156] (765s left) gem_ctx_shared (q-smoketest)
[266.393749] Starting subtest: Q-smoketest
[266.394650] Starting dynamic subtest: rcs0
[271.854139] Dynamic subtest rcs0: SUCCESS (5.454s)
[271.865069] Starting dynamic subtest: bcs0
[277.277020] Dynamic subtest bcs0: SUCCESS (5.421s)
[277.288600] Starting dynamic subtest: vcs0
[282.698442] Dynamic subtest vcs0: SUCCESS (5.422s)
[282.709471] Starting dynamic subtest: vcs1
[288.112093] Dynamic subtest vcs1: SUCCESS (5.412s)
[288.123160] Starting dynamic subtest: vecs0
[293.529453] Dynamic subtest vecs0: SUCCESS (5.417s)
[293.540403] Starting dynamic subtest: vecs1
[298.944037] Dynamic subtest vecs1: SUCCESS (5.414s)
[298.955188] Starting dynamic subtest: ccs0
[304.363484] Dynamic subtest ccs0: SUCCESS (5.419s)
[304.364637] Subtest Q-smoketest: SUCCESS (37.963s)
[304.635175] [037/156] (727s left) kms_atomic_interruptible (legacy-dpms)
[306.140781] Starting subtest: legacy-dpms
[306.141598] Starting dynamic subtest: pipe-A-HDMI-A-3
[312.367391] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.226s)
[312.368382] Subtest legacy-dpms: SUCCESS (6.227s)
[312.619845] [038/156] (719s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[314.178535] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[314.301248] [039/156] (717s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[315.828424] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[315.885852] [040/156] (716s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[315.963156] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[315.964059] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[316.102587] [041/156] (716s left) gem_mmap_gtt (big-bo)
[316.175176] Subtest big-bo: SKIP (0.000s)
[316.236390] [042/156] (716s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[317.745204] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[317.746173] Starting dynamic subtest: pipe-A-HDMI-A-3
[317.755170] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[317.766178] Starting dynamic subtest: pipe-B-HDMI-A-3
[317.775291] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[317.786057] Starting dynamic subtest: pipe-C-HDMI-A-3
[317.794528] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[317.805417] Starting dynamic subtest: pipe-D-HDMI-A-3
[317.815154] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[317.816912] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[318.066374] [043/156] (714s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[319.585486] Starting subtest: 4-tiled-8bpp-rotate-0
[321.161610] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.575s)
[321.388579] [044/156] (711s left) kms_flip (2x-flip-vs-suspend)
[322.897284] Starting subtest: 2x-flip-vs-suspend
[322.900402] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[322.993754] [045/156] (709s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[324.529230] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[325.795079] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.265s)
[326.004424] [046/156] (706s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[327.515530] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[327.517241] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[327.736941] [047/156] (705s left) gem_ctx_persistence (process)
[327.825569] Starting subtest: process
[328.014252] Subtest process: SUCCESS (0.188s)
[328.137742] [048/156] (704s left) gem_create (create-invalid-size)
[328.214266] Starting subtest: create-invalid-size
[328.215182] Subtest create-invalid-size: SUCCESS (0.000s)
[328.484923] [049/156] (704s left) gem_mmap_wc (write-read-distinct)
[328.555162] Subtest write-read-distinct: SKIP (0.000s)
[328.618623] [050/156] (704s left) gem_exec_fence (submit67)
[328.827253] Starting subtest: submit67
[328.829939] Subtest submit67: SKIP (0.000s)
[329.548069] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[329.549885] [051/156] (703s left) kms_big_fb (x-tiled-addfb-size-overflow)
[331.075763] Starting subtest: x-tiled-addfb-size-overflow
[331.078326] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.002s)
[331.218799] [052/156] (701s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[332.760532] Starting subtest: plane-lut1d-pre-ctm3x4
[332.978677] Starting dynamic subtest: pipe-A-plane-0
[333.211579] Dynamic subtest pipe-A-plane-0: SUCCESS (0.233s)
[333.248836] Starting dynamic subtest: pipe-A-plane-1
[333.410295] Dynamic subtest pipe-A-plane-1: SUCCESS (0.197s)
[333.422568] Starting dynamic subtest: pipe-A-plane-2
[333.577949] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[333.871786] Starting dynamic subtest: pipe-B-plane-0
[334.029704] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[334.060508] Starting dynamic subtest: pipe-B-plane-1
[334.211264] Dynamic subtest pipe-B-plane-1: SUCCESS (0.181s)
[334.249957] Starting dynamic subtest: pipe-B-plane-2
[334.410136] Dynamic subtest pipe-B-plane-2: SUCCESS (0.197s)
[334.710538] Starting dynamic subtest: pipe-C-plane-0
[334.877314] Dynamic subtest pipe-C-plane-0: SUCCESS (0.199s)
[334.895625] Starting dynamic subtest: pipe-C-plane-1
[335.060619] Dynamic subtest pipe-C-plane-1: SUCCESS (0.181s)
[335.093239] Starting dynamic subtest: pipe-C-plane-2
[335.277443] Dynamic subtest pipe-C-plane-2: SUCCESS (0.214s)
[335.619695] Starting dynamic subtest: pipe-D-plane-0
[335.802523] Dynamic subtest pipe-D-plane-0: SUCCESS (0.216s)
[335.835526] Starting dynamic subtest: pipe-D-plane-1
[336.002810] Dynamic subtest pipe-D-plane-1: SUCCESS (0.198s)
[336.035337] Starting dynamic subtest: pipe-D-plane-2
[336.218190] Dynamic subtest pipe-D-plane-2: SUCCESS (0.214s)
[336.242062] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.482s)
[336.458626] [053/156] (696s left) gem_exec_schedule (pi-ringfull)
[336.669798] Starting subtest: pi-ringfull
[336.670751] Starting dynamic subtest: rcs0
[336.703983] Dynamic subtest rcs0: SUCCESS (0.034s)
[336.716385] Starting dynamic subtest: bcs0
[336.738608] Dynamic subtest bcs0: SUCCESS (0.034s)
[336.749519] Starting dynamic subtest: vcs0
[336.772104] Dynamic subtest vcs0: SUCCESS (0.033s)
[336.783715] Starting dynamic subtest: vcs1
[336.803872] Dynamic subtest vcs1: SUCCESS (0.031s)
[336.815691] Starting dynamic subtest: vecs0
[336.834929] Dynamic subtest vecs0: SUCCESS (0.030s)
[336.846690] Starting dynamic subtest: vecs1
[336.865863] Dynamic subtest vecs1: SUCCESS (0.030s)
[336.877512] Starting dynamic subtest: ccs0
[336.897048] Dynamic subtest ccs0: SUCCESS (0.031s)
[336.897929] Subtest pi-ringfull: SUCCESS (0.228s)
[337.158322] [054/156] (696s left) kms_cdclk (mode-transition)
[338.672333] Starting subtest: mode-transition
[338.673227] Starting dynamic subtest: pipe-A-HDMI-A-3
[338.724306] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.050s)
[338.736160] Starting dynamic subtest: pipe-B-HDMI-A-3
[338.738051] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[338.749173] Starting dynamic subtest: pipe-C-HDMI-A-3
[338.751164] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[338.762495] Starting dynamic subtest: pipe-D-HDMI-A-3
[338.764268] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.004s)
[338.766069] Subtest mode-transition: SKIP (0.063s)
[338.982968] [055/156] (694s left) i915_pm_rc6_residency (media-rc6-accuracy)
[339.068423] Starting subtest: media-rc6-accuracy
[339.070550] Subtest media-rc6-accuracy: SKIP (0.000s)
[339.190058] [056/156] (694s left) kms_atomic (crtc-invalid-params)
[340.707321] Starting subtest: crtc-invalid-params
[340.709552] Starting dynamic subtest: pipe-A-HDMI-A-3
[341.171430] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.462s)
[341.172366] Subtest crtc-invalid-params: SUCCESS (0.464s)
[341.395708] [057/156] (692s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[342.916580] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[342.922579] Starting dynamic subtest: A-HDMI-A3
[343.673433] Dynamic subtest A-HDMI-A3: SUCCESS (0.750s)
[343.685014] Starting dynamic subtest: B-HDMI-A3
[344.328334] Dynamic subtest B-HDMI-A3: SUCCESS (0.654s)
[344.339624] Starting dynamic subtest: C-HDMI-A3
[344.975397] Dynamic subtest C-HDMI-A3: SUCCESS (0.646s)
[344.987230] Starting dynamic subtest: D-HDMI-A3
[345.652564] Dynamic subtest D-HDMI-A3: SUCCESS (0.676s)
[345.653481] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.736s)
[345.871556] [058/156] (687s left) gem_tiled_swapping (non-threaded)
[345.953274] Subtest non-threaded: SKIP (0.000s)
[346.032958] [059/156] (687s left) kms_panel_fitting (legacy)
[347.553254] Starting subtest: legacy
[347.555047] Subtest legacy: SKIP (0.000s)
[347.658476] [060/156] (686s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[349.204037] Starting subtest: fbcpsr-suspend
[349.205912] Subtest fbcpsr-suspend: SKIP (0.000s)
[349.340496] [061/156] (684s left) kms_sequence (queue-idle)
[350.881179] Starting subtest: queue-idle
[350.882145] Starting dynamic subtest: pipe-A-HDMI-A-3
[353.205556] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.323s)
[353.217373] Starting dynamic subtest: pipe-B-HDMI-A-3
[355.434411] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.228s)
[355.446220] Starting dynamic subtest: pipe-C-HDMI-A-3
[357.648908] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.212s)
[357.660604] Starting dynamic subtest: pipe-D-HDMI-A-3
[359.869820] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.220s)
[359.870721] Subtest queue-idle: SUCCESS (8.989s)
[360.081071] [062/156] (673s left) gem_exec_balancer (full-late-pulse)
[360.171298] Starting subtest: full-late-pulse
[362.318269] Subtest full-late-pulse: SUCCESS (2.147s)
[362.762980] [063/156] (671s left) kms_getfb (getfb2-handle-zero)
[364.277190] Starting subtest: getfb2-handle-zero
[364.278133] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[364.421237] [064/156] (669s left) syncobj_timeline (multi-wait-for-submit-signaled)
[364.524487] Starting subtest: multi-wait-for-submit-signaled
[364.526995] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[364.621976] [065/156] (669s left) syncobj_timeline (wait-all-for-submit-snapshot)
[364.701470] Starting subtest: wait-all-for-submit-snapshot
[364.784474] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[364.922352] [066/156] (669s left) kms_chamelium_frames (hdmi-frame-dump)
[366.492479] Subtest hdmi-frame-dump: SKIP (0.000s)
[366.627539] [067/156] (667s left) gem_exec_balancer (parallel-ordering)
[367.020706] Starting subtest: parallel-ordering
[368.812821] Subtest parallel-ordering: SUCCESS (1.792s)
[368.946425] [068/156] (665s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[370.468109] Starting subtest: hdr-rgb101010-draw-pwrite
[370.469915] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[370.607803] [069/156] (663s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-render)
[372.160982] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-render
[372.162934] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[372.303117] [070/156] (662s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-pgflip-blt)
[373.849449] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-pgflip-blt
[373.851224] Subtest fbcpsrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[374.069534] [071/156] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[375.592979] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[375.594694] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[375.825447] [072/156] (658s left) vgem_slow (nohang)
[375.894288] Starting subtest: nohang
[386.134112] Subtest nohang: SUCCESS (10.239s)
[386.244869] [073/156] (648s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[387.764954] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[387.766776] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[387.903055] [074/156] (646s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[389.445178] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[389.446087] Starting dynamic subtest: pipe-A-HDMI-A-3
[389.454912] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[389.466780] Starting dynamic subtest: pipe-B-HDMI-A-3
[389.475428] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[389.486987] Starting dynamic subtest: pipe-C-HDMI-A-3
[389.495657] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[389.507155] Starting dynamic subtest: pipe-D-HDMI-A-3
[389.516915] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[389.518551] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[389.763929] [075/156] (645s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[391.295330] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[391.297291] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[391.517535] [076/156] (643s left) perf (gen12-group-exclusive-stream-ctx-handle)
[391.910925] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[391.944445] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.033s)
[392.010407] [077/156] (643s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[393.564220] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[393.565955] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[393.703559] [078/156] (641s left) kms_psr (fbc-psr2-cursor-blt)
[395.245555] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[395.306426] [079/156] (639s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[396.827258] Starting subtest: cursorA-vs-flipB-atomic
[396.829168] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[396.940413] [080/156] (638s left) gem_lmem_swapping (verify-random-ccs)
[401.409091] Starting subtest: verify-random-ccs
[401.412587] Starting dynamic subtest: lmem0
[405.687930] Dynamic subtest lmem0: SUCCESS (4.284s)
[405.688973] Subtest verify-random-ccs: SUCCESS (4.285s)
[406.654324] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[406.655603] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[406.657773] [081/156] (628s left) gem_wait (invalid-flags)
[410.264828] Starting subtest: invalid-flags
[410.266081] Subtest invalid-flags: SUCCESS (0.000s)
[410.533267] [FACT gem_wait (invalid-flags)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[410.535543] [FACT gem_wait (invalid-flags)] new: kernel.kmod_is_loaded.i915: true
[410.538333] [082/156] (624s left) gem_ccs (block-multicopy-inplace)
[410.626583] Starting subtest: block-multicopy-inplace
[410.629011] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[410.680637] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.053s)
[410.692859] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[410.780347] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.098s)
[410.792489] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[410.795784] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[410.808225] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[410.894252] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.097s)
[410.907039] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[410.910053] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[410.922254] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[411.014950] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.104s)
[411.027313] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[411.030444] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[411.042735] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[411.129549] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.098s)
[411.130488] Subtest block-multicopy-inplace: SUCCESS (0.504s)
[411.257433] [083/156] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[412.780208] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[412.782138] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[412.928807] [084/156] (622s left) prime_mmap (test_correct_cpu_write)
[413.042396] Starting subtest: test_correct_cpu_write
[413.043333] Starting dynamic subtest: test_correct_cpu_write-smem
[413.044258] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[413.055308] Starting dynamic subtest: test_correct_cpu_write-lmem0
[413.056481] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s)
[413.057516] Subtest test_correct_cpu_write: SUCCESS (0.003s)
[413.199572] [085/156] (622s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[414.723373] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[414.788683] [086/156] (620s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[416.313189] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[416.315168] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[416.458857] [087/156] (619s left) gem_exec_whisper (basic-fds-forked)
[416.586330] Starting subtest: basic-fds-forked
[439.252513] Subtest basic-fds-forked: SUCCESS (22.665s)
[439.529112] [088/156] (596s left) kms_pm_rpm (pc8-residency)
[443.073589] Starting subtest: pc8-residency
[443.076802] Subtest pc8-residency: SKIP (0.000s)
[444.058572] [089/156] (591s left) gem_flink_race (flink_close)
[444.114220] Starting subtest: flink_close
[449.197272] Subtest flink_close: SUCCESS (5.084s)
[449.329964] [090/156] (586s left) gem_render_copy (yf-tiled)
[449.467043] Starting subtest: yf-tiled
[449.469469] Subtest yf-tiled: SKIP (0.000s)
[449.768223] [091/156] (586s left) gem_lmem_evict (dontneed-evict-race)
[454.189452] Starting subtest: dontneed-evict-race
[456.281520] Subtest dontneed-evict-race: SUCCESS (2.092s)
[458.006526] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[458.007741] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[458.010788] [092/156] (578s left) kms_addfb_basic (unused-handle)
[461.527190] Starting subtest: unused-handle
[461.528032] Subtest unused-handle: SUCCESS (0.000s)
[463.030850] [FACT kms_addfb_basic (unused-handle)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[463.033127] [FACT kms_addfb_basic (unused-handle)] new: kernel.kmod_is_loaded.i915: true
[463.036174] [093/156] (573s left) syncobj_wait (single-wait-all-signaled)
[463.119375] Starting subtest: single-wait-all-signaled
[463.120327] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[463.315698] [094/156] (573s left) kms_psr (pr-suspend)
[464.828426] Subtest pr-suspend: SKIP (0.000s)
[464.883518] [095/156] (571s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[466.406159] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[466.407943] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[466.567679] [096/156] (569s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[466.688271] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[466.690380] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[466.929247] [097/156] (569s left) i915_drm_fdinfo (busy-hang)
[467.009338] Starting subtest: busy-hang
[467.010287] Starting dynamic subtest: rcs0
[467.038199] Dynamic subtest rcs0: SKIP (0.027s)
[467.048665] Starting dynamic subtest: bcs0
[467.050558] Dynamic subtest bcs0: SKIP (0.001s)
[467.061213] Starting dynamic subtest: vcs0
[467.063641] Dynamic subtest vcs0: SKIP (0.000s)
[467.074040] Starting dynamic subtest: vcs1
[467.076373] Dynamic subtest vcs1: SKIP (0.001s)
[467.086846] Starting dynamic subtest: vecs0
[467.089091] Dynamic subtest vecs0: SKIP (0.001s)
[467.099013] Starting dynamic subtest: vecs1
[467.101339] Dynamic subtest vecs1: SKIP (0.001s)
[467.111611] Starting dynamic subtest: ccs0
[467.113909] Dynamic subtest ccs0: SKIP (0.001s)
[467.116354] Subtest busy-hang: SKIP (0.038s)
[467.169972] [098/156] (569s left) syncobj_wait (reset-signaled)
[467.251605] Starting subtest: reset-signaled
[467.252500] Subtest reset-signaled: SUCCESS (0.000s)
[467.417292] [099/156] (569s left) kms_vblank (ts-continuation-idle)
[468.939201] Starting subtest: ts-continuation-idle
[468.940151] Starting dynamic subtest: pipe-A-HDMI-A-3
[469.279927] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.339s)
[469.323294] Starting dynamic subtest: pipe-D-HDMI-A-3
[469.520814] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.227s)
[469.521719] Subtest ts-continuation-idle: SUCCESS (0.582s)
[469.725582] [100/156] (567s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[471.240291] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[471.241257] Starting dynamic subtest: pipe-A-HDMI-A-3
[471.249922] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[471.260989] Starting dynamic subtest: pipe-B-HDMI-A-3
[471.269961] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[471.280858] Starting dynamic subtest: pipe-C-HDMI-A-3
[471.289406] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[471.300249] Starting dynamic subtest: pipe-D-HDMI-A-3
[471.310919] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[471.312695] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[471.632501] [101/156] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[473.155156] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[475.930723] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.776s)
[476.194601] [102/156] (560s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[477.710262] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[477.711177] Starting dynamic subtest: pipe-A-HDMI-A-3
[477.796303] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.085s)
[477.850428] Starting dynamic subtest: pipe-B-HDMI-A-3
[478.041286] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.204s)
[478.064512] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.354s)
[478.269085] [103/156] (558s left) gem_create (create-ext-cpu-access-big)
[478.484711] Starting subtest: create-ext-cpu-access-big
[480.645671] Subtest create-ext-cpu-access-big: FAIL (2.171s)
[481.558442] [104/156] (555s left) gem_exec_fence (syncobj-timeline-wait)
[482.190870] Starting subtest: syncobj-timeline-wait
[482.295818] Subtest syncobj-timeline-wait: SUCCESS (0.105s)
[482.548347] [105/156] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[484.070020] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[484.071919] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[484.225312] [106/156] (552s left) gem_partial_pwrite_pread (reads-display)
[484.337498] Subtest reads-display: SKIP (0.000s)
[484.419070] [107/156] (552s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render)
[485.944244] Starting subtest: fbcpsrhdr-rgb101010-draw-render
[485.945986] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s)
[486.073030] [108/156] (551s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[486.176500] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[486.177451] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[486.332075] [109/156] (551s left) gem_partial_pwrite_pread (write-display)
[486.420526] Subtest write-display: SKIP (0.000s)
[486.502009] [110/156] (550s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[488.028361] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[488.030470] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[488.154866] [111/156] (549s left) gem_mmap_gtt (zero-extend)
[488.260329] Subtest zero-extend: SKIP (0.000s)
[488.340139] [112/156] (549s left) syncobj_wait (invalid-signal-illegal-handle)
[488.420649] Starting subtest: invalid-signal-illegal-handle
[488.421546] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[488.582155] [113/156] (549s left) i915_pm_freq_api (freq-basic-api)
[488.671501] Starting subtest: freq-basic-api
[488.672463] Starting dynamic subtest: gt0
[488.675966] Dynamic subtest gt0: SUCCESS (0.004s)
[488.676952] Subtest freq-basic-api: SUCCESS (0.005s)
[488.811377] [114/156] (548s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[490.333143] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[490.334896] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[490.500344] [115/156] (547s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt)
[492.044157] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt
[492.045964] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[492.180279] [116/156] (545s left) sysfs_timeslice_duration (timeout)
[492.292509] Starting subtest: timeout
[492.295120] Starting dynamic subtest: vecs0
[494.041368] Dynamic subtest vecs0: SUCCESS (1.747s)
[494.053457] Starting dynamic subtest: ccs0
[495.768381] Dynamic subtest ccs0: SUCCESS (1.726s)
[495.780601] Starting dynamic subtest: vcs0
[497.417341] Dynamic subtest vcs0: SUCCESS (1.647s)
[497.429689] Starting dynamic subtest: bcs0
[498.446264] Dynamic subtest bcs0: SUCCESS (1.028s)
[498.458182] Starting dynamic subtest: vecs1
[500.072103] Dynamic subtest vecs1: SUCCESS (1.624s)
[500.084568] Starting dynamic subtest: rcs0
[501.690110] Dynamic subtest rcs0: SUCCESS (1.617s)
[501.702344] Starting dynamic subtest: vcs1
[503.332265] Dynamic subtest vcs1: SUCCESS (1.641s)
[503.333225] Subtest timeout: SUCCESS (11.039s)
[503.471398] [117/156] (534s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[504.992465] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[504.994277] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[505.103562] [118/156] (532s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[506.642277] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[506.644111] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[506.785045] [119/156] (531s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[506.897498] Starting subtest: invalid-multi-wait-all-unsubmitted
[506.898602] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[507.044712] [120/156] (531s left) syncobj_wait (multi-wait-submitted)
[507.152509] Starting subtest: multi-wait-submitted
[507.260287] Subtest multi-wait-submitted: SUCCESS (0.107s)
[507.362937] [121/156] (530s left) gen7_exec_parse (basic-offset)
[507.453439] Subtest basic-offset: SKIP (0.000s)
[507.517458] [122/156] (530s left) gem_mmap_gtt (fault-concurrent)
[507.597310] Subtest fault-concurrent: SKIP (0.000s)
[507.672532] [123/156] (530s left) kms_addfb_basic (addfb25-modifier-no-flag)
[509.185405] Starting subtest: addfb25-modifier-no-flag
[509.186418] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[509.342322] [124/156] (529s left) gem_pxp (create-valid-protected-context)
[511.981800] Starting subtest: create-valid-protected-context
[511.983642] Subtest create-valid-protected-context: SKIP (0.000s)
[512.079073] [125/156] (526s left) gem_mmap_gtt (basic-small-bo-tiledx)
[512.160418] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[512.237537] [126/156] (526s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[513.754545] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[513.890165] [127/156] (524s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[515.419916] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[515.421568] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[515.547554] [128/156] (523s left) kms_pm_rpm (basic-rte)
[515.621515] Starting subtest: basic-rte
[520.175476] Subtest basic-rte: SUCCESS (4.554s)
[522.148913] [129/156] (516s left) kms_flip (2x-flip-vs-panning)
[523.665918] Starting subtest: 2x-flip-vs-panning
[523.678373] Subtest 2x-flip-vs-panning: SKIP (0.012s)
[523.870741] [130/156] (515s left) gem_flink_basic (bad-flink)
[523.956937] Starting subtest: bad-flink
[523.958039] Subtest bad-flink: SUCCESS (0.000s)
[524.096423] [131/156] (514s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[525.617119] Starting subtest: fbcpsrhdr-tiling-4
[525.618858] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[525.764950] [132/156] (513s left) gem_pwrite_snooped
[525.965614] [133/156] (513s left) gem_ctx_param (invalid-set-no-zeromap)
[526.047865] Starting subtest: invalid-set-no-zeromap
[526.048827] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[526.229707] [134/156] (513s left) kms_psr (psr2-sprite-plane-move)
[527.748755] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[527.813241] [135/156] (511s left) kms_cursor_crc (cursor-alpha-transparent)
[529.332194] Starting subtest: cursor-alpha-transparent
[529.333090] Starting dynamic subtest: pipe-A-HDMI-A-3
[529.906338] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.572s)
[529.918389] Starting dynamic subtest: pipe-D-HDMI-A-3
[530.375221] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.468s)
[530.376224] Subtest cursor-alpha-transparent: SUCCESS (1.044s)
[530.940031] [136/156] (508s left) kms_joiner (invalid-modeset-ultra-joiner)
[532.463988] Starting subtest: invalid-modeset-ultra-joiner
[532.465693] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[532.654844] [137/156] (506s left) kms_legacy_colorkey (basic)
[534.174347] Starting subtest: basic
[534.175258] Starting dynamic subtest: pipe-A
[534.228280] Dynamic subtest pipe-A: SUCCESS (0.054s)
[534.243073] Starting dynamic subtest: pipe-B
[534.244212] Dynamic subtest pipe-B: SUCCESS (0.000s)
[534.259415] Starting dynamic subtest: pipe-C
[534.260463] Dynamic subtest pipe-C: SUCCESS (0.000s)
[534.277886] Starting dynamic subtest: pipe-D
[534.279179] Dynamic subtest pipe-D: SUCCESS (0.000s)
[534.280490] Subtest basic: SUCCESS (0.060s)
[534.401114] [138/156] (505s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[535.923288] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[535.925112] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[536.159257] [139/156] (503s left) kms_draw_crc (fill-fb)
[537.682285] Starting subtest: fill-fb
[538.194997] Subtest fill-fb: SUCCESS (0.514s)
[538.353295] [140/156] (501s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[538.435580] Starting subtest: invalid-single-wait-all-unsubmitted
[538.436491] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[538.571956] [141/156] (501s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[540.094011] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[540.095852] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[540.330849] [142/156] (499s left) gen9_exec_parse (allowed-single)
[540.420430] Subtest allowed-single: SKIP (0.000s)
[540.491916] [143/156] (499s left) kms_psr (psr-sprite-plane-move)
[542.008452] Subtest psr-sprite-plane-move: SKIP (0.000s)
[542.076283] [144/156] (498s left) kms_content_protection (mei-interface)
[543.669669] Starting subtest: mei-interface
[543.675521] Subtest mei-interface: SKIP (0.003s)
[543.857651] [145/156] (496s left) gem_exec_schedule (semaphore-codependency)
[543.958473] Starting subtest: semaphore-codependency
[544.001697] Subtest semaphore-codependency: SUCCESS (0.044s)
[544.410925] [146/156] (495s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt)
[545.934051] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt
[545.935795] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[546.078665] [147/156] (494s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[547.634245] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc
[547.636156] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[547.781626] [148/156] (492s left) kms_cursor_legacy (single-bo)
[549.324199] Starting subtest: single-bo
[549.325191] Starting dynamic subtest: pipe-A
[554.705963] Dynamic subtest pipe-A: SUCCESS (5.380s)
[554.718409] Starting dynamic subtest: pipe-B
[560.086074] Dynamic subtest pipe-B: SUCCESS (5.378s)
[560.098050] Starting dynamic subtest: pipe-C
[565.466160] Dynamic subtest pipe-C: SUCCESS (5.378s)
[565.478030] Starting dynamic subtest: pipe-D
[570.846386] Dynamic subtest pipe-D: SUCCESS (5.379s)
[570.858440] Starting dynamic subtest: all-pipes
[576.227136] Dynamic subtest all-pipes: SUCCESS (5.379s)
[576.228248] Subtest single-bo: SUCCESS (26.902s)
[576.331764] [149/156] (464s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[577.854951] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[580.715875] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (2.862s)
[580.893950] [150/156] (459s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[582.416446] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[582.418248] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[582.654282] [151/156] (458s left) gem_exec_reloc (basic-cpu-wc)
[582.741462] Subtest basic-cpu-wc: SKIP (0.000s)
[582.851308] [152/156] (457s left) kms_plane_alpha_blend (constant-alpha-min)
[584.367242] Starting subtest: constant-alpha-min
[584.615054] Starting dynamic subtest: pipe-A-HDMI-A-3
[585.287035] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.672s)
[585.300881] Starting dynamic subtest: pipe-D-HDMI-A-3
[585.975906] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.686s)
[585.976884] Subtest constant-alpha-min: SUCCESS (1.609s)
[586.176112] [153/156] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[587.697788] Starting subtest: fbcpsr-2p-rte
[587.699451] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[587.864173] [154/156] (453s left) gem_linear_blits (interruptible)
[588.254679] Starting subtest: interruptible
[595.558104] Subtest interruptible: SUCCESS (7.303s)
[595.790029] [155/156] (445s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[597.361900] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[597.363645] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[597.525564] [156/156] (443s left) device_reset (unbind-cold-reset-rebind)
[597.650765] Starting subtest: unbind-cold-reset-rebind
[597.652547] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[597.736430] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: kms_plane_lowres
results: parsing output: 3/ for test: gem_softpin
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_dsc
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: api_intel_allocator
results: parsing output: 14/ for test: i915_selftest
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_flush
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_cursor_edge_walk
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_ctx_shared
results: parsing output: 36/ for test: kms_atomic_interruptible
results: parsing output: 37/ for test: kms_chamelium_hpd
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: gem_create
results: parsing output: 48/ for test: gem_mmap_wc
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_color_pipeline
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_cdclk
results: parsing output: 54/ for test: i915_pm_rc6_residency
results: parsing output: 55/ for test: kms_atomic
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_tiled_swapping
results: parsing output: 58/ for test: kms_panel_fitting
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_sequence
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: kms_getfb
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_chamelium_frames
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: vgem_slow
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: gem_wait
results: parsing output: 81/ for test: gem_ccs
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: prime_mmap
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: gem_flink_race
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: gem_lmem_evict
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: i915_drm_fdinfo
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: gem_create
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_partial_pwrite_pread
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: gem_partial_pwrite_pread
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: i915_pm_freq_api
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: sysfs_timeslice_duration
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: gen7_exec_parse
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_pm_rpm
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_flink_basic
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_pwrite_snooped
results: parsing output: 132/ for test: gem_ctx_param
results: parsing output: 133/ for test: kms_psr
results: parsing output: 134/ for test: kms_cursor_crc
results: parsing output: 135/ for test: kms_joiner
results: parsing output: 136/ for test: kms_legacy_colorkey
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_draw_crc
results: parsing output: 139/ for test: syncobj_wait
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gen9_exec_parse
results: parsing output: 142/ for test: kms_psr
results: parsing output: 143/ for test: kms_content_protection
results: parsing output: 144/ for test: gem_exec_schedule
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_cursor_legacy
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_reloc
results: parsing output: 151/ for test: kms_plane_alpha_blend
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_linear_blits
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: device_reset
Done.