[69.285763] Initializing watchdogs
[69.285811]   /dev/watchdog0
[69.300170] [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]
[69.304675] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.307063] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.310287] [001/132] (960s left) syncobj_eventfd (binary-wait-before-signal)
[69.396981] Starting subtest: binary-wait-before-signal
[69.427353] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[69.525262] [002/132] (960s left) gem_mmap_gtt (fault-concurrent-x)
[69.598641] Subtest fault-concurrent-X: SKIP (0.000s)
[69.658889] [003/132] (960s left) gem_exec_store (cachelines)
[69.726947] Starting subtest: cachelines
[69.729543] Starting dynamic subtest: rcs0
[69.828090] Dynamic subtest rcs0: SUCCESS (0.101s)
[69.836851] Starting dynamic subtest: bcs0
[69.890963] Dynamic subtest bcs0: SUCCESS (0.062s)
[69.898474] Starting dynamic subtest: vcs0
[69.948952] Dynamic subtest vcs0: SUCCESS (0.057s)
[69.956073] Starting dynamic subtest: vcs1
[70.001847] Dynamic subtest vcs1: SUCCESS (0.052s)
[70.008667] Starting dynamic subtest: vecs0
[70.061905] Dynamic subtest vecs0: SUCCESS (0.059s)
[70.068816] Starting dynamic subtest: ccs0
[70.126886] Dynamic subtest ccs0: SUCCESS (0.064s)
[70.129298] Subtest cachelines: SUCCESS (0.399s)
[70.330660] [004/132] (959s left) drm_read (empty-block)
[70.543660] Starting subtest: empty-block
[71.543969] Subtest empty-block: SUCCESS (0.997s)
[71.710233] [005/132] (958s left) perf (whitelisted-registers-userspace-config)
[71.851955] Starting subtest: whitelisted-registers-userspace-config
[71.854237] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[71.898439] [006/132] (958s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[71.959664] Starting subtest: wait-all-for-submit-delayed-submit
[72.064212] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[72.173101] [007/132] (957s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[72.272106] Starting subtest: random-ccs-data-y-tiled-ccs
[72.274538] Starting dynamic subtest: pipe-A-eDP-1
[72.300634] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[72.309815] Starting dynamic subtest: pipe-B-eDP-1
[72.334655] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[72.344764] Starting dynamic subtest: pipe-C-eDP-1
[72.368515] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[72.376339] Starting dynamic subtest: pipe-D-eDP-1
[72.400235] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[72.404576] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[74.475830] [008/132] (955s left) kms_content_protection (legacy)
[74.611673] Starting subtest: legacy
[74.616208] Subtest legacy: SKIP (0.000s)
[74.758674] [009/132] (955s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[74.849028] Starting subtest: bo-too-small-due-to-tiling
[74.853214] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[74.969240] [010/132] (955s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[75.065089] Starting subtest: primary-yf-tiled-reflect-x-0
[75.128106] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[75.250048] [011/132] (954s left) syncobj_timeline (wait-all-for-submit-complex)
[75.309971] Starting subtest: wait-all-for-submit-complex
[75.524056] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[75.625183] [012/132] (954s left) api_intel_bb (object-reloc-keep-cache)
[75.687051] Starting subtest: object-reloc-keep-cache
[75.691422] Subtest object-reloc-keep-cache: SKIP (0.002s)
[75.824191] [013/132] (954s left) kms_cursor_legacy (single-bo)
[75.956269] Starting subtest: single-bo
[75.958221] Starting dynamic subtest: pipe-A
[81.346695] Dynamic subtest pipe-A: SUCCESS (5.379s)
[81.355393] Starting dynamic subtest: pipe-B
[86.734793] Dynamic subtest pipe-B: SUCCESS (5.380s)
[86.744238] Starting dynamic subtest: pipe-C
[92.118614] Dynamic subtest pipe-C: SUCCESS (5.381s)
[92.127896] Starting dynamic subtest: pipe-D
[97.502400] Dynamic subtest pipe-D: SUCCESS (5.381s)
[97.511781] Starting dynamic subtest: all-pipes
[102.893940] Dynamic subtest all-pipes: SUCCESS (5.388s)
[102.896772] Subtest single-bo: SUCCESS (26.915s)
[103.065663] [014/132] (927s left) kms_cursor_crc (cursor-size-hints)
[103.207641] Starting subtest: cursor-size-hints
[103.209969] Starting dynamic subtest: pipe-A-eDP-1
[103.816906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[103.824763] Starting dynamic subtest: pipe-D-eDP-1
[105.046971] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[105.049462] Subtest cursor-size-hints: SUCCESS (1.838s)
[105.864103] [015/132] (924s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[105.987261] Starting subtest: 2x-flip-vs-cursor-atomic
[105.991986] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[106.155456] [016/132] (924s left) gem_exercise_blt (fast-copy-emit)
[106.218140] Starting subtest: fast-copy-emit
[106.220198] Starting dynamic subtest: linear-smem-smem-emit
[106.241051] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.024s)
[106.250217] Starting dynamic subtest: xmajor-smem-smem-emit
[106.257952] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[106.264907] Starting dynamic subtest: tile4-smem-smem-emit
[106.275540] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[106.282655] Starting dynamic subtest: tile64-smem-smem-emit
[106.293264] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[106.295712] Subtest fast-copy-emit: SUCCESS (0.077s)
[106.446878] [017/132] (923s left) kms_async_flips (test-cursor-atomic)
[106.537984] Starting subtest: test-cursor-atomic
[106.542733] Subtest test-cursor-atomic: SKIP (0.000s)
[107.788977] [018/132] (922s left) kms_frontbuffer_tracking (psr-2p-rte)
[107.893921] Starting subtest: psr-2p-rte
[107.898574] Subtest psr-2p-rte: SKIP (0.000s)
[108.009951] [019/132] (922s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[108.117288] Starting subtest: psr-rgb101010-draw-mmap-cpu
[115.164672] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.048s)
[115.290052] [020/132] (915s left) drm_read (empty-nonblock)
[115.449770] Starting subtest: empty-nonblock
[115.452104] Subtest empty-nonblock: SUCCESS (0.000s)
[115.605321] [021/132] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[115.710364] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[115.714368] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[115.843151] [022/132] (914s left) gem_exec_nop (basic-series)
[115.911369] Starting subtest: basic-series
[130.312533] Subtest basic-series: SUCCESS (14.410s)
[130.574587] [023/132] (900s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[130.689627] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[135.321364] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.635s)
[136.549960] [024/132] (894s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[136.947502] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[137.720554] [025/132] (893s left) prime_mmap (test_map_unmap)
[137.778080] Starting subtest: test_map_unmap
[137.780145] Starting dynamic subtest: test_map_unmap-smem
[137.826503] Dynamic subtest test_map_unmap-smem: SUCCESS (0.050s)
[137.829048] Subtest test_map_unmap: SUCCESS (0.051s)
[137.941388] [026/132] (892s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[138.005326] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[138.010701] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[138.213178] [027/132] (892s left) gem_exec_schedule (u-fairslice)
[138.288594] Starting subtest: u-fairslice
[138.290869] Starting dynamic subtest: rcs0
[140.305661] Dynamic subtest rcs0: SUCCESS (2.024s)
[140.316190] Starting dynamic subtest: bcs0
[142.331406] Dynamic subtest bcs0: SUCCESS (2.025s)
[142.343641] Starting dynamic subtest: vcs0
[144.352252] Dynamic subtest vcs0: SUCCESS (2.019s)
[144.361187] Starting dynamic subtest: vcs1
[146.368662] Dynamic subtest vcs1: SUCCESS (2.017s)
[146.377662] Starting dynamic subtest: vecs0
[148.386872] Dynamic subtest vecs0: SUCCESS (2.017s)
[148.396416] Starting dynamic subtest: ccs0
[150.406962] Dynamic subtest ccs0: SUCCESS (2.021s)
[150.409396] Subtest u-fairslice: SUCCESS (12.125s)
[150.727562] [028/132] (880s left) kms_psr (psr2-dpms)
[150.831849] Starting subtest: psr2-dpms
[150.834445] Starting dynamic subtest: eDP-1
[153.658935] Dynamic subtest eDP-1: SUCCESS (2.827s)
[153.661362] Subtest psr2-dpms: SUCCESS (2.827s)
[154.552590] [029/132] (876s left) kms_color (ctm-max)
[154.653083] Starting subtest: ctm-max
[154.655069] Starting dynamic subtest: pipe-A-eDP-1
[155.387129] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[155.395192] Starting dynamic subtest: pipe-B-eDP-1
[156.881746] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.493s)
[156.890370] Starting dynamic subtest: pipe-C-eDP-1
[158.228539] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s)
[158.237412] Starting dynamic subtest: pipe-D-eDP-1
[159.578732] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[159.580797] Subtest ctm-max: SUCCESS (4.926s)
[160.421645] [030/132] (870s left) gem_userptr_blits (nohangcheck)
[160.501077] Starting subtest: nohangcheck
[160.739871] Subtest nohangcheck: SUCCESS (0.236s)
[160.896546] [031/132] (870s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[160.994846] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[167.891602] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.898s)
[168.063328] [032/132] (862s left) kms_atomic_transition (plane-all-modeset-transition)
[168.156078] Starting subtest: plane-all-modeset-transition
[168.160385] Subtest plane-all-modeset-transition: SKIP (0.000s)
[168.249673] [033/132] (862s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[168.369830] Starting subtest: flip-vs-cursor-busy-crc-legacy
[169.178698] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.810s)
[170.021282] [034/132] (861s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[174.957416] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[174.959743] Starting dynamic subtest: pipe-A-eDP-1
[181.573028] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.612s)
[181.581908] Starting dynamic subtest: pipe-B-eDP-1
[188.124460] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.551s)
[188.127095] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.167s)
[189.024441] [035/132] (842s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[189.125785] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[195.818489] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.693s)
[195.941149] [036/132] (835s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[196.053610] Starting subtest: yf-tiled-16bpp-rotate-180
[196.058136] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[196.179845] [037/132] (835s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[196.282385] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[203.288890] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.007s)
[203.455158] [038/132] (827s left) gem_render_copy (yf-tiled-ccs-to-linear)
[203.523711] Starting subtest: yf-tiled-ccs-to-linear
[203.528039] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[203.728520] [039/132] (827s left) gem_exec_params (invalid-flag)
[203.793831] Starting subtest: invalid-flag
[203.796179] Subtest invalid-flag: SUCCESS (0.000s)
[203.934397] [040/132] (827s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[204.032630] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[204.036753] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[204.146316] [041/132] (827s left) vgem_basic (setversion)
[204.233646] Starting subtest: setversion
[204.238190] Subtest setversion: SUCCESS (0.000s)
[204.310355] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[204.314205] [042/132] (827s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[204.437580] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[204.441727] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[204.574349] [043/132] (826s left) prime_mmap (test_dup)
[204.640500] Starting subtest: test_dup
[204.642911] Starting dynamic subtest: test_dup-smem
[204.676264] Dynamic subtest test_dup-smem: SUCCESS (0.036s)
[204.678326] Subtest test_dup: SUCCESS (0.037s)
[204.772436] [044/132] (826s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[204.888058] Starting subtest: flip-vs-cursor-busy-crc-atomic
[205.699454] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.809s)
[206.509514] [045/132] (825s left) kms_cursor_crc (cursor-onscreen-64x64)
[206.682797] Starting subtest: cursor-onscreen-64x64
[206.684947] Starting dynamic subtest: pipe-A-eDP-1
[208.796768] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s)
[208.822379] Starting dynamic subtest: pipe-D-eDP-1
[211.574099] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.758s)
[211.576457] Subtest cursor-onscreen-64x64: SUCCESS (4.893s)
[212.466805] [046/132] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[212.581170] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[219.885310] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.304s)
[220.059397] [047/132] (811s left) kms_vblank (query-forked-hang)
[220.153066] Starting subtest: query-forked-hang
[220.154938] Starting dynamic subtest: pipe-A-eDP-1
[246.688077] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.533s)
[246.700592] Starting dynamic subtest: pipe-D-eDP-1
[271.635248] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.944s)
[271.637691] Subtest query-forked-hang: SUCCESS (51.481s)
[272.535569] [048/132] (759s left) syncobj_timeline (single-wait-all-available-submitted)
[272.596390] Starting subtest: single-wait-all-available-submitted
[272.598821] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[272.727218] [049/132] (758s left) i915_query (query-topology-kernel-writes)
[272.786055] Starting subtest: query-topology-kernel-writes
[272.788600] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[272.930580] [050/132] (758s left) gem_ctx_persistence (hang)
[272.989064] Starting subtest: hang
[272.993278] Subtest hang: SKIP (0.000s)
[273.116468] [051/132] (758s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[273.231518] Starting subtest: cursorA-vs-flipB-atomic-transitions
[273.236038] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[273.399430] [052/132] (758s left) kms_joiner (basic-ultra-joiner)
[273.500221] Starting subtest: basic-ultra-joiner
[273.503792] Subtest basic-ultra-joiner: SKIP (0.000s)
[273.619547] [053/132] (758s left) kms_vblank (wait-forked-busy-hang)
[273.714624] Starting subtest: wait-forked-busy-hang
[273.716550] Starting dynamic subtest: pipe-A-eDP-1
[299.668658] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.952s)
[299.681671] Starting dynamic subtest: pipe-D-eDP-1
[324.686854] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[324.689528] Subtest wait-forked-busy-hang: SUCCESS (50.971s)
[325.581015] [054/132] (706s left) intel_hwmon (hwmon-read)
[325.648299] Subtest hwmon-read: SKIP (0.000s)
[325.709153] [055/132] (706s left) gem_mmap_wc (write-read)
[325.763290] Subtest write-read: SKIP (0.000s)
[325.837127] [056/132] (706s left) kms_big_fb (linear-16bpp-rotate-0)
[325.930104] Starting subtest: linear-16bpp-rotate-0
[327.211076] Subtest linear-16bpp-rotate-0: SUCCESS (1.279s)
[327.376706] [057/132] (704s left) perf_pmu (frequency)
[327.421959] Starting subtest: frequency
[327.426099] Starting dynamic subtest: gt0
[329.562829] Dynamic subtest gt0: SUCCESS (2.132s)
[329.573188] Starting dynamic subtest: idle-gt0
[330.067952] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[330.078926] Starting dynamic subtest: gt1
[334.958083] Dynamic subtest gt1: SUCCESS (4.885s)
[334.966375] Starting dynamic subtest: idle-gt1
[335.462900] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[335.465564] Subtest frequency: SUCCESS (8.044s)
[335.591371] [058/132] (696s left) kms_flip (2x-flip-vs-panning-interruptible)
[335.695882] Starting subtest: 2x-flip-vs-panning-interruptible
[335.708021] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[335.853258] [059/132] (696s left) kms_psr (fbc-psr-sprite-plane-onoff)
[335.957223] Starting subtest: fbc-psr-sprite-plane-onoff
[335.959553] Starting dynamic subtest: eDP-1
[335.963684] Dynamic subtest eDP-1: SKIP (0.000s)
[335.967793] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[336.055093] [060/132] (696s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[336.157046] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[336.159479] Starting dynamic subtest: pipe-A-eDP-1
[337.016630] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s)
[337.024516] Starting dynamic subtest: pipe-B-eDP-1
[338.595893] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.576s)
[338.604868] Starting dynamic subtest: pipe-C-eDP-1
[340.055325] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.458s)
[340.064224] Starting dynamic subtest: pipe-D-eDP-1
[341.584419] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.528s)
[341.586753] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.420s)
[342.790934] [061/132] (689s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[342.912752] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[342.917531] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[343.054978] [062/132] (689s left) kms_prop_blob (blob-prop-core)
[343.119526] Starting subtest: blob-prop-core
[343.121849] Subtest blob-prop-core: SUCCESS (0.000s)
[343.260322] [063/132] (689s left) kms_plane_cursor (viewport)
[343.360368] Starting subtest: viewport
[343.364879] Starting dynamic subtest: pipe-A-eDP-1-size-64
[345.855183] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.495s)
[345.914558] Starting dynamic subtest: pipe-A-eDP-1-size-128
[348.431708] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.526s)
[348.495861] Starting dynamic subtest: pipe-A-eDP-1-size-256
[350.967978] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.481s)
[351.317633] Starting dynamic subtest: pipe-B-eDP-1-size-64
[354.423420] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.112s)
[354.478701] Starting dynamic subtest: pipe-B-eDP-1-size-128
[356.932886] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.460s)
[356.992214] Starting dynamic subtest: pipe-B-eDP-1-size-256
[359.422922] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.438s)
[359.771063] Starting dynamic subtest: pipe-C-eDP-1-size-64
[362.675268] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.914s)
[362.712725] Starting dynamic subtest: pipe-C-eDP-1-size-128
[364.865194] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.158s)
[364.902806] Starting dynamic subtest: pipe-C-eDP-1-size-256
[367.042612] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.146s)
[367.370240] Starting dynamic subtest: pipe-D-eDP-1-size-64
[370.201233] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.842s)
[370.242068] Starting dynamic subtest: pipe-D-eDP-1-size-128
[372.390359] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s)
[372.429041] Starting dynamic subtest: pipe-D-eDP-1-size-256
[374.522864] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[374.841942] Subtest viewport: SUCCESS (31.481s)
[375.711155] [064/132] (656s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[375.858305] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[393.205454] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.346s)
[394.020087] [065/132] (638s left) gem_softpin (evict-snoop-interruptible)
[394.082253] Starting subtest: evict-snoop-interruptible
[394.086730] Subtest evict-snoop-interruptible: SKIP (0.000s)
[394.242622] [066/132] (638s left) gen9_exec_parse (secure-batches)
[394.299412] Subtest secure-batches: SKIP (0.000s)
[394.383254] [067/132] (638s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[394.477626] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[394.480034] Starting dynamic subtest: A-eDP1
[398.022459] Dynamic subtest A-eDP1: SUCCESS (3.542s)
[398.031337] Starting dynamic subtest: B-eDP1
[401.208251] Dynamic subtest B-eDP1: SUCCESS (3.182s)
[401.218443] Starting dynamic subtest: C-eDP1
[404.308884] Dynamic subtest C-eDP1: SUCCESS (3.099s)
[404.318082] Starting dynamic subtest: D-eDP1
[407.403759] Dynamic subtest D-eDP1: SUCCESS (3.097s)
[407.405944] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.929s)
[408.250645] [068/132] (624s left) gem_exec_balancer (bonded-chain)
[408.314779] Starting subtest: bonded-chain
[415.276031] Subtest bonded-chain: SUCCESS (6.959s)
[415.622329] [069/132] (616s left) kms_psr (fbc-pr-no-drrs)
[415.723897] Starting subtest: fbc-pr-no-drrs
[415.728347] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[415.821362] [070/132] (616s left) gem_ctx_persistence (engines-hostile-preempt)
[415.887477] Starting subtest: engines-hostile-preempt
[415.889802] Starting dynamic subtest: rcs0
[415.984948] Dynamic subtest rcs0: SUCCESS (0.097s)
[415.995825] Starting dynamic subtest: bcs0
[416.054484] Dynamic subtest bcs0: SUCCESS (0.067s)
[416.072478] Starting dynamic subtest: vcs0
[417.958390] Dynamic subtest vcs0: SUCCESS (1.899s)
[417.969329] Starting dynamic subtest: vcs1
[419.913611] Dynamic subtest vcs1: SUCCESS (1.953s)
[419.924651] Starting dynamic subtest: vecs0
[421.940604] Dynamic subtest vecs0: SUCCESS (2.024s)
[421.951975] Starting dynamic subtest: ccs0
[422.020425] Dynamic subtest ccs0: SUCCESS (0.079s)
[422.023290] Subtest engines-hostile-preempt: SUCCESS (6.133s)
[422.125248] [071/132] (610s left) i915_selftest (mock)
[425.684820] Starting subtest: mock
[425.687265] Starting dynamic subtest: sanitycheck
[426.444375] Dynamic subtest sanitycheck: SUCCESS (0.763s)
[426.453263] Starting dynamic subtest: shmem
[427.241140] Dynamic subtest shmem: SUCCESS (0.795s)
[427.250437] Starting dynamic subtest: fence
[435.096349] Dynamic subtest fence: SUCCESS (7.852s)
[435.105202] Starting dynamic subtest: scatterlist
[436.845331] Dynamic subtest scatterlist: SUCCESS (1.747s)
[436.855024] Starting dynamic subtest: syncmap
[440.170418] Dynamic subtest syncmap: SUCCESS (3.323s)
[440.180083] Starting dynamic subtest: uncore
[440.912185] Dynamic subtest uncore: SUCCESS (0.740s)
[440.921517] Starting dynamic subtest: ring
[441.667487] Dynamic subtest ring: SUCCESS (0.753s)
[441.677020] Starting dynamic subtest: engine
[442.400080] Dynamic subtest engine: SUCCESS (0.730s)
[442.409338] Starting dynamic subtest: timelines
[446.317751] Dynamic subtest timelines: SUCCESS (3.915s)
[446.324967] Starting dynamic subtest: requests
[449.646560] Dynamic subtest requests: SUCCESS (3.326s)
[449.656183] Starting dynamic subtest: objects
[450.541501] Dynamic subtest objects: SUCCESS (0.893s)
[450.550773] Starting dynamic subtest: phys
[451.426503] Dynamic subtest phys: SUCCESS (0.883s)
[451.441361] Starting dynamic subtest: dmabuf
[452.240924] Dynamic subtest dmabuf: SUCCESS (0.812s)
[452.250055] Starting dynamic subtest: vma
[457.698038] Dynamic subtest vma: SUCCESS (5.455s)
[457.707610] Starting dynamic subtest: evict
[459.208449] Dynamic subtest evict: SUCCESS (1.508s)
[459.217582] Starting dynamic subtest: gtt
[462.489972] Dynamic subtest gtt: SUCCESS (3.279s)
[462.498643] Starting dynamic subtest: hugepages
[463.516445] Dynamic subtest hugepages: SUCCESS (1.026s)
[463.525145] Starting dynamic subtest: memory_region
[466.164943] Dynamic subtest memory_region: SUCCESS (2.646s)
[466.167560] Subtest mock: SUCCESS (40.484s)
[466.194492] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[466.195210] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[466.199212] [072/132] (566s left) gem_pread (uncached)
[467.770107] Subtest uncached: SKIP (0.000s)
[467.841334] [FACT gem_pread (uncached)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[467.842628] [FACT gem_pread (uncached)] new: kernel.kmod_is_loaded.i915: true
[467.846462] [073/132] (564s left) kms_psr (psr-cursor-plane-move)
[467.943344] Starting subtest: psr-cursor-plane-move
[467.945535] Starting dynamic subtest: eDP-1
[469.695966] Dynamic subtest eDP-1: SUCCESS (1.753s)
[469.698309] Subtest psr-cursor-plane-move: SUCCESS (1.754s)
[470.585239] [074/132] (562s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[470.686615] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[470.691064] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[470.810246] [075/132] (562s left) kms_flip (plain-flip-ts-check)
[470.900587] Starting subtest: plain-flip-ts-check
[470.903128] Starting dynamic subtest: A-eDP1
[479.754768] Dynamic subtest A-eDP1: SUCCESS (8.857s)
[479.764106] Starting dynamic subtest: B-eDP1
[488.577661] Dynamic subtest B-eDP1: SUCCESS (8.821s)
[488.590497] Starting dynamic subtest: C-eDP1
[497.396653] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[497.405757] Starting dynamic subtest: D-eDP1
[506.219468] Dynamic subtest D-eDP1: SUCCESS (8.821s)
[506.224693] Subtest plain-flip-ts-check: SUCCESS (35.325s)
[507.425118] [076/132] (525s left) kms_pm_rpm (modeset-pc8-residency-stress)
[509.062495] Starting subtest: modeset-pc8-residency-stress
[509.067536] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[509.682555] [077/132] (523s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[514.734058] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[514.738449] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[515.584270] [078/132] (517s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[515.675832] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[515.678106] Starting dynamic subtest: pipe-A
[516.053304] Dynamic subtest pipe-A: SUCCESS (0.379s)
[516.062161] Starting dynamic subtest: pipe-B
[517.459930] Dynamic subtest pipe-B: SUCCESS (1.405s)
[517.468259] Starting dynamic subtest: pipe-C
[518.872376] Dynamic subtest pipe-C: SUCCESS (1.412s)
[518.882715] Starting dynamic subtest: pipe-D
[520.304158] Dynamic subtest pipe-D: SUCCESS (1.431s)
[520.306451] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.630s)
[521.487763] [079/132] (511s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[521.592258] Starting subtest: y-tiled-addfb-size-offset-overflow
[521.597055] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[521.705215] [080/132] (511s left) kms_sequence (queue-busy)
[521.801497] Starting subtest: queue-busy
[521.803468] Starting dynamic subtest: pipe-A-eDP-1
[523.722713] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[523.731840] Starting dynamic subtest: pipe-B-eDP-1
[526.352343] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.625s)
[526.361602] Starting dynamic subtest: pipe-C-eDP-1
[528.959425] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s)
[528.968524] Starting dynamic subtest: pipe-D-eDP-1
[531.502994] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[531.505128] Subtest queue-busy: SUCCESS (9.702s)
[532.317572] [081/132] (500s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[532.416082] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[532.418297] Starting dynamic subtest: pipe-A-default-mode
[532.707615] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[532.712132] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.290s)
[533.544240] [082/132] (499s left) gem_ctx_engines (execute-oneforall)
[533.624993] Starting subtest: execute-oneforall
[534.073915] Subtest execute-oneforall: SUCCESS (0.449s)
[535.065713] [083/132] (498s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[535.172567] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[535.185324] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[535.284274] [084/132] (497s left) prime_mmap (test_forked_cpu_write)
[535.351505] Starting subtest: test_forked_cpu_write
[535.353511] Starting dynamic subtest: test_forked_cpu_write-smem
[535.359230] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[535.361628] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[535.506352] [085/132] (497s left) kms_dsc (dsc-fractional-bpp)
[535.614902] Starting subtest: dsc-fractional-bpp
[535.627647] Subtest dsc-fractional-bpp: SKIP (0.000s)
[535.709496] [086/132] (497s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[535.801284] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[535.803731] Starting dynamic subtest: pipe-A-eDP-1
[535.812658] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[535.821526] Starting dynamic subtest: pipe-B-eDP-1
[535.830471] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[535.838692] Starting dynamic subtest: pipe-C-eDP-1
[535.847253] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[535.855314] Starting dynamic subtest: pipe-D-eDP-1
[535.864532] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[535.869082] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[538.033413] [087/132] (495s left) gem_userptr_blits (unsync-unmap-after-close)
[538.107958] Subtest unsync-unmap-after-close: SKIP (0.000s)
[538.274152] [088/132] (495s left) gem_exec_fence (basic-busy)
[538.444350] Starting subtest: basic-busy
[538.446842] Starting dynamic subtest: rcs0
[538.502259] Dynamic subtest rcs0: SUCCESS (0.058s)
[538.512445] Starting dynamic subtest: bcs0
[538.567388] Dynamic subtest bcs0: SUCCESS (0.063s)
[538.580700] Starting dynamic subtest: vcs0
[538.630168] Dynamic subtest vcs0: SUCCESS (0.060s)
[538.641405] Starting dynamic subtest: vcs1
[538.697770] Dynamic subtest vcs1: SUCCESS (0.064s)
[538.707673] Starting dynamic subtest: vecs0
[538.758417] Dynamic subtest vecs0: SUCCESS (0.058s)
[538.768659] Starting dynamic subtest: ccs0
[538.813050] Dynamic subtest ccs0: SUCCESS (0.052s)
[538.815411] Subtest basic-busy: SUCCESS (0.370s)
[541.014976] [089/132] (492s left) i915_pm_freq_api (freq-reset)
[541.098787] Starting subtest: freq-reset
[541.101177] Starting dynamic subtest: gt0
[541.300961] Dynamic subtest gt0: SUCCESS (0.200s)
[541.310292] Starting dynamic subtest: gt1
[541.474816] Dynamic subtest gt1: SUCCESS (0.173s)
[541.477667] Subtest freq-reset: SUCCESS (0.376s)
[541.580222] [090/132] (491s left) dmabuf (all-tests)
[541.622534] Starting subtest: all-tests
[541.625032] Starting dynamic subtest: sanitycheck
[541.745771] Dynamic subtest sanitycheck: SUCCESS (0.126s)
[541.757540] Starting dynamic subtest: dma_fence
[542.023567] Dynamic subtest dma_fence: SUCCESS (0.276s)
[542.034952] Starting dynamic subtest: dma_fence_chain
[550.659720] Dynamic subtest dma_fence_chain: SUCCESS (8.633s)
[550.671086] Starting dynamic subtest: dma_fence_unwrap
[550.806638] Dynamic subtest dma_fence_unwrap: SUCCESS (0.144s)
[550.818337] Starting dynamic subtest: dma_resv
[550.946310] Dynamic subtest dma_resv: SUCCESS (0.138s)
[550.949031] Subtest all-tests: SUCCESS (9.328s)
[551.042244] [091/132] (482s left) gem_exec_parallel (engines)
[551.106997] Starting subtest: engines
[551.109383] Starting dynamic subtest: basic
[552.887864] Dynamic subtest basic: SUCCESS (1.778s)
[552.897470] Starting dynamic subtest: contexts
[557.292968] Dynamic subtest contexts: SUCCESS (4.403s)
[557.303190] Starting dynamic subtest: fds
[561.070335] Dynamic subtest fds: SUCCESS (3.774s)
[561.081997] Starting dynamic subtest: userptr
[562.903489] Dynamic subtest userptr: SUCCESS (1.831s)
[562.906097] Subtest engines: SUCCESS (11.796s)
[563.118939] [092/132] (470s left) api_intel_allocator (standalone)
[563.182079] Starting subtest: standalone
[563.202581] Subtest standalone: SUCCESS (0.022s)
[563.374782] [093/132] (470s left) sysfs_timeslice_duration (timeout)
[563.437710] Starting subtest: timeout
[563.440080] Starting dynamic subtest: vecs0
[572.890290] Dynamic subtest vecs0: SUCCESS (9.448s)
[572.901710] Starting dynamic subtest: ccs0
[574.282730] Dynamic subtest ccs0: SUCCESS (1.391s)
[574.291796] Starting dynamic subtest: vcs0
[583.898181] Dynamic subtest vcs0: SUCCESS (9.611s)
[583.910096] Starting dynamic subtest: bcs0
[584.600522] Dynamic subtest bcs0: SUCCESS (0.701s)
[584.620553] Starting dynamic subtest: rcs0
[585.969767] Dynamic subtest rcs0: SUCCESS (1.367s)
[585.989748] Starting dynamic subtest: vcs1
[595.894626] Dynamic subtest vcs1: SUCCESS (9.919s)
[595.897582] Subtest timeout: SUCCESS (32.452s)
[595.990927] [094/132] (437s left) fbdev (eof)
[596.043991] Starting subtest: eof
[596.046812] Subtest eof: SUCCESS (0.000s)
[596.139390] [095/132] (437s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[596.261352] Starting subtest: modeset-atomic-cursor-hotspot
[596.265739] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[596.430306] [096/132] (437s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[596.530229] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[596.532326] Starting dynamic subtest: pipe-A-default-mode
[599.264501] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[599.266661] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.734s)
[600.129107] [097/132] (433s left) gem_pxp (create-regular-context-2)
[600.256804] Starting subtest: create-regular-context-2
[600.259051] Subtest create-regular-context-2: SUCCESS (0.001s)
[600.398896] [098/132] (433s left) syncobj_timeline (multi-wait-all-available-signaled)
[600.465768] Starting subtest: multi-wait-all-available-signaled
[600.468200] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[600.603470] [099/132] (433s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[600.703130] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[600.705428] Starting dynamic subtest: pipe-A-eDP-1
[600.725862] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[600.736668] Starting dynamic subtest: pipe-B-eDP-1
[600.755244] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[600.764043] Starting dynamic subtest: pipe-C-eDP-1
[600.783514] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[600.792724] Starting dynamic subtest: pipe-D-eDP-1
[600.811137] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[600.812981] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[602.909956] [100/132] (430s left) kms_lease (lease-again)
[603.017088] Starting subtest: lease-again
[603.019386] Starting dynamic subtest: pipe-A-eDP-1
[603.021612] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[603.030426] Starting dynamic subtest: pipe-B-eDP-1
[603.032283] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[603.040718] Starting dynamic subtest: pipe-C-eDP-1
[603.042589] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[603.050638] Starting dynamic subtest: pipe-D-eDP-1
[603.052508] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[603.054406] Subtest lease-again: SUCCESS (0.013s)
[603.178445] [101/132] (430s left) gem_eio (execbuf)
[603.397222] Starting subtest: execbuf
[603.717429] Subtest execbuf: SUCCESS (0.320s)
[603.889551] [102/132] (430s left) kms_hdr (static-toggle-suspend)
[603.989497] Starting subtest: static-toggle-suspend
[603.994731] Subtest static-toggle-suspend: SKIP (0.000s)
[604.082915] [103/132] (429s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[604.177680] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[604.179571] Starting dynamic subtest: pipe-A-eDP-1
[604.612817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s)
[604.623029] Starting dynamic subtest: pipe-B-eDP-1
[604.640752] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[604.649419] Starting dynamic subtest: pipe-C-eDP-1
[604.665914] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[604.674263] Starting dynamic subtest: pipe-D-eDP-1
[604.690463] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[604.692304] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.457s)
[606.964834] [104/132] (427s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[607.028865] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[607.031292] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[607.165628] [105/132] (426s left) perf_pmu (busy-idle)
[607.206026] Starting subtest: busy-idle
[607.208456] Starting dynamic subtest: rcs0
[607.918079] Dynamic subtest rcs0: SUCCESS (0.713s)
[607.929653] Starting dynamic subtest: bcs0
[608.596459] Dynamic subtest bcs0: SUCCESS (0.676s)
[608.608208] Starting dynamic subtest: vcs0
[609.943768] Dynamic subtest vcs0: SUCCESS (1.344s)
[609.953902] Starting dynamic subtest: vcs1
[611.927970] Dynamic subtest vcs1: SUCCESS (1.981s)
[611.939824] Starting dynamic subtest: vecs0
[613.911714] Dynamic subtest vecs0: SUCCESS (1.981s)
[613.923689] Starting dynamic subtest: ccs0
[614.583992] Dynamic subtest ccs0: SUCCESS (0.671s)
[614.586616] Subtest busy-idle: SUCCESS (7.380s)
[614.714538] [106/132] (419s left) gem_exec_parallel (contexts)
[614.782442] Starting subtest: contexts
[614.784481] Starting dynamic subtest: rcs0
[618.505877] Dynamic subtest rcs0: SUCCESS (3.723s)
[618.517971] Starting dynamic subtest: bcs0
[622.064108] Dynamic subtest bcs0: SUCCESS (3.556s)
[622.073149] Starting dynamic subtest: vcs0
[626.365738] Dynamic subtest vcs0: SUCCESS (4.298s)
[626.377895] Starting dynamic subtest: vcs1
[630.479099] Dynamic subtest vcs1: SUCCESS (4.110s)
[630.490378] Starting dynamic subtest: vecs0
[634.470320] Dynamic subtest vecs0: SUCCESS (3.987s)
[634.482126] Starting dynamic subtest: ccs0
[638.364790] Dynamic subtest ccs0: SUCCESS (3.892s)
[638.367852] Subtest contexts: SUCCESS (23.583s)
[638.580725] [107/132] (395s left) i915_drm_fdinfo (busy-idle-check-all)
[638.619065] Starting subtest: busy-idle-check-all
[638.621459] Starting dynamic subtest: rcs0
[638.628613] Dynamic subtest rcs0: SKIP (0.005s)
[638.637744] Starting dynamic subtest: bcs0
[638.641863] Dynamic subtest bcs0: SKIP (0.000s)
[638.650934] Starting dynamic subtest: vcs0
[638.655498] Dynamic subtest vcs0: SKIP (0.000s)
[638.664051] Starting dynamic subtest: vcs1
[638.668326] Dynamic subtest vcs1: SKIP (0.000s)
[638.676788] Starting dynamic subtest: vecs0
[638.681216] Dynamic subtest vecs0: SKIP (0.000s)
[638.689664] Starting dynamic subtest: ccs0
[638.694162] Dynamic subtest ccs0: SKIP (0.000s)
[638.698312] Subtest busy-idle-check-all: SKIP (0.011s)
[638.735902] [108/132] (395s left) gem_exec_schedule (noreorder)
[638.950907] Starting subtest: noreorder
[638.953513] Starting dynamic subtest: rcs0
[639.036522] Dynamic subtest rcs0: SUCCESS (0.085s)
[639.048682] Starting dynamic subtest: vcs0
[640.901796] Dynamic subtest vcs0: SUCCESS (1.862s)
[640.913692] Starting dynamic subtest: vcs1
[642.917217] Dynamic subtest vcs1: SUCCESS (2.013s)
[642.928948] Starting dynamic subtest: vecs0
[644.916120] Dynamic subtest vecs0: SUCCESS (1.997s)
[644.927875] Starting dynamic subtest: ccs0
[645.010834] Dynamic subtest ccs0: SUCCESS (0.093s)
[645.013298] Subtest noreorder: SUCCESS (6.061s)
[645.221853] [109/132] (389s left) gem_mmap (bad-size)
[645.289051] Subtest bad-size: SKIP (0.000s)
[645.356355] [110/132] (388s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[645.459691] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[645.463938] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[645.589600] [111/132] (388s left) gem_spin_batch (resubmit-new-all)
[645.652417] Starting subtest: resubmit-new-all
[645.654649] Starting dynamic subtest: rcs0
[645.667268] Dynamic subtest rcs0: SUCCESS (0.015s)
[645.678695] Starting dynamic subtest: bcs0
[645.680794] Dynamic subtest bcs0: SUCCESS (0.009s)
[645.689580] Starting dynamic subtest: vcs0
[645.691389] Dynamic subtest vcs0: SUCCESS (0.009s)
[645.699892] Starting dynamic subtest: vcs1
[645.702074] Dynamic subtest vcs1: SUCCESS (0.009s)
[645.711336] Starting dynamic subtest: vecs0
[645.713275] Dynamic subtest vecs0: SUCCESS (0.009s)
[645.722025] Starting dynamic subtest: ccs0
[645.724120] Dynamic subtest ccs0: SUCCESS (0.011s)
[645.726187] Subtest resubmit-new-all: SUCCESS (0.067s)
[647.001977] [112/132] (387s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[647.108131] Starting subtest: x-tiled-32bpp-rotate-90
[647.128118] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[647.289146] [113/132] (387s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[647.384567] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[654.706257] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.324s)
[654.866802] [114/132] (379s left) prime_busy (after)
[654.916242] Starting subtest: after
[654.921386] Starting dynamic subtest: rcs0
[654.960981] Dynamic subtest rcs0: SUCCESS (0.041s)
[654.971896] Starting dynamic subtest: bcs0
[655.026910] Dynamic subtest bcs0: SUCCESS (0.065s)
[655.036504] Starting dynamic subtest: vcs0
[655.066833] Dynamic subtest vcs0: SUCCESS (0.040s)
[655.075591] Starting dynamic subtest: vcs1
[655.106173] Dynamic subtest vcs1: SUCCESS (0.038s)
[655.114624] Starting dynamic subtest: vecs0
[655.146159] Dynamic subtest vecs0: SUCCESS (0.040s)
[655.154599] Starting dynamic subtest: ccs0
[655.187499] Dynamic subtest ccs0: SUCCESS (0.040s)
[655.297594] Subtest after: SUCCESS (0.379s)
[655.397896] [115/132] (379s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[655.450302] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[655.555352] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[655.654622] [116/132] (378s left) gem_fence_thrash (bo-write-verify-none)
[655.687773] Starting subtest: bo-write-verify-none
[655.713485] Subtest bo-write-verify-none: SKIP (0.022s)
[655.772805] [117/132] (378s left) kms_psr (fbc-psr2-suspend)
[655.858075] Starting subtest: fbc-psr2-suspend
[655.860387] Starting dynamic subtest: eDP-1
[655.864732] Dynamic subtest eDP-1: SKIP (0.000s)
[655.869203] Subtest fbc-psr2-suspend: SKIP (0.001s)
[655.952438] [118/132] (378s left) kms_chamelium_edid (dp-mode-timings)
[656.348352] Subtest dp-mode-timings: SKIP (0.000s)
[657.161889] [119/132] (377s left) i915_pm_rpm (reg-read-ioctl)
[659.093870] Starting subtest: reg-read-ioctl
[661.372069] Subtest reg-read-ioctl: SUCCESS (2.278s)
[661.775767] [120/132] (372s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[661.831038] Starting subtest: invalid-bsd1-flag-on-blt
[661.833344] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[661.962058] [121/132] (372s left) gem_ctx_bad_destroy (invalid-ctx)
[662.027446] Starting subtest: invalid-ctx
[662.029760] Subtest invalid-ctx: SUCCESS (0.000s)
[662.126584] [122/132] (372s left) kms_pm_dc (dc6-dpms)
[663.220959] Starting subtest: dc6-dpms
[665.316620] Subtest dc6-dpms: SUCCESS (2.094s)
[665.419176] [123/132] (369s left) kms_busy (extended-modeset-hang-oldfb)
[665.528134] Starting subtest: extended-modeset-hang-oldfb
[665.530673] Starting dynamic subtest: pipe-A
[677.345198] Dynamic subtest pipe-A: SUCCESS (11.815s)
[677.355293] Starting dynamic subtest: pipe-D
[689.611763] Dynamic subtest pipe-D: SUCCESS (12.265s)
[689.614153] Subtest extended-modeset-hang-oldfb: SUCCESS (24.086s)
[690.425528] [124/132] (344s left) gem_ctx_shared (exec-single-timeline)
[690.493957] Starting subtest: exec-single-timeline
[690.496409] Starting dynamic subtest: rcs0
[691.572646] Dynamic subtest rcs0: SUCCESS (1.076s)
[691.586776] Starting dynamic subtest: bcs0
[692.660103] Dynamic subtest bcs0: SUCCESS (1.085s)
[692.672700] Starting dynamic subtest: vcs0
[693.749474] Dynamic subtest vcs0: SUCCESS (1.086s)
[693.764674] Starting dynamic subtest: vcs1
[694.836661] Dynamic subtest vcs1: SUCCESS (1.085s)
[694.849083] Starting dynamic subtest: vecs0
[695.925068] Dynamic subtest vecs0: SUCCESS (1.085s)
[695.937169] Starting dynamic subtest: ccs0
[697.013260] Dynamic subtest ccs0: SUCCESS (1.085s)
[697.016226] Subtest exec-single-timeline: SUCCESS (6.519s)
[698.012292] [125/132] (336s left) kms_plane (plane-position-covered)
[698.111025] Starting subtest: plane-position-covered
[698.642490] Starting dynamic subtest: pipe-A-plane-1
[699.974527] Dynamic subtest pipe-A-plane-1: SUCCESS (1.332s)
[699.989839] Starting dynamic subtest: pipe-A-plane-2
[701.301229] Dynamic subtest pipe-A-plane-2: SUCCESS (1.323s)
[701.311970] Starting dynamic subtest: pipe-A-plane-3
[702.530193] Dynamic subtest pipe-A-plane-3: SUCCESS (1.229s)
[702.540102] Starting dynamic subtest: pipe-A-plane-4
[703.774657] Dynamic subtest pipe-A-plane-4: SUCCESS (1.244s)
[703.785871] Starting dynamic subtest: pipe-A-plane-5
[703.799179] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[705.035221] Starting dynamic subtest: pipe-B-plane-1
[706.344411] Dynamic subtest pipe-B-plane-1: SUCCESS (1.315s)
[706.354297] Starting dynamic subtest: pipe-B-plane-2
[707.671373] Dynamic subtest pipe-B-plane-2: SUCCESS (1.327s)
[707.681699] Starting dynamic subtest: pipe-B-plane-3
[708.959041] Dynamic subtest pipe-B-plane-3: SUCCESS (1.287s)
[708.969047] Starting dynamic subtest: pipe-B-plane-4
[710.263341] Dynamic subtest pipe-B-plane-4: SUCCESS (1.302s)
[710.272969] Starting dynamic subtest: pipe-B-plane-5
[710.287808] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[710.290247] Subtest plane-position-covered: SUCCESS (12.176s)
[711.156991] [126/132] (323s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[711.278725] Starting subtest: flip-vs-cursor-crc-atomic
[711.974664] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.696s)
[712.790114] [127/132] (322s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[712.909605] Starting subtest: cursor-vs-flip-toggle
[743.776248] Subtest cursor-vs-flip-toggle: SUCCESS (30.863s)
[744.611434] [128/132] (290s left) gem_exec_fence (syncobj-invalid-flags)
[745.067881] Starting subtest: syncobj-invalid-flags
[745.070392] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[747.008320] [129/132] (288s left) gem_eio (wait-wedge-10ms)
[747.255563] Starting subtest: wait-wedge-10ms
[748.984035] Subtest wait-wedge-10ms: SUCCESS (1.728s)
[749.177808] [130/132] (285s left) perf (non-system-wide-paranoid)
[749.348631] Starting subtest: non-system-wide-paranoid
[749.370910] Subtest non-system-wide-paranoid: SUCCESS (0.026s)
[749.419362] [131/132] (285s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[749.514342] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[749.518677] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[749.651747] [132/132] (285s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[749.750556] Starting subtest: 4-tiled-16bpp-rotate-90
[749.770945] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[749.929759] Closing watchdogs
results: parsing output: 0/ for test: syncobj_eventfd
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: gem_exec_store
results: parsing output: 3/ for test: drm_read
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_content_protection
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: gem_exercise_blt
results: parsing output: 16/ for test: kms_async_flips
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: drm_read
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_nop
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_chamelium_hpd
results: parsing output: 24/ for test: prime_mmap
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_color
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_atomic_transition
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: gem_exec_params
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: vgem_basic
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: prime_mmap
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_vblank
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: i915_query
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_joiner
results: parsing output: 52/ for test: kms_vblank
results: parsing output: 53/ for test: intel_hwmon
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_prop_blob
results: parsing output: 62/ for test: kms_plane_cursor
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: gem_softpin
results: parsing output: 65/ for test: gen9_exec_parse
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: i915_selftest
results: parsing output: 71/ for test: gem_pread
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_sequence
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: gem_ctx_engines
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: prime_mmap
results: parsing output: 84/ for test: kms_dsc
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: i915_pm_freq_api
results: parsing output: 89/ for test: dmabuf
results: parsing output: 90/ for test: gem_exec_parallel
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: sysfs_timeslice_duration
results: parsing output: 93/ for test: fbdev
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_pxp
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: gem_eio
results: parsing output: 101/ for test: kms_hdr
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_exec_parallel
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: gem_mmap
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_spin_batch
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: prime_busy
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_fence_thrash
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_chamelium_edid
results: parsing output: 118/ for test: i915_pm_rpm
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: gem_ctx_bad_destroy
results: parsing output: 121/ for test: kms_pm_dc
results: parsing output: 122/ for test: kms_busy
results: parsing output: 123/ for test: gem_ctx_shared
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: gem_eio
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_big_fb
Done.