[73.339956] Initializing watchdogs
[73.340846]   /dev/watchdog0
[73.360282] [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]
[73.366316] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.369287] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.372951] [001/155] (960s left) gem_exec_balancer (invalid-balancer)
[73.553421] Starting subtest: invalid-balancer
[74.526934] Subtest invalid-balancer: SUCCESS (0.974s)
[74.841228] [002/155] (959s left) gem_userptr_blits (invalid-null-pointer)
[74.904790] Starting subtest: invalid-null-pointer
[74.906721] Subtest invalid-null-pointer: SUCCESS (0.001s)
[75.021641] [003/155] (958s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render)
[75.129053] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render
[75.133606] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[75.249224] [004/155] (958s left) syncobj_timeline (32bits-limit)
[75.301050] Starting subtest: 32bits-limit
[75.303177] Subtest 32bits-limit: SUCCESS (0.002s)
[75.400844] [005/155] (958s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary)
[75.507741] Starting subtest: fbcpsrhdr-shrfb-scaledprimary
[75.512415] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s)
[75.630057] [006/155] (958s left) kms_psr (fbc-psr-sprite-plane-onoff)
[75.738654] Starting subtest: fbc-psr-sprite-plane-onoff
[75.740993] Starting dynamic subtest: eDP-1
[75.745237] Dynamic subtest eDP-1: SKIP (0.000s)
[75.749421] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[75.807322] [007/155] (958s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt)
[75.901072] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt
[75.904876] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[75.999858] [008/155] (958s left) gem_userptr_blits (stress-mm)
[76.063118] Starting subtest: stress-mm
[81.489580] Subtest stress-mm: SUCCESS (5.369s)
[81.548723] [009/155] (952s left) api_intel_bb (simple-bb-ctx)
[81.597160] Starting subtest: simple-bb-ctx
[81.609838] Subtest simple-bb-ctx: SUCCESS (0.014s)
[81.739734] [010/155] (952s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[81.840951] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[81.845104] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[81.944498] [011/155] (952s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[82.045888] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[82.048342] Starting dynamic subtest: pipe-A-default-mode
[84.849656] Dynamic subtest pipe-A-default-mode: SUCCESS (2.805s)
[84.852101] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.806s)
[85.692921] [012/155] (948s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[85.749248] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[85.753871] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[85.942118] [013/155] (948s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[86.058039] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[86.062209] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[86.164815] [014/155] (948s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw)
[86.276997] Starting subtest: fbchdr-1p-pri-indfb-multidraw
[86.281222] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[86.380248] [015/155] (948s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[86.484718] Starting subtest: pr-cursor-plane-move-continuous-sf
[86.489159] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[86.552619] [016/155] (947s left) gem_exec_params (rel-constants-invalid-ring)
[86.613860] Starting subtest: rel-constants-invalid-ring
[86.616219] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[86.753598] [017/155] (947s left) kms_color_pipeline (plane-ctm3x4)
[86.839318] Starting subtest: plane-ctm3x4
[87.007775] Starting dynamic subtest: pipe-A-plane-0
[87.174481] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[87.183091] Starting dynamic subtest: pipe-A-plane-1
[87.330023] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[87.338171] Starting dynamic subtest: pipe-A-plane-2
[87.487227] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[88.740058] Starting dynamic subtest: pipe-B-plane-0
[88.877567] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[88.887149] Starting dynamic subtest: pipe-B-plane-1
[89.010619] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[89.020376] Starting dynamic subtest: pipe-B-plane-2
[89.166352] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[90.335848] Starting dynamic subtest: pipe-C-plane-0
[90.438789] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[90.447312] Starting dynamic subtest: pipe-C-plane-1
[90.549648] Dynamic subtest pipe-C-plane-1: SUCCESS (0.111s)
[90.558140] Starting dynamic subtest: pipe-C-plane-2
[90.662036] Dynamic subtest pipe-C-plane-2: SUCCESS (0.111s)
[91.852121] Starting dynamic subtest: pipe-D-plane-0
[91.966335] Dynamic subtest pipe-D-plane-0: SUCCESS (0.122s)
[91.976720] Starting dynamic subtest: pipe-D-plane-1
[92.077341] Dynamic subtest pipe-D-plane-1: SUCCESS (0.111s)
[92.087278] Starting dynamic subtest: pipe-D-plane-2
[92.210790] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[92.497482] Subtest plane-ctm3x4: SUCCESS (5.658s)
[93.318197] [018/155] (941s left) kms_plane (pixel-format-linear-modifier)
[93.420261] Starting subtest: pixel-format-linear-modifier
[93.446478] Starting dynamic subtest: pipe-A-plane-0
[94.035565] Dynamic subtest pipe-A-plane-0: SUCCESS (0.589s)
[94.044818] Starting dynamic subtest: pipe-A-plane-3
[94.457672] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s)
[94.467917] Starting dynamic subtest: pipe-A-plane-5
[94.679509] Dynamic subtest pipe-A-plane-5: SUCCESS (0.221s)
[95.822671] Starting dynamic subtest: pipe-B-plane-0
[96.404390] Dynamic subtest pipe-B-plane-0: SUCCESS (0.589s)
[96.414739] Starting dynamic subtest: pipe-B-plane-3
[96.848383] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[96.857110] Starting dynamic subtest: pipe-B-plane-5
[97.059246] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[97.371761] Subtest pixel-format-linear-modifier: SUCCESS (3.950s)
[98.188377] [019/155] (936s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[98.290109] Starting subtest: psr-2p-pri-indfb-multidraw
[98.294340] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[98.394665] [020/155] (936s left) gem_ccs (block-copy-uncompressed)
[98.454606] Starting subtest: block-copy-uncompressed
[98.456859] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[98.476990] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[98.486232] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[98.494597] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[98.502944] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[98.512401] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[98.523252] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[98.530915] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[98.533649] Subtest block-copy-uncompressed: SUCCESS (0.076s)
[98.656942] [021/155] (936s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-blt)
[98.764090] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-blt
[98.768228] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[98.886164] [022/155] (935s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-plflip-blt)
[98.990107] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-plflip-blt
[98.994619] Subtest fbcpsrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[99.092145] [023/155] (935s left) kms_fbcon_fbt (psr)
[99.154331] Starting subtest: psr
[106.706590] Subtest psr: SUCCESS (7.547s)
[106.790752] [024/155] (927s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[106.904654] Starting subtest: cursorB-vs-flipB-atomic
[106.909732] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[107.046954] [025/155] (927s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[107.133963] Starting subtest: random-ccs-data-y-tiled-ccs
[107.136314] Starting dynamic subtest: pipe-A-eDP-1
[107.161123] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.170109] Starting dynamic subtest: pipe-B-eDP-1
[107.192756] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[107.200541] Starting dynamic subtest: pipe-C-eDP-1
[107.224115] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[107.231954] Starting dynamic subtest: pipe-D-eDP-1
[107.256195] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[107.260619] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[109.381717] [026/155] (925s left) gem_exec_schedule (promotion)
[109.452807] Starting subtest: promotion
[109.454838] Starting dynamic subtest: rcs0
[109.549075] Dynamic subtest rcs0: SUCCESS (0.103s)
[109.561263] Starting dynamic subtest: vcs0
[109.634481] Dynamic subtest vcs0: SUCCESS (0.086s)
[109.643801] Starting dynamic subtest: vcs1
[109.720343] Dynamic subtest vcs1: SUCCESS (0.085s)
[109.732620] Starting dynamic subtest: vecs0
[109.801957] Dynamic subtest vecs0: SUCCESS (0.081s)
[109.811149] Starting dynamic subtest: ccs0
[109.890693] Dynamic subtest ccs0: SUCCESS (0.088s)
[109.893818] Subtest promotion: SUCCESS (0.446s)
[111.393299] [027/155] (923s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[111.479311] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[111.481633] Starting dynamic subtest: pipe-A-eDP-1
[111.505068] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[111.516057] Starting dynamic subtest: pipe-B-eDP-1
[111.537727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[111.545895] Starting dynamic subtest: pipe-C-eDP-1
[111.567924] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[111.575932] Starting dynamic subtest: pipe-D-eDP-1
[111.598054] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[111.602364] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[113.763965] [028/155] (921s left) syncobj_timeline (invalid-query-one-illegal-handle)
[113.817739] Starting subtest: invalid-query-one-illegal-handle
[113.820544] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[113.904871] [029/155] (921s left) gem_exec_balancer (parallel-out-fence)
[114.175991] Starting subtest: parallel-out-fence
[115.281797] Subtest parallel-out-fence: SUCCESS (1.106s)
[115.379221] [030/155] (919s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[115.474271] Starting subtest: yf-tiled-16bpp-rotate-0
[115.478345] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[115.569869] [031/155] (919s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[115.667573] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[115.671603] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[115.768984] [032/155] (919s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[115.864632] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[115.869070] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[115.946700] [033/155] (919s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[116.042705] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[116.047222] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[116.130421] [034/155] (919s left) kms_chamelium_hpd (hdmi-hpd)
[116.517490] Subtest hdmi-hpd: SKIP (0.000s)
[117.350788] [035/155] (917s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[117.449079] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[117.453273] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[117.551535] [036/155] (917s left) kms_flip (2x-flip-vs-fences)
[117.652564] Starting subtest: 2x-flip-vs-fences
[117.656902] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[117.729908] [037/155] (917s left) prime_vgem (basic-fence-flip)
[117.848951] Starting subtest: basic-fence-flip
[118.144293] Subtest basic-fence-flip: SUCCESS (0.296s)
[118.259804] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[118.263117] [038/155] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[118.358904] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[118.363134] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[118.449040] [039/155] (916s left) gen9_exec_parse (unaligned-jump)
[118.504263] Subtest unaligned-jump: SKIP (0.000s)
[118.577769] [040/155] (916s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[118.680129] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[118.682365] Starting dynamic subtest: pipe-A
[118.703327] Dynamic subtest pipe-A: SKIP (0.018s)
[118.713805] Starting dynamic subtest: pipe-B
[118.733582] Dynamic subtest pipe-B: SKIP (0.031s)
[118.744805] Starting dynamic subtest: pipe-C
[118.765265] Dynamic subtest pipe-C: SKIP (0.031s)
[118.774796] Starting dynamic subtest: pipe-D
[118.803559] Dynamic subtest pipe-D: SKIP (0.038s)
[118.808075] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.120s)
[118.919490] [041/155] (916s left) i915_hangman (engine-engine-hang)
[118.993131] Starting subtest: engine-engine-hang
[118.995464] Starting dynamic subtest: rcs0
[120.290085] Dynamic subtest rcs0: SUCCESS (1.295s)
[120.300042] Starting dynamic subtest: bcs0
[122.271604] Dynamic subtest bcs0: SUCCESS (1.980s)
[122.285837] Starting dynamic subtest: vcs0
[124.256043] Dynamic subtest vcs0: SUCCESS (1.982s)
[124.268774] Starting dynamic subtest: vcs1
[126.240126] Dynamic subtest vcs1: SUCCESS (1.982s)
[126.252879] Starting dynamic subtest: vecs0
[128.287060] Dynamic subtest vecs0: SUCCESS (2.045s)
[128.299500] Starting dynamic subtest: ccs0
[130.270958] Dynamic subtest ccs0: SUCCESS (1.982s)
[130.274035] Subtest engine-engine-hang: SUCCESS (11.276s)
[130.354885] [042/155] (905s left) gem_exec_fence (syncobj-timeline-chain-engines)
[130.904730] Starting subtest: syncobj-timeline-chain-engines
[131.066780] Subtest syncobj-timeline-chain-engines: SUCCESS (0.161s)
[132.348408] [043/155] (903s left) syncobj_timeline (wait-for-submit-snapshot)
[132.412034] Starting subtest: wait-for-submit-snapshot
[132.492588] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[132.574058] [044/155] (903s left) kms_dp_link_training (uhbr-sst)
[132.674645] Starting subtest: uhbr-sst
[132.683381] Subtest uhbr-sst: SKIP (0.000s)
[132.747988] [045/155] (902s left) api_intel_allocator (reserve-simple)
[132.801775] Starting subtest: reserve-simple
[132.804048] Subtest reserve-simple: SUCCESS (0.003s)
[132.912292] [046/155] (902s left) gem_mmap_wc (read-write-distinct)
[132.970210] Subtest read-write-distinct: SKIP (0.000s)
[133.055389] [047/155] (902s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[133.113126] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[133.221628] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[133.301241] [048/155] (902s left) perf (non-zero-reason)
[133.426055] Starting subtest: non-zero-reason
[133.428466] Starting dynamic subtest: 0-rcs0
[139.440598] Dynamic subtest 0-rcs0: SUCCESS (5.960s)
[139.452119] Starting dynamic subtest: 1-vecs0
[143.535326] Dynamic subtest 1-vecs0: SUCCESS (4.146s)
[143.538278] Subtest non-zero-reason: SUCCESS (10.108s)
[143.587203] [049/155] (892s left) kms_cursor_crc (cursor-random-512x512)
[143.875184] Starting subtest: cursor-random-512x512
[143.879777] Subtest cursor-random-512x512: SKIP (0.001s)
[144.060620] [050/155] (891s left) gem_exec_whisper (basic-queues-forked-all)
[144.122720] Starting subtest: basic-queues-forked-all
[163.599053] Subtest basic-queues-forked-all: SUCCESS (19.471s)
[163.785454] [051/155] (872s left) gem_ctx_persistence (heartbeat-many)
[163.859050] Starting subtest: heartbeat-many
[163.864806] Subtest heartbeat-many: SKIP (0.000s)
[163.978670] [052/155] (871s left) gem_softpin (safe-alignment)
[164.036470] Starting subtest: safe-alignment
[164.077462] Subtest safe-alignment: SUCCESS (0.041s)
[165.356494] [053/155] (870s left) gem_exec_schedule (implicit-boths)
[165.424130] Starting subtest: implicit-boths
[165.426521] Starting dynamic subtest: rcs0
[165.609082] Dynamic subtest rcs0: SUCCESS (0.191s)
[165.621893] Starting dynamic subtest: vcs0
[165.739109] Dynamic subtest vcs0: SUCCESS (0.131s)
[165.751228] Starting dynamic subtest: vcs1
[165.846628] Dynamic subtest vcs1: SUCCESS (0.107s)
[165.859019] Starting dynamic subtest: vecs0
[165.948637] Dynamic subtest vecs0: SUCCESS (0.101s)
[165.961831] Starting dynamic subtest: ccs0
[166.070772] Dynamic subtest ccs0: SUCCESS (0.121s)
[166.072875] Subtest implicit-boths: SUCCESS (0.655s)
[167.406730] [054/155] (868s left) gem_mmap_wc (write-wc-read-gtt)
[167.464078] Subtest write-wc-read-gtt: SKIP (0.000s)
[167.522476] [055/155] (868s left) kms_psr (psr-sprite-mmap-gtt)
[167.610565] Starting subtest: psr-sprite-mmap-gtt
[167.612735] Starting dynamic subtest: eDP-1
[169.081180] Dynamic subtest eDP-1: SKIP (1.467s)
[169.086362] Subtest psr-sprite-mmap-gtt: SKIP (1.468s)
[169.239924] [056/155] (866s left) gem_exec_nop (basic-sequential)
[169.307531] Starting subtest: basic-sequential
[183.798879] Subtest basic-sequential: SUCCESS (14.475s)
[184.007441] [057/155] (852s left) kms_flip (plain-flip-fb-recreate-interruptible)
[184.104318] Starting subtest: plain-flip-fb-recreate-interruptible
[184.106716] Starting dynamic subtest: A-eDP1
[192.997050] Dynamic subtest A-eDP1: SUCCESS (8.891s)
[193.008187] Starting dynamic subtest: B-eDP1
[201.831084] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[201.845756] Starting dynamic subtest: C-eDP1
[210.651108] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[210.663279] Starting dynamic subtest: D-eDP1
[219.484314] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[219.488343] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.382s)
[220.680234] [058/155] (815s left) kms_draw_crc (draw-method-blt)
[220.769183] Starting subtest: draw-method-blt
[220.771036] Starting dynamic subtest: xrgb8888-untiled
[221.024689] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[221.034886] Starting dynamic subtest: rgb565-untiled
[221.267584] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[221.278684] Starting dynamic subtest: xrgb2101010-untiled
[221.490698] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[221.502604] Starting dynamic subtest: xbgr16161616f-untiled
[221.689524] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[221.699444] Starting dynamic subtest: xrgb8888-xtiled
[221.811802] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[221.821343] Starting dynamic subtest: rgb565-xtiled
[221.934255] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[221.944856] Starting dynamic subtest: xrgb2101010-xtiled
[222.045282] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[222.055120] Starting dynamic subtest: xbgr16161616f-xtiled
[222.156326] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[222.166439] Starting dynamic subtest: xrgb8888-4tiled
[222.278421] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.120s)
[222.288823] Starting dynamic subtest: rgb565-4tiled
[222.389448] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[222.399449] Starting dynamic subtest: xrgb2101010-4tiled
[222.500471] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[222.510331] Starting dynamic subtest: xbgr16161616f-4tiled
[222.611660] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[222.613504] Subtest draw-method-blt: SUCCESS (1.845s)
[222.726898] [059/155] (813s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[222.771569] Starting subtest: multi-wait-available-submitted-signaled
[222.773591] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[222.893193] [060/155] (813s left) gem_pxp (verify-pxp-stale-ctx-execution)
[223.018416] Starting subtest: verify-pxp-stale-ctx-execution
[224.073883] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.056s)
[224.211498] [061/155] (812s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[224.320717] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[224.324774] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[224.430432] [062/155] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[224.535697] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[224.540249] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[224.650552] [063/155] (811s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt)
[224.755419] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt
[224.759454] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[224.848991] [064/155] (811s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[224.945130] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[224.949253] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[225.019347] [065/155] (811s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite)
[225.113495] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite
[225.116991] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[225.208840] [066/155] (811s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt)
[225.301921] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt
[225.305372] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[225.411096] [067/155] (811s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[225.532189] Starting subtest: basic-flip-after-cursor-atomic
[226.449596] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.916s)
[227.313493] [068/155] (809s left) kms_vblank (wait-forked-hang)
[227.405038] Starting subtest: wait-forked-hang
[227.406979] Starting dynamic subtest: pipe-A-eDP-1
[255.037614] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.629s)
[255.053341] Starting dynamic subtest: pipe-D-eDP-1
[279.056810] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.016s)
[279.058836] Subtest wait-forked-hang: SUCCESS (51.650s)
[279.884880] [069/155] (756s left) syncobj_wait (wait-any-interrupted)
[279.938499] Starting subtest: wait-any-interrupted
[280.045610] Subtest wait-any-interrupted: SUCCESS (0.106s)
[280.123910] [070/155] (756s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[280.224017] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[280.228179] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[280.330354] [071/155] (756s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[280.435312] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[280.439244] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[280.523927] [072/155] (756s left) kms_lease (master-vs-lease)
[280.620420] Starting subtest: master-vs-lease
[280.622993] Subtest master-vs-lease: SUCCESS (0.002s)
[280.722568] [073/155] (756s left) syncobj_wait (single-wait-all-for-submit-signaled)
[280.787563] Starting subtest: single-wait-all-for-submit-signaled
[280.790060] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[280.895780] [074/155] (755s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[281.004982] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[285.179551] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.179s)
[286.376596] [075/155] (750s left) kms_joiner (basic-ultra-joiner)
[286.476993] Starting subtest: basic-ultra-joiner
[286.481486] Subtest basic-ultra-joiner: SKIP (0.000s)
[286.545913] [076/155] (750s left) gem_exec_schedule (lateslice)
[286.609271] Starting subtest: lateslice
[286.611639] Starting dynamic subtest: rcs0
[286.618316] Dynamic subtest rcs0: SUCCESS (0.020s)
[286.629528] Starting dynamic subtest: bcs0
[286.636669] Dynamic subtest bcs0: SUCCESS (0.018s)
[286.646687] Starting dynamic subtest: vcs0
[286.654253] Dynamic subtest vcs0: SUCCESS (0.017s)
[286.663776] Starting dynamic subtest: vcs1
[286.672585] Dynamic subtest vcs1: SUCCESS (0.018s)
[286.682070] Starting dynamic subtest: vecs0
[286.690768] Dynamic subtest vecs0: SUCCESS (0.018s)
[286.700486] Starting dynamic subtest: ccs0
[286.708265] Dynamic subtest ccs0: SUCCESS (0.017s)
[286.710491] Subtest lateslice: SUCCESS (0.111s)
[288.399068] [077/155] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[288.498098] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[288.502494] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[288.612562] [078/155] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[288.724172] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[288.728607] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[288.830827] [079/155] (748s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[288.929958] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[288.934135] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[289.032596] [080/155] (748s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt)
[289.128277] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt
[289.132210] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[289.245240] [081/155] (747s left) kms_setmode (basic)
[289.306488] Starting subtest: basic
[289.633118] Starting dynamic subtest: pipe-A-eDP-1
[291.696952] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.059s)
[292.041110] Starting dynamic subtest: pipe-B-eDP-1
[294.133579] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.096s)
[294.437971] Subtest basic: SUCCESS (5.129s)
[295.282876] [082/155] (741s left) kms_vblank (query-forked-busy-hang)
[295.370243] Starting subtest: query-forked-busy-hang
[295.372382] Starting dynamic subtest: pipe-A-eDP-1
[322.046376] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.674s)
[322.063827] Starting dynamic subtest: pipe-D-eDP-1
[337.048692] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.998s)
[337.050892] Subtest query-forked-busy-hang: SUCCESS (41.676s)
[337.847502] [083/155] (699s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[338.236070] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[339.070940] [084/155] (698s left) gem_lmem_swapping (random)
[339.117720] Subtest random: SKIP (0.000s)
[339.174446] [085/155] (698s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[339.279106] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[339.283265] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[339.395269] [086/155] (698s left) perf (sysctl-defaults)
[339.473202] Starting subtest: sysctl-defaults
[339.475706] Subtest sysctl-defaults: SUCCESS (0.000s)
[339.551395] [087/155] (697s left) perf (non-system-wide-paranoid)
[339.647082] Starting subtest: non-system-wide-paranoid
[339.671397] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[339.740719] [088/155] (697s left) gen9_exec_parse (bb-chained)
[339.797694] Subtest bb-chained: SKIP (0.000s)
[339.906708] [089/155] (697s left) kms_psr (psr-cursor-plane-onoff)
[339.996847] Starting subtest: psr-cursor-plane-onoff
[339.998693] Starting dynamic subtest: eDP-1
[341.774369] Dynamic subtest eDP-1: SUCCESS (1.775s)
[341.776349] Subtest psr-cursor-plane-onoff: SUCCESS (1.776s)
[342.642549] [090/155] (695s left) kms_async_flips (alternate-sync-async-flip)
[342.744310] Starting subtest: alternate-sync-async-flip
[343.131592] Starting dynamic subtest: pipe-A-eDP-1
[345.933463] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.802s)
[346.318835] Starting dynamic subtest: pipe-B-eDP-1
[349.066833] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[349.452030] Starting dynamic subtest: pipe-C-eDP-1
[352.206404] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[352.575547] Starting dynamic subtest: pipe-D-eDP-1
[355.335110] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[355.337212] Subtest alternate-sync-async-flip: SUCCESS (12.594s)
[356.518480] [091/155] (681s left) gem_reg_read (bad-register)
[356.571713] Starting subtest: bad-register
[356.573654] Subtest bad-register: SUCCESS (0.000s)
[356.670519] [092/155] (681s left) kms_content_protection (type1)
[356.803945] Starting subtest: type1
[356.808456] Subtest type1: SKIP (0.000s)
[356.960896] [093/155] (680s left) gem_exec_balancer (bonded-chain)
[357.022921] Starting subtest: bonded-chain
[364.044873] Subtest bonded-chain: SUCCESS (7.020s)
[364.398673] [094/155] (673s left) core_auth (many-magics)
[364.455260] Starting subtest: many-magics
[365.381890] Subtest many-magics: SUCCESS (0.927s)
[365.582103] [095/155] (672s left) gem_close_race (basic-process)
[365.647600] Starting subtest: basic-process
[365.695644] Subtest basic-process: SUCCESS (0.048s)
[365.877429] [096/155] (672s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[365.967986] Starting subtest: plane-downscale-factor-0-75-with-rotation
[365.970308] Starting dynamic subtest: pipe-A
[366.210375] Dynamic subtest pipe-A: SUCCESS (0.244s)
[366.221303] Starting dynamic subtest: pipe-B
[367.485435] Dynamic subtest pipe-B: SUCCESS (1.274s)
[367.498214] Starting dynamic subtest: pipe-C
[368.823183] Dynamic subtest pipe-C: SUCCESS (1.337s)
[368.833290] Starting dynamic subtest: pipe-D
[370.163805] Dynamic subtest pipe-D: SUCCESS (1.340s)
[370.166173] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.198s)
[371.339651] [097/155] (666s left) gem_ctx_persistence (engines-hostile-preempt)
[371.401819] Starting subtest: engines-hostile-preempt
[371.404263] Starting dynamic subtest: rcs0
[371.482544] Dynamic subtest rcs0: SUCCESS (0.080s)
[371.495687] Starting dynamic subtest: bcs0
[371.534846] Dynamic subtest bcs0: SUCCESS (0.050s)
[371.546727] Starting dynamic subtest: vcs0
[373.306325] Dynamic subtest vcs0: SUCCESS (1.768s)
[373.319963] Starting dynamic subtest: vcs1
[375.293500] Dynamic subtest vcs1: SUCCESS (1.984s)
[375.305270] Starting dynamic subtest: vecs0
[377.281313] Dynamic subtest vecs0: SUCCESS (1.985s)
[377.293033] Starting dynamic subtest: ccs0
[377.347941] Dynamic subtest ccs0: SUCCESS (0.065s)
[377.351086] Subtest engines-hostile-preempt: SUCCESS (5.947s)
[377.429402] [098/155] (660s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[377.542502] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[384.545713] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.006s)
[384.684584] [099/155] (653s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[384.775761] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[384.780049] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[384.867542] [100/155] (653s left) kms_psr (pr-primary-mmap-gtt)
[384.957300] Starting subtest: pr-primary-mmap-gtt
[384.961319] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[385.044720] [101/155] (653s left) gem_ctx_bad_destroy (invalid-default-ctx)
[385.106166] Starting subtest: invalid-default-ctx
[385.108600] Subtest invalid-default-ctx: SUCCESS (0.000s)
[385.183602] [102/155] (653s left) syncobj_wait (multi-wait-all-submitted-signaled)
[385.231982] Starting subtest: multi-wait-all-submitted-signaled
[385.331917] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[385.413295] [103/155] (652s left) kms_psr (fbc-pr-primary-mmap-gtt)
[385.502097] Starting subtest: fbc-pr-primary-mmap-gtt
[385.506484] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[385.601237] [104/155] (652s left) perf_pmu (busy-start)
[385.643158] Starting subtest: busy-start
[385.645464] Starting dynamic subtest: rcs0
[388.193743] Dynamic subtest rcs0: SUCCESS (2.549s)
[388.209067] Starting dynamic subtest: bcs0
[390.767795] Dynamic subtest bcs0: SUCCESS (2.547s)
[390.782655] Starting dynamic subtest: vcs0
[394.304242] Dynamic subtest vcs0: SUCCESS (3.557s)
[394.317096] Starting dynamic subtest: vcs1
[398.273085] Dynamic subtest vcs1: SUCCESS (3.967s)
[398.285995] Starting dynamic subtest: vecs0
[402.304566] Dynamic subtest vecs0: SUCCESS (4.028s)
[402.317701] Starting dynamic subtest: ccs0
[404.873938] Dynamic subtest ccs0: SUCCESS (2.547s)
[404.875960] Subtest busy-start: SUCCESS (19.209s)
[404.968443] [105/155] (633s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[405.079099] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[409.611170] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.538s)
[410.762919] [106/155] (627s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[410.868900] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[410.873390] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[410.974773] [107/155] (627s left) syncobj_wait (multi-wait-submitted)
[411.026575] Starting subtest: multi-wait-submitted
[411.133122] Subtest multi-wait-submitted: SUCCESS (0.105s)
[411.220959] [108/155] (627s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[411.315535] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[411.317948] Starting dynamic subtest: pipe-A-eDP-1
[411.341573] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[411.354315] Starting dynamic subtest: pipe-B-eDP-1
[411.376614] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[411.386618] Starting dynamic subtest: pipe-C-eDP-1
[411.408602] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[411.418762] Starting dynamic subtest: pipe-D-eDP-1
[411.440802] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[411.445276] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[413.604662] [109/155] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[413.705198] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[413.709583] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[413.806312] [110/155] (624s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[413.895253] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[413.897476] Starting dynamic subtest: pipe-A-eDP-1
[413.919565] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[413.932803] Starting dynamic subtest: pipe-B-eDP-1
[413.954792] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[413.964857] Starting dynamic subtest: pipe-C-eDP-1
[413.986514] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[413.995999] Starting dynamic subtest: pipe-D-eDP-1
[414.018214] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[414.022229] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[416.183466] [111/155] (622s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[416.279575] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[416.283719] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[416.379580] [112/155] (622s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[416.483383] Starting subtest: psr-rgb565-draw-render
[423.630292] Subtest psr-rgb565-draw-render: SUCCESS (7.152s)
[423.768858] [113/155] (614s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[423.877262] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[424.889921] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s)
[425.009423] [114/155] (613s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-blt)
[425.114770] Starting subtest: psrhdr-rgb565-draw-blt
[425.119163] Subtest psrhdr-rgb565-draw-blt: SKIP (0.000s)
[425.214477] [115/155] (613s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[425.316957] Starting subtest: fbc-shrfb-scaledprimary
[428.204932] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.891s)
[429.415110] [116/155] (609s left) gem_workarounds (reset)
[429.481162] Starting subtest: reset
[429.642795] Subtest reset: SUCCESS (0.160s)
[429.786163] [117/155] (609s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[429.893360] Starting subtest: yf-tiled-64bpp-rotate-270
[429.897490] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[429.985851] [118/155] (608s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[430.109798] Starting subtest: short-flip-after-cursor-atomic-transitions
[431.059008] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.947s)
[431.945429] [119/155] (606s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[432.045138] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[432.047334] Starting dynamic subtest: pipe-A-eDP-1
[432.067306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[432.080898] Starting dynamic subtest: pipe-B-eDP-1
[432.100668] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[432.110662] Starting dynamic subtest: pipe-C-eDP-1
[432.130235] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[432.140129] Starting dynamic subtest: pipe-D-eDP-1
[432.159778] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[432.162057] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[434.310802] [120/155] (604s left) kms_prop_blob (blob-prop-lifetime)
[434.371850] Starting subtest: blob-prop-lifetime
[434.374670] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[434.498013] [121/155] (604s left) kms_plane_multiple (2x-tiling-x)
[434.590298] Starting subtest: 2x-tiling-x
[434.594182] Subtest 2x-tiling-x: SKIP (0.000s)
[434.662138] [122/155] (604s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[434.766494] Starting subtest: psr-rgb101010-draw-mmap-cpu
[442.021300] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.259s)
[442.137623] [123/155] (596s left) kms_pm_rpm (cursor)
[444.469717] Starting subtest: cursor
[444.474626] Subtest cursor: SKIP (0.000s)
[444.865679] [124/155] (594s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[444.982124] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[444.986269] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[445.091110] [125/155] (594s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[445.204713] Starting subtest: cursorA-vs-flipB-atomic-transitions
[445.209380] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[445.352245] [126/155] (593s left) gem_create (create-massive)
[445.407403] Starting subtest: create-massive
[445.409339] Subtest create-massive: SUCCESS (0.000s)
[445.606431] [127/155] (593s left) gem_fence_thrash (bo-write-verify-none)
[445.639679] Starting subtest: bo-write-verify-none
[445.669840] Subtest bo-write-verify-none: SKIP (0.024s)
[445.731324] [128/155] (593s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[445.836572] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[452.914398] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.082s)
[453.041761] [129/155] (586s left) kms_cursor_crc (cursor-offscreen-max-size)
[453.372834] Starting subtest: cursor-offscreen-max-size
[453.379398] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[453.517928] [130/155] (585s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[455.444192] Starting subtest: gem-execbuf-stress-pc8
[455.481813] Subtest gem-execbuf-stress-pc8: SKIP (0.038s)
[455.839051] [131/155] (583s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[455.933287] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc
[455.937739] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[456.040151] [132/155] (583s left) prime_busy (before)
[456.094458] Starting subtest: before
[456.099533] Starting dynamic subtest: rcs0
[456.122788] Dynamic subtest rcs0: SUCCESS (0.024s)
[456.133582] Starting dynamic subtest: bcs0
[456.161929] Dynamic subtest bcs0: SUCCESS (0.037s)
[456.172194] Starting dynamic subtest: vcs0
[456.200636] Dynamic subtest vcs0: SUCCESS (0.039s)
[456.210572] Starting dynamic subtest: vcs1
[456.239858] Dynamic subtest vcs1: SUCCESS (0.038s)
[456.249811] Starting dynamic subtest: vecs0
[456.279109] Dynamic subtest vecs0: SUCCESS (0.038s)
[456.289083] Starting dynamic subtest: ccs0
[456.318495] Dynamic subtest ccs0: SUCCESS (0.038s)
[456.426680] Subtest before: SUCCESS (0.330s)
[456.501837] [133/155] (583s left) gem_vm_create (isolation)
[456.563452] Starting subtest: isolation
[456.571798] Subtest isolation: SUCCESS (0.008s)
[456.709080] [134/155] (582s left) gem_mmap_gtt (basic-read)
[456.756645] Subtest basic-read: SKIP (0.000s)
[456.821333] [135/155] (582s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[456.877782] Starting subtest: single-wait-all-for-submit-available-signaled
[456.880142] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[456.973353] [136/155] (582s left) gem_softpin (softpin)
[457.040072] Starting subtest: softpin
[489.316396] Subtest softpin: SUCCESS (32.274s)
[489.423618] [137/155] (550s left) kms_cursor_legacy (forked-bo)
[489.537547] Starting subtest: forked-bo
[489.539920] Starting dynamic subtest: pipe-A
[495.058423] Dynamic subtest pipe-A: SUCCESS (5.465s)
[495.071434] Starting dynamic subtest: pipe-B
[500.537429] Dynamic subtest pipe-B: SUCCESS (5.477s)
[500.551137] Starting dynamic subtest: pipe-C
[506.011902] Dynamic subtest pipe-C: SUCCESS (5.472s)
[506.025771] Starting dynamic subtest: pipe-D
[511.495230] Dynamic subtest pipe-D: SUCCESS (5.482s)
[511.513652] Starting dynamic subtest: all-pipes
[517.006495] Dynamic subtest all-pipes: SUCCESS (5.507s)
[517.008967] Subtest forked-bo: SUCCESS (27.414s)
[517.103330] [138/155] (522s left) kms_fbcon_fbt (fbc-suspend)
[517.158834] Starting subtest: fbc-suspend
[569.601240] Subtest fbc-suspend: SUCCESS (22.669s)
[574.049696] [139/155] (468s left) gem_mmap_offset (isolation)
[574.137988] Starting subtest: isolation
[574.155197] Subtest isolation: SUCCESS (0.007s)
[574.257246] [140/155] (468s left) gem_exec_whisper (basic-forked-all)
[574.316852] Starting subtest: basic-forked-all
[587.902141] Subtest basic-forked-all: SUCCESS (13.604s)
[588.107214] [141/155] (454s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[588.208880] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[588.213318] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[588.308668] [142/155] (454s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[588.404497] Starting subtest: 4-tiled-8bpp-rotate-0
[589.606705] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.203s)
[589.734312] [143/155] (453s left) kms_atomic_transition (modeset-transition-fencing)
[589.831350] Starting subtest: modeset-transition-fencing
[589.833160] Starting dynamic subtest: 1x-outputs
[600.935305] Dynamic subtest 1x-outputs: SUCCESS (11.112s)
[600.937959] Subtest modeset-transition-fencing: SUCCESS (11.114s)
[601.802814] [144/155] (441s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[601.906573] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[609.690534] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.899s)
[609.803106] [145/155] (433s left) kms_psr (fbc-psr2-cursor-blt)
[609.906041] Starting subtest: fbc-psr2-cursor-blt
[609.908456] Starting dynamic subtest: eDP-1
[609.912843] Dynamic subtest eDP-1: SKIP (0.000s)
[609.917276] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[609.997231] [146/155] (433s left) gem_exec_nop (basic-parallel)
[610.059533] Starting subtest: basic-parallel
[626.316642] Subtest basic-parallel: SUCCESS (16.363s)
[626.575424] [147/155] (416s left) dmabuf_sync_file (import-multiple-read-write)
[626.653839] Starting subtest: import-multiple-read-write
[626.656242] Subtest import-multiple-read-write: SUCCESS (0.004s)
[626.719354] [148/155] (416s left) i915_query (query-topology-coherent-slice-mask)
[626.774876] Starting subtest: query-topology-coherent-slice-mask
[626.779208] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[626.881818] [149/155] (416s left) gem_exec_params (invalid-ring)
[626.935863] Starting subtest: invalid-ring
[626.938486] Subtest invalid-ring: SUCCESS (0.000s)
[627.056477] [150/155] (416s left) gem_exec_params (cliprects_ptr-dirt)
[627.119831] Starting subtest: cliprects_ptr-dirt
[627.122246] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[627.229972] [151/155] (416s left) i915_suspend (basic-s3-without-i915)
[627.267683] Starting subtest: basic-s3-without-i915
[631.958835] Subtest basic-s3-without-i915: SKIP (4.692s)
[633.582769] [152/155] (409s left) kms_plane_alpha_blend (alpha-basic)
[633.686450] Starting subtest: alpha-basic
[633.999391] Starting dynamic subtest: pipe-A-eDP-1
[636.013789] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.017s)
[636.047051] Starting dynamic subtest: pipe-D-eDP-1
[638.731960] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.694s)
[638.734452] Subtest alpha-basic: SUCCESS (5.049s)
[639.612825] [153/155] (403s left) kms_invalid_mode (bad-hsync-end)
[639.704749] Starting subtest: bad-hsync-end
[639.707212] Starting dynamic subtest: pipe-A-eDP-1
[639.996297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[640.007120] Starting dynamic subtest: pipe-B-eDP-1
[640.009420] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[640.019612] Starting dynamic subtest: pipe-C-eDP-1
[640.021596] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[640.031104] Starting dynamic subtest: pipe-D-eDP-1
[640.033052] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[640.035094] Subtest bad-hsync-end: SUCCESS (0.296s)
[640.849978] [154/155] (402s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-fullscreen)
[640.949351] Starting subtest: psrhdr-1p-primscrn-spr-indfb-fullscreen
[640.953415] Subtest psrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[641.071036] [155/155] (402s left) kms_big_fb (linear-8bpp-rotate-270)
[641.171032] Starting subtest: linear-8bpp-rotate-270
[641.195151] Subtest linear-8bpp-rotate-270: SKIP (0.024s)
[641.307846] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: api_intel_bb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: kms_color_pipeline
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_fbcon_fbt
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_chamelium_hpd
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: prime_vgem
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gen9_exec_parse
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_dp_link_training
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: gem_mmap_wc
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_exec_nop
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_draw_crc
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_lease
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_joiner
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_frontbuffer_tracking
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: kms_setmode
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_chamelium_frames
results: parsing output: 83/ for test: gem_lmem_swapping
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_async_flips
results: parsing output: 90/ for test: gem_reg_read
results: parsing output: 91/ for test: kms_content_protection
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: core_auth
results: parsing output: 94/ for test: gem_close_race
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_ctx_bad_destroy
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_workarounds
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_prop_blob
results: parsing output: 120/ for test: kms_plane_multiple
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_create
results: parsing output: 126/ for test: gem_fence_thrash
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: i915_pm_rpm
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: prime_busy
results: parsing output: 132/ for test: gem_vm_create
results: parsing output: 133/ for test: gem_mmap_gtt
results: parsing output: 134/ for test: syncobj_timeline
results: parsing output: 135/ for test: gem_softpin
results: parsing output: 136/ for test: kms_cursor_legacy
results: parsing output: 137/ for test: kms_fbcon_fbt
results: parsing output: 138/ for test: gem_mmap_offset
results: parsing output: 139/ for test: gem_exec_whisper
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_big_fb
results: parsing output: 142/ for test: kms_atomic_transition
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_psr
results: parsing output: 145/ for test: gem_exec_nop
results: parsing output: 146/ for test: dmabuf_sync_file
results: parsing output: 147/ for test: i915_query
results: parsing output: 148/ for test: gem_exec_params
results: parsing output: 149/ for test: gem_exec_params
results: parsing output: 150/ for test: i915_suspend
results: parsing output: 151/ for test: kms_plane_alpha_blend
results: parsing output: 152/ for test: kms_invalid_mode
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_big_fb
Done.