[47.873454] Initializing watchdogs
[47.873520]   /dev/watchdog0
[47.890304] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[47.895930] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[47.898889] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[47.901329] [001/156] (960s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[48.009329] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[48.010715] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[48.111925] [002/156] (960s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[48.208667] Starting subtest: y-tiled-32bpp-rotate-90
[49.641131] Subtest y-tiled-32bpp-rotate-90: SUCCESS (1.434s)
[49.771678] [003/156] (958s left) gem_mmap_gtt (medium-copy)
[49.806750] Starting subtest: medium-copy
[53.031285] Subtest medium-copy: SUCCESS (3.228s)
[53.134409] [004/156] (955s left) kms_psr (fbc-pr-primary-render)
[53.276228] Subtest fbc-pr-primary-render: SKIP (0.000s)
[53.314423] [005/156] (955s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[53.404341] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[53.405029] Starting dynamic subtest: pipe-A-HDMI-A-1
[69.676210] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.532s)
[69.683413] Starting dynamic subtest: pipe-B-HDMI-A-1
[86.652058] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.382s)
[86.661844] Starting dynamic subtest: pipe-C-HDMI-A-1
[103.635101] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.366s)
[103.642855] Starting dynamic subtest: pipe-D-HDMI-A-1
[120.628942] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.344s)
[120.629685] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SUCCESS (5.629s)
[132.857874] [006/156] (887s left) kms_vblank (query-forked-hang)
[132.958384] Starting subtest: query-forked-hang
[132.959134] Starting dynamic subtest: pipe-A-HDMI-A-1
[147.249948] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.302s)
[147.260214] Starting dynamic subtest: pipe-D-HDMI-A-1
[161.064866] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.817s)
[161.065600] Subtest query-forked-hang: SUCCESS (28.124s)
[161.253465] [007/156] (859s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[161.354371] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite
[161.355827] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[161.457937] [008/156] (859s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[161.550401] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[161.551851] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[161.657627] [009/156] (859s left) kms_psr (psr2-sprite-render)
[161.747425] Subtest psr2-sprite-render: SKIP (0.000s)
[161.788933] [010/156] (858s left) kms_flip (dpms-vs-vblank-race)
[161.877535] Starting subtest: dpms-vs-vblank-race
[161.879194] Starting dynamic subtest: A-HDMI-A1
[164.717001] Dynamic subtest A-HDMI-A1: SUCCESS (2.838s)
[164.724690] Starting dynamic subtest: B-HDMI-A1
[167.559087] Dynamic subtest B-HDMI-A1: SUCCESS (2.842s)
[167.568958] Starting dynamic subtest: C-HDMI-A1
[170.345809] Dynamic subtest C-HDMI-A1: SUCCESS (2.785s)
[170.354603] Starting dynamic subtest: D-HDMI-A1
[173.214130] Dynamic subtest D-HDMI-A1: SUCCESS (2.866s)
[173.215867] Subtest dpms-vs-vblank-race: SUCCESS (11.340s)
[173.356447] [011/156] (847s left) kms_lease (master-vs-lease)
[173.458965] Starting subtest: master-vs-lease
[173.459763] Subtest master-vs-lease: SUCCESS (0.001s)
[173.527810] [012/156] (847s left) gem_create (busy-create)
[173.566713] Starting subtest: busy-create
[173.567408] Starting dynamic subtest: smem0
[205.820640] Dynamic subtest smem0: SUCCESS (32.253s)
[205.821935] Subtest busy-create: SUCCESS (32.255s)
[206.022455] [013/156] (814s left) gem_exec_params (cliprects_ptr-dirt)
[206.062625] Starting subtest: cliprects_ptr-dirt
[206.063392] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[206.170276] [014/156] (814s left) syncobj_timeline (single-wait-available-submitted)
[206.212451] Starting subtest: single-wait-available-submitted
[206.213229] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[206.281657] [015/156] (814s left) kms_rotation_crc (exhaust-fences)
[206.371962] Starting subtest: exhaust-fences
[207.505274] Subtest exhaust-fences: SUCCESS (1.133s)
[207.599466] [016/156] (813s left) kms_properties (plane-properties-atomic)
[207.693104] Starting subtest: plane-properties-atomic
[207.693910] Starting dynamic subtest: pipe-A-HDMI-A-1
[207.938200] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.245s)
[207.948309] Starting dynamic subtest: pipe-B-HDMI-A-1
[208.216207] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.276s)
[208.227446] Starting dynamic subtest: pipe-C-HDMI-A-1
[208.500809] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.282s)
[208.510353] Starting dynamic subtest: pipe-D-HDMI-A-1
[208.796718] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.293s)
[208.797415] Subtest plane-properties-atomic: SUCCESS (1.105s)
[208.961501] [017/156] (812s left) i915_drm_fdinfo (busy-idle-check-all)
[209.003935] Starting subtest: busy-idle-check-all
[209.004782] Starting dynamic subtest: rcs0
[209.624156] Dynamic subtest rcs0: SUCCESS (0.619s)
[209.634747] Starting dynamic subtest: bcs0
[210.247818] Dynamic subtest bcs0: SUCCESS (0.621s)
[210.257038] Starting dynamic subtest: vcs0
[210.870098] Dynamic subtest vcs0: SUCCESS (0.621s)
[210.883404] Starting dynamic subtest: vcs1
[211.494024] Dynamic subtest vcs1: SUCCESS (0.622s)
[211.504557] Starting dynamic subtest: vecs0
[212.117609] Dynamic subtest vecs0: SUCCESS (0.620s)
[212.118798] Subtest busy-idle-check-all: SUCCESS (3.113s)
[212.200836] [018/156] (808s left) prime_vgem (basic-write)
[212.330229] Starting subtest: basic-write
[212.361280] Subtest basic-write: SUCCESS (0.031s)
[212.433125] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[212.435248] [019/156] (808s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[212.526771] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[212.528214] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[212.700850] [020/156] (808s left) kms_busy (extended-pageflip-hang-newfb)
[212.800166] Starting subtest: extended-pageflip-hang-newfb
[212.800921] Starting dynamic subtest: pipe-A
[226.133627] Dynamic subtest pipe-A: SUCCESS (13.334s)
[226.144712] Starting dynamic subtest: pipe-D
[240.462277] Dynamic subtest pipe-D: SUCCESS (14.325s)
[240.463077] Subtest extended-pageflip-hang-newfb: SUCCESS (27.665s)
[240.598256] [021/156] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[240.699750] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[240.701136] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[240.790407] [022/156] (780s left) kms_cursor_crc (cursor-sliding-512x170)
[240.884586] Starting subtest: cursor-sliding-512x170
[240.887078] Subtest cursor-sliding-512x170: SKIP (0.001s)
[240.980964] [023/156] (780s left) gem_basic (multigpu-create-close)
[241.015180] Starting subtest: multigpu-create-close
[241.016591] Subtest multigpu-create-close: SKIP (0.000s)
[241.076423] [024/156] (780s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[241.171535] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[241.173040] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[241.264989] [025/156] (780s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[241.359184] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[241.360619] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[241.457325] [026/156] (779s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[241.553823] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[241.555324] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[241.651835] [027/156] (779s left) kms_cursor_crc (cursor-random-128x128)
[241.744361] Starting subtest: cursor-random-128x128
[241.748985] Starting dynamic subtest: pipe-A-HDMI-A-1
[243.645159] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.895s)
[243.689918] Starting dynamic subtest: pipe-D-HDMI-A-1
[245.583535] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.902s)
[245.584276] Subtest cursor-random-128x128: SUCCESS (3.840s)
[245.792048] [028/156] (775s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[245.891434] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[245.892829] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[245.994730] [029/156] (775s left) gem_exec_balancer (indices)
[246.038601] Starting subtest: indices
[247.403695] Subtest indices: SUCCESS (1.365s)
[247.595382] [030/156] (774s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[247.691624] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[248.780825] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (1.089s)
[248.954078] [031/156] (772s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[249.053213] Starting subtest: psr-rgb565-draw-blt
[249.054706] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[249.148910] [032/156] (772s left) gem_lmem_swapping (parallel-random-engines)
[249.187614] Subtest parallel-random-engines: SKIP (0.000s)
[249.257466] [033/156] (772s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[249.361113] Starting subtest: x-tiled-32bpp-rotate-90
[249.439174] Subtest x-tiled-32bpp-rotate-90: SKIP (0.078s)
[249.543970] [034/156] (772s left) prime_vgem (sync)
[249.608423] Starting subtest: sync
[249.609162] Starting dynamic subtest: rcs0
[249.627386] Dynamic subtest rcs0: SUCCESS (0.018s)
[249.638021] Starting dynamic subtest: bcs0
[249.643470] Dynamic subtest bcs0: SUCCESS (0.015s)
[249.653087] Starting dynamic subtest: vcs0
[249.665302] Dynamic subtest vcs0: SUCCESS (0.021s)
[249.674339] Starting dynamic subtest: vcs1
[249.683576] Dynamic subtest vcs1: SUCCESS (0.017s)
[249.692998] Starting dynamic subtest: vecs0
[249.700940] Dynamic subtest vecs0: SUCCESS (0.016s)
[249.701707] Subtest sync: SUCCESS (0.093s)
[249.814096] [035/156] (772s left) kms_prop_blob (blob-prop-core)
[249.848957] Starting subtest: blob-prop-core
[249.849746] Subtest blob-prop-core: SUCCESS (0.000s)
[249.908091] [036/156] (772s left) perf_pmu (semaphore-busy)
[249.946362] Starting subtest: semaphore-busy
[249.947092] Starting dynamic subtest: rcs0
[251.517542] Dynamic subtest rcs0: SUCCESS (1.561s)
[251.529469] Starting dynamic subtest: bcs0
[253.068033] Dynamic subtest bcs0: SUCCESS (1.548s)
[253.080177] Starting dynamic subtest: vcs0
[254.630265] Dynamic subtest vcs0: SUCCESS (1.558s)
[254.642058] Starting dynamic subtest: vcs1
[256.182324] Dynamic subtest vcs1: SUCCESS (1.549s)
[256.194145] Starting dynamic subtest: vecs0
[257.728480] Dynamic subtest vecs0: SUCCESS (1.543s)
[257.729548] Subtest semaphore-busy: SUCCESS (7.774s)
[257.801222] [037/156] (764s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[257.894325] Starting subtest: addfb25-x-tiled-legacy
[257.895098] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[257.996105] [038/156] (763s left) gem_exec_balancer (parallel-ordering)
[258.158547] Subtest parallel-ordering: SKIP (0.000s)
[258.249294] [039/156] (763s left) kms_addfb_basic (bad-pitch-1024)
[258.284261] Starting subtest: bad-pitch-1024
[258.284988] Subtest bad-pitch-1024: SUCCESS (0.000s)
[258.468046] [040/156] (763s left) gem_ctx_shared (exec-shared-gtt)
[258.511628] Starting subtest: exec-shared-gtt
[258.512402] Starting dynamic subtest: rcs0
[258.516884] Dynamic subtest rcs0: SUCCESS (0.005s)
[258.527412] Starting dynamic subtest: bcs0
[258.528146] Dynamic subtest bcs0: SUCCESS (0.003s)
[258.537593] Starting dynamic subtest: vcs0
[258.538303] Dynamic subtest vcs0: SUCCESS (0.003s)
[258.546225] Starting dynamic subtest: vcs1
[258.546906] Dynamic subtest vcs1: SUCCESS (0.004s)
[258.554943] Starting dynamic subtest: vecs0
[258.555666] Dynamic subtest vecs0: SUCCESS (0.003s)
[258.556339] Subtest exec-shared-gtt: SUCCESS (0.023s)
[258.731597] [041/156] (763s left) device_reset (unbind-cold-reset-rebind)
[258.780739] Starting subtest: unbind-cold-reset-rebind
[258.782326] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[258.842087] [042/156] (763s left) prime_vgem (basic-gtt)
[258.908913] Starting subtest: basic-gtt
[258.921964] Subtest basic-gtt: SUCCESS (0.013s)
[259.031276] [043/156] (763s left) gem_pwrite_snooped
[259.175466] [044/156] (763s left) gem_userptr_blits (invalid-null-pointer)
[259.214479] Starting subtest: invalid-null-pointer
[259.216850] Subtest invalid-null-pointer: SUCCESS (0.001s)
[259.340165] [045/156] (762s left) perf (invalid-oa-metric-set-id)
[259.429034] Starting subtest: invalid-oa-metric-set-id
[259.439811] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[259.483816] [046/156] (762s left) gem_ctx_persistence (userptr)
[259.523521] Starting subtest: userptr
[259.626131] Subtest userptr: SUCCESS (0.100s)
[259.695638] [047/156] (762s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[259.787110] Starting subtest: primary-yf-tiled-reflect-x-180
[259.841516] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.053s)
[259.930844] [048/156] (762s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[260.022880] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[260.023607] Starting dynamic subtest: pipe-A
[260.423144] Dynamic subtest pipe-A: SUCCESS (0.400s)
[260.439280] Starting dynamic subtest: pipe-B
[260.874665] Dynamic subtest pipe-B: SUCCESS (0.450s)
[260.886920] Starting dynamic subtest: pipe-C
[261.316965] Dynamic subtest pipe-C: SUCCESS (0.441s)
[261.332747] Starting dynamic subtest: pipe-D
[261.760047] Dynamic subtest pipe-D: SUCCESS (0.442s)
[261.760742] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (1.739s)
[261.943104] [049/156] (760s left) api_intel_bb (delta-check)
[261.981105] Starting subtest: delta-check
[261.983398] Subtest delta-check: SUCCESS (0.003s)
[262.092786] [050/156] (760s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[262.188455] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[262.189959] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[262.274149] [051/156] (760s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[262.368471] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[262.369876] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[262.467898] [052/156] (760s left) gem_userptr_blits (create-destroy-unsync)
[262.508735] Subtest create-destroy-unsync: SKIP (0.000s)
[262.627051] [053/156] (760s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[262.721321] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[262.722863] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[262.827166] [054/156] (759s left) kms_async_flips (test-cursor)
[262.917150] Starting subtest: test-cursor
[263.047354] Starting dynamic subtest: pipe-A-HDMI-A-1
[263.143404] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.097s)
[263.282607] Starting dynamic subtest: pipe-B-HDMI-A-1
[263.349179] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.075s)
[263.465689] Starting dynamic subtest: pipe-C-HDMI-A-1
[263.552600] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.097s)
[263.669109] Starting dynamic subtest: pipe-D-HDMI-A-1
[263.752119] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.091s)
[263.752906] Subtest test-cursor: SUCCESS (0.836s)
[264.031824] [055/156] (758s left) kms_chamelium_audio (dp-audio-edid)
[264.183677] Subtest dp-audio-edid: SKIP (0.000s)
[264.284829] [056/156] (758s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[264.323971] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[264.324745] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[264.401674] [057/156] (758s left) kms_psr (pr-primary-mmap-gtt)
[264.492753] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[264.539367] [058/156] (758s left) syncobj_wait (multi-wait-signaled)
[264.575084] Starting subtest: multi-wait-signaled
[264.575789] Subtest multi-wait-signaled: SUCCESS (0.000s)
[264.649686] [059/156] (758s left) syncobj_timeline (invalid-wait-bad-flags)
[264.685939] Starting subtest: invalid-wait-bad-flags
[264.686776] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[264.743298] [060/156] (758s left) api_intel_bb (lot-of-buffers)
[264.778056] Starting subtest: lot-of-buffers
[266.101765] Subtest lot-of-buffers: SUCCESS (1.316s)
[266.254696] [061/156] (756s left) gem_ctx_persistence (engines-mixed)
[266.294106] Starting subtest: engines-mixed
[266.294810] Starting dynamic subtest: rcs0
[266.333568] Dynamic subtest rcs0: SUCCESS (0.040s)
[266.349893] Starting dynamic subtest: bcs0
[266.384677] Dynamic subtest bcs0: SUCCESS (0.049s)
[266.405173] Starting dynamic subtest: vcs0
[266.449726] Dynamic subtest vcs0: SUCCESS (0.061s)
[266.471838] Starting dynamic subtest: vcs1
[266.515819] Dynamic subtest vcs1: SUCCESS (0.063s)
[266.538288] Starting dynamic subtest: vecs0
[266.572675] Dynamic subtest vecs0: SUCCESS (0.053s)
[266.573851] Subtest engines-mixed: SUCCESS (0.281s)
[266.656127] [062/156] (756s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[266.754106] Starting subtest: flip-vs-cursor-varying-size
[275.540546] Subtest flip-vs-cursor-varying-size: SUCCESS (8.787s)
[275.677572] [063/156] (747s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[275.779495] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[275.780911] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[275.854146] [064/156] (747s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render)
[275.948877] Starting subtest: fbcpsrhdr-rgb101010-draw-render
[275.950220] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s)
[276.063801] [065/156] (747s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[276.154408] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[276.155154] Starting dynamic subtest: pipe-A-HDMI-A-1
[276.162196] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[276.171091] Starting dynamic subtest: pipe-B-HDMI-A-1
[276.178253] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[276.186921] Starting dynamic subtest: pipe-C-HDMI-A-1
[276.193963] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[276.202303] Starting dynamic subtest: pipe-D-HDMI-A-1
[276.209321] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[276.210666] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[276.414474] [066/156] (746s left) gem_exec_schedule (preempt-queue-chain)
[276.461691] Starting subtest: preempt-queue-chain
[276.462510] Starting dynamic subtest: rcs0
[276.609148] Dynamic subtest rcs0: SUCCESS (0.138s)
[276.619078] Starting dynamic subtest: bcs0
[276.754204] Dynamic subtest bcs0: SUCCESS (0.144s)
[276.764264] Starting dynamic subtest: vcs0
[276.895867] Dynamic subtest vcs0: SUCCESS (0.140s)
[276.905932] Starting dynamic subtest: vcs1
[277.036573] Dynamic subtest vcs1: SUCCESS (0.139s)
[277.045990] Starting dynamic subtest: vecs0
[277.176152] Dynamic subtest vecs0: SUCCESS (0.138s)
[277.177030] Subtest preempt-queue-chain: SUCCESS (0.707s)
[277.475501] [067/156] (745s left) kms_psr (fbc-psr-cursor-render)
[277.570186] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[277.617157] [068/156] (745s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[277.711527] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[277.712942] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[277.807284] [069/156] (745s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[277.901546] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[277.902953] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[278.013188] [070/156] (745s left) kms_big_fb (linear-8bpp-rotate-180)
[278.112982] Starting subtest: linear-8bpp-rotate-180
[279.400518] Subtest linear-8bpp-rotate-180: SUCCESS (1.287s)
[279.525425] [071/156] (743s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[279.565536] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[279.566306] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[279.643279] [072/156] (743s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[279.687085] Starting subtest: x-tiled-to-vebox-yf-tiled
[279.687827] Starting dynamic subtest: smem
[279.754128] Dynamic subtest smem: SUCCESS (0.068s)
[279.754916] Subtest x-tiled-to-vebox-yf-tiled: SUCCESS (0.069s)
[279.941944] [073/156] (743s left) gen9_exec_parse (batch-zero-length)
[279.981755] Subtest batch-zero-length: SKIP (0.000s)
[280.024507] [074/156] (743s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[280.121420] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[280.122903] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[280.222603] [075/156] (743s left) kms_chamelium_edid (dp-mode-timings)
[280.368439] Subtest dp-mode-timings: SKIP (0.000s)
[280.477155] [076/156] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[280.576760] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[280.578091] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[280.675181] [077/156] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[280.769398] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[280.770910] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[280.853354] [078/156] (742s left) gem_softpin (32b-excludes-last-page)
[280.893286] Starting subtest: 32b-excludes-last-page
[280.895341] Subtest 32b-excludes-last-page: SUCCESS (0.002s)
[281.009886] [079/156] (742s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[281.044488] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[281.160955] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[281.225361] [080/156] (742s left) gem_exec_fence (submit67)
[281.387066] Starting subtest: submit67
[281.388131] Starting dynamic subtest: rcs0
[282.327380] Dynamic subtest rcs0: SUCCESS (0.931s)
[282.336129] Starting dynamic subtest: bcs0
[282.785870] Dynamic subtest bcs0: SUCCESS (0.457s)
[282.795279] Starting dynamic subtest: vcs0
[283.289085] Dynamic subtest vcs0: SUCCESS (0.502s)
[283.297843] Starting dynamic subtest: vcs1
[283.789378] Dynamic subtest vcs1: SUCCESS (0.499s)
[283.800657] Starting dynamic subtest: vecs0
[284.268435] Dynamic subtest vecs0: SUCCESS (0.478s)
[284.269202] Subtest submit67: SUCCESS (2.874s)
[284.745914] [081/156] (739s left) gem_exec_params (invalid-bsd1-flag-on-render)
[284.783948] Starting subtest: invalid-bsd1-flag-on-render
[284.784769] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[284.871657] [082/156] (739s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[284.967429] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[284.968927] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[285.049977] [083/156] (738s left) i915_pm_rpm (gem-evict-pwrite)
[286.455541] Starting subtest: gem-evict-pwrite
[287.712964] Subtest gem-evict-pwrite: SUCCESS (1.258s)
[287.910221] [084/156] (736s left) gem_exec_create (forked)
[287.955566] Starting subtest: forked
[287.956311] Starting dynamic subtest: smem
[308.040167] Dynamic subtest smem: SUCCESS (20.086s)
[308.040883] Subtest forked: SUCCESS (20.087s)
[308.231125] [085/156] (715s left) gem_mmap_offset (ptrace)
[308.266515] Starting subtest: ptrace
[308.268899] Starting dynamic subtest: smem0-gtt
[308.295837] Dynamic subtest smem0-gtt: SUCCESS (0.027s)
[308.305965] Starting dynamic subtest: smem0-wb
[308.313893] Dynamic subtest smem0-wb: SUCCESS (0.017s)
[308.323788] Starting dynamic subtest: smem0-wc
[308.333207] Dynamic subtest smem0-wc: SUCCESS (0.018s)
[308.343241] Starting dynamic subtest: smem0-uc
[308.353334] Dynamic subtest smem0-uc: SUCCESS (0.019s)
[308.354054] Subtest ptrace: SUCCESS (0.087s)
[308.458965] [086/156] (715s left) perf (oa-exponents)
[308.537426] Starting subtest: oa-exponents
[308.538229] Starting dynamic subtest: 0-rcs0
[312.001718] Dynamic subtest 0-rcs0: SUCCESS (3.456s)
[312.002495] Subtest oa-exponents: SUCCESS (3.457s)
[312.037531] [087/156] (712s left) kms_lease (implicit-plane-lease)
[312.144069] Starting subtest: implicit-plane-lease
[312.144915] Subtest implicit-plane-lease: SUCCESS (0.001s)
[312.208184] [088/156] (711s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[312.299886] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[312.300643] Starting dynamic subtest: pipe-A-valid-mode
[313.527094] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.227s)
[313.527943] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.228s)
[313.687996] [089/156] (710s left) perf (create-destroy-userspace-config)
[313.788585] Starting subtest: create-destroy-userspace-config
[313.807469] Subtest create-destroy-userspace-config: SUCCESS (0.018s)
[313.853467] [090/156] (710s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[313.949979] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[313.950699] Starting dynamic subtest: pipe-A-valid-mode
[314.990129] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.040s)
[314.991904] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.042s)
[315.163181] [091/156] (709s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[315.260075] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[315.260777] Starting dynamic subtest: pipe-A
[315.399139] Dynamic subtest pipe-A: SUCCESS (0.140s)
[315.409800] Starting dynamic subtest: pipe-B
[315.561768] Dynamic subtest pipe-B: SUCCESS (0.161s)
[315.572375] Starting dynamic subtest: pipe-C
[315.730542] Dynamic subtest pipe-C: SUCCESS (0.168s)
[315.743516] Starting dynamic subtest: pipe-D
[315.882401] Dynamic subtest pipe-D: SUCCESS (0.150s)
[315.883151] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.624s)
[316.089244] [092/156] (708s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[316.183818] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[316.185292] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[316.272134] [093/156] (708s left) gem_exec_reloc (basic-write-cpu-active)
[316.312179] Starting subtest: basic-write-cpu-active
[316.441164] Subtest basic-write-cpu-active: SUCCESS (0.121s)
[316.556395] [094/156] (707s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[316.703327] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[316.801585] [095/156] (707s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[316.905139] Starting subtest: stress-xrgb8888-ytiled
[324.299738] Subtest stress-xrgb8888-ytiled: SUCCESS (7.396s)
[324.437300] [096/156] (700s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[324.542060] Starting subtest: 4-tiled-64bpp-rotate-270
[324.543474] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[324.629300] [097/156] (699s left) kms_cursor_crc (cursor-random-128x42)
[324.721564] Starting subtest: cursor-random-128x42
[324.726033] Starting dynamic subtest: pipe-A-HDMI-A-1
[326.625158] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.899s)
[326.670881] Starting dynamic subtest: pipe-D-HDMI-A-1
[328.552429] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.889s)
[328.553188] Subtest cursor-random-128x42: SUCCESS (3.831s)
[328.712911] [098/156] (695s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render)
[328.814752] Starting subtest: hdr-rgb101010-draw-render
[328.816137] Subtest hdr-rgb101010-draw-render: SKIP (0.000s)
[328.912067] [099/156] (695s left) gem_exec_schedule (smoketest)
[329.081285] Starting subtest: smoketest
[329.082304] Starting dynamic subtest: rcs0
[334.540585] Dynamic subtest rcs0: SUCCESS (5.418s)
[334.552131] Starting dynamic subtest: bcs0
[339.961748] Dynamic subtest bcs0: SUCCESS (5.421s)
[339.972616] Starting dynamic subtest: vcs0
[345.383914] Dynamic subtest vcs0: SUCCESS (5.422s)
[345.394564] Starting dynamic subtest: vcs1
[350.805718] Dynamic subtest vcs1: SUCCESS (5.421s)
[350.816285] Starting dynamic subtest: vecs0
[356.230360] Dynamic subtest vecs0: SUCCESS (5.422s)
[356.231323] Subtest smoketest: SUCCESS (27.112s)
[356.373949] [100/156] (668s left) gem_exec_gttfill (engines)
[356.418482] Starting subtest: engines
[356.419223] Starting dynamic subtest: rcs0
[379.681088] Dynamic subtest rcs0: SUCCESS (23.260s)
[379.692191] Starting dynamic subtest: bcs0
[402.677566] Dynamic subtest bcs0: SUCCESS (22.994s)
[402.691769] Starting dynamic subtest: vcs0
[425.892957] Dynamic subtest vcs0: SUCCESS (23.213s)
[425.908789] Starting dynamic subtest: vcs1
[448.895353] Dynamic subtest vcs1: SUCCESS (22.999s)
[448.907298] Starting dynamic subtest: vecs0
[471.913722] Dynamic subtest vecs0: SUCCESS (23.018s)
[471.914526] Subtest engines: SUCCESS (115.493s)
[472.133834] [101/156] (552s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[472.291066] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[472.292482] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[472.448539] [102/156] (552s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[472.541067] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[472.542505] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[472.655089] [103/156] (552s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[472.748772] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[472.750271] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[472.926803] [104/156] (552s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[473.019133] Starting subtest: fbcpsrhdr-suspend
[473.020509] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[473.137365] [105/156] (551s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[473.233293] Starting subtest: 2x-plain-flip-ts-check-interruptible
[473.243129] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.009s)
[473.307155] [106/156] (551s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[473.399088] Starting subtest: cursorB-vs-flipA-legacy
[473.401561] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[473.472841] [107/156] (551s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[473.564946] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[473.616926] [108/156] (551s left) gem_exec_suspend (basic-s4-devices)
[473.663040] Starting subtest: basic-S4-devices
[473.663737] Starting dynamic subtest: smem
[481.491977] Dynamic subtest smem: SUCCESS (7.829s)
[481.493556] Subtest basic-S4-devices: SUCCESS (7.831s)
[490.704358] [109/156] (543s left) kms_content_protection (atomic-dpms)
[490.810283] Starting subtest: atomic-dpms
[490.816834] Subtest atomic-dpms: SKIP (0.004s)
[490.901034] [110/156] (543s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[490.996478] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[490.997904] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[491.096748] [111/156] (543s left) kms_feature_discovery (dp-mst)
[491.188137] Starting subtest: dp-mst
[491.189550] Subtest dp-mst: SKIP (0.000s)
[491.267820] [112/156] (543s left) gem_mmap_gtt (big-copy-xy)
[491.303312] Starting subtest: big-copy-XY
[501.507515] Subtest big-copy-XY: SUCCESS (10.204s)
[501.578672] [113/156] (532s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[501.736249] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[501.737836] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[501.842706] [114/156] (532s left) gem_eio (in-flight-immediate)
[501.891201] Starting subtest: in-flight-immediate
[504.141392] Subtest in-flight-immediate: SUCCESS (2.250s)
[504.277286] [115/156] (530s left) kms_vrr (flipline)
[504.367113] Starting subtest: flipline
[504.369143] Subtest flipline: SKIP (0.000s)
[504.432892] [116/156] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[504.525690] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[504.527092] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[504.599674] [117/156] (530s left) perf (gen12-oa-tlb-invalidate)
[504.684143] Starting subtest: gen12-oa-tlb-invalidate
[504.684875] Starting dynamic subtest: 0-rcs0
[514.752648] Dynamic subtest 0-rcs0: SUCCESS (10.033s)
[514.753967] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.034s)
[514.821077] [118/156] (519s left) syncobj_wait (reset-multiple-signaled)
[514.862307] Starting subtest: reset-multiple-signaled
[514.863069] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[514.925750] [119/156] (519s left) gem_userptr_blits (stress-purge)
[514.971642] Starting subtest: stress-purge
[520.350409] Subtest stress-purge: SUCCESS (5.372s)
[520.465168] [120/156] (514s left) i915_query (engine-info)
[520.551270] Starting subtest: engine-info
[520.552415] Subtest engine-info: SUCCESS (0.002s)
[520.621606] [121/156] (514s left) gem_close (many-handles-one-vma)
[520.661386] Starting subtest: many-handles-one-vma
[520.685388] Subtest many-handles-one-vma: SUCCESS (0.024s)
[520.795773] [122/156] (514s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[520.900703] Starting subtest: yf-tiled-32bpp-rotate-270
[520.902117] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[521.003866] [123/156] (513s left) gem_mmap_gtt (hang-user)
[521.037818] Starting subtest: hang-user
[556.826814] Subtest hang-user: SUCCESS (35.790s)
[556.924708] [124/156] (478s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[557.016353] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[557.018519] Starting dynamic subtest: pipe-A-HDMI-A-1
[557.025540] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[557.038161] Starting dynamic subtest: pipe-B-HDMI-A-1
[557.045396] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[557.057807] Starting dynamic subtest: pipe-C-HDMI-A-1
[557.064627] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[557.075371] Starting dynamic subtest: pipe-D-HDMI-A-1
[557.083109] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[557.084701] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[557.287827] [125/156] (477s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[557.383066] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[557.384535] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[557.472929] [126/156] (477s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[557.562470] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[557.604445] [127/156] (477s left) sw_sync (sync_expired_merge)
[557.646000] Starting subtest: sync_expired_merge
[558.728772] Subtest sync_expired_merge: SUCCESS (1.074s)
[558.777226] [128/156] (476s left) sysfs_defaults (readonly)
[558.816339] Starting subtest: readonly
[558.818153] Starting dynamic subtest: vecs0
[558.818854] Dynamic subtest vecs0: SUCCESS (0.000s)
[558.828919] Starting dynamic subtest: vcs0
[558.829640] Dynamic subtest vcs0: SUCCESS (0.001s)
[558.839566] Starting dynamic subtest: bcs0
[558.840273] Dynamic subtest bcs0: SUCCESS (0.000s)
[558.850076] Starting dynamic subtest: rcs0
[558.850788] Dynamic subtest rcs0: SUCCESS (0.000s)
[558.862141] Starting dynamic subtest: vcs1
[558.862878] Dynamic subtest vcs1: SUCCESS (0.000s)
[558.863572] Subtest readonly: SUCCESS (0.007s)
[558.898799] [129/156] (476s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[558.994742] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[558.996154] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[559.090902] [130/156] (476s left) kms_psr (fbc-psr2-cursor-plane-move)
[559.182394] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[559.229796] [131/156] (476s left) gem_softpin (allocator-nopin-reserve)
[559.268762] Starting subtest: allocator-nopin-reserve
[559.350177] Subtest allocator-nopin-reserve: SUCCESS (0.081s)
[559.475088] [132/156] (475s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[559.567158] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[559.937794] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (0.370s)
[560.059272] [133/156] (475s left) kms_color (gamma)
[560.147836] Starting subtest: gamma
[560.148654] Starting dynamic subtest: pipe-A-HDMI-A-1
[560.483331] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.335s)
[560.496598] Starting dynamic subtest: pipe-B-HDMI-A-1
[560.794943] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.309s)
[560.806896] Starting dynamic subtest: pipe-C-HDMI-A-1
[561.108814] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.311s)
[561.121983] Starting dynamic subtest: pipe-D-HDMI-A-1
[561.410226] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.302s)
[561.410949] Subtest gamma: SUCCESS (1.263s)
[561.569343] [134/156] (473s left) gem_exec_whisper (basic-fds)
[561.616099] Starting subtest: basic-fds
[564.573838] Subtest basic-fds: SUCCESS (2.956s)
[564.752924] [135/156] (470s left) i915_hangman (gt-engine-hang)
[564.796208] Starting subtest: gt-engine-hang
[564.796921] Starting dynamic subtest: rcs0
[565.377130] Dynamic subtest rcs0: SUCCESS (0.580s)
[565.390795] Starting dynamic subtest: bcs0
[565.957045] Dynamic subtest bcs0: SUCCESS (0.576s)
[565.973208] Starting dynamic subtest: vcs0
[566.543228] Dynamic subtest vcs0: SUCCESS (0.583s)
[566.563723] Starting dynamic subtest: vcs1
[567.127944] Dynamic subtest vcs1: SUCCESS (0.582s)
[567.141734] Starting dynamic subtest: vecs0
[567.698865] Dynamic subtest vecs0: SUCCESS (0.569s)
[567.700087] Subtest gt-engine-hang: SUCCESS (2.903s)
[567.778978] [136/156] (467s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[567.869956] Starting subtest: 2x-long-flip-vs-cursor-atomic
[567.872380] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[567.931778] [137/156] (467s left) prime_vgem (basic-fence-flip)
[567.995946] Starting subtest: basic-fence-flip
[568.276966] Subtest basic-fence-flip: SUCCESS (0.281s)
[568.389341] [138/156] (467s left) prime_mmap (test_refcounting)
[568.424894] Starting subtest: test_refcounting
[568.425601] Starting dynamic subtest: test_refcounting-smem
[568.426300] Dynamic subtest test_refcounting-smem: SUCCESS (0.002s)
[568.427057] Subtest test_refcounting: SUCCESS (0.003s)
[568.516139] [139/156] (467s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[568.610442] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[568.611895] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[568.692478] [140/156] (466s left) prime_mmap (test_forked)
[568.726967] Starting subtest: test_forked
[568.727711] Starting dynamic subtest: test_forked-smem
[568.737368] Dynamic subtest test_forked-smem: SUCCESS (0.011s)
[568.738184] Subtest test_forked: SUCCESS (0.012s)
[568.834201] [141/156] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[568.926394] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[568.927872] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[569.026940] [142/156] (466s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[569.120271] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[569.121796] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[569.217690] [143/156] (466s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-blt)
[569.310501] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-blt
[569.311921] Subtest hdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[569.421112] [144/156] (466s left) kms_pm_rpm (i2c)
[570.849252] Starting subtest: i2c
[573.554851] Subtest i2c: SUCCESS (2.706s)
[573.687602] [145/156] (462s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[573.786457] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[573.787937] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[573.886035] [146/156] (462s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render)
[573.979351] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render
[573.980856] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[574.075483] [147/156] (461s left) gem_readwrite (read-bad-handle)
[574.110182] Starting subtest: read-bad-handle
[574.111562] Subtest read-bad-handle: SUCCESS (0.000s)
[574.221896] [148/156] (461s left) gem_mmap_gtt (basic-write-gtt)
[574.254910] Starting subtest: basic-write-gtt
[574.391636] Subtest basic-write-gtt: SUCCESS (0.128s)
[574.486567] [149/156] (461s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[574.579231] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[574.580618] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[574.664878] [150/156] (461s left) gem_mmap_gtt (cpuset-big-copy)
[574.699086] Starting subtest: cpuset-big-copy
[586.886247] Subtest cpuset-big-copy: SUCCESS (12.187s)
[586.989333] [151/156] (449s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[587.134060] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[588.320828] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.188s)
[588.450254] [152/156] (447s left) kms_cursor_legacy (torture-move)
[588.543987] Starting subtest: torture-move
[588.544742] Starting dynamic subtest: pipe-A
[594.043530] Dynamic subtest pipe-A: SUCCESS (5.491s)
[594.059698] Starting dynamic subtest: pipe-B
[599.549296] Dynamic subtest pipe-B: SUCCESS (5.479s)
[599.565808] Starting dynamic subtest: pipe-C
[605.042115] Dynamic subtest pipe-C: SUCCESS (5.490s)
[605.057619] Starting dynamic subtest: pipe-D
[610.515048] Dynamic subtest pipe-D: SUCCESS (5.473s)
[610.526132] Starting dynamic subtest: all-pipes
[615.977193] Dynamic subtest all-pipes: SUCCESS (5.461s)
[615.978143] Subtest torture-move: SUCCESS (27.400s)
[616.040804] [153/156] (420s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[616.084616] Starting subtest: wait-all-for-submit-delayed-submit
[616.187259] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[616.266883] [154/156] (420s left) kms_getfb (getfb-reject-nv12)
[616.357081] Starting subtest: getfb-reject-nv12
[616.357925] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[616.471272] [155/156] (419s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[616.560309] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[616.561827] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[616.620843] [156/156] (419s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[616.709031] Starting subtest: primary-4-tiled-reflect-x-0
[616.758095] Subtest primary-4-tiled-reflect-x-0: SKIP (0.048s)
[616.859208] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_lease
results: parsing output: 11/ for test: gem_create
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: kms_properties
results: parsing output: 16/ for test: i915_drm_fdinfo
results: parsing output: 17/ for test: prime_vgem
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_busy
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: gem_basic
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_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: kms_prop_blob
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: gem_ctx_shared
results: parsing output: 40/ for test: device_reset
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: gem_pwrite_snooped
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: kms_chamelium_audio
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_render_copy
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_chamelium_edid
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_softpin
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: i915_pm_rpm
results: parsing output: 83/ for test: gem_exec_create
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: kms_lease
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: kms_pipe_stress
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: gem_exec_gttfill
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: gem_exec_suspend
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_feature_discovery
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_vrr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: gem_close
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: sw_sync
results: parsing output: 127/ for test: sysfs_defaults
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_softpin
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_color
results: parsing output: 133/ for test: gem_exec_whisper
results: parsing output: 134/ for test: i915_hangman
results: parsing output: 135/ for test: kms_cursor_legacy
results: parsing output: 136/ for test: prime_vgem
results: parsing output: 137/ for test: prime_mmap
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: prime_mmap
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_pm_rpm
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gem_readwrite
results: parsing output: 147/ for test: gem_mmap_gtt
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_mmap_gtt
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_cursor_legacy
results: parsing output: 152/ for test: syncobj_wait
results: parsing output: 153/ for test: kms_getfb
results: parsing output: 154/ for test: kms_plane
results: parsing output: 155/ for test: kms_rotation_crc
Done.