[59.455510] Initializing watchdogs
[59.455553]   /dev/watchdog0
[59.469358] [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]
[59.473689] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.476024] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.479345] [001/133] (960s left) perf_pmu (busy-start)
[59.548242] Starting subtest: busy-start
[59.550616] Starting dynamic subtest: rcs0
[62.105282] Dynamic subtest rcs0: SUCCESS (2.557s)
[62.115759] Starting dynamic subtest: bcs0
[64.654727] Dynamic subtest bcs0: SUCCESS (2.548s)
[64.661933] Starting dynamic subtest: vcs0
[67.979609] Dynamic subtest vcs0: SUCCESS (3.322s)
[67.988981] Starting dynamic subtest: vcs1
[71.893460] Dynamic subtest vcs1: SUCCESS (3.913s)
[71.902864] Starting dynamic subtest: vecs0
[75.925822] Dynamic subtest vecs0: SUCCESS (4.031s)
[75.938804] Starting dynamic subtest: ccs0
[78.475083] Dynamic subtest ccs0: SUCCESS (2.550s)
[78.477691] Subtest busy-start: SUCCESS (18.927s)
[78.600846] [002/133] (941s left) gem_exec_flush (basic-wb-rw-before-default)
[78.662423] Starting subtest: basic-wb-rw-before-default
[84.121227] Subtest basic-wb-rw-before-default: SUCCESS (5.460s)
[84.308853] [003/133] (935s left) kms_lease (lessee-list)
[84.411689] Starting subtest: lessee-list
[84.413852] Starting dynamic subtest: pipe-A-eDP-1
[84.416344] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[84.424084] Starting dynamic subtest: pipe-B-eDP-1
[84.426145] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[84.432570] Starting dynamic subtest: pipe-C-eDP-1
[84.434505] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[84.440882] Starting dynamic subtest: pipe-D-eDP-1
[84.442864] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[84.444838] Subtest lessee-list: SUCCESS (0.007s)
[84.533875] [004/133] (935s left) i915_drm_fdinfo (virtual-busy-hang-all)
[84.577229] Starting subtest: virtual-busy-hang-all
[84.581227] Subtest virtual-busy-hang-all: SKIP (0.000s)
[84.666415] [005/133] (935s left) kms_atomic_interruptible (legacy-setmode)
[84.764927] Starting subtest: legacy-setmode
[84.767258] Starting dynamic subtest: pipe-A-eDP-1
[91.663382] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.897s)
[91.665410] Subtest legacy-setmode: SUCCESS (6.898s)
[92.540746] [006/133] (927s left) kms_color (ctm-max)
[92.645395] Starting subtest: ctm-max
[92.647717] Starting dynamic subtest: pipe-A-eDP-1
[93.367894] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[93.376831] Starting dynamic subtest: pipe-B-eDP-1
[94.739562] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.374s)
[94.748082] Starting dynamic subtest: pipe-C-eDP-1
[96.138288] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[96.146058] Starting dynamic subtest: pipe-D-eDP-1
[97.462117] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[97.464415] Subtest ctm-max: SUCCESS (4.816s)
[98.272795] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[98.372632] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[102.617466] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.250s)
[103.767094] [008/133] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[103.875339] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[103.879532] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[104.000101] [009/133] (916s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[104.098240] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[104.100557] Starting dynamic subtest: pipe-A
[104.118304] Dynamic subtest pipe-A: SKIP (0.018s)
[104.127060] Starting dynamic subtest: pipe-B
[104.149442] Dynamic subtest pipe-B: SKIP (0.030s)
[104.157091] Starting dynamic subtest: pipe-C
[104.179820] Dynamic subtest pipe-C: SKIP (0.030s)
[104.188942] Starting dynamic subtest: pipe-D
[104.208332] Dynamic subtest pipe-D: SKIP (0.030s)
[104.212090] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.108s)
[104.323807] [010/133] (915s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[104.423844] Starting subtest: y-tiled-64bpp-rotate-180
[104.428288] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[104.535966] [011/133] (915s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[104.662093] Starting subtest: primary-x-tiled-reflect-x-180
[111.714929] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.054s)
[112.947106] [012/133] (907s left) kms_flip (2x-flip-vs-expired-vblank)
[113.047977] Starting subtest: 2x-flip-vs-expired-vblank
[113.055279] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[113.181594] [013/133] (907s left) api_intel_allocator (fork-simple-stress)
[113.233599] Starting subtest: fork-simple-stress
[118.632490] Subtest fork-simple-stress: SUCCESS (5.400s)
[118.770463] [014/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[118.897612] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[125.446058] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.553s)
[125.618670] [015/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[125.735399] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[125.739552] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[125.848545] [016/133] (894s left) gem_mmap (bad-size)
[125.904766] Subtest bad-size: SKIP (0.000s)
[125.971671] [017/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[126.048502] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[126.052669] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[126.237509] [018/133] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[126.333437] Starting subtest: psr-2p-primscrn-cur-indfb-move
[126.337686] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[126.435857] [019/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[126.546767] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[133.027972] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.485s)
[133.218716] [020/133] (887s left) syncobj_timeline (wait-all-snapshot)
[133.285114] Starting subtest: wait-all-snapshot
[133.366824] Subtest wait-all-snapshot: SUCCESS (0.082s)
[133.451426] [021/133] (887s left) gem_partial_pwrite_pread (reads)
[133.510431] Subtest reads: SKIP (0.000s)
[133.593962] [022/133] (887s left) syncobj_basic (create-signaled)
[133.653082] Starting subtest: create-signaled
[133.655079] Subtest create-signaled: SUCCESS (0.000s)
[133.779078] [023/133] (887s left) kms_chamelium_frames (dp-crc-multiple)
[134.199648] Subtest dp-crc-multiple: SKIP (0.000s)
[134.970886] [024/133] (885s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[135.087098] Starting subtest: cursorA-vs-flipA-varying-size
[146.268883] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.179s)
[147.140611] [025/133] (873s left) gem_ctx_persistence (hang)
[147.213569] Starting subtest: hang
[147.218124] Subtest hang: SKIP (0.000s)
[147.337114] [026/133] (873s left) kms_psr (pr-primary-page-flip)
[147.444461] Starting subtest: pr-primary-page-flip
[147.449043] Subtest pr-primary-page-flip: SKIP (0.000s)
[147.526589] [027/133] (873s left) gem_lmem_swapping (heavy-random)
[147.566928] Subtest heavy-random: SKIP (0.000s)
[147.600792] [028/133] (873s left) kms_addfb_basic (master-rmfb)
[147.655387] Starting subtest: master-rmfb
[147.657581] Subtest master-rmfb: SUCCESS (0.001s)
[147.838296] [029/133] (873s left) kms_addfb_basic (invalid-get-prop-any)
[147.895039] Starting subtest: invalid-get-prop-any
[147.897273] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[148.062382] [030/133] (873s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[148.155190] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[148.157065] Starting dynamic subtest: pipe-A-eDP-1
[148.178579] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[148.186237] Starting dynamic subtest: pipe-B-eDP-1
[148.204681] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[148.211499] Starting dynamic subtest: pipe-C-eDP-1
[148.231219] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[148.238069] Starting dynamic subtest: pipe-D-eDP-1
[148.257570] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[148.260953] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[150.400380] [031/133] (870s left) gem_exec_basic (basic)
[150.456659] Starting subtest: basic
[150.459005] Starting dynamic subtest: rcs0-smem
[150.461322] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[150.469754] Starting dynamic subtest: bcs0-smem
[150.472065] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[150.479410] Starting dynamic subtest: vcs0-smem
[150.481312] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[150.488067] Starting dynamic subtest: vcs1-smem
[150.489938] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[150.496757] Starting dynamic subtest: vecs0-smem
[150.498715] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[150.505589] Starting dynamic subtest: ccs0-smem
[150.507520] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[150.509460] Subtest basic: SUCCESS (0.013s)
[151.941893] [032/133] (869s left) gem_mmap_offset (oob-read)
[152.007562] Starting subtest: oob-read
[152.009575] Subtest oob-read: SUCCESS (0.000s)
[152.140015] [033/133] (869s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[152.229800] Starting subtest: bad-pixel-format-yf-tiled-ccs
[152.232023] Starting dynamic subtest: pipe-A-eDP-1
[152.253635] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[152.262345] Starting dynamic subtest: pipe-B-eDP-1
[152.282974] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[152.290724] Starting dynamic subtest: pipe-C-eDP-1
[152.311418] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[152.318955] Starting dynamic subtest: pipe-D-eDP-1
[152.340784] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[152.345095] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[154.469916] [034/133] (866s left) kms_cursor_crc (cursor-random-64x21)
[154.669911] Starting subtest: cursor-random-64x21
[154.710528] Subtest cursor-random-64x21: SKIP (0.038s)
[154.953345] [035/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[155.061711] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[155.065989] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[155.178938] [036/133] (866s left) kms_plane_alpha_blend (constant-alpha-max)
[155.267268] Starting subtest: constant-alpha-max
[155.546071] Starting dynamic subtest: pipe-A-eDP-1
[156.589237] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.043s)
[156.597780] Starting dynamic subtest: pipe-D-eDP-1
[158.198400] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.605s)
[158.200716] Subtest constant-alpha-max: SUCCESS (2.931s)
[159.044313] [037/133] (862s left) gem_exec_fence (keep-in-fence)
[159.221125] Starting subtest: keep-in-fence
[159.223657] Starting dynamic subtest: rcs0
[159.289888] Dynamic subtest rcs0: SUCCESS (0.069s)
[159.299930] Starting dynamic subtest: bcs0
[159.341546] Dynamic subtest bcs0: SUCCESS (0.050s)
[159.351773] Starting dynamic subtest: vcs0
[160.919509] Dynamic subtest vcs0: SUCCESS (1.574s)
[160.930268] Starting dynamic subtest: vcs1
[162.902311] Dynamic subtest vcs1: SUCCESS (1.981s)
[162.913120] Starting dynamic subtest: vecs0
[164.886101] Dynamic subtest vecs0: SUCCESS (1.982s)
[164.896855] Starting dynamic subtest: ccs0
[165.131109] Dynamic subtest ccs0: SUCCESS (0.244s)
[165.134107] Subtest keep-in-fence: SUCCESS (5.911s)
[167.049696] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[167.052940] [038/133] (854s left) i915_pm_rps (min-max-config-idle)
[167.133306] Starting subtest: min-max-config-idle
[167.137425] Subtest min-max-config-idle: SKIP (0.001s)
[167.262840] [039/133] (854s left) dumb_buffer (map-invalid-size)
[167.327138] Starting subtest: map-invalid-size
[167.329842] Subtest map-invalid-size: SUCCESS (0.000s)
[167.452377] [040/133] (854s left) gem_mmap_gtt (basic-write-gtt)
[167.517936] Subtest basic-write-gtt: SKIP (0.000s)
[167.590830] [041/133] (853s left) gem_userptr_blits (set-cache-level)
[167.661412] Starting subtest: set-cache-level
[167.665722] Subtest set-cache-level: SKIP (0.000s)
[167.838888] [042/133] (853s left) kms_psr (psr-primary-render)
[167.934089] Starting subtest: psr-primary-render
[167.936406] Starting dynamic subtest: eDP-1
[169.636468] Dynamic subtest eDP-1: SUCCESS (1.700s)
[169.638769] Subtest psr-primary-render: SUCCESS (1.701s)
[170.519118] [043/133] (851s left) gem_create (create-ext-placement-sanity-check)
[170.692725] Starting subtest: create-ext-placement-sanity-check
[170.698612] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[170.815595] [044/133] (850s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[170.910298] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[170.926780] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.018s)
[171.025776] [045/133] (850s left) gem_exec_schedule (u-lateslice)
[171.099148] Starting subtest: u-lateslice
[171.101360] Starting dynamic subtest: rcs0
[171.111074] Dynamic subtest rcs0: SUCCESS (0.021s)
[171.119318] Starting dynamic subtest: bcs0
[171.128626] Dynamic subtest bcs0: SUCCESS (0.017s)
[171.136856] Starting dynamic subtest: vcs0
[171.147227] Dynamic subtest vcs0: SUCCESS (0.018s)
[171.158823] Starting dynamic subtest: vcs1
[171.165581] Dynamic subtest vcs1: SUCCESS (0.017s)
[171.173183] Starting dynamic subtest: vecs0
[171.183797] Dynamic subtest vecs0: SUCCESS (0.018s)
[171.191414] Starting dynamic subtest: ccs0
[171.201164] Dynamic subtest ccs0: SUCCESS (0.017s)
[171.203460] Subtest u-lateslice: SUCCESS (0.112s)
[172.991979] [046/133] (848s left) kms_flip (dpms-off-confusion-interruptible)
[173.083348] Starting subtest: dpms-off-confusion-interruptible
[173.085708] Starting dynamic subtest: A-eDP1
[181.714856] Dynamic subtest A-eDP1: SUCCESS (8.630s)
[181.725411] Starting dynamic subtest: B-eDP1
[190.344487] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[190.354542] Starting dynamic subtest: C-eDP1
[198.967188] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[198.977067] Starting dynamic subtest: D-eDP1
[207.588456] Dynamic subtest D-eDP1: SUCCESS (8.619s)
[207.594069] Subtest dpms-off-confusion-interruptible: SUCCESS (34.508s)
[208.776413] [047/133] (813s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[208.883691] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[215.730399] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.848s)
[215.923872] [048/133] (805s left) kms_plane (plane-position-hole)
[216.017130] Starting subtest: plane-position-hole
[216.542087] Starting dynamic subtest: pipe-A-plane-1
[217.847662] Dynamic subtest pipe-A-plane-1: SUCCESS (1.306s)
[217.859200] Starting dynamic subtest: pipe-A-plane-2
[219.087399] Dynamic subtest pipe-A-plane-2: SUCCESS (1.238s)
[219.096112] Starting dynamic subtest: pipe-A-plane-3
[220.313170] Dynamic subtest pipe-A-plane-3: SUCCESS (1.224s)
[220.321922] Starting dynamic subtest: pipe-A-plane-4
[221.555086] Dynamic subtest pipe-A-plane-4: SUCCESS (1.241s)
[221.563963] Starting dynamic subtest: pipe-A-plane-5
[221.578563] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[222.707395] Starting dynamic subtest: pipe-B-plane-1
[223.960287] Dynamic subtest pipe-B-plane-1: SUCCESS (1.261s)
[223.969367] Starting dynamic subtest: pipe-B-plane-2
[225.261757] Dynamic subtest pipe-B-plane-2: SUCCESS (1.301s)
[225.271183] Starting dynamic subtest: pipe-B-plane-3
[226.563844] Dynamic subtest pipe-B-plane-3: SUCCESS (1.301s)
[226.572865] Starting dynamic subtest: pipe-B-plane-4
[227.802146] Dynamic subtest pipe-B-plane-4: SUCCESS (1.239s)
[227.811077] Starting dynamic subtest: pipe-B-plane-5
[227.827671] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[227.829842] Subtest plane-position-hole: SUCCESS (11.811s)
[228.609528] [049/133] (793s left) kms_draw_crc (draw-method-mmap-cpu)
[228.703081] Starting subtest: draw-method-mmap-cpu
[228.704959] Starting dynamic subtest: xrgb8888-untiled
[228.923212] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[228.931610] Starting dynamic subtest: rgb565-untiled
[229.135343] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[229.143486] Starting dynamic subtest: xrgb2101010-untiled
[229.345371] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[229.353967] Starting dynamic subtest: xbgr16161616f-untiled
[229.544906] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[229.553188] Starting dynamic subtest: xrgb8888-xtiled
[229.667110] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[229.674791] Starting dynamic subtest: rgb565-xtiled
[229.789305] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[229.797071] Starting dynamic subtest: xrgb2101010-xtiled
[229.912258] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[229.927888] Starting dynamic subtest: xbgr16161616f-xtiled
[230.033908] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.119s)
[230.041793] Starting dynamic subtest: xrgb8888-4tiled
[230.167177] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[230.174676] Starting dynamic subtest: rgb565-4tiled
[230.301233] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[230.316790] Starting dynamic subtest: xrgb2101010-4tiled
[230.456080] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.153s)
[230.466182] Starting dynamic subtest: xbgr16161616f-4tiled
[230.600458] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.142s)
[230.602435] Subtest draw-method-mmap-cpu: SUCCESS (1.901s)
[230.742469] [050/133] (791s left) gem_mmap_gtt (medium-copy-xy)
[230.799385] Subtest medium-copy-XY: SKIP (0.000s)
[230.865212] [051/133] (791s left) vgem_basic (bad-flag)
[230.908089] Starting subtest: bad-flag
[230.909955] Subtest bad-flag: SUCCESS (0.000s)
[230.980828] [052/133] (791s left) gem_ctx_persistence (engines-hostile-preempt)
[231.035210] Starting subtest: engines-hostile-preempt
[231.037231] Starting dynamic subtest: rcs0
[231.143186] Dynamic subtest rcs0: SUCCESS (0.108s)
[231.156289] Starting dynamic subtest: bcs0
[231.205495] Dynamic subtest bcs0: SUCCESS (0.060s)
[231.217809] Starting dynamic subtest: vcs0
[232.864920] Dynamic subtest vcs0: SUCCESS (1.654s)
[232.882726] Starting dynamic subtest: vcs1
[234.852855] Dynamic subtest vcs1: SUCCESS (1.985s)
[234.866593] Starting dynamic subtest: vecs0
[236.971086] Dynamic subtest vecs0: SUCCESS (2.115s)
[236.985060] Starting dynamic subtest: ccs0
[237.055916] Dynamic subtest ccs0: SUCCESS (0.083s)
[237.058416] Subtest engines-hostile-preempt: SUCCESS (6.021s)
[237.150300] [053/133] (784s left) kms_sequence (queue-idle)
[237.260214] Starting subtest: queue-idle
[237.262124] Starting dynamic subtest: pipe-A-eDP-1
[239.071986] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[239.080325] Starting dynamic subtest: pipe-B-eDP-1
[241.563782] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.491s)
[241.572824] Starting dynamic subtest: pipe-C-eDP-1
[243.983430] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.418s)
[243.992239] Starting dynamic subtest: pipe-D-eDP-1
[246.419448] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.435s)
[246.421798] Subtest queue-idle: SUCCESS (9.161s)
[247.255950] [054/133] (774s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[247.361257] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[247.363508] Starting dynamic subtest: pipe-A-eDP-1
[247.434665] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[247.443818] Starting dynamic subtest: pipe-B-eDP-1
[248.512348] Dynamic subtest pipe-B-eDP-1: SKIP (1.075s)
[248.516659] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.154s)
[249.696986] [055/133] (772s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[249.802151] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[249.806730] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[249.934985] [056/133] (772s left) kms_atomic (atomic-plane-damage)
[250.023454] Starting subtest: atomic-plane-damage
[250.073913] Starting dynamic subtest: pipe-A-eDP-1
[250.623023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.549s)
[250.625357] Subtest atomic-plane-damage: SUCCESS (0.598s)
[251.435729] [057/133] (770s left) kms_big_fb (linear-16bpp-rotate-90)
[251.548940] Starting subtest: linear-16bpp-rotate-90
[251.568663] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[251.742367] [058/133] (770s left) perf (stress-open-close)
[251.873722] Starting subtest: stress-open-close
[251.876070] Starting dynamic subtest: 0-rcs0
[254.035954] Dynamic subtest 0-rcs0: SUCCESS (2.164s)
[254.049062] Starting dynamic subtest: 1-vcs0
[256.202948] Dynamic subtest 1-vcs0: SUCCESS (2.165s)
[256.204959] Subtest stress-open-close: SUCCESS (4.332s)
[256.242283] [059/133] (766s left) gem_workarounds (basic-read-fd)
[256.326980] Starting subtest: basic-read-fd
[256.345259] Subtest basic-read-fd: SUCCESS (0.019s)
[256.498071] [060/133] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[256.612307] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[257.647565] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.034s)
[257.794809] [061/133] (764s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[257.892181] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[257.895532] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[258.004594] [062/133] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[258.101488] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[258.105077] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[258.232855] [063/133] (764s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[258.330254] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[258.333817] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[258.452821] [064/133] (764s left) kms_cursor_crc (cursor-offscreen-32x10)
[258.629450] Starting subtest: cursor-offscreen-32x10
[258.674838] Subtest cursor-offscreen-32x10: SKIP (0.041s)
[258.972076] [065/133] (763s left) kms_psr (psr2-primary-render)
[259.074638] Starting subtest: psr2-primary-render
[259.076599] Starting dynamic subtest: eDP-1
[260.816566] Dynamic subtest eDP-1: SUCCESS (1.741s)
[260.818951] Subtest psr2-primary-render: SUCCESS (1.743s)
[261.689950] [066/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[261.789441] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[261.793486] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[261.931587] [067/133] (760s left) gem_exec_schedule (noreorder-priority)
[262.112766] Starting subtest: noreorder-priority
[262.115293] Starting dynamic subtest: rcs0
[263.291804] Dynamic subtest rcs0: SUCCESS (1.180s)
[263.300974] Starting dynamic subtest: vcs0
[264.923452] Dynamic subtest vcs0: SUCCESS (1.628s)
[264.934880] Starting dynamic subtest: vcs1
[266.823463] Dynamic subtest vcs1: SUCCESS (1.897s)
[266.838450] Starting dynamic subtest: vecs0
[269.932289] Dynamic subtest vecs0: SUCCESS (3.106s)
[269.947972] Starting dynamic subtest: ccs0
[271.097940] Dynamic subtest ccs0: SUCCESS (1.164s)
[271.100717] Subtest noreorder-priority: SUCCESS (8.987s)
[271.296840] [068/133] (751s left) gem_softpin (allocator-evict)
[271.356081] Starting subtest: allocator-evict
[271.358381] Starting dynamic subtest: rcs0
[295.239718] Dynamic subtest rcs0: SUCCESS (23.881s)
[295.252917] Starting dynamic subtest: bcs0
[318.828274] Dynamic subtest bcs0: SUCCESS (23.585s)
[318.837111] Starting dynamic subtest: vcs0
[342.334070] Dynamic subtest vcs0: SUCCESS (23.502s)
[342.344913] Starting dynamic subtest: vcs1
[365.902144] Dynamic subtest vcs1: SUCCESS (23.565s)
[365.911431] Starting dynamic subtest: vecs0
[389.373534] Dynamic subtest vecs0: SUCCESS (23.469s)
[389.384874] Starting dynamic subtest: ccs0
[413.382573] Dynamic subtest ccs0: SUCCESS (24.007s)
[413.384944] Subtest allocator-evict: SUCCESS (142.020s)
[413.474285] [069/133] (609s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[413.615644] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[418.430906] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.819s)
[419.582760] [070/133] (603s left) gem_exec_reloc (basic-cpu-gtt-active)
[419.645474] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[419.735873] [071/133] (603s left) gem_ctx_shared (single-timeline)
[419.803801] Starting subtest: single-timeline
[419.825164] Subtest single-timeline: SUCCESS (0.015s)
[420.073474] [072/133] (602s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[420.133411] Starting subtest: etime-multi-wait-all-for-submit-submitted
[420.242200] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[420.329448] [073/133] (602s left) syncobj_timeline (etime-single-wait-all-submitted)
[420.384084] Starting subtest: etime-single-wait-all-submitted
[420.490077] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s)
[420.579902] [074/133] (602s left) kms_chamelium_hpd (dp-hpd-storm)
[420.974406] Subtest dp-hpd-storm: SKIP (0.000s)
[421.753920] [075/133] (601s left) kms_flip (2x-flip-vs-suspend)
[421.853216] Starting subtest: 2x-flip-vs-suspend
[421.864986] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[421.985821] [076/133] (601s left) kms_psr (fbc-psr2-sprite-plane-move)
[422.084445] Starting subtest: fbc-psr2-sprite-plane-move
[422.086780] Starting dynamic subtest: eDP-1
[422.091190] Dynamic subtest eDP-1: SKIP (0.000s)
[422.095352] Subtest fbc-psr2-sprite-plane-move: SKIP (0.003s)
[422.176078] [077/133] (600s left) gem_exec_params (mmapped)
[422.231750] Starting subtest: mmapped
[422.237069] Subtest mmapped: SUCCESS (0.003s)
[422.367295] [078/133] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[422.469259] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[422.473490] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[422.604404] [079/133] (600s left) sw_sync (sync_merge_invalid)
[422.639873] Starting subtest: sync_merge_invalid
[422.652307] Subtest sync_merge_invalid: SUCCESS (0.016s)
[422.731865] [080/133] (600s left) perf_pmu (busy)
[422.769757] Starting subtest: busy
[422.771763] Starting dynamic subtest: rcs0
[423.383706] Dynamic subtest rcs0: SUCCESS (0.614s)
[423.395381] Starting dynamic subtest: bcs0
[423.957597] Dynamic subtest bcs0: SUCCESS (0.572s)
[423.968972] Starting dynamic subtest: vcs0
[425.942492] Dynamic subtest vcs0: SUCCESS (1.980s)
[425.954120] Starting dynamic subtest: vcs1
[427.926717] Dynamic subtest vcs1: SUCCESS (1.981s)
[427.938135] Starting dynamic subtest: vecs0
[429.911878] Dynamic subtest vecs0: SUCCESS (1.982s)
[429.926099] Starting dynamic subtest: ccs0
[430.487084] Dynamic subtest ccs0: SUCCESS (0.572s)
[430.489580] Subtest busy: SUCCESS (7.719s)
[430.619736] [081/133] (592s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[430.693766] Starting subtest: multi-wait-for-submit-submitted-signaled
[430.696128] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[430.812987] [082/133] (592s left) gem_mmap_wc (write-wc-read-gtt)
[430.866514] Subtest write-wc-read-gtt: SKIP (0.000s)
[430.936779] [083/133] (592s left) kms_hdmi_inject (inject-audio)
[431.287174] Starting subtest: inject-audio
[431.564980] Subtest inject-audio: SUCCESS (0.280s)
[432.135231] [084/133] (591s left) kms_flip (2x-blocking-wf_vblank)
[432.237160] Starting subtest: 2x-blocking-wf_vblank
[432.248479] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[432.383576] [085/133] (590s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[432.472168] Starting subtest: plane-all-transition-nonblocking-fencing
[432.474337] Starting dynamic subtest: pipe-A-eDP-1
[434.965892] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[435.279671] Starting dynamic subtest: pipe-B-eDP-1
[438.498811] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.227s)
[438.796373] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.326s)
[439.611499] [086/133] (583s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[439.746518] Starting subtest: flip-vs-cursor-crc-legacy
[440.442635] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.696s)
[441.301526] [087/133] (582s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[441.410361] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[441.414591] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[441.498737] [088/133] (582s left) gem_exec_params (invalid-ring2)
[441.579311] Starting subtest: invalid-ring2
[441.581648] Subtest invalid-ring2: SUCCESS (0.000s)
[441.731941] [089/133] (581s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[441.841193] Starting subtest: fbcpsr-slowdraw
[466.945199] Subtest fbcpsr-slowdraw: SUCCESS (25.106s)
[467.117106] [090/133] (556s left) kms_joiner (basic-force-ultra-joiner)
[467.222744] Starting subtest: basic-force-ultra-joiner
[467.226837] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[467.302109] [091/133] (556s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[467.392336] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[467.418299] Starting dynamic subtest: pipe-A-plane-0
[467.694777] Dynamic subtest pipe-A-plane-0: SUCCESS (0.277s)
[467.703331] Starting dynamic subtest: pipe-A-plane-3
[467.917034] Dynamic subtest pipe-A-plane-3: SUCCESS (0.221s)
[469.050682] Starting dynamic subtest: pipe-B-plane-0
[469.342114] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[469.350770] Starting dynamic subtest: pipe-B-plane-3
[469.586391] Dynamic subtest pipe-B-plane-3: SUCCESS (0.243s)
[469.910392] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.517s)
[470.723533] [092/133] (552s left) kms_vblank (query-forked-busy-hang)
[470.820153] Starting subtest: query-forked-busy-hang
[470.822327] Starting dynamic subtest: pipe-A-eDP-1
[497.682334] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.862s)
[497.696559] Starting dynamic subtest: pipe-D-eDP-1
[521.694721] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.009s)
[521.697061] Subtest query-forked-busy-hang: SUCCESS (50.875s)
[522.508789] [093/133] (501s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[522.610100] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[522.614435] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[522.747450] [094/133] (500s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[522.861968] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[523.452455] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.592s)
[523.669573] [095/133] (500s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[523.772987] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[523.775119] Starting dynamic subtest: pipe-A-default-mode
[526.489479] Dynamic subtest pipe-A-default-mode: SUCCESS (2.715s)
[526.491310] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.716s)
[527.301648] [096/133] (496s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[527.360414] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[527.465540] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[527.565650] [097/133] (496s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[527.671771] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[527.676118] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[527.797056] [098/133] (496s left) gem_exec_whisper (basic-fds-forked)
[527.870906] Starting subtest: basic-fds-forked
[550.939229] Subtest basic-fds-forked: SUCCESS (23.062s)
[551.124616] [099/133] (472s left) kms_addfb_basic (bad-pitch-999)
[551.197689] Starting subtest: bad-pitch-999
[551.199745] Subtest bad-pitch-999: SUCCESS (0.000s)
[551.360194] [100/133] (472s left) kms_prop_blob (basic)
[551.426802] Starting subtest: basic
[551.428737] Subtest basic: SUCCESS (0.000s)
[551.532980] [101/133] (472s left) syncobj_basic (bad-pad-fd-to-handle)
[551.584294] Starting subtest: bad-pad-fd-to-handle
[551.586161] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[551.712852] [102/133] (472s left) kms_cursor_crc (cursor-sliding-256x256)
[551.958196] Starting subtest: cursor-sliding-256x256
[551.960469] Starting dynamic subtest: pipe-A-eDP-1
[555.206946] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.247s)
[555.233869] Starting dynamic subtest: pipe-D-eDP-1
[559.094822] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.866s)
[559.096689] Subtest cursor-sliding-256x256: SUCCESS (7.136s)
[559.898459] [103/133] (464s left) gem_busy (busy)
[559.972077] Starting subtest: busy
[559.974635] Starting dynamic subtest: all-engines
[560.033280] Dynamic subtest all-engines: SUCCESS (0.061s)
[560.048206] Starting dynamic subtest: rcs0
[561.949951] Dynamic subtest rcs0: SUCCESS (1.914s)
[561.961074] Starting dynamic subtest: bcs0
[561.991050] Dynamic subtest bcs0: SUCCESS (0.038s)
[562.001294] Starting dynamic subtest: vcs0
[562.029212] Dynamic subtest vcs0: SUCCESS (0.038s)
[562.038205] Starting dynamic subtest: vcs1
[563.930909] Dynamic subtest vcs1: SUCCESS (1.898s)
[563.941481] Starting dynamic subtest: vecs0
[565.916109] Dynamic subtest vecs0: SUCCESS (1.983s)
[565.926554] Starting dynamic subtest: ccs0
[567.899662] Dynamic subtest ccs0: SUCCESS (1.981s)
[567.902158] Subtest busy: SUCCESS (7.924s)
[568.273243] [104/133] (455s left) i915_pm_rps (thresholds)
[568.355696] Starting subtest: thresholds
[568.360140] Subtest thresholds: SKIP (0.001s)
[568.451561] [105/133] (455s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[568.544837] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[568.547074] Starting dynamic subtest: pipe-A-eDP-1
[568.569396] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[568.579708] Starting dynamic subtest: pipe-B-eDP-1
[568.600144] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[568.609034] Starting dynamic subtest: pipe-C-eDP-1
[568.630115] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[568.638670] Starting dynamic subtest: pipe-D-eDP-1
[568.660475] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[568.664543] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[570.799660] [106/133] (453s left) gem_softpin (evict-snoop-interruptible)
[570.856102] Starting subtest: evict-snoop-interruptible
[570.860308] Subtest evict-snoop-interruptible: SKIP (0.000s)
[570.998683] [107/133] (453s left) gem_mmap_gtt (big-bo)
[571.046744] Subtest big-bo: SKIP (0.000s)
[571.119049] [108/133] (453s left) gem_partial_pwrite_pread (write-display)
[571.189410] Subtest write-display: SKIP (0.000s)
[571.274181] [109/133] (453s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[571.365278] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[571.367499] Starting dynamic subtest: pipe-A-eDP-1
[571.390208] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[571.401158] Starting dynamic subtest: pipe-B-eDP-1
[571.422527] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[571.431055] Starting dynamic subtest: pipe-C-eDP-1
[571.452304] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[571.461250] Starting dynamic subtest: pipe-D-eDP-1
[571.482883] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[571.487079] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[573.597120] [110/133] (450s left) kms_psr (fbc-pr-cursor-blt)
[573.698149] Starting subtest: fbc-pr-cursor-blt
[573.702183] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[573.797654] [111/133] (450s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[573.855125] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[573.857416] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[573.977604] [112/133] (450s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[574.049095] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[574.053255] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[574.254403] [113/133] (450s left) gem_mmap (basic)
[574.319854] Subtest basic: SKIP (0.000s)
[574.387447] [114/133] (450s left) gem_exec_gttfill (basic)
[574.455336] Starting subtest: basic
[576.847101] Subtest basic: SUCCESS (2.390s)
[577.046157] [115/133] (447s left) kms_addfb_basic (size-max)
[577.193308] Starting subtest: size-max
[577.195636] Subtest size-max: SUCCESS (0.000s)
[577.330837] [116/133] (447s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[577.437210] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[577.439421] Starting dynamic subtest: pipe-A-eDP-1
[577.462344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[577.473447] Starting dynamic subtest: pipe-B-eDP-1
[577.495853] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[577.505902] Starting dynamic subtest: pipe-C-eDP-1
[577.527683] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[577.536381] Starting dynamic subtest: pipe-D-eDP-1
[577.559810] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[577.563986] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[579.698316] [117/133] (444s left) api_intel_bb (purge-bb)
[579.761462] Starting subtest: purge-bb
[579.763780] Subtest purge-bb: SUCCESS (0.003s)
[579.918433] [118/133] (444s left) kms_cursor_legacy (forked-move)
[580.043535] Starting subtest: forked-move
[580.045447] Starting dynamic subtest: pipe-A
[585.562851] Dynamic subtest pipe-A: SUCCESS (5.517s)
[585.576822] Starting dynamic subtest: pipe-B
[591.033229] Dynamic subtest pipe-B: SUCCESS (5.468s)
[591.045376] Starting dynamic subtest: pipe-C
[596.495558] Dynamic subtest pipe-C: SUCCESS (5.461s)
[596.507558] Starting dynamic subtest: pipe-D
[601.957812] Dynamic subtest pipe-D: SUCCESS (5.460s)
[601.967661] Starting dynamic subtest: all-pipes
[607.454054] Dynamic subtest all-pipes: SUCCESS (5.494s)
[607.456531] Subtest forked-move: SUCCESS (27.409s)
[607.609877] [119/133] (417s left) gen9_exec_parse (bb-chained)
[607.677479] Subtest bb-chained: SKIP (0.000s)
[607.751259] [120/133] (417s left) kms_concurrent (multi-plane-atomic-lowres)
[607.848084] Starting subtest: multi-plane-atomic-lowres
[607.850566] Starting dynamic subtest: pipe-A-eDP-1
[608.342305] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.490s)
[608.344644] Subtest multi-plane-atomic-lowres: SUCCESS (0.492s)
[609.199383] [121/133] (415s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[609.270109] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[609.347191] [122/133] (415s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[609.405733] Starting subtest: multi-wait-available-unsubmitted-submitted
[609.408110] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[609.507618] [123/133] (415s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[609.599882] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[614.026281] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.429s)
[615.204099] [124/133] (409s left) kms_pm_dc (dc3co-vpb-simulation)
[616.315955] Starting subtest: dc3co-vpb-simulation
[625.079993] Subtest dc3co-vpb-simulation: SKIP (8.761s)
[625.210913] [125/133] (399s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[625.316442] Starting subtest: x-tiled-8bpp-rotate-90
[625.337124] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[625.473872] [126/133] (399s left) kms_plane_multiple (2x-tiling-none)
[625.568318] Starting subtest: 2x-tiling-none
[625.572582] Subtest 2x-tiling-none: SKIP (0.000s)
[625.650033] [127/133] (399s left) gem_exec_balancer (bonded-false-hang)
[625.909134] Starting subtest: bonded-false-hang
[625.913716] Subtest bonded-false-hang: SKIP (0.000s)
[626.037455] [128/133] (399s left) i915_drm_fdinfo (idle)
[626.078512] Starting subtest: idle
[626.080711] Starting dynamic subtest: rcs0
[626.673572] Dynamic subtest rcs0: SUCCESS (0.596s)
[626.684930] Starting dynamic subtest: bcs0
[627.181531] Dynamic subtest bcs0: SUCCESS (0.503s)
[627.193626] Starting dynamic subtest: vcs0
[627.687038] Dynamic subtest vcs0: SUCCESS (0.503s)
[627.696275] Starting dynamic subtest: vcs1
[628.192798] Dynamic subtest vcs1: SUCCESS (0.503s)
[628.202207] Starting dynamic subtest: vecs0
[628.702624] Dynamic subtest vecs0: SUCCESS (0.503s)
[628.711434] Starting dynamic subtest: ccs0
[629.204167] Dynamic subtest ccs0: SUCCESS (0.503s)
[629.206762] Subtest idle: SUCCESS (3.128s)
[629.304907] [129/133] (395s left) kms_getfb (getfb2-handle-closed)
[629.409738] Starting subtest: getfb2-handle-closed
[629.411904] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[629.534651] [130/133] (395s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[629.603815] Starting subtest: invalid-bsd1-flag-on-vebox
[629.606202] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[629.731016] [131/133] (395s left) kms_psr (fbc-pr-suspend)
[629.824274] Starting subtest: fbc-pr-suspend
[629.828133] Subtest fbc-pr-suspend: SKIP (0.000s)
[629.907397] [132/133] (395s left) gem_softpin (overlap)
[629.971888] Starting subtest: overlap
[630.818672] Subtest overlap: SUCCESS (0.845s)
[630.952453] [133/133] (394s left) gem_madvise (dontneed-before-mmap)
[630.986653] Starting subtest: dontneed-before-mmap
[631.017584] Subtest dontneed-before-mmap: SUCCESS (0.033s)
[631.154317] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_exec_flush
results: parsing output: 2/ for test: kms_lease
results: parsing output: 3/ for test: i915_drm_fdinfo
results: parsing output: 4/ for test: kms_atomic_interruptible
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: api_intel_allocator
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_mmap
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_partial_pwrite_pread
results: parsing output: 21/ for test: syncobj_basic
results: parsing output: 22/ for test: kms_chamelium_frames
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_lmem_swapping
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_basic
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_plane_alpha_blend
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: i915_pm_rps
results: parsing output: 38/ for test: dumb_buffer
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_draw_crc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: vgem_basic
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_atomic
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: perf
results: parsing output: 58/ for test: gem_workarounds
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_softpin
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: gem_ctx_shared
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: kms_hdmi_inject
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_joiner
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_vblank
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_prop_blob
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_busy
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_softpin
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: gem_partial_pwrite_pread
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: gem_mmap
results: parsing output: 113/ for test: gem_exec_gttfill
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: kms_concurrent
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pm_dc
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: kms_getfb
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: gem_madvise
Done.