[58.636072] Initializing watchdogs
[58.636122]   /dev/watchdog0
[58.651369] [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]
[58.656505] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.658822] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.660535] [001/133] (960s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[58.722334] Starting subtest: x-tiled-to-vebox-y-tiled
[58.724196] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[58.893887] [002/133] (960s left) kms_rmfb (rmfb-ioctl)
[58.997226] Starting subtest: rmfb-ioctl
[58.998231] Starting dynamic subtest: pipe-A-eDP-1
[59.112942] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.117s)
[59.120069] Starting dynamic subtest: pipe-B-eDP-1
[60.262645] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s)
[60.271100] Starting dynamic subtest: pipe-C-eDP-1
[61.481376] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.225s)
[61.487119] Starting dynamic subtest: pipe-D-eDP-1
[62.604635] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[62.605669] Subtest rmfb-ioctl: SUCCESS (3.632s)
[63.738261] [003/133] (955s left) kms_pm_rpm (cursor-dpms)
[65.277242] Starting subtest: cursor-dpms
[65.280276] Subtest cursor-dpms: SKIP (0.000s)
[65.970166] [004/133] (953s left) kms_fbcon_fbt (psr)
[66.026932] Starting subtest: psr
[73.389541] Subtest psr: SUCCESS (7.367s)
[73.460897] [005/133] (945s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[73.552241] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[73.553152] Starting dynamic subtest: pipe-A-eDP-1
[73.562103] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[73.568506] Starting dynamic subtest: pipe-B-eDP-1
[73.576989] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.582721] Starting dynamic subtest: pipe-C-eDP-1
[73.591390] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.596821] Starting dynamic subtest: pipe-D-eDP-1
[73.605645] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.607325] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[75.840389] [006/133] (943s left) kms_chamelium_hpd (hdmi-hpd)
[76.233599] Subtest hdmi-hpd: SKIP (0.000s)
[77.054169] [007/133] (942s left) syncobj_timeline (single-wait-signaled)
[77.096787] Starting subtest: single-wait-signaled
[77.097728] Subtest single-wait-signaled: SUCCESS (0.000s)
[77.189267] [008/133] (942s left) i915_suspend (forcewake)
[77.229102] Starting subtest: forcewake
[109.636339] Subtest forcewake: SUCCESS (3.135s)
[115.775318] [009/133] (909s left) gem_userptr_blits (vma-merge)
[115.859358] Starting subtest: vma-merge
[115.903465] Subtest vma-merge: SUCCESS (0.046s)
[116.028960] [010/133] (909s left) i915_hangman (gt-engine-hang)
[116.104240] Starting subtest: gt-engine-hang
[116.105285] Starting dynamic subtest: rcs0
[117.143848] Dynamic subtest rcs0: SUCCESS (1.072s)
[117.153314] Starting dynamic subtest: bcs0
[119.125735] Dynamic subtest bcs0: SUCCESS (2.048s)
[119.135442] Starting dynamic subtest: vcs0
[121.174391] Dynamic subtest vcs0: SUCCESS (2.101s)
[121.183327] Starting dynamic subtest: vcs1
[123.158330] Dynamic subtest vcs1: SUCCESS (2.022s)
[123.168587] Starting dynamic subtest: vecs0
[125.141727] Dynamic subtest vecs0: SUCCESS (2.013s)
[125.149753] Starting dynamic subtest: ccs0
[127.127327] Dynamic subtest ccs0: SUCCESS (2.008s)
[127.128841] Subtest gt-engine-hang: SUCCESS (11.270s)
[127.204519] [011/133] (898s left) gem_lmem_swapping (heavy-multi)
[127.242363] Subtest heavy-multi: SKIP (0.000s)
[127.274474] [012/133] (898s left) prime_vgem (basic-fence-read)
[127.367587] Starting subtest: basic-fence-read
[127.379990] Subtest basic-fence-read: SKIP (0.012s)
[127.471377] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[127.473246] [013/133] (898s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[127.574175] Starting subtest: psr-rgb565-draw-mmap-wc
[134.460394] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.933s)
[134.555669] [014/133] (891s left) kms_prop_blob (blob-prop-lifetime)
[134.607689] Starting subtest: blob-prop-lifetime
[134.609332] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[134.700774] [015/133] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[134.797532] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[138.529241] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.745s)
[139.698674] [016/133] (886s left) kms_psr (psr-primary-page-flip)
[139.787875] Starting subtest: psr-primary-page-flip
[139.789285] Starting dynamic subtest: eDP-1
[141.583674] Dynamic subtest eDP-1: SUCCESS (1.800s)
[141.584965] Subtest psr-primary-page-flip: SUCCESS (1.801s)
[142.442434] [017/133] (883s left) i915_drm_fdinfo (memory-info-resident)
[142.489442] Starting subtest: memory-info-resident
[142.490734] Starting dynamic subtest: smem0
[145.656375] Dynamic subtest smem0: SUCCESS (3.166s)
[145.658262] Subtest memory-info-resident: SUCCESS (3.167s)
[145.736818] [018/133] (880s left) core_getversion (basic)
[145.773641] Starting subtest: basic
[145.776208] Subtest basic: SUCCESS (0.000s)
[145.838414] [019/133] (879s left) intel_hwmon (hwmon-write)
[145.884494] Subtest hwmon-write: SKIP (0.000s)
[145.937720] [020/133] (879s left) gem_mmap_gtt (flink-race)
[145.986754] Subtest flink-race: SKIP (0.000s)
[146.037106] [021/133] (879s left) kms_plane_alpha_blend (constant-alpha-mid)
[146.125311] Starting subtest: constant-alpha-mid
[146.416219] Starting dynamic subtest: pipe-A-eDP-1
[147.316135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.900s)
[147.324731] Starting dynamic subtest: pipe-D-eDP-1
[148.854442] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.536s)
[148.855660] Subtest constant-alpha-mid: SUCCESS (2.730s)
[149.686219] [022/133] (876s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[149.775606] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[149.776636] Starting dynamic subtest: pipe-A-eDP-1
[149.787459] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.794997] Starting dynamic subtest: pipe-B-eDP-1
[149.807444] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.814632] Starting dynamic subtest: pipe-C-eDP-1
[149.824950] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.832128] Starting dynamic subtest: pipe-D-eDP-1
[149.845226] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.847575] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[152.046241] [023/133] (873s left) gem_set_tiling_vs_gtt
[152.162232] [024/133] (873s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[152.246287] Starting subtest: fb-8bpc-vs-panel-8bpc
[152.247636] Starting dynamic subtest: pipe-A-eDP-1
[153.631555] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.386s)
[153.632529] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.387s)
[154.426657] [025/133] (871s left) gem_close (basic)
[154.475428] Starting subtest: basic
[154.476356] Subtest basic: SUCCESS (0.000s)
[154.564077] [026/133] (871s left) gem_ctx_persistence (many-contexts)
[154.614366] Starting subtest: many-contexts
[199.805299] Subtest many-contexts: SUCCESS (45.199s)
[199.875470] [027/133] (826s left) kms_cursor_crc (cursor-offscreen-32x10)
[200.026710] Starting subtest: cursor-offscreen-32x10
[200.070907] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[200.347304] [028/133] (825s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[200.442645] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[200.445651] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[200.534028] [029/133] (825s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[200.634719] Starting subtest: plane-ctm3x4-lut1d
[200.817631] Starting dynamic subtest: pipe-A-plane-0
[201.017743] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[201.025778] Starting dynamic subtest: pipe-A-plane-1
[201.206201] Dynamic subtest pipe-A-plane-1: SUCCESS (0.189s)
[201.213246] Starting dynamic subtest: pipe-A-plane-2
[201.372859] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[202.602551] Starting dynamic subtest: pipe-B-plane-0
[202.771126] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[202.779332] Starting dynamic subtest: pipe-B-plane-1
[202.937607] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[202.945470] Starting dynamic subtest: pipe-B-plane-2
[203.104348] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[204.332414] Starting dynamic subtest: pipe-C-plane-0
[204.469980] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[204.477490] Starting dynamic subtest: pipe-C-plane-1
[204.614459] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[204.622240] Starting dynamic subtest: pipe-C-plane-2
[204.769740] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[205.989896] Starting dynamic subtest: pipe-D-plane-0
[206.149956] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[206.160685] Starting dynamic subtest: pipe-D-plane-1
[206.294567] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[206.302125] Starting dynamic subtest: pipe-D-plane-2
[206.460939] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[206.758604] Subtest plane-ctm3x4-lut1d: SUCCESS (6.126s)
[207.627807] [030/133] (818s left) gem_ctx_bad_destroy (invalid-default-ctx)
[207.685177] Starting subtest: invalid-default-ctx
[207.686351] Subtest invalid-default-ctx: SUCCESS (0.000s)
[207.754719] [031/133] (818s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[207.848609] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[207.850581] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[207.936080] [032/133] (818s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[208.043526] Starting subtest: flip-vs-cursor-varying-size
[217.220948] Subtest flip-vs-cursor-varying-size: SUCCESS (9.170s)
[218.062855] [033/133] (808s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[218.153856] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[218.155825] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[218.243647] [034/133] (808s left) perf (polling-small-buf)
[218.376273] Starting subtest: polling-small-buf
[218.467442] Subtest polling-small-buf: SUCCESS (0.091s)
[218.511714] [035/133] (807s left) syncobj_timeline (invalid-wait-illegal-handle)
[218.558119] Starting subtest: invalid-wait-illegal-handle
[218.559433] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[218.643668] [036/133] (807s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[218.728701] Starting subtest: x-tiled-32bpp-rotate-0
[220.163237] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.435s)
[220.293894] [037/133] (806s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[220.422150] Starting subtest: cursorA-vs-flipA-legacy
[231.554113] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.128s)
[232.395502] [038/133] (794s left) gem_exec_create (madvise)
[232.455102] Starting subtest: madvise
[232.456376] Starting dynamic subtest: smem
[253.239286] Dynamic subtest smem: SUCCESS (20.774s)
[253.240887] Subtest madvise: SUCCESS (20.775s)
[254.072596] [039/133] (772s left) gem_ctx_param (root-set)
[254.131679] Starting subtest: root-set
[254.132982] Subtest root-set: SUCCESS (0.001s)
[254.247584] [040/133] (772s left) gem_ctx_param (set-priority-range)
[254.300682] Starting subtest: set-priority-range
[254.317419] Subtest set-priority-range: SUCCESS (0.017s)
[254.438754] [041/133] (772s left) kms_cursor_edge_walk (64x64-right-edge)
[254.536698] Starting subtest: 64x64-right-edge
[254.537831] Starting dynamic subtest: pipe-A-eDP-1
[257.970407] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.433s)
[257.977881] Starting dynamic subtest: pipe-D-eDP-1
[261.087571] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[261.088744] Subtest 64x64-right-edge: SUCCESS (6.552s)
[261.895263] [042/133] (764s left) kms_prime (basic-modeset-hybrid)
[262.004026] Subtest basic-modeset-hybrid: SKIP (0.000s)
[262.105586] [043/133] (764s left) gem_mmap (basic-small-bo)
[262.155708] Subtest basic-small-bo: SKIP (0.000s)
[262.206177] [044/133] (764s left) kms_dsc (dsc-with-bpc-formats)
[262.295890] Starting subtest: dsc-with-bpc-formats
[262.340394] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[262.368466] [045/133] (764s left) gem_render_copy (yf-tiled-to-vebox-linear)
[262.417946] Starting subtest: yf-tiled-to-vebox-linear
[262.420587] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[262.600953] [046/133] (764s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[262.719596] Starting subtest: flip-vs-cursor-atomic
[270.290584] Subtest flip-vs-cursor-atomic: SUCCESS (7.571s)
[271.125699] [047/133] (755s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[271.215936] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[278.432479] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.219s)
[278.527422] [048/133] (748s left) gem_exec_schedule (submit-golden-slice)
[278.582601] Starting subtest: submit-golden-slice
[278.583573] Starting dynamic subtest: rcs0
[278.622986] Dynamic subtest rcs0: SUCCESS (0.041s)
[278.633473] Starting dynamic subtest: bcs0
[278.662897] Dynamic subtest bcs0: SUCCESS (0.038s)
[278.672194] Starting dynamic subtest: vcs0
[278.693261] Dynamic subtest vcs0: SUCCESS (0.030s)
[278.700823] Starting dynamic subtest: vcs1
[278.733249] Dynamic subtest vcs1: SUCCESS (0.039s)
[278.741195] Starting dynamic subtest: vecs0
[278.768629] Dynamic subtest vecs0: SUCCESS (0.035s)
[278.778277] Starting dynamic subtest: ccs0
[278.804870] Dynamic subtest ccs0: SUCCESS (0.035s)
[278.806676] Subtest submit-golden-slice: SUCCESS (0.223s)
[280.262625] [049/133] (746s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[280.362729] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[281.385360] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.024s)
[281.491003] [050/133] (745s left) gem_exec_flush (basic-wb-prw-default)
[281.549933] Starting subtest: basic-wb-prw-default
[287.017041] Subtest basic-wb-prw-default: SUCCESS (5.467s)
[287.206430] [051/133] (739s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[287.810890] Starting subtest: syncobj-stationary-timeline-chain-engines
[287.968315] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.157s)
[289.235415] [052/133] (737s left) kms_big_fb (linear-16bpp-rotate-270)
[289.341974] Starting subtest: linear-16bpp-rotate-270
[289.362425] Subtest linear-16bpp-rotate-270: SKIP (0.020s)
[289.461793] [053/133] (737s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[289.551938] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[289.553205] Starting dynamic subtest: pipe-A-eDP-1
[289.576812] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[289.585448] Starting dynamic subtest: pipe-B-eDP-1
[289.610194] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[289.617167] Starting dynamic subtest: pipe-C-eDP-1
[289.642086] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[289.649965] Starting dynamic subtest: pipe-D-eDP-1
[289.672057] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[289.673607] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[291.803223] [054/133] (735s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[291.886216] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[291.887270] Starting dynamic subtest: pipe-A-eDP-1
[302.607598] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.725s)
[302.616144] Starting dynamic subtest: pipe-B-eDP-1
[314.045785] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.440s)
[314.046797] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.168s)
[314.887285] [055/133] (712s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[314.994782] Starting subtest: short-flip-before-cursor-atomic-transitions
[315.942391] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.946s)
[316.815371] [056/133] (710s left) perf_pmu (init-busy)
[316.859449] Starting subtest: init-busy
[316.860516] Starting dynamic subtest: rcs0
[316.861435] Dynamic subtest rcs0: SUCCESS (0.001s)
[316.868840] Starting dynamic subtest: bcs0
[316.877987] Dynamic subtest bcs0: SUCCESS (0.000s)
[316.888410] Starting dynamic subtest: vcs0
[316.889626] Dynamic subtest vcs0: SUCCESS (0.001s)
[316.896959] Starting dynamic subtest: vcs1
[316.898244] Dynamic subtest vcs1: SUCCESS (0.001s)
[316.905597] Starting dynamic subtest: vecs0
[316.906697] Dynamic subtest vecs0: SUCCESS (0.001s)
[316.913956] Starting dynamic subtest: ccs0
[316.915353] Dynamic subtest ccs0: SUCCESS (0.001s)
[316.916576] Subtest init-busy: SUCCESS (0.010s)
[316.965368] [057/133] (710s left) kms_invalid_mode (bad-vsync-start)
[317.065174] Starting subtest: bad-vsync-start
[317.066131] Starting dynamic subtest: pipe-A-eDP-1
[317.351239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[317.359943] Starting dynamic subtest: pipe-B-eDP-1
[317.360754] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[317.367706] Starting dynamic subtest: pipe-C-eDP-1
[317.368489] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[317.375474] Starting dynamic subtest: pipe-D-eDP-1
[317.376418] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[317.377243] Subtest bad-vsync-start: SUCCESS (0.294s)
[318.149396] [058/133] (709s left) kms_flip (flip-vs-absolute-wf_vblank)
[318.232386] Starting subtest: flip-vs-absolute-wf_vblank
[318.233767] Starting dynamic subtest: A-eDP1
[327.197557] Dynamic subtest A-eDP1: SUCCESS (8.968s)
[327.207273] Starting dynamic subtest: B-eDP1
[336.131256] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[336.141403] Starting dynamic subtest: C-eDP1
[345.091582] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[345.102335] Starting dynamic subtest: D-eDP1
[354.029252] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[354.030628] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.759s)
[355.120767] [059/133] (672s left) gem_ppgtt (flink-and-close-vma-leak)
[355.169844] Starting subtest: flink-and-close-vma-leak
[355.213359] Subtest flink-and-close-vma-leak: SUCCESS (0.043s)
[355.334878] [060/133] (671s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[355.427495] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[355.429410] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[355.514616] [061/133] (671s left) kms_plane_multiple (tiling-4)
[355.601579] Starting subtest: tiling-4
[355.602560] Starting dynamic subtest: pipe-A-eDP-1
[359.262302] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.658s)
[359.270108] Starting dynamic subtest: pipe-B-eDP-1
[363.823675] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.560s)
[363.831804] Starting dynamic subtest: pipe-C-eDP-1
[368.231603] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.405s)
[368.239661] Starting dynamic subtest: pipe-D-eDP-1
[372.667443] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.434s)
[372.668350] Subtest tiling-4: SUCCESS (17.062s)
[373.473694] [062/133] (653s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[373.568127] Starting subtest: plane-upscale-20x20-with-pixel-format
[373.569436] Starting dynamic subtest: pipe-A
[374.639466] Dynamic subtest pipe-A: SUCCESS (1.072s)
[374.647461] Starting dynamic subtest: pipe-B
[376.811685] Dynamic subtest pipe-B: SUCCESS (2.171s)
[376.819678] Starting dynamic subtest: pipe-C
[377.985813] Dynamic subtest pipe-C: SUCCESS (1.173s)
[377.998237] Starting dynamic subtest: pipe-D
[379.215698] Dynamic subtest pipe-D: SUCCESS (1.228s)
[379.216981] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.648s)
[380.413633] [063/133] (646s left) gem_bad_reloc (negative-reloc)
[380.463203] Subtest negative-reloc: SKIP (0.000s)
[380.526184] [064/133] (646s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[380.620830] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[380.623263] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[380.708013] [065/133] (646s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[380.800197] Starting subtest: yf-tiled-addfb-size-overflow
[380.801933] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[380.916790] [066/133] (646s left) gem_pxp (create-valid-protected-context)
[381.030628] Starting subtest: create-valid-protected-context
[381.032193] Subtest create-valid-protected-context: SUCCESS (0.002s)
[381.142737] [067/133] (646s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[381.232482] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[382.292307] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.060s)
[382.411159] [068/133] (645s left) gem_userptr_blits (process-exit-busy)
[382.476969] Starting subtest: process-exit-busy
[382.490438] Subtest process-exit-busy: SUCCESS (0.013s)
[382.617522] [069/133] (644s left) kms_chamelium_edid (hdmi-mode-timings)
[382.995685] Subtest hdmi-mode-timings: SKIP (0.000s)
[383.802416] [070/133] (643s left) gem_ctx_isolation (clean)
[383.859371] Starting subtest: clean
[383.860545] Starting dynamic subtest: rcs0
[383.905788] Dynamic subtest rcs0: SUCCESS (0.046s)
[383.915480] Starting dynamic subtest: bcs0
[383.962256] Dynamic subtest bcs0: SUCCESS (0.055s)
[383.971733] Starting dynamic subtest: vcs0
[383.999870] Dynamic subtest vcs0: SUCCESS (0.037s)
[384.008143] Starting dynamic subtest: vcs1
[385.233065] Dynamic subtest vcs1: SUCCESS (1.232s)
[385.247388] Starting dynamic subtest: vecs0
[387.184489] Dynamic subtest vecs0: SUCCESS (1.950s)
[387.194513] Starting dynamic subtest: ccs0
[389.170372] Dynamic subtest ccs0: SUCCESS (1.985s)
[389.171649] Subtest clean: SUCCESS (5.312s)
[389.390517] [071/133] (638s left) perf (blocking)
[389.488526] Starting subtest: blocking
[389.489612] Starting dynamic subtest: 0-rcs0
[399.543879] Dynamic subtest 0-rcs0: SUCCESS (10.010s)
[399.553469] Starting dynamic subtest: 1-vcs1
[409.528681] Dynamic subtest 1-vcs1: SUCCESS (10.019s)
[409.529753] Subtest blocking: SUCCESS (20.032s)
[409.571567] [072/133] (618s left) gem_ctx_sseu (invalid-sseu)
[409.624597] Subtest invalid-sseu: SKIP (0.000s)
[409.689111] [073/133] (618s left) kms_content_protection (mei-interface)
[409.836679] Starting subtest: mei-interface
[409.839544] Subtest mei-interface: SKIP (0.001s)
[409.947207] [074/133] (617s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[410.042667] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[414.463973] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.422s)
[415.648486] [075/133] (612s left) kms_atomic_transition (modeset-transition-nonblocking)
[415.736461] Starting subtest: modeset-transition-nonblocking
[415.737567] Starting dynamic subtest: 1x-outputs
[426.841788] Dynamic subtest 1x-outputs: SUCCESS (11.107s)
[426.843407] Subtest modeset-transition-nonblocking: SUCCESS (11.108s)
[427.687426] [076/133] (600s left) kms_psr (fbc-psr2-cursor-plane-move)
[427.778705] Starting subtest: fbc-psr2-cursor-plane-move
[427.780136] Starting dynamic subtest: eDP-1
[427.782482] Dynamic subtest eDP-1: SKIP (0.000s)
[427.784393] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[427.858364] [077/133] (600s left) gem_exec_balancer (bonded-dual)
[427.920341] Starting subtest: bonded-dual
[427.923589] Subtest bonded-dual: SKIP (0.000s)
[428.214995] [078/133] (599s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[428.313783] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[428.316070] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[428.400416] [079/133] (599s left) kms_frontbuffer_tracking (psr-slowdraw)
[428.502204] Starting subtest: psr-slowdraw
[453.747518] Subtest psr-slowdraw: SUCCESS (25.248s)
[453.857326] [080/133] (574s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[454.042792] Starting subtest: cursor-rapid-movement-64x64
[454.047473] Starting dynamic subtest: pipe-A-eDP-1
[454.587170] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[454.619257] Starting dynamic subtest: pipe-D-eDP-1
[455.825292] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[455.826617] Subtest cursor-rapid-movement-64x64: SUCCESS (1.781s)
[456.659571] [081/133] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[456.746319] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[456.748602] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[456.830515] [082/133] (571s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[456.917663] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[456.945218] Starting dynamic subtest: pipe-A-plane-0
[457.244715] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[457.254351] Starting dynamic subtest: pipe-A-plane-3
[457.478571] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[457.486737] Starting dynamic subtest: pipe-A-plane-5
[457.489280] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[458.559084] Starting dynamic subtest: pipe-B-plane-0
[458.862725] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[458.870679] Starting dynamic subtest: pipe-B-plane-3
[459.107364] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[459.115720] Starting dynamic subtest: pipe-B-plane-5
[459.118347] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[459.414820] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.498s)
[460.238225] [083/133] (567s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[460.289272] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[460.290473] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[460.381548] [084/133] (567s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[460.437232] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[460.438555] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[460.540615] [085/133] (567s left) gen9_exec_parse (batch-invalid-length)
[460.584623] Subtest batch-invalid-length: SKIP (0.000s)
[460.645505] [086/133] (567s left) gem_ccs (large-ctrl-surf-copy)
[460.692848] Starting subtest: large-ctrl-surf-copy
[460.695537] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[460.781270] [087/133] (567s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[460.880507] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[460.882499] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[460.976385] [088/133] (567s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[461.064535] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[461.066448] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[461.156320] [089/133] (567s left) gem_exec_schedule (noreorder-priority)
[461.346720] Starting subtest: noreorder-priority
[461.347948] Starting dynamic subtest: rcs0
[462.477953] Dynamic subtest rcs0: SUCCESS (1.139s)
[462.488305] Starting dynamic subtest: vcs0
[464.180250] Dynamic subtest vcs0: SUCCESS (1.691s)
[464.189913] Starting dynamic subtest: vcs1
[466.146511] Dynamic subtest vcs1: SUCCESS (1.963s)
[466.160686] Starting dynamic subtest: vecs0
[468.126329] Dynamic subtest vecs0: SUCCESS (1.977s)
[468.135792] Starting dynamic subtest: ccs0
[469.267946] Dynamic subtest ccs0: SUCCESS (1.150s)
[469.269375] Subtest noreorder-priority: SUCCESS (7.932s)
[469.457422] [090/133] (558s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[469.554549] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[469.556409] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[469.644821] [091/133] (558s left) kms_chamelium_color (ctm-blue-to-red)
[469.739992] Subtest ctm-blue-to-red: SKIP (0.000s)
[469.780824] [092/133] (558s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[469.871862] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[469.874209] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[469.955336] [093/133] (558s left) sysfs_heartbeat_interval (precise)
[470.012475] Starting subtest: precise
[470.013635] Starting dynamic subtest: vecs0
[477.166477] Dynamic subtest vecs0: SUCCESS (7.154s)
[477.178431] Starting dynamic subtest: ccs0
[478.237821] Dynamic subtest ccs0: SUCCESS (1.067s)
[478.247715] Starting dynamic subtest: vcs0
[486.194818] Dynamic subtest vcs0: SUCCESS (7.950s)
[486.204343] Starting dynamic subtest: bcs0
[487.253991] Dynamic subtest bcs0: SUCCESS (1.065s)
[487.264364] Starting dynamic subtest: rcs0
[488.339216] Dynamic subtest rcs0: SUCCESS (1.084s)
[488.350956] Starting dynamic subtest: vcs1
[496.166163] Dynamic subtest vcs1: SUCCESS (7.826s)
[496.167712] Subtest precise: SUCCESS (26.159s)
[496.247176] [094/133] (532s left) gem_softpin (allocator-evict)
[496.303211] Starting subtest: allocator-evict
[496.304657] Starting dynamic subtest: rcs0
[520.428364] Dynamic subtest rcs0: SUCCESS (24.129s)
[520.438821] Starting dynamic subtest: bcs0
[544.141258] Dynamic subtest bcs0: SUCCESS (23.716s)
[544.157244] Starting dynamic subtest: vcs0
[567.977895] Dynamic subtest vcs0: SUCCESS (23.839s)
[567.989233] Starting dynamic subtest: vcs1
[591.897993] Dynamic subtest vcs1: SUCCESS (23.924s)
[591.907571] Starting dynamic subtest: vecs0
[615.946788] Dynamic subtest vecs0: SUCCESS (24.026s)
[615.957675] Starting dynamic subtest: ccs0
[639.540392] Dynamic subtest ccs0: SUCCESS (23.579s)
[639.541876] Subtest allocator-evict: SUCCESS (143.224s)
[639.628027] [095/133] (388s left) kms_vrr (lobf)
[639.793704] Starting subtest: lobf
[639.796577] Subtest lobf: SKIP (0.000s)
[639.884903] [096/133] (388s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[639.985783] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[644.283494] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.297s)
[645.436463] [097/133] (383s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[645.534736] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[652.671297] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.136s)
[652.829453] [098/133] (375s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[652.930982] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[659.764616] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.831s)
[659.887377] [099/133] (368s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[659.982266] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[667.399505] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.416s)
[667.529870] [100/133] (361s left) kms_psr (fbc-pr-primary-blt)
[667.620838] Starting subtest: fbc-pr-primary-blt
[667.622525] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[667.689430] [101/133] (361s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[667.778811] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[667.780586] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[667.847857] [102/133] (360s left) syncobj_wait (single-wait-all-for-submit-submitted)
[667.905842] Starting subtest: single-wait-all-for-submit-submitted
[668.010755] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[668.084377] [103/133] (360s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[668.129210] Starting subtest: invalid-single-wait-all-unsubmitted
[668.130550] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[668.218079] [104/133] (360s left) gem_exec_capture (capture)
[668.280389] Starting subtest: capture
[668.281539] Starting dynamic subtest: rcs0-smem
[669.120398] Dynamic subtest rcs0-smem: SUCCESS (0.838s)
[669.129698] Starting dynamic subtest: bcs0-smem
[669.942540] Dynamic subtest bcs0-smem: SUCCESS (0.823s)
[669.952268] Starting dynamic subtest: vcs0-smem
[670.774420] Dynamic subtest vcs0-smem: SUCCESS (0.830s)
[670.783941] Starting dynamic subtest: vcs1-smem
[672.104346] Dynamic subtest vcs1-smem: SUCCESS (1.330s)
[672.114761] Starting dynamic subtest: vecs0-smem
[672.952325] Dynamic subtest vecs0-smem: FAIL (0.824s)
[672.960433] Starting dynamic subtest: ccs0-smem
[674.262013] Dynamic subtest ccs0-smem: SUCCESS (1.330s)
[674.262790] Subtest capture: FAIL (5.980s)
[674.372064] [105/133] (354s left) gem_exec_reloc (basic-cpu)
[674.428203] Subtest basic-cpu: SKIP (0.000s)
[674.495739] [106/133] (354s left) syncobj_timeline (device-signal-unordered)
[674.540881] Starting subtest: device-signal-unordered
[674.542313] Subtest device-signal-unordered: SUCCESS (0.000s)
[674.636158] [107/133] (354s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[674.734681] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[674.736818] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[674.843769] [108/133] (354s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[674.951628] Starting subtest: 2x-long-cursor-vs-flip-atomic
[674.955697] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[675.094225] [109/133] (353s left) gem_eio (throttle)
[675.299187] Starting subtest: throttle
[675.568127] Subtest throttle: SUCCESS (0.268s)
[675.680204] [110/133] (353s left) api_intel_allocator (gem-pool)
[675.729345] Starting subtest: gem-pool
[675.737476] Subtest gem-pool: SUCCESS (0.009s)
[675.846840] [111/133] (353s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[675.942446] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[683.271270] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.327s)
[683.395929] [112/133] (345s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[683.454277] Starting subtest: single-wait-for-submit-unsubmitted
[683.554647] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[683.642826] [113/133] (345s left) kms_vblank (query-forked-busy)
[683.726738] Starting subtest: query-forked-busy
[683.727944] Starting dynamic subtest: pipe-A-eDP-1
[685.613591] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[685.624633] Starting dynamic subtest: pipe-D-eDP-1
[688.210419] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.594s)
[688.211631] Subtest query-forked-busy: SUCCESS (4.483s)
[689.003833] [114/133] (340s left) kms_psr (psr2-suspend)
[689.102636] Starting subtest: psr2-suspend
[689.103813] Starting dynamic subtest: eDP-1
[708.046262] Dynamic subtest eDP-1: SUCCESS (3.317s)
[708.047181] Subtest psr2-suspend: SUCCESS (3.318s)
[714.852366] [115/133] (320s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[714.959484] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[714.960437] Starting dynamic subtest: pipe-A-default-mode
[717.611615] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s)
[717.612540] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.751s)
[718.420941] [116/133] (316s left) kms_vblank (invalid)
[718.507647] Starting subtest: invalid
[718.508488] Starting dynamic subtest: pipe-A-eDP-1
[718.909121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.411s)
[718.910047] Subtest invalid: SUCCESS (0.412s)
[719.735338] [117/133] (315s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[719.817547] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[719.818504] Starting dynamic subtest: pipe-A
[719.836268] Dynamic subtest pipe-A: SKIP (0.017s)
[719.846358] Starting dynamic subtest: pipe-B
[719.867017] Dynamic subtest pipe-B: SKIP (0.032s)
[719.875101] Starting dynamic subtest: pipe-C
[719.899202] Dynamic subtest pipe-C: SKIP (0.032s)
[719.907172] Starting dynamic subtest: pipe-D
[719.930939] Dynamic subtest pipe-D: SKIP (0.032s)
[719.932605] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.115s)
[720.034620] [118/133] (315s left) gem_exec_nop (basic-sequential)
[720.093271] Starting subtest: basic-sequential
[735.263816] Subtest basic-sequential: SUCCESS (15.317s)
[735.482741] [119/133] (299s left) kms_psr (psr2-basic)
[735.587546] Starting subtest: psr2-basic
[735.588567] Starting dynamic subtest: eDP-1
[737.255561] Dynamic subtest eDP-1: SUCCESS (1.672s)
[737.256415] Subtest psr2-basic: SUCCESS (1.673s)
[738.070590] [120/133] (297s left) gem_mmap_gtt (close-race)
[738.129220] Subtest close-race: SKIP (0.000s)
[738.194524] [121/133] (297s left) gem_ctx_param (invalid-ctx-get)
[738.249006] Starting subtest: invalid-ctx-get
[738.250001] Subtest invalid-ctx-get: SUCCESS (0.000s)
[738.323445] [122/133] (297s left) kms_psr (fbc-psr-primary-page-flip)
[738.436094] Starting subtest: fbc-psr-primary-page-flip
[738.437121] Starting dynamic subtest: eDP-1
[738.439130] Dynamic subtest eDP-1: SKIP (0.000s)
[738.440859] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[738.518963] [123/133] (297s left) kms_legacy_colorkey (basic)
[738.819018] Starting subtest: basic
[738.820131] Starting dynamic subtest: pipe-A
[738.862642] Dynamic subtest pipe-A: SUCCESS (0.045s)
[738.873001] Starting dynamic subtest: pipe-B
[738.874123] Dynamic subtest pipe-B: SUCCESS (0.001s)
[738.882414] Starting dynamic subtest: pipe-C
[738.883440] Dynamic subtest pipe-C: SUCCESS (0.000s)
[738.891964] Starting dynamic subtest: pipe-D
[738.893003] Dynamic subtest pipe-D: SUCCESS (0.000s)
[738.894045] Subtest basic: SUCCESS (0.051s)
[738.959735] [124/133] (296s left) kms_flip (dpms-vs-vblank-race)
[739.331731] Starting subtest: dpms-vs-vblank-race
[739.334113] Starting dynamic subtest: A-eDP1
[744.329252] Dynamic subtest A-eDP1: SUCCESS (5.003s)
[744.337815] Starting dynamic subtest: B-eDP1
[748.965125] Dynamic subtest B-eDP1: SUCCESS (4.638s)
[748.976277] Starting dynamic subtest: C-eDP1
[753.583385] Dynamic subtest C-eDP1: SUCCESS (4.614s)
[753.592786] Starting dynamic subtest: D-eDP1
[758.232472] Dynamic subtest D-eDP1: SUCCESS (4.644s)
[758.234088] Subtest dpms-vs-vblank-race: SUCCESS (18.909s)
[759.113627] [125/133] (276s left) api_intel_bb (offset-control)
[759.167216] Starting subtest: offset-control
[759.173858] Subtest offset-control: SUCCESS (0.007s)
[759.292030] [126/133] (276s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[759.383457] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[759.385291] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[759.466163] [127/133] (276s left) kms_properties (crtc-properties-atomic)
[759.546861] Starting subtest: crtc-properties-atomic
[759.547864] Starting dynamic subtest: pipe-A-eDP-1
[759.986474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[759.995225] Starting dynamic subtest: pipe-B-eDP-1
[761.165001] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.176s)
[761.173930] Starting dynamic subtest: pipe-C-eDP-1
[762.276510] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[762.284661] Starting dynamic subtest: pipe-D-eDP-1
[763.418575] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[763.419779] Subtest crtc-properties-atomic: SUCCESS (3.871s)
[764.227937] [128/133] (271s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[764.322954] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[764.323967] Starting dynamic subtest: pipe-A-eDP-1
[764.345597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[764.357460] Starting dynamic subtest: pipe-B-eDP-1
[764.369170] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[764.378634] Starting dynamic subtest: pipe-C-eDP-1
[764.392996] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[764.402762] Starting dynamic subtest: pipe-D-eDP-1
[764.416247] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[764.417125] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[766.671076] [129/133] (269s left) gem_exec_whisper (basic-contexts-priority-all)
[766.729589] Starting subtest: basic-contexts-priority-all
[788.004096] Subtest basic-contexts-priority-all: SUCCESS (21.268s)
[788.182199] [130/133] (247s left) gem_softpin (noreloc-s3)
[788.237389] Starting subtest: noreloc-S3
[809.362225] Subtest noreloc-S3: SUCCESS (5.433s)
[812.531842] [131/133] (226s left) i915_pm_rps (min-max-config-idle)
[812.590675] Starting subtest: min-max-config-idle
[812.592367] Subtest min-max-config-idle: SKIP (0.001s)
[812.675173] [132/133] (226s left) gem_exec_params (invalid-batch-start-offset)
[812.733254] Starting subtest: invalid-batch-start-offset
[812.735194] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[812.845618] [133/133] (226s left) prime_self_import (basic-with_fd_dup)
[812.878298] Starting subtest: basic-with_fd_dup
[812.895683] Subtest basic-with_fd_dup: SUCCESS (0.018s)
[812.998482] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy
results: parsing output: 1/ for test: kms_rmfb
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_fbcon_fbt
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: i915_suspend
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: i915_hangman
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: prime_vgem
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_prop_blob
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: i915_drm_fdinfo
results: parsing output: 17/ for test: core_getversion
results: parsing output: 18/ for test: intel_hwmon
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_plane_alpha_blend
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_set_tiling_vs_gtt
results: parsing output: 23/ for test: kms_dither
results: parsing output: 24/ for test: gem_close
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_color_pipeline
results: parsing output: 29/ for test: gem_ctx_bad_destroy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: gem_exec_create
results: parsing output: 38/ for test: gem_ctx_param
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_cursor_edge_walk
results: parsing output: 41/ for test: kms_prime
results: parsing output: 42/ for test: gem_mmap
results: parsing output: 43/ for test: kms_dsc
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_exec_flush
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_invalid_mode
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_ppgtt
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_plane_multiple
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: gem_bad_reloc
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_chamelium_edid
results: parsing output: 69/ for test: gem_ctx_isolation
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: gem_ctx_sseu
results: parsing output: 72/ for test: kms_content_protection
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_atomic_transition
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_plane
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gen9_exec_parse
results: parsing output: 85/ for test: gem_ccs
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_chamelium_color
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: sysfs_heartbeat_interval
results: parsing output: 93/ for test: gem_softpin
results: parsing output: 94/ for test: kms_vrr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_flip_scaled_crc
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: gem_exec_capture
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: gem_exec_nop
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: gem_ctx_param
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_legacy_colorkey
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_properties
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: i915_pm_rps
results: parsing output: 131/ for test: gem_exec_params
results: parsing output: 132/ for test: prime_self_import
Done.