[58.382544] Initializing watchdogs
[58.382599]   /dev/watchdog0
[58.398433] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.403074] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.405453] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.407628] [001/155] (960s left) i915_query (query-topology-known-pci-ids)
[58.473219] Starting subtest: query-topology-known-pci-ids
[58.475255] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[58.560491] [002/155] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[58.651116] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[63.005818] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.325s)
[64.161737] [003/155] (954s left) kms_big_fb (y-tiled-addfb)
[64.268023] Starting subtest: y-tiled-addfb
[64.270092] Subtest y-tiled-addfb: SKIP (0.000s)
[64.371356] [004/155] (954s left) kms_properties (crtc-properties-legacy)
[64.451767] Starting subtest: crtc-properties-legacy
[64.452701] Starting dynamic subtest: pipe-A-eDP-1
[64.933034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[64.939894] Starting dynamic subtest: pipe-B-eDP-1
[66.164594] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.218s)
[66.173097] Starting dynamic subtest: pipe-C-eDP-1
[67.295322] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.134s)
[67.303465] Starting dynamic subtest: pipe-D-eDP-1
[68.420940] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[68.422305] Subtest crtc-properties-legacy: SUCCESS (3.955s)
[69.249698] [005/155] (949s left) gem_mmap_offset (bad-object)
[69.313420] Starting subtest: bad-object
[69.314593] Subtest bad-object: SUCCESS (0.001s)
[69.405222] [006/155] (949s left) i915_suspend (fence-restore-untiled)
[69.452378] Starting subtest: fence-restore-untiled
[69.454272] Subtest fence-restore-untiled: SKIP (0.000s)
[69.543930] [007/155] (949s left) gem_workarounds (basic-read-context)
[69.602221] Starting subtest: basic-read-context
[69.613437] Subtest basic-read-context: SUCCESS (0.012s)
[69.717554] [008/155] (949s left) gem_exec_flush (basic-wb-ro-before-default)
[69.768293] Starting subtest: basic-wb-ro-before-default
[75.233691] Subtest basic-wb-ro-before-default: SUCCESS (5.457s)
[75.410588] [009/155] (943s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[75.503062] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[75.504708] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[75.605575] [010/155] (943s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[75.707581] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[75.708636] Starting dynamic subtest: pipe-A
[76.040065] Dynamic subtest pipe-A: SUCCESS (0.338s)
[76.048165] Starting dynamic subtest: pipe-B
[77.446804] Dynamic subtest pipe-B: SUCCESS (1.405s)
[77.455188] Starting dynamic subtest: pipe-C
[78.875485] Dynamic subtest pipe-C: SUCCESS (1.427s)
[78.883746] Starting dynamic subtest: pipe-D
[80.319993] Dynamic subtest pipe-D: SUCCESS (1.444s)
[80.321054] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.615s)
[81.481529] [011/155] (937s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[81.580697] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[81.582545] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[81.662265] [012/155] (937s left) gem_mmap_wc (read-write-distinct)
[81.709170] Subtest read-write-distinct: SKIP (0.000s)
[81.768235] [013/155] (937s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-fullscreen)
[81.856752] Starting subtest: hdr-1p-primscrn-spr-indfb-fullscreen
[81.858382] Subtest hdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[81.936067] [014/155] (937s left) kms_atomic_interruptible (legacy-cursor)
[82.028300] Starting subtest: legacy-cursor
[82.029188] Starting dynamic subtest: pipe-A-eDP-1
[89.427225] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.395s)
[89.427995] Subtest legacy-cursor: SUCCESS (7.396s)
[90.270907] [015/155] (929s left) gem_ctx_exec (basic-norecovery)
[90.321154] Starting subtest: basic-norecovery
[90.611653] Subtest basic-norecovery: SUCCESS (0.290s)
[90.737161] [016/155] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[90.842839] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[99.833059] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.992s)
[99.938166] [017/155] (919s left) kms_flip (nonexisting-fb)
[100.030908] Starting subtest: nonexisting-fb
[100.032709] Starting dynamic subtest: A-eDP1
[101.210233] Dynamic subtest A-eDP1: SUCCESS (1.178s)
[101.219095] Starting dynamic subtest: B-eDP1
[102.340479] Dynamic subtest B-eDP1: SUCCESS (1.129s)
[102.348443] Starting dynamic subtest: C-eDP1
[103.472501] Dynamic subtest C-eDP1: SUCCESS (1.131s)
[103.481472] Starting dynamic subtest: D-eDP1
[104.607687] Dynamic subtest D-eDP1: SUCCESS (1.133s)
[104.609992] Subtest nonexisting-fb: SUCCESS (4.579s)
[105.764189] [018/155] (913s left) kms_color (degamma)
[105.853472] Starting subtest: degamma
[105.854462] Starting dynamic subtest: pipe-A-eDP-1
[106.589908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[106.597156] Starting dynamic subtest: pipe-B-eDP-1
[107.980982] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s)
[107.988754] Starting dynamic subtest: pipe-C-eDP-1
[109.385685] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.403s)
[109.393256] Starting dynamic subtest: pipe-D-eDP-1
[110.820398] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.435s)
[110.821273] Subtest degamma: SUCCESS (4.967s)
[111.700239] [019/155] (907s left) gem_close (basic)
[111.748123] Starting subtest: basic
[111.749127] Subtest basic: SUCCESS (0.000s)
[111.865339] [020/155] (907s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[111.957078] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[111.958730] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[112.051274] [021/155] (907s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[112.621078] Starting subtest: syncobj-timeline-invalid-wait
[112.622465] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[114.399164] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[114.401038] [022/155] (905s left) prime_vgem (fence-write-hang)
[114.468682] Subtest fence-write-hang: SKIP (0.000s)
[114.553183] [023/155] (905s left) perf (invalid-oa-format-id)
[114.669804] Starting subtest: invalid-oa-format-id
[114.680431] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[114.720889] [024/155] (904s left) gem_exec_reloc (basic-wc-read)
[114.777619] Subtest basic-wc-read: SKIP (0.000s)
[114.842009] [025/155] (904s left) vgem_slow (nohang)
[114.881561] Starting subtest: nohang
[124.967939] Subtest nohang: SUCCESS (10.040s)
[124.999741] [026/155] (894s left) gem_exec_schedule (pi-shared-iova)
[125.181745] Starting subtest: pi-shared-iova
[125.182724] Starting dynamic subtest: rcs0
[125.323214] Dynamic subtest rcs0: SUCCESS (0.140s)
[125.331501] Starting dynamic subtest: vcs0
[125.411494] Dynamic subtest vcs0: SUCCESS (0.097s)
[125.422941] Starting dynamic subtest: vcs1
[125.504044] Dynamic subtest vcs1: SUCCESS (0.091s)
[125.512598] Starting dynamic subtest: vecs0
[125.591591] Dynamic subtest vecs0: SUCCESS (0.085s)
[125.603126] Starting dynamic subtest: ccs0
[125.707067] Dynamic subtest ccs0: SUCCESS (0.116s)
[125.708558] Subtest pi-shared-iova: SUCCESS (0.534s)
[127.413464] [027/155] (892s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[127.507019] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[127.508835] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[127.606042] [028/155] (892s left) gem_ctx_param (invalid-size-get)
[127.651465] Starting subtest: invalid-size-get
[127.652543] Subtest invalid-size-get: SUCCESS (0.001s)
[127.734251] [029/155] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[127.827510] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[127.829398] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[127.924674] [030/155] (891s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[128.022710] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[128.024304] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[128.122352] [031/155] (891s left) gem_exec_await (wide-all)
[128.299792] Starting subtest: wide-all
[151.176247] Subtest wide-all: SUCCESS (22.874s)
[151.367505] [032/155] (868s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[151.506602] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[151.508571] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[151.576159] [033/155] (868s left) kms_flip (2x-flip-vs-fences)
[151.664543] Starting subtest: 2x-flip-vs-fences
[151.666628] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[151.753563] [034/155] (868s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[151.838622] Starting subtest: fbc-psr2-primary-mmap-cpu
[151.839538] Starting dynamic subtest: eDP-1
[151.841284] Dynamic subtest eDP-1: SKIP (0.000s)
[151.843044] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[151.906737] [035/155] (868s left) gem_exec_reloc (basic-write-read-active)
[151.953477] Subtest basic-write-read-active: SKIP (0.000s)
[152.018878] [036/155] (868s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[152.116280] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[152.118157] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[152.234770] [037/155] (867s left) perf (missing-sample-flags)
[152.350966] Starting subtest: missing-sample-flags
[152.352602] Subtest missing-sample-flags: SUCCESS (0.000s)
[152.389784] [038/155] (867s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[152.478331] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[152.480134] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[152.584651] [039/155] (867s left) syncobj_wait (wait-delayed-signal)
[152.639153] Starting subtest: wait-delayed-signal
[152.743179] Subtest wait-delayed-signal: SUCCESS (0.103s)
[152.818039] [040/155] (867s left) kms_plane_cursor (primary)
[152.911559] Starting subtest: primary
[152.913454] Starting dynamic subtest: pipe-A-eDP-1-size-64
[155.511255] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.600s)
[155.537190] Starting dynamic subtest: pipe-A-eDP-1-size-128
[158.093244] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.564s)
[158.115840] Starting dynamic subtest: pipe-A-eDP-1-size-256
[160.679868] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[161.000827] Starting dynamic subtest: pipe-B-eDP-1-size-64
[164.284356] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.292s)
[164.311985] Starting dynamic subtest: pipe-B-eDP-1-size-128
[166.919071] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.617s)
[166.944624] Starting dynamic subtest: pipe-B-eDP-1-size-256
[169.586787] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.650s)
[169.899915] Starting dynamic subtest: pipe-C-eDP-1-size-64
[172.883758] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.992s)
[172.913652] Starting dynamic subtest: pipe-C-eDP-1-size-128
[175.183940] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.281s)
[175.211642] Starting dynamic subtest: pipe-C-eDP-1-size-256
[177.450462] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.247s)
[177.767431] Starting dynamic subtest: pipe-D-eDP-1-size-64
[180.708055] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.949s)
[180.735533] Starting dynamic subtest: pipe-D-eDP-1-size-128
[182.930776] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[182.958551] Starting dynamic subtest: pipe-D-eDP-1-size-256
[185.230792] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.281s)
[185.536526] Subtest primary: SUCCESS (32.625s)
[186.419113] [041/155] (833s left) i915_pm_rpm (gem-execbuf)
[188.478843] Starting subtest: gem-execbuf
[188.480254] Starting dynamic subtest: smem0
[190.284856] Dynamic subtest smem0: SUCCESS (1.808s)
[190.286311] Subtest gem-execbuf: SUCCESS (1.810s)
[190.396380] [042/155] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[190.480629] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[190.482332] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[190.596481] [043/155] (829s left) prime_busy (hang-wait)
[190.647346] Starting subtest: hang-wait
[190.648278] Starting dynamic subtest: rcs0
[216.830795] Dynamic subtest rcs0: SUCCESS (26.182s)
[216.841087] Starting dynamic subtest: bcs0
[223.918240] Dynamic subtest bcs0: SUCCESS (7.084s)
[223.927996] Starting dynamic subtest: vcs0
[231.020359] Dynamic subtest vcs0: SUCCESS (7.101s)
[231.031914] Starting dynamic subtest: vcs1
[237.995562] Dynamic subtest vcs1: SUCCESS (6.970s)
[238.006498] Starting dynamic subtest: vecs0
[244.970630] Dynamic subtest vecs0: SUCCESS (6.974s)
[244.981263] Starting dynamic subtest: ccs0
[258.878050] Dynamic subtest ccs0: SUCCESS (13.908s)
[258.879459] Subtest hang-wait: SUCCESS (68.227s)
[258.994595] [044/155] (761s left) gem_lmem_swapping (parallel-multi)
[259.034686] Subtest parallel-multi: SKIP (0.000s)
[259.080802] [045/155] (761s left) gem_exec_reloc (basic-cpu-wc)
[259.149278] Subtest basic-cpu-wc: SKIP (0.000s)
[259.233363] [046/155] (761s left) kms_psr (psr2-dpms)
[259.325160] Starting subtest: psr2-dpms
[259.325961] Starting dynamic subtest: eDP-1
[262.275337] Dynamic subtest eDP-1: SUCCESS (2.948s)
[262.276466] Subtest psr2-dpms: SUCCESS (2.949s)
[263.132615] [047/155] (757s left) gem_exec_balancer (full)
[263.186215] Starting subtest: full
[268.194673] Subtest full: SUCCESS (5.009s)
[268.508731] [048/155] (751s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[268.603041] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[268.604815] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[268.692306] [049/155] (751s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[268.777376] Starting subtest: fbcpsr-rgb565-draw-render
[275.889675] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.113s)
[276.021210] [050/155] (744s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[276.073229] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[276.175909] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[276.251814] [051/155] (744s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt)
[276.343188] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt
[276.344820] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[276.426068] [052/155] (744s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[276.514540] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[276.515460] Starting dynamic subtest: pipe-A-eDP-1
[276.524054] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[276.533057] Starting dynamic subtest: pipe-B-eDP-1
[276.541691] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[276.550731] Starting dynamic subtest: pipe-C-eDP-1
[276.559172] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[276.567522] Starting dynamic subtest: pipe-D-eDP-1
[276.575834] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[276.577461] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[278.844035] [053/155] (741s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[278.942620] Starting subtest: fbchdr-rgb101010-draw-render
[278.944391] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[279.029139] [054/155] (741s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[279.139529] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[280.242665] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.101s)
[280.349393] [055/155] (740s left) kms_addfb_basic (unused-handle)
[280.400100] Starting subtest: unused-handle
[280.408886] Subtest unused-handle: SUCCESS (0.000s)
[280.531910] [056/155] (740s left) gem_reg_read (timestamp-moving)
[280.572858] Starting subtest: timestamp-moving
[281.574386] Subtest timestamp-moving: SUCCESS (1.001s)
[281.647045] [057/155] (739s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt)
[281.743862] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt
[281.745867] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[281.853841] [058/155] (739s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[281.942418] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[281.944088] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[282.030592] [059/155] (738s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[282.122083] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[282.123899] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[282.215051] [060/155] (738s left) gem_exec_parallel (userptr)
[282.275562] Starting subtest: userptr
[282.276662] Starting dynamic subtest: rcs0
[283.695670] Dynamic subtest rcs0: SUCCESS (1.420s)
[283.706997] Starting dynamic subtest: bcs0
[285.174207] Dynamic subtest bcs0: SUCCESS (1.477s)
[285.185658] Starting dynamic subtest: vcs0
[287.332567] Dynamic subtest vcs0: SUCCESS (2.147s)
[287.344512] Starting dynamic subtest: vcs1
[289.317227] Dynamic subtest vcs1: SUCCESS (1.982s)
[289.328244] Starting dynamic subtest: vecs0
[291.300734] Dynamic subtest vecs0: SUCCESS (1.980s)
[291.312028] Starting dynamic subtest: ccs0
[292.808070] Dynamic subtest ccs0: SUCCESS (1.515s)
[292.808920] Subtest userptr: SUCCESS (10.533s)
[292.992308] [061/155] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[293.086507] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[302.932601] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.845s)
[303.078846] [062/155] (717s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[303.166272] Starting subtest: crc-primary-suspend-y-tiled-ccs
[303.167300] Starting dynamic subtest: pipe-A-eDP-1
[303.171089] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[303.182200] Starting dynamic subtest: pipe-B-eDP-1
[303.185871] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[303.194722] Starting dynamic subtest: pipe-C-eDP-1
[303.198390] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[303.207219] Starting dynamic subtest: pipe-D-eDP-1
[303.210664] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[303.212367] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[305.470470] [063/155] (715s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[305.562489] Starting subtest: compare-crc-sanitycheck-xr24
[305.564577] Starting dynamic subtest: pipe-A-eDP-1
[306.248712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.683s)
[306.257626] Starting dynamic subtest: pipe-B-eDP-1
[307.584713] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.335s)
[307.593801] Starting dynamic subtest: pipe-C-eDP-1
[308.857853] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.272s)
[308.867803] Starting dynamic subtest: pipe-D-eDP-1
[310.091306] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[310.092358] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.527s)
[310.925897] [064/155] (710s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[310.981587] Starting subtest: invalid-multi-wait-all-unsubmitted
[310.982553] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[311.095456] [065/155] (710s left) kms_vrr (max-min)
[311.194095] Starting subtest: max-min
[311.196899] Subtest max-min: SKIP (0.000s)
[311.262202] [066/155] (709s left) kms_invalid_mode (bad-hsync-end)
[311.354585] Starting subtest: bad-hsync-end
[311.355528] Starting dynamic subtest: pipe-A-eDP-1
[311.651448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[311.660681] Starting dynamic subtest: pipe-B-eDP-1
[311.661777] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[311.670200] Starting dynamic subtest: pipe-C-eDP-1
[311.671216] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[311.679727] Starting dynamic subtest: pipe-D-eDP-1
[311.680849] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[311.681857] Subtest bad-hsync-end: SUCCESS (0.304s)
[312.463023] [067/155] (708s left) kms_chamelium_audio (hdmi-audio)
[312.853915] Subtest hdmi-audio: SKIP (0.000s)
[313.681219] [068/155] (707s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[313.777120] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[313.778694] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[313.845840] [069/155] (707s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[313.934544] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[313.936395] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[314.030859] [070/155] (707s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[314.131441] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[314.133365] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[314.209470] [071/155] (707s left) gem_exec_whisper (basic-queues-all)
[314.270913] Starting subtest: basic-queues-all
[326.276868] Subtest basic-queues-all: SUCCESS (11.996s)
[326.451160] [072/155] (694s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[326.540404] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[326.542472] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[327.636826] [073/155] (693s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary)
[327.728590] Starting subtest: hdr-shrfb-scaledprimary
[327.730356] Subtest hdr-shrfb-scaledprimary: SKIP (0.000s)
[327.840321] [074/155] (693s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[327.924299] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[334.562322] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.638s)
[334.706333] [075/155] (686s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[334.793156] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[334.794835] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[334.880693] [076/155] (686s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[334.982969] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[334.984759] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[335.063105] [077/155] (686s left) gem_pxp (verify-pxp-stale-buf-execution)
[335.182058] Starting subtest: verify-pxp-stale-buf-execution
[336.239934] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.059s)
[336.363562] [078/155] (685s left) syncobj_timeline (wait-all-delayed-signal)
[336.416756] Starting subtest: wait-all-delayed-signal
[336.520860] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[336.593853] [079/155] (685s left) kms_flip (flip-vs-fences)
[336.688042] Starting subtest: flip-vs-fences
[336.689861] Subtest flip-vs-fences: SKIP (0.000s)
[336.783294] [080/155] (684s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[336.884456] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[336.885279] Starting dynamic subtest: pipe-A-default-mode
[338.054337] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[338.056557] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.169s)
[338.207679] [081/155] (683s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[338.341810] Starting subtest: cursor-vs-flip-legacy
[368.182421] Subtest cursor-vs-flip-legacy: SUCCESS (29.839s)
[369.064173] [082/155] (652s left) kms_psr (fbc-psr-primary-render)
[369.149769] Starting subtest: fbc-psr-primary-render
[369.150796] Starting dynamic subtest: eDP-1
[369.152490] Dynamic subtest eDP-1: SKIP (0.000s)
[369.154097] Subtest fbc-psr-primary-render: SKIP (0.001s)
[369.232232] [083/155] (652s left) syncobj_timeline (invalid-signal-illegal-point)
[369.288561] Starting subtest: invalid-signal-illegal-point
[369.289769] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[369.398755] [084/155] (652s left) kms_psr (psr2-sprite-mmap-gtt)
[369.492575] Starting subtest: psr2-sprite-mmap-gtt
[369.493516] Starting dynamic subtest: eDP-1
[370.976074] Dynamic subtest eDP-1: SKIP (1.473s)
[370.977976] Subtest psr2-sprite-mmap-gtt: SKIP (1.475s)
[371.119201] [085/155] (650s left) kms_psr (fbc-pr-cursor-blt)
[371.202382] Starting subtest: fbc-pr-cursor-blt
[371.204296] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[371.271325] [086/155] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[371.360599] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[371.362399] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[371.453733] [087/155] (650s left) gem_mmap_wc (write-wc-read-gtt)
[371.501720] Subtest write-wc-read-gtt: SKIP (0.000s)
[371.560260] [088/155] (650s left) fbdev (unaligned-read)
[371.596094] Starting subtest: unaligned-read
[371.612015] Subtest unaligned-read: SUCCESS (0.016s)
[371.661455] [089/155] (650s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[371.713649] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[371.766560] [090/155] (650s left) i915_drm_fdinfo (memory-info-active)
[371.802239] Starting subtest: memory-info-active
[371.803425] Starting dynamic subtest: smem0
[374.536081] Dynamic subtest smem0: SUCCESS (2.733s)
[374.537638] Subtest memory-info-active: SUCCESS (2.734s)
[374.610201] [091/155] (647s left) gem_exec_schedule (semaphore-user)
[374.663604] Starting subtest: semaphore-user
[374.726503] Subtest semaphore-user: SUCCESS (0.062s)
[376.383934] [092/155] (645s left) kms_cursor_crc (cursor-offscreen-128x128)
[376.594463] Starting subtest: cursor-offscreen-128x128
[376.598290] Starting dynamic subtest: pipe-A-eDP-1
[378.531640] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[378.562246] Starting dynamic subtest: pipe-D-eDP-1
[381.140283] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s)
[381.141209] Subtest cursor-offscreen-128x128: SUCCESS (4.544s)
[381.986713] [093/155] (640s left) kms_pm_rpm (system-suspend-modeset)
[383.507592] Starting subtest: system-suspend-modeset
[403.287192] Subtest system-suspend-modeset: SUCCESS (5.164s)
[407.742611] [094/155] (618s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[407.842654] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[407.844370] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[407.925221] [095/155] (618s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[408.009225] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[408.010908] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[408.097765] [096/155] (618s left) gem_ctx_param (invalid-param-get)
[408.150522] Starting subtest: invalid-param-get
[408.151320] Subtest invalid-param-get: SUCCESS (0.001s)
[408.240053] [097/155] (618s left) perf (gen12-invalid-class-instance)
[408.323579] Starting subtest: gen12-invalid-class-instance
[408.331881] Subtest gen12-invalid-class-instance: SUCCESS (0.008s)
[408.378819] [098/155] (617s left) gem_vm_create (invalid-create)
[408.427896] Starting subtest: invalid-create
[408.430182] Subtest invalid-create: SUCCESS (0.002s)
[408.529625] [099/155] (617s left) dmabuf (all-tests)
[408.560256] Starting subtest: all-tests
[408.563731] Subtest all-tests: SKIP (0.000s)
[408.636743] [100/155] (617s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[408.725173] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[408.727079] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[408.826910] [101/155] (617s left) perf_pmu (frequency)
[408.861836] Starting subtest: frequency
[408.865873] Starting dynamic subtest: gt0
[411.018735] Dynamic subtest gt0: SUCCESS (2.105s)
[411.032238] Starting dynamic subtest: idle-gt0
[411.543359] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[411.557708] Starting dynamic subtest: gt1
[415.929156] Dynamic subtest gt1: SUCCESS (4.325s)
[415.941933] Starting dynamic subtest: idle-gt1
[416.438127] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[416.439732] Subtest frequency: SUCCESS (7.455s)
[416.535250] [102/155] (609s left) perf_pmu (most-busy-check-all)
[416.571309] Starting subtest: most-busy-check-all
[416.572811] Starting dynamic subtest: rcs0
[417.980957] Dynamic subtest rcs0: SUCCESS (1.388s)
[417.991805] Starting dynamic subtest: bcs0
[419.964938] Dynamic subtest bcs0: SUCCESS (1.968s)
[419.976651] Starting dynamic subtest: vcs0
[421.949304] Dynamic subtest vcs0: SUCCESS (1.971s)
[421.961072] Starting dynamic subtest: vcs1
[423.933690] Dynamic subtest vcs1: SUCCESS (1.973s)
[423.945618] Starting dynamic subtest: vecs0
[425.981121] Dynamic subtest vecs0: SUCCESS (2.038s)
[425.993105] Starting dynamic subtest: ccs0
[427.965749] Dynamic subtest ccs0: SUCCESS (1.976s)
[427.967373] Subtest most-busy-check-all: SUCCESS (11.331s)
[428.069788] [103/155] (598s left) gem_ctx_persistence (hostile)
[428.123838] Starting subtest: hostile
[438.291385] Subtest hostile: SUCCESS (10.141s)
[438.387966] [104/155] (588s left) sysfs_heartbeat_interval (invalid)
[438.440001] Starting subtest: invalid
[438.441593] Starting dynamic subtest: vecs0
[438.443094] Dynamic subtest vecs0: SUCCESS (0.000s)
[438.455221] Starting dynamic subtest: ccs0
[438.456307] Dynamic subtest ccs0: SUCCESS (0.000s)
[438.466023] Starting dynamic subtest: vcs0
[438.467177] Dynamic subtest vcs0: SUCCESS (0.000s)
[438.477191] Starting dynamic subtest: bcs0
[438.478362] Dynamic subtest bcs0: SUCCESS (0.000s)
[438.489028] Starting dynamic subtest: rcs0
[438.490342] Dynamic subtest rcs0: SUCCESS (0.000s)
[438.500175] Starting dynamic subtest: vcs1
[438.501616] Dynamic subtest vcs1: SUCCESS (0.000s)
[438.502633] Subtest invalid: SUCCESS (0.006s)
[438.538502] [105/155] (588s left) kms_vblank (invalid)
[438.631011] Starting subtest: invalid
[438.632301] Starting dynamic subtest: pipe-A-eDP-1
[439.055446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[439.057025] Subtest invalid: SUCCESS (0.423s)
[439.931088] [106/155] (586s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[440.015528] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[440.016870] Starting dynamic subtest: pipe-A-eDP-1
[440.511931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.485s)
[440.524042] Starting dynamic subtest: pipe-B-eDP-1
[441.991009] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.468s)
[442.001615] Starting dynamic subtest: pipe-C-eDP-1
[443.363964] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[443.375229] Starting dynamic subtest: pipe-D-eDP-1
[444.819815] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.458s)
[444.820597] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.795s)
[445.974382] [107/155] (580s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[446.098125] Starting subtest: cursorA-vs-flipB-varying-size
[446.100702] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[446.239518] [108/155] (580s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[446.329588] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[446.331345] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[446.422906] [109/155] (580s left) i915_pm_freq_mult (media-freq)
[446.466925] Starting subtest: media-freq
[446.468000] Starting dynamic subtest: gt0
[446.470297] Dynamic subtest gt0: SKIP (0.000s)
[446.481220] Starting dynamic subtest: gt1
[446.483784] Dynamic subtest gt1: SKIP (0.000s)
[446.485992] Subtest media-freq: SKIP (0.001s)
[446.585067] [110/155] (580s left) kms_flip (modeset-vs-vblank-race)
[446.667659] Starting subtest: modeset-vs-vblank-race
[446.668600] Starting dynamic subtest: A-eDP1
[451.495147] Dynamic subtest A-eDP1: SUCCESS (4.825s)
[451.507903] Starting dynamic subtest: B-eDP1
[456.331366] Dynamic subtest B-eDP1: SUCCESS (4.833s)
[456.345035] Starting dynamic subtest: C-eDP1
[461.061684] Dynamic subtest C-eDP1: SUCCESS (4.726s)
[461.075022] Starting dynamic subtest: D-eDP1
[465.791069] Dynamic subtest D-eDP1: SUCCESS (4.726s)
[465.794333] Subtest modeset-vs-vblank-race: SUCCESS (19.122s)
[466.949946] [111/155] (559s left) kms_feature_discovery (chamelium)
[467.039302] Starting subtest: chamelium
[467.041595] Subtest chamelium: SKIP (0.000s)
[467.110371] [112/155] (559s left) gem_exec_fence (basic-wait)
[467.281662] Starting subtest: basic-wait
[467.282926] Starting dynamic subtest: rcs0
[467.360766] Dynamic subtest rcs0: SUCCESS (0.081s)
[467.374598] Starting dynamic subtest: bcs0
[467.422910] Dynamic subtest bcs0: SUCCESS (0.059s)
[467.435714] Starting dynamic subtest: vcs0
[467.483902] Dynamic subtest vcs0: SUCCESS (0.058s)
[467.497094] Starting dynamic subtest: vcs1
[467.541307] Dynamic subtest vcs1: SUCCESS (0.055s)
[467.554275] Starting dynamic subtest: vecs0
[467.594544] Dynamic subtest vecs0: SUCCESS (0.051s)
[467.606652] Starting dynamic subtest: ccs0
[467.655852] Dynamic subtest ccs0: SUCCESS (0.058s)
[467.657602] Subtest basic-wait: SUCCESS (0.378s)
[468.997603] [113/155] (557s left) vgem_basic (unload)
[469.030627] Starting subtest: unload
[498.029784] Subtest unload: SUCCESS (28.988s)
[498.125033] [114/155] (528s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[498.222050] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[498.223042] Starting dynamic subtest: pipe-A-default-mode
[501.017577] Dynamic subtest pipe-A-default-mode: SUCCESS (2.794s)
[501.018605] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.796s)
[501.846090] [115/155] (525s left) kms_cursor_crc (cursor-sliding-128x42)
[502.070211] Starting subtest: cursor-sliding-128x42
[502.115632] Subtest cursor-sliding-128x42: SKIP (0.044s)
[502.310634] [116/155] (524s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[502.363309] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[502.364796] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[502.457721] [117/155] (524s left) kms_big_fb (linear-8bpp-rotate-270)
[502.550185] Starting subtest: linear-8bpp-rotate-270
[502.572117] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[502.674484] [118/155] (524s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[502.756902] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[502.758774] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[502.827398] [119/155] (524s left) kms_big_fb (4-tiled-addfb)
[502.914512] Starting subtest: 4-tiled-addfb
[502.915478] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[502.996408] [120/155] (524s left) kms_atomic (test-only)
[503.076896] Starting subtest: test-only
[503.125930] Starting dynamic subtest: pipe-A-eDP-1
[505.675534] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.550s)
[505.676643] Subtest test-only: SUCCESS (2.602s)
[506.537145] [121/155] (520s left) kms_async_flips (alternate-sync-async-flip-atomic)
[506.629196] Starting subtest: alternate-sync-async-flip-atomic
[507.001020] Starting dynamic subtest: pipe-A-eDP-1
[509.825644] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.825s)
[510.219110] Starting dynamic subtest: pipe-B-eDP-1
[512.971688] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[513.366079] Starting dynamic subtest: pipe-C-eDP-1
[516.119769] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[516.498778] Starting dynamic subtest: pipe-D-eDP-1
[519.259865] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[519.261550] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.635s)
[520.419200] [122/155] (506s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[520.524620] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[524.259524] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.738s)
[525.423202] [123/155] (501s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-blt)
[525.510799] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-blt
[525.512653] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[525.597850] [124/155] (501s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[525.693103] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[525.694075] Starting dynamic subtest: pipe-A
[526.867618] Dynamic subtest pipe-A: SUCCESS (1.176s)
[526.877110] Starting dynamic subtest: pipe-B
[529.156945] Dynamic subtest pipe-B: SUCCESS (2.288s)
[529.167059] Starting dynamic subtest: pipe-C
[530.318096] Dynamic subtest pipe-C: SUCCESS (1.160s)
[530.328504] Starting dynamic subtest: pipe-D
[531.548678] Dynamic subtest pipe-D: SUCCESS (1.229s)
[531.550092] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.857s)
[532.739334] [125/155] (494s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[532.836245] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[532.837969] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[532.925295] [126/155] (494s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[533.010019] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[537.236596] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.227s)
[538.438760] [127/155] (488s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt)
[538.541628] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt
[538.543388] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[538.637460] [128/155] (488s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[538.720364] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[538.721576] Starting dynamic subtest: pipe-A-eDP-1
[538.781214] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[538.795236] Starting dynamic subtest: pipe-B-eDP-1
[538.843064] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[538.854705] Starting dynamic subtest: pipe-C-eDP-1
[538.905046] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s)
[538.915038] Starting dynamic subtest: pipe-D-eDP-1
[538.969779] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.064s)
[538.970992] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.251s)
[541.303252] [129/155] (486s left) kms_properties (plane-properties-legacy)
[541.386625] Starting subtest: plane-properties-legacy
[541.387494] Starting dynamic subtest: pipe-A-eDP-1
[541.925994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.538s)
[541.936045] Starting dynamic subtest: pipe-B-eDP-1
[543.171975] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.243s)
[543.183337] Starting dynamic subtest: pipe-C-eDP-1
[544.488217] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.316s)
[544.500803] Starting dynamic subtest: pipe-D-eDP-1
[545.728344] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[545.729333] Subtest plane-properties-legacy: SUCCESS (4.342s)
[546.541691] [130/155] (480s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt)
[546.639803] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt
[546.641355] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[546.727742] [131/155] (480s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[546.815823] Starting subtest: psr-2p-primscrn-cur-indfb-move
[546.817823] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[546.909627] [132/155] (480s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[546.998772] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[547.000662] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[547.096694] [133/155] (480s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[547.231748] Starting subtest: dp-mst-lic-type-0-hdcp14
[547.233935] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[547.338777] [134/155] (480s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[547.433644] Starting subtest: psr-shrfb-scaledprimary
[553.220678] Subtest psr-shrfb-scaledprimary: SUCCESS (5.788s)
[553.341088] [135/155] (474s left) gem_softpin (evict-prime)
[553.397956] Starting subtest: evict-prime
[553.399623] Starting dynamic subtest: rcs0
[554.569144] Dynamic subtest rcs0: SUCCESS (1.170s)
[554.583680] Starting dynamic subtest: bcs0
[555.689288] Dynamic subtest bcs0: SUCCESS (1.118s)
[555.701927] Starting dynamic subtest: vcs0
[556.931523] Dynamic subtest vcs0: SUCCESS (1.231s)
[556.946124] Starting dynamic subtest: vcs1
[558.974607] Dynamic subtest vcs1: SUCCESS (2.041s)
[558.987027] Starting dynamic subtest: vecs0
[560.948769] Dynamic subtest vecs0: SUCCESS (1.971s)
[560.962323] Starting dynamic subtest: ccs0
[562.065705] Dynamic subtest ccs0: SUCCESS (1.123s)
[562.078802] Starting dynamic subtest: all
[563.964993] Dynamic subtest all: SUCCESS (1.888s)
[563.966639] Subtest evict-prime: SUCCESS (10.557s)
[564.043676] [136/155] (463s left) api_intel_bb (intel-bb-blit-x)
[564.095081] Starting subtest: intel-bb-blit-x
[567.908173] Subtest intel-bb-blit-x: SUCCESS (3.804s)
[568.009732] [137/155] (459s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[568.107562] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[568.134599] Starting dynamic subtest: pipe-A-plane-0
[568.556706] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[568.567139] Starting dynamic subtest: pipe-A-plane-3
[568.890035] Dynamic subtest pipe-A-plane-3: SUCCESS (0.332s)
[569.970655] Starting dynamic subtest: pipe-B-plane-0
[570.372622] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[570.382646] Starting dynamic subtest: pipe-B-plane-3
[570.706655] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s)
[571.027115] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.919s)
[571.858139] [138/155] (455s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render)
[571.946642] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render
[571.948644] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[572.048906] [139/155] (455s left) gen9_exec_parse (allowed-single)
[572.099777] Subtest allowed-single: SKIP (0.000s)
[572.162731] [140/155] (455s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[572.538645] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[573.346080] [141/155] (454s left) kms_psr (psr-primary-page-flip)
[573.437041] Starting subtest: psr-primary-page-flip
[573.438349] Starting dynamic subtest: eDP-1
[575.171638] Dynamic subtest eDP-1: SUCCESS (1.734s)
[575.172796] Subtest psr-primary-page-flip: SUCCESS (1.735s)
[576.033360] [142/155] (451s left) gem_exec_reloc (basic-write-read)
[576.086924] Subtest basic-write-read: SKIP (0.000s)
[576.144587] [143/155] (451s left) kms_cursor_edge_walk (128x128-top-bottom)
[576.234550] Starting subtest: 128x128-top-bottom
[576.235385] Starting dynamic subtest: pipe-A-eDP-1
[579.701378] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s)
[579.713801] Starting dynamic subtest: pipe-D-eDP-1
[582.851947] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.148s)
[582.853072] Subtest 128x128-top-bottom: SUCCESS (6.616s)
[583.659101] [144/155] (444s left) kms_dp_link_training (uhbr-sst)
[583.747257] Starting subtest: uhbr-sst
[583.751996] Subtest uhbr-sst: SKIP (0.000s)
[583.816094] [145/155] (444s left) gem_ctx_sseu (invalid-sseu)
[583.871024] Subtest invalid-sseu: SKIP (0.000s)
[583.929402] [146/155] (444s left) gem_ctx_param (get-priority-new-ctx)
[583.978628] Starting subtest: get-priority-new-ctx
[583.980056] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[584.073785] [147/155] (444s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[584.446311] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[585.269210] [148/155] (442s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[585.357934] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[585.360612] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[585.435651] [149/155] (442s left) kms_rotation_crc (primary-rotation-270)
[585.523919] Starting subtest: primary-rotation-270
[585.526100] Subtest primary-rotation-270: SKIP (0.001s)
[585.596190] [150/155] (442s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite)
[585.685826] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite
[585.687605] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[585.794500] [151/155] (442s left) kms_frontbuffer_tracking (hdr-2p-rte)
[585.891253] Starting subtest: hdr-2p-rte
[585.893292] Subtest hdr-2p-rte: SKIP (0.000s)
[585.989140] [152/155] (442s left) gem_ringfill (legacy-basic)
[591.935157] Starting subtest: legacy-basic
[591.936371] Starting dynamic subtest: default
[591.996347] Dynamic subtest default: SUCCESS (0.067s)
[592.011186] Starting dynamic subtest: render
[592.041097] Dynamic subtest render: SUCCESS (0.042s)
[592.053830] Starting dynamic subtest: bsd
[592.087785] Dynamic subtest bsd: SUCCESS (0.044s)
[592.100659] Starting dynamic subtest: bsd1
[592.128182] Dynamic subtest bsd1: SUCCESS (0.038s)
[592.140357] Starting dynamic subtest: bsd2
[592.177355] Dynamic subtest bsd2: SUCCESS (0.047s)
[592.190778] Starting dynamic subtest: blt
[592.222776] Dynamic subtest blt: SUCCESS (0.042s)
[592.235361] Starting dynamic subtest: vebox
[592.266909] Dynamic subtest vebox: SUCCESS (0.041s)
[592.268349] Subtest legacy-basic: SUCCESS (0.339s)
[592.345605] [153/155] (436s left) kms_pm_rpm (cursor-dpms)
[594.071591] Starting subtest: cursor-dpms
[594.074962] Subtest cursor-dpms: SKIP (0.000s)
[594.626952] [154/155] (433s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[594.722579] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[594.724586] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[594.818799] [155/155] (433s left) gem_create (create-ext-placement-sanity-check)
[594.980267] Starting subtest: create-ext-placement-sanity-check
[594.982082] Subtest create-ext-placement-sanity-check: SUCCESS (0.002s)
[595.064159] Closing watchdogs
results: parsing output: 0/ for test: i915_query
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_properties
results: parsing output: 4/ for test: gem_mmap_offset
results: parsing output: 5/ for test: i915_suspend
results: parsing output: 6/ for test: gem_workarounds
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_mmap_wc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_atomic_interruptible
results: parsing output: 14/ for test: gem_ctx_exec
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_color
results: parsing output: 18/ for test: gem_close
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: prime_vgem
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: vgem_slow
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_ctx_param
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_await
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_plane_cursor
results: parsing output: 40/ for test: i915_pm_rpm
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: prime_busy
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: gem_exec_reloc
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: gem_reg_read
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_parallel
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_vrr
results: parsing output: 65/ for test: kms_invalid_mode
results: parsing output: 66/ for test: kms_chamelium_audio
results: parsing output: 67/ for test: kms_joiner
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_whisper
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_pxp
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_mmap_wc
results: parsing output: 87/ for test: fbdev
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: i915_drm_fdinfo
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_cursor_crc
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_ctx_param
results: parsing output: 96/ for test: perf
results: parsing output: 97/ for test: gem_vm_create
results: parsing output: 98/ for test: dmabuf
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: sysfs_heartbeat_interval
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: i915_pm_freq_mult
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_feature_discovery
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: vgem_basic
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_atomic
results: parsing output: 120/ for test: kms_async_flips
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_properties
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_content_protection
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_softpin
results: parsing output: 135/ for test: api_intel_bb
results: parsing output: 136/ for test: kms_plane
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gen9_exec_parse
results: parsing output: 139/ for test: kms_chamelium_frames
results: parsing output: 140/ for test: kms_psr
results: parsing output: 141/ for test: gem_exec_reloc
results: parsing output: 142/ for test: kms_cursor_edge_walk
results: parsing output: 143/ for test: kms_dp_link_training
results: parsing output: 144/ for test: gem_ctx_sseu
results: parsing output: 145/ for test: gem_ctx_param
results: parsing output: 146/ for test: kms_chamelium_hpd
results: parsing output: 147/ for test: kms_psr2_sf
results: parsing output: 148/ for test: kms_rotation_crc
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: gem_ringfill
results: parsing output: 152/ for test: kms_pm_rpm
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_create
Done.