[87.886243] Initializing watchdogs
[87.886453]   /dev/watchdog0
[87.925833] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[87.940465] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.948794] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.956314] [001/154] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[88.177090] Starting subtest: fbc-tiling-linear
[90.936843] Subtest fbc-tiling-linear: SUCCESS (2.769s)
[91.235952] [002/154] (957s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[91.341105] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[91.435889] [003/154] (957s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[91.623484] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[91.627597] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[91.767773] [004/154] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[91.958795] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[91.962875] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[92.103116] [005/154] (956s left) kms_force_connector_basic (prune-stale-modes)
[92.351953] Starting subtest: prune-stale-modes
[92.507737] Subtest prune-stale-modes: SUCCESS (0.155s)
[92.815740] [006/154] (956s left) perf_pmu (most-busy-check-all)
[92.933151] Starting subtest: most-busy-check-all
[92.935117] Starting dynamic subtest: rcs0
[93.461047] Dynamic subtest rcs0: SUCCESS (0.528s)
[93.486796] Starting dynamic subtest: bcs0
[93.992159] Dynamic subtest bcs0: SUCCESS (0.530s)
[94.016792] Starting dynamic subtest: vcs0
[94.524262] Dynamic subtest vcs0: SUCCESS (0.531s)
[94.549382] Starting dynamic subtest: vecs0
[95.049904] Dynamic subtest vecs0: SUCCESS (0.525s)
[95.051823] Subtest most-busy-check-all: SUCCESS (2.117s)
[95.184300] [007/154] (953s left) gem_ccs (large-ctrl-surf-copy)
[95.300616] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[95.392626] [008/154] (953s left) kms_plane_alpha_blend (coverage-7efc)
[95.563392] Starting subtest: coverage-7efc
[95.751153] Starting dynamic subtest: pipe-A-HDMI-A-1
[96.696446] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.946s)
[96.777518] Starting dynamic subtest: pipe-C-HDMI-A-1
[97.698256] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.939s)
[97.700036] Subtest coverage-7efc: SUCCESS (2.135s)
[98.021365] [009/154] (951s left) gem_mmap_gtt (fault-concurrent)
[98.128215] Starting subtest: fault-concurrent
[101.364497] Subtest fault-concurrent: SUCCESS (3.236s)
[101.539185] [010/154] (947s left) api_intel_allocator (gem-pool)
[101.643678] Starting subtest: gem-pool
[101.662565] Subtest gem-pool: SUCCESS (0.020s)
[101.819212] [011/154] (947s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[102.009242] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[103.152595] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SUCCESS (1.145s)
[103.366687] [012/154] (945s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[103.537697] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[103.541480] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[103.670448] [013/154] (945s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[103.865812] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[103.867648] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.608180] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.729s)
[104.629100] Starting dynamic subtest: pipe-A-HDMI-A-2
[105.072657] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.463s)
[105.093985] Starting dynamic subtest: pipe-B-HDMI-A-1
[105.567884] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.493s)
[105.588630] Starting dynamic subtest: pipe-B-HDMI-A-2
[106.002048] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.431s)
[106.022602] Starting dynamic subtest: pipe-C-HDMI-A-1
[106.041644] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[106.062216] Starting dynamic subtest: pipe-C-HDMI-A-2
[106.081080] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[106.083156] Subtest crc-primary-rotation-180-yf-tiled-ccs: SUCCESS (2.137s)
[106.792356] [014/154] (942s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[106.969302] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[106.971141] Starting dynamic subtest: pipe-A-HDMI-A-1
[106.989781] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[107.010923] Starting dynamic subtest: pipe-A-HDMI-A-2
[107.029294] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[107.050075] Starting dynamic subtest: pipe-B-HDMI-A-1
[107.068566] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[107.090637] Starting dynamic subtest: pipe-B-HDMI-A-2
[107.109761] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[107.129618] Starting dynamic subtest: pipe-C-HDMI-A-1
[107.147788] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[107.168092] Starting dynamic subtest: pipe-C-HDMI-A-2
[107.186167] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[107.190018] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.018s)
[107.919567] [015/154] (941s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[108.107336] Starting subtest: hdr-rgb565-draw-blt
[108.894495] Subtest hdr-rgb565-draw-blt: SUCCESS (0.785s)
[109.149881] [016/154] (940s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[109.267184] Starting subtest: x-tiled-to-vebox-y-tiled
[109.271573] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[109.500550] [017/154] (940s left) sysfs_heartbeat_interval (invalid)
[109.611474] Starting subtest: invalid
[109.613686] Starting dynamic subtest: vecs0
[109.615714] Dynamic subtest vecs0: SUCCESS (0.001s)
[109.637581] Starting dynamic subtest: vcs0
[109.640272] Dynamic subtest vcs0: SUCCESS (0.001s)
[109.661591] Starting dynamic subtest: bcs0
[109.664593] Dynamic subtest bcs0: SUCCESS (0.001s)
[109.685105] Starting dynamic subtest: rcs0
[109.687193] Dynamic subtest rcs0: SUCCESS (0.001s)
[109.689209] Subtest invalid: SUCCESS (0.011s)
[109.766344] [018/154] (940s left) kms_frontbuffer_tracking (fbc-stridechange)
[109.959012] Starting subtest: fbc-stridechange
[112.344897] Subtest fbc-stridechange: SUCCESS (2.384s)
[112.642566] [019/154] (937s left) gem_ctx_param (basic-default)
[112.746988] Starting subtest: basic-default
[112.749129] Subtest basic-default: SUCCESS (0.000s)
[112.873366] [020/154] (937s left) kms_psr (fbc-pr-primary-mmap-gtt)
[113.045223] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[113.148841] [021/154] (936s left) i915_pm_freq_mult (media-freq)
[113.246475] Starting subtest: media-freq
[113.248347] Starting dynamic subtest: gt0
[113.252290] Dynamic subtest gt0: SKIP (0.000s)
[113.255884] Subtest media-freq: SKIP (0.002s)
[113.373719] [022/154] (936s left) prime_busy (before-wait)
[113.483805] Starting subtest: before-wait
[113.496316] Starting dynamic subtest: rcs0
[113.507990] Dynamic subtest rcs0: SUCCESS (0.011s)
[113.529759] Starting dynamic subtest: bcs0
[113.532551] Dynamic subtest bcs0: SUCCESS (0.020s)
[113.555877] Starting dynamic subtest: vcs0
[113.558218] Dynamic subtest vcs0: SUCCESS (0.018s)
[113.581062] Starting dynamic subtest: vecs0
[113.583878] Dynamic subtest vecs0: SUCCESS (0.016s)
[113.676788] Subtest before-wait: SUCCESS (0.192s)
[113.812402] [023/154] (936s left) gem_exec_gttfill (engines)
[113.935221] Starting subtest: engines
[113.937364] Starting dynamic subtest: rcs0
[140.902691] Dynamic subtest rcs0: SUCCESS (26.964s)
[140.929530] Starting dynamic subtest: bcs0
[168.938375] Dynamic subtest bcs0: SUCCESS (28.033s)
[168.962092] Starting dynamic subtest: vcs0
[196.311884] Dynamic subtest vcs0: SUCCESS (27.373s)
[196.336520] Starting dynamic subtest: vecs0
[223.687488] Dynamic subtest vecs0: SUCCESS (27.374s)
[223.689542] Subtest engines: SUCCESS (109.752s)
[223.937794] [024/154] (826s left) syncobj_timeline (etime-multi-wait-all-submitted)
[224.148075] Starting subtest: etime-multi-wait-all-submitted
[224.260898] Subtest etime-multi-wait-all-submitted: SUCCESS (0.111s)
[224.395614] [025/154] (826s left) gem_ctx_param (get-priority-new-ctx)
[224.495090] Starting subtest: get-priority-new-ctx
[224.497141] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[224.630220] [026/154] (825s left) kms_big_fb (linear-32bpp-rotate-90)
[224.837286] Starting subtest: linear-32bpp-rotate-90
[225.138392] Subtest linear-32bpp-rotate-90: SKIP (0.297s)
[225.412531] [027/154] (825s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[225.526121] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[225.624215] [028/154] (825s left) gem_ctx_shared (disjoint-timelines)
[225.744624] Starting subtest: disjoint-timelines
[225.814983] Subtest disjoint-timelines: SUCCESS (0.070s)
[226.097947] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[226.105411] [029/154] (824s left) kms_psr (fbc-psr2-cursor-plane-move)
[226.276340] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[226.381908] [030/154] (824s left) gem_bad_reloc (negative-reloc-bltcopy)
[226.490827] Starting subtest: negative-reloc-bltcopy
[229.400866] Subtest negative-reloc-bltcopy: SUCCESS (2.906s)
[229.721382] [031/154] (821s left) kms_chamelium_hpd (hdmi-hpd)
[230.261736] Subtest hdmi-hpd: SKIP (0.000s)
[230.563973] [032/154] (820s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[230.738248] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[230.854863] [033/154] (820s left) gem_eio (wait-10ms)
[230.978418] Starting subtest: wait-10ms
[231.071452] Subtest wait-10ms: SUCCESS (0.089s)
[231.329498] [034/154] (819s left) kms_content_protection (legacy-hdcp14)
[231.534831] Starting subtest: legacy-hdcp14
[231.552726] Subtest legacy-hdcp14: SKIP (0.012s)
[231.698916] [035/154] (819s left) syncobj_wait (reset-signaled)
[231.802138] Starting subtest: reset-signaled
[231.804340] Subtest reset-signaled: SUCCESS (0.001s)
[231.946467] [036/154] (819s left) gem_ctx_isolation (dirty-switch)
[232.062783] Starting subtest: dirty-switch
[232.065034] Starting dynamic subtest: rcs0
[232.660536] Dynamic subtest rcs0: SUCCESS (0.595s)
[232.685947] Starting dynamic subtest: bcs0
[233.579633] Dynamic subtest bcs0: SUCCESS (0.919s)
[233.604560] Starting dynamic subtest: vcs0
[234.166649] Dynamic subtest vcs0: SUCCESS (0.585s)
[234.191471] Starting dynamic subtest: vecs0
[234.744273] Dynamic subtest vecs0: SUCCESS (0.577s)
[234.746134] Subtest dirty-switch: SUCCESS (2.681s)
[234.999598] [037/154] (816s left) gem_flink_basic (bad-open)
[235.096735] Starting subtest: bad-open
[235.099991] Subtest bad-open: SUCCESS (0.000s)
[235.241590] [038/154] (816s left) gem_caching (writes)
[235.352263] Starting subtest: writes
[248.723395] Subtest writes: SUCCESS (13.371s)
[248.899988] [039/154] (802s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[249.074570] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[249.076474] Starting dynamic subtest: pipe-A
[249.885573] Dynamic subtest pipe-A: SUCCESS (0.814s)
[249.912282] Starting dynamic subtest: pipe-B
[250.711717] Dynamic subtest pipe-B: SUCCESS (0.824s)
[250.738660] Starting dynamic subtest: pipe-C
[251.543414] Dynamic subtest pipe-C: SUCCESS (0.830s)
[251.545536] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (2.474s)
[252.082853] [040/154] (799s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[252.190539] Starting subtest: single-wait-all-for-submit-available-submitted
[252.192638] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[252.334747] [041/154] (799s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[252.521240] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[253.719411] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SUCCESS (1.198s)
[253.967902] [042/154] (798s left) kms_pm_rpm (system-suspend-idle)
[255.894748] Starting subtest: system-suspend-idle
[272.960303] Subtest system-suspend-idle: SUCCESS (1.783s)
[282.377923] [043/154] (778s left) kms_atomic_transition (modeset-transition)
[282.559172] Starting subtest: modeset-transition
[282.561227] Starting dynamic subtest: 1x-outputs
[286.339346] Dynamic subtest 1x-outputs: SUCCESS (3.903s)
[286.366571] Starting dynamic subtest: 2x-outputs
[293.909528] Dynamic subtest 2x-outputs: SUCCESS (7.686s)
[293.911751] Subtest modeset-transition: SUCCESS (11.593s)
[294.253394] [044/154] (767s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[294.433639] Starting subtest: pipe-fbc-rte
[294.443369] Subtest pipe-fbc-rte: SKIP (0.001s)
[294.614490] [045/154] (766s left) gem_spin_batch (resubmit-all)
[294.734430] Starting subtest: resubmit-all
[294.736399] Starting dynamic subtest: rcs0
[294.745193] Dynamic subtest rcs0: SUCCESS (0.009s)
[294.782939] Starting dynamic subtest: bcs0
[294.785972] Dynamic subtest bcs0: SUCCESS (0.007s)
[294.813080] Starting dynamic subtest: vcs0
[294.816953] Dynamic subtest vcs0: SUCCESS (0.005s)
[294.844279] Starting dynamic subtest: vecs0
[294.847441] Dynamic subtest vecs0: SUCCESS (0.005s)
[294.850398] Subtest resubmit-all: SUCCESS (0.037s)
[295.057293] [046/154] (766s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[295.245112] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[295.249218] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[295.408525] [047/154] (766s left) syncobj_basic (illegal-fd-to-handle)
[295.509009] Starting subtest: illegal-fd-to-handle
[295.511016] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[295.656536] [048/154] (766s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[295.840902] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[298.585583] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.760s)
[298.812213] [049/154] (762s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[299.005721] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[300.724848] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.725s)
[301.020672] [050/154] (760s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[301.122957] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[301.233354] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[301.384522] [051/154] (760s left) api_intel_bb (misplaced-blitter)
[301.483052] Starting subtest: misplaced-blitter
[301.495442] Subtest misplaced-blitter: SUCCESS (0.012s)
[301.668335] [052/154] (760s left) kms_atomic_interruptible (universal-setplane-cursor)
[301.843387] Starting subtest: universal-setplane-cursor
[301.848771] Starting dynamic subtest: pipe-A-HDMI-A-1
[308.607867] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.777s)
[308.610023] Subtest universal-setplane-cursor: SUCCESS (6.782s)
[308.953099] [053/154] (753s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[309.148284] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[309.152286] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[309.302952] [054/154] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[309.492844] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[309.496537] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[309.651703] [055/154] (752s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[309.828532] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[309.830362] Starting dynamic subtest: pipe-A-valid-mode
[310.788606] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.957s)
[310.790681] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.961s)
[311.139665] [056/154] (751s left) gem_pxp (create-protected-buffer)
[313.788988] Starting subtest: create-protected-buffer
[313.794096] Subtest create-protected-buffer: SKIP (0.000s)
[313.969563] [057/154] (748s left) gen9_exec_parse (allowed-single)
[314.090441] Starting subtest: allowed-single
[314.098064] Subtest allowed-single: SUCCESS (0.008s)
[314.421775] [058/154] (748s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[314.609630] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[314.613605] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[314.774645] [059/154] (747s left) gem_exec_balancer (bonded-semaphore)
[314.898696] Starting subtest: bonded-semaphore
[318.958257] Subtest bonded-semaphore: SUCCESS (4.055s)
[319.259790] [060/154] (743s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[319.434714] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[319.438543] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[319.572654] [061/154] (743s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[319.761758] Starting subtest: fbc-rgb565-draw-mmap-wc
[322.474714] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.711s)
[322.772381] [062/154] (740s left) kms_pwrite_crc (basic)
[322.950264] Starting subtest: basic
[323.859580] Subtest basic: SUCCESS (0.909s)
[324.199895] [063/154] (738s left) gem_flink_basic (bad-flink)
[324.300121] Starting subtest: bad-flink
[324.303771] Subtest bad-flink: SUCCESS (0.000s)
[324.449327] [064/154] (738s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[324.636767] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[325.744330] Subtest hdr-2p-primscrn-spr-indfb-move: SUCCESS (1.109s)
[325.980027] [065/154] (737s left) gem_ctx_persistence (legacy-engines-persistence)
[326.094725] Starting subtest: legacy-engines-persistence
[326.096733] Starting dynamic subtest: render
[326.900247] Dynamic subtest render: SUCCESS (0.802s)
[326.931180] Starting dynamic subtest: bsd
[327.664933] Dynamic subtest bsd: SUCCESS (0.760s)
[327.696036] Starting dynamic subtest: blt
[328.428362] Dynamic subtest blt: SUCCESS (0.759s)
[328.458924] Starting dynamic subtest: vebox
[329.201441] Dynamic subtest vebox: SUCCESS (0.768s)
[329.203784] Subtest legacy-engines-persistence: SUCCESS (3.110s)
[329.380124] [066/154] (734s left) gen7_exec_parse (basic-allowed)
[329.491687] Subtest basic-allowed: SKIP (0.000s)
[329.602384] [067/154] (733s left) gem_exec_schedule (reorder-wide)
[329.855575] Starting subtest: reorder-wide
[329.857529] Starting dynamic subtest: rcs0
[330.020374] Dynamic subtest rcs0: SUCCESS (0.160s)
[330.052661] Starting dynamic subtest: bcs0
[330.326919] Dynamic subtest bcs0: SUCCESS (0.302s)
[330.363778] Starting dynamic subtest: vcs0
[330.476813] Dynamic subtest vcs0: SUCCESS (0.148s)
[330.509851] Starting dynamic subtest: vecs0
[330.624027] Dynamic subtest vecs0: SUCCESS (0.141s)
[330.625931] Subtest reorder-wide: SUCCESS (0.766s)
[330.942359] [068/154] (732s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[331.129081] Starting subtest: psrhdr-slowdraw
[331.132896] Subtest psrhdr-slowdraw: SKIP (0.000s)
[331.315398] [069/154] (732s left) perf (non-zero-reason)
[331.570354] Starting subtest: non-zero-reason
[331.572512] Starting dynamic subtest: 0-rcs0
[380.468747] Dynamic subtest 0-rcs0: SUCCESS (48.910s)
[380.471597] Subtest non-zero-reason: SUCCESS (48.912s)
[380.583903] [070/154] (683s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[380.772486] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[382.012609] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.239s)
[382.252852] [071/154] (681s left) i915_drm_fdinfo (all-busy-check-all)
[382.363161] Starting subtest: all-busy-check-all
[382.882020] Subtest all-busy-check-all: SUCCESS (0.517s)
[383.019999] [072/154] (681s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[383.209165] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[383.213654] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[383.372927] [073/154] (680s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[383.547732] Starting subtest: compare-crc-sanitycheck-nv12
[383.549737] Starting dynamic subtest: pipe-A-HDMI-A-1
[384.724661] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.173s)
[384.757828] Starting dynamic subtest: pipe-B-HDMI-A-2
[385.392592] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.662s)
[385.423920] Starting dynamic subtest: pipe-C-HDMI-A-1
[386.069093] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.670s)
[386.071368] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.523s)
[386.412799] [074/154] (677s left) gem_exec_reloc (basic-write-gtt)
[386.532999] Starting subtest: basic-write-gtt
[386.549894] Subtest basic-write-gtt: SUCCESS (0.016s)
[386.779725] [075/154] (677s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[386.971686] Starting subtest: cursor-rapid-movement-max-size
[386.977409] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[387.130727] [076/154] (677s left) kms_color_pipeline (plane-lut1d)
[387.303895] Starting subtest: plane-lut1d
[388.791669] Subtest plane-lut1d: SKIP (1.487s)
[389.111975] [077/154] (675s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[389.305622] Starting subtest: yf-tiled-16bpp-rotate-180
[392.279773] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (2.972s)
[392.628114] [078/154] (672s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[392.822398] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[392.826269] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[392.981150] [079/154] (671s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[393.168725] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[393.172403] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[393.328661] [080/154] (671s left) gem_exec_reloc (basic-wc-read)
[393.443412] Starting subtest: basic-wc-read
[393.460370] Subtest basic-wc-read: SUCCESS (0.016s)
[393.679946] [081/154] (671s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[393.854754] Starting subtest: short-busy-flip-before-cursor-toggle
[393.858509] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[394.027913] [082/154] (671s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[394.216540] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[394.223688] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[405.238996] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.018s)
[405.271957] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[416.225775] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.980s)
[416.257843] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[427.197184] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.967s)
[427.199521] Subtest 2x-plain-flip-fb-recreate-interruptible: SUCCESS (32.985s)
[427.808132] [083/154] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[428.000974] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[428.004816] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[428.161105] [084/154] (637s left) kms_draw_crc (draw-method-render)
[428.336420] Starting subtest: draw-method-render
[428.338387] Starting dynamic subtest: xrgb8888-untiled
[428.841049] Dynamic subtest xrgb8888-untiled: SUCCESS (0.505s)
[428.872397] Starting dynamic subtest: rgb565-untiled
[429.123509] Dynamic subtest rgb565-untiled: SUCCESS (0.279s)
[429.154863] Starting dynamic subtest: xrgb2101010-untiled
[429.423442] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s)
[429.455063] Starting dynamic subtest: xbgr16161616f-untiled
[429.757159] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.330s)
[429.786008] Starting dynamic subtest: xrgb8888-xtiled
[429.957308] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.198s)
[429.989541] Starting dynamic subtest: rgb565-xtiled
[430.142139] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s)
[430.174786] Starting dynamic subtest: xrgb2101010-xtiled
[430.324261] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.177s)
[430.355065] Starting dynamic subtest: xbgr16161616f-xtiled
[430.506779] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.180s)
[430.539317] Starting dynamic subtest: xrgb8888-ytiled
[430.690828] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.181s)
[430.722789] Starting dynamic subtest: rgb565-ytiled
[430.873720] Dynamic subtest rgb565-ytiled: SUCCESS (0.179s)
[430.906744] Starting dynamic subtest: xrgb2101010-ytiled
[431.039811] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.163s)
[431.073576] Starting dynamic subtest: xbgr16161616f-ytiled
[431.223776] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.180s)
[431.225837] Subtest draw-method-render: SUCCESS (2.891s)
[431.474648] [085/154] (633s left) kms_cursor_crc (cursor-sliding-256x85)
[431.660587] Starting subtest: cursor-sliding-256x85
[431.705005] Starting dynamic subtest: pipe-A-HDMI-A-1
[435.690749] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.985s)
[435.776967] Starting dynamic subtest: pipe-C-HDMI-A-1
[439.473659] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.720s)
[439.475570] Subtest cursor-sliding-256x85: SUCCESS (7.814s)
[439.819874] [086/154] (625s left) kms_cursor_crc (cursor-onscreen-256x256)
[440.006659] Starting subtest: cursor-onscreen-256x256
[440.047810] Starting dynamic subtest: pipe-A-HDMI-A-1
[442.700707] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.651s)
[442.804335] Starting dynamic subtest: pipe-C-HDMI-A-1
[445.156178] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.394s)
[445.158278] Subtest cursor-onscreen-256x256: SUCCESS (5.150s)
[445.514223] [087/154] (620s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[445.704987] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[445.708822] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[445.862894] [088/154] (619s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[446.050699] Starting subtest: fbcpsr-slowdraw
[446.054676] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[446.212249] [089/154] (619s left) kms_lease (cursor-implicit-plane)
[446.393634] Starting subtest: cursor-implicit-plane
[446.395905] Starting dynamic subtest: pipe-A-HDMI-A-1
[447.044530] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.652s)
[447.079256] Starting dynamic subtest: pipe-A-HDMI-A-2
[447.462956] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.415s)
[447.497006] Starting dynamic subtest: pipe-B-HDMI-A-1
[447.857282] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.387s)
[447.887585] Starting dynamic subtest: pipe-B-HDMI-A-2
[448.248578] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.388s)
[448.280699] Starting dynamic subtest: pipe-C-HDMI-A-1
[448.641297] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.387s)
[448.670976] Starting dynamic subtest: pipe-C-HDMI-A-2
[449.042613] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.397s)
[449.044707] Subtest cursor-implicit-plane: SUCCESS (2.657s)
[449.385733] [090/154] (616s left) syncobj_wait (invalid-reset-zero-handles)
[449.493206] Starting subtest: invalid-reset-zero-handles
[449.495297] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[449.647415] [091/154] (616s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[449.838877] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[452.081239] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SUCCESS (2.241s)
[452.312797] [092/154] (613s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[452.507742] Starting subtest: yf-tiled-64bpp-rotate-90
[452.512183] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[452.677016] [093/154] (613s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[452.863341] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[453.607617] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (0.741s)
[453.916873] [094/154] (612s left) gem_exec_fence (long-history)
[454.443935] Starting subtest: long-history
[460.188480] Subtest long-history: SUCCESS (5.739s)
[460.816847] [095/154] (605s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[461.004252] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[461.010043] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[461.183496] [096/154] (605s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[461.362248] Starting subtest: bad-rotation-90-yf-tiled-ccs
[461.364391] Starting dynamic subtest: pipe-A-HDMI-A-1
[461.501330] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.128s)
[461.533910] Starting dynamic subtest: pipe-A-HDMI-A-2
[461.562524] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.055s)
[461.592818] Starting dynamic subtest: pipe-B-HDMI-A-1
[461.622098] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.054s)
[461.652334] Starting dynamic subtest: pipe-B-HDMI-A-2
[461.676174] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.048s)
[461.705862] Starting dynamic subtest: pipe-C-HDMI-A-1
[461.724613] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[461.753217] Starting dynamic subtest: pipe-C-HDMI-A-2
[461.771202] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[461.774817] Subtest bad-rotation-90-yf-tiled-ccs: SUCCESS (0.312s)
[462.656043] [097/154] (603s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[462.830008] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[468.609239] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (5.782s)
[468.933169] [098/154] (597s left) kms_chamelium_audio (dp-audio-edid)
[469.486813] Subtest dp-audio-edid: SKIP (0.000s)
[469.789956] [099/154] (597s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[469.966670] Starting subtest: addfb25-yf-tiled-legacy
[469.968634] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[470.137730] [100/154] (596s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[470.323401] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[471.159780] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SUCCESS (0.837s)
[471.436793] [101/154] (595s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[471.628473] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[471.632477] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[471.787044] [102/154] (595s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[471.975545] Starting subtest: fbc-2p-pri-indfb-multidraw
[489.111540] Subtest fbc-2p-pri-indfb-multidraw: SUCCESS (17.139s)
[489.342641] [103/154] (577s left) kms_sequence (queue-busy)
[489.522641] Starting subtest: queue-busy
[489.524613] Starting dynamic subtest: pipe-A-HDMI-A-1
[492.409111] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.886s)
[492.438314] Starting dynamic subtest: pipe-A-HDMI-A-2
[495.055250] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.645s)
[495.089663] Starting dynamic subtest: pipe-B-HDMI-A-1
[497.684064] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.621s)
[497.711995] Starting dynamic subtest: pipe-B-HDMI-A-2
[500.270474] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.587s)
[500.302424] Starting dynamic subtest: pipe-C-HDMI-A-1
[502.876392] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.599s)
[502.908658] Starting dynamic subtest: pipe-C-HDMI-A-2
[505.472602] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.590s)
[505.474750] Subtest queue-busy: SUCCESS (15.955s)
[505.801111] [104/154] (561s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[505.980384] Starting subtest: plane-upscale-20x20-with-rotation
[505.982484] Starting dynamic subtest: pipe-A
[509.861168] Dynamic subtest pipe-A: SKIP (3.877s)
[509.889820] Starting dynamic subtest: pipe-B
[513.783462] Dynamic subtest pipe-B: SKIP (3.915s)
[513.811662] Starting dynamic subtest: pipe-C
[517.825321] Dynamic subtest pipe-C: SKIP (4.039s)
[517.829436] Subtest plane-upscale-20x20-with-rotation: SKIP (11.840s)
[518.360076] [105/154] (549s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[518.580913] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[518.585738] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[518.744673] [106/154] (548s left) gem_exec_reloc (basic-write-wc)
[518.858970] Starting subtest: basic-write-wc
[518.875724] Subtest basic-write-wc: SUCCESS (0.019s)
[519.091487] [107/154] (548s left) syncobj_timeline (reset-signaled)
[519.195538] Starting subtest: reset-signaled
[519.197646] Subtest reset-signaled: SUCCESS (0.001s)
[519.342873] [108/154] (548s left) kms_psr (pr-cursor-plane-move)
[519.516715] Subtest pr-cursor-plane-move: SKIP (0.000s)
[519.667189] [109/154] (548s left) syncobj_wait (invalid-wait-illegal-handle)
[519.770801] Starting subtest: invalid-wait-illegal-handle
[519.772990] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[519.909835] [110/154] (548s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[520.100896] Starting subtest: extended-pageflip-modeset-hang-oldfb
[520.102770] Starting dynamic subtest: pipe-A
[524.177021] Dynamic subtest pipe-A: SUCCESS (4.073s)
[524.209715] Starting dynamic subtest: pipe-C
[528.127738] Dynamic subtest pipe-C: SUCCESS (3.942s)
[528.130019] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (8.031s)
[528.503848] [111/154] (539s left) kms_psr (psr2-primary-blt)
[528.679335] Subtest psr2-primary-blt: SKIP (0.000s)
[528.794433] [112/154] (539s left) gem_softpin (evict-snoop-interruptible)
[528.906743] Starting subtest: evict-snoop-interruptible
[528.910607] Subtest evict-snoop-interruptible: SKIP (0.000s)
[529.086673] [113/154] (539s left) kms_force_connector_basic (force-load-detect)
[529.342015] Starting subtest: force-load-detect
[529.345654] Subtest force-load-detect: SKIP (0.000s)
[529.671938] [114/154] (538s left) kms_chamelium_edid (hdmi-mode-timings)
[530.221219] Subtest hdmi-mode-timings: SKIP (0.000s)
[530.528268] [115/154] (537s left) syncobj_timeline (invalid-signal-zero-handles)
[530.630946] Starting subtest: invalid-signal-zero-handles
[530.633083] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[530.780748] [116/154] (537s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[530.967492] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[530.971541] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[531.134201] [117/154] (537s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[531.321282] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[531.325532] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[531.498917] [118/154] (537s left) gem_mmap_gtt (fault-concurrent-x)
[531.602674] Starting subtest: fault-concurrent-X
[534.787019] Subtest fault-concurrent-X: SUCCESS (3.184s)
[534.947095] [119/154] (533s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[535.068305] Starting subtest: y-tiled-to-vebox-y-tiled
[535.072055] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[535.330721] [120/154] (533s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[535.518847] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[535.522661] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[535.682988] [121/154] (533s left) vgem_basic (debugfs)
[535.788704] Starting subtest: debugfs
[535.790829] Subtest debugfs: SUCCESS (0.001s)
[535.912738] [122/154] (533s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[536.084323] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[536.086369] Starting dynamic subtest: pipe-A-valid-mode
[537.021593] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.937s)
[537.023714] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.941s)
[537.368743] [123/154] (531s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[537.560002] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[540.935520] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.378s)
[541.140962] [124/154] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[541.332717] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[541.336565] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[541.500889] [125/154] (527s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[541.688798] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[541.692680] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[541.868227] [126/154] (527s left) kms_vblank (wait-forked-hang)
[542.048617] Starting subtest: wait-forked-hang
[542.050471] Starting dynamic subtest: pipe-A-HDMI-A-1
[549.143518] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.094s)
[549.175538] Starting dynamic subtest: pipe-A-HDMI-A-2
[556.195355] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.044s)
[556.233225] Starting dynamic subtest: pipe-C-HDMI-A-1
[563.141823] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.939s)
[563.173649] Starting dynamic subtest: pipe-C-HDMI-A-2
[570.194382] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.044s)
[570.196356] Subtest wait-forked-hang: SUCCESS (28.150s)
[570.546917] [127/154] (499s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[570.721426] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[570.723244] Starting dynamic subtest: pipe-A-valid-mode
[571.551030] Dynamic subtest pipe-A-valid-mode: SKIP (0.826s)
[571.554653] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.831s)
[572.057387] [128/154] (497s left) gem_ctx_exec (basic-invalid-context)
[572.166551] Starting subtest: basic-invalid-context
[572.171860] Subtest basic-invalid-context: SUCCESS (0.007s)
[572.351507] [129/154] (497s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[572.551282] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[572.555010] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[572.706874] [130/154] (497s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[572.890109] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[572.998093] [131/154] (497s left) gem_ppgtt (blt-vs-render-ctxn)
[573.108795] Starting subtest: blt-vs-render-ctxN
[606.128368] Subtest blt-vs-render-ctxN: SUCCESS (33.023s)
[606.308066] [132/154] (463s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[606.535432] Starting subtest: basic-gtt-cpu-noreloc
[606.541515] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.009s)
[606.771151] [133/154] (463s left) gem_softpin (invalid)
[606.884107] Starting subtest: invalid
[606.894788] Subtest invalid: SUCCESS (0.011s)
[607.086836] [134/154] (463s left) gem_exec_capture (capture)
[607.199787] Starting subtest: capture
[607.201627] Starting dynamic subtest: rcs0-smem
[608.486645] Dynamic subtest rcs0-smem: SUCCESS (1.285s)
[608.514805] Starting dynamic subtest: bcs0-smem
[609.766547] Dynamic subtest bcs0-smem: SUCCESS (1.279s)
[609.798160] Starting dynamic subtest: vcs0-smem
[611.054608] Dynamic subtest vcs0-smem: SUCCESS (1.285s)
[611.086164] Starting dynamic subtest: vecs0-smem
[612.336783] Dynamic subtest vecs0-smem: SUCCESS (1.278s)
[612.338811] Subtest capture: SUCCESS (5.140s)
[612.486259] [135/154] (458s left) gem_tiled_blits (basic)
[612.688543] Starting subtest: basic
[612.716940] Subtest basic: SUCCESS (0.032s)
[612.920916] [136/154] (457s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[613.244923] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[613.248895] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[613.419097] [137/154] (457s left) gem_mmap_offset (partial-remap)
[613.525673] Starting subtest: partial-remap
[613.527754] Starting dynamic subtest: smem0
[613.537564] Dynamic subtest smem0: SUCCESS (0.007s)
[613.539704] Subtest partial-remap: SUCCESS (0.010s)
[613.717856] [138/154] (457s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[613.907296] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[614.730258] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (0.824s)
[615.055974] [139/154] (455s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[615.243305] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[616.420731] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SUCCESS (1.178s)
[616.640764] [140/154] (454s left) i915_power (sanity)
[616.743262] Starting subtest: sanity
[620.769066] Subtest sanity: SUCCESS (4.023s)
[620.946176] [141/154] (450s left) gem_exec_schedule (preempt-queue)
[621.092986] Starting subtest: preempt-queue
[621.094978] Starting dynamic subtest: rcs0
[621.430636] Dynamic subtest rcs0: SUCCESS (0.334s)
[621.467569] Starting dynamic subtest: bcs0
[621.774959] Dynamic subtest bcs0: SUCCESS (0.337s)
[621.807598] Starting dynamic subtest: vcs0
[622.100877] Dynamic subtest vcs0: SUCCESS (0.325s)
[622.137318] Starting dynamic subtest: vecs0
[622.426981] Dynamic subtest vecs0: SUCCESS (0.323s)
[622.429597] Subtest preempt-queue: SUCCESS (1.335s)
[622.843910] [142/154] (448s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[623.028717] Starting subtest: cursorB-vs-flipA-legacy
[634.628687] Subtest cursorB-vs-flipA-legacy: SUCCESS (11.606s)
[634.974068] [143/154] (436s left) i915_pm_rps (reset)
[635.097195] Starting subtest: reset
[639.666586] Subtest reset: SUCCESS (4.574s)
[639.834621] [144/154] (431s left) kms_psr (fbc-psr-cursor-plane-onoff)
[640.009536] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[640.136806] [145/154] (431s left) kms_setmode (clone-exclusive-crtc)
[640.239431] Starting subtest: clone-exclusive-crtc
[640.690293] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[640.990845] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.299s)
[641.462290] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[641.739477] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (0.302s)
[642.152973] Subtest clone-exclusive-crtc: SUCCESS (1.914s)
[642.507690] [146/154] (429s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[642.699557] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[642.703793] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[642.870887] [147/154] (428s left) kms_flip (flip-vs-rmfb)
[643.042649] Starting subtest: flip-vs-rmfb
[643.049912] Starting dynamic subtest: A-HDMI-A1
[648.712166] Dynamic subtest A-HDMI-A1: SUCCESS (5.665s)
[648.744974] Starting dynamic subtest: B-HDMI-A1
[654.136655] Dynamic subtest B-HDMI-A1: SUCCESS (5.421s)
[654.169621] Starting dynamic subtest: C-HDMI-A1
[659.557756] Dynamic subtest C-HDMI-A1: SUCCESS (5.416s)
[659.590571] Starting dynamic subtest: A-HDMI-A2
[664.997768] Dynamic subtest A-HDMI-A2: SUCCESS (5.435s)
[665.030375] Starting dynamic subtest: B-HDMI-A2
[670.413957] Dynamic subtest B-HDMI-A2: SUCCESS (5.413s)
[670.446998] Starting dynamic subtest: C-HDMI-A2
[675.838132] Dynamic subtest C-HDMI-A2: SUCCESS (5.420s)
[675.840286] Subtest flip-vs-rmfb: SUCCESS (32.803s)
[676.370730] [148/154] (395s left) gem_exec_whisper (basic-contexts-all)
[676.497640] Starting subtest: basic-contexts-all
[683.255728] Subtest basic-contexts-all: SUCCESS (6.756s)
[683.518913] [149/154] (388s left) dmabuf_sync_file (export-basic)
[683.639126] Starting subtest: export-basic
[683.642352] Subtest export-basic: SUCCESS (0.004s)
[683.764054] [150/154] (388s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[683.959749] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[685.089382] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.130s)
[685.280271] [151/154] (386s left) gem_sync (basic-each)
[685.406605] Starting subtest: basic-each
[687.625552] Subtest basic-each: SUCCESS (2.223s)
[687.895956] [152/154] (384s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[688.067307] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[688.074961] Starting dynamic subtest: pipe-A-HDMI-A-1
[688.099009] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[688.132395] Starting dynamic subtest: pipe-A-HDMI-A-2
[688.177530] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[688.205907] Starting dynamic subtest: pipe-B-HDMI-A-1
[688.227768] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[688.255598] Starting dynamic subtest: pipe-B-HDMI-A-2
[688.277672] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[688.305739] Starting dynamic subtest: pipe-C-HDMI-A-1
[688.326701] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[688.354877] Starting dynamic subtest: pipe-C-HDMI-A-2
[688.375588] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[688.379414] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.032s)
[689.056668] [153/154] (383s left) syncobj_wait (multi-wait-for-submit-submitted)
[689.165147] Starting subtest: multi-wait-for-submit-submitted
[689.265018] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[689.418566] [154/154] (383s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[689.607587] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[689.611677] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[689.765656] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_pipe_b_c_ivb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_force_connector_basic
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: gem_ccs
results: parsing output: 7/ for test: kms_plane_alpha_blend
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: sysfs_heartbeat_interval
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: i915_pm_freq_mult
results: parsing output: 21/ for test: prime_busy
results: parsing output: 22/ for test: gem_exec_gttfill
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_ctx_param
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_lmem_swapping
results: parsing output: 27/ for test: gem_ctx_shared
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_bad_reloc
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: kms_content_protection
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_ctx_isolation
results: parsing output: 36/ for test: gem_flink_basic
results: parsing output: 37/ for test: gem_caching
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: kms_atomic_transition
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_basic
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_atomic_interruptible
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_pwrite_crc
results: parsing output: 62/ for test: gem_flink_basic
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_ctx_persistence
results: parsing output: 65/ for test: gen7_exec_parse
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: i915_drm_fdinfo
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_pipe_crc_basic
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_color_pipeline
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_draw_crc
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_chamelium_audio
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
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_sequence
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_busy
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: kms_force_connector_basic
results: parsing output: 113/ for test: kms_chamelium_edid
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: vgem_basic
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_flip_scaled_crc
results: parsing output: 127/ for test: gem_ctx_exec
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: gem_ppgtt
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: gem_softpin
results: parsing output: 133/ for test: gem_exec_capture
results: parsing output: 134/ for test: gem_tiled_blits
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_mmap_offset
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: i915_power
results: parsing output: 140/ for test: gem_exec_schedule
results: parsing output: 141/ for test: kms_cursor_legacy
results: parsing output: 142/ for test: i915_pm_rps
results: parsing output: 143/ for test: kms_psr
results: parsing output: 144/ for test: kms_setmode
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_flip
results: parsing output: 147/ for test: gem_exec_whisper
results: parsing output: 148/ for test: dmabuf_sync_file
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_sync
results: parsing output: 151/ for test: kms_ccs
results: parsing output: 152/ for test: syncobj_wait
results: parsing output: 153/ for test: kms_frontbuffer_tracking
Done.