[58.490395] Initializing watchdogs [58.490441] /dev/watchdog0 [58.505486] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.509972] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.512204] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.515743] [001/133] (960s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [58.642035] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [58.644371] Starting dynamic subtest: pipe-A-default-mode [59.823785] Dynamic subtest pipe-A-default-mode: SKIP (1.172s) [59.828368] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.173s) [59.964966] [002/133] (959s left) i915_pm_rpm (gem-idle) [62.027451] Starting subtest: gem-idle [68.253775] Subtest gem-idle: SUCCESS (6.191s) [68.564541] [003/133] (950s left) vgem_basic (bad-handle) [68.631402] Starting subtest: bad-handle [68.633632] Subtest bad-handle: SUCCESS (0.000s) [68.686243] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true [68.689316] [004/133] (950s left) kms_addfb_basic (bad-pitch-0) [69.880680] Starting subtest: bad-pitch-0 [69.882895] Subtest bad-pitch-0: SUCCESS (0.000s) [70.002163] [005/133] (949s left) kms_atomic_transition (modeset-transition) [70.098118] Starting subtest: modeset-transition [70.100452] Starting dynamic subtest: 1x-outputs [80.902794] Dynamic subtest 1x-outputs: SUCCESS (10.795s) [80.905549] Subtest modeset-transition: SUCCESS (10.796s) [81.774898] [006/133] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [81.870848] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [81.875069] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [81.958229] [007/133] (937s left) gem_exec_fence (invalid-fence-array) [82.382766] Starting subtest: invalid-fence-array [82.385307] Subtest invalid-fence-array: SUCCESS (0.002s) [83.980840] [008/133] (935s left) gem_busy (extended) [84.161792] Starting subtest: extended [84.164762] Starting dynamic subtest: rcs0 [84.245720] Dynamic subtest rcs0: SUCCESS (0.084s) [84.256326] Starting dynamic subtest: bcs0 [84.287516] Dynamic subtest bcs0: SUCCESS (0.041s) [84.297116] Starting dynamic subtest: vcs0 [85.911433] Dynamic subtest vcs0: SUCCESS (1.620s) [85.920481] Starting dynamic subtest: vcs1 [87.948675] Dynamic subtest vcs1: SUCCESS (1.982s) [87.957956] Starting dynamic subtest: vecs0 [89.878832] Dynamic subtest vecs0: SUCCESS (1.979s) [89.887621] Starting dynamic subtest: ccs0 [89.923399] Dynamic subtest ccs0: SUCCESS (0.046s) [89.926061] Subtest extended: SUCCESS (5.759s) [90.136460] [009/133] (929s left) gem_softpin (noreloc-s3) [90.203749] Starting subtest: noreloc-S3 [110.328012] Subtest noreloc-S3: SUCCESS (5.430s) [110.459572] [010/133] (908s left) kms_chamelium_hpd (hdmi-hpd) [110.904110] Subtest hdmi-hpd: SKIP (0.000s) [111.695265] [011/133] (907s left) kms_big_fb (y-tiled-8bpp-rotate-90) [111.792826] Starting subtest: y-tiled-8bpp-rotate-90 [111.797491] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [111.905374] [012/133] (907s left) perf (invalid-create-userspace-config) [112.051821] Starting subtest: invalid-create-userspace-config [112.053764] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [112.098186] [013/133] (907s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [112.185477] Starting subtest: primary-yf-tiled-reflect-x-180 [112.246682] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s) [112.357418] [014/133] (907s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [112.459736] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [119.650513] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.101s) [119.797133] [015/133] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [119.890305] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [119.894897] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [120.009668] [016/133] (899s left) prime_self_import (basic-with_one_bo_two_files) [120.041119] Starting subtest: basic-with_one_bo_two_files [120.071208] Subtest basic-with_one_bo_two_files: SUCCESS (0.029s) [120.183403] [017/133] (899s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [120.282022] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [120.286530] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [120.350090] [018/133] (899s left) gem_wait (await) [120.425207] Starting subtest: await [120.427734] Starting dynamic subtest: all-engines [121.527472] Dynamic subtest all-engines: SUCCESS (1.095s) [121.545129] Starting dynamic subtest: rcs0 [122.591160] Dynamic subtest rcs0: SUCCESS (1.056s) [122.607529] Starting dynamic subtest: bcs0 [123.652856] Dynamic subtest bcs0: SUCCESS (1.053s) [123.667978] Starting dynamic subtest: vcs0 [124.706556] Dynamic subtest vcs0: SUCCESS (1.050s) [124.721916] Starting dynamic subtest: vcs1 [125.759696] Dynamic subtest vcs1: SUCCESS (1.048s) [125.775369] Starting dynamic subtest: vecs0 [126.811911] Dynamic subtest vecs0: SUCCESS (1.047s) [126.826397] Starting dynamic subtest: ccs0 [127.868592] Dynamic subtest ccs0: SUCCESS (1.053s) [127.871244] Subtest await: SUCCESS (7.408s) [128.065539] [019/133] (891s left) kms_flip (2x-plain-flip-fb-recreate) [128.158791] Starting subtest: 2x-plain-flip-fb-recreate [128.169102] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s) [128.250914] [020/133] (891s left) syncobj_timeline (single-wait-all-available-signaled) [128.307163] Starting subtest: single-wait-all-available-signaled [128.309465] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [128.394379] [021/133] (891s left) kms_flip (wf_vblank-ts-check) [128.487708] Starting subtest: wf_vblank-ts-check [128.490118] Starting dynamic subtest: A-eDP1 [137.382577] Dynamic subtest A-eDP1: SUCCESS (8.881s) [137.393596] Starting dynamic subtest: B-eDP1 [146.354963] Dynamic subtest B-eDP1: SUCCESS (8.932s) [146.364945] Starting dynamic subtest: C-eDP1 [155.280841] Dynamic subtest C-eDP1: SUCCESS (8.910s) [155.290017] Starting dynamic subtest: D-eDP1 [164.215977] Dynamic subtest D-eDP1: SUCCESS (8.925s) [164.218093] Subtest wf_vblank-ts-check: SUCCESS (35.657s) [165.386487] [022/133] (854s left) kms_vblank (ts-continuation-dpms-suspend) [165.487558] Starting subtest: ts-continuation-dpms-suspend [165.489973] Starting dynamic subtest: pipe-A-eDP-1 [182.722454] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.866s) [182.737714] Starting dynamic subtest: pipe-D-eDP-1 [200.755836] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.457s) [200.758322] Subtest ts-continuation-dpms-suspend: SUCCESS (4.326s) [201.587761] [023/133] (818s left) kms_cursor_crc (cursor-rapid-movement-512x170) [201.900292] Starting subtest: cursor-rapid-movement-512x170 [201.904235] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [202.052735] [024/133] (817s left) i915_hangman (engine-engine-hang) [202.127855] Starting subtest: engine-engine-hang [202.130199] Starting dynamic subtest: rcs0 [203.286387] Dynamic subtest rcs0: SUCCESS (1.123s) [203.298505] Starting dynamic subtest: bcs0 [205.271238] Dynamic subtest bcs0: SUCCESS (1.935s) [205.282724] Starting dynamic subtest: vcs0 [207.254668] Dynamic subtest vcs0: SUCCESS (1.945s) [207.266762] Starting dynamic subtest: vcs1 [209.239060] Dynamic subtest vcs1: SUCCESS (1.954s) [209.251356] Starting dynamic subtest: vecs0 [211.288380] Dynamic subtest vecs0: SUCCESS (2.024s) [211.299377] Starting dynamic subtest: ccs0 [213.269895] Dynamic subtest ccs0: SUCCESS (1.963s) [213.272715] Subtest engine-engine-hang: SUCCESS (10.952s) [213.353314] [025/133] (806s left) gem_exec_schedule (preempt-queue-contexts-chain) [213.425360] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [213.724178] [026/133] (806s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [213.819686] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [213.821962] Starting dynamic subtest: pipe-A-eDP-1 [214.241624] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.417s) [214.253169] Starting dynamic subtest: pipe-B-eDP-1 [214.274235] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [214.283226] Starting dynamic subtest: pipe-C-eDP-1 [214.302741] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s) [214.311048] Starting dynamic subtest: pipe-D-eDP-1 [214.331898] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [214.334139] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.430s) [216.565393] [027/133] (803s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [216.661128] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [222.011402] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.333s) [223.176567] [028/133] (796s left) i915_selftest (live) [224.884418] Starting subtest: live [224.887087] Starting dynamic subtest: sanitycheck [229.173903] Dynamic subtest sanitycheck: SUCCESS (4.282s) [229.183927] Starting dynamic subtest: uncore [233.501257] Dynamic subtest uncore: SUCCESS (4.322s) [233.509964] Starting dynamic subtest: workarounds [253.247240] Dynamic subtest workarounds: FAIL (19.268s) [253.255145] Starting dynamic subtest: gt_engines [255.775254] Dynamic subtest gt_engines: SUCCESS (3.000s) [255.784480] Starting dynamic subtest: gt_timelines [271.826751] Dynamic subtest gt_timelines: SUCCESS (16.045s) [271.836296] Starting dynamic subtest: gt_contexts [276.135699] Dynamic subtest gt_contexts: SUCCESS (4.306s) [276.145138] Starting dynamic subtest: gt_lrc [280.482356] Dynamic subtest gt_lrc: SUCCESS (4.344s) [280.490035] Starting dynamic subtest: gt_mocs [283.397478] Dynamic subtest gt_mocs: SUCCESS (2.912s) [283.406655] Starting dynamic subtest: gt_pm [290.177506] Dynamic subtest gt_pm: SUCCESS (6.776s) [290.185426] Starting dynamic subtest: gt_heartbeat [294.490260] Dynamic subtest gt_heartbeat: SUCCESS (4.309s) [294.498286] Starting dynamic subtest: gt_tlb [303.827567] Dynamic subtest gt_tlb: SUCCESS (9.337s) [303.842446] Starting dynamic subtest: requests [315.090929] Dynamic subtest requests: SUCCESS (11.264s) [315.099966] Starting dynamic subtest: migrate [322.860194] Dynamic subtest migrate: SUCCESS (7.768s) [322.869263] Starting dynamic subtest: active [327.189783] Dynamic subtest active: SUCCESS (4.329s) [327.201792] Starting dynamic subtest: objects [331.791656] Dynamic subtest objects: SUCCESS (4.600s) [331.801104] Starting dynamic subtest: mman [336.648254] Dynamic subtest mman: SUCCESS (4.854s) [336.657781] Starting dynamic subtest: dmabuf [340.946484] Dynamic subtest dmabuf: SUCCESS (4.297s) [340.955717] Starting dynamic subtest: vma [345.200242] Dynamic subtest vma: SUCCESS (4.252s) [345.208194] Starting dynamic subtest: coherency [348.603088] Dynamic subtest coherency: SUCCESS (3.401s) [348.611950] Starting dynamic subtest: gtt [360.299397] Dynamic subtest gtt: SUCCESS (11.692s) [360.308945] Starting dynamic subtest: gem [367.900214] Dynamic subtest gem: SUCCESS (7.598s) [367.909128] Starting dynamic subtest: evict [373.476479] Dynamic subtest evict: SUCCESS (5.574s) [373.485762] Starting dynamic subtest: hugepages [384.432637] Dynamic subtest hugepages: SUCCESS (10.952s) [384.447250] Starting dynamic subtest: gem_contexts [412.049168] Dynamic subtest gem_contexts: SUCCESS (27.606s) [412.058725] Starting dynamic subtest: client [414.742990] Dynamic subtest client: SUCCESS (2.691s) [414.752151] Starting dynamic subtest: gem_migrate [419.016095] Dynamic subtest gem_migrate: SUCCESS (4.269s) [419.024208] Starting dynamic subtest: reset [423.584724] Dynamic subtest reset: SUCCESS (4.564s) [423.594873] Starting dynamic subtest: memory_region [427.891067] Dynamic subtest memory_region: SUCCESS (4.305s) [427.906083] Starting dynamic subtest: hangcheck [441.327768] Dynamic subtest hangcheck: SUCCESS (13.439s) [441.337716] Starting dynamic subtest: execlists [445.675531] Dynamic subtest execlists: SUCCESS (4.347s) [445.684281] Starting dynamic subtest: ring_submission [449.923818] Dynamic subtest ring_submission: SUCCESS (4.248s) [449.933317] Starting dynamic subtest: perf [454.274536] Dynamic subtest perf: SUCCESS (4.350s) [454.283713] Starting dynamic subtest: slpc [468.360803] Dynamic subtest slpc: SUCCESS (14.086s) [468.368517] Starting dynamic subtest: guc [472.234845] Dynamic subtest guc: SUCCESS (3.872s) [472.244279] Starting dynamic subtest: guc_multi_lrc [476.518543] Dynamic subtest guc_multi_lrc: SUCCESS (4.282s) [476.527713] Starting dynamic subtest: guc_hang [481.435237] Dynamic subtest guc_hang: SUCCESS (4.916s) [481.443223] Starting dynamic subtest: late_gt_pm [485.765838] Dynamic subtest late_gt_pm: SUCCESS (4.328s) [485.768449] Subtest live: FAIL (260.838s) [485.795183] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [485.795930] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [485.799139] [029/133] (534s left) kms_plane (pixel-format-yf-tiled-ccs-modifier) [487.296397] Starting subtest: pixel-format-yf-tiled-ccs-modifier [487.300814] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s) [487.414200] [FACT kms_plane (pixel-format-yf-tiled-ccs-modifier)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [487.415343] [FACT kms_plane (pixel-format-yf-tiled-ccs-modifier)] new: kernel.kmod_is_loaded.i915: true [487.419030] [030/133] (532s left) kms_dither (fb-8bpc-vs-panel-8bpc) [487.510977] Starting subtest: fb-8bpc-vs-panel-8bpc [487.513291] Starting dynamic subtest: pipe-A-eDP-1 [488.963672] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.454s) [488.966017] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.455s) [489.823277] [031/133] (530s left) gem_exec_flush (basic-wb-set-default) [489.882190] Starting subtest: basic-wb-set-default [495.337338] Subtest basic-wb-set-default: SUCCESS (5.455s) [495.517495] [032/133] (524s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [495.619867] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [502.198671] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.581s) [502.345977] [033/133] (517s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [502.440188] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [502.444552] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [503.588036] [034/133] (516s left) kms_cursor_crc (cursor-onscreen-32x10) [503.756155] Starting subtest: cursor-onscreen-32x10 [503.810790] Subtest cursor-onscreen-32x10: SKIP (0.048s) [504.068930] [035/133] (516s left) gem_exec_balancer (bonded-false-hang) [504.326131] Starting subtest: bonded-false-hang [504.331323] Subtest bonded-false-hang: SKIP (0.000s) [504.428428] [036/133] (515s left) prime_mmap (test_reprime) [504.484775] Starting subtest: test_reprime [504.487321] Starting dynamic subtest: test_reprime-smem [504.513792] Dynamic subtest test_reprime-smem: SUCCESS (0.032s) [504.516305] Subtest test_reprime: SUCCESS (0.032s) [504.610994] [037/133] (515s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [504.695351] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [504.699536] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [504.766243] [038/133] (515s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [505.147772] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [505.984758] [039/133] (514s left) gen9_exec_parse (unaligned-jump) [506.042215] Subtest unaligned-jump: SKIP (0.000s) [506.111808] [040/133] (514s left) gem_ctx_persistence (legacy-engines-mixed-process) [506.181233] Starting subtest: legacy-engines-mixed-process [506.183654] Starting dynamic subtest: render [507.304094] Dynamic subtest render: SUCCESS (1.120s) [507.313613] Starting dynamic subtest: bsd1 [509.310252] Dynamic subtest bsd1: SUCCESS (2.006s) [509.319716] Starting dynamic subtest: bsd2 [511.304301] Dynamic subtest bsd2: SUCCESS (1.992s) [511.315389] Starting dynamic subtest: blt [513.350745] Dynamic subtest blt: SUCCESS (2.044s) [513.361176] Starting dynamic subtest: vebox [515.318373] Dynamic subtest vebox: SUCCESS (1.966s) [515.320749] Subtest legacy-engines-mixed-process: SUCCESS (9.136s) [515.396150] [041/133] (505s left) prime_vgem (basic-blt) [515.469933] Starting subtest: basic-blt [515.520346] Subtest basic-blt: SUCCESS (0.051s) [515.640728] [042/133] (505s left) gen9_exec_parse (bb-oversize) [515.700019] Subtest bb-oversize: SKIP (0.000s) [515.764930] [043/133] (504s left) perf (mi-rpc) [515.895024] Starting subtest: mi-rpc [515.899331] Subtest mi-rpc: SKIP (0.000s) [515.940776] [044/133] (504s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [516.044360] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [516.046573] Starting dynamic subtest: pipe-A-eDP-1 [516.069049] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [516.081460] Starting dynamic subtest: pipe-B-eDP-1 [516.104030] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [516.119560] Starting dynamic subtest: pipe-C-eDP-1 [516.141035] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [516.150195] Starting dynamic subtest: pipe-D-eDP-1 [516.171756] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [516.175723] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [518.278155] [045/133] (502s left) gem_set_tiling_vs_blt (untiled-to-tiled) [518.341075] Subtest untiled-to-tiled: SKIP (0.000s) [518.442844] [046/133] (502s left) gem_mmap_wc (bad-object) [518.509660] Subtest bad-object: SKIP (0.000s) [518.573375] [047/133] (502s left) syncobj_timeline (multi-wait-all-signaled) [518.634342] Starting subtest: multi-wait-all-signaled [518.636825] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [518.740751] [048/133] (502s left) kms_psr (fbc-psr2-cursor-plane-onoff) [518.834363] Starting subtest: fbc-psr2-cursor-plane-onoff [518.836702] Starting dynamic subtest: eDP-1 [518.841078] Dynamic subtest eDP-1: SKIP (0.000s) [518.845426] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [518.906265] [049/133] (502s left) kms_big_fb (linear-64bpp-rotate-0) [519.009909] Starting subtest: linear-64bpp-rotate-0 [520.611531] Subtest linear-64bpp-rotate-0: SUCCESS (1.602s) [520.744601] [050/133] (500s left) gem_exec_alignment (pi) [520.810922] Starting subtest: pi [573.647585] Subtest pi: SUCCESS (52.827s) [574.791194] [051/133] (446s left) kms_joiner (basic-big-joiner) [574.944570] Starting subtest: basic-big-joiner [574.949054] Subtest basic-big-joiner: SKIP (0.000s) [575.008807] [052/133] (446s left) api_intel_bb (intel-bb-blit-none) [575.072898] Starting subtest: intel-bb-blit-none [579.031267] Subtest intel-bb-blit-none: SUCCESS (3.960s) [579.172699] [053/133] (441s left) kms_big_fb (4-tiled-8bpp-rotate-270) [579.283995] Starting subtest: 4-tiled-8bpp-rotate-270 [579.308066] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s) [579.406792] [054/133] (441s left) syncobj_basic (bad-fd-to-handle) [579.468070] Starting subtest: bad-fd-to-handle [579.470023] Subtest bad-fd-to-handle: SUCCESS (0.000s) [579.569077] [055/133] (441s left) gem_ctx_param (invalid-size-get) [579.627747] Starting subtest: invalid-size-get [579.630134] Subtest invalid-size-get: SUCCESS (0.001s) [579.727875] [056/133] (441s left) gem_exec_fence (syncobj-wait) [580.191797] Starting subtest: syncobj-wait [581.328086] Subtest syncobj-wait: SUCCESS (1.135s) [581.689007] [057/133] (439s left) gem_exec_schedule (preempt-queue-chain) [581.778214] Subtest preempt-queue-chain: SKIP (0.000s) [582.066723] [058/133] (439s left) kms_selftest (drm_dp_mst_helper) [582.114964] Starting subtest: drm_dp_mst_helper [582.123142] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [582.213929] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.091s) [582.225586] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [582.348710] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.132s) [582.359050] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [582.445418] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.097s) [582.447501] Subtest drm_dp_mst_helper: SUCCESS (0.329s) [582.591707] [059/133] (438s left) gem_mmap_gtt (isolation) [582.647934] Subtest isolation: SKIP (0.000s) [582.709799] [060/133] (438s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [582.811714] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [582.815720] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [582.893341] [061/133] (438s left) kms_psr (pr-dpms) [582.981290] Starting subtest: pr-dpms [582.985618] Subtest pr-dpms: SKIP (0.000s) [583.055134] [062/133] (438s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [583.142294] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [583.146419] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [583.252484] [063/133] (438s left) gem_exec_fence (basic-busy-all) [583.318708] Starting subtest: basic-busy-all [583.401033] Subtest basic-busy-all: SUCCESS (0.083s) [585.424694] [064/133] (436s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [585.480649] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [585.482695] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [585.571383] [065/133] (436s left) kms_cdclk (mode-transition) [585.673363] Starting subtest: mode-transition [585.675961] Starting dynamic subtest: pipe-A-eDP-1 [585.961871] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s) [585.971677] Starting dynamic subtest: pipe-B-eDP-1 [585.976972] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [585.988510] Starting dynamic subtest: pipe-C-eDP-1 [585.992925] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [586.002096] Starting dynamic subtest: pipe-D-eDP-1 [586.006384] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [586.010770] Subtest mode-transition: SKIP (0.293s) [586.810069] [066/133] (434s left) kms_flip (bo-too-big-interruptible) [586.906014] Starting subtest: bo-too-big-interruptible [586.908246] Starting dynamic subtest: A-eDP1 [588.273493] Dynamic subtest A-eDP1: SUCCESS (1.366s) [588.288966] Starting dynamic subtest: B-eDP1 [589.587789] Dynamic subtest B-eDP1: SUCCESS (1.311s) [589.597802] Starting dynamic subtest: C-eDP1 [590.829712] Dynamic subtest C-eDP1: SUCCESS (1.240s) [590.841701] Starting dynamic subtest: D-eDP1 [592.079695] Dynamic subtest D-eDP1: SUCCESS (1.249s) [592.085118] Subtest bo-too-big-interruptible: SUCCESS (5.178s) [593.289858] [067/133] (428s left) gem_ctx_isolation (dirty-create) [593.354708] Starting subtest: dirty-create [593.357144] Starting dynamic subtest: rcs0 [593.551105] Dynamic subtest rcs0: SUCCESS (0.196s) [593.564378] Starting dynamic subtest: bcs0 [593.771737] Dynamic subtest bcs0: SUCCESS (0.219s) [593.783992] Starting dynamic subtest: vcs0 [593.980674] Dynamic subtest vcs0: SUCCESS (0.208s) [593.991097] Starting dynamic subtest: vcs1 [595.489871] Dynamic subtest vcs1: SUCCESS (1.508s) [595.499638] Starting dynamic subtest: vecs0 [597.506392] Dynamic subtest vecs0: SUCCESS (2.015s) [597.518015] Starting dynamic subtest: ccs0 [599.557838] Dynamic subtest ccs0: SUCCESS (2.050s) [599.560241] Subtest dirty-create: SUCCESS (6.202s) [599.794388] [068/133] (421s left) kms_pipe_stress (stress-xrgb8888-untiled) [599.899072] Starting subtest: stress-xrgb8888-untiled [605.800894] Subtest stress-xrgb8888-untiled: SUCCESS (5.901s) [605.856294] [069/133] (415s left) gem_close_race (basic-process) [605.922147] Starting subtest: basic-process [605.972198] Subtest basic-process: SUCCESS (0.052s) [606.157941] [070/133] (415s left) kms_feature_discovery (psr1) [606.255903] Starting subtest: psr1 [606.258117] Subtest psr1: SUCCESS (0.000s) [606.328356] [071/133] (415s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [606.427925] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [607.417495] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.989s) [607.541276] [072/133] (414s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [607.642428] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [607.646695] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s) [607.757050] [073/133] (414s left) gem_exec_balancer (sliced) [607.825648] Starting subtest: sliced [607.829280] Subtest sliced: SKIP (0.000s) [608.133537] [074/133] (413s left) perf_pmu (busy-double-start) [608.169750] Starting subtest: busy-double-start [608.171969] Starting dynamic subtest: rcs0 [611.810142] Dynamic subtest rcs0: FAIL (3.589s) [611.819869] Starting dynamic subtest: bcs0 [615.328280] Dynamic subtest bcs0: SUCCESS (3.570s) [615.339499] Starting dynamic subtest: vcs0 [619.851492] Dynamic subtest vcs0: SUCCESS (4.520s) [619.869221] Starting dynamic subtest: vcs1 [623.893877] Dynamic subtest vcs1: SUCCESS (4.038s) [623.906412] Starting dynamic subtest: vecs0 [627.861192] Dynamic subtest vecs0: SUCCESS (3.964s) [627.873525] Starting dynamic subtest: ccs0 [631.495475] Dynamic subtest ccs0: FAIL (3.565s) [631.497463] Subtest busy-double-start: FAIL (23.258s) [631.538797] [075/133] (390s left) kms_flip (flip-vs-expired-vblank) [631.645314] Starting subtest: flip-vs-expired-vblank [631.647564] Starting dynamic subtest: A-eDP1 [640.325953] Dynamic subtest A-eDP1: SUCCESS (8.643s) [640.337503] Starting dynamic subtest: B-eDP1 [648.918472] Dynamic subtest B-eDP1: SUCCESS (8.624s) [648.928111] Starting dynamic subtest: C-eDP1 [657.584889] Dynamic subtest C-eDP1: SUCCESS (8.616s) [657.594547] Starting dynamic subtest: D-eDP1 [666.216504] Dynamic subtest D-eDP1: SUCCESS (8.628s) [666.218691] Subtest flip-vs-expired-vblank: SUCCESS (34.526s) [667.346063] [076/133] (354s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [667.446695] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [676.069572] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.623s) [676.169218] [077/133] (346s left) perf (buffer-fill) [676.273277] Starting subtest: buffer-fill [676.275631] Starting dynamic subtest: 0-rcs0 [678.519538] Dynamic subtest 0-rcs0: SUCCESS (2.243s) [678.533103] Starting dynamic subtest: 1-vcs0 [682.954406] Dynamic subtest 1-vcs0: SUCCESS (4.434s) [682.957016] Subtest buffer-fill: SUCCESS (6.680s) [682.993201] [078/133] (339s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait) [684.535430] Starting subtest: modeset-non-lpsp-stress-no-wait [684.575600] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.041s) [685.278107] [079/133] (337s left) kms_content_protection (atomic-dpms-hdcp14) [685.412658] Starting subtest: atomic-dpms-hdcp14 [685.417126] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [685.538749] [080/133] (336s left) prime_vgem (basic-fence-read) [685.613103] Starting subtest: basic-fence-read [685.630490] Subtest basic-fence-read: SKIP (0.016s) [685.743030] [081/133] (336s left) kms_properties (get_properties-sanity-non-atomic) [685.834597] Starting subtest: get_properties-sanity-non-atomic [685.836739] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s) [685.908033] [082/133] (336s left) gem_partial_pwrite_pread (write) [685.967382] Subtest write: SKIP (0.000s) [686.052532] [083/133] (336s left) kms_properties (plane-properties-atomic) [686.144991] Starting subtest: plane-properties-atomic [686.147300] Starting dynamic subtest: pipe-A-eDP-1 [686.705363] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s) [686.718081] Starting dynamic subtest: pipe-B-eDP-1 [687.944520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.241s) [687.954938] Starting dynamic subtest: pipe-C-eDP-1 [689.183234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s) [689.194531] Starting dynamic subtest: pipe-D-eDP-1 [690.412826] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s) [690.415114] Subtest plane-properties-atomic: SUCCESS (4.273s) [691.215003] [084/133] (331s left) syncobj_timeline (invalid-wait-bad-flags) [691.274136] Starting subtest: invalid-wait-bad-flags [691.276067] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [691.380930] [085/133] (331s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [691.491187] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [691.495114] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [691.590713] [086/133] (330s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [691.680725] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [691.685093] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [691.762013] [087/133] (330s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [691.850219] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [691.854560] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [692.940951] [088/133] (329s left) gem_readwrite (write-bad-handle) [692.995687] Subtest write-bad-handle: SKIP (0.000s) [693.056039] [089/133] (329s left) sw_sync (timeline_closed_signaled) [693.105231] Starting subtest: timeline_closed_signaled [693.107652] Subtest timeline_closed_signaled: SUCCESS (0.000s) [693.167000] [090/133] (329s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [695.494644] Starting subtest: dpms-mode-unset-non-lpsp [696.652162] Subtest dpms-mode-unset-non-lpsp: SKIP (1.152s) [697.030026] [091/133] (325s left) kms_addfb_basic (bad-pitch-63) [697.095578] Starting subtest: bad-pitch-63 [697.097662] Subtest bad-pitch-63: SUCCESS (0.000s) [697.226664] [092/133] (325s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [697.323746] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [697.327641] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [697.423191] [093/133] (325s left) gem_userptr_blits (map-fixed-invalidate-busy) [697.499370] Starting subtest: map-fixed-invalidate-busy [697.503769] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [697.613542] [094/133] (325s left) perf_pmu (busy-idle) [697.651081] Starting subtest: busy-idle [697.653348] Starting dynamic subtest: rcs0 [698.343134] Dynamic subtest rcs0: SUCCESS (0.693s) [698.353249] Starting dynamic subtest: bcs0 [699.021345] Dynamic subtest bcs0: SUCCESS (0.676s) [699.034362] Starting dynamic subtest: vcs0 [700.344685] Dynamic subtest vcs0: SUCCESS (1.320s) [700.358057] Starting dynamic subtest: vcs1 [702.328138] Dynamic subtest vcs1: SUCCESS (1.982s) [702.341061] Starting dynamic subtest: vecs0 [704.311937] Dynamic subtest vecs0: SUCCESS (1.982s) [704.325227] Starting dynamic subtest: ccs0 [704.975087] Dynamic subtest ccs0: SUCCESS (0.662s) [704.977716] Subtest busy-idle: SUCCESS (7.329s) [705.091684] [095/133] (317s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [705.190508] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [705.194862] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [705.312826] [096/133] (317s left) kms_psr (psr-sprite-mmap-gtt) [705.404620] Starting subtest: psr-sprite-mmap-gtt [705.406836] Starting dynamic subtest: eDP-1 [706.831425] Dynamic subtest eDP-1: SKIP (1.424s) [706.836537] Subtest psr-sprite-mmap-gtt: SKIP (1.426s) [707.011703] [097/133] (316s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [707.140820] Starting subtest: cursorB-vs-flipA-varying-size [707.145391] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s) [707.283959] [098/133] (315s left) gem_create (create-ext-placement-all) [707.459738] Starting subtest: create-ext-placement-all [707.461840] Subtest create-ext-placement-all: SUCCESS (0.000s) [707.568594] [099/133] (315s left) gem_render_copy (linear-to-vebox-yf-tiled) [707.627378] Starting subtest: linear-to-vebox-yf-tiled [707.632301] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [707.826177] [100/133] (315s left) kms_color (ctm-max) [707.919840] Starting subtest: ctm-max [707.921833] Starting dynamic subtest: pipe-A-eDP-1 [708.627770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s) [708.639212] Starting dynamic subtest: pipe-B-eDP-1 [710.050406] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s) [710.061061] Starting dynamic subtest: pipe-C-eDP-1 [711.428903] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s) [711.439598] Starting dynamic subtest: pipe-D-eDP-1 [712.758200] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s) [712.760536] Subtest ctm-max: SUCCESS (4.841s) [713.556839] [101/133] (309s left) kms_psr (psr2-no-drrs) [713.664879] Starting subtest: psr2-no-drrs [713.667246] Starting dynamic subtest: eDP-1 [715.240081] Dynamic subtest eDP-1: SUCCESS (1.575s) [715.242404] Subtest psr2-no-drrs: SUCCESS (1.576s) [716.045678] [102/133] (307s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [716.175393] Starting subtest: yf-tiled-8bpp-rotate-270 [716.179961] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [716.289924] [103/133] (307s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [716.371564] Starting subtest: async-flip-with-page-flip-events-linear-atomic [716.748614] Starting dynamic subtest: pipe-A-eDP-1 [719.583326] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.782s) [719.916132] Starting dynamic subtest: pipe-B-eDP-1 [722.707016] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.751s) [723.031288] Starting dynamic subtest: pipe-C-eDP-1 [725.843827] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s) [726.165094] Starting dynamic subtest: pipe-D-eDP-1 [728.964971] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.756s) [728.967267] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.547s) [730.097063] [104/133] (293s left) kms_psr2_su (page_flip-xrgb8888) [730.161233] Subtest page_flip-XRGB8888: SKIP (0.000s) [730.221904] [105/133] (293s left) syncobj_eventfd (invalid-illegal-handle) [730.269537] Starting subtest: invalid-illegal-handle [730.271738] Subtest invalid-illegal-handle: SUCCESS (0.000s) [730.369815] [106/133] (293s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [730.463648] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [730.467755] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [730.566295] [107/133] (292s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [730.660490] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [730.664416] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [730.743094] [108/133] (292s left) gem_mmap_gtt (basic-small-bo-tiledx) [730.808814] Subtest basic-small-bo-tiledX: SKIP (0.000s) [730.873699] [109/133] (292s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [730.962031] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [730.966089] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [731.066371] [110/133] (292s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [731.164329] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [732.277358] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.112s) [732.389754] [111/133] (291s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [732.503228] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [732.506527] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [732.572372] [112/133] (291s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [732.637858] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [732.741073] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s) [732.818074] [113/133] (290s left) gem_softpin (allocator-basic) [732.884048] Starting subtest: allocator-basic [732.952486] Subtest allocator-basic: SUCCESS (0.068s) [733.081315] [114/133] (290s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [733.177145] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [733.181569] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [733.277225] [115/133] (290s left) gem_flink_basic (bad-open) [733.331122] Starting subtest: bad-open [733.333496] Subtest bad-open: SUCCESS (0.000s) [733.439802] [116/133] (290s left) gem_exec_whisper (basic-fds-priority-all) [733.500172] Starting subtest: basic-fds-priority-all [757.276657] Subtest basic-fds-priority-all: SUCCESS (23.776s) [757.463535] [117/133] (266s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [757.568787] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [757.570966] Starting dynamic subtest: pipe-A [757.593225] Dynamic subtest pipe-A: SKIP (0.018s) [757.603879] Starting dynamic subtest: pipe-B [757.624056] Dynamic subtest pipe-B: SKIP (0.031s) [757.635497] Starting dynamic subtest: pipe-C [757.655644] Dynamic subtest pipe-C: SKIP (0.031s) [757.665816] Starting dynamic subtest: pipe-D [757.686279] Dynamic subtest pipe-D: SKIP (0.031s) [757.690014] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.113s) [757.794594] [118/133] (266s left) gem_ctx_param (basic) [757.839347] Starting subtest: basic [757.841660] Subtest basic: SUCCESS (0.001s) [757.933798] [119/133] (266s left) kms_cursor_edge_walk (64x64-top-bottom) [758.033095] Starting subtest: 64x64-top-bottom [758.036042] Starting dynamic subtest: pipe-A-eDP-1 [761.463593] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.433s) [761.474375] Starting dynamic subtest: pipe-D-eDP-1 [764.588501] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s) [764.590693] Subtest 64x64-top-bottom: SUCCESS (6.560s) [765.399431] [120/133] (258s left) kms_psr (fbc-psr-primary-blt) [765.495653] Starting subtest: fbc-psr-primary-blt [765.498019] Starting dynamic subtest: eDP-1 [765.502458] Dynamic subtest eDP-1: SKIP (0.000s) [765.506860] Subtest fbc-psr-primary-blt: SKIP (0.001s) [765.568730] [121/133] (258s left) gem_mmap_gtt (cpuset-big-copy-xy) [765.634097] Subtest cpuset-big-copy-XY: SKIP (0.000s) [765.699193] [122/133] (258s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [765.760337] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [765.764495] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [765.959816] [123/133] (258s left) api_intel_allocator (default-alignment) [766.018576] Starting subtest: default-alignment [766.020515] Subtest default-alignment: SUCCESS (0.003s) [766.113616] [124/133] (258s left) kms_lease (lease-get) [766.202572] Starting subtest: lease-get [766.205290] Starting dynamic subtest: pipe-A-eDP-1 [766.208110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [766.219170] Starting dynamic subtest: pipe-B-eDP-1 [766.221503] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [766.231547] Starting dynamic subtest: pipe-C-eDP-1 [766.233736] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [766.243514] Starting dynamic subtest: pipe-D-eDP-1 [766.245759] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [766.247650] Subtest lease-get: SUCCESS (0.010s) [766.303360] [125/133] (257s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [766.398585] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [773.020753] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.624s) [773.157871] [126/133] (251s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [773.252846] Starting subtest: plane-use-after-nonblocking-unbind [773.255116] Starting dynamic subtest: pipe-A-eDP-1 [773.315163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s) [773.612421] Starting dynamic subtest: pipe-B-eDP-1 [774.434008] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.833s) [774.750072] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.497s) [775.601897] [127/133] (248s left) kms_busy (extended-pageflip-hang-newfb) [775.704644] Starting subtest: extended-pageflip-hang-newfb [775.707098] Starting dynamic subtest: pipe-A [802.138728] Dynamic subtest pipe-A: SUCCESS (26.432s) [802.149976] Starting dynamic subtest: pipe-D [827.086741] Dynamic subtest pipe-D: SUCCESS (24.938s) [827.091125] Subtest extended-pageflip-hang-newfb: SUCCESS (51.378s) [827.882182] [128/133] (196s left) dumb_buffer (create-valid-dumb) [827.938227] Starting subtest: create-valid-dumb [827.940224] Subtest create-valid-dumb: SUCCESS (0.000s) [828.052306] [129/133] (196s left) gem_lmem_swapping (heavy-multi) [828.095142] Subtest heavy-multi: SKIP (0.000s) [828.137264] [130/133] (196s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [828.235976] Starting subtest: psr-1p-primscrn-cur-indfb-move [835.592263] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.357s) [835.773042] [131/133] (188s left) perf_pmu (all-busy-check-all) [835.823221] Starting subtest: all-busy-check-all [837.304751] Subtest all-busy-check-all: SUCCESS (1.480s) [837.400357] [132/133] (187s left) gem_exec_nop (basic-parallel) [837.474271] Starting subtest: basic-parallel [853.305551] Subtest basic-parallel: SUCCESS (15.839s) [853.543331] [133/133] (171s left) gem_exec_flush (basic-batch-kernel-default-uc) [853.606176] Starting subtest: basic-batch-kernel-default-uc [860.124740] Subtest basic-batch-kernel-default-uc: SUCCESS (6.518s) [860.317632] Closing watchdogs results: parsing output: 0/ for test: kms_flip_scaled_crc results: parsing output: 1/ for test: i915_pm_rpm results: parsing output: 2/ for test: vgem_basic results: parsing output: 3/ for test: kms_addfb_basic results: parsing output: 4/ for test: kms_atomic_transition results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_exec_fence results: parsing output: 7/ for test: gem_busy results: parsing output: 8/ for test: gem_softpin results: parsing output: 9/ for test: kms_chamelium_hpd results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: perf results: parsing output: 12/ for test: kms_rotation_crc results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: prime_self_import results: parsing output: 16/ for test: kms_psr2_sf results: parsing output: 17/ for test: gem_wait results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: kms_vblank results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: i915_hangman results: parsing output: 24/ for test: gem_exec_schedule results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: i915_selftest results: parsing output: 28/ for test: kms_plane results: parsing output: 29/ for test: kms_dither results: parsing output: 30/ for test: gem_exec_flush results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: gem_exec_balancer results: parsing output: 35/ for test: prime_mmap results: parsing output: 36/ for test: kms_plane results: parsing output: 37/ for test: kms_chamelium_edid results: parsing output: 38/ for test: gen9_exec_parse results: parsing output: 39/ for test: gem_ctx_persistence results: parsing output: 40/ for test: prime_vgem results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: perf results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: gem_set_tiling_vs_blt results: parsing output: 45/ for test: gem_mmap_wc results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: gem_exec_alignment results: parsing output: 50/ for test: kms_joiner results: parsing output: 51/ for test: api_intel_bb results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: syncobj_basic results: parsing output: 54/ for test: gem_ctx_param results: parsing output: 55/ for test: gem_exec_fence results: parsing output: 56/ for test: gem_exec_schedule results: parsing output: 57/ for test: kms_selftest results: parsing output: 58/ for test: gem_mmap_gtt results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_exec_fence results: parsing output: 63/ for test: syncobj_wait results: parsing output: 64/ for test: kms_cdclk results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: gem_ctx_isolation results: parsing output: 67/ for test: kms_pipe_stress results: parsing output: 68/ for test: gem_close_race results: parsing output: 69/ for test: kms_feature_discovery results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: kms_plane results: parsing output: 72/ for test: gem_exec_balancer results: parsing output: 73/ for test: perf_pmu results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: perf results: parsing output: 77/ for test: kms_pm_rpm results: parsing output: 78/ for test: kms_content_protection results: parsing output: 79/ for test: prime_vgem results: parsing output: 80/ for test: kms_properties results: parsing output: 81/ for test: gem_partial_pwrite_pread results: parsing output: 82/ for test: kms_properties results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_flip_scaled_crc results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: gem_readwrite results: parsing output: 88/ for test: sw_sync results: parsing output: 89/ for test: kms_pm_rpm results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: gem_userptr_blits results: parsing output: 93/ for test: perf_pmu results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_psr results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: gem_create results: parsing output: 98/ for test: gem_render_copy results: parsing output: 99/ for test: kms_color results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_async_flips results: parsing output: 103/ for test: kms_psr2_su results: parsing output: 104/ for test: syncobj_eventfd results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_mmap_gtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_big_fb results: parsing output: 110/ for test: kms_psr2_sf results: parsing output: 111/ for test: syncobj_timeline results: parsing output: 112/ for test: gem_softpin results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_flink_basic results: parsing output: 115/ for test: gem_exec_whisper results: parsing output: 116/ for test: kms_plane_scaling results: parsing output: 117/ for test: gem_ctx_param results: parsing output: 118/ for test: kms_cursor_edge_walk results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: gem_mmap_gtt results: parsing output: 121/ for test: gem_render_copy results: parsing output: 122/ for test: api_intel_allocator results: parsing output: 123/ for test: kms_lease results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_atomic_transition results: parsing output: 126/ for test: kms_busy results: parsing output: 127/ for test: dumb_buffer results: parsing output: 128/ for test: gem_lmem_swapping results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: perf_pmu results: parsing output: 131/ for test: gem_exec_nop results: parsing output: 132/ for test: gem_exec_flush Done.