[50.695821] Initializing watchdogs
[50.695958]   /dev/watchdog0
[50.714120] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[50.718727] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[50.721267] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[50.724754] [001/156] (960s left) perf (stress-open-close)
[50.873247] Starting subtest: stress-open-close
[50.875415] Starting dynamic subtest: 0-rcs0
[52.963165] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[52.970336] Starting dynamic subtest: 1-vcs0
[55.050810] Dynamic subtest 1-vcs0: SUCCESS (2.162s)
[55.052684] Subtest stress-open-close: SUCCESS (4.330s)
[55.097649] [002/156] (956s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[55.203932] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[55.205801] Starting dynamic subtest: pipe-A
[55.224495] Dynamic subtest pipe-A: SKIP (0.018s)
[55.232962] Starting dynamic subtest: pipe-B
[55.259359] Dynamic subtest pipe-B: SKIP (0.035s)
[55.266323] Starting dynamic subtest: pipe-C
[55.292662] Dynamic subtest pipe-C: SKIP (0.035s)
[55.299474] Starting dynamic subtest: pipe-D
[55.326650] Dynamic subtest pipe-D: SKIP (0.035s)
[55.330110] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.124s)
[55.422216] [003/156] (955s left) kms_plane_lowres (tiling-yf)
[55.512065] Starting subtest: tiling-yf
[55.515571] Subtest tiling-yf: SKIP (0.000s)
[55.594053] [004/156] (955s left) gem_softpin (evict-single-offset)
[55.654609] Starting subtest: evict-single-offset
[82.312272] Subtest evict-single-offset: SUCCESS (26.860s)
[82.393185] [005/156] (928s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[82.548235] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[82.552764] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[82.661863] [006/156] (928s left) kms_dsc (dsc-with-output-formats)
[82.761885] Starting subtest: dsc-with-output-formats
[82.784485] Subtest dsc-with-output-formats: SKIP (0.001s)
[82.835440] [007/156] (928s left) kms_psr (pr-cursor-blt)
[82.930946] Starting subtest: pr-cursor-blt
[82.935633] Subtest pr-cursor-blt: SKIP (0.000s)
[83.003183] [008/156] (928s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[83.097296] Starting subtest: addfb25-y-tiled-legacy
[83.099587] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[83.187610] [009/156] (928s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[83.285118] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[89.931432] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.649s)
[90.053197] [010/156] (921s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[90.109373] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[90.214391] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[90.300172] [011/156] (921s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt)
[90.394698] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt
[90.399255] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[90.483483] [012/156] (921s left) api_intel_bb (purge-bb)
[90.540889] Starting subtest: purge-bb
[90.542853] Subtest purge-bb: SUCCESS (0.004s)
[90.668766] [013/156] (921s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render)
[90.755620] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render
[90.759765] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[90.862215] [014/156] (920s left) api_intel_allocator (two-level-inception)
[90.904928] Starting subtest: two-level-inception
[96.302803] Subtest two-level-inception: SUCCESS (5.399s)
[96.440603] [015/156] (915s left) i915_selftest (mock)
[98.447886] Starting subtest: mock
[98.450386] Starting dynamic subtest: sanitycheck
[99.306018] Dynamic subtest sanitycheck: SUCCESS (0.857s)
[99.314912] Starting dynamic subtest: shmem
[100.001495] Dynamic subtest shmem: SUCCESS (0.693s)
[100.010459] Starting dynamic subtest: fence
[107.475845] Dynamic subtest fence: SUCCESS (7.473s)
[107.485068] Starting dynamic subtest: scatterlist
[109.168978] Dynamic subtest scatterlist: SUCCESS (1.692s)
[109.179058] Starting dynamic subtest: syncmap
[112.349704] Dynamic subtest syncmap: SUCCESS (3.180s)
[112.361567] Starting dynamic subtest: uncore
[113.036247] Dynamic subtest uncore: SUCCESS (0.686s)
[113.045549] Starting dynamic subtest: ring
[113.723321] Dynamic subtest ring: SUCCESS (0.686s)
[113.732784] Starting dynamic subtest: engine
[114.395260] Dynamic subtest engine: SUCCESS (0.671s)
[114.404430] Starting dynamic subtest: timelines
[118.231853] Dynamic subtest timelines: SUCCESS (3.824s)
[118.241478] Starting dynamic subtest: requests
[122.301153] Dynamic subtest requests: SUCCESS (4.080s)
[122.310407] Starting dynamic subtest: objects
[123.058091] Dynamic subtest objects: SUCCESS (0.757s)
[123.067524] Starting dynamic subtest: phys
[123.835246] Dynamic subtest phys: SUCCESS (0.776s)
[123.844600] Starting dynamic subtest: dmabuf
[124.617881] Dynamic subtest dmabuf: SUCCESS (0.782s)
[124.627138] Starting dynamic subtest: vma
[130.280431] Dynamic subtest vma: SUCCESS (5.661s)
[130.289248] Starting dynamic subtest: evict
[131.672489] Dynamic subtest evict: SUCCESS (1.392s)
[131.681521] Starting dynamic subtest: gtt
[135.035306] Dynamic subtest gtt: SUCCESS (3.362s)
[135.044647] Starting dynamic subtest: hugepages
[135.956884] Dynamic subtest hugepages: SUCCESS (0.921s)
[135.966512] Starting dynamic subtest: memory_region
[138.452328] Dynamic subtest memory_region: SUCCESS (2.494s)
[138.455245] Subtest mock: SUCCESS (40.002s)
[138.484748] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[138.487577] [016/156] (873s left) perf_pmu (semaphore-busy)
[140.030129] Starting subtest: semaphore-busy
[140.032558] Starting dynamic subtest: rcs0
[141.656562] Dynamic subtest rcs0: SUCCESS (1.622s)
[141.667398] Starting dynamic subtest: bcs0
[143.291067] Dynamic subtest bcs0: SUCCESS (1.634s)
[143.303204] Starting dynamic subtest: vcs0
[147.781871] Dynamic subtest vcs0: SUCCESS (4.487s)
[147.792956] Starting dynamic subtest: vcs1
[153.796508] Dynamic subtest vcs1: SUCCESS (6.013s)
[153.807834] Starting dynamic subtest: vecs0
[159.812893] Dynamic subtest vecs0: SUCCESS (6.015s)
[159.823696] Starting dynamic subtest: ccs0
[162.888971] Dynamic subtest ccs0: SUCCESS (3.075s)
[162.891774] Subtest semaphore-busy: SUCCESS (22.855s)
[162.973476] [FACT perf_pmu (semaphore-busy)] new: kernel.kmod_is_loaded.i915: true
[162.976862] [017/156] (848s left) kms_flip (absolute-wf_vblank-interruptible)
[163.095068] Starting subtest: absolute-wf_vblank-interruptible
[163.097338] Starting dynamic subtest: A-eDP1
[171.850182] Dynamic subtest A-eDP1: SUCCESS (8.753s)
[171.859280] Starting dynamic subtest: B-eDP1
[180.577955] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[180.587890] Starting dynamic subtest: C-eDP1
[189.293215] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[189.305579] Starting dynamic subtest: D-eDP1
[198.027185] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[198.032692] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.936s)
[199.246578] [018/156] (812s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[199.340328] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[199.344613] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[199.411564] [019/156] (812s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[199.511331] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[199.513691] Starting dynamic subtest: pipe-A-eDP-1
[199.572608] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[199.581528] Starting dynamic subtest: pipe-B-eDP-1
[199.638813] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[199.648774] Starting dynamic subtest: pipe-C-eDP-1
[199.705788] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[199.715411] Starting dynamic subtest: pipe-D-eDP-1
[199.772762] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[199.776898] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[201.828057] [020/156] (810s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[201.932826] Starting subtest: psr-rgb101010-draw-pwrite
[209.643162] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.716s)
[209.770507] [021/156] (802s left) gem_exec_flush (basic-batch-kernel-default-uc)
[209.846698] Starting subtest: basic-batch-kernel-default-uc
[216.981772] Subtest basic-batch-kernel-default-uc: SUCCESS (7.135s)
[217.179790] [022/156] (794s left) syncobj_timeline (invalid-wait-illegal-handle)
[217.243978] Starting subtest: invalid-wait-illegal-handle
[217.246298] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[217.334962] [023/156] (794s left) kms_cursor_edge_walk (256x256-left-edge)
[217.431983] Starting subtest: 256x256-left-edge
[217.434384] Starting dynamic subtest: pipe-A-eDP-1
[220.870197] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s)
[220.879483] Starting dynamic subtest: pipe-D-eDP-1
[224.000315] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[224.002679] Subtest 256x256-left-edge: SUCCESS (6.570s)
[224.808237] [024/156] (787s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[224.926964] Starting subtest: yf-tiled-64bpp-rotate-90
[224.931495] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[225.036372] [025/156] (787s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[225.139990] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[225.144132] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[225.234626] [026/156] (786s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[225.338200] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[225.342852] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[225.453791] [027/156] (786s left) kms_flip (nonblocking-read)
[225.559567] Starting subtest: nonblocking-read
[225.561813] Subtest nonblocking-read: SUCCESS (0.000s)
[225.661916] [028/156] (786s left) kms_plane_scaling (intel-max-src-size)
[225.751944] Starting subtest: intel-max-src-size
[225.757635] Subtest intel-max-src-size: SKIP (0.000s)
[225.859387] [029/156] (786s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[225.946574] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[225.958519] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[226.035635] [030/156] (786s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[226.132193] Starting subtest: fbchdr-rgb101010-draw-render
[226.135799] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[226.233623] [031/156] (786s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[226.325105] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[226.328544] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[226.420186] [032/156] (785s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[226.532533] Starting subtest: x-tiled-16bpp-rotate-0
[227.790645] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.257s)
[227.916651] [033/156] (784s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[228.098497] Starting subtest: cursor-rapid-movement-64x64
[228.102561] Starting dynamic subtest: pipe-A-eDP-1
[228.653857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[228.682060] Starting dynamic subtest: pipe-D-eDP-1
[229.903628] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[229.906067] Subtest cursor-rapid-movement-64x64: SUCCESS (1.805s)
[230.762956] [034/156] (781s left) kms_frontbuffer_tracking (hdr-2p-rte)
[230.859038] Starting subtest: hdr-2p-rte
[230.863562] Subtest hdr-2p-rte: SKIP (0.000s)
[230.958850] [035/156] (781s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move)
[231.051194] Starting subtest: hdr-2p-scndscrn-cur-indfb-move
[231.055278] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[231.143353] [036/156] (781s left) gem_ctx_shared (q-smoketest)
[231.206178] Starting subtest: Q-smoketest
[231.208661] Starting dynamic subtest: rcs0
[236.757795] Dynamic subtest rcs0: SUCCESS (5.503s)
[236.768349] Starting dynamic subtest: bcs0
[242.269873] Dynamic subtest bcs0: SUCCESS (5.508s)
[242.282361] Starting dynamic subtest: vcs0
[247.749612] Dynamic subtest vcs0: SUCCESS (5.482s)
[247.759752] Starting dynamic subtest: vcs1
[253.246485] Dynamic subtest vcs1: SUCCESS (5.488s)
[253.255815] Starting dynamic subtest: vecs0
[258.732450] Dynamic subtest vecs0: SUCCESS (5.488s)
[258.743953] Starting dynamic subtest: ccs0
[264.208826] Dynamic subtest ccs0: SUCCESS (5.481s)
[264.211117] Subtest Q-smoketest: SUCCESS (32.954s)
[264.346348] [037/156] (748s left) kms_atomic_interruptible (legacy-dpms)
[264.447852] Starting subtest: legacy-dpms
[264.450152] Starting dynamic subtest: pipe-A-eDP-1
[271.923917] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.475s)
[271.926161] Subtest legacy-dpms: SUCCESS (7.477s)
[272.745282] [038/156] (739s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[273.134614] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[273.964736] [039/156] (738s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[274.063039] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[274.065322] Starting dynamic subtest: pipe-A-eDP-1
[274.160985] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[274.174093] Starting dynamic subtest: pipe-B-eDP-1
[275.370738] Dynamic subtest pipe-B-eDP-1: SKIP (1.207s)
[275.375180] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.309s)
[276.557198] [040/156] (736s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[276.607668] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[276.609996] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[276.714931] [041/156] (736s left) gem_mmap_gtt (big-bo)
[276.782694] Subtest big-bo: SKIP (0.000s)
[276.878610] [042/156] (735s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[276.972642] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[276.975065] Starting dynamic subtest: pipe-A-eDP-1
[276.996363] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[277.007070] Starting dynamic subtest: pipe-B-eDP-1
[277.026818] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[277.035671] Starting dynamic subtest: pipe-C-eDP-1
[277.055830] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[277.065677] Starting dynamic subtest: pipe-D-eDP-1
[277.084759] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[277.086947] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[279.445299] [043/156] (733s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[279.549633] Starting subtest: 4-tiled-8bpp-rotate-0
[280.773515] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.225s)
[280.897748] [044/156] (732s left) kms_flip (2x-flip-vs-suspend)
[280.990359] Starting subtest: 2x-flip-vs-suspend
[280.993902] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[281.087921] [045/156] (731s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[281.184124] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[282.276797] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.091s)
[282.394846] [046/156] (730s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[282.494696] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[282.498087] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[282.591319] [047/156] (730s left) gem_ctx_persistence (process)
[282.656224] Starting subtest: process
[282.795387] Subtest process: SUCCESS (0.139s)
[282.889265] [048/156] (730s left) gem_create (create-invalid-size)
[282.947345] Starting subtest: create-invalid-size
[282.949306] Subtest create-invalid-size: SUCCESS (0.000s)
[283.136211] [049/156] (729s left) gem_mmap_wc (write-read-distinct)
[283.200466] Subtest write-read-distinct: SKIP (0.000s)
[283.269321] [050/156] (729s left) gem_exec_fence (submit67)
[283.444969] Starting subtest: submit67
[283.449664] Subtest submit67: SKIP (0.000s)
[285.423532] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[285.427216] [051/156] (727s left) kms_big_fb (x-tiled-addfb-size-overflow)
[285.535518] Starting subtest: x-tiled-addfb-size-overflow
[285.537767] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[285.635979] [052/156] (727s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[285.724291] Starting subtest: plane-lut1d-pre-ctm3x4
[285.871723] Starting dynamic subtest: pipe-A-plane-0
[286.037348] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[286.047935] Starting dynamic subtest: pipe-A-plane-1
[286.203767] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[286.213414] Starting dynamic subtest: pipe-A-plane-2
[286.392773] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[287.647581] Starting dynamic subtest: pipe-B-plane-0
[287.817582] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[287.827850] Starting dynamic subtest: pipe-B-plane-1
[287.984207] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[287.995692] Starting dynamic subtest: pipe-B-plane-2
[288.162969] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[289.352544] Starting dynamic subtest: pipe-C-plane-0
[289.488868] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[289.500987] Starting dynamic subtest: pipe-C-plane-1
[289.633444] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[289.642708] Starting dynamic subtest: pipe-C-plane-2
[289.777759] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[290.995677] Starting dynamic subtest: pipe-D-plane-0
[291.129152] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[291.139032] Starting dynamic subtest: pipe-D-plane-1
[291.285556] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[291.295723] Starting dynamic subtest: pipe-D-plane-2
[291.451753] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[291.741666] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.015s)
[292.575190] [053/156] (720s left) gem_exec_schedule (pi-ringfull)
[292.755495] Starting subtest: pi-ringfull
[292.757572] Starting dynamic subtest: rcs0
[292.780271] Dynamic subtest rcs0: SUCCESS (0.027s)
[292.794807] Starting dynamic subtest: bcs0
[292.809136] Dynamic subtest bcs0: SUCCESS (0.028s)
[292.821193] Starting dynamic subtest: vcs0
[292.837677] Dynamic subtest vcs0: SUCCESS (0.028s)
[292.851548] Starting dynamic subtest: vcs1
[292.864101] Dynamic subtest vcs1: SUCCESS (0.026s)
[292.877266] Starting dynamic subtest: vecs0
[292.891916] Dynamic subtest vecs0: SUCCESS (0.027s)
[292.905658] Starting dynamic subtest: ccs0
[292.920066] Dynamic subtest ccs0: SUCCESS (0.027s)
[292.922278] Subtest pi-ringfull: SUCCESS (0.168s)
[293.158834] [054/156] (720s left) kms_cdclk (mode-transition)
[293.249195] Starting subtest: mode-transition
[293.251445] Starting dynamic subtest: pipe-A-eDP-1
[293.550306] Dynamic subtest pipe-A-eDP-1: SKIP (0.300s)
[293.562969] Starting dynamic subtest: pipe-B-eDP-1
[293.567566] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[293.576772] Starting dynamic subtest: pipe-C-eDP-1
[293.581298] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[293.590046] Starting dynamic subtest: pipe-D-eDP-1
[293.594478] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[293.598660] Subtest mode-transition: SKIP (0.307s)
[294.402511] [055/156] (718s left) i915_pm_rc6_residency (media-rc6-accuracy)
[294.457521] Starting subtest: media-rc6-accuracy
[294.461467] Subtest media-rc6-accuracy: SKIP (0.000s)
[294.551200] [056/156] (718s left) kms_atomic (crtc-invalid-params)
[294.644127] Starting subtest: crtc-invalid-params
[294.646377] Starting dynamic subtest: pipe-A-eDP-1
[295.006519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.361s)
[295.008663] Subtest crtc-invalid-params: SUCCESS (0.362s)
[295.836244] [057/156] (717s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[295.928259] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[295.930611] Starting dynamic subtest: A-eDP1
[299.593916] Dynamic subtest A-eDP1: SUCCESS (3.661s)
[299.604465] Starting dynamic subtest: B-eDP1
[302.795695] Dynamic subtest B-eDP1: SUCCESS (3.202s)
[302.806519] Starting dynamic subtest: C-eDP1
[306.018063] Dynamic subtest C-eDP1: SUCCESS (3.220s)
[306.028050] Starting dynamic subtest: D-eDP1
[309.254945] Dynamic subtest D-eDP1: SUCCESS (3.233s)
[309.257137] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.326s)
[310.056692] [058/156] (703s left) gem_tiled_swapping (non-threaded)
[310.109933] Subtest non-threaded: SKIP (0.000s)
[310.167305] [059/156] (703s left) kms_panel_fitting (legacy)
[310.261122] Starting subtest: legacy
[310.263255] Starting dynamic subtest: pipe-A-eDP-1
[310.771812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.513s)
[310.799012] Starting dynamic subtest: pipe-B-eDP-1
[312.294669] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.503s)
[312.322211] Starting dynamic subtest: pipe-C-eDP-1
[313.808849] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.494s)
[313.835660] Starting dynamic subtest: pipe-D-eDP-1
[315.334155] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.506s)
[315.336499] Subtest legacy: SUCCESS (5.076s)
[316.601638] [060/156] (696s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[316.695456] Starting subtest: fbcpsr-suspend
[357.433965] Subtest fbcpsr-suspend: SUCCESS (10.186s)
[357.589157] [061/156] (656s left) kms_sequence (queue-idle)
[357.678916] Starting subtest: queue-idle
[357.681126] Starting dynamic subtest: pipe-A-eDP-1
[359.449818] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[359.462832] Starting dynamic subtest: pipe-B-eDP-1
[361.904164] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.503s)
[361.914697] Starting dynamic subtest: pipe-C-eDP-1
[364.389571] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.521s)
[364.400015] Starting dynamic subtest: pipe-D-eDP-1
[366.800881] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.436s)
[366.803100] Subtest queue-idle: SUCCESS (9.283s)
[367.609463] [062/156] (646s left) gem_exec_balancer (full-late-pulse)
[367.670365] Starting subtest: full-late-pulse
[371.853392] Subtest full-late-pulse: SUCCESS (4.210s)
[372.194293] [063/156] (641s left) kms_getfb (getfb2-handle-zero)
[372.308082] Starting subtest: getfb2-handle-zero
[372.310419] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[372.422515] [064/156] (641s left) syncobj_timeline (multi-wait-for-submit-signaled)
[372.488015] Starting subtest: multi-wait-for-submit-signaled
[372.490697] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[372.597000] [065/156] (641s left) syncobj_timeline (wait-all-for-submit-snapshot)
[372.657918] Starting subtest: wait-all-for-submit-snapshot
[372.740637] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[372.827739] [066/156] (640s left) kms_chamelium_frames (hdmi-frame-dump)
[373.205289] Subtest hdmi-frame-dump: SKIP (0.000s)
[373.999985] [067/156] (639s left) gem_exec_balancer (parallel-ordering)
[374.256656] Starting subtest: parallel-ordering
[375.231839] Subtest parallel-ordering: SUCCESS (0.981s)
[375.386045] [068/156] (638s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[375.491968] Starting subtest: hdr-rgb101010-draw-pwrite
[375.496339] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[375.585117] [069/156] (638s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-render)
[375.688818] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-render
[375.693109] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[375.794236] [070/156] (638s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-pgflip-blt)
[375.893055] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-pgflip-blt
[375.897111] Subtest fbcpsrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[375.996729] [071/156] (638s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[376.106220] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[376.110523] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[376.214692] [072/156] (637s left) vgem_slow (nohang)
[376.257641] Starting subtest: nohang
[386.516395] Subtest nohang: SUCCESS (10.274s)
[386.583854] [073/156] (627s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[386.692013] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[386.696080] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[386.784197] [074/156] (627s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[386.876437] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[386.878696] Starting dynamic subtest: pipe-A-eDP-1
[386.901291] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[386.912371] Starting dynamic subtest: pipe-B-eDP-1
[386.934079] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[386.944091] Starting dynamic subtest: pipe-C-eDP-1
[386.965913] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[386.975383] Starting dynamic subtest: pipe-D-eDP-1
[386.997452] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[387.001544] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[389.175266] [075/156] (625s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[389.283868] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[389.288185] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[389.391854] [076/156] (624s left) perf (gen12-group-exclusive-stream-ctx-handle)
[389.522455] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[389.550536] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s)
[389.599208] [077/156] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[391.051497] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[398.334174] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.283s)
[398.495661] [078/156] (615s left) kms_psr (fbc-psr2-cursor-blt)
[398.587141] Starting subtest: fbc-psr2-cursor-blt
[398.589450] Starting dynamic subtest: eDP-1
[398.593643] Dynamic subtest eDP-1: SKIP (0.000s)
[398.598003] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[398.659460] [079/156] (615s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[398.776520] Starting subtest: cursorA-vs-flipB-atomic
[398.781100] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[398.949475] [080/156] (615s left) gem_lmem_swapping (verify-random-ccs)
[398.992139] Subtest verify-random-ccs: SKIP (0.000s)
[399.041192] [081/156] (615s left) gem_wait (invalid-flags)
[399.096457] Starting subtest: invalid-flags
[399.098890] Subtest invalid-flags: SUCCESS (0.000s)
[399.305569] [082/156] (615s left) gem_ccs (block-multicopy-inplace)
[399.366929] Starting subtest: block-multicopy-inplace
[399.371050] Subtest block-multicopy-inplace: SKIP (0.000s)
[399.479726] [083/156] (615s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[399.577195] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[406.353466] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.783s)
[406.496685] [084/156] (608s left) prime_mmap (test_correct_cpu_write)
[406.555802] Starting subtest: test_correct_cpu_write
[406.558511] Starting dynamic subtest: test_correct_cpu_write-smem
[406.560654] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[406.563027] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[406.662831] [085/156] (607s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[406.757897] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[406.762064] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[406.830825] [086/156] (607s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[406.930593] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[406.934893] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[407.049978] [087/156] (607s left) gem_exec_whisper (basic-fds-forked)
[407.106221] Starting subtest: basic-fds-forked
[431.269127] Subtest basic-fds-forked: SUCCESS (24.161s)
[431.471263] [088/156] (583s left) kms_pm_rpm (pc8-residency)
[433.218152] Starting subtest: pc8-residency
[433.223665] Subtest pc8-residency: SKIP (0.000s)
[433.728355] [089/156] (581s left) gem_flink_race (flink_close)
[433.763610] Starting subtest: flink_close
[438.858659] Subtest flink_close: SUCCESS (5.092s)
[438.937486] [090/156] (575s left) gem_render_copy (yf-tiled)
[439.009405] Starting subtest: yf-tiled
[439.013992] Subtest yf-tiled: SKIP (0.000s)
[439.193539] [091/156] (575s left) gem_lmem_evict (dontneed-evict-race)
[439.238278] Subtest dontneed-evict-race: SKIP (0.000s)
[439.282092] [092/156] (575s left) kms_addfb_basic (unused-handle)
[439.335972] Starting subtest: unused-handle
[439.338303] Subtest unused-handle: SUCCESS (0.000s)
[439.479256] [093/156] (575s left) syncobj_wait (single-wait-all-signaled)
[439.526725] Starting subtest: single-wait-all-signaled
[439.529006] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[439.625227] [094/156] (575s left) kms_psr (pr-suspend)
[439.726084] Starting subtest: pr-suspend
[439.730584] Subtest pr-suspend: SKIP (0.000s)
[439.811404] [095/156] (575s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[439.905522] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[439.909691] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[439.996327] [096/156] (575s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[440.060824] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[440.065198] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[440.242061] [097/156] (574s left) i915_drm_fdinfo (busy-hang)
[440.288659] Starting subtest: busy-hang
[440.290630] Starting dynamic subtest: rcs0
[440.307966] Dynamic subtest rcs0: SKIP (0.017s)
[440.321057] Starting dynamic subtest: bcs0
[440.324774] Dynamic subtest bcs0: SKIP (0.001s)
[440.334431] Starting dynamic subtest: vcs0
[440.337817] Dynamic subtest vcs0: SKIP (0.000s)
[440.347200] Starting dynamic subtest: vcs1
[440.350735] Dynamic subtest vcs1: SKIP (0.000s)
[440.359990] Starting dynamic subtest: vecs0
[440.363567] Dynamic subtest vecs0: SKIP (0.000s)
[440.372690] Starting dynamic subtest: ccs0
[440.376388] Dynamic subtest ccs0: SKIP (0.001s)
[440.380069] Subtest busy-hang: SKIP (0.025s)
[440.417585] [098/156] (574s left) syncobj_wait (reset-signaled)
[440.460802] Starting subtest: reset-signaled
[440.462802] Subtest reset-signaled: SUCCESS (0.000s)
[440.543168] [099/156] (574s left) kms_vblank (ts-continuation-idle)
[440.624372] Starting subtest: ts-continuation-idle
[440.626210] Starting dynamic subtest: pipe-A-eDP-1
[441.022177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[441.039511] Starting dynamic subtest: pipe-D-eDP-1
[442.102006] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.076s)
[442.104321] Subtest ts-continuation-idle: SUCCESS (1.478s)
[442.961849] [100/156] (572s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[443.055826] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[443.058124] Starting dynamic subtest: pipe-A-eDP-1
[443.080763] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[443.094379] Starting dynamic subtest: pipe-B-eDP-1
[443.115230] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[443.125860] Starting dynamic subtest: pipe-C-eDP-1
[443.147751] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[443.159614] Starting dynamic subtest: pipe-D-eDP-1
[443.182052] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[443.186632] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[445.340105] [101/156] (569s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[445.448466] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[449.349500] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.912s)
[450.561905] [102/156] (564s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[450.666354] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[450.668647] Starting dynamic subtest: pipe-A-eDP-1
[450.731883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s)
[451.027153] Starting dynamic subtest: pipe-B-eDP-1
[451.832678] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.816s)
[452.137479] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.469s)
[452.982342] [103/156] (562s left) gem_create (create-ext-cpu-access-big)
[453.152992] Starting subtest: create-ext-cpu-access-big
[453.158399] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[453.232875] [104/156] (562s left) gem_exec_fence (syncobj-timeline-wait)
[453.796881] Starting subtest: syncobj-timeline-wait
[455.043680] Subtest syncobj-timeline-wait: SUCCESS (1.246s)
[457.079755] [105/156] (558s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[457.178423] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[457.182582] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[457.283962] [106/156] (558s left) gem_partial_pwrite_pread (reads-display)
[457.341571] Subtest reads-display: SKIP (0.000s)
[457.417693] [107/156] (558s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render)
[457.525197] Starting subtest: fbcpsrhdr-rgb101010-draw-render
[457.529508] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s)
[457.610484] [108/156] (558s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[457.667057] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[457.669464] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[457.783738] [109/156] (557s left) gem_partial_pwrite_pread (write-display)
[457.847127] Subtest write-display: SKIP (0.000s)
[457.918815] [110/156] (557s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[458.015242] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[458.018662] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[458.115300] [111/156] (557s left) gem_mmap_gtt (zero-extend)
[458.167983] Subtest zero-extend: SKIP (0.000s)
[458.228293] [112/156] (557s left) syncobj_wait (invalid-signal-illegal-handle)
[458.287820] Starting subtest: invalid-signal-illegal-handle
[458.290249] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[458.379925] [113/156] (557s left) i915_pm_freq_api (freq-basic-api)
[458.451135] Starting subtest: freq-basic-api
[458.453085] Starting dynamic subtest: gt0
[458.454928] Dynamic subtest gt0: SUCCESS (0.002s)
[458.465874] Starting dynamic subtest: gt1
[458.467543] Dynamic subtest gt1: SUCCESS (0.003s)
[458.469191] Subtest freq-basic-api: SUCCESS (0.007s)
[458.549226] [114/156] (557s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[458.652698] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[465.366054] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.715s)
[465.485418] [115/156] (550s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt)
[465.594005] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt
[465.598264] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[465.696925] [116/156] (550s left) sysfs_timeslice_duration (timeout)
[465.749408] Starting subtest: timeout
[465.751865] Starting dynamic subtest: vecs0
[474.993659] Dynamic subtest vecs0: SUCCESS (9.240s)
[475.007361] Starting dynamic subtest: ccs0
[476.262736] Dynamic subtest ccs0: SUCCESS (1.268s)
[476.273976] Starting dynamic subtest: vcs0
[486.003685] Dynamic subtest vcs0: SUCCESS (9.736s)
[486.015260] Starting dynamic subtest: bcs0
[486.616784] Dynamic subtest bcs0: SUCCESS (0.612s)
[486.626747] Starting dynamic subtest: rcs0
[487.867864] Dynamic subtest rcs0: SUCCESS (1.250s)
[487.878373] Starting dynamic subtest: vcs1
[497.006371] Dynamic subtest vcs1: SUCCESS (9.137s)
[497.008967] Subtest timeout: SUCCESS (31.255s)
[497.084454] [117/156] (518s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[497.184160] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[497.188698] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[497.260402] [118/156] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[497.357398] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[497.361535] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[497.447302] [119/156] (518s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[497.496652] Starting subtest: invalid-multi-wait-all-unsubmitted
[497.498916] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[497.603324] [120/156] (518s left) syncobj_wait (multi-wait-submitted)
[497.667691] Starting subtest: multi-wait-submitted
[497.777886] Subtest multi-wait-submitted: SUCCESS (0.108s)
[497.869773] [121/156] (518s left) gen7_exec_parse (basic-offset)
[497.930412] Subtest basic-offset: SKIP (0.000s)
[498.006335] [122/156] (518s left) gem_mmap_gtt (fault-concurrent)
[498.064552] Subtest fault-concurrent: SKIP (0.000s)
[498.123085] [123/156] (518s left) kms_addfb_basic (addfb25-modifier-no-flag)
[498.221392] Starting subtest: addfb25-modifier-no-flag
[498.223521] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[498.329171] [124/156] (517s left) gem_pxp (create-valid-protected-context)
[498.451883] Starting subtest: create-valid-protected-context
[498.454452] Subtest create-valid-protected-context: SUCCESS (0.002s)
[498.572393] [125/156] (517s left) gem_mmap_gtt (basic-small-bo-tiledx)
[498.638474] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[498.704052] [126/156] (517s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[498.792859] Starting subtest: fbc-pr-cursor-mmap-cpu
[498.796477] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[498.866402] [127/156] (517s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[498.960136] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[498.963522] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[499.056619] [128/156] (517s left) kms_pm_rpm (basic-rte)
[499.089645] Starting subtest: basic-rte
[502.656619] Subtest basic-rte: SUCCESS (3.569s)
[504.466724] [129/156] (512s left) kms_flip (2x-flip-vs-panning)
[504.558045] Starting subtest: 2x-flip-vs-panning
[504.570304] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[504.664697] [130/156] (511s left) gem_flink_basic (bad-flink)
[504.712839] Starting subtest: bad-flink
[504.715075] Subtest bad-flink: SUCCESS (0.000s)
[504.802455] [131/156] (511s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[504.901829] Starting subtest: fbcpsrhdr-tiling-4
[504.906035] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[505.001223] [132/156] (511s left) gem_pwrite_snooped
[505.109628] [133/156] (511s left) gem_ctx_param (invalid-set-no-zeromap)
[505.152810] Starting subtest: invalid-set-no-zeromap
[505.155217] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[505.222995] [134/156] (511s left) kms_psr (psr2-sprite-plane-move)
[505.310509] Starting subtest: psr2-sprite-plane-move
[505.312724] Starting dynamic subtest: eDP-1
[507.079012] Dynamic subtest eDP-1: SUCCESS (1.767s)
[507.081230] Subtest psr2-sprite-plane-move: SUCCESS (1.768s)
[507.916234] [135/156] (508s left) kms_cursor_crc (cursor-alpha-transparent)
[508.013069] Starting subtest: cursor-alpha-transparent
[508.015345] Starting dynamic subtest: pipe-A-eDP-1
[508.646538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s)
[508.658565] Starting dynamic subtest: pipe-D-eDP-1
[509.905378] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[509.907281] Subtest cursor-alpha-transparent: SUCCESS (1.893s)
[510.792819] [136/156] (506s left) kms_joiner (invalid-modeset-ultra-joiner)
[510.887337] Starting subtest: invalid-modeset-ultra-joiner
[510.891235] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[510.957316] [137/156] (505s left) kms_legacy_colorkey (basic)
[511.052047] Starting subtest: basic
[511.054158] Starting dynamic subtest: pipe-A
[511.095529] Dynamic subtest pipe-A: SUCCESS (0.045s)
[511.109864] Starting dynamic subtest: pipe-B
[511.111981] Dynamic subtest pipe-B: SUCCESS (0.000s)
[511.122077] Starting dynamic subtest: pipe-C
[511.124370] Dynamic subtest pipe-C: SUCCESS (0.000s)
[511.136957] Starting dynamic subtest: pipe-D
[511.139101] Dynamic subtest pipe-D: SUCCESS (0.000s)
[511.141184] Subtest basic: SUCCESS (0.051s)
[511.194842] [138/156] (505s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[511.303119] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[511.307194] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[511.401056] [139/156] (505s left) kms_draw_crc (fill-fb)
[511.490011] Starting subtest: fill-fb
[511.930460] Subtest fill-fb: SUCCESS (0.442s)
[512.024330] [140/156] (504s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[512.085714] Starting subtest: invalid-single-wait-all-unsubmitted
[512.087655] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[512.207087] [141/156] (504s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[512.302396] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[512.305847] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[512.395342] [142/156] (504s left) gen9_exec_parse (allowed-single)
[512.444676] Subtest allowed-single: SKIP (0.000s)
[512.513866] [143/156] (504s left) kms_psr (psr-sprite-plane-move)
[512.607519] Starting subtest: psr-sprite-plane-move
[512.609452] Starting dynamic subtest: eDP-1
[514.405601] Dynamic subtest eDP-1: SUCCESS (1.798s)
[514.408017] Subtest psr-sprite-plane-move: SUCCESS (1.799s)
[515.256324] [144/156] (501s left) kms_content_protection (mei-interface)
[515.401302] Starting subtest: mei-interface
[515.406110] Subtest mei-interface: SKIP (0.001s)
[515.525084] [145/156] (501s left) gem_exec_schedule (semaphore-codependency)
[515.588796] Starting subtest: semaphore-codependency
[515.594552] Subtest semaphore-codependency: SUCCESS (0.014s)
[515.945721] [146/156] (501s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt)
[516.046176] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt
[516.050269] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[516.138495] [147/156] (501s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[516.243655] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc
[516.247754] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[516.349573] [148/156] (501s left) kms_cursor_legacy (single-bo)
[516.464646] Starting subtest: single-bo
[516.467006] Starting dynamic subtest: pipe-A
[521.845519] Dynamic subtest pipe-A: SUCCESS (5.379s)
[521.857152] Starting dynamic subtest: pipe-B
[527.228721] Dynamic subtest pipe-B: SUCCESS (5.381s)
[527.243816] Starting dynamic subtest: pipe-C
[532.609725] Dynamic subtest pipe-C: SUCCESS (5.380s)
[532.623033] Starting dynamic subtest: pipe-D
[537.991632] Dynamic subtest pipe-D: SUCCESS (5.380s)
[538.003921] Starting dynamic subtest: all-pipes
[543.381470] Dynamic subtest all-pipes: SUCCESS (5.385s)
[543.383812] Subtest single-bo: SUCCESS (26.919s)
[543.526347] [149/156] (473s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[543.628761] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[548.229903] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.607s)
[549.459118] [150/156] (467s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[549.552190] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[549.556097] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[549.643194] [151/156] (467s left) gem_exec_reloc (basic-cpu-wc)
[549.696017] Subtest basic-cpu-wc: SKIP (0.000s)
[549.768028] [152/156] (467s left) kms_plane_alpha_blend (constant-alpha-min)
[549.854729] Starting subtest: constant-alpha-min
[550.147605] Starting dynamic subtest: pipe-A-eDP-1
[550.858298] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[550.871458] Starting dynamic subtest: pipe-D-eDP-1
[552.331345] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.471s)
[552.333666] Subtest constant-alpha-min: SUCCESS (2.479s)
[553.192360] [153/156] (464s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[553.307188] Starting subtest: fbcpsr-2p-rte
[553.311198] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[553.414711] [154/156] (464s left) gem_linear_blits (interruptible)
[553.674995] Starting subtest: interruptible
[557.668164] Subtest interruptible: SUCCESS (3.993s)
[557.794559] [155/156] (459s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[557.950127] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[557.954149] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[558.032045] [156/156] (459s left) device_reset (unbind-cold-reset-rebind)
[558.083010] Starting subtest: unbind-cold-reset-rebind
[558.088045] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[558.157481] 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.