[59.297226] Initializing watchdogs
[59.297301]   /dev/watchdog0
[59.312469] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.316968] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.319796] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.321856] [001/133] (960s left) kms_vrr (flip-basic)
[59.413159] Starting subtest: flip-basic
[59.415768] Subtest flip-basic: SKIP (0.000s)
[59.488340] [002/133] (960s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[59.575464] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[59.576316] Starting dynamic subtest: pipe-A-eDP-1
[59.583464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[59.589381] Starting dynamic subtest: pipe-B-eDP-1
[59.598173] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[59.607864] Starting dynamic subtest: pipe-C-eDP-1
[59.615217] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[59.620705] Starting dynamic subtest: pipe-D-eDP-1
[59.627558] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[59.628349] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[61.900679] [003/133] (957s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[61.993822] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[69.041833] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.048s)
[69.194503] [004/133] (950s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[69.573192] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[70.429639] [005/133] (949s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[70.517319] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[70.519054] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[70.632132] [006/133] (949s left) kms_properties (connector-properties-atomic)
[70.723112] Starting subtest: connector-properties-atomic
[70.724293] Starting dynamic subtest: pipe-A-eDP-1
[78.557459] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.834s)
[78.564362] Starting dynamic subtest: pipe-None-DP-1
[78.566094] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[78.571613] Starting dynamic subtest: pipe-None-HDMI-A-1
[78.573283] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[78.579681] Starting dynamic subtest: pipe-None-DP-2
[78.581423] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[78.587411] Starting dynamic subtest: pipe-None-HDMI-A-2
[78.589254] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[78.594842] Starting dynamic subtest: pipe-None-DP-3
[78.596575] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[78.602241] Starting dynamic subtest: pipe-None-DP-4
[78.603835] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[78.604859] Subtest connector-properties-atomic: SUCCESS (7.843s)
[79.411253] [007/133] (940s left) kms_plane (plane-panning-top-left)
[79.501292] Starting subtest: plane-panning-top-left
[79.502278] Starting dynamic subtest: pipe-A
[81.196215] Dynamic subtest pipe-A: SUCCESS (1.694s)
[81.203057] Starting dynamic subtest: pipe-B
[83.531323] Dynamic subtest pipe-B: SUCCESS (2.333s)
[83.532249] Subtest plane-panning-top-left: SUCCESS (4.030s)
[84.344568] [008/133] (935s left) kms_prop_blob (invalid-set-prop)
[84.397290] Starting subtest: invalid-set-prop
[84.398238] Subtest invalid-set-prop: SUCCESS (0.000s)
[84.472691] [009/133] (935s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[84.574507] Starting subtest: extended-modeset-hang-newfb-with-reset
[84.575367] Starting dynamic subtest: pipe-A
[100.001202] Dynamic subtest pipe-A: SUCCESS (15.424s)
[100.012286] Starting dynamic subtest: pipe-D
[115.869886] Dynamic subtest pipe-D: SUCCESS (15.865s)
[115.872754] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.297s)
[116.655079] [010/133] (903s left) gem_exec_reloc (basic-write-read-active)
[116.716642] Subtest basic-write-read-active: SKIP (0.000s)
[116.777583] [011/133] (903s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[116.890189] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[116.891862] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[117.030819] [012/133] (903s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[117.136262] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[117.137861] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[117.222581] [013/133] (902s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[117.314621] Starting subtest: addfb25-yf-tiled-legacy
[117.315564] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[117.402991] [014/133] (902s left) kms_prop_blob (basic)
[117.450351] Starting subtest: basic
[117.451385] Subtest basic: SUCCESS (0.000s)
[117.536300] [015/133] (902s left) gem_pxp (hw-rejects-pxp-buffer)
[117.652686] Starting subtest: hw-rejects-pxp-buffer
[117.655897] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[117.756118] [016/133] (902s left) i915_pm_rc6_residency (rc6-accuracy)
[117.806462] Starting subtest: rc6-accuracy
[117.807398] Starting dynamic subtest: gt0
[120.987286] Dynamic subtest gt0: SUCCESS (3.170s)
[120.996775] Starting dynamic subtest: gt1
[124.193297] Dynamic subtest gt1: SUCCESS (3.168s)
[124.194133] Subtest rc6-accuracy: SUCCESS (6.342s)
[124.219985] [017/133] (896s left) kms_big_fb (linear-64bpp-rotate-0)
[124.330694] Starting subtest: linear-64bpp-rotate-0
[126.047660] Subtest linear-64bpp-rotate-0: SUCCESS (1.717s)
[126.197691] [018/133] (894s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[126.287800] Starting subtest: crc-primary-suspend-y-tiled-ccs
[126.288889] Starting dynamic subtest: pipe-A-eDP-1
[126.292370] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[126.299896] Starting dynamic subtest: pipe-B-eDP-1
[126.303154] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[126.309758] Starting dynamic subtest: pipe-C-eDP-1
[126.312967] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[126.319957] Starting dynamic subtest: pipe-D-eDP-1
[126.322985] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[126.324478] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[128.520129] [019/133] (891s left) kms_frontbuffer_tracking (fbc-tiling-y)
[128.612394] Starting subtest: fbc-tiling-y
[128.614564] Subtest fbc-tiling-y: SKIP (0.000s)
[128.699315] [020/133] (891s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[128.788340] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[128.789932] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[128.886223] [021/133] (891s left) gem_exec_whisper (basic-queues)
[128.947799] Starting subtest: basic-queues
[134.897593] Subtest basic-queues: SUCCESS (5.939s)
[135.070587] [022/133] (885s left) gem_mmap (big-bo)
[135.143362] Subtest big-bo: SKIP (0.000s)
[135.193861] [023/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[135.297844] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[135.299585] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[135.392490] [024/133] (885s left) prime_vgem (basic-read)
[135.504126] Starting subtest: basic-read
[135.510224] Subtest basic-read: SKIP (0.005s)
[135.603853] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[135.605566] [025/133] (884s left) kms_rotation_crc (sprite-rotation-270)
[135.684966] Starting subtest: sprite-rotation-270
[135.686769] Subtest sprite-rotation-270: SKIP (0.001s)
[135.752693] [026/133] (884s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[135.811232] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[135.860707] [027/133] (884s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[135.922863] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[135.924039] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[136.015352] [028/133] (884s left) gem_mmap_offset (bad-extensions)
[136.056375] Starting subtest: bad-extensions
[136.057426] Subtest bad-extensions: SUCCESS (0.000s)
[136.166597] [029/133] (884s left) gem_pxp (create-protected-buffer)
[136.223940] Starting subtest: create-protected-buffer
[136.224926] Subtest create-protected-buffer: SUCCESS (0.000s)
[136.342987] [030/133] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[136.439024] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[136.440746] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[136.530268] [031/133] (884s left) syncobj_wait (wait-delayed-signal)
[136.580148] Starting subtest: wait-delayed-signal
[136.682920] Subtest wait-delayed-signal: SUCCESS (0.102s)
[136.771378] [032/133] (884s left) gem_exec_reloc (basic-cpu-read)
[136.820045] Subtest basic-cpu-read: SKIP (0.000s)
[136.883501] [033/133] (883s left) gem_exec_schedule (pi-shared-iova)
[137.060683] Starting subtest: pi-shared-iova
[137.062029] Starting dynamic subtest: rcs0
[137.138921] Dynamic subtest rcs0: SUCCESS (0.079s)
[137.149980] Starting dynamic subtest: vcs0
[137.203606] Dynamic subtest vcs0: SUCCESS (0.064s)
[137.214363] Starting dynamic subtest: vcs1
[137.257822] Dynamic subtest vcs1: SUCCESS (0.054s)
[137.266936] Starting dynamic subtest: vecs0
[137.315943] Dynamic subtest vecs0: SUCCESS (0.058s)
[137.323593] Starting dynamic subtest: ccs0
[137.376697] Dynamic subtest ccs0: SUCCESS (0.060s)
[137.378486] Subtest pi-shared-iova: SUCCESS (0.317s)
[138.977581] [034/133] (881s left) gem_ctx_persistence (saturated-hostile)
[139.033255] Starting subtest: saturated-hostile
[139.034627] Starting dynamic subtest: rcs0
[139.876499] Dynamic subtest rcs0: SUCCESS (0.843s)
[139.887556] Starting dynamic subtest: bcs0
[140.647924] Dynamic subtest bcs0: SUCCESS (0.770s)
[140.658918] Starting dynamic subtest: vcs0
[141.441036] Dynamic subtest vcs0: SUCCESS (0.791s)
[141.451831] Starting dynamic subtest: vcs1
[142.242777] Dynamic subtest vcs1: SUCCESS (0.801s)
[142.253808] Starting dynamic subtest: vecs0
[143.034583] Dynamic subtest vecs0: SUCCESS (0.791s)
[143.045275] Starting dynamic subtest: ccs0
[143.878064] Dynamic subtest ccs0: SUCCESS (0.843s)
[143.879243] Subtest saturated-hostile: SUCCESS (4.846s)
[143.967220] [035/133] (876s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[144.061059] Starting subtest: fbcpsr-rgb101010-draw-blt
[150.780946] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.719s)
[150.906309] [036/133] (870s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[150.999529] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[151.000476] Starting dynamic subtest: pipe-A-eDP-1
[151.009243] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.017443] Starting dynamic subtest: pipe-B-eDP-1
[151.026217] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.033915] Starting dynamic subtest: pipe-C-eDP-1
[151.042363] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.049366] Starting dynamic subtest: pipe-D-eDP-1
[151.057708] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.059291] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[153.295970] [037/133] (867s left) i915_pm_rps (thresholds-idle)
[153.362578] Starting subtest: thresholds-idle
[153.364647] Subtest thresholds-idle: SKIP (0.001s)
[153.454811] [038/133] (867s left) prime_busy (hang-wait)
[153.507969] Starting subtest: hang-wait
[153.509076] Starting dynamic subtest: rcs0
[179.379208] Dynamic subtest rcs0: SUCCESS (25.866s)
[179.389303] Starting dynamic subtest: bcs0
[186.535423] Dynamic subtest bcs0: SUCCESS (7.156s)
[186.544818] Starting dynamic subtest: vcs0
[193.512599] Dynamic subtest vcs0: SUCCESS (6.973s)
[193.528424] Starting dynamic subtest: vcs1
[200.483859] Dynamic subtest vcs1: SUCCESS (6.973s)
[200.494545] Starting dynamic subtest: vecs0
[207.521830] Dynamic subtest vecs0: SUCCESS (7.035s)
[207.531319] Starting dynamic subtest: ccs0
[221.359568] Dynamic subtest ccs0: SUCCESS (13.838s)
[221.360752] Subtest hang-wait: SUCCESS (67.850s)
[221.487687] [039/133] (799s left) i915_pm_freq_api (freq-reset-multiple)
[221.541999] Starting subtest: freq-reset-multiple
[221.542969] Starting dynamic subtest: gt0
[229.971192] Dynamic subtest gt0: SUCCESS (8.428s)
[229.979862] Starting dynamic subtest: gt1
[237.334266] Dynamic subtest gt1: SUCCESS (7.353s)
[237.335519] Subtest freq-reset-multiple: SUCCESS (15.783s)
[237.413577] [040/133] (783s left) sysfs_timeslice_duration (idempotent)
[237.475323] Starting subtest: idempotent
[237.476253] Starting dynamic subtest: vecs0
[237.477119] Dynamic subtest vecs0: SUCCESS (0.000s)
[237.485404] Starting dynamic subtest: ccs0
[237.486421] Dynamic subtest ccs0: SUCCESS (0.000s)
[237.494090] Starting dynamic subtest: vcs0
[237.494999] Dynamic subtest vcs0: SUCCESS (0.000s)
[237.502446] Starting dynamic subtest: bcs0
[237.503453] Dynamic subtest bcs0: SUCCESS (0.000s)
[237.510756] Starting dynamic subtest: rcs0
[237.511712] Dynamic subtest rcs0: SUCCESS (0.000s)
[237.520490] Starting dynamic subtest: vcs1
[237.521597] Dynamic subtest vcs1: SUCCESS (0.000s)
[237.522598] Subtest idempotent: SUCCESS (0.005s)
[237.585529] [041/133] (783s left) gem_exec_balancer (semaphore)
[237.642944] Starting subtest: semaphore
[238.942658] Subtest semaphore: SUCCESS (1.290s)
[239.249407] [042/133] (781s left) gem_ctx_isolation (preservation)
[239.323652] Starting subtest: preservation
[239.324748] Starting dynamic subtest: rcs0
[239.480888] Dynamic subtest rcs0: SUCCESS (0.157s)
[239.489471] Starting dynamic subtest: bcs0
[239.647307] Dynamic subtest bcs0: SUCCESS (0.165s)
[239.658553] Starting dynamic subtest: vcs0
[239.804394] Dynamic subtest vcs0: SUCCESS (0.157s)
[239.815428] Starting dynamic subtest: vcs1
[241.041789] Dynamic subtest vcs1: SUCCESS (1.237s)
[241.052564] Starting dynamic subtest: vecs0
[243.024726] Dynamic subtest vecs0: SUCCESS (1.982s)
[243.035893] Starting dynamic subtest: ccs0
[245.023810] Dynamic subtest ccs0: SUCCESS (1.998s)
[245.025420] Subtest preservation: SUCCESS (5.700s)
[245.266612] [043/133] (775s left) i915_drm_fdinfo (isolation)
[245.306289] Starting subtest: isolation
[245.307142] Starting dynamic subtest: rcs0
[245.332102] Dynamic subtest rcs0: SKIP (0.025s)
[245.342659] Starting dynamic subtest: bcs0
[245.344394] Dynamic subtest bcs0: SKIP (0.000s)
[245.355220] Starting dynamic subtest: vcs0
[245.357284] Dynamic subtest vcs0: SKIP (0.000s)
[245.364765] Starting dynamic subtest: vcs1
[245.366692] Dynamic subtest vcs1: SKIP (0.000s)
[245.374083] Starting dynamic subtest: vecs0
[245.375610] Dynamic subtest vecs0: SKIP (0.000s)
[245.382747] Starting dynamic subtest: ccs0
[245.384495] Dynamic subtest ccs0: SKIP (0.000s)
[245.386074] Subtest isolation: SKIP (0.029s)
[245.415673] [044/133] (775s left) kms_cursor_crc (cursor-onscreen-256x85)
[245.691201] Starting subtest: cursor-onscreen-256x85
[245.738082] Subtest cursor-onscreen-256x85: SKIP (0.044s)
[245.916755] [045/133] (775s left) gem_workarounds (reset)
[245.986517] Starting subtest: reset
[246.177047] Subtest reset: SUCCESS (0.191s)
[246.291086] [046/133] (774s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[246.444952] Starting subtest: dp-mst-type-1-suspend-resume
[246.446885] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[246.549774] [047/133] (774s left) gem_userptr_blits (nohangcheck)
[246.614764] Starting subtest: nohangcheck
[246.829269] Subtest nohangcheck: SUCCESS (0.216s)
[246.946006] [048/133] (774s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[247.035690] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[247.037404] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[247.127805] [049/133] (774s left) gem_mmap_gtt (cpuset-medium-copy)
[247.184327] Subtest cpuset-medium-copy: SKIP (0.000s)
[247.243837] [050/133] (774s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[247.294573] Starting subtest: yf-tiled-to-vebox-x-tiled
[247.296442] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[247.485407] [051/133] (773s left) syncobj_timeline (signal-point-0)
[247.546259] Starting subtest: signal-point-0
[247.547240] Subtest signal-point-0: SUCCESS (0.000s)
[247.647826] [052/133] (773s left) api_intel_allocator (default-alignment)
[247.702064] Starting subtest: default-alignment
[247.704597] Subtest default-alignment: SUCCESS (0.003s)
[247.839545] [053/133] (773s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[248.393146] Starting subtest: syncobj-timeline-multiple-ext-nodes
[248.393937] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[250.006780] [054/133] (771s left) kms_cursor_edge_walk (64x64-left-edge)
[250.106046] Starting subtest: 64x64-left-edge
[250.106944] Starting dynamic subtest: pipe-A-eDP-1
[253.565162] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[253.573128] Starting dynamic subtest: pipe-D-eDP-1
[256.685809] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[256.686718] Subtest 64x64-left-edge: SUCCESS (6.580s)
[257.492545] [055/133] (764s left) perf (global-sseu-config-invalid)
[257.615472] Starting subtest: global-sseu-config-invalid
[257.617128] Subtest global-sseu-config-invalid: SKIP (0.000s)
[257.656076] [056/133] (763s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[257.742992] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[258.855337] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.113s)
[258.975643] [057/133] (762s left) api_intel_bb (destroy-bb)
[259.043654] Starting subtest: destroy-bb
[259.052269] Subtest destroy-bb: SUCCESS (0.008s)
[259.147804] [058/133] (762s left) kms_flip (plain-flip-fb-recreate)
[259.234913] Starting subtest: plain-flip-fb-recreate
[259.236982] Starting dynamic subtest: A-eDP1
[268.076728] Dynamic subtest A-eDP1: SUCCESS (8.841s)
[268.085946] Starting dynamic subtest: B-eDP1
[276.900134] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[276.910359] Starting dynamic subtest: C-eDP1
[285.723357] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[285.734791] Starting dynamic subtest: D-eDP1
[294.546704] Dynamic subtest D-eDP1: SUCCESS (8.820s)
[294.548808] Subtest plain-flip-fb-recreate: SUCCESS (35.313s)
[295.725856] [059/133] (725s left) gem_exec_params (readonly)
[295.787224] Starting subtest: readonly
[295.789339] Subtest readonly: SUCCESS (0.002s)
[295.908018] [060/133] (725s left) syncobj_wait (invalid-reset-one-illegal-handle)
[295.962078] Starting subtest: invalid-reset-one-illegal-handle
[295.962963] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[296.042289] [061/133] (725s left) kms_hdr (static-toggle-dpms)
[296.129998] Starting subtest: static-toggle-dpms
[296.132847] Subtest static-toggle-dpms: SKIP (0.000s)
[296.196563] [062/133] (725s left) gem_exec_params (cliprects-invalid)
[296.245677] Starting subtest: cliprects-invalid
[296.246800] Subtest cliprects-invalid: SUCCESS (0.000s)
[296.335931] [063/133] (725s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[296.424803] Starting subtest: x-tiled-32bpp-rotate-270
[296.444016] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[296.543112] [064/133] (725s left) kms_psr (psr-cursor-mmap-gtt)
[296.632439] Starting subtest: psr-cursor-mmap-gtt
[296.633419] Starting dynamic subtest: eDP-1
[298.328213] Dynamic subtest eDP-1: SUCCESS (1.695s)
[298.329030] Subtest psr-cursor-mmap-gtt: SUCCESS (1.697s)
[299.185814] [065/133] (722s left) gem_exec_reloc (basic-wc-cpu)
[299.246618] Subtest basic-wc-cpu: SKIP (0.000s)
[299.318478] [066/133] (722s left) kms_chamelium_audio (dp-audio)
[299.699736] Subtest dp-audio: SKIP (0.000s)
[300.498696] [067/133] (721s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[300.590393] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[300.592358] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[300.657793] [068/133] (721s left) gem_eio (in-flight-external)
[300.882780] Starting subtest: in-flight-external
[301.982389] Subtest in-flight-external: SUCCESS (1.099s)
[302.103851] [069/133] (719s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[302.191204] Starting subtest: 2x-flip-vs-rmfb-interruptible
[302.202092] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[302.274213] [070/133] (719s left) gem_lmem_swapping (heavy-verify-random)
[302.315980] Subtest heavy-verify-random: SKIP (0.000s)
[302.357140] [071/133] (719s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[302.451477] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[307.005673] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.554s)
[308.135997] [072/133] (714s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[308.222236] Starting subtest: fbc-psr-sprite-mmap-cpu
[308.223120] Starting dynamic subtest: eDP-1
[308.224870] Dynamic subtest eDP-1: SKIP (0.000s)
[308.226858] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[308.296412] [073/133] (713s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[308.338275] Starting subtest: invalid-multi-wait-unsubmitted
[308.339125] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[308.435179] [074/133] (713s left) gem_render_copy_redux (interruptible)
[308.493465] Starting subtest: interruptible
[308.821244] Subtest interruptible: SUCCESS (0.328s)
[308.947361] [075/133] (713s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[309.035103] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[309.142239] [076/133] (713s left) kms_scaling_modes (scaling-mode-center)
[309.237988] Starting subtest: scaling-mode-center
[309.238955] Starting dynamic subtest: pipe-A-eDP-1
[309.343244] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[309.352816] Starting dynamic subtest: pipe-B-eDP-1
[310.560582] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.215s)
[310.572564] Starting dynamic subtest: pipe-C-eDP-1
[311.673989] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[311.683976] Starting dynamic subtest: pipe-D-eDP-1
[312.804845] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[312.805744] Subtest scaling-mode-center: SUCCESS (3.567s)
[313.972494] [077/133] (708s left) kms_plane_scaling (planes-downscale-factor-0-5)
[314.056747] Starting subtest: planes-downscale-factor-0-5
[314.057767] Starting dynamic subtest: pipe-A
[314.074461] Dynamic subtest pipe-A: SKIP (0.018s)
[314.082575] Starting dynamic subtest: pipe-B
[314.107428] Dynamic subtest pipe-B: SKIP (0.032s)
[314.115627] Starting dynamic subtest: pipe-C
[314.140643] Dynamic subtest pipe-C: SKIP (0.032s)
[314.148270] Starting dynamic subtest: pipe-D
[314.172712] Dynamic subtest pipe-D: SKIP (0.032s)
[314.174410] Subtest planes-downscale-factor-0-5: SKIP (0.116s)
[314.273207] [078/133] (708s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[314.364051] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[314.365840] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[314.434135] [079/133] (707s left) kms_lease (page-flip-implicit-plane)
[314.516082] Starting subtest: page-flip-implicit-plane
[314.516959] Starting dynamic subtest: pipe-A-eDP-1
[314.996573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[315.007060] Starting dynamic subtest: pipe-B-eDP-1
[316.116919] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.118s)
[316.125260] Starting dynamic subtest: pipe-C-eDP-1
[317.223318] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[317.233326] Starting dynamic subtest: pipe-D-eDP-1
[318.353773] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[318.354696] Subtest page-flip-implicit-plane: SUCCESS (3.837s)
[319.200931] [080/133] (703s left) kms_pm_dc (dc5-dpms-negative)
[320.325168] Starting subtest: dc5-dpms-negative
[320.326902] Subtest dc5-dpms-negative: SKIP (0.000s)
[320.391984] [081/133] (702s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[320.485987] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[320.487479] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[320.556254] [082/133] (701s left) gem_exec_schedule (promotion)
[320.619672] Starting subtest: promotion
[320.620708] Starting dynamic subtest: rcs0
[320.729886] Dynamic subtest rcs0: SUCCESS (0.109s)
[320.739871] Starting dynamic subtest: vcs0
[320.820192] Dynamic subtest vcs0: SUCCESS (0.089s)
[320.831040] Starting dynamic subtest: vcs1
[320.905115] Dynamic subtest vcs1: SUCCESS (0.084s)
[320.915445] Starting dynamic subtest: vecs0
[320.998988] Dynamic subtest vecs0: SUCCESS (0.093s)
[321.009693] Starting dynamic subtest: ccs0
[321.105756] Dynamic subtest ccs0: SUCCESS (0.105s)
[321.107085] Subtest promotion: SUCCESS (0.486s)
[321.972575] [083/133] (700s left) sw_sync (sync_merge)
[322.007776] Starting subtest: sync_merge
[322.008699] Subtest sync_merge: SUCCESS (0.000s)
[322.059182] [084/133] (700s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[322.159510] Starting subtest: 4-tiled-16bpp-rotate-0
[323.430682] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.271s)
[323.550396] [085/133] (699s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[323.640703] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[323.641785] Starting dynamic subtest: pipe-A-eDP-1
[323.731526] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[323.740259] Starting dynamic subtest: pipe-B-eDP-1
[324.861294] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[324.863191] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.220s)
[326.043975] [086/133] (696s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[326.101935] Subtest writes-after-reads-uncached: SKIP (0.000s)
[326.174638] [087/133] (696s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[326.267565] Starting subtest: fbc-farfromfence-mmap-gtt
[326.269412] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[326.381677] [088/133] (696s left) gem_eio (in-flight-1us)
[326.620442] Starting subtest: in-flight-1us
[334.895041] Subtest in-flight-1us: SUCCESS (8.273s)
[335.023909] [089/133] (687s left) kms_chamelium_edid (vga-edid-read)
[335.397909] Subtest vga-edid-read: SKIP (0.000s)
[336.245094] [090/133] (686s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[336.341971] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[336.344138] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[336.433041] [091/133] (686s left) kms_fb_coherency (memset-crc)
[336.520145] Starting subtest: memset-crc
[336.520984] Starting dynamic subtest: mmap-offset-wc
[336.918247] Dynamic subtest mmap-offset-wc: SUCCESS (0.397s)
[337.218027] Starting dynamic subtest: mmap-offset-uc
[343.409813] Dynamic subtest mmap-offset-uc: SUCCESS (6.199s)
[343.709428] Subtest memset-crc: SUCCESS (7.188s)
[344.545396] [092/133] (678s left) syncobj_timeline (invalid-query-bad-pad)
[344.604786] Starting subtest: invalid-query-bad-pad
[344.605804] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[344.717311] [093/133] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[344.810432] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[344.812271] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[344.910809] [094/133] (678s left) kms_psr (pr-no-drrs)
[345.002566] Starting subtest: pr-no-drrs
[345.004577] Subtest pr-no-drrs: SKIP (0.000s)
[345.085461] [095/133] (677s left) prime_self_import (export-vs-gem_close-race)
[345.121919] Starting subtest: export-vs-gem_close-race
[350.214199] Subtest export-vs-gem_close-race: SUCCESS (5.092s)
[350.288507] [096/133] (672s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[350.412271] Starting subtest: fbc-pr-cursor-mmap-gtt
[350.413908] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[350.504165] [097/133] (672s left) gem_exec_flush (basic-wb-set-default)
[350.583356] Starting subtest: basic-wb-set-default
[356.094805] Subtest basic-wb-set-default: SUCCESS (5.511s)
[356.274513] [098/133] (666s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[356.371837] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[356.373595] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[356.483512] [099/133] (666s left) kms_cursor_crc (cursor-sliding-128x42)
[356.699999] Starting subtest: cursor-sliding-128x42
[356.743799] Subtest cursor-sliding-128x42: SKIP (0.041s)
[356.939884] [100/133] (666s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[357.029508] Starting subtest: psr-1p-primscrn-spr-indfb-move
[364.630980] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.603s)
[364.767378] [101/133] (658s left) gem_ctx_shared (exec-single-timeline)
[364.818555] Starting subtest: exec-single-timeline
[364.819423] Starting dynamic subtest: rcs0
[365.884443] Dynamic subtest rcs0: SUCCESS (1.055s)
[365.894698] Starting dynamic subtest: bcs0
[366.973505] Dynamic subtest bcs0: SUCCESS (1.085s)
[366.986391] Starting dynamic subtest: vcs0
[368.060968] Dynamic subtest vcs0: SUCCESS (1.085s)
[368.072524] Starting dynamic subtest: vcs1
[369.149394] Dynamic subtest vcs1: SUCCESS (1.085s)
[369.160902] Starting dynamic subtest: vecs0
[370.237360] Dynamic subtest vecs0: SUCCESS (1.085s)
[370.247780] Starting dynamic subtest: ccs0
[371.326061] Dynamic subtest ccs0: SUCCESS (1.085s)
[371.327265] Subtest exec-single-timeline: SUCCESS (6.498s)
[372.005823] [102/133] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[372.094708] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[372.096548] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[372.187169] [103/133] (651s left) gem_exec_balancer (noheartbeat)
[372.451299] Starting subtest: noheartbeat
[372.453325] Subtest noheartbeat: SKIP (0.000s)
[372.536265] [104/133] (650s left) gem_softpin (evict-prime)
[372.584352] Starting subtest: evict-prime
[372.585248] Starting dynamic subtest: rcs0
[373.748436] Dynamic subtest rcs0: SUCCESS (1.163s)
[373.759305] Starting dynamic subtest: bcs0
[374.886512] Dynamic subtest bcs0: SUCCESS (1.136s)
[374.898359] Starting dynamic subtest: vcs0
[376.876059] Dynamic subtest vcs0: SUCCESS (1.977s)
[376.888014] Starting dynamic subtest: vcs1
[378.859499] Dynamic subtest vcs1: SUCCESS (1.981s)
[378.870374] Starting dynamic subtest: vecs0
[380.895864] Dynamic subtest vecs0: SUCCESS (2.034s)
[380.904533] Starting dynamic subtest: ccs0
[382.009411] Dynamic subtest ccs0: SUCCESS (1.121s)
[382.019989] Starting dynamic subtest: all
[383.907047] Dynamic subtest all: SUCCESS (1.885s)
[383.908438] Subtest evict-prime: SUCCESS (11.313s)
[383.981441] [105/133] (639s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[384.071804] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[384.073380] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[384.158130] [106/133] (639s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[384.245630] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[388.621386] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.376s)
[389.766747] [107/133] (633s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[389.853279] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[389.854163] Starting dynamic subtest: pipe-A-eDP-1
[389.862537] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.871439] Starting dynamic subtest: pipe-B-eDP-1
[389.879620] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.888429] Starting dynamic subtest: pipe-C-eDP-1
[389.896316] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.906657] Starting dynamic subtest: pipe-D-eDP-1
[389.914933] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.916555] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[392.105605] [108/133] (631s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[392.216442] Starting subtest: cursorA-vs-flipA-varying-size
[403.355104] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.137s)
[404.147341] [109/133] (619s left) gen7_exec_parse (oacontrol-tracking)
[404.202607] Subtest oacontrol-tracking: SKIP (0.000s)
[404.256900] [110/133] (619s left) gem_gtt_cpu_tlb
[404.360042] [111/133] (619s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[404.462052] Starting subtest: 4-tiled-32bpp-rotate-90
[404.481901] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[404.600112] [112/133] (618s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[404.712528] Starting subtest: fbc-psr2-sprite-mmap-cpu
[404.713456] Starting dynamic subtest: eDP-1
[404.715271] Dynamic subtest eDP-1: SKIP (0.000s)
[404.716934] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.002s)
[404.786242] [113/133] (618s left) kms_flip (basic-plain-flip)
[404.874312] Starting subtest: basic-plain-flip
[404.877525] Starting dynamic subtest: A-eDP1
[406.558500] Dynamic subtest A-eDP1: SUCCESS (1.682s)
[406.571860] Starting dynamic subtest: B-eDP1
[408.192231] Dynamic subtest B-eDP1: SUCCESS (1.630s)
[408.204389] Starting dynamic subtest: C-eDP1
[409.833344] Dynamic subtest C-eDP1: SUCCESS (1.635s)
[409.846554] Starting dynamic subtest: D-eDP1
[411.469123] Dynamic subtest D-eDP1: SUCCESS (1.634s)
[411.473466] Subtest basic-plain-flip: SUCCESS (6.600s)
[412.635617] [114/133] (611s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[412.736480] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[412.763525] Starting dynamic subtest: pipe-A-plane-0
[413.418820] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[413.427573] Starting dynamic subtest: pipe-A-plane-3
[413.874765] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[414.943178] Starting dynamic subtest: pipe-B-plane-0
[415.643457] Dynamic subtest pipe-B-plane-0: SUCCESS (0.711s)
[415.653078] Starting dynamic subtest: pipe-B-plane-3
[416.165787] Dynamic subtest pipe-B-plane-3: SUCCESS (0.521s)
[416.489927] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.754s)
[417.320208] [115/133] (606s left) core_setmaster_vs_auth
[417.500279] [116/133] (606s left) gem_ccs (ctrl-surf-copy)
[417.551836] Starting subtest: ctrl-surf-copy
[417.554047] Subtest ctrl-surf-copy: SKIP (0.000s)
[417.647185] [117/133] (606s left) drm_read (short-buffer-wakeup)
[417.800325] Starting subtest: short-buffer-wakeup
[450.027216] Subtest short-buffer-wakeup: SUCCESS (32.217s)
[450.160029] [118/133] (573s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[450.247267] Starting subtest: nonblocking-crc-frame-sequence
[450.248213] Starting dynamic subtest: pipe-A-eDP-1
[450.993380] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[451.001813] Starting dynamic subtest: pipe-B-eDP-1
[452.463305] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.468s)
[452.471595] Starting dynamic subtest: pipe-C-eDP-1
[453.830206] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[453.838472] Starting dynamic subtest: pipe-D-eDP-1
[455.156379] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[455.157259] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.909s)
[455.980146] [119/133] (567s left) perf_pmu (busy-idle-no-semaphores)
[456.019777] Starting subtest: busy-idle-no-semaphores
[456.020584] Starting dynamic subtest: rcs0
[456.686573] Dynamic subtest rcs0: SUCCESS (0.657s)
[456.697640] Starting dynamic subtest: bcs0
[457.339994] Dynamic subtest bcs0: SUCCESS (0.651s)
[457.351052] Starting dynamic subtest: vcs0
[457.992740] Dynamic subtest vcs0: SUCCESS (0.650s)
[458.003645] Starting dynamic subtest: vcs1
[459.527819] Dynamic subtest vcs1: SUCCESS (1.532s)
[459.538598] Starting dynamic subtest: vecs0
[461.510087] Dynamic subtest vecs0: SUCCESS (1.980s)
[461.521055] Starting dynamic subtest: ccs0
[463.559322] Dynamic subtest ccs0: SUCCESS (2.046s)
[463.560551] Subtest busy-idle-no-semaphores: SUCCESS (7.532s)
[463.664984] [120/133] (560s left) gem_exec_create (basic)
[463.720963] Starting subtest: basic
[463.721889] Starting dynamic subtest: smem
[465.815019] Dynamic subtest smem: SUCCESS (2.094s)
[465.818176] Subtest basic: SUCCESS (2.096s)
[466.001636] [121/133] (557s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[466.100451] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[473.088848] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.989s)
[473.233189] [122/133] (550s left) kms_color (ctm-max)
[473.327534] Starting subtest: ctm-max
[473.328452] Starting dynamic subtest: pipe-A-eDP-1
[474.044145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[474.053221] Starting dynamic subtest: pipe-B-eDP-1
[475.492421] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.455s)
[475.500704] Starting dynamic subtest: pipe-C-eDP-1
[476.890102] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[476.900241] Starting dynamic subtest: pipe-D-eDP-1
[478.209098] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[478.209923] Subtest ctm-max: SUCCESS (4.882s)
[479.010076] [123/133] (545s left) perf (invalid-create-userspace-config)
[479.104361] Starting subtest: invalid-create-userspace-config
[479.107215] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[479.141439] [124/133] (544s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[479.231582] Starting subtest: plane-use-after-nonblocking-unbind
[479.232468] Starting dynamic subtest: pipe-A-eDP-1
[479.294491] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[479.601410] Starting dynamic subtest: pipe-B-eDP-1
[480.414722] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.820s)
[480.702166] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.471s)
[481.570390] [125/133] (542s left) kms_flip (flip-vs-panning-vs-hang)
[481.655764] Starting subtest: flip-vs-panning-vs-hang
[481.656584] Starting dynamic subtest: A-eDP1
[533.441133] Dynamic subtest A-eDP1: SUCCESS (51.783s)
[533.453579] Starting dynamic subtest: D-eDP1
[573.443681] Dynamic subtest D-eDP1: SUCCESS (39.999s)
[573.446671] Subtest flip-vs-panning-vs-hang: SUCCESS (91.786s)
[574.661904] [126/133] (449s left) gem_create (create-ext-cpu-access-big)
[574.847441] Starting subtest: create-ext-cpu-access-big
[574.850031] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[574.926964] [127/133] (449s left) gem_reg_read (timestamp-moving)
[574.973110] Starting subtest: timestamp-moving
[575.983929] Subtest timestamp-moving: SUCCESS (1.001s)
[576.080216] [128/133] (448s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[576.145206] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[576.250906] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[576.324095] [129/133] (447s left) kms_addfb_basic (unused-handle)
[576.386071] Starting subtest: unused-handle
[576.386950] Subtest unused-handle: SUCCESS (0.000s)
[576.536785] [130/133] (447s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[576.631069] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[576.633538] Starting dynamic subtest: A-eDP1
[580.167491] Dynamic subtest A-eDP1: SUCCESS (3.533s)
[580.176125] Starting dynamic subtest: B-eDP1
[583.357142] Dynamic subtest B-eDP1: SUCCESS (3.188s)
[583.367627] Starting dynamic subtest: C-eDP1
[586.459810] Dynamic subtest C-eDP1: SUCCESS (3.102s)
[586.468470] Starting dynamic subtest: D-eDP1
[589.574750] Dynamic subtest D-eDP1: SUCCESS (3.113s)
[589.576959] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.944s)
[590.373157] [131/133] (433s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[590.470388] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[597.566228] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.095s)
[597.683539] [132/133] (426s left) kms_universal_plane (disable-primary-vs-flip)
[597.776409] Starting subtest: disable-primary-vs-flip
[597.777301] Starting dynamic subtest: pipe-A-eDP-1
[599.382395] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.604s)
[599.396529] Starting dynamic subtest: pipe-B-eDP-1
[601.631542] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.247s)
[601.641757] Starting dynamic subtest: pipe-C-eDP-1
[603.881617] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.248s)
[603.891194] Starting dynamic subtest: pipe-D-eDP-1
[606.068961] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.187s)
[606.069881] Subtest disable-primary-vs-flip: SUCCESS (8.293s)
[606.858655] [133/133] (417s left) syncobj_timeline (multi-wait-submitted-signaled)
[606.908871] Starting subtest: multi-wait-submitted-signaled
[606.909777] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[606.987283] Closing watchdogs
results: parsing output: 0/ for test: kms_vrr
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_properties
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: kms_prop_blob
results: parsing output: 8/ for test: kms_busy
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: kms_prop_blob
results: parsing output: 14/ for test: gem_pxp
results: parsing output: 15/ for test: i915_pm_rc6_residency
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: gem_mmap
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: prime_vgem
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: kms_pipe_b_c_ivb
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: gem_mmap_offset
results: parsing output: 28/ for test: gem_pxp
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: i915_pm_rps
results: parsing output: 37/ for test: prime_busy
results: parsing output: 38/ for test: i915_pm_freq_api
results: parsing output: 39/ for test: sysfs_timeslice_duration
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: gem_ctx_isolation
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: gem_workarounds
results: parsing output: 45/ for test: kms_content_protection
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_hdr
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_chamelium_audio
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: gem_eio
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_render_copy_redux
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: kms_scaling_modes
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_lease
results: parsing output: 79/ for test: kms_pm_dc
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: sw_sync
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: gem_partial_pwrite_pread
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_chamelium_edid
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_fb_coherency
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: prime_self_import
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_exec_flush
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_ctx_shared
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gen7_exec_parse
results: parsing output: 109/ for test: gem_gtt_cpu_tlb
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: core_setmaster_vs_auth
results: parsing output: 115/ for test: gem_ccs
results: parsing output: 116/ for test: drm_read
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: gem_exec_create
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_color
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: kms_atomic_transition
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_create
results: parsing output: 126/ for test: gem_reg_read
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_universal_plane
results: parsing output: 132/ for test: syncobj_timeline
Done.