[57.970429] Initializing watchdogs [57.970470] /dev/watchdog0 [57.985043] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [57.989898] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.992108] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.995284] [001/156] (960s left) syncobj_timeline (transfer-timeline-point) [58.075980] Starting subtest: transfer-timeline-point [58.078308] Subtest transfer-timeline-point: SUCCESS (0.000s) [58.181114] [002/156] (960s left) gem_vm_create (execbuf) [58.252666] Starting subtest: execbuf [58.261027] Subtest execbuf: SUCCESS (0.011s) [58.381325] [003/156] (960s left) kms_flip (flip-vs-expired-vblank) [58.470378] Starting subtest: flip-vs-expired-vblank [58.472286] Starting dynamic subtest: A-eDP1 [67.179637] Dynamic subtest A-eDP1: SUCCESS (8.737s) [67.189042] Starting dynamic subtest: B-eDP1 [75.889331] Dynamic subtest B-eDP1: SUCCESS (8.716s) [75.897768] Starting dynamic subtest: C-eDP1 [84.612945] Dynamic subtest C-eDP1: SUCCESS (8.725s) [84.620960] Starting dynamic subtest: D-eDP1 [93.333649] Dynamic subtest D-eDP1: SUCCESS (8.720s) [93.338271] Subtest flip-vs-expired-vblank: SUCCESS (34.905s) [94.517596] [004/156] (924s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt) [94.600189] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt [94.604504] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [94.696445] [005/156] (923s left) perf_pmu (busy-start) [94.741350] Starting subtest: busy-start [94.743685] Starting dynamic subtest: rcs0 [97.293857] Dynamic subtest rcs0: SUCCESS (2.554s) [97.305651] Starting dynamic subtest: bcs0 [99.845058] Dynamic subtest bcs0: SUCCESS (2.549s) [99.855985] Starting dynamic subtest: vcs0 [103.230649] Dynamic subtest vcs0: SUCCESS (3.383s) [103.241036] Starting dynamic subtest: vcs1 [107.197426] Dynamic subtest vcs1: SUCCESS (3.966s) [107.208096] Starting dynamic subtest: vecs0 [111.229201] Dynamic subtest vecs0: SUCCESS (4.031s) [111.239839] Starting dynamic subtest: ccs0 [113.775635] Dynamic subtest ccs0: SUCCESS (2.547s) [113.778597] Subtest busy-start: SUCCESS (19.036s) [113.883068] [006/156] (904s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [113.966783] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [113.969071] Starting dynamic subtest: pipe-A [113.989118] Dynamic subtest pipe-A: SKIP (0.018s) [113.998045] Starting dynamic subtest: pipe-B [114.020081] Dynamic subtest pipe-B: SKIP (0.031s) [114.027877] Starting dynamic subtest: pipe-C [114.052116] Dynamic subtest pipe-C: SKIP (0.031s) [114.059850] Starting dynamic subtest: pipe-D [114.088643] Dynamic subtest pipe-D: SKIP (0.035s) [114.092964] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.117s) [114.167937] [007/156] (904s left) syncobj_wait (wait-zero-handles) [114.221750] Starting subtest: wait-zero-handles [114.223862] Subtest wait-zero-handles: SUCCESS (0.000s) [114.338727] [008/156] (904s left) intel_hwmon (hwmon-write) [114.396835] Subtest hwmon-write: SKIP (0.000s) [114.454590] [009/156] (904s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [114.510844] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [114.617909] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s) [114.694331] [010/156] (904s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-onoff) [114.780370] Starting subtest: fbchdr-1p-primscrn-cur-indfb-onoff [114.784886] Subtest fbchdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [114.888858] [011/156] (903s left) gem_ctx_persistence (legacy-engines-queued) [114.950643] Starting subtest: legacy-engines-queued [114.952577] Starting dynamic subtest: render [115.029188] Dynamic subtest render: SUCCESS (0.080s) [115.040228] Starting dynamic subtest: bsd1 [116.188706] Dynamic subtest bsd1: SUCCESS (1.155s) [116.200149] Starting dynamic subtest: bsd2 [118.171037] Dynamic subtest bsd2: SUCCESS (1.981s) [118.181925] Starting dynamic subtest: blt [118.204314] Dynamic subtest blt: SUCCESS (0.033s) [118.213244] Starting dynamic subtest: vebox [120.218816] Dynamic subtest vebox: SUCCESS (2.012s) [120.222446] Subtest legacy-engines-queued: SUCCESS (5.269s) [120.297182] [012/156] (898s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [120.381817] Starting subtest: psr-1p-primscrn-spr-indfb-move [127.811112] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.435s) [127.944818] [013/156] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [128.036691] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [131.598460] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.567s) [132.770105] [014/156] (886s left) kms_big_fb (linear-32bpp-rotate-180) [132.855874] Starting subtest: linear-32bpp-rotate-180 [134.389616] Subtest linear-32bpp-rotate-180: SUCCESS (1.534s) [134.518475] [015/156] (884s left) kms_frontbuffer_tracking (psr-suspend) [134.609250] Starting subtest: psr-suspend [173.599726] Subtest psr-suspend: SUCCESS (8.180s) [173.706045] [016/156] (845s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [173.790705] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [173.795031] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [173.883328] [017/156] (845s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-fullscreen) [173.971899] Starting subtest: fbchdr-2p-primscrn-spr-indfb-fullscreen [173.976190] Subtest fbchdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [174.073578] [018/156] (845s left) gem_workarounds (basic-read-context) [174.137423] Starting subtest: basic-read-context [174.147368] Subtest basic-read-context: SUCCESS (0.010s) [174.270396] [019/156] (844s left) kms_plane_scaling (invalid-num-scalers) [174.343368] Starting subtest: invalid-num-scalers [174.345558] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [174.361205] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s) [174.370678] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [174.395221] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [174.405706] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [174.425203] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s) [174.433819] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [174.456775] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s) [174.458917] Subtest invalid-num-scalers: SUCCESS (0.117s) [174.563222] [020/156] (844s left) gem_exec_reloc (basic-gtt-read) [174.618720] Subtest basic-gtt-read: SKIP (0.000s) [174.682010] [021/156] (844s left) gem_basic (multigpu-create-close) [174.727770] Starting subtest: multigpu-create-close [174.731533] Subtest multigpu-create-close: SKIP (0.000s) [174.837830] [022/156] (844s left) gem_flink_basic (bad-flink) [174.889082] Starting subtest: bad-flink [174.891127] Subtest bad-flink: SUCCESS (0.000s) [174.981901] [023/156] (844s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [175.057049] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [176.004287] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.956s) [176.126670] [024/156] (843s left) gem_mmap_gtt (cpuset-medium-copy-xy) [176.180444] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [176.238596] [025/156] (843s left) vgem_slow (nohang) [176.309658] Starting subtest: nohang [186.384386] Subtest nohang: SUCCESS (10.123s) [186.451131] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true [186.454284] [026/156] (832s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [186.535580] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu [186.540377] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [186.631244] [027/156] (832s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [186.716235] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [193.347251] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.647s) [193.473381] [028/156] (826s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [193.562023] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [193.566252] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [193.658597] [029/156] (825s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [193.744803] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [193.748899] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [193.857758] [030/156] (825s left) kms_content_protection (dp-mst-type-1-suspend-resume) [193.979410] Starting subtest: dp-mst-type-1-suspend-resume [193.983902] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s) [194.086611] [031/156] (825s left) kms_vblank (wait-idle) [194.160512] Starting subtest: wait-idle [194.163133] Starting dynamic subtest: pipe-A-eDP-1 [195.914108] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.756s) [195.927471] Starting dynamic subtest: pipe-D-eDP-1 [198.371308] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.456s) [198.373700] Subtest wait-idle: SUCCESS (4.216s) [199.193673] [032/156] (820s left) gem_exec_fence (syncobj-timeline-invalid-wait) [199.734825] Starting subtest: syncobj-timeline-invalid-wait [199.737869] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [201.177741] [033/156] (818s left) kms_vblank (invalid) [201.246691] Starting subtest: invalid [201.248557] Starting dynamic subtest: pipe-A-eDP-1 [201.654542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s) [201.657140] Subtest invalid: SUCCESS (0.408s) [202.511287] [034/156] (817s left) kms_chamelium_frames (dp-frame-dump) [202.891921] Subtest dp-frame-dump: SKIP (0.000s) [203.733237] [035/156] (816s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [203.814691] Starting subtest: pr-overlay-plane-update-sf-dmg-area [203.818865] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [203.870780] [036/156] (815s left) kms_cursor_edge_walk (256x256-left-edge) [203.948438] Starting subtest: 256x256-left-edge [203.950753] Starting dynamic subtest: pipe-A-eDP-1 [207.433421] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s) [207.443348] Starting dynamic subtest: pipe-D-eDP-1 [210.652457] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.216s) [210.654882] Subtest 256x256-left-edge: SUCCESS (6.700s) [211.473809] [037/156] (808s left) gem_render_copy (linear-to-vebox-y-tiled) [211.532070] Starting subtest: linear-to-vebox-y-tiled [211.536401] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [211.724958] [038/156] (808s left) gem_exercise_blt (fast-copy-emit) [211.788713] Starting subtest: fast-copy-emit [211.790525] Starting dynamic subtest: linear-smem-smem-emit [211.810684] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s) [211.819685] Starting dynamic subtest: xmajor-smem-smem-emit [211.827489] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s) [211.836273] Starting dynamic subtest: tile4-smem-smem-emit [211.844428] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s) [211.853130] Starting dynamic subtest: tile64-smem-smem-emit [211.860363] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s) [211.862682] Subtest fast-copy-emit: SUCCESS (0.073s) [212.003167] [039/156] (807s left) perf (invalid-oa-metric-set-id) [212.129325] Starting subtest: invalid-oa-metric-set-id [212.142589] Subtest invalid-oa-metric-set-id: SUCCESS (0.013s) [212.189072] [040/156] (807s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear) [212.277512] Starting subtest: fbcpsrhdr-tiling-linear [212.281773] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s) [212.379212] [041/156] (807s left) kms_psr (psr-sprite-plane-move) [212.450542] Starting subtest: psr-sprite-plane-move [212.453330] Starting dynamic subtest: eDP-1 [214.192362] Dynamic subtest eDP-1: SUCCESS (1.740s) [214.194498] Subtest psr-sprite-plane-move: SUCCESS (1.741s) [215.045938] [042/156] (805s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [215.129372] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [215.133861] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [215.210795] [043/156] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [215.288377] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [215.292403] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [215.394618] [044/156] (804s left) kms_psr (psr-cursor-plane-move) [215.476700] Starting subtest: psr-cursor-plane-move [215.478839] Starting dynamic subtest: eDP-1 [217.233390] Dynamic subtest eDP-1: SUCCESS (1.756s) [217.235704] Subtest psr-cursor-plane-move: SUCCESS (1.757s) [218.104985] [045/156] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [218.188261] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [218.192436] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [218.286454] [046/156] (801s left) api_intel_bb (offset-control) [218.340035] Starting subtest: offset-control [218.344857] Subtest offset-control: SUCCESS (0.007s) [218.479950] [047/156] (801s left) kms_big_fb (4-tiled-addfb) [218.559461] Starting subtest: 4-tiled-addfb [218.561774] Subtest 4-tiled-addfb: SUCCESS (0.000s) [218.653058] [048/156] (801s left) gem_exec_schedule (u-semaphore-noskip) [218.716652] Starting subtest: u-semaphore-noskip [219.111182] Subtest u-semaphore-noskip: SUCCESS (0.401s) [219.457063] [049/156] (800s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [219.523976] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [219.527721] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s) [219.597035] [050/156] (800s left) kms_cursor_legacy (forked-move) [219.699825] Starting subtest: forked-move [219.702037] Starting dynamic subtest: pipe-A [225.161080] Dynamic subtest pipe-A: SUCCESS (5.457s) [225.180901] Starting dynamic subtest: pipe-B [230.637431] Dynamic subtest pipe-B: SUCCESS (5.472s) [230.656562] Starting dynamic subtest: pipe-C [236.107682] Dynamic subtest pipe-C: SUCCESS (5.471s) [236.126248] Starting dynamic subtest: pipe-D [241.574246] Dynamic subtest pipe-D: SUCCESS (5.465s) [241.588366] Starting dynamic subtest: all-pipes [247.081143] Dynamic subtest all-pipes: SUCCESS (5.507s) [247.083687] Subtest forked-move: SUCCESS (27.381s) [247.228974] [051/156] (773s left) gem_exec_schedule (lateslice) [247.295003] Starting subtest: lateslice [247.296931] Starting dynamic subtest: rcs0 [247.311042] Dynamic subtest rcs0: SUCCESS (0.022s) [247.321221] Starting dynamic subtest: bcs0 [247.329935] Dynamic subtest bcs0: SUCCESS (0.018s) [247.338796] Starting dynamic subtest: vcs0 [247.346567] Dynamic subtest vcs0: SUCCESS (0.016s) [247.356451] Starting dynamic subtest: vcs1 [247.363689] Dynamic subtest vcs1: SUCCESS (0.016s) [247.372922] Starting dynamic subtest: vecs0 [247.381551] Dynamic subtest vecs0: SUCCESS (0.017s) [247.391454] Starting dynamic subtest: ccs0 [247.401497] Dynamic subtest ccs0: SUCCESS (0.018s) [247.404439] Subtest lateslice: SUCCESS (0.113s) [249.162785] [052/156] (771s left) syncobj_basic (bad-fd-to-handle) [249.219603] Starting subtest: bad-fd-to-handle [249.221853] Subtest bad-fd-to-handle: SUCCESS (0.000s) [249.333197] [053/156] (771s left) gem_partial_pwrite_pread (write-uncached) [249.390805] Subtest write-uncached: SKIP (0.000s) [249.467805] [054/156] (771s left) i915_drm_fdinfo (most-busy-check-all) [249.508600] Starting subtest: most-busy-check-all [249.510931] Starting dynamic subtest: rcs0 [249.515465] Dynamic subtest rcs0: SKIP (0.003s) [249.525704] Starting dynamic subtest: bcs0 [249.529946] Dynamic subtest bcs0: SKIP (0.000s) [249.538403] Starting dynamic subtest: vcs0 [249.542764] Dynamic subtest vcs0: SKIP (0.000s) [249.551797] Starting dynamic subtest: vcs1 [249.556904] Dynamic subtest vcs1: SKIP (0.000s) [249.572488] Starting dynamic subtest: vecs0 [249.576839] Dynamic subtest vecs0: SKIP (0.000s) [249.585283] Starting dynamic subtest: ccs0 [249.589701] Dynamic subtest ccs0: SKIP (0.000s) [249.594029] Subtest most-busy-check-all: SKIP (0.008s) [249.630668] [055/156] (771s left) gem_exec_balancer (parallel-bb-first) [249.909065] Starting subtest: parallel-bb-first [250.843225] Subtest parallel-bb-first: SUCCESS (0.934s) [252.125071] [056/156] (768s left) kms_atomic_transition (modeset-transition) [252.211133] Starting subtest: modeset-transition [252.213074] Starting dynamic subtest: 1x-outputs [263.330309] Dynamic subtest 1x-outputs: SUCCESS (11.123s) [263.332828] Subtest modeset-transition: SUCCESS (11.125s) [264.196642] [057/156] (756s left) gem_pread (bench) [264.255425] Subtest bench: SKIP (0.000s) [264.314797] [058/156] (756s left) kms_addfb_basic (basic) [264.369555] Starting subtest: basic [264.371443] Subtest basic: SUCCESS (0.000s) [264.511960] [059/156] (756s left) kms_plane_lowres (tiling-4) [264.601252] Starting subtest: tiling-4 [264.603584] Starting dynamic subtest: pipe-A-eDP-1 [264.608188] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [264.897212] Starting dynamic subtest: pipe-B-eDP-1 [264.902175] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [264.911079] Starting dynamic subtest: pipe-C-eDP-1 [264.916029] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [264.926596] Starting dynamic subtest: pipe-D-eDP-1 [264.931142] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [264.935717] Subtest tiling-4: SKIP (0.295s) [265.717807] [060/156] (755s left) syncobj_wait (wait-all-complex) [265.777121] Starting subtest: wait-all-complex [265.992150] Subtest wait-all-complex: SUCCESS (0.214s) [266.065913] [061/156] (754s left) kms_frontbuffer_tracking (psrhdr-suspend) [266.143028] Starting subtest: psrhdr-suspend [266.147100] Subtest psrhdr-suspend: SKIP (0.000s) [266.261712] [062/156] (754s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc) [266.349256] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc [266.353370] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [266.426675] [063/156] (754s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [266.518855] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [266.523434] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [266.619757] [064/156] (754s left) perf (gen12-group-exclusive-stream-ctx-handle) [266.724025] Starting subtest: gen12-group-exclusive-stream-ctx-handle [266.744726] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.024s) [266.792032] [065/156] (754s left) kms_addfb_basic (bad-pitch-1024) [268.053099] Starting subtest: bad-pitch-1024 [268.055258] Subtest bad-pitch-1024: SUCCESS (0.000s) [268.176971] [066/156] (752s left) kms_cursor_crc (cursor-onscreen-64x64) [268.334416] Starting subtest: cursor-onscreen-64x64 [268.339347] Starting dynamic subtest: pipe-A-eDP-1 [270.443320] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.104s) [270.474138] Starting dynamic subtest: pipe-D-eDP-1 [273.189817] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.723s) [273.192116] Subtest cursor-onscreen-64x64: SUCCESS (4.853s) [273.996483] [067/156] (747s left) gem_exec_flush (basic-uc-pro-default) [274.058696] Starting subtest: basic-uc-pro-default [279.510780] Subtest basic-uc-pro-default: SUCCESS (5.451s) [279.696452] [068/156] (741s left) gem_eio (in-flight-internal-1us) [279.936785] Starting subtest: in-flight-internal-1us [281.154846] Subtest in-flight-internal-1us: SUCCESS (1.218s) [281.297221] [069/156] (739s left) i915_pm_rpm (system-suspend) [283.206844] Starting subtest: system-suspend [301.861877] Subtest system-suspend: SUCCESS (2.892s) [302.245152] [070/156] (719s left) kms_cursor_crc (cursor-size-hints) [302.367931] Starting subtest: cursor-size-hints [302.370104] Starting dynamic subtest: pipe-A-eDP-1 [302.977970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.617s) [302.987872] Starting dynamic subtest: pipe-D-eDP-1 [304.290023] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s) [304.292466] Subtest cursor-size-hints: SUCCESS (1.944s) [305.168687] [071/156] (716s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [305.251233] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [312.259620] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.051s) [312.360438] [072/156] (708s left) syncobj_timeline (reset-signaled) [312.425444] Starting subtest: reset-signaled [312.428232] Subtest reset-signaled: SUCCESS (0.000s) [312.523374] [073/156] (708s left) kms_psr (fbc-psr2-sprite-plane-onoff) [312.599711] Starting subtest: fbc-psr2-sprite-plane-onoff [312.601840] Starting dynamic subtest: eDP-1 [312.606621] Dynamic subtest eDP-1: SKIP (0.000s) [312.610873] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s) [312.669432] [074/156] (708s left) prime_vgem (shrink) [312.729017] Starting subtest: shrink [312.756533] Subtest shrink: SUCCESS (0.025s) [312.868326] [075/156] (708s left) vgem_basic (dmabuf-fence-before) [312.917910] Starting subtest: dmabuf-fence-before [312.920647] Subtest dmabuf-fence-before: SUCCESS (0.000s) [312.975708] [076/156] (708s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [313.046716] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [313.049109] Starting dynamic subtest: pipe-A-eDP-1 [313.059019] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [313.070904] Starting dynamic subtest: pipe-B-eDP-1 [313.081604] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [313.092010] Starting dynamic subtest: pipe-C-eDP-1 [313.102781] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [313.112902] Starting dynamic subtest: pipe-D-eDP-1 [313.123500] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [313.128502] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s) [315.321729] [077/156] (706s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [315.383008] Starting subtest: multi-wait-all-available-submitted-signaled [315.385416] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [315.470911] [078/156] (706s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [315.540458] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [315.542888] Starting dynamic subtest: A-eDP1 [319.138123] Dynamic subtest A-eDP1: SUCCESS (3.606s) [319.149583] Starting dynamic subtest: B-eDP1 [322.448787] Dynamic subtest B-eDP1: SUCCESS (3.311s) [322.460147] Starting dynamic subtest: C-eDP1 [325.736914] Dynamic subtest C-eDP1: SUCCESS (3.292s) [325.747427] Starting dynamic subtest: D-eDP1 [328.975279] Dynamic subtest D-eDP1: SUCCESS (3.240s) [328.980569] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.461s) [329.791037] [079/156] (691s left) kms_frontbuffer_tracking (hdr-1p-rte) [329.877886] Starting subtest: hdr-1p-rte [329.882973] Subtest hdr-1p-rte: SKIP (0.000s) [329.992412] [080/156] (691s left) syncobj_timeline (device-submit-unordered) [330.053183] Starting subtest: device-submit-unordered [330.055730] Subtest device-submit-unordered: SUCCESS (0.000s) [330.149400] [081/156] (691s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt) [330.224289] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt [330.229365] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [330.323636] [082/156] (691s left) gem_mmap_gtt (hang) [330.391910] Subtest hang: SKIP (0.000s) [330.452603] [083/156] (691s left) gem_ctx_isolation (preservation-reset) [330.613773] Starting subtest: preservation-reset [330.616743] Starting dynamic subtest: rcs0 [330.889935] Dynamic subtest rcs0: SUCCESS (0.277s) [330.900610] Starting dynamic subtest: bcs0 [331.203002] Dynamic subtest bcs0: SUCCESS (0.312s) [331.214714] Starting dynamic subtest: vcs0 [331.509537] Dynamic subtest vcs0: SUCCESS (0.306s) [331.521942] Starting dynamic subtest: vcs1 [333.091130] Dynamic subtest vcs1: SUCCESS (1.581s) [333.103418] Starting dynamic subtest: vecs0 [335.149363] Dynamic subtest vecs0: SUCCESS (2.058s) [335.159912] Starting dynamic subtest: ccs0 [337.148310] Dynamic subtest ccs0: SUCCESS (1.996s) [337.151150] Subtest preservation-reset: SUCCESS (6.538s) [337.277905] [084/156] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [337.358686] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [344.288999] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.935s) [344.402211] [085/156] (677s left) gem_exec_whisper (basic-queues) [344.458470] Starting subtest: basic-queues [350.868144] Subtest basic-queues: SUCCESS (6.409s) [351.053731] [086/156] (670s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [351.145970] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [351.151641] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [351.242957] [087/156] (670s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render) [351.323824] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render [351.328567] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [351.418435] [088/156] (670s left) syncobj_basic (test-valid-cycle) [351.473015] Starting subtest: test-valid-cycle [351.475940] Subtest test-valid-cycle: SUCCESS (0.000s) [351.566498] [089/156] (670s left) gem_exec_balancer (waits) [351.635390] Starting subtest: waits [358.162165] Subtest waits: SUCCESS (6.525s) [358.463603] [090/156] (663s left) kms_chamelium_color (ctm-max) [358.551305] Subtest ctm-max: SKIP (0.000s) [358.595781] [091/156] (663s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [358.665868] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [358.670437] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [358.740544] [092/156] (663s left) intel_hwmon (hwmon-read) [358.791771] Subtest hwmon-read: SKIP (0.000s) [358.852281] [093/156] (663s left) gem_userptr_blits (usage-restrictions) [358.924659] Starting subtest: usage-restrictions [358.926871] Subtest usage-restrictions: SUCCESS (0.000s) [359.050589] [094/156] (663s left) gem_exec_reloc (basic-write-wc-noreloc) [359.102046] Subtest basic-write-wc-noreloc: SKIP (0.000s) [359.171754] [095/156] (663s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt) [359.253650] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt [359.258628] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [359.359336] [096/156] (662s left) kms_pm_dc (dc5-psr) [360.436854] Starting subtest: dc5-psr [363.329322] Subtest dc5-psr: SUCCESS (2.893s) [364.135500] [097/156] (658s left) drm_read (invalid-buffer) [364.258347] Starting subtest: invalid-buffer [364.260750] Subtest invalid-buffer: SUCCESS (0.000s) [364.373621] [098/156] (658s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [364.447682] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc [364.450125] Starting dynamic subtest: pipe-A-eDP-1 [364.474996] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [364.486620] Starting dynamic subtest: pipe-B-eDP-1 [364.511956] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [364.521872] Starting dynamic subtest: pipe-C-eDP-1 [364.548007] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [364.557939] Starting dynamic subtest: pipe-D-eDP-1 [364.584456] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [364.589117] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [366.705458] [099/156] (655s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-onoff) [366.794042] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-onoff [366.799299] Subtest psrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [366.884206] [100/156] (655s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs) [366.955866] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs [366.960607] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s) [368.155656] [101/156] (654s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [368.238374] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [368.243098] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [368.332392] [102/156] (654s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [368.420501] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [368.425699] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [368.511697] [103/156] (654s left) kms_prime (basic-modeset-hybrid) [368.575248] Subtest basic-modeset-hybrid: SKIP (0.000s) [368.691052] [104/156] (653s left) kms_flip (2x-flip-vs-panning-vs-hang) [368.767375] Starting subtest: 2x-flip-vs-panning-vs-hang [368.772575] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s) [368.875972] [105/156] (653s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [368.972670] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [373.720652] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.755s) [374.936871] [106/156] (647s left) kms_color (invalid-gamma-lut-sizes) [375.033937] Starting subtest: invalid-gamma-lut-sizes [375.036855] Starting dynamic subtest: pipe-A [375.327673] Dynamic subtest pipe-A: SUCCESS (0.295s) [375.338287] Starting dynamic subtest: pipe-B [375.340796] Dynamic subtest pipe-B: SUCCESS (0.000s) [375.350932] Starting dynamic subtest: pipe-C [375.353622] Dynamic subtest pipe-C: SUCCESS (0.000s) [375.363636] Starting dynamic subtest: pipe-D [375.366042] Dynamic subtest pipe-D: SUCCESS (0.000s) [375.368968] Subtest invalid-gamma-lut-sizes: SUCCESS (0.298s) [376.172144] [107/156] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [376.252044] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [376.257105] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [376.354510] [108/156] (646s left) kms_chamelium_hpd (dp-hpd-storm) [376.727803] Subtest dp-hpd-storm: SKIP (0.000s) [377.573582] [109/156] (645s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt) [377.651912] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt [377.657357] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [377.742786] [110/156] (645s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen) [377.823928] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen [377.829231] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [377.920393] [111/156] (645s left) kms_lease (page-flip-implicit-plane) [377.988040] Starting subtest: page-flip-implicit-plane [377.990610] Starting dynamic subtest: pipe-A-eDP-1 [378.471246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.482s) [378.487468] Starting dynamic subtest: pipe-B-eDP-1 [379.629814] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s) [379.640826] Starting dynamic subtest: pipe-C-eDP-1 [380.744856] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s) [380.754860] Starting dynamic subtest: pipe-D-eDP-1 [381.858868] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.115s) [381.861481] Subtest page-flip-implicit-plane: SUCCESS (3.872s) [382.694208] [112/156] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [382.776836] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [389.511963] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.745s) [389.639610] [113/156] (633s left) gem_exec_params (cliprects-invalid) [389.690130] Starting subtest: cliprects-invalid [389.693109] Subtest cliprects-invalid: SUCCESS (0.000s) [389.783853] [114/156] (633s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [389.862733] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [389.867854] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [389.954523] [115/156] (633s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [390.038940] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [390.044409] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [390.136392] [116/156] (633s left) gen9_exec_parse (bb-oversize) [390.203918] Subtest bb-oversize: SKIP (0.000s) [390.272229] [117/156] (632s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt) [390.358690] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt [390.363152] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [390.451171] [118/156] (632s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [390.532818] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [390.537748] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [390.633505] [119/156] (632s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [390.705910] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [390.709909] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [390.796419] [120/156] (632s left) perf_pmu (interrupts) [390.841115] Starting subtest: interrupts [391.919536] Subtest interrupts: SUCCESS (1.079s) [392.053858] [121/156] (631s left) kms_dsc (dsc-with-bpc) [392.127810] Starting subtest: dsc-with-bpc [392.164101] Subtest dsc-with-bpc: SKIP (0.001s) [392.206834] [122/156] (631s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [392.295438] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [392.299849] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [392.397204] [123/156] (631s left) gem_exec_create (madvise) [392.458821] Starting subtest: madvise [392.461712] Starting dynamic subtest: smem [412.873516] Dynamic subtest smem: SUCCESS (20.407s) [412.876428] Subtest madvise: SUCCESS (20.408s) [413.602188] [124/156] (609s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [413.695739] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [413.700838] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [413.784133] [125/156] (609s left) kms_psr (fbc-psr-primary-blt) [413.861795] Starting subtest: fbc-psr-primary-blt [413.864505] Starting dynamic subtest: eDP-1 [413.869634] Dynamic subtest eDP-1: SKIP (0.000s) [413.874988] Subtest fbc-psr-primary-blt: SKIP (0.001s) [413.945965] [126/156] (609s left) kms_flip (flip-vs-fences-interruptible) [414.028342] Starting subtest: flip-vs-fences-interruptible [414.033641] Subtest flip-vs-fences-interruptible: SKIP (0.000s) [414.116850] [127/156] (609s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [414.192653] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [414.194733] Starting dynamic subtest: pipe-A-eDP-1 [414.218777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s) [414.229878] Starting dynamic subtest: pipe-B-eDP-1 [414.252240] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s) [414.262363] Starting dynamic subtest: pipe-C-eDP-1 [414.285815] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s) [414.296123] Starting dynamic subtest: pipe-D-eDP-1 [414.318879] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s) [414.321645] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.082s) [416.599799] [128/156] (607s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [416.670097] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [416.675885] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [416.747017] [129/156] (606s left) kms_addfb_basic (bad-pitch-65536) [416.793924] Starting subtest: bad-pitch-65536 [416.796729] Subtest bad-pitch-65536: SUCCESS (0.000s) [416.899768] [130/156] (606s left) kms_invalid_mode (int-max-clock) [416.973002] Starting subtest: int-max-clock [416.975668] Starting dynamic subtest: pipe-A-eDP-1 [417.263873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [417.275251] Starting dynamic subtest: pipe-B-eDP-1 [417.277999] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [417.288369] Starting dynamic subtest: pipe-C-eDP-1 [417.290660] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [417.300132] Starting dynamic subtest: pipe-D-eDP-1 [417.303008] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [417.305719] Subtest int-max-clock: SUCCESS (0.294s) [418.135627] [131/156] (605s left) gem_spin_batch (legacy-resubmit-new) [418.186736] Starting subtest: legacy-resubmit-new [418.189799] Starting dynamic subtest: default [418.198820] Dynamic subtest default: SUCCESS (0.011s) [418.209817] Starting dynamic subtest: render [418.212443] Dynamic subtest render: SUCCESS (0.004s) [418.222893] Starting dynamic subtest: bsd [418.225420] Dynamic subtest bsd: SUCCESS (0.005s) [418.235094] Starting dynamic subtest: bsd1 [418.237584] Dynamic subtest bsd1: SUCCESS (0.003s) [418.246922] Starting dynamic subtest: bsd2 [418.249669] Dynamic subtest bsd2: SUCCESS (0.004s) [418.259250] Starting dynamic subtest: blt [418.261998] Dynamic subtest blt: SUCCESS (0.004s) [418.271824] Starting dynamic subtest: vebox [418.274507] Dynamic subtest vebox: SUCCESS (0.004s) [418.277033] Subtest legacy-resubmit-new: SUCCESS (0.041s) [419.898381] [132/156] (603s left) gem_mmap_offset (bad-extensions) [419.948246] Starting subtest: bad-extensions [419.950939] Subtest bad-extensions: SUCCESS (0.000s) [420.039119] [133/156] (603s left) syncobj_wait (wait-any-complex) [420.084879] Starting subtest: wait-any-complex [420.146473] Subtest wait-any-complex: SUCCESS (0.062s) [420.223663] [134/156] (603s left) kms_big_fb (x-tiled-16bpp-rotate-0) [420.305785] Starting subtest: x-tiled-16bpp-rotate-0 [421.617626] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.312s) [421.750554] [135/156] (602s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [421.836810] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [421.840693] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [421.926217] [136/156] (602s left) prime_mmap_coherency (write) [421.981581] Starting subtest: write [427.358935] Subtest write: SUCCESS (5.376s) [427.488131] [137/156] (596s left) api_intel_bb (bb-with-allocator) [427.536124] Starting subtest: bb-with-allocator [427.543629] Subtest bb-with-allocator: SUCCESS (0.009s) [427.650038] [138/156] (596s left) kms_flip (2x-plain-flip-interruptible) [427.728717] Starting subtest: 2x-plain-flip-interruptible [427.737876] Subtest 2x-plain-flip-interruptible: SKIP (0.007s) [427.809777] [139/156] (596s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [427.878981] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [427.881488] Starting dynamic subtest: A-eDP1 [431.475856] Dynamic subtest A-eDP1: SUCCESS (3.593s) [431.488142] Starting dynamic subtest: B-eDP1 [434.684743] Dynamic subtest B-eDP1: SUCCESS (3.207s) [434.695104] Starting dynamic subtest: C-eDP1 [437.899587] Dynamic subtest C-eDP1: SUCCESS (3.216s) [437.910603] Starting dynamic subtest: D-eDP1 [441.107988] Dynamic subtest D-eDP1: SUCCESS (3.207s) [441.110588] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.230s) [441.921306] [140/156] (582s left) kms_psr (pr-dpms) [441.993432] Starting subtest: pr-dpms [441.998640] Subtest pr-dpms: SKIP (0.000s) [442.065297] [141/156] (582s left) kms_psr (fbc-pr-cursor-render) [442.135894] Starting subtest: fbc-pr-cursor-render [442.141263] Subtest fbc-pr-cursor-render: SKIP (0.000s) [442.207480] [142/156] (582s left) syncobj_wait (wait-any-interrupted) [442.258933] Starting subtest: wait-any-interrupted [442.366698] Subtest wait-any-interrupted: SUCCESS (0.108s) [442.444804] [143/156] (581s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [442.532055] Starting subtest: fbc-rgb101010-draw-mmap-cpu [445.013573] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.485s) [446.140776] [144/156] (578s left) core_setmaster (master-drop-set-shared-fd) [446.211767] Starting subtest: master-drop-set-shared-fd [446.223102] Subtest master-drop-set-shared-fd: SUCCESS (0.011s) [446.263351] [145/156] (578s left) gem_close_race (multigpu-basic-threads) [446.322950] Starting subtest: multigpu-basic-threads [446.328444] Subtest multigpu-basic-threads: SKIP (0.000s) [446.539161] [146/156] (577s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [446.618223] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [446.623347] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [446.692573] [147/156] (577s left) gem_exec_async (forked-writes) [446.749734] Starting subtest: forked-writes [446.752049] Starting dynamic subtest: rcs0 [446.776056] Dynamic subtest rcs0: SUCCESS (0.026s) [446.788447] Starting dynamic subtest: bcs0 [446.804115] Dynamic subtest bcs0: SUCCESS (0.027s) [446.815103] Starting dynamic subtest: vcs0 [446.824938] Dynamic subtest vcs0: SUCCESS (0.020s) [446.836919] Starting dynamic subtest: vcs1 [446.846654] Dynamic subtest vcs1: SUCCESS (0.021s) [446.857832] Starting dynamic subtest: vecs0 [446.869544] Dynamic subtest vecs0: SUCCESS (0.021s) [446.880727] Starting dynamic subtest: ccs0 [446.891888] Dynamic subtest ccs0: SUCCESS (0.021s) [446.894859] Subtest forked-writes: SUCCESS (0.142s) [447.110823] [148/156] (577s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt) [447.190999] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt [447.196121] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [447.286503] [149/156] (577s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [447.366103] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu [447.370932] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [447.463724] [150/156] (577s left) i915_module_load (resize-bar) [447.504028] Starting subtest: resize-bar [447.511783] Subtest resize-bar: SKIP (0.006s) [447.560715] [151/156] (577s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [447.642245] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [447.647641] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [447.740728] [152/156] (576s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [447.821627] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [447.826922] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [447.938611] [153/156] (576s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-pwrite) [448.026132] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-pwrite [448.030768] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [448.127666] [154/156] (576s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [448.178447] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [448.182912] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [448.359094] [155/156] (576s left) gem_exec_fence (syncobj-timeline-unused-fence) [448.943133] Starting subtest: syncobj-timeline-unused-fence [448.950013] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s) [449.898882] [156/156] (574s left) kms_flip (absolute-wf_vblank) [449.974531] Starting subtest: absolute-wf_vblank [449.977208] Starting dynamic subtest: A-eDP1 [458.680015] Dynamic subtest A-eDP1: SUCCESS (8.708s) [458.689938] Starting dynamic subtest: B-eDP1 [467.415674] Dynamic subtest B-eDP1: SUCCESS (8.734s) [467.426922] Starting dynamic subtest: C-eDP1 [476.130005] Dynamic subtest C-eDP1: SUCCESS (8.714s) [476.141896] Starting dynamic subtest: D-eDP1 [484.853510] Dynamic subtest D-eDP1: SUCCESS (8.723s) [484.855993] Subtest absolute-wf_vblank: SUCCESS (34.887s) [486.058995] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: gem_vm_create results: parsing output: 2/ for test: kms_flip results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: perf_pmu results: parsing output: 5/ for test: kms_plane_scaling results: parsing output: 6/ for test: syncobj_wait results: parsing output: 7/ for test: intel_hwmon results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_ctx_persistence results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_workarounds results: parsing output: 18/ for test: kms_plane_scaling results: parsing output: 19/ for test: gem_exec_reloc results: parsing output: 20/ for test: gem_basic results: parsing output: 21/ for test: gem_flink_basic results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: gem_mmap_gtt results: parsing output: 24/ for test: vgem_slow results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_content_protection results: parsing output: 30/ for test: kms_vblank results: parsing output: 31/ for test: gem_exec_fence results: parsing output: 32/ for test: kms_vblank results: parsing output: 33/ for test: kms_chamelium_frames results: parsing output: 34/ for test: kms_psr2_sf results: parsing output: 35/ for test: kms_cursor_edge_walk results: parsing output: 36/ for test: gem_render_copy results: parsing output: 37/ for test: gem_exercise_blt results: parsing output: 38/ for test: perf results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_psr results: parsing output: 41/ for test: kms_flip_scaled_crc results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_psr results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: api_intel_bb results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: gem_exec_schedule results: parsing output: 48/ for test: kms_plane results: parsing output: 49/ for test: kms_cursor_legacy results: parsing output: 50/ for test: gem_exec_schedule results: parsing output: 51/ for test: syncobj_basic results: parsing output: 52/ for test: gem_partial_pwrite_pread results: parsing output: 53/ for test: i915_drm_fdinfo results: parsing output: 54/ for test: gem_exec_balancer results: parsing output: 55/ for test: kms_atomic_transition results: parsing output: 56/ for test: gem_pread results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_plane_lowres results: parsing output: 59/ for test: syncobj_wait 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_big_fb results: parsing output: 63/ for test: perf results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_cursor_crc results: parsing output: 66/ for test: gem_exec_flush results: parsing output: 67/ for test: gem_eio results: parsing output: 68/ for test: i915_pm_rpm results: parsing output: 69/ for test: kms_cursor_crc results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: prime_vgem results: parsing output: 74/ for test: vgem_basic results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: syncobj_timeline results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: syncobj_timeline results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_mmap_gtt results: parsing output: 82/ for test: gem_ctx_isolation results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_exec_whisper results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: syncobj_basic results: parsing output: 88/ for test: gem_exec_balancer results: parsing output: 89/ for test: kms_chamelium_color results: parsing output: 90/ for test: kms_plane results: parsing output: 91/ for test: intel_hwmon results: parsing output: 92/ for test: gem_userptr_blits results: parsing output: 93/ for test: gem_exec_reloc results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_pm_dc results: parsing output: 96/ for test: drm_read results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_prime results: parsing output: 103/ for test: kms_flip results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_color results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_chamelium_hpd results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_lease results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_exec_params results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: gen9_exec_parse results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: perf_pmu results: parsing output: 120/ for test: kms_dsc results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_exec_create results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_flip results: parsing output: 126/ for test: kms_ccs results: parsing output: 127/ for test: kms_flip_scaled_crc results: parsing output: 128/ for test: kms_addfb_basic results: parsing output: 129/ for test: kms_invalid_mode results: parsing output: 130/ for test: gem_spin_batch results: parsing output: 131/ for test: gem_mmap_offset results: parsing output: 132/ for test: syncobj_wait results: parsing output: 133/ for test: kms_big_fb results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: prime_mmap_coherency results: parsing output: 136/ for test: api_intel_bb results: parsing output: 137/ for test: kms_flip results: parsing output: 138/ for test: kms_flip results: parsing output: 139/ for test: kms_psr results: parsing output: 140/ for test: kms_psr results: parsing output: 141/ for test: syncobj_wait results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: core_setmaster results: parsing output: 144/ for test: gem_close_race results: parsing output: 145/ for test: kms_psr2_sf results: parsing output: 146/ for test: gem_exec_async results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: i915_module_load results: parsing output: 150/ for test: kms_big_fb results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: gem_render_copy results: parsing output: 154/ for test: gem_exec_fence results: parsing output: 155/ for test: kms_flip Done.