[56.182752] Initializing watchdogs
[56.182801]   /dev/watchdog0
[56.198315] [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.203306] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.205560] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.209013] [001/155] (960s left) syncobj_timeline (single-wait-all-available-signaled)
[56.282876] Starting subtest: single-wait-all-available-signaled
[56.285084] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[56.386862] [002/155] (960s left) gem_exec_params (dr1-dirt)
[56.454721] Starting subtest: DR1-dirt
[56.457171] Subtest DR1-dirt: SUCCESS (0.000s)
[56.574042] [003/155] (960s left) gem_ctx_param (root-set)
[56.624299] Starting subtest: root-set
[56.628920] Subtest root-set: SUCCESS (0.003s)
[56.721553] [004/155] (960s left) gen9_exec_parse (allowed-single)
[56.777719] Subtest allowed-single: SKIP (0.000s)
[56.846733] [005/155] (960s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-msflip-blt)
[56.948589] Starting subtest: fbchdr-2p-primscrn-shrfb-msflip-blt
[56.952518] Subtest fbchdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[57.048115] [006/155] (959s left) kms_addfb_basic (basic-y-tiled-legacy)
[57.101426] Starting subtest: basic-y-tiled-legacy
[57.105772] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[57.235626] [007/155] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[57.332830] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[57.336495] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[57.422879] [008/155] (959s left) perf_pmu (init-sema)
[57.461235] Starting subtest: init-sema
[57.463068] Starting dynamic subtest: rcs0
[57.464937] Dynamic subtest rcs0: SUCCESS (0.002s)
[57.473425] Starting dynamic subtest: bcs0
[57.475021] Dynamic subtest bcs0: SUCCESS (0.000s)
[57.481835] Starting dynamic subtest: vcs0
[57.483369] Dynamic subtest vcs0: SUCCESS (0.001s)
[57.489997] Starting dynamic subtest: vcs1
[57.491600] Dynamic subtest vcs1: SUCCESS (0.001s)
[57.498240] Starting dynamic subtest: vecs0
[57.499761] Dynamic subtest vecs0: SUCCESS (0.001s)
[57.507768] Starting dynamic subtest: ccs0
[57.509327] Dynamic subtest ccs0: SUCCESS (0.000s)
[57.510874] Subtest init-sema: SUCCESS (0.006s)
[57.568693] [009/155] (959s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[57.668269] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[57.671635] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[57.752410] [010/155] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[57.853162] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[57.856652] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.938815] [011/155] (959s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[58.039678] Starting subtest: fbc-pr-cursor-plane-update-sf
[58.043178] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[58.105194] [012/155] (959s left) gem_pread (display)
[58.152835] Subtest display: SKIP (0.000s)
[58.206416] [013/155] (958s left) i915_drm_fdinfo (busy-idle)
[58.245278] Starting subtest: busy-idle
[58.247320] Starting dynamic subtest: rcs0
[58.279258] Dynamic subtest rcs0: SKIP (0.033s)
[58.290481] Starting dynamic subtest: bcs0
[58.294146] Dynamic subtest bcs0: SKIP (0.001s)
[58.301992] Starting dynamic subtest: vcs0
[58.305389] Dynamic subtest vcs0: SKIP (0.000s)
[58.312435] Starting dynamic subtest: vcs1
[58.315950] Dynamic subtest vcs1: SKIP (0.000s)
[58.322760] Starting dynamic subtest: vecs0
[58.326341] Dynamic subtest vecs0: SKIP (0.000s)
[58.333110] Starting dynamic subtest: ccs0
[58.336663] Dynamic subtest ccs0: SKIP (0.000s)
[58.340184] Subtest busy-idle: SKIP (0.037s)
[58.377736] [014/155] (958s left) kms_pipe_crc_basic (hang-read-crc)
[58.467758] Starting subtest: hang-read-crc
[58.470390] Starting dynamic subtest: pipe-A-eDP-1
[60.560263] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.123s)
[60.570152] Starting dynamic subtest: pipe-B-eDP-1
[63.326542] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.794s)
[63.335208] Starting dynamic subtest: pipe-C-eDP-1
[66.022844] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.713s)
[66.032580] Starting dynamic subtest: pipe-D-eDP-1
[68.682857] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.671s)
[68.684696] Subtest hang-read-crc: SUCCESS (10.305s)
[69.502193] [015/155] (947s left) kms_psr (psr2-sprite-render)
[69.591970] Starting subtest: psr2-sprite-render
[69.594602] Starting dynamic subtest: eDP-1
[71.309667] Dynamic subtest eDP-1: SUCCESS (1.724s)
[71.312010] Subtest psr2-sprite-render: SUCCESS (1.725s)
[72.167245] [016/155] (945s left) kms_chamelium_frames (hdmi-crc-fast)
[72.622483] Subtest hdmi-crc-fast: SKIP (0.000s)
[73.475842] [017/155] (943s left) kms_atomic (crtc-invalid-params)
[73.673039] Starting subtest: crtc-invalid-params
[73.675603] Starting dynamic subtest: pipe-A-eDP-1
[74.055772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.384s)
[74.057929] Subtest crtc-invalid-params: SUCCESS (0.385s)
[74.922973] [018/155] (942s left) kms_content_protection (mei-interface)
[75.073190] Starting subtest: mei-interface
[75.077799] Subtest mei-interface: SKIP (0.001s)
[75.219942] [019/155] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[75.326646] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[81.892151] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.579s)
[82.016142] [020/155] (935s left) fbdev (info)
[82.055411] Starting subtest: info
[82.057842] Subtest info: SUCCESS (0.000s)
[82.111647] [021/155] (935s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[82.206772] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[82.211250] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[82.305871] [022/155] (935s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[82.358553] Subtest writes-after-reads: SKIP (0.000s)
[82.426886] [023/155] (935s left) kms_atomic_transition (plane-toggle-modeset-transition)
[82.510851] Starting subtest: plane-toggle-modeset-transition
[82.513127] Starting dynamic subtest: pipe-A-eDP-1
[95.304691] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.792s)
[95.318595] Starting dynamic subtest: pipe-B-eDP-1
[107.784689] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.478s)
[107.787226] Subtest plane-toggle-modeset-transition: SUCCESS (25.275s)
[108.599789] [024/155] (909s left) gem_ctx_persistence (engines-hang)
[108.657812] Starting subtest: engines-hang
[108.660131] Starting dynamic subtest: rcs0
[108.780645] Dynamic subtest rcs0: SUCCESS (0.125s)
[108.791953] Starting dynamic subtest: bcs0
[108.873305] Dynamic subtest bcs0: SUCCESS (0.091s)
[108.884290] Starting dynamic subtest: vcs0
[108.972969] Dynamic subtest vcs0: SUCCESS (0.099s)
[108.983636] Starting dynamic subtest: vcs1
[109.075791] Dynamic subtest vcs1: SUCCESS (0.102s)
[109.085992] Starting dynamic subtest: vecs0
[109.155590] Dynamic subtest vecs0: SUCCESS (0.079s)
[109.165079] Starting dynamic subtest: ccs0
[109.285054] Dynamic subtest ccs0: SUCCESS (0.128s)
[109.287852] Subtest engines-hang: SUCCESS (0.630s)
[109.375905] [025/155] (908s left) perf (invalid-open-flags)
[109.508423] Starting subtest: invalid-open-flags
[109.510820] Subtest invalid-open-flags: SUCCESS (0.000s)
[109.554815] [026/155] (908s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[109.658981] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[110.737813] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.080s)
[110.849618] [027/155] (906s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[110.957944] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[110.962076] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[111.062764] [028/155] (906s left) gem_fence_thrash (bo-write-verify-x)
[111.098367] Starting subtest: bo-write-verify-x
[111.119296] Subtest bo-write-verify-x: SKIP (0.021s)
[111.175380] [029/155] (906s left) gem_gpgpu_fill (offset-16x16)
[111.229508] Starting subtest: offset-16x16
[111.234473] Subtest offset-16x16: SUCCESS (0.006s)
[111.364682] [030/155] (906s left) perf_pmu (busy-idle)
[111.402923] Starting subtest: busy-idle
[111.404693] Starting dynamic subtest: rcs0
[112.088558] Dynamic subtest rcs0: SUCCESS (0.686s)
[112.098549] Starting dynamic subtest: bcs0
[112.755917] Dynamic subtest bcs0: SUCCESS (0.667s)
[112.768515] Starting dynamic subtest: vcs0
[114.337972] Dynamic subtest vcs0: SUCCESS (1.579s)
[114.349186] Starting dynamic subtest: vcs1
[116.321402] Dynamic subtest vcs1: SUCCESS (1.982s)
[116.331708] Starting dynamic subtest: vecs0
[118.305346] Dynamic subtest vecs0: SUCCESS (1.982s)
[118.315328] Starting dynamic subtest: ccs0
[118.971756] Dynamic subtest ccs0: SUCCESS (0.666s)
[118.974479] Subtest busy-idle: SUCCESS (7.571s)
[119.076913] [031/155] (898s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[119.168162] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[119.170392] Starting dynamic subtest: pipe-A-eDP-1
[119.190849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[119.201629] Starting dynamic subtest: pipe-B-eDP-1
[119.220924] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[119.229599] Starting dynamic subtest: pipe-C-eDP-1
[119.249085] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[119.257573] Starting dynamic subtest: pipe-D-eDP-1
[119.277168] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[119.279382] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[121.482246] [032/155] (896s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[121.595023] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[121.637724] [033/155] (896s left) gem_ctx_sseu (invalid-args)
[121.696632] Subtest invalid-args: SKIP (0.000s)
[121.760255] [034/155] (896s left) gem_ctx_param (invalid-param-get)
[121.818854] Starting subtest: invalid-param-get
[121.821431] Subtest invalid-param-get: SUCCESS (0.001s)
[121.929271] [035/155] (896s left) kms_big_fb (linear-64bpp-rotate-0)
[122.028415] Starting subtest: linear-64bpp-rotate-0
[123.730654] Subtest linear-64bpp-rotate-0: SUCCESS (1.702s)
[123.906538] [036/155] (894s left) i915_hangman (gt-error-state-capture)
[123.963893] Starting subtest: gt-error-state-capture
[123.966357] Starting dynamic subtest: rcs0
[135.295874] Dynamic subtest rcs0: SUCCESS (11.331s)
[135.310224] Starting dynamic subtest: bcs0
[146.305624] Dynamic subtest bcs0: SUCCESS (11.008s)
[146.317803] Starting dynamic subtest: vcs0
[158.275966] Dynamic subtest vcs0: SUCCESS (11.968s)
[158.288076] Starting dynamic subtest: vcs1
[169.279963] Dynamic subtest vcs1: SUCCESS (11.001s)
[169.293243] Starting dynamic subtest: vecs0
[179.264770] Dynamic subtest vecs0: SUCCESS (9.983s)
[179.276654] Starting dynamic subtest: ccs0
[190.272789] Dynamic subtest ccs0: SUCCESS (11.005s)
[190.275967] Subtest gt-error-state-capture: SUCCESS (66.306s)
[190.353325] [037/155] (827s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[190.454948] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[190.459203] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[190.555225] [038/155] (827s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[190.651960] Starting subtest: crc-primary-basic-yf-tiled-ccs
[190.654281] Starting dynamic subtest: pipe-A-eDP-1
[190.678182] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[190.689852] Starting dynamic subtest: pipe-B-eDP-1
[190.711504] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[190.721507] Starting dynamic subtest: pipe-C-eDP-1
[190.743691] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[190.753845] Starting dynamic subtest: pipe-D-eDP-1
[190.776030] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[190.780102] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[192.933505] [039/155] (825s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[192.988784] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[193.094428] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[193.170281] [040/155] (825s left) gem_exec_schedule (u-lateslice)
[193.243078] Starting subtest: u-lateslice
[193.245096] Starting dynamic subtest: rcs0
[193.254153] Dynamic subtest rcs0: SUCCESS (0.021s)
[193.264867] Starting dynamic subtest: bcs0
[193.272191] Dynamic subtest bcs0: SUCCESS (0.017s)
[193.282963] Starting dynamic subtest: vcs0
[193.290617] Dynamic subtest vcs0: SUCCESS (0.018s)
[193.299946] Starting dynamic subtest: vcs1
[193.310655] Dynamic subtest vcs1: SUCCESS (0.020s)
[193.319763] Starting dynamic subtest: vecs0
[193.328585] Dynamic subtest vecs0: SUCCESS (0.017s)
[193.337706] Starting dynamic subtest: ccs0
[193.347070] Dynamic subtest ccs0: SUCCESS (0.018s)
[193.349273] Subtest u-lateslice: SUCCESS (0.114s)
[195.373428] [041/155] (822s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[195.473923] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[195.476234] Starting dynamic subtest: pipe-A-default-mode
[196.672417] Dynamic subtest pipe-A-default-mode: SKIP (1.195s)
[196.676766] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.198s)
[196.828019] [042/155] (821s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[196.913971] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[196.918391] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[196.986898] [043/155] (821s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[197.088691] Starting subtest: fbchdr-farfromfence-mmap-gtt
[197.093060] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[197.185774] [044/155] (821s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[197.283508] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[197.287557] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[197.365239] [045/155] (821s left) kms_cursor_edge_walk (256x256-left-edge)
[197.458262] Starting subtest: 256x256-left-edge
[197.460537] Starting dynamic subtest: pipe-A-eDP-1
[200.906974] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.450s)
[200.919395] Starting dynamic subtest: pipe-D-eDP-1
[204.046540] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s)
[204.048787] Subtest 256x256-left-edge: SUCCESS (6.589s)
[204.855604] [046/155] (813s left) gem_exec_schedule (fifo)
[204.925951] Starting subtest: fifo
[204.928244] Starting dynamic subtest: rcs0
[205.016597] Dynamic subtest rcs0: SUCCESS (0.100s)
[205.032235] Starting dynamic subtest: vcs0
[205.102308] Dynamic subtest vcs0: SUCCESS (0.085s)
[205.115122] Starting dynamic subtest: vcs1
[205.179329] Dynamic subtest vcs1: SUCCESS (0.076s)
[205.196507] Starting dynamic subtest: vecs0
[205.255680] Dynamic subtest vecs0: SUCCESS (0.076s)
[205.268574] Starting dynamic subtest: ccs0
[205.344440] Dynamic subtest ccs0: SUCCESS (0.088s)
[205.347091] Subtest fifo: SUCCESS (0.428s)
[206.419586] [047/155] (812s left) core_auth (getclient-master-drop)
[206.456614] Starting subtest: getclient-master-drop
[206.470778] Subtest getclient-master-drop: SUCCESS (0.015s)
[206.576349] [048/155] (812s left) gem_exec_reloc (basic-softpin)
[206.629689] Subtest basic-softpin: SKIP (0.000s)
[206.698547] [049/155] (811s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[206.793734] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[206.797982] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[206.889266] [050/155] (811s left) gem_linear_blits (basic)
[207.278172] Starting subtest: basic
[207.286319] Subtest basic: SUCCESS (0.012s)
[207.428477] [051/155] (811s left) gem_exec_reloc (basic-gtt-cpu-active)
[207.528869] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[207.609735] [052/155] (811s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[207.720380] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[207.724394] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[207.813197] [053/155] (810s left) gem_pread (exhaustion)
[207.876532] Subtest exhaustion: SKIP (0.000s)
[207.933228] [054/155] (810s left) kms_psr (psr-sprite-blt)
[208.031033] Starting subtest: psr-sprite-blt
[208.033359] Starting dynamic subtest: eDP-1
[209.760904] Dynamic subtest eDP-1: SUCCESS (1.728s)
[209.763216] Subtest psr-sprite-blt: SUCCESS (1.729s)
[210.618433] [055/155] (808s left) kms_vrr (flipline)
[210.713243] Starting subtest: flipline
[210.719738] Subtest flipline: SKIP (0.000s)
[210.784203] [056/155] (808s left) i915_pm_sseu (full-enable)
[210.846482] Subtest full-enable: SKIP (0.000s)
[210.965035] [057/155] (807s left) prime_self_import (reimport-vs-gem_close-race)
[211.003961] Starting subtest: reimport-vs-gem_close-race
[216.083124] Subtest reimport-vs-gem_close-race: SUCCESS (5.080s)
[216.172748] [058/155] (802s left) gem_spin_batch (legacy-resubmit)
[216.235676] Starting subtest: legacy-resubmit
[216.238139] Starting dynamic subtest: default
[216.245179] Dynamic subtest default: SUCCESS (0.009s)
[216.255189] Starting dynamic subtest: render
[216.257068] Dynamic subtest render: SUCCESS (0.001s)
[216.268360] Starting dynamic subtest: bsd
[216.270486] Dynamic subtest bsd: SUCCESS (0.004s)
[216.280947] Starting dynamic subtest: bsd1
[216.283072] Dynamic subtest bsd1: SUCCESS (0.004s)
[216.292381] Starting dynamic subtest: bsd2
[216.294531] Dynamic subtest bsd2: SUCCESS (0.001s)
[216.304103] Starting dynamic subtest: blt
[216.306222] Dynamic subtest blt: SUCCESS (0.006s)
[216.316273] Starting dynamic subtest: vebox
[216.318470] Dynamic subtest vebox: SUCCESS (0.004s)
[216.320693] Subtest legacy-resubmit: SUCCESS (0.037s)
[216.520318] [059/155] (802s left) gem_exec_whisper (basic-fds-priority-all)
[216.577022] Starting subtest: basic-fds-priority-all
[240.506968] Subtest basic-fds-priority-all: SUCCESS (23.927s)
[240.701841] [060/155] (778s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[240.805821] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[240.810215] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[240.903319] [061/155] (778s left) syncobj_timeline (invalid-query-illegal-handle)
[240.963241] Starting subtest: invalid-query-illegal-handle
[240.965549] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[241.055634] [062/155] (778s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[241.158761] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[241.162966] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[241.278849] [063/155] (777s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[241.388494] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[242.394096] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.005s)
[243.258902] [064/155] (775s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[243.365072] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[243.369706] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[243.462219] [065/155] (775s left) gem_exec_fence (parallel)
[243.628526] Starting subtest: parallel
[243.631163] Starting dynamic subtest: rcs0
[245.781500] Dynamic subtest rcs0: SUCCESS (2.154s)
[245.793089] Starting dynamic subtest: bcs0
[247.933908] Dynamic subtest bcs0: SUCCESS (2.151s)
[247.944964] Starting dynamic subtest: vcs0
[250.089076] Dynamic subtest vcs0: SUCCESS (2.154s)
[250.100643] Starting dynamic subtest: vcs1
[252.244907] Dynamic subtest vcs1: SUCCESS (2.155s)
[252.257547] Starting dynamic subtest: vecs0
[254.395055] Dynamic subtest vecs0: SUCCESS (2.149s)
[254.405384] Starting dynamic subtest: ccs0
[256.548177] Dynamic subtest ccs0: SUCCESS (2.153s)
[256.550191] Subtest parallel: SUCCESS (12.921s)
[257.407438] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[257.410736] [066/155] (761s left) gem_exec_balancer (individual)
[257.460370] Starting subtest: individual
[259.272407] Subtest individual: SUCCESS (1.810s)
[259.611977] [067/155] (759s left) kms_flip (2x-dpms-vs-vblank-race)
[259.700774] Starting subtest: 2x-dpms-vs-vblank-race
[259.710358] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[259.793217] [068/155] (759s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[259.884533] Starting subtest: fbc-psr2-sprite-mmap-gtt
[259.886810] Starting dynamic subtest: eDP-1
[259.891299] Dynamic subtest eDP-1: SKIP (0.000s)
[259.895177] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[259.958121] [069/155] (759s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-move)
[260.057617] Starting subtest: hdr-2p-scndscrn-spr-indfb-move
[260.061530] Subtest hdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[260.162555] [070/155] (759s left) gem_mmap_gtt (close-race)
[260.221779] Subtest close-race: SKIP (0.000s)
[260.294380] [071/155] (759s left) gem_ctx_persistence (legacy-engines-cleanup)
[260.351698] Starting subtest: legacy-engines-cleanup
[260.354119] Starting dynamic subtest: render
[260.429745] Dynamic subtest render: SUCCESS (0.077s)
[260.442851] Starting dynamic subtest: bsd1
[260.468756] Dynamic subtest bsd1: SUCCESS (0.037s)
[260.482846] Starting dynamic subtest: bsd2
[260.505080] Dynamic subtest bsd2: SUCCESS (0.034s)
[260.514857] Starting dynamic subtest: blt
[260.541325] Dynamic subtest blt: SUCCESS (0.034s)
[260.551246] Starting dynamic subtest: vebox
[260.583070] Dynamic subtest vebox: SUCCESS (0.040s)
[260.585279] Subtest legacy-engines-cleanup: SUCCESS (0.233s)
[260.663857] [072/155] (758s left) kms_joiner (basic-max-non-joiner)
[260.755852] Starting subtest: basic-max-non-joiner
[260.759318] Subtest basic-max-non-joiner: SKIP (0.000s)
[260.828771] [073/155] (758s left) gem_mmap_offset (mmap-boundaries)
[260.885123] Starting subtest: mmap-boundaries
[260.886673] Starting dynamic subtest: smem0
[261.169501] Dynamic subtest smem0: SUCCESS (0.284s)
[261.171933] Subtest mmap-boundaries: SUCCESS (0.285s)
[261.298864] [074/155] (758s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[261.389600] Starting subtest: primary-y-tiled-reflect-x-0
[261.459972] Subtest primary-y-tiled-reflect-x-0: SKIP (0.071s)
[261.563070] [075/155] (758s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[261.667020] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[261.675963] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[261.777701] [076/155] (757s left) kms_prime (basic-modeset-hybrid)
[261.860203] Subtest basic-modeset-hybrid: SKIP (0.000s)
[261.970365] [077/155] (757s left) kms_fb_coherency (memset-crc)
[262.065271] Starting subtest: memset-crc
[262.067090] Starting dynamic subtest: mmap-offset-wc
[262.453377] Dynamic subtest mmap-offset-wc: SUCCESS (0.389s)
[262.745756] Starting dynamic subtest: mmap-offset-uc
[268.205084] Dynamic subtest mmap-offset-uc: SUCCESS (5.472s)
[268.484866] Subtest memset-crc: SUCCESS (6.420s)
[269.312363] [078/155] (750s left) kms_hdr (bpc-switch)
[269.424981] Starting subtest: bpc-switch
[269.427247] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[273.981799] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.558s)
[273.993612] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[278.516443] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.533s)
[278.518833] Subtest bpc-switch: SUCCESS (9.094s)
[278.619775] [079/155] (741s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[278.728933] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[286.081510] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.357s)
[286.209136] [080/155] (733s left) gem_exec_reloc (basic-wc-cpu-active)
[286.269071] Subtest basic-wc-cpu-active: SKIP (0.000s)
[286.344579] [081/155] (733s left) gen3_render_linear_blits
[286.468226] [082/155] (733s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[286.576329] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[286.580776] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[286.691789] [083/155] (733s left) gem_ctx_exec (basic-close-race)
[286.760753] Starting subtest: basic-close-race
[292.563112] Subtest basic-close-race: SUCCESS (5.801s)
[292.701483] [084/155] (727s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[292.797664] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[292.802197] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[292.895525] [085/155] (727s left) i915_query (query-garbage)
[292.947456] Starting subtest: query-garbage
[292.949659] Subtest query-garbage: SUCCESS (0.000s)
[293.057945] [086/155] (727s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[293.184941] Starting subtest: short-flip-before-cursor-atomic-transitions
[294.144701] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.959s)
[295.002254] [087/155] (725s left) gem_eio (in-flight-internal-1us)
[295.219064] Starting subtest: in-flight-internal-1us
[296.433026] Subtest in-flight-internal-1us: SUCCESS (1.213s)
[296.594727] [088/155] (723s left) gem_exec_params (invalid-flag)
[296.652834] Starting subtest: invalid-flag
[296.655167] Subtest invalid-flag: SUCCESS (0.000s)
[296.775188] [089/155] (723s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[296.871938] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[296.876069] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[296.986210] [090/155] (723s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[297.048634] Starting subtest: etime-multi-wait-all-for-submit-submitted
[297.149802] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[297.231775] [091/155] (723s left) kms_cursor_legacy (single-move)
[297.349340] Starting subtest: single-move
[297.351647] Starting dynamic subtest: pipe-A
[302.732672] Dynamic subtest pipe-A: SUCCESS (5.379s)
[302.745652] Starting dynamic subtest: pipe-B
[308.114873] Dynamic subtest pipe-B: SUCCESS (5.379s)
[308.126895] Starting dynamic subtest: pipe-C
[313.496839] Dynamic subtest pipe-C: SUCCESS (5.379s)
[313.509057] Starting dynamic subtest: pipe-D
[318.878060] Dynamic subtest pipe-D: SUCCESS (5.379s)
[318.890602] Starting dynamic subtest: all-pipes
[324.266372] Dynamic subtest all-pipes: SUCCESS (5.386s)
[324.268738] Subtest single-move: SUCCESS (26.914s)
[324.412467] [092/155] (696s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[324.520312] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[324.524142] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[324.617327] [093/155] (695s left) kms_flip (2x-blocking-wf_vblank)
[324.702151] Starting subtest: 2x-blocking-wf_vblank
[324.713343] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[324.794640] [094/155] (695s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[324.890081] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[324.894518] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[324.983397] [095/155] (695s left) gem_wait (await)
[325.050883] Starting subtest: await
[325.053339] Starting dynamic subtest: all-engines
[326.167565] Dynamic subtest all-engines: SUCCESS (1.116s)
[326.186170] Starting dynamic subtest: rcs0
[327.224900] Dynamic subtest rcs0: SUCCESS (1.055s)
[327.243690] Starting dynamic subtest: bcs0
[328.284730] Dynamic subtest bcs0: SUCCESS (1.057s)
[328.304099] Starting dynamic subtest: vcs0
[329.339471] Dynamic subtest vcs0: SUCCESS (1.053s)
[329.357075] Starting dynamic subtest: vcs1
[330.392825] Dynamic subtest vcs1: SUCCESS (1.051s)
[330.411678] Starting dynamic subtest: vecs0
[331.446230] Dynamic subtest vecs0: SUCCESS (1.051s)
[331.465037] Starting dynamic subtest: ccs0
[332.504223] Dynamic subtest ccs0: SUCCESS (1.056s)
[332.506737] Subtest await: SUCCESS (7.454s)
[332.722047] [096/155] (687s left) gem_exec_create (madvise)
[332.778194] Starting subtest: madvise
[332.780481] Starting dynamic subtest: smem
[354.400183] Dynamic subtest smem: SUCCESS (21.617s)
[354.404620] Subtest madvise: SUCCESS (21.618s)
[355.143256] [097/155] (665s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render)
[355.248895] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render
[355.252831] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[355.355557] [098/155] (665s left) prime_vgem (wait)
[355.429039] Starting subtest: wait
[355.431400] Starting dynamic subtest: rcs0
[355.505207] Dynamic subtest rcs0: SUCCESS (0.076s)
[355.515223] Starting dynamic subtest: bcs0
[355.574227] Dynamic subtest bcs0: SUCCESS (0.068s)
[355.584129] Starting dynamic subtest: vcs0
[355.620280] Dynamic subtest vcs0: SUCCESS (0.044s)
[355.630641] Starting dynamic subtest: vcs1
[355.664481] Dynamic subtest vcs1: SUCCESS (0.043s)
[355.675068] Starting dynamic subtest: vecs0
[355.709402] Dynamic subtest vecs0: SUCCESS (0.044s)
[355.719752] Starting dynamic subtest: ccs0
[355.758122] Dynamic subtest ccs0: SUCCESS (0.048s)
[355.760348] Subtest wait: SUCCESS (0.330s)
[355.878119] [099/155] (664s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[355.977912] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[355.980416] Starting dynamic subtest: pipe-A
[356.109155] Dynamic subtest pipe-A: SKIP (0.130s)
[356.119362] Starting dynamic subtest: pipe-B
[357.297955] Dynamic subtest pipe-B: SKIP (1.188s)
[357.308720] Starting dynamic subtest: pipe-C
[358.514541] Dynamic subtest pipe-C: SUCCESS (1.221s)
[358.527198] Starting dynamic subtest: pipe-D
[359.750268] Dynamic subtest pipe-D: SUCCESS (1.235s)
[359.752385] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.778s)
[360.938331] [100/155] (659s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[361.049950] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[368.432937] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.389s)
[368.559271] [101/155] (652s left) api_intel_allocator (reloc-allocator)
[368.625382] Starting subtest: reloc-allocator
[368.627625] Starting dynamic subtest: basic
[368.629605] Dynamic subtest basic: SUCCESS (0.004s)
[368.640665] Starting dynamic subtest: parallel-one
[368.642868] Dynamic subtest parallel-one: SUCCESS (0.008s)
[368.653487] Starting dynamic subtest: print
[368.656183] Dynamic subtest print: SUCCESS (0.000s)
[368.666229] Starting dynamic subtest: reuse
[368.668435] Dynamic subtest reuse: SUCCESS (0.000s)
[368.678471] Starting dynamic subtest: fork-reopen-allocator
[368.680733] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[368.683032] Subtest reloc-allocator: SUCCESS (0.030s)
[368.801877] [102/155] (652s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[368.860314] Starting subtest: y-tiled-ccs-to-yf-tiled
[368.864463] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[369.043375] [103/155] (651s left) kms_frontbuffer_tracking (fbchdr-suspend)
[369.140769] Starting subtest: fbchdr-suspend
[369.145264] Subtest fbchdr-suspend: SKIP (0.000s)
[369.246422] [104/155] (651s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[369.337277] Starting subtest: psr-rgb101010-draw-mmap-cpu
[376.556420] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.223s)
[376.685561] [105/155] (644s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[376.746049] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[376.821987] [106/155] (644s left) kms_pm_backlight (fade-with-suspend)
[376.906163] Starting subtest: fade-with-suspend
[393.620496] Starting dynamic subtest: eDP-1
[396.620841] Dynamic subtest eDP-1: SUCCESS (3.001s)
[396.623256] Subtest fade-with-suspend: SUCCESS (5.464s)
[400.528354] [107/155] (623s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[400.640372] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[400.644895] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[401.728592] [108/155] (622s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[401.820306] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[401.824253] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[401.912935] [109/155] (622s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[402.010103] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[402.012380] Starting dynamic subtest: pipe-A-eDP-1
[402.032173] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[402.045112] Starting dynamic subtest: pipe-B-eDP-1
[402.063754] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[402.074656] Starting dynamic subtest: pipe-C-eDP-1
[402.093580] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[402.103947] Starting dynamic subtest: pipe-D-eDP-1
[402.123315] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[402.125382] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[404.226114] [110/155] (619s left) kms_color (deep-color)
[404.321818] Starting subtest: deep-color
[405.378352] Starting dynamic subtest: pipe-A-eDP-1-gamma
[406.093589] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.726s)
[406.107042] Starting dynamic subtest: pipe-A-eDP-1-degamma
[407.545747] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.478s)
[407.558541] Starting dynamic subtest: pipe-A-eDP-1-ctm
[408.971622] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.447s)
[409.738082] Starting dynamic subtest: pipe-B-eDP-1-gamma
[410.435352] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.715s)
[410.450074] Starting dynamic subtest: pipe-B-eDP-1-degamma
[411.933385] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.510s)
[411.944932] Starting dynamic subtest: pipe-B-eDP-1-ctm
[413.452533] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.528s)
[414.287925] Starting dynamic subtest: pipe-C-eDP-1-gamma
[414.964327] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.691s)
[414.976224] Starting dynamic subtest: pipe-C-eDP-1-degamma
[416.355449] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.395s)
[416.366801] Starting dynamic subtest: pipe-C-eDP-1-ctm
[417.778629] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.430s)
[418.579653] Starting dynamic subtest: pipe-D-eDP-1-gamma
[419.283969] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.714s)
[419.294822] Starting dynamic subtest: pipe-D-eDP-1-degamma
[420.719243] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.442s)
[420.730628] Starting dynamic subtest: pipe-D-eDP-1-ctm
[422.142386] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.424s)
[422.144740] Subtest deep-color: SUCCESS (17.983s)
[422.999015] [111/155] (601s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[423.103035] Starting subtest: y-tiled-64bpp-rotate-270
[423.107541] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[423.203087] [112/155] (601s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[424.727256] Starting subtest: dpms-mode-unset-non-lpsp
[425.881739] Subtest dpms-mode-unset-non-lpsp: SKIP (1.157s)
[426.289839] [113/155] (598s left) kms_addfb_basic (bad-pitch-999)
[426.349037] Starting subtest: bad-pitch-999
[426.351316] Subtest bad-pitch-999: SUCCESS (0.000s)
[426.507048] [114/155] (597s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-plflip-blt)
[426.615711] Starting subtest: psrhdr-2p-primscrn-indfb-plflip-blt
[426.620251] Subtest psrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[426.711504] [115/155] (597s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[426.800924] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[430.491926] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.696s)
[431.698991] [116/155] (592s left) i915_pm_rpm (reg-read-ioctl)
[433.732677] Starting subtest: reg-read-ioctl
[436.028667] Subtest reg-read-ioctl: SUCCESS (2.301s)
[436.427359] [117/155] (588s left) dumb_buffer (create-valid-dumb)
[436.497798] Starting subtest: create-valid-dumb
[436.500211] Subtest create-valid-dumb: SUCCESS (0.000s)
[436.606485] [118/155] (587s left) gem_exec_schedule (independent)
[436.670855] Starting subtest: independent
[436.672842] Starting dynamic subtest: rcs0
[438.604124] Dynamic subtest rcs0: SUCCESS (1.941s)
[438.618096] Starting dynamic subtest: vcs0
[440.597571] Dynamic subtest vcs0: SUCCESS (1.991s)
[440.610255] Starting dynamic subtest: vcs1
[442.587734] Dynamic subtest vcs1: SUCCESS (1.987s)
[442.601952] Starting dynamic subtest: vecs0
[444.562066] Dynamic subtest vecs0: SUCCESS (1.973s)
[444.574507] Starting dynamic subtest: ccs0
[446.603504] Dynamic subtest ccs0: SUCCESS (2.039s)
[446.606044] Subtest independent: SUCCESS (9.943s)
[446.908198] [119/155] (577s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[447.005840] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[447.010137] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[447.080856] [120/155] (577s left) gem_exec_balancer (waits)
[447.142669] Starting subtest: waits
[453.644519] Subtest waits: SUCCESS (6.502s)
[453.947710] [121/155] (570s left) gem_exec_params (rel-constants-invalid-ring)
[454.002250] Starting subtest: rel-constants-invalid-ring
[454.004499] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[454.106225] [122/155] (570s left) gem_exec_create (forked)
[454.163812] Starting subtest: forked
[454.165706] Starting dynamic subtest: smem
[475.596645] Dynamic subtest smem: SUCCESS (21.440s)
[475.599648] Subtest forked: SUCCESS (21.443s)
[475.803316] [123/155] (548s left) gem_exec_reloc (basic-wc)
[475.868322] Subtest basic-wc: SKIP (0.000s)
[475.944647] [124/155] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[476.047992] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[476.052164] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[476.153530] [125/155] (548s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[476.261740] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[483.452836] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.197s)
[483.594722] [126/155] (541s left) gem_render_copy (linear-to-vebox-y-tiled)
[483.660485] Starting subtest: linear-to-vebox-y-tiled
[483.664640] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[483.841346] [127/155] (541s left) gem_mmap_gtt (basic-read-write-distinct)
[483.892242] Subtest basic-read-write-distinct: SKIP (0.000s)
[483.951186] [128/155] (541s left) kms_psr (pr-cursor-render)
[484.041629] Starting subtest: pr-cursor-render
[484.045659] Subtest pr-cursor-render: SKIP (0.000s)
[484.115461] [129/155] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[484.209745] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[484.213799] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[484.310943] [130/155] (540s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[484.410225] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[484.414207] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[484.518329] [131/155] (540s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt)
[484.609677] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt
[484.614068] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[484.705814] [132/155] (540s left) kms_flip (2x-flip-vs-modeset)
[484.803017] Starting subtest: 2x-flip-vs-modeset
[484.812101] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[484.891575] [133/155] (540s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render)
[484.995617] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render
[484.998938] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[485.075278] [134/155] (540s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[485.172191] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[485.175505] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[485.241551] [135/155] (540s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[485.333092] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[491.915275] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.587s)
[492.040974] [136/155] (533s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[492.163422] Starting subtest: flip-vs-cursor-toggle
[501.221928] Subtest flip-vs-cursor-toggle: SUCCESS (9.052s)
[502.083018] [137/155] (523s left) kms_cursor_crc (cursor-random-256x256)
[502.336940] Starting subtest: cursor-random-256x256
[502.339204] Starting dynamic subtest: pipe-A-eDP-1
[505.670268] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.331s)
[505.703090] Starting dynamic subtest: pipe-D-eDP-1
[509.685771] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.990s)
[509.688168] Subtest cursor-random-256x256: SUCCESS (7.347s)
[510.564903] [138/155] (514s left) kms_lease (simple-lease)
[510.668242] Starting subtest: simple-lease
[510.670588] Starting dynamic subtest: pipe-A-eDP-1
[511.165910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.499s)
[511.181070] Starting dynamic subtest: pipe-B-eDP-1
[512.601137] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.434s)
[512.613011] Starting dynamic subtest: pipe-C-eDP-1
[514.101926] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.496s)
[514.115173] Starting dynamic subtest: pipe-D-eDP-1
[515.535077] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.432s)
[515.537389] Subtest simple-lease: SUCCESS (4.868s)
[516.364031] [139/155] (509s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[516.478370] Starting subtest: x-tiled-16bpp-rotate-90
[516.501496] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[516.632162] [140/155] (508s left) kms_chamelium_hpd (common-hpd-after-suspend)
[517.021758] Subtest common-hpd-after-suspend: SKIP (0.000s)
[517.857325] [141/155] (507s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[517.953252] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[517.957342] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[518.061331] [142/155] (507s left) kms_psr (fbc-psr-no-drrs)
[518.152094] Starting subtest: fbc-psr-no-drrs
[518.154229] Starting dynamic subtest: eDP-1
[518.158122] Dynamic subtest eDP-1: SKIP (0.000s)
[518.162070] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[518.226016] [143/155] (507s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[518.280381] Subtest untiled-to-tiled: SKIP (0.000s)
[518.359185] [144/155] (507s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[518.465739] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[518.468110] Starting dynamic subtest: pipe-A-eDP-1
[518.594419] Dynamic subtest pipe-A-eDP-1: FAIL (0.052s)
[518.606466] Starting dynamic subtest: pipe-B-eDP-1
[518.708275] Dynamic subtest pipe-B-eDP-1: FAIL (0.005s)
[518.710595] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: FAIL (0.061s)
[518.753553] [145/155] (506s left) syncobj_timeline (single-wait-all-signaled)
[518.797249] Starting subtest: single-wait-all-signaled
[518.799043] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[518.908315] [146/155] (506s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[519.009685] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[519.013152] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[519.104953] [147/155] (506s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[519.198534] Starting subtest: random-ccs-data-yf-tiled-ccs
[519.200414] Starting dynamic subtest: pipe-A-eDP-1
[519.221262] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[519.234320] Starting dynamic subtest: pipe-B-eDP-1
[519.253773] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[519.264569] Starting dynamic subtest: pipe-C-eDP-1
[519.284169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[519.294342] Starting dynamic subtest: pipe-D-eDP-1
[519.314135] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[519.317727] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[521.536232] [148/155] (504s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-plflip-blt)
[521.648666] Starting subtest: psrhdr-1p-primscrn-shrfb-plflip-blt
[521.652901] Subtest psrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[521.751348] [149/155] (504s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[521.845001] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[521.849305] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[521.921176] [150/155] (504s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[522.020957] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[522.645553] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[522.820770] [151/155] (503s left) gem_exec_flush (basic-wb-rw-default)
[522.879316] Starting subtest: basic-wb-rw-default
[528.337241] Subtest basic-wb-rw-default: SUCCESS (5.457s)
[528.530958] [152/155] (497s left) kms_cursor_crc (cursor-onscreen-32x32)
[528.682116] Starting subtest: cursor-onscreen-32x32
[528.731851] Subtest cursor-onscreen-32x32: SKIP (0.045s)
[529.017282] [153/155] (497s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt)
[529.116006] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt
[529.120550] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[529.221049] [154/155] (496s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[529.324001] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[533.451611] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.133s)
[534.653328] [155/155] (491s left) syncobj_wait (wait-delayed-signal)
[534.708618] Starting subtest: wait-delayed-signal
[534.812073] Subtest wait-delayed-signal: SUCCESS (0.103s)
[534.886423] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: gen9_exec_parse
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_pread
results: parsing output: 12/ for test: i915_drm_fdinfo
results: parsing output: 13/ for test: kms_pipe_crc_basic
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_chamelium_frames
results: parsing output: 16/ for test: kms_atomic
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: fbdev
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 22/ for test: kms_atomic_transition
results: parsing output: 23/ for test: gem_ctx_persistence
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_fence_thrash
results: parsing output: 28/ for test: gem_gpgpu_fill
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_tiled_display
results: parsing output: 32/ for test: gem_ctx_sseu
results: parsing output: 33/ for test: gem_ctx_param
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: i915_hangman
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: kms_plane
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_cursor_edge_walk
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: core_auth
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_linear_blits
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_pread
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_vrr
results: parsing output: 55/ for test: i915_pm_sseu
results: parsing output: 56/ for test: prime_self_import
results: parsing output: 57/ for test: gem_spin_batch
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_joiner
results: parsing output: 72/ for test: gem_mmap_offset
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_prime
results: parsing output: 76/ for test: kms_fb_coherency
results: parsing output: 77/ for test: kms_hdr
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gen3_render_linear_blits
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_ctx_exec
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_query
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: gem_eio
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_wait
results: parsing output: 95/ for test: gem_exec_create
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: prime_vgem
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: api_intel_allocator
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_fenced_exec_thrash
results: parsing output: 105/ for test: kms_pm_backlight
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_color
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: dumb_buffer
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: gem_exec_create
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_render_copy
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_psr2_sf
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_cursor_legacy
results: parsing output: 136/ for test: kms_cursor_crc
results: parsing output: 137/ for test: kms_lease
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: kms_chamelium_hpd
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_psr
results: parsing output: 142/ for test: gem_set_tiling_vs_blt
results: parsing output: 143/ for test: kms_psr2_sf
results: parsing output: 144/ for test: syncobj_timeline
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_ccs
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_plane
results: parsing output: 149/ for test: kms_big_fb
results: parsing output: 150/ for test: gem_exec_flush
results: parsing output: 151/ for test: kms_cursor_crc
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: syncobj_wait
Done.