[56.548082] Initializing watchdogs
[56.548132]   /dev/watchdog0
[56.563198] [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]
[56.568263] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.570898] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.574633] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[56.702702] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[56.707266] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[56.795315] [002/133] (960s left) gem_exec_schedule (u-lateslice)
[56.867232] Starting subtest: u-lateslice
[56.869253] Starting dynamic subtest: rcs0
[56.880635] Dynamic subtest rcs0: SUCCESS (0.022s)
[56.891430] Starting dynamic subtest: bcs0
[56.898885] Dynamic subtest bcs0: SUCCESS (0.018s)
[56.910424] Starting dynamic subtest: vcs0
[56.917284] Dynamic subtest vcs0: SUCCESS (0.018s)
[56.926146] Starting dynamic subtest: vcs1
[56.936310] Dynamic subtest vcs1: SUCCESS (0.018s)
[56.943739] Starting dynamic subtest: vecs0
[56.951657] Dynamic subtest vecs0: SUCCESS (0.015s)
[56.959195] Starting dynamic subtest: ccs0
[56.969451] Dynamic subtest ccs0: SUCCESS (0.017s)
[56.971914] Subtest u-lateslice: SUCCESS (0.109s)
[58.380428] [003/133] (958s left) perf (oa-formats)
[58.498784] Starting subtest: oa-formats
[58.500761] Starting dynamic subtest: 0-rcs0
[58.512134] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[58.520769] Starting dynamic subtest: 1-vcs1
[58.534065] Dynamic subtest 1-vcs1: SUCCESS (0.021s)
[58.536354] Subtest oa-formats: SUCCESS (0.037s)
[58.581672] [004/133] (958s left) kms_pm_rpm (system-suspend-idle)
[60.460547] Starting subtest: system-suspend-idle
[80.224990] Subtest system-suspend-idle: SUCCESS (4.596s)
[80.606079] [005/133] (936s left) kms_scaling_modes (scaling-mode-full-aspect)
[80.717508] Starting subtest: scaling-mode-full-aspect
[80.719658] Starting dynamic subtest: pipe-A-eDP-1
[80.875951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.156s)
[80.886514] Starting dynamic subtest: pipe-B-eDP-1
[82.048579] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.149s)
[82.061212] Starting dynamic subtest: pipe-C-eDP-1
[83.189321] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[83.201307] Starting dynamic subtest: pipe-D-eDP-1
[84.344707] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[84.347075] Subtest scaling-mode-full-aspect: SUCCESS (3.573s)
[85.508038] [006/133] (931s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[85.617914] Starting subtest: y-tiled-16bpp-rotate-90
[85.622556] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[85.709985] [007/133] (931s left) gem_exec_schedule (preempt-other-chain)
[85.791485] Starting subtest: preempt-other-chain
[85.793432] Starting dynamic subtest: rcs0
[85.879715] Dynamic subtest rcs0: SUCCESS (0.090s)
[85.891508] Starting dynamic subtest: bcs0
[85.973109] Dynamic subtest bcs0: SUCCESS (0.092s)
[85.984092] Starting dynamic subtest: vcs0
[86.062987] Dynamic subtest vcs0: SUCCESS (0.088s)
[86.077899] Starting dynamic subtest: vcs1
[86.143504] Dynamic subtest vcs1: SUCCESS (0.079s)
[86.160428] Starting dynamic subtest: vecs0
[86.226260] Dynamic subtest vecs0: SUCCESS (0.082s)
[86.238190] Starting dynamic subtest: ccs0
[86.314800] Dynamic subtest ccs0: SUCCESS (0.088s)
[86.317723] Subtest preempt-other-chain: SUCCESS (0.522s)
[87.503067] [008/133] (929s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[87.798568] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[87.889857] [009/133] (929s left) kms_flip (basic-flip-vs-wf_vblank)
[88.162145] Starting subtest: basic-flip-vs-wf_vblank
[88.164616] Starting dynamic subtest: A-eDP1
[90.099422] Dynamic subtest A-eDP1: SUCCESS (1.926s)
[90.110521] Starting dynamic subtest: B-eDP1
[92.040305] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[92.051264] Starting dynamic subtest: C-eDP1
[93.961836] Dynamic subtest C-eDP1: SUCCESS (1.912s)
[93.972675] Starting dynamic subtest: D-eDP1
[95.895475] Dynamic subtest D-eDP1: SUCCESS (1.926s)
[95.900654] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.702s)
[97.157548] [010/133] (920s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[97.264806] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[97.267021] Starting dynamic subtest: pipe-A-eDP-1
[103.119195] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.844s)
[103.131458] Starting dynamic subtest: pipe-B-eDP-1
[109.796230] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.669s)
[109.798616] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.515s)
[110.676167] [011/133] (906s left) vgem_basic (unload)
[110.726625] Starting subtest: unload
[139.777590] Subtest unload: SUCCESS (29.050s)
[139.871549] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[139.875315] [012/133] (877s left) gem_mmap_wc (write-read-distinct)
[139.943475] Subtest write-read-distinct: SKIP (0.000s)
[140.000233] [013/133] (877s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[140.052172] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[140.107254] [014/133] (877s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[140.210709] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[141.035170] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[141.211064] [015/133] (876s left) kms_psr (pr-primary-mmap-gtt)
[141.310401] Starting subtest: pr-primary-mmap-gtt
[141.314895] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[141.386052] [016/133] (876s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[141.504256] Starting subtest: flip-vs-cursor-atomic-transitions
[149.202472] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.694s)
[150.011409] [017/133] (867s left) i915_pciid
[150.151917] [018/133] (867s left) kms_flip (2x-flip-vs-panning-interruptible)
[150.248594] Starting subtest: 2x-flip-vs-panning-interruptible
[150.259843] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[150.340046] [019/133] (867s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[150.431132] Starting subtest: read-crc-frame-sequence
[150.433557] Starting dynamic subtest: pipe-A-eDP-1
[151.132815] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s)
[151.143201] Starting dynamic subtest: pipe-B-eDP-1
[152.491013] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.357s)
[152.500690] Starting dynamic subtest: pipe-C-eDP-1
[153.796264] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.303s)
[153.808476] Starting dynamic subtest: pipe-D-eDP-1
[155.126372] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[155.128702] Subtest read-crc-frame-sequence: SUCCESS (4.695s)
[155.951624] [020/133] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[156.059484] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[156.063943] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[156.158782] [021/133] (861s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[156.253032] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[160.261331] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.011s)
[161.469114] [022/133] (856s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[161.850872] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[162.664116] [023/133] (855s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[162.782283] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[167.042781] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.262s)
[168.204926] [024/133] (849s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[168.321881] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[175.179697] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.862s)
[175.296294] [025/133] (842s left) kms_atomic_interruptible (atomic-setmode)
[175.389313] Starting subtest: atomic-setmode
[175.391514] Starting dynamic subtest: pipe-A-eDP-1
[182.272484] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.884s)
[182.274915] Subtest atomic-setmode: SUCCESS (6.885s)
[183.065589] [026/133] (835s left) syncobj_wait (single-wait-for-submit-signaled)
[183.118628] Starting subtest: single-wait-for-submit-signaled
[183.120952] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[183.218577] [027/133] (834s left) api_intel_allocator (fork-simple-stress-signal)
[183.275105] Starting subtest: fork-simple-stress-signal
[188.679079] Subtest fork-simple-stress-signal: SUCCESS (5.404s)
[188.798827] [028/133] (829s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[188.909832] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[188.914823] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[188.983076] [029/133] (829s left) sysfs_timeslice_duration (duration)
[189.049199] Starting subtest: duration
[189.051485] Starting dynamic subtest: vecs0
[202.336521] Dynamic subtest vecs0: SUCCESS (13.285s)
[202.346322] Starting dynamic subtest: ccs0
[215.479241] Dynamic subtest ccs0: SUCCESS (13.141s)
[215.490533] Starting dynamic subtest: vcs0
[229.340607] Dynamic subtest vcs0: SUCCESS (13.855s)
[229.351186] Starting dynamic subtest: bcs0
[242.473682] Dynamic subtest bcs0: SUCCESS (13.129s)
[242.488896] Starting dynamic subtest: rcs0
[255.628073] Dynamic subtest rcs0: SUCCESS (13.150s)
[255.639586] Starting dynamic subtest: vcs1
[269.339863] Dynamic subtest vcs1: SUCCESS (13.704s)
[269.342759] Subtest duration: SUCCESS (80.280s)
[269.421602] [030/133] (748s left) kms_async_flips (alternate-sync-async-flip-atomic)
[269.524882] Starting subtest: alternate-sync-async-flip-atomic
[269.910014] Starting dynamic subtest: pipe-A-eDP-1
[272.666313] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.757s)
[273.047317] Starting dynamic subtest: pipe-B-eDP-1
[275.804263] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.763s)
[276.193784] Starting dynamic subtest: pipe-C-eDP-1
[278.938653] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.752s)
[279.306340] Starting dynamic subtest: pipe-D-eDP-1
[282.068494] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s)
[282.070380] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.543s)
[283.236944] [031/133] (735s left) sw_sync (sync_merge)
[283.279973] Starting subtest: sync_merge
[283.282268] Subtest sync_merge: SUCCESS (0.000s)
[283.342344] [032/133] (735s left) gem_softpin (evict-snoop)
[283.403398] Starting subtest: evict-snoop
[283.408198] Subtest evict-snoop: SKIP (0.000s)
[283.532563] [033/133] (734s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[283.650989] Starting subtest: flip-vs-cursor-busy-crc-atomic
[284.488362] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.837s)
[285.373755] [034/133] (733s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[287.616871] Starting subtest: dpms-mode-unset-lpsp
[291.671554] Subtest dpms-mode-unset-lpsp: SUCCESS (4.058s)
[292.098552] [035/133] (726s left) kms_setmode (clone-exclusive-crtc)
[292.156325] Starting subtest: clone-exclusive-crtc
[292.162963] Subtest clone-exclusive-crtc: SKIP (0.000s)
[292.262381] [036/133] (726s left) kms_vblank (wait-busy)
[292.353546] Starting subtest: wait-busy
[292.355797] Starting dynamic subtest: pipe-A-eDP-1
[294.227365] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[294.247009] Starting dynamic subtest: pipe-D-eDP-1
[296.794112] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.563s)
[296.796487] Subtest wait-busy: SUCCESS (4.441s)
[297.598152] [037/133] (721s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[297.716482] Starting subtest: cursorB-vs-flipA-atomic
[297.720933] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[297.864956] [038/133] (720s left) gen9_exec_parse (bb-oversize)
[297.920816] Subtest bb-oversize: SKIP (0.000s)
[298.000843] [039/133] (720s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[298.060689] Starting subtest: multi-wait-all-for-submit-available-submitted
[298.062935] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[298.159785] [040/133] (720s left) gem_ctx_param (non-root-set)
[298.216030] Starting subtest: non-root-set
[298.231848] Subtest non-root-set: SUCCESS (0.016s)
[298.320486] [041/133] (720s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[298.422314] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[298.424621] Starting dynamic subtest: pipe-A
[298.444983] Dynamic subtest pipe-A: SKIP (0.019s)
[298.455193] Starting dynamic subtest: pipe-B
[298.479446] Dynamic subtest pipe-B: SKIP (0.035s)
[298.488240] Starting dynamic subtest: pipe-C
[298.516518] Dynamic subtest pipe-C: SKIP (0.033s)
[298.525308] Starting dynamic subtest: pipe-D
[298.545678] Dynamic subtest pipe-D: SKIP (0.031s)
[298.549434] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.122s)
[298.656820] [042/133] (720s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[298.762494] Starting subtest: fbc-psr-sprite-mmap-cpu
[298.764393] Starting dynamic subtest: eDP-1
[298.767874] Dynamic subtest eDP-1: SKIP (0.000s)
[298.771462] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[298.840381] [043/133] (720s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[298.898656] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[298.902233] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[299.084084] [044/133] (719s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[299.186302] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[299.190523] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[299.288262] [045/133] (719s left) kms_psr (fbc-psr2-primary-blt)
[299.386090] Starting subtest: fbc-psr2-primary-blt
[299.388342] Starting dynamic subtest: eDP-1
[299.392639] Dynamic subtest eDP-1: SKIP (0.000s)
[299.396856] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[299.459016] [046/133] (719s left) kms_frontbuffer_tracking (fbc-stridechange)
[299.554997] Starting subtest: fbc-stridechange
[302.780990] Subtest fbc-stridechange: SUCCESS (3.231s)
[303.922696] [047/133] (715s left) kms_cursor_edge_walk (256x256-top-bottom)
[304.026385] Starting subtest: 256x256-top-bottom
[304.028659] Starting dynamic subtest: pipe-A-eDP-1
[307.709686] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.686s)
[307.718918] Starting dynamic subtest: pipe-D-eDP-1
[310.850206] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s)
[310.852499] Subtest 256x256-top-bottom: SUCCESS (6.827s)
[311.653286] [048/133] (707s left) api_intel_bb (intel-bb-blit-x)
[311.717131] Starting subtest: intel-bb-blit-x
[315.178812] Subtest intel-bb-blit-x: SUCCESS (3.463s)
[315.287506] [049/133] (703s left) kms_chamelium_color (ctm-0-25)
[315.392416] Subtest ctm-0-25: SKIP (0.000s)
[315.438685] [050/133] (703s left) gem_close_race (basic-process)
[315.505810] Starting subtest: basic-process
[315.539648] Subtest basic-process: SUCCESS (0.034s)
[315.722491] [051/133] (703s left) kms_cursor_crc (cursor-random-512x170)
[315.996850] Starting subtest: cursor-random-512x170
[316.001117] Subtest cursor-random-512x170: SKIP (0.001s)
[316.157677] [052/133] (703s left) kms_atomic (test-only)
[316.239462] Starting subtest: test-only
[316.287058] Starting dynamic subtest: pipe-A-eDP-1
[318.742801] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.456s)
[318.744888] Subtest test-only: SUCCESS (2.504s)
[319.545921] [053/133] (699s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[319.648651] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[319.650916] Starting dynamic subtest: pipe-A-eDP-1
[330.636979] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.995s)
[330.647213] Starting dynamic subtest: pipe-B-eDP-1
[342.351290] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.713s)
[342.353574] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.710s)
[343.204960] [054/133] (676s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[343.316012] Starting subtest: fb-8bpc-vs-panel-6bpc
[343.318465] Starting dynamic subtest: pipe-A-eDP-1
[344.665974] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.352s)
[344.668272] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.353s)
[345.476537] [055/133] (673s left) gem_exec_balancer (bonded-true-hang)
[345.728627] Starting subtest: bonded-true-hang
[345.733782] Subtest bonded-true-hang: SKIP (0.000s)
[345.840426] [056/133] (673s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[345.938077] Starting subtest: 4-tiled-16bpp-rotate-270
[345.957946] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[346.064241] [057/133] (673s left) kms_content_protection (legacy)
[346.213517] Starting subtest: legacy
[346.217888] Subtest legacy: SKIP (0.000s)
[346.317036] [058/133] (673s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[346.402576] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[346.406572] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[346.496713] [059/133] (673s left) kms_getfb (getfb-repeated-different-handles)
[346.585990] Starting subtest: getfb-repeated-different-handles
[346.588257] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[346.718569] [060/133] (672s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[346.812017] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[346.815989] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[346.906652] [061/133] (672s left) gem_caching (read-writes)
[346.962984] Subtest read-writes: SKIP (0.000s)
[347.032200] [062/133] (672s left) kms_vrr (negative-basic)
[347.129551] Starting subtest: negative-basic
[347.135133] Starting dynamic subtest: pipe-A-eDP-1
[352.548898] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[352.831895] Subtest negative-basic: SUCCESS (5.703s)
[353.691976] [063/133] (666s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[353.810715] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[385.628914] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.815s)
[386.423750] [064/133] (633s left) prime_busy (after)
[386.488399] Starting subtest: after
[386.493117] Starting dynamic subtest: rcs0
[386.525352] Dynamic subtest rcs0: SUCCESS (0.034s)
[386.536170] Starting dynamic subtest: bcs0
[386.579646] Dynamic subtest bcs0: SUCCESS (0.053s)
[386.590154] Starting dynamic subtest: vcs0
[386.619014] Dynamic subtest vcs0: SUCCESS (0.039s)
[386.628384] Starting dynamic subtest: vcs1
[386.659284] Dynamic subtest vcs1: SUCCESS (0.039s)
[386.668630] Starting dynamic subtest: vecs0
[386.700548] Dynamic subtest vecs0: SUCCESS (0.040s)
[386.710304] Starting dynamic subtest: ccs0
[386.741093] Dynamic subtest ccs0: SUCCESS (0.040s)
[386.850013] Subtest after: SUCCESS (0.360s)
[386.928293] [065/133] (632s left) gem_ctx_isolation (dirty-create)
[386.995111] Starting subtest: dirty-create
[386.997417] Starting dynamic subtest: rcs0
[387.173407] Dynamic subtest rcs0: SUCCESS (0.178s)
[387.183445] Starting dynamic subtest: bcs0
[387.368011] Dynamic subtest bcs0: SUCCESS (0.194s)
[387.378458] Starting dynamic subtest: vcs0
[387.580684] Dynamic subtest vcs0: SUCCESS (0.211s)
[387.591681] Starting dynamic subtest: vcs1
[389.568209] Dynamic subtest vcs1: SUCCESS (1.986s)
[389.577880] Starting dynamic subtest: vecs0
[391.558692] Dynamic subtest vecs0: SUCCESS (1.989s)
[391.567775] Starting dynamic subtest: ccs0
[393.620886] Dynamic subtest ccs0: SUCCESS (2.061s)
[393.623282] Subtest dirty-create: SUCCESS (6.626s)
[393.847543] [066/133] (626s left) gem_exec_capture (capture-recoverable)
[393.920875] Starting subtest: capture-recoverable
[393.929823] Subtest capture-recoverable: SUCCESS (0.008s)
[394.043051] [067/133] (625s left) perf (i915-ref-count)
[394.107958] Starting subtest: i915-ref-count
[394.144240] Subtest i915-ref-count: SUCCESS (0.036s)
[394.206633] [068/133] (625s left) gem_exec_params (invalid-batch-start-offset)
[394.253021] Starting subtest: invalid-batch-start-offset
[394.258751] Subtest invalid-batch-start-offset: SUCCESS (0.005s)
[394.418871] [069/133] (625s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[394.527907] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[394.532430] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[394.624077] [070/133] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[394.721450] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[402.089781] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.370s)
[402.234026] [071/133] (617s left) syncobj_basic (illegal-fd-to-handle)
[402.298785] Starting subtest: illegal-fd-to-handle
[402.301073] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[402.395617] [072/133] (617s left) kms_psr (psr2-primary-mmap-cpu)
[402.482542] Starting subtest: psr2-primary-mmap-cpu
[402.484864] Starting dynamic subtest: eDP-1
[404.251913] Dynamic subtest eDP-1: SUCCESS (1.771s)
[404.254384] Subtest psr2-primary-mmap-cpu: SUCCESS (1.772s)
[405.126570] [073/133] (615s left) device_reset (unbind-reset-rebind)
[405.181080] Starting subtest: unbind-reset-rebind
[410.136580] Subtest unbind-reset-rebind: SUCCESS (4.953s)
[410.175395] [074/133] (610s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[410.280042] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[410.282459] Starting dynamic subtest: pipe-A-eDP-1
[410.341676] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[410.352839] Starting dynamic subtest: pipe-B-eDP-1
[410.409552] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[410.420759] Starting dynamic subtest: pipe-C-eDP-1
[410.478431] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[410.489261] Starting dynamic subtest: pipe-D-eDP-1
[410.548329] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[410.552597] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[412.549520] [075/133] (607s left) gem_eio (context-create)
[412.684856] Starting subtest: context-create
[412.840720] Subtest context-create: SUCCESS (0.155s)
[412.987180] [076/133] (607s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[413.051783] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[413.054377] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[413.162559] [077/133] (607s left) gem_userptr_blits (unsync-unmap-after-close)
[413.236308] Subtest unsync-unmap-after-close: SKIP (0.000s)
[413.373817] [078/133] (607s left) kms_addfb_basic (addfb25-modifier-no-flag)
[413.466349] Starting subtest: addfb25-modifier-no-flag
[413.468335] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[413.573163] [079/133] (606s left) gem_exec_whisper (basic-normal-all)
[413.641493] Starting subtest: basic-normal-all
[416.108279] Subtest basic-normal-all: SUCCESS (2.466s)
[416.297129] [080/133] (604s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[416.394521] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[423.699881] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.306s)
[423.823077] [081/133] (596s left) syncobj_timeline (32bits-limit)
[423.874252] Starting subtest: 32bits-limit
[423.876501] Subtest 32bits-limit: SUCCESS (0.001s)
[423.979841] [082/133] (596s left) gem_pxp (reject-modify-context-protection-off-3)
[424.106109] Starting subtest: reject-modify-context-protection-off-3
[424.108908] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[424.230418] [083/133] (596s left) kms_feature_discovery (psr1)
[424.318412] Starting subtest: psr1
[424.320825] Subtest psr1: SUCCESS (0.000s)
[424.405617] [084/133] (596s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[424.496888] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[425.608029] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.525s)
[425.651570] [085/133] (595s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[425.702765] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[425.705021] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[425.824403] [086/133] (594s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[425.927693] Starting subtest: psr-indfb-scaledprimary
[431.682280] Subtest psr-indfb-scaledprimary: SUCCESS (5.756s)
[431.811176] [087/133] (589s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[431.915889] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[431.920265] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[432.010908] [088/133] (588s left) i915_pm_rpm (gem-execbuf-stress)
[433.533957] Starting subtest: gem-execbuf-stress
[433.536301] Starting dynamic subtest: smem0
[446.337640] Dynamic subtest smem0: SUCCESS (12.802s)
[446.351432] Starting dynamic subtest: extra-wait-smem0
[508.209656] Dynamic subtest extra-wait-smem0: SUCCESS (61.856s)
[508.212334] Subtest gem-execbuf-stress: SUCCESS (74.665s)
[508.597078] [089/133] (512s left) kms_plane_multiple (2x-tiling-y)
[508.703097] Starting subtest: 2x-tiling-y
[508.707723] Subtest 2x-tiling-y: SKIP (0.000s)
[508.773794] [090/133] (512s left) kms_prop_blob (blob-multiple)
[508.815206] Starting subtest: blob-multiple
[508.817664] Subtest blob-multiple: SUCCESS (0.002s)
[508.920722] [091/133] (512s left) syncobj_wait (invalid-signal-bad-pad)
[508.971168] Starting subtest: invalid-signal-bad-pad
[508.973361] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[509.070537] [092/133] (511s left) i915_drm_fdinfo (virtual-busy)
[509.112910] Starting subtest: virtual-busy
[509.117186] Subtest virtual-busy: SKIP (0.000s)
[509.182921] [093/133] (511s left) syncobj_wait (multi-wait-all-submitted)
[509.232485] Starting subtest: multi-wait-all-submitted
[509.338142] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[509.431975] [094/133] (511s left) gem_busy (busy)
[509.491813] Starting subtest: busy
[509.494121] Starting dynamic subtest: all-engines
[509.536505] Dynamic subtest all-engines: SUCCESS (0.044s)
[509.547481] Starting dynamic subtest: rcs0
[511.368846] Dynamic subtest rcs0: SUCCESS (1.830s)
[511.380597] Starting dynamic subtest: bcs0
[511.426128] Dynamic subtest bcs0: SUCCESS (0.054s)
[511.436915] Starting dynamic subtest: vcs0
[511.465754] Dynamic subtest vcs0: SUCCESS (0.039s)
[511.475156] Starting dynamic subtest: vcs1
[513.412273] Dynamic subtest vcs1: SUCCESS (1.944s)
[513.422847] Starting dynamic subtest: vecs0
[515.396658] Dynamic subtest vecs0: SUCCESS (1.983s)
[515.408996] Starting dynamic subtest: ccs0
[517.380356] Dynamic subtest ccs0: SUCCESS (1.982s)
[517.382782] Subtest busy: SUCCESS (7.884s)
[517.741011] [095/133] (503s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[517.836136] Starting subtest: plane-ctm3x4-lut1d
[517.963137] Starting dynamic subtest: pipe-A-plane-0
[518.116416] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[518.126768] Starting dynamic subtest: pipe-A-plane-1
[518.249799] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[518.260838] Starting dynamic subtest: pipe-A-plane-2
[518.437964] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[519.664321] Starting dynamic subtest: pipe-B-plane-0
[519.823177] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[519.833936] Starting dynamic subtest: pipe-B-plane-1
[520.000033] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[520.015519] Starting dynamic subtest: pipe-B-plane-2
[520.166534] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[521.450882] Starting dynamic subtest: pipe-C-plane-0
[521.575410] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[521.585933] Starting dynamic subtest: pipe-C-plane-1
[521.743829] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[521.760172] Starting dynamic subtest: pipe-C-plane-2
[521.908877] Dynamic subtest pipe-C-plane-2: SUCCESS (0.165s)
[523.145276] Starting dynamic subtest: pipe-D-plane-0
[523.303198] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[523.313571] Starting dynamic subtest: pipe-D-plane-1
[523.458600] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[523.469074] Starting dynamic subtest: pipe-D-plane-2
[523.603020] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[523.895579] Subtest plane-ctm3x4-lut1d: SUCCESS (6.058s)
[524.718402] [096/133] (496s left) gem_exec_params (invalid-ring)
[524.782917] Starting subtest: invalid-ring
[524.785272] Subtest invalid-ring: SUCCESS (0.000s)
[524.910318] [097/133] (496s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[525.011660] Starting subtest: fbc-2p-pri-indfb-multidraw
[525.015916] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[525.136640] [098/133] (496s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[525.257516] Starting subtest: cursor-vs-flip-toggle
[556.524611] Subtest cursor-vs-flip-toggle: SUCCESS (31.260s)
[557.361595] [099/133] (463s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[557.478575] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[557.480953] Starting dynamic subtest: pipe-A
[557.540677] Dynamic subtest pipe-A: SUCCESS (0.065s)
[557.551964] Starting dynamic subtest: pipe-B
[558.676100] Dynamic subtest pipe-B: SUCCESS (1.134s)
[558.692389] Starting dynamic subtest: pipe-C
[559.800681] Dynamic subtest pipe-C: SUCCESS (1.122s)
[559.810910] Starting dynamic subtest: pipe-D
[560.938596] Dynamic subtest pipe-D: SUCCESS (1.137s)
[560.940845] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.464s)
[562.094153] [100/133] (459s left) kms_lease (lease-unleased-crtc)
[562.190942] Starting subtest: lease-unleased-crtc
[562.193314] Starting dynamic subtest: pipe-A-eDP-1
[562.481902] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[562.493173] Starting dynamic subtest: pipe-B-eDP-1
[563.248793] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[563.260331] Starting dynamic subtest: pipe-C-eDP-1
[563.262585] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[563.272390] Starting dynamic subtest: pipe-D-eDP-1
[563.274470] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[563.276576] Subtest lease-unleased-crtc: SUCCESS (1.069s)
[563.647075] [101/133] (457s left) kms_rotation_crc (cursor-rotation-180)
[563.741346] Starting subtest: cursor-rotation-180
[565.300363] Subtest cursor-rotation-180: SUCCESS (1.562s)
[566.491628] [102/133] (455s left) kms_selftest (drm_damage_helper)
[566.540335] Starting subtest: drm_damage_helper
[566.556686] Starting dynamic subtest: drm_test_damage_iter_no_damage
[566.649287] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.092s)
[566.660522] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[566.732258] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.083s)
[566.742999] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[566.826091] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.093s)
[566.836755] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[566.919328] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.092s)
[566.930851] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[567.008275] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.088s)
[567.023496] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[567.107773] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.099s)
[567.119327] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[567.200408] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.092s)
[567.211349] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[567.288584] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.087s)
[567.299500] Starting dynamic subtest: drm_test_damage_iter_single_damage
[567.382436] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.093s)
[567.398076] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[567.473852] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.092s)
[567.484651] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[567.589937] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.114s)
[567.600839] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[567.691246] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.101s)
[567.702386] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[567.784311] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.092s)
[567.796407] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[567.875202] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.090s)
[567.886900] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[567.971641] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.097s)
[567.981438] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[568.075984] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.103s)
[568.085800] Starting dynamic subtest: drm_test_damage_iter_damage
[568.170006] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.094s)
[568.180470] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[568.261780] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.090s)
[568.272800] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[568.375135] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.113s)
[568.386324] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[568.487675] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.111s)
[568.499037] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[568.584534] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.096s)
[568.586475] Subtest drm_damage_helper: SUCCESS (2.045s)
[568.735094] [103/133] (452s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[568.848408] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[568.852032] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[568.958871] [104/133] (452s left) i915_query (engine-info-invalid)
[569.015539] Starting subtest: engine-info-invalid
[569.017433] Subtest engine-info-invalid: SUCCESS (0.000s)
[569.126230] [105/133] (452s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[569.507361] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[570.285326] [106/133] (451s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[570.380479] Starting subtest: x-tiled-32bpp-rotate-90
[570.402160] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[570.520767] [107/133] (451s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[570.612808] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[577.652407] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.042s)
[577.814843] [108/133] (443s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[578.351569] Starting subtest: syncobj-backward-timeline-chain-engines
[578.477344] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.126s)
[579.495932] [109/133] (442s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[579.591047] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[579.595269] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[579.689998] [110/133] (442s left) kms_invalid_mode (zero-vdisplay)
[579.779630] Starting subtest: zero-vdisplay
[579.781828] Starting dynamic subtest: pipe-A-eDP-1
[580.063044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[580.073499] Starting dynamic subtest: pipe-B-eDP-1
[580.075356] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[580.085395] Starting dynamic subtest: pipe-C-eDP-1
[580.087479] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[580.097475] Starting dynamic subtest: pipe-D-eDP-1
[580.099688] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[580.101832] Subtest zero-vdisplay: SUCCESS (0.291s)
[580.911827] [111/133] (441s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[581.002237] Starting subtest: plane-all-modeset-transition-fencing
[581.006408] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[581.102691] [112/133] (440s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[581.201070] Starting subtest: bad-pixel-format-yf-tiled-ccs
[581.203297] Starting dynamic subtest: pipe-A-eDP-1
[581.225031] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[581.235712] Starting dynamic subtest: pipe-B-eDP-1
[581.257468] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[581.267715] Starting dynamic subtest: pipe-C-eDP-1
[581.288339] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[581.297866] Starting dynamic subtest: pipe-D-eDP-1
[581.318833] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[581.322956] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.014s)
[583.537336] [113/133] (438s left) gem_softpin (allocator-basic-reserve)
[583.600488] Starting subtest: allocator-basic-reserve
[583.674283] Subtest allocator-basic-reserve: SUCCESS (0.074s)
[583.807424] [114/133] (438s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[583.898261] Starting subtest: plane-primary-toggle-with-vblank-wait
[583.900800] Starting dynamic subtest: pipe-A-eDP-1
[584.071237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[584.386643] Starting dynamic subtest: pipe-B-eDP-1
[585.322846] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.945s)
[585.621877] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.723s)
[586.500800] [115/133] (435s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[586.589799] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[586.594185] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[586.669563] [116/133] (435s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[586.769421] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[586.773811] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[586.868587] [117/133] (435s left) gem_mmap_wc (pf-nonblock)
[586.928521] Subtest pf-nonblock: SKIP (0.000s)
[586.993672] [118/133] (435s left) gem_lmem_swapping (parallel-multi)
[587.033381] Subtest parallel-multi: SKIP (0.000s)
[587.085689] [119/133] (435s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[587.182905] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[587.187295] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[587.276676] [120/133] (435s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[587.373023] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[594.037665] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.666s)
[594.167541] [121/133] (428s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[594.257465] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[594.259803] Starting dynamic subtest: pipe-A-eDP-1
[594.282675] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[594.295019] Starting dynamic subtest: pipe-B-eDP-1
[594.316831] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[594.326647] Starting dynamic subtest: pipe-C-eDP-1
[594.347544] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[594.357001] Starting dynamic subtest: pipe-D-eDP-1
[594.379023] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[594.383424] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[596.498997] [122/133] (425s left) gem_exec_params (invalid-bsd1-flag-on-render)
[596.563514] Starting subtest: invalid-bsd1-flag-on-render
[596.565915] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[596.672119] [123/133] (425s left) gem_ctx_persistence (processes)
[596.729843] Starting subtest: processes
[598.418485] Subtest processes: SUCCESS (1.689s)
[598.498990] [124/133] (424s left) gem_mmap_gtt (fault-concurrent-y)
[598.553823] Subtest fault-concurrent-Y: SKIP (0.000s)
[598.622351] [125/133] (423s left) kms_addfb_basic (invalid-get-prop)
[598.689351] Starting subtest: invalid-get-prop
[598.691510] Subtest invalid-get-prop: SUCCESS (0.000s)
[598.830899] [126/133] (423s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[598.939825] Starting subtest: fbcpsr-indfb-scaledprimary
[604.681528] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.743s)
[604.806158] [127/133] (417s left) perf_pmu (busy-hang)
[604.847672] Starting subtest: busy-hang
[604.849889] Starting dynamic subtest: rcs0
[606.108410] Dynamic subtest rcs0: SUCCESS (1.258s)
[606.120198] Starting dynamic subtest: bcs0
[607.341637] Dynamic subtest bcs0: SUCCESS (1.231s)
[607.353712] Starting dynamic subtest: vcs0
[609.914451] Dynamic subtest vcs0: SUCCESS (2.574s)
[609.927754] Starting dynamic subtest: vcs1
[611.905506] Dynamic subtest vcs1: SUCCESS (1.986s)
[611.917465] Starting dynamic subtest: vecs0
[613.892506] Dynamic subtest vecs0: SUCCESS (1.985s)
[613.904524] Starting dynamic subtest: ccs0
[615.137259] Dynamic subtest ccs0: SUCCESS (1.246s)
[615.139881] Subtest busy-hang: SUCCESS (10.292s)
[615.228120] [128/133] (407s left) kms_force_connector_basic (force-load-detect)
[615.307240] Starting subtest: force-load-detect
[615.311766] Subtest force-load-detect: SKIP (0.000s)
[615.425766] [129/133] (407s left) gem_userptr_blits (vma-merge)
[615.494995] Starting subtest: vma-merge
[615.534179] Subtest vma-merge: SUCCESS (0.039s)
[615.639682] [130/133] (407s left) kms_cursor_crc (cursor-offscreen-64x21)
[615.857140] Starting subtest: cursor-offscreen-64x21
[615.905541] Subtest cursor-offscreen-64x21: SKIP (0.043s)
[616.179443] [131/133] (406s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[616.271673] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[616.273502] Starting dynamic subtest: pipe-A-eDP-1
[616.294711] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[616.310125] Starting dynamic subtest: pipe-B-eDP-1
[616.327166] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[616.337521] Starting dynamic subtest: pipe-C-eDP-1
[616.355447] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[616.367761] Starting dynamic subtest: pipe-D-eDP-1
[616.386407] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[616.389743] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[618.595702] [132/133] (404s left) gem_ccs (large-ctrl-surf-copy)
[618.662780] Starting subtest: large-ctrl-surf-copy
[618.667393] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[618.777906] [133/133] (404s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[618.831819] Starting subtest: single-wait-for-submit-available-signaled
[618.834135] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[618.937947] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_pm_rpm
results: parsing output: 4/ for test: kms_scaling_modes
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: vgem_basic
results: parsing output: 11/ for test: gem_mmap_wc
results: parsing output: 12/ for test: kms_pipe_b_c_ivb
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: i915_pciid
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_pipe_crc_basic
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_atomic_interruptible
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: sysfs_timeslice_duration
results: parsing output: 29/ for test: kms_async_flips
results: parsing output: 30/ for test: sw_sync
results: parsing output: 31/ for test: gem_softpin
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: kms_setmode
results: parsing output: 35/ for test: kms_vblank
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: gen9_exec_parse
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_edge_walk
results: parsing output: 47/ for test: api_intel_bb
results: parsing output: 48/ for test: kms_chamelium_color
results: parsing output: 49/ for test: gem_close_race
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_atomic
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_dither
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_getfb
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_caching
results: parsing output: 61/ for test: kms_vrr
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: prime_busy
results: parsing output: 64/ for test: gem_ctx_isolation
results: parsing output: 65/ for test: gem_exec_capture
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: syncobj_basic
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: device_reset
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: gem_exec_whisper
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: kms_feature_discovery
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: i915_pm_rpm
results: parsing output: 88/ for test: kms_plane_multiple
results: parsing output: 89/ for test: kms_prop_blob
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: i915_drm_fdinfo
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: gem_busy
results: parsing output: 94/ for test: kms_color_pipeline
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: kms_rotation_crc
results: parsing output: 101/ for test: kms_selftest
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: i915_query
results: parsing output: 104/ for test: kms_chamelium_frames
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_invalid_mode
results: parsing output: 110/ for test: kms_atomic_transition
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: kms_atomic_transition
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: gem_ctx_persistence
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: kms_force_connector_basic
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: gem_ccs
results: parsing output: 132/ for test: syncobj_timeline
Done.