[58.099582] Initializing watchdogs
[58.099632]   /dev/watchdog0
[58.114439] [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]
[58.118835] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.121110] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.124403] [001/156] (960s left) kms_dp_linktrain_fallback (dsc-fallback)
[58.247893] Starting subtest: dsc-fallback
[58.254236] Subtest dsc-fallback: SKIP (0.000s)
[58.314200] [002/156] (960s left) kms_cursor_crc (cursor-offscreen-max-size)
[58.632864] Starting subtest: cursor-offscreen-max-size
[58.639909] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[58.769800] [003/156] (959s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[58.861901] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[58.864619] Starting dynamic subtest: pipe-A-eDP-1
[58.890252] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.901208] Starting dynamic subtest: pipe-B-eDP-1
[58.922383] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.929128] Starting dynamic subtest: pipe-C-eDP-1
[58.946876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.953448] Starting dynamic subtest: pipe-D-eDP-1
[58.972189] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.975568] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[61.437682] [004/156] (957s left) gem_exec_whisper (basic-fds-forked)
[61.523052] Starting subtest: basic-fds-forked
[87.429200] Subtest basic-fds-forked: SUCCESS (25.799s)
[87.616085] [005/156] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[87.710963] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[87.713323] Starting dynamic subtest: pipe-A-eDP-1
[87.736542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[87.744391] Starting dynamic subtest: pipe-B-eDP-1
[87.765248] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[87.772947] Starting dynamic subtest: pipe-C-eDP-1
[87.793645] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[87.800759] Starting dynamic subtest: pipe-D-eDP-1
[87.822794] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[87.827233] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[90.013110] [006/156] (928s left) perf (non-system-wide-paranoid)
[90.122824] Starting subtest: non-system-wide-paranoid
[90.151665] Subtest non-system-wide-paranoid: SUCCESS (0.031s)
[90.189192] [007/156] (928s left) gem_exec_reloc (basic-write-gtt-noreloc)
[90.246075] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[90.317025] [008/156] (928s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[90.375066] Starting subtest: multi-wait-all-for-submit-available-submitted
[90.377368] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[90.474780] [009/156] (928s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[90.554997] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[90.557347] Starting dynamic subtest: pipe-A-eDP-1
[90.615197] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[90.624950] Starting dynamic subtest: pipe-B-eDP-1
[90.677512] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[90.685406] Starting dynamic subtest: pipe-C-eDP-1
[90.737363] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s)
[90.745144] Starting dynamic subtest: pipe-D-eDP-1
[90.800069] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.062s)
[90.802287] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.248s)
[93.058057] [010/156] (925s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[93.163169] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[93.165588] Starting dynamic subtest: A-eDP1
[102.106430] Dynamic subtest A-eDP1: SUCCESS (8.939s)
[102.116810] Starting dynamic subtest: B-eDP1
[111.035060] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[111.046381] Starting dynamic subtest: C-eDP1
[119.953879] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[119.964058] Starting dynamic subtest: D-eDP1
[128.884903] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[128.890118] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.717s)
[130.107757] [011/156] (888s left) gem_exec_fence (submit3)
[130.276047] Starting subtest: submit3
[130.281488] Subtest submit3: SKIP (0.000s)
[132.344927] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[132.348486] [012/156] (886s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[132.409066] Starting subtest: etime-multi-wait-all-available-unsubmitted
[132.509850] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[132.586761] [013/156] (886s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[132.699624] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite
[132.703585] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[132.799831] [014/156] (886s left) gem_exec_schedule (timeslicing)
[132.856687] Starting subtest: timeslicing
[132.858556] Starting dynamic subtest: rcs0
[132.869361] Dynamic subtest rcs0: SUCCESS (0.022s)
[132.877197] Starting dynamic subtest: bcs0
[132.891761] Dynamic subtest bcs0: SUCCESS (0.021s)
[132.901625] Starting dynamic subtest: vcs0
[132.911535] Dynamic subtest vcs0: SUCCESS (0.020s)
[132.919322] Starting dynamic subtest: vcs1
[132.934281] Dynamic subtest vcs1: SUCCESS (0.022s)
[132.946178] Starting dynamic subtest: vecs0
[132.954956] Dynamic subtest vecs0: SUCCESS (0.020s)
[132.962884] Starting dynamic subtest: ccs0
[132.974782] Dynamic subtest ccs0: SUCCESS (0.020s)
[132.977073] Subtest timeslicing: SUCCESS (0.127s)
[134.326225] [015/156] (884s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[134.417881] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[134.422222] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[134.487977] [016/156] (884s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[134.578262] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[134.582836] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[134.648382] [017/156] (884s left) api_intel_bb (simple-bb)
[134.698348] Starting subtest: simple-bb
[134.702873] Subtest simple-bb: SUCCESS (0.006s)
[134.819161] [018/156] (884s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[134.914203] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[135.882712] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.969s)
[136.025527] [019/156] (883s left) syncobj_wait (wait-for-submit-delayed-submit)
[136.073154] Starting subtest: wait-for-submit-delayed-submit
[136.174991] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[136.252179] [020/156] (883s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[136.351405] Starting subtest: crc-primary-basic-y-tiled-ccs
[136.353855] Starting dynamic subtest: pipe-A-eDP-1
[136.377811] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[136.388269] Starting dynamic subtest: pipe-B-eDP-1
[136.409843] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[136.420758] Starting dynamic subtest: pipe-C-eDP-1
[136.442814] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[136.453305] Starting dynamic subtest: pipe-D-eDP-1
[136.475538] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[136.479972] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s)
[138.677640] [021/156] (880s left) api_intel_allocator (gem-pool)
[138.738871] Starting subtest: gem-pool
[138.746439] Subtest gem-pool: SUCCESS (0.009s)
[138.861590] [022/156] (880s left) syncobj_wait (wait-all-snapshot)
[138.906701] Starting subtest: wait-all-snapshot
[138.987228] Subtest wait-all-snapshot: SUCCESS (0.082s)
[139.075214] [023/156] (880s left) gem_ctx_shared (q-smoketest-all)
[139.135456] Starting subtest: Q-smoketest-all
[171.521231] Subtest Q-smoketest-all: SUCCESS (32.334s)
[172.333201] [024/156] (847s left) gem_ctx_bad_destroy (invalid-ctx)
[172.383064] Starting subtest: invalid-ctx
[172.385214] Subtest invalid-ctx: SUCCESS (0.000s)
[172.468138] [025/156] (847s left) kms_properties (colorop-properties-legacy)
[172.559606] Starting subtest: colorop-properties-legacy
[172.561767] Starting dynamic subtest: pipe-A-eDP-1
[172.922421] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s)
[172.931586] Starting dynamic subtest: pipe-B-eDP-1
[174.088607] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[174.096763] Starting dynamic subtest: pipe-C-eDP-1
[175.198126] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[175.206788] Starting dynamic subtest: pipe-D-eDP-1
[176.232897] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.034s)
[176.235366] Subtest colorop-properties-legacy: SUCCESS (3.673s)
[177.043776] [026/156] (842s left) kms_flip (2x-flip-vs-modeset)
[177.139331] Starting subtest: 2x-flip-vs-modeset
[177.150220] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[177.225172] [027/156] (842s left) kms_lease (invalid-create-leases)
[177.322087] Starting subtest: invalid-create-leases
[177.326848] Subtest invalid-create-leases: SUCCESS (0.005s)
[177.435583] [028/156] (842s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[177.549969] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[177.554672] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[177.688850] [029/156] (842s left) kms_cursor_legacy (forked-bo)
[177.804361] Starting subtest: forked-bo
[177.806299] Starting dynamic subtest: pipe-A
[183.260484] Dynamic subtest pipe-A: SUCCESS (5.454s)
[183.271118] Starting dynamic subtest: pipe-B
[188.734413] Dynamic subtest pipe-B: SUCCESS (5.471s)
[188.749598] Starting dynamic subtest: pipe-C
[194.202616] Dynamic subtest pipe-C: SUCCESS (5.467s)
[194.213219] Starting dynamic subtest: pipe-D
[199.678355] Dynamic subtest pipe-D: SUCCESS (5.474s)
[199.688266] Starting dynamic subtest: all-pipes
[205.185815] Dynamic subtest all-pipes: SUCCESS (5.505s)
[205.188387] Subtest forked-bo: SUCCESS (27.378s)
[205.337436] [030/156] (814s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[205.482020] Starting subtest: cursor-rapid-movement-32x32
[205.527785] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[205.834913] [031/156] (813s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt)
[205.935752] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt
[205.939776] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[206.030391] [032/156] (813s left) gem_exec_balancer (sequential)
[206.090380] Starting subtest: sequential
[209.153634] Subtest sequential: SUCCESS (3.063s)
[209.473375] [033/156] (810s left) gem_exec_reloc (basic-gtt-noreloc)
[209.532584] Subtest basic-gtt-noreloc: SKIP (0.000s)
[209.609825] [034/156] (810s left) gem_ccs (large-ctrl-surf-copy)
[209.673668] Starting subtest: large-ctrl-surf-copy
[209.677617] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[209.775643] [035/156] (810s left) gem_create (create-ext-placement-each)
[209.945836] Starting subtest: create-ext-placement-each
[209.947930] Subtest create-ext-placement-each: SUCCESS (0.000s)
[210.039558] [036/156] (809s left) i915_pm_rpm (system-suspend)
[211.562370] Starting subtest: system-suspend
[228.919814] Subtest system-suspend: SUCCESS (3.051s)
[229.315910] [037/156] (790s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[229.433709] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[237.301443] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.667s)
[237.425601] [038/156] (782s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[237.524406] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[237.528624] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[237.649576] [039/156] (782s left) kms_plane_alpha_blend (alpha-opaque-fb)
[237.737965] Starting subtest: alpha-opaque-fb
[238.017771] Starting dynamic subtest: pipe-A-eDP-1
[238.740284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[238.750594] Starting dynamic subtest: pipe-D-eDP-1
[240.158451] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[240.160863] Subtest alpha-opaque-fb: SUCCESS (2.391s)
[240.983279] [040/156] (779s left) gem_exec_reloc (basic-cpu-wc-active)
[241.053067] Subtest basic-cpu-wc-active: SKIP (0.000s)
[241.133534] [041/156] (779s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[241.230732] Starting subtest: fbcpsr-indfb-scaledprimary
[247.077767] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.812s)
[247.213808] [042/156] (773s left) perf (gen12-unprivileged-single-ctx-counters)
[247.315571] Starting subtest: gen12-unprivileged-single-ctx-counters
[247.318037] Starting dynamic subtest: rcs0
[247.459365] Dynamic subtest rcs0: SUCCESS (0.143s)
[247.461581] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.144s)
[247.502411] [043/156] (772s left) gem_tiled_blits (basic)
[247.590859] Subtest basic: SKIP (0.000s)
[247.667855] [044/156] (772s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[247.758362] Starting subtest: addfb25-y-tiled-legacy
[247.760229] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[247.850210] [045/156] (772s left) gem_softpin (allocator-nopin)
[247.902349] Starting subtest: allocator-nopin
[248.004766] Subtest allocator-nopin: SUCCESS (0.101s)
[248.134350] [046/156] (772s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[248.222816] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[248.225184] Starting dynamic subtest: pipe-A-eDP-1
[248.283014] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[248.291432] Starting dynamic subtest: pipe-B-eDP-1
[248.347238] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[248.357771] Starting dynamic subtest: pipe-C-eDP-1
[248.415480] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[248.425540] Starting dynamic subtest: pipe-D-eDP-1
[248.482947] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[248.487192] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[250.514249] [047/156] (769s left) gem_ctx_persistence (userptr)
[250.584983] Starting subtest: userptr
[250.748688] Subtest userptr: SUCCESS (0.166s)
[250.840348] [048/156] (769s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[250.943406] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[250.947617] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[251.038264] [049/156] (769s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[251.137614] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[251.142077] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[251.225855] [050/156] (769s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[251.316161] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[251.320431] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[251.413269] [051/156] (769s left) kms_addfb_basic (size-max)
[251.506398] Starting subtest: size-max
[251.508362] Subtest size-max: SUCCESS (0.000s)
[251.610213] [052/156] (769s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[251.662725] Starting subtest: yf-tiled-to-vebox-x-tiled
[251.666862] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[251.848496] [053/156] (768s left) kms_dsc (dsc-fractional-bpp)
[251.944087] Starting subtest: dsc-fractional-bpp
[251.957204] Subtest dsc-fractional-bpp: SKIP (0.000s)
[252.020389] [054/156] (768s left) kms_psr (psr2-cursor-render)
[252.114582] Starting subtest: psr2-cursor-render
[252.116886] Starting dynamic subtest: eDP-1
[253.799524] Dynamic subtest eDP-1: SUCCESS (1.683s)
[253.801883] Subtest psr2-cursor-render: SUCCESS (1.684s)
[254.686813] [055/156] (766s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy)
[254.788658] Starting subtest: psrhdr-modesetfrombusy
[254.793063] Subtest psrhdr-modesetfrombusy: SKIP (0.000s)
[254.879644] [056/156] (765s left) syncobj_timeline (single-wait-signaled)
[254.926943] Starting subtest: single-wait-signaled
[254.929328] Subtest single-wait-signaled: SUCCESS (0.000s)
[255.047641] [057/156] (765s left) kms_chamelium_edid (vga-edid-read)
[255.432516] Subtest vga-edid-read: SKIP (0.000s)
[256.305453] [058/156] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[256.399458] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[256.403753] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[256.514239] [059/156] (764s left) kms_pm_rpm (dpms-lpsp)
[258.751200] Starting subtest: dpms-lpsp
[259.059071] Subtest dpms-lpsp: SUCCESS (0.312s)
[259.159258] [060/156] (761s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[259.281564] Starting subtest: verify-pxp-stale-buf-optout-execution
[260.342673] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.062s)
[260.469524] [061/156] (760s left) gem_lmem_swapping (verify-ccs)
[260.507531] Subtest verify-ccs: SKIP (0.000s)
[260.555124] [062/156] (760s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[260.652566] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[261.277446] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[261.428209] [063/156] (759s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[261.524733] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[261.529044] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[261.607631] [064/156] (759s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[261.708849] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[261.713007] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[261.819668] [065/156] (759s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[261.943978] Starting subtest: cursorA-vs-flipA-atomic-transitions
[273.119331] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.174s)
[273.963523] [066/156] (747s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[274.071505] Starting subtest: fbc-psr2-cursor-mmap-cpu
[274.073947] Starting dynamic subtest: eDP-1
[274.077972] Dynamic subtest eDP-1: SKIP (0.000s)
[274.082078] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[274.144911] [067/156] (747s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[274.254036] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[274.303840] [068/156] (747s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[274.395950] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[274.421428] Starting dynamic subtest: pipe-A-plane-0
[274.801433] Dynamic subtest pipe-A-plane-0: SUCCESS (0.378s)
[274.811956] Starting dynamic subtest: pipe-A-plane-3
[275.109776] Dynamic subtest pipe-A-plane-3: SUCCESS (0.310s)
[276.241238] Starting dynamic subtest: pipe-B-plane-0
[276.636466] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[276.651077] Starting dynamic subtest: pipe-B-plane-3
[276.966125] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s)
[277.283828] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.888s)
[278.111602] [069/156] (743s left) syncobj_timeline (reset-multiple-signaled)
[278.165805] Starting subtest: reset-multiple-signaled
[278.167857] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[278.261149] [070/156] (743s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[278.370445] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[278.374502] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[278.473969] [071/156] (742s left) sysfs_heartbeat_interval (precise)
[278.528350] Starting subtest: precise
[278.530601] Starting dynamic subtest: vecs0
[286.560109] Dynamic subtest vecs0: SUCCESS (8.029s)
[286.573083] Starting dynamic subtest: ccs0
[287.728221] Dynamic subtest ccs0: SUCCESS (1.164s)
[287.739621] Starting dynamic subtest: vcs0
[295.586667] Dynamic subtest vcs0: SUCCESS (7.854s)
[295.598646] Starting dynamic subtest: bcs0
[296.677232] Dynamic subtest bcs0: SUCCESS (1.091s)
[296.686413] Starting dynamic subtest: rcs0
[299.564683] Dynamic subtest rcs0: SUCCESS (2.883s)
[299.575938] Starting dynamic subtest: vcs1
[307.625346] Dynamic subtest vcs1: SUCCESS (8.053s)
[307.628239] Subtest precise: SUCCESS (29.084s)
[307.704597] [072/156] (713s left) perf_pmu (init-busy)
[307.742213] Starting subtest: init-busy
[307.744601] Starting dynamic subtest: rcs0
[307.746971] Dynamic subtest rcs0: SUCCESS (0.001s)
[307.756126] Starting dynamic subtest: bcs0
[307.758043] Dynamic subtest bcs0: SUCCESS (0.000s)
[307.766591] Starting dynamic subtest: vcs0
[307.768528] Dynamic subtest vcs0: SUCCESS (0.001s)
[307.777262] Starting dynamic subtest: vcs1
[307.779511] Dynamic subtest vcs1: SUCCESS (0.000s)
[307.788207] Starting dynamic subtest: vecs0
[307.790108] Dynamic subtest vecs0: SUCCESS (0.001s)
[307.798882] Starting dynamic subtest: ccs0
[307.801175] Dynamic subtest ccs0: SUCCESS (0.000s)
[307.803503] Subtest init-busy: SUCCESS (0.007s)
[307.843658] [073/156] (713s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[308.222425] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[309.025914] [074/156] (712s left) kms_psr (fbc-pr-cursor-blt)
[309.120905] Starting subtest: fbc-pr-cursor-blt
[309.125505] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[309.189379] [075/156] (712s left) gem_pxp (fail-invalid-protected-context)
[309.245346] Starting subtest: fail-invalid-protected-context
[309.247615] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[309.365333] [076/156] (712s left) dumb_buffer (invalid-bpp)
[309.411624] Starting subtest: invalid-bpp
[309.413913] Subtest invalid-bpp: SUCCESS (0.000s)
[309.500301] [077/156] (712s left) i915_drm_fdinfo (virtual-busy-hang)
[309.540454] Starting subtest: virtual-busy-hang
[309.544964] Subtest virtual-busy-hang: SKIP (0.000s)
[309.628614] [078/156] (712s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[309.713595] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[316.530095] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.819s)
[316.676952] [079/156] (705s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[316.776868] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[316.781256] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[316.897591] [080/156] (704s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[316.993174] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[316.997394] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[317.104733] [081/156] (704s left) gem_mmap_gtt (basic-copy)
[317.151384] Subtest basic-copy: SKIP (0.000s)
[317.207995] [082/156] (704s left) kms_chamelium_audio (dp-audio-edid)
[317.602612] Subtest dp-audio-edid: SKIP (0.000s)
[318.392896] [083/156] (703s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[318.492609] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[318.497022] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[318.598159] [084/156] (703s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[318.703653] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[318.707913] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[318.808033] [085/156] (703s left) syncobj_wait (invalid-single-wait-unsubmitted)
[318.867663] Starting subtest: invalid-single-wait-unsubmitted
[318.870059] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[318.990521] [086/156] (703s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[319.082186] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[319.873390] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.792s)
[320.036190] [087/156] (702s left) gem_exec_whisper (basic-queues-priority-all)
[320.090719] Starting subtest: basic-queues-priority-all
[339.926259] Subtest basic-queues-priority-all: SUCCESS (19.838s)
[340.112230] [088/156] (682s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[340.242070] Starting subtest: short-flip-after-cursor-toggle
[341.163011] Subtest short-flip-after-cursor-toggle: SUCCESS (0.924s)
[342.037835] [089/156] (680s left) gem_mmap_gtt (hang-user)
[342.108362] Subtest hang-user: SKIP (0.000s)
[342.177613] [090/156] (680s left) kms_atomic_transition (plane-all-transition-fencing)
[342.267126] Starting subtest: plane-all-transition-fencing
[342.269464] Starting dynamic subtest: pipe-A-eDP-1
[344.764402] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[345.076422] Starting dynamic subtest: pipe-B-eDP-1
[348.292134] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.226s)
[348.593918] Subtest plane-all-transition-fencing: SUCCESS (6.329s)
[349.423155] [091/156] (672s left) gem_ctx_bad_destroy (invalid-pad)
[349.471591] Starting subtest: invalid-pad
[349.473849] Subtest invalid-pad: SUCCESS (0.000s)
[349.547125] [092/156] (672s left) kms_atomic (atomic-plane-damage)
[349.641036] Starting subtest: atomic-plane-damage
[349.691439] Starting dynamic subtest: pipe-A-eDP-1
[350.219097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.527s)
[350.221387] Subtest atomic-plane-damage: SUCCESS (0.577s)
[351.044246] [093/156] (671s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-gtt)
[351.139945] Starting subtest: fbchdr-rgb101010-draw-mmap-gtt
[351.144199] Subtest fbchdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[351.244451] [094/156] (671s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[351.336037] Starting subtest: primary-y-tiled-reflect-x-0
[351.395163] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[351.510258] [095/156] (670s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[351.600862] Starting subtest: multiplane-rotation-cropping-top
[369.071701] Subtest multiplane-rotation-cropping-top: SUCCESS (17.471s)
[369.200201] [096/156] (653s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[369.313692] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[369.316989] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[369.414813] [097/156] (653s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[369.521761] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[369.525245] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[369.617152] [098/156] (652s left) perf_pmu (frequency)
[369.652626] Starting subtest: frequency
[369.656862] Starting dynamic subtest: gt0
[371.801720] Dynamic subtest gt0: SUCCESS (2.140s)
[371.814012] Starting dynamic subtest: idle-gt0
[372.308789] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[372.321649] Starting dynamic subtest: gt1
[376.615693] Dynamic subtest gt1: SUCCESS (4.301s)
[376.631123] Starting dynamic subtest: idle-gt1
[377.120905] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[377.123553] Subtest frequency: SUCCESS (7.469s)
[377.216516] [099/156] (645s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-render)
[377.326738] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-render
[377.331016] Subtest hdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[377.423764] [100/156] (645s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[377.521700] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[377.526089] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[377.633010] [101/156] (645s left) gem_exec_reloc (basic-gtt-read)
[377.695924] Subtest basic-gtt-read: SKIP (0.000s)
[377.763837] [102/156] (644s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[377.865539] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[377.869539] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[377.971397] [103/156] (644s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[378.075688] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[378.079910] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[378.159298] [104/156] (644s left) kms_color (deep-color)
[378.247663] Starting subtest: deep-color
[379.312998] Starting dynamic subtest: pipe-A-eDP-1-gamma
[380.028365] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.714s)
[380.039478] Starting dynamic subtest: pipe-A-eDP-1-degamma
[381.532749] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.501s)
[381.545089] Starting dynamic subtest: pipe-A-eDP-1-ctm
[382.946073] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.412s)
[383.732095] Starting dynamic subtest: pipe-B-eDP-1-gamma
[384.428974] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.705s)
[384.438832] Starting dynamic subtest: pipe-B-eDP-1-degamma
[385.930084] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.503s)
[385.942328] Starting dynamic subtest: pipe-B-eDP-1-ctm
[387.383664] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.449s)
[388.147638] Starting dynamic subtest: pipe-C-eDP-1-gamma
[388.818941] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.680s)
[388.829516] Starting dynamic subtest: pipe-C-eDP-1-degamma
[390.206355] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.386s)
[390.220449] Starting dynamic subtest: pipe-C-eDP-1-ctm
[391.638574] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.429s)
[392.436543] Starting dynamic subtest: pipe-D-eDP-1-gamma
[393.142234] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.715s)
[393.151965] Starting dynamic subtest: pipe-D-eDP-1-degamma
[394.581094] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.438s)
[394.592059] Starting dynamic subtest: pipe-D-eDP-1-ctm
[396.009995] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.429s)
[396.012178] Subtest deep-color: SUCCESS (17.761s)
[396.872313] [105/156] (625s left) gem_exec_schedule (preempt-queue-contexts-chain)
[396.938827] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[397.242740] [106/156] (625s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[397.338981] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[397.343418] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[397.438678] [107/156] (625s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[397.550505] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[397.554572] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[397.657891] [108/156] (625s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render)
[397.753979] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render
[397.757912] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[397.841462] [109/156] (625s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[397.945112] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[397.949013] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[398.054241] [110/156] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[398.151227] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[398.155742] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[398.242398] [111/156] (624s left) gen9_exec_parse (secure-batches)
[398.291522] Subtest secure-batches: SKIP (0.000s)
[398.360748] [112/156] (624s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[398.455172] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[398.458692] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[398.574648] [113/156] (624s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-plflip-blt)
[398.679766] Starting subtest: psrhdr-2p-primscrn-shrfb-plflip-blt
[398.683396] Subtest psrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[398.771740] [114/156] (624s left) kms_psr (psr2-sprite-plane-onoff)
[398.862355] Starting subtest: psr2-sprite-plane-onoff
[398.864339] Starting dynamic subtest: eDP-1
[400.580552] Dynamic subtest eDP-1: SUCCESS (1.717s)
[400.582997] Subtest psr2-sprite-plane-onoff: SUCCESS (1.718s)
[401.437548] [115/156] (621s left) kms_vblank (wait-busy)
[401.534867] Starting subtest: wait-busy
[401.536794] Starting dynamic subtest: pipe-A-eDP-1
[403.413454] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[403.428928] Starting dynamic subtest: pipe-D-eDP-1
[405.999957] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s)
[406.002456] Subtest wait-busy: SUCCESS (4.464s)
[406.801750] [116/156] (616s left) kms_pm_rpm (pm-tiling)
[408.827663] Starting subtest: pm-tiling
[408.832291] Subtest pm-tiling: SKIP (0.000s)
[409.218517] [117/156] (614s left) gem_exec_schedule (implicit-read-write)
[409.289172] Starting subtest: implicit-read-write
[409.291127] Starting dynamic subtest: rcs0
[409.389182] Dynamic subtest rcs0: SUCCESS (0.107s)
[409.402021] Starting dynamic subtest: vcs0
[409.477575] Dynamic subtest vcs0: SUCCESS (0.088s)
[409.491490] Starting dynamic subtest: vcs1
[409.556332] Dynamic subtest vcs1: SUCCESS (0.076s)
[409.570964] Starting dynamic subtest: vecs0
[409.628283] Dynamic subtest vecs0: SUCCESS (0.073s)
[409.640127] Starting dynamic subtest: ccs0
[409.715003] Dynamic subtest ccs0: SUCCESS (0.086s)
[409.717427] Subtest implicit-read-write: SUCCESS (0.433s)
[410.694349] [118/156] (612s left) sriov_basic (bind-unbind-vf)
[410.751310] Starting subtest: bind-unbind-vf
[410.753614] Starting dynamic subtest: vf-1
[410.828560] Dynamic subtest vf-1: FAIL (0.016s)
[410.840702] Starting dynamic subtest: vf-2
[410.914557] Dynamic subtest vf-2: FAIL (0.004s)
[410.925946] Starting dynamic subtest: vf-3
[410.998974] Dynamic subtest vf-3: FAIL (0.004s)
[411.011928] Starting dynamic subtest: vf-4
[411.082372] Dynamic subtest vf-4: FAIL (0.004s)
[411.092517] Starting dynamic subtest: vf-5
[411.163922] Dynamic subtest vf-5: FAIL (0.004s)
[411.174860] Starting dynamic subtest: vf-6
[411.249605] Dynamic subtest vf-6: FAIL (0.004s)
[411.260456] Starting dynamic subtest: vf-7
[411.335544] Dynamic subtest vf-7: FAIL (0.004s)
[411.347333] Starting dynamic subtest: vf-random
[411.420848] Dynamic subtest vf-random: FAIL (0.004s)
[411.431535] Starting dynamic subtest: vf-last
[411.506361] Dynamic subtest vf-last: FAIL (0.522s)
[411.508689] Subtest bind-unbind-vf: FAIL (0.571s)
[411.549580] [119/156] (611s left) gem_mmap_gtt (basic-small-copy-xy)
[411.603363] Subtest basic-small-copy-XY: SKIP (0.000s)
[411.667477] [120/156] (611s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[411.765674] Starting subtest: psrhdr-slowdraw
[411.769227] Subtest psrhdr-slowdraw: SKIP (0.000s)
[411.876624] [121/156] (611s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[411.976377] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[411.979608] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[412.096684] [122/156] (611s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen)
[412.188600] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen
[412.192408] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[412.287571] [123/156] (611s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[412.392111] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[412.395692] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[412.486044] [124/156] (611s left) gem_pipe_control_store_loop (fresh-buffer)
[412.537132] Starting subtest: fresh-buffer
[414.691929] Subtest fresh-buffer: SUCCESS (2.152s)
[414.832889] [125/156] (608s left) kms_flip (2x-flip-vs-fences-interruptible)
[414.934828] Starting subtest: 2x-flip-vs-fences-interruptible
[414.939242] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[415.049215] [126/156] (608s left) gem_ctx_param (set-priority-range)
[415.112720] Starting subtest: set-priority-range
[415.128365] Subtest set-priority-range: SUCCESS (0.016s)
[415.272433] [127/156] (608s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[415.358782] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[415.363061] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[415.475439] [128/156] (608s left) kms_joiner (basic-max-non-joiner)
[415.571170] Starting subtest: basic-max-non-joiner
[415.575394] Subtest basic-max-non-joiner: SKIP (0.000s)
[415.638340] [129/156] (608s left) gem_ctx_isolation (dirty-create)
[415.712169] Starting subtest: dirty-create
[415.713838] Starting dynamic subtest: rcs0
[415.883309] Dynamic subtest rcs0: SUCCESS (0.174s)
[415.895240] Starting dynamic subtest: bcs0
[416.089319] Dynamic subtest bcs0: SUCCESS (0.205s)
[416.099770] Starting dynamic subtest: vcs0
[416.301341] Dynamic subtest vcs0: SUCCESS (0.211s)
[416.310935] Starting dynamic subtest: vcs1
[417.738376] Dynamic subtest vcs1: SUCCESS (1.435s)
[417.748290] Starting dynamic subtest: vecs0
[419.802920] Dynamic subtest vecs0: SUCCESS (2.063s)
[419.815138] Starting dynamic subtest: ccs0
[421.814468] Dynamic subtest ccs0: SUCCESS (2.010s)
[421.816994] Subtest dirty-create: SUCCESS (6.104s)
[422.054107] [130/156] (601s left) gem_exec_balancer (nohangcheck)
[422.317603] Starting subtest: nohangcheck
[423.220149] Subtest nohangcheck: SUCCESS (0.901s)
[423.344570] [131/156] (600s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[423.444485] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[423.448985] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[423.556432] [132/156] (600s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[423.655046] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[423.659145] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[423.745145] [133/156] (600s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[423.844946] Starting subtest: y-tiled-32bpp-rotate-180
[423.849353] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[423.955287] [134/156] (600s left) gem_exec_params (secure-non-master)
[424.011320] Starting subtest: secure-non-master
[424.015846] Subtest secure-non-master: SKIP (0.000s)
[424.134016] [135/156] (599s left) gem_userptr_blits (unsync-unmap-cycles)
[424.207964] Subtest unsync-unmap-cycles: SKIP (0.000s)
[424.333367] [136/156] (599s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[424.434157] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[424.437655] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[424.537699] [137/156] (599s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[424.627095] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[424.630756] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[424.720286] [138/156] (599s left) kms_psr (fbc-psr-primary-render)
[424.811173] Starting subtest: fbc-psr-primary-render
[424.812964] Starting dynamic subtest: eDP-1
[424.816242] Dynamic subtest eDP-1: SKIP (0.000s)
[424.819544] Subtest fbc-psr-primary-render: SKIP (0.001s)
[424.900553] [139/156] (599s left) kms_content_protection (content-type-change)
[425.028955] Starting subtest: content-type-change
[425.032795] Subtest content-type-change: SKIP (0.000s)
[425.144413] [140/156] (599s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[425.243996] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[425.255757] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[425.346968] [141/156] (598s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[425.444451] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[425.446451] Starting dynamic subtest: pipe-A
[426.492174] Dynamic subtest pipe-A: SUCCESS (1.049s)
[426.502922] Starting dynamic subtest: pipe-B
[428.619024] Dynamic subtest pipe-B: SUCCESS (2.125s)
[428.629732] Starting dynamic subtest: pipe-C
[429.807640] Dynamic subtest pipe-C: SUCCESS (1.186s)
[429.819363] Starting dynamic subtest: pipe-D
[431.040335] Dynamic subtest pipe-D: SUCCESS (1.232s)
[431.042669] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.597s)
[432.226131] [142/156] (592s left) kms_plane (plane-position-covered)
[432.322209] Starting subtest: plane-position-covered
[432.845131] Starting dynamic subtest: pipe-A-plane-1
[434.082076] Dynamic subtest pipe-A-plane-1: SUCCESS (1.237s)
[434.094398] Starting dynamic subtest: pipe-A-plane-2
[435.321073] Dynamic subtest pipe-A-plane-2: SUCCESS (1.239s)
[435.333350] Starting dynamic subtest: pipe-A-plane-3
[436.553507] Dynamic subtest pipe-A-plane-3: SUCCESS (1.231s)
[436.564740] Starting dynamic subtest: pipe-A-plane-4
[437.784940] Dynamic subtest pipe-A-plane-4: SUCCESS (1.229s)
[437.797006] Starting dynamic subtest: pipe-A-plane-5
[437.810025] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[438.977949] Starting dynamic subtest: pipe-B-plane-1
[440.263078] Dynamic subtest pipe-B-plane-1: SUCCESS (1.292s)
[440.273568] Starting dynamic subtest: pipe-B-plane-2
[441.484810] Dynamic subtest pipe-B-plane-2: SUCCESS (1.223s)
[441.495250] Starting dynamic subtest: pipe-B-plane-3
[442.748947] Dynamic subtest pipe-B-plane-3: SUCCESS (1.262s)
[442.759658] Starting dynamic subtest: pipe-B-plane-4
[444.077082] Dynamic subtest pipe-B-plane-4: SUCCESS (1.326s)
[444.087853] Starting dynamic subtest: pipe-B-plane-5
[444.104632] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[444.106946] Subtest plane-position-covered: SUCCESS (11.779s)
[444.883152] [143/156] (579s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[444.990934] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[444.995311] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[445.093486] [144/156] (579s left) kms_frontbuffer_tracking (hdr-indfb-scaledprimary)
[445.191839] Starting subtest: hdr-indfb-scaledprimary
[445.196060] Subtest hdr-indfb-scaledprimary: SKIP (0.000s)
[445.306233] [145/156] (579s left) i915_suspend (sysfs-reader)
[445.350451] Starting subtest: sysfs-reader
[463.107050] Subtest sysfs-reader: SUCCESS (3.875s)
[463.211645] [146/156] (561s left) i915_pciid
[463.368313] [147/156] (561s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[463.464825] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[463.469066] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[463.547506] [148/156] (561s left) perf (i915-ref-count)
[463.617357] Starting subtest: i915-ref-count
[463.653738] Subtest i915-ref-count: SUCCESS (0.037s)
[463.713603] [149/156] (561s left) gem_wait (busy)
[463.775178] Starting subtest: busy
[463.777510] Starting dynamic subtest: all-engines
[465.504479] Dynamic subtest all-engines: SUCCESS (1.731s)
[465.517813] Starting dynamic subtest: rcs0
[466.047971] Dynamic subtest rcs0: SUCCESS (0.540s)
[466.059711] Starting dynamic subtest: bcs0
[466.589506] Dynamic subtest bcs0: SUCCESS (0.539s)
[466.602862] Starting dynamic subtest: vcs0
[468.512991] Dynamic subtest vcs0: SUCCESS (1.851s)
[468.528410] Starting dynamic subtest: vcs1
[470.497942] Dynamic subtest vcs1: SUCCESS (1.926s)
[470.510453] Starting dynamic subtest: vecs0
[472.481427] Dynamic subtest vecs0: SUCCESS (1.937s)
[472.495141] Starting dynamic subtest: ccs0
[473.023994] Dynamic subtest ccs0: SUCCESS (0.531s)
[473.026664] Subtest busy: SUCCESS (9.070s)
[473.243799] [150/156] (551s left) gem_fence_thrash (bo-write-verify-threaded-none)
[473.280254] Starting subtest: bo-write-verify-threaded-none
[473.296869] Subtest bo-write-verify-threaded-none: SKIP (0.013s)
[473.369157] [151/156] (551s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[473.479278] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[480.270089] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.718s)
[480.397179] [152/156] (544s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[480.450273] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[480.557354] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[480.636746] [153/156] (544s left) gem_exec_flush (basic-wb-rw-default)
[480.694796] Starting subtest: basic-wb-rw-default
[486.180150] Subtest basic-wb-rw-default: SUCCESS (5.451s)
[486.361279] [154/156] (538s left) gem_exec_params (invalid-bsd2-flag-on-render)
[486.423366] Starting subtest: invalid-bsd2-flag-on-render
[486.425852] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[486.523994] [155/156] (538s left) sw_sync (sync_merge)
[486.565113] Starting subtest: sync_merge
[486.567602] Subtest sync_merge: SUCCESS (0.000s)
[486.625975] [156/156] (538s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[486.727214] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[486.729929] Starting dynamic subtest: pipe-A-eDP-1
[488.105727] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.375s)
[488.384123] Starting dynamic subtest: pipe-B-eDP-1
[489.467455] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.089s)
[489.735970] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (3.003s)
[490.610046] Closing watchdogs
results: parsing output: 0/ for test: kms_dp_linktrain_fallback
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_exec_whisper
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: api_intel_allocator
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: gem_ctx_shared
results: parsing output: 23/ for test: gem_ctx_bad_destroy
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_ccs
results: parsing output: 34/ for test: gem_create
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_plane_alpha_blend
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: perf
results: parsing output: 42/ for test: gem_tiled_blits
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_dsc
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_chamelium_edid
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_pm_rpm
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_tiled_display
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: sysfs_heartbeat_interval
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_chamelium_hpd
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: dumb_buffer
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_chamelium_audio
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: kms_atomic_transition
results: parsing output: 90/ for test: gem_ctx_bad_destroy
results: parsing output: 91/ for test: kms_atomic
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: kms_pm_rpm
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: sriov_basic
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_pipe_control_store_loop
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_joiner
results: parsing output: 128/ for test: gem_ctx_isolation
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_big_fb
results: parsing output: 133/ for test: gem_exec_params
results: parsing output: 134/ for test: gem_userptr_blits
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_psr
results: parsing output: 138/ for test: kms_content_protection
results: parsing output: 139/ for test: kms_flip
results: parsing output: 140/ for test: kms_plane_scaling
results: parsing output: 141/ for test: kms_plane
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: i915_suspend
results: parsing output: 145/ for test: i915_pciid
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: perf
results: parsing output: 148/ for test: gem_wait
results: parsing output: 149/ for test: gem_fence_thrash
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: syncobj_timeline
results: parsing output: 152/ for test: gem_exec_flush
results: parsing output: 153/ for test: gem_exec_params
results: parsing output: 154/ for test: sw_sync
results: parsing output: 155/ for test: kms_atomic_transition
Done.