[56.737097] Initializing watchdogs
[56.737150]   /dev/watchdog0
[56.752701] [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]
[56.757213] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.759528] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.762797] [001/155] (960s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[56.899686] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[56.903727] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[57.014824] [002/155] (960s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[57.074873] Starting subtest: etime-multi-wait-all-submitted-signaled
[57.180031] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[57.270422] [003/155] (960s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[57.324909] Starting subtest: multi-wait-all-available-submitted-signaled
[57.327584] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[57.421231] [004/155] (959s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt)
[57.519620] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt
[57.523850] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[57.619937] [005/155] (959s left) api_intel_bb (object-reloc-purge-cache)
[57.682775] Starting subtest: object-reloc-purge-cache
[57.687297] Subtest object-reloc-purge-cache: SKIP (0.003s)
[57.794661] [006/155] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt)
[57.889584] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt
[57.893958] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[57.981783] [007/155] (959s left) gem_mmap_offset (partial-unmap)
[58.034436] Starting subtest: partial-unmap
[58.036260] Starting dynamic subtest: smem0
[58.540944] Dynamic subtest smem0: SUCCESS (0.509s)
[58.543887] Subtest partial-unmap: SUCCESS (0.510s)
[58.643948] [008/155] (958s left) kms_chamelium_audio (hdmi-audio)
[59.018732] Subtest hdmi-audio: SKIP (0.000s)
[59.810433] [009/155] (957s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[59.915538] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[59.917970] Starting dynamic subtest: pipe-A-eDP-1
[66.740750] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.865s)
[66.753861] Starting dynamic subtest: pipe-B-eDP-1
[73.769907] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.041s)
[73.772390] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.908s)
[74.646517] [010/155] (942s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[74.754052] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[74.758325] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[74.849917] [011/155] (942s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[74.941936] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[74.944191] Starting dynamic subtest: pipe-A-eDP-1
[74.953265] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.962628] Starting dynamic subtest: pipe-B-eDP-1
[74.971423] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.979105] Starting dynamic subtest: pipe-C-eDP-1
[74.987194] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.994163] Starting dynamic subtest: pipe-D-eDP-1
[75.002144] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[75.006373] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[77.217190] [012/155] (940s left) perf_pmu (render-node-busy)
[77.283843] Starting subtest: render-node-busy
[77.286615] Starting dynamic subtest: rcs0
[77.882052] Dynamic subtest rcs0: SUCCESS (0.598s)
[77.892769] Starting dynamic subtest: bcs0
[78.444027] Dynamic subtest bcs0: SUCCESS (0.562s)
[78.455229] Starting dynamic subtest: vcs0
[80.352081] Dynamic subtest vcs0: SUCCESS (1.907s)
[80.363062] Starting dynamic subtest: vcs1
[82.336537] Dynamic subtest vcs1: SUCCESS (1.984s)
[82.347530] Starting dynamic subtest: vecs0
[84.322747] Dynamic subtest vecs0: SUCCESS (1.984s)
[84.333378] Starting dynamic subtest: ccs0
[84.882743] Dynamic subtest ccs0: SUCCESS (0.561s)
[84.885274] Subtest render-node-busy: SUCCESS (7.602s)
[84.955909] [013/155] (932s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[85.062267] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[85.066267] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[85.158909] [014/155] (932s left) kms_getfb (getfb2-into-addfb2)
[85.246728] Starting subtest: getfb2-into-addfb2
[85.249054] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[85.356323] [015/155] (932s left) gem_ctx_isolation (clean)
[85.418556] Starting subtest: clean
[85.420426] Starting dynamic subtest: rcs0
[85.477280] Dynamic subtest rcs0: SUCCESS (0.060s)
[85.485652] Starting dynamic subtest: bcs0
[85.545952] Dynamic subtest bcs0: SUCCESS (0.069s)
[85.554047] Starting dynamic subtest: vcs0
[85.611882] Dynamic subtest vcs0: SUCCESS (0.066s)
[85.622630] Starting dynamic subtest: vcs1
[87.328811] Dynamic subtest vcs1: SUCCESS (1.716s)
[87.338636] Starting dynamic subtest: vecs0
[89.338677] Dynamic subtest vecs0: SUCCESS (2.010s)
[89.347315] Starting dynamic subtest: ccs0
[91.322748] Dynamic subtest ccs0: SUCCESS (1.984s)
[91.325595] Subtest clean: SUCCESS (5.906s)
[91.566198] [016/155] (926s left) kms_psr (psr2-cursor-plane-onoff)
[91.659214] Starting subtest: psr2-cursor-plane-onoff
[91.661634] Starting dynamic subtest: eDP-1
[93.399786] Dynamic subtest eDP-1: SUCCESS (1.739s)
[93.402023] Subtest psr2-cursor-plane-onoff: SUCCESS (1.740s)
[94.296636] [017/155] (923s left) gem_exec_params (invalid-flag)
[94.347693] Starting subtest: invalid-flag
[94.350077] Subtest invalid-flag: SUCCESS (0.000s)
[94.445044] [018/155] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[94.545246] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[94.549952] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[94.671328] [019/155] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[94.767716] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[101.790507] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.027s)
[101.939609] [020/155] (916s left) gem_exec_balancer (hang)
[102.195913] Starting subtest: hang
[104.350717] Subtest hang: SUCCESS (2.155s)
[104.479902] [021/155] (913s left) kms_flip (wf_vblank-ts-check-interruptible)
[104.578619] Starting subtest: wf_vblank-ts-check-interruptible
[104.580871] Starting dynamic subtest: A-eDP1
[113.598962] Dynamic subtest A-eDP1: SUCCESS (8.986s)
[113.608166] Starting dynamic subtest: B-eDP1
[122.537597] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[122.546386] Starting dynamic subtest: C-eDP1
[131.470513] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[131.481538] Starting dynamic subtest: D-eDP1
[140.350670] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[140.356207] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.776s)
[141.581775] [022/155] (876s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[141.673396] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[141.677894] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[141.753933] [023/155] (876s left) syncobj_eventfd (invalid-bad-flags)
[141.813666] Starting subtest: invalid-bad-flags
[141.816868] Subtest invalid-bad-flags: SUCCESS (0.000s)
[141.906543] [024/155] (876s left) kms_prop_blob (blob-multiple)
[141.956704] Starting subtest: blob-multiple
[141.958562] Subtest blob-multiple: SUCCESS (0.003s)
[142.091896] [025/155] (876s left) perf (enable-disable)
[142.210255] Starting subtest: enable-disable
[142.212507] Starting dynamic subtest: 0-rcs0
[144.488361] Dynamic subtest 0-rcs0: SUCCESS (2.277s)
[144.499209] Starting dynamic subtest: 1-vecs0
[148.991694] Dynamic subtest 1-vecs0: SUCCESS (4.503s)
[148.993879] Subtest enable-disable: SUCCESS (6.780s)
[149.038762] [026/155] (869s left) kms_psr (fbc-psr-no-drrs)
[149.138984] Starting subtest: fbc-psr-no-drrs
[149.141337] Starting dynamic subtest: eDP-1
[149.145476] Dynamic subtest eDP-1: SKIP (0.000s)
[149.149715] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[149.206956] [027/155] (869s left) sw_sync (alloc_fence)
[149.244038] Starting subtest: alloc_fence
[149.246896] Subtest alloc_fence: SUCCESS (0.000s)
[149.297653] [028/155] (869s left) gem_readwrite (read-write)
[149.344570] Subtest read-write: SKIP (0.000s)
[149.398871] [029/155] (868s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[149.499995] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[149.504224] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[149.563201] [030/155] (868s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[149.657300] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[156.557918] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.904s)
[156.694694] [031/155] (861s left) kms_chamelium_hpd (hdmi-hpd-fast)
[157.079790] Subtest hdmi-hpd-fast: SKIP (0.000s)
[157.893566] [032/155] (860s left) i915_drm_fdinfo (virtual-busy-all)
[157.933767] Starting subtest: virtual-busy-all
[157.938096] Subtest virtual-busy-all: SKIP (0.000s)
[158.014493] [033/155] (860s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[158.107170] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[158.109412] Starting dynamic subtest: pipe-A-eDP-1
[158.167986] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[158.462262] Starting dynamic subtest: pipe-B-eDP-1
[159.325224] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.870s)
[159.623631] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.516s)
[160.470201] [034/155] (858s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[160.566328] Starting subtest: primary-yf-tiled-reflect-x-0
[160.626606] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[160.726501] [035/155] (857s left) kms_selftest (drm_dp_mst_helper)
[160.766790] Starting subtest: drm_dp_mst_helper
[160.792015] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[160.896326] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.103s)
[160.904608] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[160.999069] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.103s)
[161.007601] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[161.111071] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.111s)
[161.113328] Subtest drm_dp_mst_helper: SUCCESS (0.346s)
[161.259984] [036/155] (857s left) kms_cursor_crc (cursor-onscreen-128x42)
[161.471095] Starting subtest: cursor-onscreen-128x42
[161.516451] Subtest cursor-onscreen-128x42: SKIP (0.042s)
[161.712272] [037/155] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[161.805599] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[169.114308] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.313s)
[169.247761] [038/155] (849s left) gem_ctx_persistence (heartbeat-hang)
[169.305402] Starting subtest: heartbeat-hang
[169.309992] Subtest heartbeat-hang: SKIP (0.000s)
[169.408840] [039/155] (849s left) syncobj_timeline (invalid-query-bad-pad)
[169.457264] Starting subtest: invalid-query-bad-pad
[169.459449] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[169.549604] [040/155] (849s left) kms_flip (2x-wf_vblank-ts-check)
[169.639497] Starting subtest: 2x-wf_vblank-ts-check
[169.651775] Subtest 2x-wf_vblank-ts-check: SKIP (0.012s)
[169.751984] [041/155] (849s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[169.846381] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[177.623744] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.783s)
[177.723024] [042/155] (841s left) gem_spin_batch (resubmit-all)
[177.787511] Starting subtest: resubmit-all
[177.789689] Starting dynamic subtest: rcs0
[177.796189] Dynamic subtest rcs0: SUCCESS (0.012s)
[177.807088] Starting dynamic subtest: bcs0
[177.809316] Dynamic subtest bcs0: SUCCESS (0.002s)
[177.817805] Starting dynamic subtest: vcs0
[177.819632] Dynamic subtest vcs0: SUCCESS (0.002s)
[177.827725] Starting dynamic subtest: vcs1
[177.829625] Dynamic subtest vcs1: SUCCESS (0.002s)
[177.837578] Starting dynamic subtest: vecs0
[177.839491] Dynamic subtest vecs0: SUCCESS (0.002s)
[177.847340] Starting dynamic subtest: ccs0
[177.849225] Dynamic subtest ccs0: SUCCESS (0.002s)
[177.851106] Subtest resubmit-all: SUCCESS (0.025s)
[179.398283] [043/155] (839s left) kms_cursor_crc (cursor-random-256x85)
[179.668848] Starting subtest: cursor-random-256x85
[179.713688] Subtest cursor-random-256x85: SKIP (0.043s)
[179.891720] [044/155] (839s left) kms_big_fb (linear-16bpp-rotate-180)
[179.996580] Starting subtest: linear-16bpp-rotate-180
[181.420302] Subtest linear-16bpp-rotate-180: SUCCESS (1.425s)
[181.540039] [045/155] (837s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[181.629935] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[181.633796] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[181.702047] [046/155] (837s left) gem_exec_parallel (engines)
[181.757556] Starting subtest: engines
[181.759333] Starting dynamic subtest: basic
[183.329902] Dynamic subtest basic: SUCCESS (1.570s)
[183.341597] Starting dynamic subtest: contexts
[187.603290] Dynamic subtest contexts: SUCCESS (4.271s)
[187.613631] Starting dynamic subtest: fds
[191.444110] Dynamic subtest fds: SUCCESS (3.839s)
[191.456065] Starting dynamic subtest: userptr
[193.311655] Dynamic subtest userptr: SUCCESS (1.865s)
[193.314792] Subtest engines: SUCCESS (11.553s)
[193.501343] [047/155] (825s left) kms_pm_dc (dc3co-vpb-simulation)
[194.597585] Starting subtest: dc3co-vpb-simulation
[203.237776] Subtest dc3co-vpb-simulation: SKIP (8.586s)
[203.291547] [048/155] (815s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[203.389666] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[203.393776] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[203.485673] [049/155] (815s left) i915_pm_freq_api (freq-reset-multiple)
[203.535706] Starting subtest: freq-reset-multiple
[203.538139] Starting dynamic subtest: gt0
[213.312492] Dynamic subtest gt0: SUCCESS (9.774s)
[213.321387] Starting dynamic subtest: gt1
[221.845219] Dynamic subtest gt1: SUCCESS (8.532s)
[221.847860] Subtest freq-reset-multiple: SUCCESS (18.308s)
[221.938546] [050/155] (797s left) kms_legacy_colorkey (basic)
[222.041577] Starting subtest: basic
[222.043764] Starting dynamic subtest: pipe-A
[222.084936] Dynamic subtest pipe-A: SUCCESS (0.045s)
[222.097509] Starting dynamic subtest: pipe-B
[222.099534] Dynamic subtest pipe-B: SUCCESS (0.001s)
[222.108508] Starting dynamic subtest: pipe-C
[222.110709] Dynamic subtest pipe-C: SUCCESS (0.000s)
[222.119811] Starting dynamic subtest: pipe-D
[222.122099] Dynamic subtest pipe-D: SUCCESS (0.000s)
[222.124267] Subtest basic: SUCCESS (0.050s)
[222.165378] [051/155] (797s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[222.224403] Starting subtest: yf-tiled-ccs-to-y-tiled
[222.228713] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[222.402343] [052/155] (796s left) gem_exec_fence (invalid-fence-array)
[222.906965] Starting subtest: invalid-fence-array
[222.909403] Subtest invalid-fence-array: SUCCESS (0.002s)
[224.421343] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[224.424673] [053/155] (794s left) gen7_exec_parse (basic-offset)
[224.473486] Subtest basic-offset: SKIP (0.000s)
[224.546428] [054/155] (794s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[224.655769] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[224.665308] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[224.755307] [055/155] (794s left) kms_force_connector_basic (prune-stale-modes)
[224.837183] Starting subtest: prune-stale-modes
[225.278845] Subtest prune-stale-modes: SUCCESS (0.444s)
[225.417762] [056/155] (794s left) gem_mmap_wc (write)
[225.476134] Subtest write: SKIP (0.000s)
[225.537222] [057/155] (793s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[225.637446] Starting subtest: yf-tiled-8bpp-rotate-180
[225.640894] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[225.738162] [058/155] (793s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt)
[225.837114] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt
[225.840810] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[225.942038] [059/155] (793s left) gem_exec_parallel (fds)
[225.999228] Starting subtest: fds
[226.001243] Starting dynamic subtest: rcs0
[228.626404] Dynamic subtest rcs0: SUCCESS (2.624s)
[228.638187] Starting dynamic subtest: bcs0
[232.513229] Dynamic subtest bcs0: SUCCESS (3.885s)
[232.523626] Starting dynamic subtest: vcs0
[236.531805] Dynamic subtest vcs0: SUCCESS (4.018s)
[236.544751] Starting dynamic subtest: vcs1
[240.536123] Dynamic subtest vcs1: SUCCESS (4.002s)
[240.548306] Starting dynamic subtest: vecs0
[244.629662] Dynamic subtest vecs0: SUCCESS (4.092s)
[244.640207] Starting dynamic subtest: ccs0
[248.344225] Dynamic subtest ccs0: SUCCESS (3.714s)
[248.346914] Subtest fds: SUCCESS (22.345s)
[248.540655] [060/155] (771s left) gem_mmap_wc (fault-concurrent)
[248.590054] Subtest fault-concurrent: SKIP (0.000s)
[248.646964] [061/155] (770s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[248.763037] Starting subtest: x-tiled-32bpp-rotate-270
[248.784678] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[248.887920] [062/155] (770s left) prime_mmap (test_map_unmap)
[248.950570] Starting subtest: test_map_unmap
[248.952880] Starting dynamic subtest: test_map_unmap-smem
[248.981750] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[248.984139] Subtest test_map_unmap: SUCCESS (0.033s)
[249.107902] [063/155] (770s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[249.204940] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[249.207301] Starting dynamic subtest: pipe-A
[249.331616] Dynamic subtest pipe-A: SKIP (0.121s)
[249.342103] Starting dynamic subtest: pipe-B
[250.508791] Dynamic subtest pipe-B: SKIP (1.178s)
[250.522733] Starting dynamic subtest: pipe-C
[251.684331] Dynamic subtest pipe-C: SUCCESS (1.181s)
[251.694624] Starting dynamic subtest: pipe-D
[252.895278] Dynamic subtest pipe-D: SUCCESS (1.210s)
[252.897538] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.693s)
[254.044155] [064/155] (765s left) kms_invalid_mode (bad-vsync-end)
[254.141076] Starting subtest: bad-vsync-end
[254.143299] Starting dynamic subtest: pipe-A-eDP-1
[254.426634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[254.436924] Starting dynamic subtest: pipe-B-eDP-1
[254.439165] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[254.448232] Starting dynamic subtest: pipe-C-eDP-1
[254.450628] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[254.460524] Starting dynamic subtest: pipe-D-eDP-1
[254.462433] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[254.464288] Subtest bad-vsync-end: SUCCESS (0.294s)
[255.245742] [065/155] (764s left) gem_gpgpu_fill (offset-16x16)
[255.308062] Starting subtest: offset-16x16
[255.313926] Subtest offset-16x16: SUCCESS (0.007s)
[255.446480] [066/155] (764s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render)
[255.555963] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render
[255.560127] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[255.652641] [067/155] (764s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[255.737429] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[255.739806] Starting dynamic subtest: pipe-A-eDP-1
[255.899970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.153s)
[255.911409] Starting dynamic subtest: pipe-B-eDP-1
[255.932909] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[255.942416] Starting dynamic subtest: pipe-C-eDP-1
[255.961979] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[255.971432] Starting dynamic subtest: pipe-D-eDP-1
[255.990146] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[255.992194] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.190s)
[258.138405] [068/155] (761s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[258.242373] Starting subtest: psr-indfb-scaledprimary
[263.948402] Subtest psr-indfb-scaledprimary: SUCCESS (5.712s)
[264.073841] [069/155] (755s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[264.176613] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[264.180921] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[264.282447] [070/155] (755s left) gem_partial_pwrite_pread (write-snoop)
[264.348340] Subtest write-snoop: SKIP (0.000s)
[264.424360] [071/155] (755s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[264.528256] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[264.532229] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[264.627355] [072/155] (755s left) gem_exec_whisper (basic-contexts-forked)
[264.690240] Starting subtest: basic-contexts-forked
[289.551127] Subtest basic-contexts-forked: SUCCESS (24.808s)
[289.700562] [073/155] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[289.804176] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[289.808195] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[289.905608] [074/155] (730s left) i915_query (query-topology-kernel-writes)
[289.958885] Starting subtest: query-topology-kernel-writes
[289.961165] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[290.069899] [075/155] (730s left) gem_softpin (evict-snoop-interruptible)
[290.125843] Starting subtest: evict-snoop-interruptible
[290.130220] Subtest evict-snoop-interruptible: SKIP (0.000s)
[290.242932] [076/155] (730s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[290.355936] Starting subtest: y-tiled-8bpp-rotate-270
[290.360102] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[290.477923] [077/155] (729s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[290.584207] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[290.587731] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[290.678104] [078/155] (729s left) kms_rotation_crc (primary-rotation-270)
[290.772388] Starting subtest: primary-rotation-270
[290.775878] Subtest primary-rotation-270: SKIP (0.001s)
[290.844689] [079/155] (729s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-blt)
[290.950820] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-blt
[290.954161] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[291.043819] [080/155] (729s left) syncobj_basic (bad-flags-handle-to-fd)
[291.095116] Starting subtest: bad-flags-handle-to-fd
[291.096877] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[291.215195] [081/155] (729s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[291.318622] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc
[291.322087] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[291.411341] [082/155] (729s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[291.509621] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[291.513445] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[291.584881] [083/155] (729s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw)
[291.676060] Starting subtest: fbcpsrhdr-slowdraw
[291.679458] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s)
[291.777425] [084/155] (728s left) kms_vblank (invalid)
[291.867416] Starting subtest: invalid
[291.869104] Starting dynamic subtest: pipe-A-eDP-1
[292.268649] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[292.271031] Subtest invalid: SUCCESS (0.403s)
[293.139745] [085/155] (727s left) perf_pmu (invalid-init)
[293.176850] Starting subtest: invalid-init
[293.179908] Subtest invalid-init: SUCCESS (0.000s)
[293.298328] [086/155] (727s left) fbdev (read)
[293.342994] Starting subtest: read
[293.882366] Subtest read: SUCCESS (0.537s)
[293.944574] [087/155] (726s left) gem_render_tiled_blits (basic)
[294.007462] Subtest basic: SKIP (0.000s)
[294.074942] [088/155] (726s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[294.174702] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[294.177185] Starting dynamic subtest: pipe-A-eDP-1
[305.178568] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.009s)
[305.188876] Starting dynamic subtest: pipe-B-eDP-1
[316.913457] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.734s)
[316.915732] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.746s)
[317.735324] [089/155] (703s left) gen7_exec_parse (cmd-crossing-page)
[317.804168] Subtest cmd-crossing-page: SKIP (0.000s)
[317.870247] [090/155] (703s left) kms_addfb_basic (bad-pitch-128)
[317.923435] Starting subtest: bad-pitch-128
[317.925316] Subtest bad-pitch-128: SUCCESS (0.000s)
[318.073752] [091/155] (702s left) gem_userptr_blits (dmabuf-unsync)
[318.135728] Subtest dmabuf-unsync: SKIP (0.000s)
[318.244015] [092/155] (702s left) gem_set_tiling_vs_gtt
[318.364881] [093/155] (702s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[318.470487] Starting subtest: stress-xrgb8888-yftiled
[318.474792] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[318.545614] [094/155] (702s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[318.668063] Starting subtest: 2x-flip-vs-cursor-atomic
[318.671818] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[318.811318] [095/155] (702s left) kms_async_flips (async-flip-dpms)
[318.911275] Starting subtest: async-flip-dpms
[319.296612] Starting dynamic subtest: pipe-A-eDP-1
[323.175880] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.880s)
[323.571011] Starting dynamic subtest: pipe-B-eDP-1
[326.476686] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.914s)
[326.881707] Starting dynamic subtest: pipe-C-eDP-1
[329.781716] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.906s)
[330.157228] Starting dynamic subtest: pipe-D-eDP-1
[333.090028] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.939s)
[333.092302] Subtest async-flip-dpms: SUCCESS (14.177s)
[334.344202] [096/155] (686s left) gem_mmap_gtt (fault-concurrent-x)
[334.401655] Subtest fault-concurrent-X: SKIP (0.000s)
[334.457600] [097/155] (686s left) i915_pm_rpm (sysfs-read)
[336.483739] Starting subtest: sysfs-read
[337.630097] Subtest sysfs-read: SUCCESS (1.146s)
[338.011557] [098/155] (683s left) sw_sync (sync_multi_producer_single_consumer)
[338.046057] Starting subtest: sync_multi_producer_single_consumer
[339.122527] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[339.186897] [099/155] (682s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[339.295922] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[339.300214] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[339.390314] [100/155] (681s left) kms_hdmi_inject (inject-4k)
[339.744251] Starting subtest: inject-4k
[340.089622] Subtest inject-4k: SUCCESS (0.348s)
[340.662859] [101/155] (680s left) gem_ctx_shared (exec-single-timeline)
[340.716405] Starting subtest: exec-single-timeline
[340.718868] Starting dynamic subtest: rcs0
[341.756043] Dynamic subtest rcs0: SUCCESS (1.038s)
[341.769632] Starting dynamic subtest: bcs0
[342.844491] Dynamic subtest bcs0: SUCCESS (1.085s)
[342.857803] Starting dynamic subtest: vcs0
[343.932500] Dynamic subtest vcs0: SUCCESS (1.085s)
[343.947235] Starting dynamic subtest: vcs1
[345.022455] Dynamic subtest vcs1: SUCCESS (1.087s)
[345.035620] Starting dynamic subtest: vecs0
[346.109609] Dynamic subtest vecs0: SUCCESS (1.085s)
[346.121072] Starting dynamic subtest: ccs0
[347.197877] Dynamic subtest ccs0: SUCCESS (1.085s)
[347.201072] Subtest exec-single-timeline: SUCCESS (6.481s)
[347.390842] [102/155] (674s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[347.495064] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[351.740041] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.250s)
[352.944398] [103/155] (668s left) api_intel_allocator (simple-allocator)
[353.010628] Starting subtest: simple-allocator
[353.013138] Starting dynamic subtest: basic
[353.015543] Dynamic subtest basic: SUCCESS (0.003s)
[353.030446] Starting dynamic subtest: parallel-one
[353.182933] Dynamic subtest parallel-one: SUCCESS (0.170s)
[353.193264] Starting dynamic subtest: print
[353.195573] Dynamic subtest print: SUCCESS (0.000s)
[353.206109] Starting dynamic subtest: reuse
[353.208390] Dynamic subtest reuse: SUCCESS (0.000s)
[353.217681] Starting dynamic subtest: reserve
[353.219944] Dynamic subtest reserve: SUCCESS (0.000s)
[353.229270] Starting dynamic subtest: fork-reopen-allocator
[353.231504] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[353.233824] Subtest simple-allocator: SUCCESS (0.192s)
[353.342825] [104/155] (668s left) kms_vblank (ts-continuation-modeset-hang)
[353.431302] Starting subtest: ts-continuation-modeset-hang
[353.433469] Starting dynamic subtest: pipe-A-eDP-1
[380.074335] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.642s)
[380.089080] Starting dynamic subtest: pipe-D-eDP-1
[395.169945] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.092s)
[395.171788] Subtest ts-continuation-modeset-hang: SUCCESS (41.738s)
[396.025546] [105/155] (625s left) kms_cursor_edge_walk (128x128-left-edge)
[396.114223] Starting subtest: 128x128-left-edge
[396.116453] Starting dynamic subtest: pipe-A-eDP-1
[399.546135] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.433s)
[399.556727] Starting dynamic subtest: pipe-D-eDP-1
[402.760209] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.213s)
[402.762391] Subtest 128x128-left-edge: SUCCESS (6.649s)
[403.635056] [106/155] (617s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[403.735644] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[407.964475] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.234s)
[409.135274] [107/155] (612s left) syncobj_timeline (wait-all-snapshot)
[409.188110] Starting subtest: wait-all-snapshot
[409.269798] Subtest wait-all-snapshot: SUCCESS (0.082s)
[409.360421] [108/155] (612s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[409.483930] Starting subtest: cursorB-vs-flipB-toggle
[409.488299] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[409.625343] [109/155] (612s left) gem_mmap_wc (write-wc-read-gtt)
[409.684770] Subtest write-wc-read-gtt: SKIP (0.000s)
[409.750737] [110/155] (611s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render)
[409.844211] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render
[409.848332] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[409.949353] [111/155] (611s left) kms_content_protection (uevent-hdcp14)
[410.090605] Starting subtest: uevent-hdcp14
[410.094559] Subtest uevent-hdcp14: SKIP (0.000s)
[410.199391] [112/155] (611s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[410.305233] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite
[410.308606] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[410.423360] [113/155] (611s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[410.545854] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[410.549586] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[410.691771] [114/155] (611s left) kms_feature_discovery (psr2)
[410.779364] Starting subtest: psr2
[410.781089] Subtest psr2: SUCCESS (0.000s)
[410.851169] [115/155] (611s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[410.938179] Starting subtest: crc-primary-basic-y-tiled-ccs
[410.940081] Starting dynamic subtest: pipe-A-eDP-1
[410.959079] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[410.969120] Starting dynamic subtest: pipe-B-eDP-1
[410.987184] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[410.996937] Starting dynamic subtest: pipe-C-eDP-1
[411.014995] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[411.025562] Starting dynamic subtest: pipe-D-eDP-1
[411.043963] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[411.047365] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[413.230399] [116/155] (608s left) prime_self_import (basic-llseek-size)
[413.269035] Starting subtest: basic-llseek-size
[413.294830] Subtest basic-llseek-size: SUCCESS (0.027s)
[413.413670] [117/155] (608s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[413.504101] Starting subtest: plane-ctm3x4-lut1d
[413.639207] Starting dynamic subtest: pipe-A-plane-0
[413.816574] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[413.828078] Starting dynamic subtest: pipe-A-plane-1
[414.016316] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s)
[414.026380] Starting dynamic subtest: pipe-A-plane-2
[414.174665] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[415.436348] Starting dynamic subtest: pipe-B-plane-0
[415.583193] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[415.593760] Starting dynamic subtest: pipe-B-plane-1
[415.727960] Dynamic subtest pipe-B-plane-1: SUCCESS (0.143s)
[415.740767] Starting dynamic subtest: pipe-B-plane-2
[415.894292] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[417.100932] Starting dynamic subtest: pipe-C-plane-0
[417.226130] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[417.237416] Starting dynamic subtest: pipe-C-plane-1
[417.369802] Dynamic subtest pipe-C-plane-1: SUCCESS (0.142s)
[417.380173] Starting dynamic subtest: pipe-C-plane-2
[417.514542] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[418.690049] Starting dynamic subtest: pipe-D-plane-0
[418.837998] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[418.849024] Starting dynamic subtest: pipe-D-plane-1
[419.005472] Dynamic subtest pipe-D-plane-1: SUCCESS (0.165s)
[419.015537] Starting dynamic subtest: pipe-D-plane-2
[419.170231] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[419.466626] Subtest plane-ctm3x4-lut1d: SUCCESS (5.964s)
[420.319623] [118/155] (601s left) perf (blocking-parameterized)
[420.424131] Starting subtest: blocking-parameterized
[440.490438] Subtest blocking-parameterized: SUCCESS (20.015s)
[440.536529] [119/155] (581s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[440.637240] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[440.641285] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[440.747508] [120/155] (581s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[440.845803] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[447.589151] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.749s)
[447.729905] [121/155] (574s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[447.835083] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[447.837332] Starting dynamic subtest: pipe-A-eDP-1
[447.861721] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[447.873086] Starting dynamic subtest: pipe-B-eDP-1
[447.896115] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[447.905509] Starting dynamic subtest: pipe-C-eDP-1
[447.929087] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[447.938698] Starting dynamic subtest: pipe-D-eDP-1
[447.962714] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[447.966816] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[450.127453] [122/155] (572s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[450.227997] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[450.230290] Starting dynamic subtest: A-eDP1
[453.861375] Dynamic subtest A-eDP1: SUCCESS (3.632s)
[453.872184] Starting dynamic subtest: B-eDP1
[457.145156] Dynamic subtest B-eDP1: SUCCESS (3.286s)
[457.157434] Starting dynamic subtest: C-eDP1
[460.442495] Dynamic subtest C-eDP1: SUCCESS (3.292s)
[460.453147] Starting dynamic subtest: D-eDP1
[463.757740] Dynamic subtest D-eDP1: SUCCESS (3.317s)
[463.759906] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.536s)
[464.616305] [123/155] (557s left) kms_chamelium_edid (dp-mode-timings)
[465.000939] Subtest dp-mode-timings: SKIP (0.000s)
[465.794420] [124/155] (556s left) kms_pm_dc (dc6-dpms)
[466.886375] Starting subtest: dc6-dpms
[468.964895] Subtest dc6-dpms: SUCCESS (2.078s)
[469.060079] [125/155] (553s left) gem_ctx_bad_destroy (double-destroy)
[469.110849] Starting subtest: double-destroy
[469.113176] Subtest double-destroy: SUCCESS (0.000s)
[469.200348] [126/155] (553s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-fullscreen)
[469.302141] Starting subtest: fbchdr-1p-primscrn-spr-indfb-fullscreen
[469.306310] Subtest fbchdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[469.403647] [127/155] (553s left) kms_flip (2x-flip-vs-panning-vs-hang)
[469.494296] Starting subtest: 2x-flip-vs-panning-vs-hang
[469.499579] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[469.617436] [128/155] (552s left) gem_exec_nop (basic-series)
[469.689804] Starting subtest: basic-series
[486.308033] Subtest basic-series: SUCCESS (16.624s)
[486.539848] [129/155] (536s left) kms_getfb (getfb-handle-zero)
[486.636962] Starting subtest: getfb-handle-zero
[486.639305] Subtest getfb-handle-zero: SUCCESS (0.000s)
[486.757108] [130/155] (535s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[486.868096] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[486.872514] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[486.963783] [131/155] (535s left) syncobj_wait (multi-wait-all-signaled)
[487.016832] Starting subtest: multi-wait-all-signaled
[487.019476] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[487.121460] [132/155] (535s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[487.177716] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[487.182438] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[487.361398] [133/155] (535s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[487.467370] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[487.472055] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[487.573880] [134/155] (535s left) gem_exec_schedule (semaphore-power)
[487.753926] Subtest semaphore-power: SKIP (0.000s)
[487.942608] [135/155] (534s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[488.037075] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[488.041152] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[488.136929] [136/155] (534s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[488.223173] Starting subtest: pixel-format-y-tiled-ccs-modifier
[488.227197] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[488.305445] [137/155] (534s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[488.404869] Starting subtest: yf-tiled-32bpp-rotate-0
[488.409362] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[488.507310] [138/155] (534s left) device_reset (cold-reset-bound)
[488.554439] Starting subtest: cold-reset-bound
[488.558802] Subtest cold-reset-bound: SKIP (0.000s)
[488.641270] [139/155] (534s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[488.690512] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[488.692499] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[488.786429] [140/155] (534s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[488.885439] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[489.942808] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.057s)
[490.065599] [141/155] (532s left) i915_suspend (fence-restore-untiled)
[490.120147] Starting subtest: fence-restore-untiled
[490.123898] Subtest fence-restore-untiled: SKIP (0.000s)
[490.221128] [142/155] (532s left) gem_create (hog-create)
[490.274214] Starting subtest: hog-create
[490.276078] Starting dynamic subtest: smem0
[524.268615] Dynamic subtest smem0: SUCCESS (33.992s)
[524.271491] Subtest hog-create: SUCCESS (33.994s)
[524.458443] [143/155] (498s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[524.567149] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[524.571392] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[524.676292] [144/155] (498s left) kms_psr (fbc-pr-sprite-plane-move)
[524.764390] Starting subtest: fbc-pr-sprite-plane-move
[524.768438] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[524.839872] [145/155] (498s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[524.946182] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[524.950315] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[525.044159] [146/155] (498s left) kms_atomic (plane-immutable-zpos)
[525.136402] Starting subtest: plane-immutable-zpos
[525.138714] Starting dynamic subtest: pipe-A-eDP-1
[525.787318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.652s)
[525.789744] Subtest plane-immutable-zpos: SUCCESS (0.653s)
[526.605817] [147/155] (496s left) kms_psr (psr-cursor-plane-onoff)
[526.697757] Starting subtest: psr-cursor-plane-onoff
[526.699947] Starting dynamic subtest: eDP-1
[528.476752] Dynamic subtest eDP-1: SUCCESS (1.779s)
[528.479551] Subtest psr-cursor-plane-onoff: SUCCESS (1.780s)
[529.320804] [148/155] (494s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[529.425186] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[529.429110] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[529.517278] [149/155] (493s left) syncobj_wait (invalid-signal-illegal-handle)
[529.564948] Starting subtest: invalid-signal-illegal-handle
[529.567157] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[529.680261] [150/155] (493s left) gem_exec_schedule (pi-ringfull)
[529.867547] Starting subtest: pi-ringfull
[529.869989] Starting dynamic subtest: rcs0
[529.904241] Dynamic subtest rcs0: SUCCESS (0.041s)
[529.914274] Starting dynamic subtest: bcs0
[529.952649] Dynamic subtest bcs0: SUCCESS (0.047s)
[529.963233] Starting dynamic subtest: vcs0
[529.990397] Dynamic subtest vcs0: SUCCESS (0.037s)
[530.000196] Starting dynamic subtest: vcs1
[530.026443] Dynamic subtest vcs1: SUCCESS (0.035s)
[530.039632] Starting dynamic subtest: vecs0
[530.060059] Dynamic subtest vecs0: SUCCESS (0.033s)
[530.073075] Starting dynamic subtest: ccs0
[530.091879] Dynamic subtest ccs0: SUCCESS (0.031s)
[530.094117] Subtest pi-ringfull: SUCCESS (0.230s)
[530.333125] [151/155] (493s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[530.434877] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[530.439316] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[530.531928] [152/155] (492s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[530.632699] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[537.382668] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.754s)
[537.520179] [153/155] (486s left) gem_exec_fence (keep-in-fence)
[537.698081] Starting subtest: keep-in-fence
[537.700270] Starting dynamic subtest: rcs0
[537.756803] Dynamic subtest rcs0: SUCCESS (0.062s)
[537.768776] Starting dynamic subtest: bcs0
[537.813507] Dynamic subtest bcs0: SUCCESS (0.055s)
[537.825775] Starting dynamic subtest: vcs0
[539.361102] Dynamic subtest vcs0: SUCCESS (1.543s)
[539.373973] Starting dynamic subtest: vcs1
[541.344263] Dynamic subtest vcs1: SUCCESS (1.981s)
[541.357670] Starting dynamic subtest: vecs0
[543.382193] Dynamic subtest vecs0: SUCCESS (1.981s)
[543.395257] Starting dynamic subtest: ccs0
[543.559863] Dynamic subtest ccs0: SUCCESS (0.230s)
[543.562917] Subtest keep-in-fence: SUCCESS (5.866s)
[545.388269] [154/155] (478s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[545.487800] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[545.489982] Starting dynamic subtest: pipe-A-default-mode
[546.636860] Dynamic subtest pipe-A-default-mode: SKIP (1.148s)
[546.641380] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.149s)
[546.800347] [155/155] (476s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[546.907243] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[546.911399] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[547.006965] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_mmap_offset
results: parsing output: 7/ for test: kms_chamelium_audio
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: gem_ctx_isolation
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_eventfd
results: parsing output: 23/ for test: kms_prop_blob
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: gem_readwrite
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: i915_drm_fdinfo
results: parsing output: 32/ for test: kms_atomic_transition
results: parsing output: 33/ for test: kms_rotation_crc
results: parsing output: 34/ for test: kms_selftest
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_spin_batch
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: gem_exec_parallel
results: parsing output: 46/ for test: kms_pm_dc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: i915_pm_freq_api
results: parsing output: 49/ for test: kms_legacy_colorkey
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: gen7_exec_parse
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_force_connector_basic
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: gem_mmap_wc
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: prime_mmap
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: kms_invalid_mode
results: parsing output: 64/ for test: gem_gpgpu_fill
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_partial_pwrite_pread
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_whisper
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_vblank
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: fbdev
results: parsing output: 86/ for test: gem_render_tiled_blits
results: parsing output: 87/ for test: kms_psr2_sf
results: parsing output: 88/ for test: gen7_exec_parse
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: gem_set_tiling_vs_gtt
results: parsing output: 92/ for test: kms_pipe_stress
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: i915_pm_rpm
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_hdmi_inject
results: parsing output: 100/ for test: gem_ctx_shared
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: api_intel_allocator
results: parsing output: 103/ for test: kms_vblank
results: parsing output: 104/ for test: kms_cursor_edge_walk
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_content_protection
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: kms_feature_discovery
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: prime_self_import
results: parsing output: 116/ for test: kms_color_pipeline
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_chamelium_edid
results: parsing output: 123/ for test: kms_pm_dc
results: parsing output: 124/ for test: gem_ctx_bad_destroy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: gem_exec_nop
results: parsing output: 128/ for test: kms_getfb
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: gem_render_copy
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_exec_schedule
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_plane
results: parsing output: 136/ for test: kms_big_fb
results: parsing output: 137/ for test: device_reset
results: parsing output: 138/ for test: syncobj_timeline
results: parsing output: 139/ for test: kms_big_fb
results: parsing output: 140/ for test: i915_suspend
results: parsing output: 141/ for test: gem_create
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_psr
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_atomic
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: syncobj_wait
results: parsing output: 149/ for test: gem_exec_schedule
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_exec_fence
results: parsing output: 153/ for test: kms_flip_scaled_crc
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.