[61.848327] Initializing watchdogs
[61.848376]   /dev/watchdog0
[61.861486] [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]
[61.866154] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.868376] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.872815] [001/132] (960s left) syncobj_timeline (wait-for-submit-snapshot)
[61.950953] Starting subtest: wait-for-submit-snapshot
[62.032799] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[62.142630] [002/132] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[62.238842] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[62.241212] Starting dynamic subtest: pipe-A-eDP-1
[62.518901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.248s)
[62.527634] Starting dynamic subtest: pipe-B-eDP-1
[63.792482] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.277s)
[63.800081] Starting dynamic subtest: pipe-C-eDP-1
[64.998169] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s)
[65.007731] Starting dynamic subtest: pipe-D-eDP-1
[66.224577] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[66.226580] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.962s)
[67.501264] [003/132] (954s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[67.665769] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[71.754872] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.098s)
[72.977283] [004/132] (949s left) kms_big_fb (linear-8bpp-rotate-270)
[73.093266] Starting subtest: linear-8bpp-rotate-270
[73.113531] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[73.267428] [005/132] (949s left) kms_busy (extended-modeset-hang-newfb)
[73.372764] Starting subtest: extended-modeset-hang-newfb
[73.374966] Starting dynamic subtest: pipe-A
[107.875297] Dynamic subtest pipe-A: SUCCESS (34.502s)
[107.883975] Starting dynamic subtest: pipe-D
[130.790899] Dynamic subtest pipe-D: SUCCESS (22.913s)
[130.793431] Subtest extended-modeset-hang-newfb: SUCCESS (57.419s)
[131.684941] [006/132] (890s left) perf (oa-exponents)
[131.827238] Starting subtest: oa-exponents
[131.829111] Starting dynamic subtest: 0-rcs0
[133.606864] Dynamic subtest 0-rcs0: SUCCESS (1.779s)
[133.615685] Starting dynamic subtest: 1-vecs0
[135.437741] Dynamic subtest 1-vecs0: SUCCESS (1.831s)
[135.440160] Subtest oa-exponents: SUCCESS (3.610s)
[135.480316] [007/132] (887s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[135.582582] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[136.694320] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.112s)
[136.864212] [008/132] (885s left) kms_pipe_crc_basic (suspend-read-crc)
[136.962097] Starting subtest: suspend-read-crc
[136.963947] Starting dynamic subtest: pipe-A-eDP-1
[155.055115] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.041s)
[155.063526] Starting dynamic subtest: pipe-B-eDP-1
[173.017103] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.147s)
[173.025953] Starting dynamic subtest: pipe-C-eDP-1
[191.019856] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.049s)
[191.028061] Starting dynamic subtest: pipe-D-eDP-1
[208.987892] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.014s)
[208.989888] Subtest suspend-read-crc: SUCCESS (15.254s)
[209.837055] [009/132] (812s left) perf_pmu (interrupts-sync)
[209.883270] Starting subtest: interrupts-sync
[211.038816] Subtest interrupts-sync: SUCCESS (1.171s)
[211.171982] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[211.175226] [010/132] (811s left) gem_exec_reloc (basic-gtt-active)
[211.239477] Subtest basic-gtt-active: SKIP (0.000s)
[211.319910] [011/132] (811s left) kms_flip (modeset-vs-vblank-race)
[211.415946] Starting subtest: modeset-vs-vblank-race
[211.418379] Starting dynamic subtest: A-eDP1
[216.072229] Dynamic subtest A-eDP1: SUCCESS (4.700s)
[216.083186] Starting dynamic subtest: B-eDP1
[220.797238] Dynamic subtest B-eDP1: SUCCESS (4.748s)
[220.807449] Starting dynamic subtest: C-eDP1
[225.465007] Dynamic subtest C-eDP1: SUCCESS (4.680s)
[225.487516] Starting dynamic subtest: D-eDP1
[230.199773] Dynamic subtest D-eDP1: SUCCESS (4.741s)
[230.202107] Subtest modeset-vs-vblank-race: SUCCESS (18.878s)
[231.400116] [012/132] (791s left) gem_sync (basic-each)
[231.474696] Starting subtest: basic-each
[233.726521] Subtest basic-each: SUCCESS (2.267s)
[233.936541] [013/132] (788s left) gem_ctx_persistence (legacy-engines-mixed)
[234.006840] Starting subtest: legacy-engines-mixed
[234.009581] Starting dynamic subtest: render
[234.119244] Dynamic subtest render: SUCCESS (0.111s)
[234.131094] Starting dynamic subtest: bsd1
[234.189746] Dynamic subtest bsd1: SUCCESS (0.069s)
[234.200600] Starting dynamic subtest: bsd2
[234.261234] Dynamic subtest bsd2: SUCCESS (0.068s)
[234.272773] Starting dynamic subtest: blt
[234.347215] Dynamic subtest blt: SUCCESS (0.084s)
[234.358687] Starting dynamic subtest: vebox
[234.428821] Dynamic subtest vebox: SUCCESS (0.080s)
[234.431761] Subtest legacy-engines-mixed: SUCCESS (0.423s)
[234.533433] [014/132] (788s left) kms_plane (plane-panning-bottom-right)
[234.625707] Starting subtest: plane-panning-bottom-right
[234.628014] Starting dynamic subtest: pipe-A
[236.331323] Dynamic subtest pipe-A: SUCCESS (1.706s)
[236.341334] Starting dynamic subtest: pipe-B
[238.568486] Dynamic subtest pipe-B: SUCCESS (2.237s)
[238.570383] Subtest plane-panning-bottom-right: SUCCESS (3.946s)
[239.410834] [015/132] (783s left) prime_vgem (wait)
[239.502122] Starting subtest: wait
[239.504664] Starting dynamic subtest: rcs0
[239.551278] Dynamic subtest rcs0: SUCCESS (0.049s)
[239.559947] Starting dynamic subtest: bcs0
[239.629706] Dynamic subtest bcs0: SUCCESS (0.078s)
[239.638451] Starting dynamic subtest: vcs0
[239.677887] Dynamic subtest vcs0: SUCCESS (0.048s)
[239.686390] Starting dynamic subtest: vcs1
[239.725424] Dynamic subtest vcs1: SUCCESS (0.047s)
[239.733975] Starting dynamic subtest: vecs0
[239.769702] Dynamic subtest vecs0: SUCCESS (0.044s)
[239.778116] Starting dynamic subtest: ccs0
[239.816624] Dynamic subtest ccs0: SUCCESS (0.046s)
[239.818899] Subtest wait: SUCCESS (0.315s)
[239.971413] [016/132] (783s left) i915_query (query-topology-matches-eu-total)
[240.039106] Starting subtest: query-topology-matches-eu-total
[240.041402] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[240.168211] [017/132] (782s left) syncobj_timeline (reset-signaled)
[240.223030] Starting subtest: reset-signaled
[240.224917] Subtest reset-signaled: SUCCESS (0.000s)
[240.351125] [018/132] (782s left) syncobj_timeline (multi-wait-all-available-signaled)
[240.409169] Starting subtest: multi-wait-all-available-signaled
[240.411228] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[240.549921] [019/132] (782s left) kms_cursor_crc (cursor-random-256x256)
[240.759774] Starting subtest: cursor-random-256x256
[240.763645] Starting dynamic subtest: pipe-A-eDP-1
[244.083943] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.319s)
[244.115253] Starting dynamic subtest: pipe-D-eDP-1
[248.071291] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.965s)
[248.073664] Subtest cursor-random-256x256: SUCCESS (7.308s)
[248.978822] [020/132] (774s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[249.051007] Starting subtest: mixed-tiled-to-y-tiled-ccs
[249.055476] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[249.255325] [021/132] (773s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[249.356579] Starting subtest: primary-y-tiled-reflect-x-180
[249.427540] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s)
[249.552067] [022/132] (773s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[249.626179] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[249.630640] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[249.832324] [023/132] (773s left) gem_exec_schedule (reorder-wide)
[250.014380] Subtest reorder-wide: SKIP (0.000s)
[250.223051] [024/132] (773s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[250.326595] Starting subtest: fbc-indfb-scaledprimary
[253.334464] Subtest fbc-indfb-scaledprimary: SUCCESS (3.011s)
[254.483065] [025/132] (768s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[254.583469] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[261.120879] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.541s)
[261.283688] [026/132] (762s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[261.382395] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[261.384803] Starting dynamic subtest: pipe-A-eDP-1
[261.394179] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[261.404650] Starting dynamic subtest: pipe-B-eDP-1
[261.413510] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[261.421878] Starting dynamic subtest: pipe-C-eDP-1
[261.430161] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[261.438121] Starting dynamic subtest: pipe-D-eDP-1
[261.446564] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[261.450661] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[263.563136] [027/132] (759s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[268.626168] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[268.630735] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[269.492955] [028/132] (754s left) kms_cursor_crc (cursor-random-64x21)
[269.684430] Starting subtest: cursor-random-64x21
[269.724695] Subtest cursor-random-64x21: SKIP (0.039s)
[269.991088] [029/132] (753s left) prime_mmap (test_dup)
[270.047001] Starting subtest: test_dup
[270.048962] Starting dynamic subtest: test_dup-smem
[270.078011] Dynamic subtest test_dup-smem: SUCCESS (0.033s)
[270.080536] Subtest test_dup: SUCCESS (0.033s)
[270.175848] [030/132] (753s left) gem_exec_schedule (u-submit-late-slice)
[270.245129] Starting subtest: u-submit-late-slice
[270.247387] Starting dynamic subtest: rcs0
[270.270527] Dynamic subtest rcs0: SUCCESS (0.034s)
[270.282498] Starting dynamic subtest: bcs0
[270.297120] Dynamic subtest bcs0: SUCCESS (0.026s)
[270.305832] Starting dynamic subtest: vcs0
[270.324532] Dynamic subtest vcs0: SUCCESS (0.027s)
[270.333232] Starting dynamic subtest: vcs1
[270.352896] Dynamic subtest vcs1: SUCCESS (0.027s)
[270.361441] Starting dynamic subtest: vecs0
[270.379389] Dynamic subtest vecs0: SUCCESS (0.026s)
[270.388444] Starting dynamic subtest: ccs0
[270.407705] Dynamic subtest ccs0: SUCCESS (0.028s)
[270.409778] Subtest u-submit-late-slice: SUCCESS (0.172s)
[271.987714] [031/132] (751s left) syncobj_timeline (etime-multi-wait-all-submitted)
[272.051857] Starting subtest: etime-multi-wait-all-submitted
[272.153601] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[272.259553] [032/132] (751s left) fbdev (write)
[272.307991] Starting subtest: write
[272.666533] Subtest write: SUCCESS (0.359s)
[272.755527] [033/132] (750s left) syncobj_wait (invalid-signal-zero-handles)
[272.815763] Starting subtest: invalid-signal-zero-handles
[272.818314] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[272.953855] [034/132] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[273.052317] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[273.056440] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[273.192941] [035/132] (750s left) gem_exec_balancer (sliced)
[273.263522] Starting subtest: sliced
[273.268079] Subtest sliced: SKIP (0.000s)
[273.586171] [036/132] (750s left) gem_ccs (large-ctrl-surf-copy)
[273.637812] Starting subtest: large-ctrl-surf-copy
[273.642836] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[273.775537] [037/132] (750s left) gem_fenced_exec_thrash (2-spare-fences)
[273.845268] Subtest 2-spare-fences: SKIP (0.000s)
[273.924722] [038/132] (749s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[274.038346] Starting subtest: basic-busy-flip-before-cursor-varying-size
[274.042990] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[274.213312] [039/132] (749s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[274.308445] Starting subtest: 4-tiled-8bpp-rotate-0
[275.411724] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.102s)
[275.591493] [040/132] (748s left) gem_mmap_wc (copy)
[275.650626] Subtest copy: SKIP (0.000s)
[275.719666] [041/132] (748s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[275.841310] Starting subtest: cursor-vs-flip-toggle
[306.445632] Subtest cursor-vs-flip-toggle: SUCCESS (30.613s)
[307.311556] [042/132] (716s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[307.410442] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[307.414929] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[307.545746] [043/132] (716s left) kms_addfb_basic (unused-handle)
[307.605355] Starting subtest: unused-handle
[307.607603] Subtest unused-handle: SUCCESS (0.000s)
[307.759101] [044/132] (716s left) gem_ctx_shared (q-smoketest-all)
[307.827865] Starting subtest: Q-smoketest-all
[340.238170] Subtest Q-smoketest-all: SUCCESS (32.353s)
[341.867704] [045/132] (682s left) kms_flip (2x-flip-vs-expired-vblank)
[341.980930] Starting subtest: 2x-flip-vs-expired-vblank
[341.989851] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[342.128668] [046/132] (682s left) kms_force_connector_basic (force-edid)
[342.219804] Starting subtest: force-edid
[342.582962] Subtest force-edid: SUCCESS (0.366s)
[342.750982] [047/132] (681s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[342.849973] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[343.806786] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.956s)
[343.963505] [048/132] (680s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[344.076185] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[344.078182] Starting dynamic subtest: pipe-A
[344.097731] Dynamic subtest pipe-A: SKIP (0.017s)
[344.106091] Starting dynamic subtest: pipe-B
[344.129622] Dynamic subtest pipe-B: SKIP (0.032s)
[344.140029] Starting dynamic subtest: pipe-C
[344.165117] Dynamic subtest pipe-C: SKIP (0.035s)
[344.173184] Starting dynamic subtest: pipe-D
[344.193574] Dynamic subtest pipe-D: SKIP (0.028s)
[344.196747] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.115s)
[344.323774] [049/132] (680s left) kms_chamelium_audio (hdmi-audio)
[344.708938] Subtest hdmi-audio: SKIP (0.000s)
[345.495035] [050/132] (678s left) gem_set_tiling_vs_gtt
[345.614403] [051/132] (678s left) gem_lmem_swapping (massive)
[345.653862] Subtest massive: SKIP (0.000s)
[345.693982] [052/132] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[345.788271] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[352.405079] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.619s)
[352.589447] [053/132] (671s left) prime_busy (after)
[352.642900] Starting subtest: after
[352.648152] Starting dynamic subtest: rcs0
[352.669190] Dynamic subtest rcs0: SUCCESS (0.023s)
[352.679411] Starting dynamic subtest: bcs0
[352.731708] Dynamic subtest bcs0: SUCCESS (0.061s)
[352.742131] Starting dynamic subtest: vcs0
[352.772271] Dynamic subtest vcs0: SUCCESS (0.040s)
[352.781215] Starting dynamic subtest: vcs1
[352.813538] Dynamic subtest vcs1: SUCCESS (0.040s)
[352.822401] Starting dynamic subtest: vecs0
[352.854365] Dynamic subtest vecs0: SUCCESS (0.040s)
[352.863583] Starting dynamic subtest: ccs0
[352.895097] Dynamic subtest ccs0: SUCCESS (0.040s)
[353.005395] Subtest after: SUCCESS (0.361s)
[353.102397] [054/132] (671s left) syncobj_wait (invalid-signal-illegal-handle)
[353.163457] Starting subtest: invalid-signal-illegal-handle
[353.165691] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[353.292298] [055/132] (671s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[353.394804] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[353.397254] Starting dynamic subtest: pipe-A-default-mode
[353.689768] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[353.694455] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.294s)
[354.528748] [056/132] (670s left) gem_gtt_cpu_tlb
[354.650206] [057/132] (670s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[354.757098] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[354.761537] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[354.887696] [058/132] (669s left) gen9_exec_parse (batch-zero-length)
[354.955541] Subtest batch-zero-length: SKIP (0.000s)
[355.024011] [059/132] (669s left) gem_softpin (evict-snoop-interruptible)
[355.088301] Starting subtest: evict-snoop-interruptible
[355.092855] Subtest evict-snoop-interruptible: SKIP (0.000s)
[355.247347] [060/132] (669s left) dmabuf_sync_file (export-basic)
[355.287559] Starting subtest: export-basic
[355.289722] Subtest export-basic: SUCCESS (0.001s)
[355.372660] [061/132] (669s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[355.463779] Starting subtest: fb-8bpc-vs-panel-6bpc
[355.465757] Starting dynamic subtest: pipe-A-eDP-1
[356.840312] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.376s)
[356.842724] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.377s)
[357.723529] [062/132] (667s left) syncobj_timeline (host-signal-ordered)
[357.787309] Starting subtest: host-signal-ordered
[357.789246] Subtest host-signal-ordered: SUCCESS (0.000s)
[357.923783] [063/132] (666s left) kms_chamelium_hpd (common-hpd-after-suspend)
[358.311166] Subtest common-hpd-after-suspend: SKIP (0.000s)
[359.085830] [064/132] (665s left) kms_flip (2x-flip-vs-fences)
[359.181762] Starting subtest: 2x-flip-vs-fences
[359.186996] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[359.317830] [065/132] (665s left) perf (mi-rpc)
[359.429879] Starting subtest: mi-rpc
[359.434545] Subtest mi-rpc: SKIP (0.000s)
[359.470738] [066/132] (665s left) sw_sync (sync_random_merge)
[359.500829] Starting subtest: sync_random_merge
[359.538266] Subtest sync_random_merge: SUCCESS (0.038s)
[359.619149] [067/132] (665s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[359.721882] Starting subtest: psr-rgb101010-draw-pwrite
[367.187568] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.468s)
[367.327361] [068/132] (657s left) kms_getfb (getfb2-handle-closed)
[367.422450] Starting subtest: getfb2-handle-closed
[367.424633] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[367.565728] [069/132] (657s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[367.670880] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[367.675038] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.793755] [070/132] (657s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[367.847838] Starting subtest: invalid-smem-bo-on-discrete
[367.852343] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[368.005455] [071/132] (657s left) perf (gen12-invalid-class-instance)
[368.099189] Starting subtest: gen12-invalid-class-instance
[368.108761] Subtest gen12-invalid-class-instance: SUCCESS (0.008s)
[368.147979] [072/132] (657s left) gem_exec_schedule (implicit-read-write)
[368.209516] Starting subtest: implicit-read-write
[368.211265] Starting dynamic subtest: rcs0
[368.317846] Dynamic subtest rcs0: SUCCESS (0.114s)
[368.328889] Starting dynamic subtest: vcs0
[368.398264] Dynamic subtest vcs0: SUCCESS (0.079s)
[368.409639] Starting dynamic subtest: vcs1
[368.473599] Dynamic subtest vcs1: SUCCESS (0.075s)
[368.485132] Starting dynamic subtest: vecs0
[368.547228] Dynamic subtest vecs0: SUCCESS (0.073s)
[368.559385] Starting dynamic subtest: ccs0
[368.625834] Dynamic subtest ccs0: SUCCESS (0.078s)
[368.628153] Subtest implicit-read-write: SUCCESS (0.422s)
[369.967296] [073/132] (655s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[370.062232] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[370.204164] [074/132] (655s left) kms_atomic (plane-cursor-legacy)
[370.306959] Starting subtest: plane-cursor-legacy
[370.309267] Starting dynamic subtest: pipe-A-eDP-1
[370.682477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.374s)
[370.684831] Subtest plane-cursor-legacy: SUCCESS (0.376s)
[371.525233] [075/132] (653s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[371.622528] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[371.624758] Starting dynamic subtest: pipe-A-eDP-1
[371.647381] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[371.657632] Starting dynamic subtest: pipe-B-eDP-1
[371.679246] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[371.687973] Starting dynamic subtest: pipe-C-eDP-1
[371.709874] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[371.718647] Starting dynamic subtest: pipe-D-eDP-1
[371.741271] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[371.745426] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[373.926242] [076/132] (651s left) gem_exec_balancer (bonded-pair)
[374.001911] Starting subtest: bonded-pair
[374.006688] Subtest bonded-pair: SKIP (0.000s)
[374.341618] [077/132] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[374.444708] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[374.449154] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[374.566798] [078/132] (650s left) gem_ctx_exec (basic-invalid-context)
[374.630849] Starting subtest: basic-invalid-context
[374.635468] Subtest basic-invalid-context: SUCCESS (0.004s)
[374.792721] [079/132] (650s left) kms_content_protection (lic-type-0-hdcp14)
[374.929572] Starting subtest: lic-type-0-hdcp14
[374.934030] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[375.093898] [080/132] (650s left) gem_eio (wait-immediate)
[375.321859] Starting subtest: wait-immediate
[375.690220] Subtest wait-immediate: SUCCESS (0.368s)
[375.880753] [081/132] (649s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[375.979330] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[375.989150] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[376.132604] [082/132] (649s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[376.234927] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[376.236769] Starting dynamic subtest: pipe-A-default-mode
[377.436757] Dynamic subtest pipe-A-default-mode: SKIP (1.199s)
[377.441327] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.201s)
[377.629899] [083/132] (648s left) kms_psr (psr2-basic)
[377.732483] Starting subtest: psr2-basic
[377.734679] Starting dynamic subtest: eDP-1
[379.344941] Dynamic subtest eDP-1: SUCCESS (1.612s)
[379.347292] Subtest psr2-basic: SUCCESS (1.613s)
[380.215685] [084/132] (645s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[380.308403] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[380.310588] Starting dynamic subtest: pipe-A-eDP-1
[380.333155] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[380.344413] Starting dynamic subtest: pipe-B-eDP-1
[380.365186] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[380.373894] Starting dynamic subtest: pipe-C-eDP-1
[380.395401] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[380.403958] Starting dynamic subtest: pipe-D-eDP-1
[380.425757] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[380.429856] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[382.613348] [085/132] (643s left) kms_vblank (query-forked-busy)
[382.717582] Starting subtest: query-forked-busy
[382.719878] Starting dynamic subtest: pipe-A-eDP-1
[384.599426] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[384.614711] Starting dynamic subtest: pipe-D-eDP-1
[387.123324] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[387.125645] Subtest query-forked-busy: SUCCESS (4.409s)
[388.019744] [086/132] (637s left) kms_pm_dc (dc9-dpms)
[389.126694] Starting subtest: dc9-dpms
[390.537600] Subtest dc9-dpms: SUCCESS (1.412s)
[390.637076] [087/132] (635s left) gem_userptr_blits (set-cache-level)
[390.708441] Starting subtest: set-cache-level
[390.712666] Subtest set-cache-level: SKIP (0.000s)
[390.864498] [088/132] (635s left) gem_exec_fence (keep-in-fence)
[391.044456] Starting subtest: keep-in-fence
[391.047031] Starting dynamic subtest: rcs0
[391.123755] Dynamic subtest rcs0: SUCCESS (0.079s)
[391.135820] Starting dynamic subtest: bcs0
[391.178564] Dynamic subtest bcs0: SUCCESS (0.053s)
[391.189874] Starting dynamic subtest: vcs0
[392.808831] Dynamic subtest vcs0: SUCCESS (1.627s)
[392.820380] Starting dynamic subtest: vcs1
[394.856159] Dynamic subtest vcs1: SUCCESS (2.045s)
[394.868579] Starting dynamic subtest: vecs0
[396.841005] Dynamic subtest vecs0: SUCCESS (1.983s)
[396.853256] Starting dynamic subtest: ccs0
[397.077573] Dynamic subtest ccs0: SUCCESS (0.236s)
[397.080142] Subtest keep-in-fence: SUCCESS (6.036s)
[398.892102] [089/132] (627s left) kms_pm_rpm (modeset-pc8-residency-stress)
[400.918678] Starting subtest: modeset-pc8-residency-stress
[400.923161] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[401.319617] [090/132] (624s left) kms_psr (fbc-psr2-sprite-plane-move)
[401.419091] Starting subtest: fbc-psr2-sprite-plane-move
[401.421355] Starting dynamic subtest: eDP-1
[401.425715] Dynamic subtest eDP-1: SKIP (0.000s)
[401.430065] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[401.516859] [091/132] (624s left) gem_exec_create (forked)
[401.578752] Starting subtest: forked
[401.581142] Starting dynamic subtest: smem
[422.823833] Dynamic subtest smem: SUCCESS (21.248s)
[422.826595] Subtest forked: SUCCESS (21.250s)
[423.033201] [092/132] (603s left) kms_psr (pr-cursor-mmap-cpu)
[423.145742] Starting subtest: pr-cursor-mmap-cpu
[423.150015] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[423.243739] [093/132] (602s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[423.340932] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[423.344897] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[423.455145] [094/132] (602s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[428.449438] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[428.454054] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[429.300211] [095/132] (596s left) gem_exec_reloc (basic-wc-read)
[429.370723] Subtest basic-wc-read: SKIP (0.000s)
[429.444230] [096/132] (596s left) kms_psr (psr-cursor-plane-move)
[429.547741] Starting subtest: psr-cursor-plane-move
[429.550009] Starting dynamic subtest: eDP-1
[431.232936] Dynamic subtest eDP-1: SUCCESS (1.685s)
[431.235216] Subtest psr-cursor-plane-move: SUCCESS (1.687s)
[432.095418] [097/132] (594s left) kms_flip (basic-plain-flip)
[432.199904] Starting subtest: basic-plain-flip
[432.202292] Starting dynamic subtest: A-eDP1
[433.850880] Dynamic subtest A-eDP1: SUCCESS (1.649s)
[433.864872] Starting dynamic subtest: B-eDP1
[435.549528] Dynamic subtest B-eDP1: SUCCESS (1.696s)
[435.560024] Starting dynamic subtest: C-eDP1
[437.239369] Dynamic subtest C-eDP1: SUCCESS (1.687s)
[437.249715] Starting dynamic subtest: D-eDP1
[438.947104] Dynamic subtest D-eDP1: SUCCESS (1.705s)
[438.953331] Subtest basic-plain-flip: SUCCESS (6.750s)
[440.210110] [098/132] (586s left) kms_flip (plain-flip-fb-recreate)
[440.317511] Starting subtest: plain-flip-fb-recreate
[440.319877] Starting dynamic subtest: A-eDP1
[449.151261] Dynamic subtest A-eDP1: SUCCESS (8.833s)
[449.161861] Starting dynamic subtest: B-eDP1
[458.051139] Dynamic subtest B-eDP1: SUCCESS (8.896s)
[458.061827] Starting dynamic subtest: C-eDP1
[466.942384] Dynamic subtest C-eDP1: SUCCESS (8.888s)
[466.952960] Starting dynamic subtest: D-eDP1
[475.842350] Dynamic subtest D-eDP1: SUCCESS (8.896s)
[475.846725] Subtest plain-flip-fb-recreate: SUCCESS (35.522s)
[477.112889] [099/132] (549s left) i915_suspend (debugfs-reader)
[477.177231] Starting subtest: debugfs-reader
[495.158815] Subtest debugfs-reader: SUCCESS (3.205s)
[495.338032] [100/132] (531s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[495.443013] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[495.447142] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[495.569228] [101/132] (531s left) gem_exec_nop (basic-sequential)
[495.639825] Starting subtest: basic-sequential
[510.065539] Subtest basic-sequential: SUCCESS (14.543s)
[510.323453] [102/132] (516s left) gem_pxp (create-regular-buffer)
[510.465593] Starting subtest: create-regular-buffer
[510.468199] Subtest create-regular-buffer: SUCCESS (0.000s)
[510.617031] [103/132] (516s left) syncobj_basic (test-valid-cycle)
[510.673791] Starting subtest: test-valid-cycle
[510.676609] Subtest test-valid-cycle: SUCCESS (0.000s)
[510.795051] [104/132] (515s left) gem_exec_suspend (basic-s3-devices)
[510.854749] Starting subtest: basic-S3-devices
[510.857130] Starting dynamic subtest: smem
[522.538452] Dynamic subtest smem: SUCCESS (11.699s)
[522.541127] Subtest basic-S3-devices: SUCCESS (11.700s)
[522.749980] [105/132] (504s left) template (a)
[522.819359] Starting subtest: A
[522.821406] Subtest A: SUCCESS (0.000s)
[522.958597] [106/132] (503s left) gem_mmap_gtt (bad-object)
[523.024799] Subtest bad-object: SKIP (0.000s)
[523.093626] [107/132] (503s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[523.195268] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[523.199568] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[523.333239] [108/132] (503s left) api_intel_bb (intel-bb-blit-y)
[523.391988] Starting subtest: intel-bb-blit-y
[527.184806] Subtest intel-bb-blit-y: SUCCESS (3.792s)
[527.344681] [109/132] (499s left) kms_selftest (drm_format_helper)
[527.391976] Starting subtest: drm_format_helper
[527.436285] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[527.598467] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.162s)
[527.609120] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[527.753385] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.154s)
[527.762531] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[527.899245] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.143s)
[527.908233] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[528.054377] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.154s)
[528.063112] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[528.203221] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.148s)
[528.212298] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[528.362394] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.160s)
[528.373032] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[528.511054] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.145s)
[528.522268] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[528.660995] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.149s)
[528.671364] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[528.819349] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.159s)
[528.828072] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[528.972918] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.152s)
[528.983227] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[529.118250] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.145s)
[529.126678] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[529.270000] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.150s)
[529.278668] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[529.427256] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.159s)
[529.436022] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[529.583512] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.153s)
[529.599475] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[529.739010] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.155s)
[529.749317] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[529.904045] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.165s)
[529.914678] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[530.068720] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.163s)
[530.070629] Subtest drm_format_helper: SUCCESS (2.675s)
[530.305137] [110/132] (496s left) gem_mmap_offset (oob-read)
[530.367186] Starting subtest: oob-read
[530.369429] Subtest oob-read: SUCCESS (0.000s)
[530.505092] [111/132] (496s left) gem_spin_batch (resubmit-all)
[530.576035] Starting subtest: resubmit-all
[530.578384] Starting dynamic subtest: rcs0
[530.593475] Dynamic subtest rcs0: SUCCESS (0.017s)
[530.605066] Starting dynamic subtest: bcs0
[530.607238] Dynamic subtest bcs0: SUCCESS (0.003s)
[530.615706] Starting dynamic subtest: vcs0
[530.617843] Dynamic subtest vcs0: SUCCESS (0.002s)
[530.626570] Starting dynamic subtest: vcs1
[530.628688] Dynamic subtest vcs1: SUCCESS (0.002s)
[530.637026] Starting dynamic subtest: vecs0
[530.639115] Dynamic subtest vecs0: SUCCESS (0.002s)
[530.647681] Starting dynamic subtest: ccs0
[530.649766] Dynamic subtest ccs0: SUCCESS (0.002s)
[530.651838] Subtest resubmit-all: SUCCESS (0.032s)
[532.649391] [112/132] (494s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[532.772693] Starting subtest: cursorB-vs-flipA-toggle
[532.777310] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[532.942635] [113/132] (494s left) gen9_exec_parse (valid-registers)
[533.006278] Subtest valid-registers: SKIP (0.000s)
[533.075152] [114/132] (494s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[533.167988] Starting subtest: disable-crc-after-crtc
[533.169826] Starting dynamic subtest: pipe-A-eDP-1
[534.806074] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.640s)
[534.816108] Starting dynamic subtest: pipe-B-eDP-1
[537.096644] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.286s)
[537.107089] Starting dynamic subtest: pipe-C-eDP-1
[539.289522] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.195s)
[539.300757] Starting dynamic subtest: pipe-D-eDP-1
[541.499559] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.208s)
[541.501866] Subtest disable-crc-after-crtc: SUCCESS (8.334s)
[542.321963] [115/132] (484s left) gem_exec_fence (syncobj-unused-fence)
[542.741576] Starting subtest: syncobj-unused-fence
[542.746558] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[544.736262] [116/132] (482s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[544.850546] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[544.854666] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[544.993211] [117/132] (482s left) gem_set_tiling_vs_pwrite
[545.112798] [118/132] (482s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[545.209202] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[545.213042] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[545.326350] [119/132] (482s left) vgem_basic (busy-fence)
[545.365981] Starting subtest: busy-fence
[545.368273] Subtest busy-fence: SUCCESS (0.000s)
[545.445741] [120/132] (481s left) i915_pm_rpm (debugfs-read)
[546.962307] Starting subtest: debugfs-read
[548.118035] Subtest debugfs-read: SUCCESS (1.153s)
[548.504830] [121/132] (478s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[548.614959] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[553.216096] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.605s)
[554.435976] [122/132] (473s left) perf_pmu (busy-start)
[554.483897] Starting subtest: busy-start
[554.486212] Starting dynamic subtest: rcs0
[557.033768] Dynamic subtest rcs0: SUCCESS (2.549s)
[557.045356] Starting dynamic subtest: bcs0
[559.584704] Dynamic subtest bcs0: SUCCESS (2.548s)
[559.596920] Starting dynamic subtest: vcs0
[563.626057] Dynamic subtest vcs0: SUCCESS (4.038s)
[563.638529] Starting dynamic subtest: vcs1
[567.594191] Dynamic subtest vcs1: SUCCESS (3.965s)
[567.606557] Starting dynamic subtest: vecs0
[571.626055] Dynamic subtest vecs0: SUCCESS (4.030s)
[571.637991] Starting dynamic subtest: ccs0
[574.174152] Dynamic subtest ccs0: SUCCESS (2.548s)
[574.176646] Subtest busy-start: SUCCESS (19.691s)
[574.321782] [123/132] (453s left) kms_addfb_basic (size-max)
[574.427097] Starting subtest: size-max
[574.429266] Subtest size-max: SUCCESS (0.000s)
[574.547657] [124/132] (453s left) kms_psr (fbc-pr-primary-blt)
[574.655184] Starting subtest: fbc-pr-primary-blt
[574.659303] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[574.761356] [125/132] (452s left) kms_color_pipeline (plane-ctm3x4)
[574.854904] Starting subtest: plane-ctm3x4
[574.868017] Starting dynamic subtest: pipe-A-eDP-1
[575.496084] Dynamic subtest pipe-A-eDP-1: FAIL (0.309s)
[576.243393] Starting dynamic subtest: pipe-B-eDP-1
[577.058844] Dynamic subtest pipe-B-eDP-1: FAIL (0.323s)
[577.634771] Starting dynamic subtest: pipe-C-eDP-1
[578.437298] Dynamic subtest pipe-C-eDP-1: FAIL (0.224s)
[578.938528] Starting dynamic subtest: pipe-D-eDP-1
[579.724735] Dynamic subtest pipe-D-eDP-1: FAIL (0.201s)
[579.727101] Subtest plane-ctm3x4: FAIL (4.569s)
[580.315176] [126/132] (447s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[580.702221] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[581.468242] [127/132] (446s left) api_intel_allocator (standalone)
[581.534585] Starting subtest: standalone
[581.549362] Subtest standalone: SUCCESS (0.017s)
[581.685195] [128/132] (446s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[581.791589] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[588.153236] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.365s)
[588.290242] [129/132] (439s left) kms_big_fb (y-tiled-addfb)
[588.402358] Starting subtest: y-tiled-addfb
[588.406649] Subtest y-tiled-addfb: SKIP (0.000s)
[588.534044] [130/132] (439s left) kms_prime (basic-crc-vgem)
[588.620714] Starting subtest: basic-crc-vgem
[588.622996] Starting dynamic subtest: second-to-first
[589.518023] Dynamic subtest second-to-first: SUCCESS (0.901s)
[589.519978] Subtest basic-crc-vgem: SUCCESS (0.902s)
[589.634262] [131/132] (438s left) i915_hangman (engine-error-state-capture)
[589.746771] Starting subtest: engine-error-state-capture
[589.749497] Starting dynamic subtest: rcs0
[593.545745] Dynamic subtest rcs0: SUCCESS (3.799s)
[593.558078] Starting dynamic subtest: bcs0
[599.561494] Dynamic subtest bcs0: SUCCESS (6.014s)
[599.574566] Starting dynamic subtest: vcs0
[605.512441] Dynamic subtest vcs0: SUCCESS (5.950s)
[605.525339] Starting dynamic subtest: vcs1
[610.504833] Dynamic subtest vcs1: SUCCESS (4.992s)
[610.516447] Starting dynamic subtest: vecs0
[615.497017] Dynamic subtest vecs0: SUCCESS (4.991s)
[615.509119] Starting dynamic subtest: ccs0
[619.593333] Dynamic subtest ccs0: SUCCESS (4.094s)
[619.595983] Subtest engine-error-state-capture: SUCCESS (29.855s)
[619.751418] [132/132] (408s left) kms_invalid_mode (bad-vsync-end)
[619.853464] Starting subtest: bad-vsync-end
[619.855763] Starting dynamic subtest: pipe-A-eDP-1
[620.139814] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[620.149893] Starting dynamic subtest: pipe-B-eDP-1
[620.151926] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[620.160426] Starting dynamic subtest: pipe-C-eDP-1
[620.162805] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[620.171588] Starting dynamic subtest: pipe-D-eDP-1
[620.173910] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[620.176194] Subtest bad-vsync-end: SUCCESS (0.295s)
[621.002694] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_busy
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_pipe_crc_basic
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_sync
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: fbdev
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: gem_ccs
results: parsing output: 36/ for test: gem_fenced_exec_thrash
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: gem_ctx_shared
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_force_connector_basic
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_chamelium_audio
results: parsing output: 49/ for test: gem_set_tiling_vs_gtt
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: prime_busy
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: gem_gtt_cpu_tlb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gen9_exec_parse
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: dmabuf_sync_file
results: parsing output: 60/ for test: kms_dither
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: sw_sync
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_getfb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_atomic
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ctx_exec
results: parsing output: 78/ for test: kms_content_protection
results: parsing output: 79/ for test: gem_eio
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_pm_dc
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_exec_create
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: i915_suspend
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_nop
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: gem_exec_suspend
results: parsing output: 104/ for test: template
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: kms_selftest
results: parsing output: 109/ for test: gem_mmap_offset
results: parsing output: 110/ for test: gem_spin_batch
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_pipe_crc_basic
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_color_pipeline
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_prime
results: parsing output: 130/ for test: i915_hangman
results: parsing output: 131/ for test: kms_invalid_mode
Done.