[58.456128] Initializing watchdogs
[58.456175]   /dev/watchdog0
[58.471389] [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.477940] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.480029] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.481909] [001/132] (960s left) kms_psr (fbc-psr-sprite-plane-onoff)
[58.585238] Starting subtest: fbc-psr-sprite-plane-onoff
[58.586141] Starting dynamic subtest: eDP-1
[58.587826] Dynamic subtest eDP-1: SKIP (0.000s)
[58.589517] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[58.648441] [002/132] (960s left) syncobj_wait (reset-multiple-signaled)
[58.700368] Starting subtest: reset-multiple-signaled
[58.701453] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[58.817426] [003/132] (960s left) perf_pmu (invalid-init)
[58.859848] Starting subtest: invalid-init
[58.860879] Subtest invalid-init: SUCCESS (0.000s)
[58.949442] [004/132] (960s left) kms_legacy_colorkey (invalid-plane)
[59.034130] Starting subtest: invalid-plane
[59.035108] Starting dynamic subtest: zero-id
[59.035954] Dynamic subtest zero-id: SUCCESS (0.000s)
[59.041903] Starting dynamic subtest: outrange-id
[59.042958] Dynamic subtest outrange-id: SUCCESS (0.000s)
[59.043869] Subtest invalid-plane: SUCCESS (0.000s)
[59.111445] [005/132] (959s left) gem_workarounds (basic-read-fd)
[59.174204] Starting subtest: basic-read-fd
[59.186381] Subtest basic-read-fd: SUCCESS (0.013s)
[59.284611] [006/132] (959s left) perf_pmu (enable-race)
[59.320472] Starting subtest: enable-race
[59.321498] Starting dynamic subtest: rcs0
[72.087383] Dynamic subtest rcs0: SUCCESS (12.756s)
[72.094148] Starting dynamic subtest: bcs0
[84.827824] Dynamic subtest bcs0: SUCCESS (12.743s)
[84.834794] Starting dynamic subtest: vcs0
[100.958197] Dynamic subtest vcs0: SUCCESS (16.135s)
[100.964978] Starting dynamic subtest: vcs1
[116.893577] Dynamic subtest vcs1: SUCCESS (15.936s)
[116.902098] Starting dynamic subtest: vecs0
[132.895825] Dynamic subtest vecs0: SUCCESS (16.001s)
[132.903655] Starting dynamic subtest: ccs0
[145.655218] Dynamic subtest ccs0: SUCCESS (12.748s)
[145.656914] Subtest enable-race: SUCCESS (86.326s)
[145.735093] [007/132] (873s left) gem_ctx_exec (basic)
[145.782801] Starting subtest: basic
[145.788619] Subtest basic: SUCCESS (0.008s)
[145.911337] [008/132] (873s left) kms_getfb (getfb2-accept-nv12)
[146.011860] Starting subtest: getfb2-accept-nv12
[146.013635] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[146.128921] [009/132] (873s left) gem_exec_balancer (indices)
[146.196104] Starting subtest: indices
[148.860968] Subtest indices: SUCCESS (2.653s)
[149.129577] [010/132] (870s left) perf (per-context-mode-unprivileged)
[149.239867] Starting subtest: per-context-mode-unprivileged
[149.241714] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[149.273590] [011/132] (870s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[149.359970] Starting subtest: plane-ctm3x4-lut1d
[149.530389] Starting dynamic subtest: pipe-A-plane-0
[149.707866] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[149.715171] Starting dynamic subtest: pipe-A-plane-1
[149.897328] Dynamic subtest pipe-A-plane-1: SUCCESS (0.189s)
[149.903850] Starting dynamic subtest: pipe-A-plane-2
[150.075654] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[151.246075] Starting dynamic subtest: pipe-B-plane-0
[151.439994] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[151.447484] Starting dynamic subtest: pipe-B-plane-1
[151.606939] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[151.613627] Starting dynamic subtest: pipe-B-plane-2
[151.773529] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[152.949562] Starting dynamic subtest: pipe-C-plane-0
[153.099288] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s)
[153.107616] Starting dynamic subtest: pipe-C-plane-1
[153.254788] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[153.263302] Starting dynamic subtest: pipe-C-plane-2
[153.399401] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[154.614627] Starting dynamic subtest: pipe-D-plane-0
[154.775060] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[154.782871] Starting dynamic subtest: pipe-D-plane-1
[154.930772] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[154.938783] Starting dynamic subtest: pipe-D-plane-2
[155.097443] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[155.384528] Subtest plane-ctm3x4-lut1d: SUCCESS (6.022s)
[156.262389] [012/132] (863s left) gem_blits (basic)
[156.319969] Starting subtest: basic
[157.739992] Subtest basic: SUCCESS (1.410s)
[157.869810] [013/132] (861s left) gem_ccs (suspend-resume)
[157.927845] Starting subtest: suspend-resume
[157.929959] Subtest suspend-resume: SKIP (0.000s)
[158.012315] [014/132] (861s left) gem_mmap_gtt (medium-copy-odd)
[158.076178] Subtest medium-copy-odd: SKIP (0.000s)
[158.136306] [015/132] (861s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[158.231733] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[158.233379] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[158.302246] [016/132] (861s left) gem_flink_race (flink_close)
[158.328070] Starting subtest: flink_close
[163.428929] Subtest flink_close: SUCCESS (5.097s)
[163.495237] [017/132] (855s left) gem_ctx_isolation (preservation-reset)
[163.670368] Starting subtest: preservation-reset
[163.671415] Starting dynamic subtest: rcs0
[163.994624] Dynamic subtest rcs0: SUCCESS (0.333s)
[164.004090] Starting dynamic subtest: bcs0
[164.390568] Dynamic subtest bcs0: SUCCESS (0.396s)
[164.399642] Starting dynamic subtest: vcs0
[164.747771] Dynamic subtest vcs0: SUCCESS (0.357s)
[164.756829] Starting dynamic subtest: vcs1
[166.219356] Dynamic subtest vcs1: SUCCESS (1.470s)
[166.228829] Starting dynamic subtest: vecs0
[168.198895] Dynamic subtest vecs0: SUCCESS (1.978s)
[168.206042] Starting dynamic subtest: ccs0
[170.260695] Dynamic subtest ccs0: SUCCESS (2.061s)
[170.262492] Subtest preservation-reset: SUCCESS (6.599s)
[170.371862] [018/132] (849s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[170.468991] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[171.161272] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[171.324036] [019/132] (848s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[171.419840] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[171.421693] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[171.503682] [020/132] (848s left) gem_partial_pwrite_pread (reads)
[171.558549] Subtest reads: SKIP (0.000s)
[171.621181] [021/132] (847s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[171.705376] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[171.707142] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[171.790290] [022/132] (847s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[171.885197] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[179.083587] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.198s)
[179.189846] [023/132] (840s left) gem_exec_capture (capture-invisible)
[179.247915] Starting subtest: capture-invisible
[179.249131] Starting dynamic subtest: smem0
[179.250958] Dynamic subtest smem0: SKIP (0.000s)
[179.252840] Subtest capture-invisible: SKIP (0.000s)
[179.367525] [024/132] (840s left) kms_psr (fbc-psr2-sprite-blt)
[179.466195] Starting subtest: fbc-psr2-sprite-blt
[179.467104] Starting dynamic subtest: eDP-1
[179.468954] Dynamic subtest eDP-1: SKIP (0.000s)
[179.471990] Subtest fbc-psr2-sprite-blt: SKIP (0.002s)
[179.550449] [025/132] (840s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[179.603054] Subtest tiled-to-untiled: SKIP (0.000s)
[179.664123] [026/132] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[179.748068] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[179.749875] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[179.846846] [027/132] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[179.932923] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[179.934779] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[180.036838] [028/132] (839s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[180.125051] Starting subtest: 2x-plain-flip-ts-check-interruptible
[180.136547] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[180.201707] [029/132] (839s left) sw_sync (sync_busy_fork_unixsocket)
[180.234127] Starting subtest: sync_busy_fork_unixsocket
[180.240629] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[180.290807] [030/132] (839s left) gem_fenced_exec_thrash (2-spare-fences)
[180.339085] Subtest 2-spare-fences: SKIP (0.000s)
[180.400436] [031/132] (839s left) kms_addfb_basic (small-bo)
[180.490044] Starting subtest: small-bo
[180.491020] Subtest small-bo: SUCCESS (0.000s)
[180.584577] [032/132] (839s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[180.674375] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[188.135252] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.461s)
[188.253388] [033/132] (831s left) kms_sequence (get-forked)
[188.353342] Starting subtest: get-forked
[188.354336] Starting dynamic subtest: pipe-A-eDP-1
[190.238664] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[190.251342] Starting dynamic subtest: pipe-B-eDP-1
[192.762915] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.523s)
[192.770172] Starting dynamic subtest: pipe-C-eDP-1
[195.274523] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.511s)
[195.282028] Starting dynamic subtest: pipe-D-eDP-1
[197.820340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[197.821246] Subtest get-forked: SUCCESS (9.466s)
[198.645906] [034/132] (821s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[198.700339] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[198.701291] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[198.803253] [035/132] (821s left) gem_exec_flush (basic-uc-prw-default)
[198.859182] Starting subtest: basic-uc-prw-default
[204.349270] Subtest basic-uc-prw-default: SUCCESS (5.489s)
[204.540830] [036/132] (815s left) kms_addfb_basic (size-max)
[204.630461] Starting subtest: size-max
[204.631414] Subtest size-max: SUCCESS (0.000s)
[204.714777] [037/132] (815s left) kms_pm_rpm (cursor)
[206.230757] Starting subtest: cursor
[206.233748] Subtest cursor: SKIP (0.000s)
[206.972320] [038/132] (813s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[207.061066] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[207.063084] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[207.151591] [039/132] (813s left) i915_pm_sseu (full-enable)
[207.196509] Subtest full-enable: SKIP (0.000s)
[207.283067] [040/132] (812s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[207.373767] Starting subtest: extended-modeset-hang-newfb-with-reset
[207.374705] Starting dynamic subtest: pipe-A
[222.971341] Dynamic subtest pipe-A: SUCCESS (15.598s)
[222.979136] Starting dynamic subtest: pipe-D
[238.772067] Dynamic subtest pipe-D: SUCCESS (15.797s)
[238.772962] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.399s)
[239.559995] [041/132] (780s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[239.647610] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[239.648565] Starting dynamic subtest: pipe-A-eDP-1
[239.657232] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[239.664971] Starting dynamic subtest: pipe-B-eDP-1
[239.674326] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.681067] Starting dynamic subtest: pipe-C-eDP-1
[239.689398] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.696069] Starting dynamic subtest: pipe-D-eDP-1
[239.704899] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[239.706647] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[241.828296] [042/132] (778s left) gem_exec_schedule (preempt-queue-contexts)
[241.899024] Subtest preempt-queue-contexts: SKIP (0.000s)
[242.186578] [043/132] (778s left) gem_lmem_swapping (verify-random)
[242.220886] Subtest verify-random: SKIP (0.000s)
[242.261207] [044/132] (778s left) i915_pm_rps (min-max-config-idle)
[242.315569] Starting subtest: min-max-config-idle
[242.317234] Subtest min-max-config-idle: SKIP (0.001s)
[242.425203] [045/132] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[242.524135] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[242.525683] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[242.617634] [046/132] (777s left) gem_pxp (protected-raw-src-copy-not-readible)
[242.726747] Starting subtest: protected-raw-src-copy-not-readible
[242.786030] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[242.909502] [047/132] (777s left) kms_addfb_basic (basic-x-tiled-legacy)
[242.960184] Starting subtest: basic-x-tiled-legacy
[242.961885] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[243.092906] [048/132] (777s left) kms_draw_crc (draw-method-mmap-wc)
[243.173203] Starting subtest: draw-method-mmap-wc
[243.174125] Starting dynamic subtest: xrgb8888-untiled
[243.417599] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[243.426754] Starting dynamic subtest: rgb565-untiled
[243.639991] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[243.648502] Starting dynamic subtest: xrgb2101010-untiled
[243.862134] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[243.869211] Starting dynamic subtest: xbgr16161616f-untiled
[244.084173] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[244.092514] Starting dynamic subtest: xrgb8888-xtiled
[244.228509] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.142s)
[244.235091] Starting dynamic subtest: rgb565-xtiled
[244.361904] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[244.368541] Starting dynamic subtest: xrgb2101010-xtiled
[244.495416] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[244.504514] Starting dynamic subtest: xbgr16161616f-xtiled
[244.628864] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[244.636693] Starting dynamic subtest: xrgb8888-4tiled
[244.795374] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.165s)
[244.802186] Starting dynamic subtest: rgb565-4tiled
[244.950848] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[244.958874] Starting dynamic subtest: xrgb2101010-4tiled
[245.106937] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.154s)
[245.118890] Starting dynamic subtest: xbgr16161616f-4tiled
[245.295630] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.187s)
[245.296562] Subtest draw-method-mmap-wc: SUCCESS (2.123s)
[245.395808] [049/132] (775s left) syncobj_timeline (device-submit-unordered)
[245.441543] Starting subtest: device-submit-unordered
[245.442518] Subtest device-submit-unordered: SUCCESS (0.001s)
[245.524154] [050/132] (775s left) gem_gpgpu_fill (basic)
[245.582964] Starting subtest: basic
[245.584104] Starting dynamic subtest: smem
[245.590343] Dynamic subtest smem: SUCCESS (0.008s)
[245.591229] Subtest basic: SUCCESS (0.008s)
[245.721739] [051/132] (774s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[245.814216] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[245.815994] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[245.907447] [052/132] (774s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[246.001244] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[246.002908] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[246.093635] [053/132] (774s left) kms_chamelium_edid (dp-edid-read)
[246.489871] Subtest dp-edid-read: SKIP (0.000s)
[247.328745] [054/132] (773s left) gem_exec_reloc (basic-cpu-wc)
[247.386335] Subtest basic-cpu-wc: SKIP (0.000s)
[247.453566] [055/132] (773s left) kms_scaling_modes (scaling-mode-center)
[247.543330] Starting subtest: scaling-mode-center
[247.544638] Starting dynamic subtest: pipe-A-eDP-1
[247.647377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.103s)
[247.662501] Starting dynamic subtest: pipe-B-eDP-1
[248.788096] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.138s)
[248.797985] Starting dynamic subtest: pipe-C-eDP-1
[249.898222] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[249.907507] Starting dynamic subtest: pipe-D-eDP-1
[251.027344] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[251.028871] Subtest scaling-mode-center: SUCCESS (3.484s)
[252.184604] [056/132] (768s left) syncobj_wait (wait-for-submit-complex)
[252.239911] Starting subtest: wait-for-submit-complex
[252.301911] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[252.384933] [057/132] (768s left) kms_chamelium_hpd (vga-hpd)
[252.770541] Subtest vga-hpd: SKIP (0.000s)
[253.583784] [058/132] (767s left) i915_drm_fdinfo (all-busy-check-all)
[253.628290] Starting subtest: all-busy-check-all
[253.633526] Subtest all-busy-check-all: SKIP (0.004s)
[253.700787] [059/132] (767s left) gem_exec_fence (syncobj-wait)
[254.191879] Starting subtest: syncobj-wait
[255.915274] Subtest syncobj-wait: SUCCESS (1.713s)
[256.232719] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[256.234600] [060/132] (764s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[256.356881] Starting subtest: cursorA-vs-flipB-atomic-transitions
[256.358632] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[256.496533] [061/132] (764s left) syncobj_wait (invalid-reset-zero-handles)
[256.543389] Starting subtest: invalid-reset-zero-handles
[256.544347] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[256.626728] [062/132] (764s left) api_intel_bb (object-reloc-purge-cache)
[256.672206] Starting subtest: object-reloc-purge-cache
[256.675316] Subtest object-reloc-purge-cache: SKIP (0.003s)
[256.782823] [063/132] (764s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[256.826210] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[256.930380] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[257.000153] [064/132] (763s left) kms_flip (2x-plain-flip-ts-check)
[257.097546] Starting subtest: 2x-plain-flip-ts-check
[257.108799] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[257.218374] [065/132] (763s left) gen7_exec_parse (basic-allocation)
[257.273710] Subtest basic-allocation: SKIP (0.000s)
[257.334965] [066/132] (763s left) kms_async_flips (test-cursor-atomic)
[257.419535] Starting subtest: test-cursor-atomic
[257.805779] Starting dynamic subtest: pipe-A-eDP-1
[258.612634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[259.006048] Starting dynamic subtest: pipe-B-eDP-1
[259.749595] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.750s)
[260.137492] Starting dynamic subtest: pipe-C-eDP-1
[260.888340] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.757s)
[261.263516] Starting dynamic subtest: pipe-D-eDP-1
[262.027860] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[262.028722] Subtest test-cursor-atomic: SUCCESS (4.608s)
[263.185536] [067/132] (757s left) gen7_exec_parse (basic-offset)
[263.249136] Subtest basic-offset: SKIP (0.000s)
[263.301628] [068/132] (757s left) kms_chamelium_audio (hdmi-audio)
[263.687838] Subtest hdmi-audio: SKIP (0.000s)
[264.501397] [069/132] (756s left) gem_exec_whisper (basic-contexts-forked-all)
[264.568346] Starting subtest: basic-contexts-forked-all
[286.109830] Subtest basic-contexts-forked-all: SUCCESS (21.529s)
[286.293829] [070/132] (734s left) kms_properties (invalid-properties-legacy)
[286.394105] Starting subtest: invalid-properties-legacy
[286.516911] Subtest invalid-properties-legacy: SUCCESS (0.113s)
[286.586660] [071/132] (734s left) kms_flip (flip-vs-dpms-on-nop)
[286.682854] Starting subtest: flip-vs-dpms-on-nop
[286.685144] Starting dynamic subtest: A-eDP1
[288.515840] Dynamic subtest A-eDP1: SUCCESS (1.831s)
[288.526476] Starting dynamic subtest: B-eDP1
[290.353334] Dynamic subtest B-eDP1: SUCCESS (1.836s)
[290.365125] Starting dynamic subtest: C-eDP1
[292.180353] Dynamic subtest C-eDP1: SUCCESS (1.824s)
[292.189172] Starting dynamic subtest: D-eDP1
[294.001541] Dynamic subtest D-eDP1: SUCCESS (1.818s)
[294.002434] Subtest flip-vs-dpms-on-nop: SUCCESS (7.319s)
[295.195417] [072/132] (726s left) gem_pxp (create-regular-buffer)
[295.248170] Starting subtest: create-regular-buffer
[295.249085] Subtest create-regular-buffer: SUCCESS (0.000s)
[295.336089] [073/132] (725s left) gem_mmap_gtt (big-bo-tiledy)
[295.381719] Subtest big-bo-tiledY: SKIP (0.000s)
[295.431223] [074/132] (725s left) kms_psr (psr2-cursor-blt)
[295.527242] Starting subtest: psr2-cursor-blt
[295.528131] Starting dynamic subtest: eDP-1
[297.255164] Dynamic subtest eDP-1: SUCCESS (1.728s)
[297.256044] Subtest psr2-cursor-blt: SUCCESS (1.729s)
[298.054161] [075/132] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[298.149390] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[304.763236] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.615s)
[304.868567] [076/132] (716s left) kms_cursor_edge_walk (128x128-top-edge)
[304.953275] Starting subtest: 128x128-top-edge
[304.954113] Starting dynamic subtest: pipe-A-eDP-1
[308.382297] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s)
[308.391434] Starting dynamic subtest: pipe-D-eDP-1
[311.495810] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[311.496639] Subtest 128x128-top-edge: SUCCESS (6.542s)
[312.309863] [077/132] (709s left) kms_big_fb (4-tiled-addfb-size-overflow)
[312.407653] Starting subtest: 4-tiled-addfb-size-overflow
[312.408536] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[312.502923] [078/132] (708s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[312.592824] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[312.594600] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[312.681494] [079/132] (708s left) kms_plane (pixel-format-4-tiled-modifier)
[312.760433] Starting subtest: pixel-format-4-tiled-modifier
[312.788167] Starting dynamic subtest: pipe-A-plane-0
[313.454536] Dynamic subtest pipe-A-plane-0: SUCCESS (0.666s)
[313.462256] Starting dynamic subtest: pipe-A-plane-3
[313.865712] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[313.873271] Starting dynamic subtest: pipe-A-plane-5
[313.875045] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[314.993683] Starting dynamic subtest: pipe-B-plane-0
[315.698592] Dynamic subtest pipe-B-plane-0: SUCCESS (0.711s)
[315.706536] Starting dynamic subtest: pipe-B-plane-3
[316.142021] Dynamic subtest pipe-B-plane-3: SUCCESS (0.443s)
[316.149910] Starting dynamic subtest: pipe-B-plane-5
[316.151664] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[316.451263] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.691s)
[317.275036] [080/132] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[317.373933] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[317.375515] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[317.466833] [081/132] (704s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[317.558884] Starting subtest: fbcpsr-rgb565-draw-pwrite
[324.744939] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.186s)
[324.854590] [082/132] (696s left) kms_flip (flip-vs-rmfb-interruptible)
[324.944718] Starting subtest: flip-vs-rmfb-interruptible
[324.947062] Starting dynamic subtest: A-eDP1
[333.597105] Dynamic subtest A-eDP1: SUCCESS (8.650s)
[333.607199] Starting dynamic subtest: B-eDP1
[342.231343] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[342.241766] Starting dynamic subtest: C-eDP1
[350.850258] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[350.860080] Starting dynamic subtest: D-eDP1
[359.476509] Dynamic subtest D-eDP1: SUCCESS (8.623s)
[359.480446] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.534s)
[360.652109] [083/132] (661s left) kms_invalid_mode (zero-vdisplay)
[360.743829] Starting subtest: zero-vdisplay
[360.744666] Starting dynamic subtest: pipe-A-eDP-1
[361.028219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[361.037374] Starting dynamic subtest: pipe-B-eDP-1
[361.038229] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[361.060052] Starting dynamic subtest: pipe-C-eDP-1
[361.060942] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[361.068400] Starting dynamic subtest: pipe-D-eDP-1
[361.069613] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[361.070738] Subtest zero-vdisplay: SUCCESS (0.290s)
[361.878107] [084/132] (659s left) kms_pm_rpm (modeset-non-lpsp-stress)
[364.098381] Starting subtest: modeset-non-lpsp-stress
[365.267322] Subtest modeset-non-lpsp-stress: SKIP (1.170s)
[365.634467] [085/132] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[365.718262] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[365.719798] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[365.809530] [086/132] (655s left) kms_plane_lowres (tiling-4)
[365.900955] Starting subtest: tiling-4
[365.901969] Starting dynamic subtest: pipe-A-eDP-1
[365.903594] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[366.196053] Starting dynamic subtest: pipe-B-eDP-1
[366.205227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[366.212815] Starting dynamic subtest: pipe-C-eDP-1
[366.214620] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[366.222187] Starting dynamic subtest: pipe-D-eDP-1
[366.223841] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[366.225559] Subtest tiling-4: SKIP (0.295s)
[367.071494] [087/132] (654s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[367.153389] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[367.154368] Starting dynamic subtest: pipe-A-default-mode
[369.890349] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[369.891205] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.737s)
[370.753291] [088/132] (651s left) kms_psr (fbc-pr-primary-blt)
[370.833271] Starting subtest: fbc-pr-primary-blt
[370.834915] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[370.902916] [089/132] (650s left) kms_dirtyfb (default-dirtyfb-ioctl)
[370.985174] Starting subtest: default-dirtyfb-ioctl
[370.986017] Starting dynamic subtest: A-eDP-1
[372.622728] Dynamic subtest A-eDP-1: SUCCESS (1.636s)
[372.623691] Subtest default-dirtyfb-ioctl: SUCCESS (1.637s)
[373.490540] [090/132] (648s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[373.578424] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[380.416240] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.839s)
[380.563960] [091/132] (641s left) i915_query (query-topology-known-pci-ids)
[380.622321] Starting subtest: query-topology-known-pci-ids
[380.624253] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[380.737739] [092/132] (641s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[380.824471] Starting subtest: compare-crc-sanitycheck-xr24
[380.825363] Starting dynamic subtest: pipe-A-eDP-1
[381.476189] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.652s)
[381.484927] Starting dynamic subtest: pipe-B-eDP-1
[382.829036] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.350s)
[382.839342] Starting dynamic subtest: pipe-C-eDP-1
[384.086610] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.256s)
[384.096620] Starting dynamic subtest: pipe-D-eDP-1
[385.313414] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[385.314302] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.489s)
[386.129955] [093/132] (635s left) gem_mmap_gtt (hang-user)
[386.178325] Subtest hang-user: SKIP (0.000s)
[386.236490] [094/132] (635s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[386.320367] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[386.321999] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[387.456256] [095/132] (634s left) i915_hangman (gt-engine-hang)
[387.521242] Starting subtest: gt-engine-hang
[387.522188] Starting dynamic subtest: rcs0
[388.862358] Dynamic subtest rcs0: SUCCESS (1.331s)
[388.873521] Starting dynamic subtest: bcs0
[390.908422] Dynamic subtest bcs0: SUCCESS (2.043s)
[390.918765] Starting dynamic subtest: vcs0
[392.893385] Dynamic subtest vcs0: SUCCESS (1.982s)
[392.903803] Starting dynamic subtest: vcs1
[394.875932] Dynamic subtest vcs1: SUCCESS (1.979s)
[394.885616] Starting dynamic subtest: vecs0
[396.925359] Dynamic subtest vecs0: SUCCESS (2.046s)
[396.935228] Starting dynamic subtest: ccs0
[398.908536] Dynamic subtest ccs0: SUCCESS (1.980s)
[398.909826] Subtest gt-engine-hang: SUCCESS (11.379s)
[399.065909] [096/132] (623s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[399.187022] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[399.190099] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[399.335414] [097/132] (622s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[399.935586] Starting subtest: syncobj-stationary-timeline-chain-engines
[400.054836] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.119s)
[400.998899] [098/132] (621s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[401.094838] Starting subtest: fbc-pr-cursor-plane-update-sf
[401.096493] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[401.161693] [099/132] (621s left) gem_ctx_shared (q-smoketest-all)
[401.212166] Starting subtest: Q-smoketest-all
[433.587918] Subtest Q-smoketest-all: SUCCESS (32.346s)
[435.017910] [100/132] (587s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[435.124015] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[435.124921] Starting dynamic subtest: pipe-A-eDP-1
[435.144963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[435.154088] Starting dynamic subtest: pipe-B-eDP-1
[435.166410] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[435.175708] Starting dynamic subtest: pipe-C-eDP-1
[435.187115] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[435.198825] Starting dynamic subtest: pipe-D-eDP-1
[435.209401] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[435.210551] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s)
[437.523499] [101/132] (584s left) perf_pmu (busy)
[437.564088] Starting subtest: busy
[437.565036] Starting dynamic subtest: rcs0
[438.129721] Dynamic subtest rcs0: SUCCESS (0.565s)
[438.140643] Starting dynamic subtest: bcs0
[438.689245] Dynamic subtest bcs0: SUCCESS (0.557s)
[438.699761] Starting dynamic subtest: vcs0
[439.902864] Dynamic subtest vcs0: SUCCESS (1.201s)
[439.913482] Starting dynamic subtest: vcs1
[441.886834] Dynamic subtest vcs1: SUCCESS (1.981s)
[441.899810] Starting dynamic subtest: vecs0
[443.934864] Dynamic subtest vecs0: SUCCESS (2.045s)
[443.944555] Starting dynamic subtest: ccs0
[444.492928] Dynamic subtest ccs0: SUCCESS (0.566s)
[444.496575] Subtest busy: SUCCESS (6.930s)
[444.610780] [102/132] (577s left) kms_cursor_crc (cursor-random-32x10)
[444.780820] Starting subtest: cursor-random-32x10
[444.826960] Subtest cursor-random-32x10: SKIP (0.045s)
[445.084335] [103/132] (577s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[445.175720] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[445.177419] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[445.264402] [104/132] (577s left) gem_spin_batch (legacy-resubmit-new)
[445.319193] Starting subtest: legacy-resubmit-new
[445.320076] Starting dynamic subtest: default
[445.330044] Dynamic subtest default: SUCCESS (0.010s)
[445.340250] Starting dynamic subtest: render
[445.341068] Dynamic subtest render: SUCCESS (0.003s)
[445.348596] Starting dynamic subtest: bsd
[445.349516] Dynamic subtest bsd: SUCCESS (0.006s)
[445.356980] Starting dynamic subtest: bsd1
[445.357855] Dynamic subtest bsd1: SUCCESS (0.003s)
[445.365371] Starting dynamic subtest: bsd2
[445.366223] Dynamic subtest bsd2: SUCCESS (0.003s)
[445.373517] Starting dynamic subtest: blt
[445.374470] Dynamic subtest blt: SUCCESS (0.003s)
[445.381774] Starting dynamic subtest: vebox
[445.382571] Dynamic subtest vebox: SUCCESS (0.004s)
[445.383403] Subtest legacy-resubmit-new: SUCCESS (0.041s)
[446.967937] [105/132] (575s left) perf (disabled-read-error)
[447.065074] Starting subtest: disabled-read-error
[447.086695] Subtest disabled-read-error: SUCCESS (0.022s)
[447.122533] [106/132] (575s left) gem_fenced_exec_thrash (no-spare-fences)
[447.172112] Subtest no-spare-fences: SKIP (0.000s)
[447.236167] [107/132] (575s left) prime_mmap (test_aperture_limit)
[447.286803] Starting subtest: test_aperture_limit
[447.287766] Starting dynamic subtest: test_aperture_limit-smem
[447.295848] Dynamic subtest test_aperture_limit-smem: SKIP (0.009s)
[447.297915] Subtest test_aperture_limit: SKIP (0.010s)
[447.363897] [108/132] (575s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[447.455965] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[447.456997] Starting dynamic subtest: pipe-A
[447.851817] Dynamic subtest pipe-A: SUCCESS (0.397s)
[447.859863] Starting dynamic subtest: pipe-B
[449.249117] Dynamic subtest pipe-B: SUCCESS (1.396s)
[449.258531] Starting dynamic subtest: pipe-C
[450.708805] Dynamic subtest pipe-C: SUCCESS (1.459s)
[450.716706] Starting dynamic subtest: pipe-D
[452.104193] Dynamic subtest pipe-D: SUCCESS (1.394s)
[452.105052] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.650s)
[453.258823] [109/132] (569s left) kms_psr (psr2-suspend)
[453.347584] Starting subtest: psr2-suspend
[453.348527] Starting dynamic subtest: eDP-1
[471.441357] Dynamic subtest eDP-1: SUCCESS (3.383s)
[471.442346] Subtest psr2-suspend: SUCCESS (3.384s)
[479.301667] [110/132] (550s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[479.394632] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[479.395421] Starting dynamic subtest: pipe-A-eDP-1
[479.403685] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[479.412348] Starting dynamic subtest: pipe-B-eDP-1
[479.420836] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[479.429191] Starting dynamic subtest: pipe-C-eDP-1
[479.437404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[479.445562] Starting dynamic subtest: pipe-D-eDP-1
[479.453853] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[479.455525] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[481.689211] [111/132] (548s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[481.737501] Starting subtest: single-wait-all-for-submit-available-signaled
[481.738262] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[481.831506] [112/132] (547s left) dmabuf_sync_file (export-basic)
[481.874155] Starting subtest: export-basic
[481.875178] Subtest export-basic: SUCCESS (0.001s)
[481.926436] [113/132] (547s left) kms_cursor_crc (cursor-onscreen-32x32)
[482.065613] Starting subtest: cursor-onscreen-32x32
[482.112344] Subtest cursor-onscreen-32x32: SKIP (0.044s)
[482.379402] [114/132] (547s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[482.480247] Starting subtest: x-tiled-32bpp-rotate-180
[483.971154] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.491s)
[484.100663] [115/132] (545s left) gem_linear_blits (interruptible)
[484.591854] Starting subtest: interruptible
[488.871882] Subtest interruptible: SUCCESS (4.271s)
[489.031361] [116/132] (540s left) gem_exec_reloc (basic-wc-read)
[489.138554] Subtest basic-wc-read: SKIP (0.000s)
[489.201583] [117/132] (540s left) gem_ctx_persistence (legacy-engines-persistence)
[489.259670] Starting subtest: legacy-engines-persistence
[489.260457] Starting dynamic subtest: render
[490.061954] Dynamic subtest render: SUCCESS (0.801s)
[490.075775] Starting dynamic subtest: bsd1
[490.823756] Dynamic subtest bsd1: SUCCESS (0.759s)
[490.837021] Starting dynamic subtest: bsd2
[491.577110] Dynamic subtest bsd2: SUCCESS (0.750s)
[491.589331] Starting dynamic subtest: blt
[492.429736] Dynamic subtest blt: SUCCESS (0.850s)
[492.442512] Starting dynamic subtest: vebox
[493.175255] Dynamic subtest vebox: SUCCESS (0.742s)
[493.176644] Subtest legacy-engines-persistence: SUCCESS (3.916s)
[493.311406] [118/132] (536s left) sriov_basic (bind-unbind-vf)
[493.376939] Starting subtest: bind-unbind-vf
[493.378076] Starting dynamic subtest: vf-1
[493.412942] Dynamic subtest vf-1: FAIL (0.017s)
[493.425004] Starting dynamic subtest: vf-2
[493.452662] Dynamic subtest vf-2: FAIL (0.004s)
[493.462760] Starting dynamic subtest: vf-3
[493.498985] Dynamic subtest vf-3: FAIL (0.004s)
[493.508049] Starting dynamic subtest: vf-4
[493.544421] Dynamic subtest vf-4: FAIL (0.004s)
[493.553546] Starting dynamic subtest: vf-5
[493.580727] Dynamic subtest vf-5: FAIL (0.004s)
[493.589139] Starting dynamic subtest: vf-6
[493.615857] Dynamic subtest vf-6: FAIL (0.004s)
[493.624238] Starting dynamic subtest: vf-7
[493.651152] Dynamic subtest vf-7: FAIL (0.004s)
[493.660171] Starting dynamic subtest: vf-random
[493.685779] Dynamic subtest vf-random: FAIL (0.004s)
[493.694095] Starting dynamic subtest: vf-last
[493.719856] Dynamic subtest vf-last: FAIL (0.004s)
[493.720646] Subtest bind-unbind-vf: FAIL (0.053s)
[493.751410] [119/132] (536s left) kms_vrr (flip-basic-fastset)
[493.841619] Starting subtest: flip-basic-fastset
[493.844292] Subtest flip-basic-fastset: SKIP (0.000s)
[493.910354] [120/132] (536s left) prime_vgem (fence-flip-hang)
[493.965153] Subtest fence-flip-hang: SKIP (0.000s)
[494.057330] [121/132] (536s left) gem_exec_fence (basic-busy-all)
[494.122551] Starting subtest: basic-busy-all
[494.212624] Subtest basic-busy-all: SUCCESS (0.090s)
[495.699143] [122/132] (534s left) syncobj_timeline (invalid-transfer-illegal-handle)
[495.750424] Starting subtest: invalid-transfer-illegal-handle
[495.751381] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[495.820593] [123/132] (534s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[495.917993] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[495.919725] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[496.008902] [124/132] (534s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[496.158982] Starting subtest: dp-mst-type-1-suspend-resume
[496.161306] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[496.275629] [125/132] (533s left) api_intel_bb (bb-with-allocator)
[496.324812] Starting subtest: bb-with-allocator
[496.329263] Subtest bb-with-allocator: SUCCESS (0.006s)
[496.436184] [126/132] (533s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[496.529542] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[496.531250] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[496.627933] [127/132] (533s left) sysfs_timeslice_duration (duration)
[496.690265] Starting subtest: duration
[496.691344] Starting dynamic subtest: vecs0
[510.515195] Dynamic subtest vecs0: SUCCESS (13.814s)
[510.526879] Starting dynamic subtest: ccs0
[523.659135] Dynamic subtest ccs0: SUCCESS (13.132s)
[523.669409] Starting dynamic subtest: vcs0
[537.521529] Dynamic subtest vcs0: SUCCESS (13.867s)
[537.533019] Starting dynamic subtest: bcs0
[550.661147] Dynamic subtest bcs0: SUCCESS (13.134s)
[550.672810] Starting dynamic subtest: rcs0
[563.795094] Dynamic subtest rcs0: SUCCESS (13.142s)
[563.809168] Starting dynamic subtest: vcs1
[578.545085] Dynamic subtest vcs1: SUCCESS (14.738s)
[578.546348] Subtest duration: SUCCESS (81.843s)
[578.623783] [128/132] (451s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[578.717078] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[578.718034] Starting dynamic subtest: pipe-A
[578.783344] Dynamic subtest pipe-A: SUCCESS (0.066s)
[578.792616] Starting dynamic subtest: pipe-B
[579.912440] Dynamic subtest pipe-B: SUCCESS (1.128s)
[579.929508] Starting dynamic subtest: pipe-C
[581.027336] Dynamic subtest pipe-C: SUCCESS (1.113s)
[581.036235] Starting dynamic subtest: pipe-D
[582.156979] Dynamic subtest pipe-D: SUCCESS (1.129s)
[582.158090] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.441s)
[583.315117] [129/132] (447s left) gem_exec_schedule (timeslicing)
[583.374431] Starting subtest: timeslicing
[583.375387] Starting dynamic subtest: rcs0
[583.396144] Dynamic subtest rcs0: SUCCESS (0.022s)
[583.407714] Starting dynamic subtest: bcs0
[583.416433] Dynamic subtest bcs0: SUCCESS (0.020s)
[583.425173] Starting dynamic subtest: vcs0
[583.437827] Dynamic subtest vcs0: SUCCESS (0.021s)
[583.446512] Starting dynamic subtest: vcs1
[583.458188] Dynamic subtest vcs1: SUCCESS (0.020s)
[583.466742] Starting dynamic subtest: vecs0
[583.478106] Dynamic subtest vecs0: SUCCESS (0.019s)
[583.486857] Starting dynamic subtest: ccs0
[583.498478] Dynamic subtest ccs0: SUCCESS (0.019s)
[583.499498] Subtest timeslicing: SUCCESS (0.125s)
[584.686196] [130/132] (445s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[584.739508] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[584.741763] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[584.929689] [131/132] (445s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[585.026839] Starting subtest: y-tiled-32bpp-rotate-0
[585.028765] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[585.122887] [132/132] (445s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[585.238685] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[586.347882] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.111s)
[586.455774] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: kms_legacy_colorkey
results: parsing output: 4/ for test: gem_workarounds
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: gem_ctx_exec
results: parsing output: 7/ for test: kms_getfb
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: perf
results: parsing output: 10/ for test: kms_color_pipeline
results: parsing output: 11/ for test: gem_blits
results: parsing output: 12/ for test: gem_ccs
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: gem_flink_race
results: parsing output: 16/ for test: gem_ctx_isolation
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_partial_pwrite_pread
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_capture
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gem_set_tiling_vs_blt
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: sw_sync
results: parsing output: 29/ for test: gem_fenced_exec_thrash
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_sequence
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_exec_flush
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: i915_pm_sseu
results: parsing output: 39/ for test: kms_busy
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: i915_pm_rps
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: kms_draw_crc
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_gpgpu_fill
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_chamelium_edid
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_scaling_modes
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_chamelium_hpd
results: parsing output: 57/ for test: i915_drm_fdinfo
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: api_intel_bb
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gen7_exec_parse
results: parsing output: 65/ for test: kms_async_flips
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: kms_chamelium_audio
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: kms_properties
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_pxp
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_edge_walk
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_invalid_mode
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_plane_lowres
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_dirtyfb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: i915_query
results: parsing output: 91/ for test: kms_pipe_crc_basic
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: i915_hangman
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: gem_ctx_shared
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_spin_batch
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: gem_fenced_exec_thrash
results: parsing output: 106/ for test: prime_mmap
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: dmabuf_sync_file
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_linear_blits
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: sriov_basic
results: parsing output: 118/ for test: kms_vrr
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_content_protection
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: sysfs_timeslice_duration
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_big_fb
Done.