[70.193938] Initializing watchdogs
[70.193999]   /dev/watchdog0
[70.213870] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[70.224063] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[70.228131] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.230841] [001/131] (960s left) kms_vblank (ts-continuation-idle-hang)
[70.423174] Starting subtest: ts-continuation-idle-hang
[70.425162] Starting dynamic subtest: pipe-A-DP-3
[96.574718] Dynamic subtest pipe-A-DP-3: SUCCESS (26.156s)
[96.589696] Starting dynamic subtest: pipe-D-DP-3
[121.581421] Dynamic subtest pipe-D-DP-3: SUCCESS (25.008s)
[121.582401] Subtest ts-continuation-idle-hang: SUCCESS (51.173s)
[121.802736] [002/131] (908s left) gem_ctx_param (root-set)
[121.876354] Starting subtest: root-set
[121.878250] Subtest root-set: SUCCESS (0.002s)
[121.983535] [003/131] (908s left) gem_exec_reloc (basic-write-cpu-noreloc)
[122.069504] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[122.139674] [004/131] (908s left) vgem_basic (unload)
[122.181558] Starting subtest: unload
[151.274794] Subtest unload: SUCCESS (29.093s)
[151.398711] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[151.401012] [005/131] (879s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[151.601061] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[151.602816] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[151.750644] [006/131] (879s left) gem_exec_schedule (submit-late-slice)
[151.848186] Starting subtest: submit-late-slice
[151.849137] Starting dynamic subtest: rcs0
[151.929107] Dynamic subtest rcs0: SUCCESS (0.081s)
[151.937027] Starting dynamic subtest: bcs0
[151.980435] Dynamic subtest bcs0: SUCCESS (0.051s)
[151.988182] Starting dynamic subtest: vcs0
[152.032362] Dynamic subtest vcs0: SUCCESS (0.052s)
[152.040402] Starting dynamic subtest: vcs1
[152.083970] Dynamic subtest vcs1: SUCCESS (0.051s)
[152.092467] Starting dynamic subtest: vecs0
[152.138129] Dynamic subtest vecs0: SUCCESS (0.054s)
[152.145697] Starting dynamic subtest: vecs1
[152.188022] Dynamic subtest vecs1: SUCCESS (0.050s)
[152.195746] Starting dynamic subtest: ccs0
[152.240040] Dynamic subtest ccs0: SUCCESS (0.052s)
[152.241123] Subtest submit-late-slice: SUCCESS (0.392s)
[152.672958] [007/131] (878s left) gem_eio (in-flight-internal-10ms)
[152.934918] Starting subtest: in-flight-internal-10ms
[153.856961] Subtest in-flight-internal-10ms: SUCCESS (0.922s)
[154.076237] [008/131] (877s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[154.155118] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[154.156249] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[154.278578] [009/131] (876s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[154.480573] Starting subtest: fbcpsr-rgb565-draw-render
[154.482250] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[154.631735] [010/131] (876s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[154.833464] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[154.835125] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[154.984939] [011/131] (876s left) i915_pm_rc6_residency (rc6-idle)
[155.065514] Starting subtest: rc6-idle
[155.098187] Starting dynamic subtest: gt0-rcs0
[179.483721] Dynamic subtest gt0-rcs0: SUCCESS (24.385s)
[179.492768] Starting dynamic subtest: gt0-bcs0
[203.876467] Dynamic subtest gt0-bcs0: SUCCESS (24.392s)
[203.886037] Starting dynamic subtest: gt0-vcs0
[228.393120] Dynamic subtest gt0-vcs0: SUCCESS (24.515s)
[228.402675] Starting dynamic subtest: gt0-vecs0
[252.781539] Dynamic subtest gt0-vecs0: SUCCESS (24.389s)
[252.790836] Starting dynamic subtest: gt0-ccs0
[277.228856] Dynamic subtest gt0-ccs0: SUCCESS (24.445s)
[277.230921] Subtest rc6-idle: SUCCESS (122.163s)
[277.370932] [012/131] (754s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[277.452984] Starting subtest: multi-wait-for-submit-submitted-signaled
[277.453999] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[277.591715] [013/131] (753s left) i915_drm_fdinfo (isolation)
[277.662420] Starting subtest: isolation
[277.663359] Starting dynamic subtest: rcs0
[277.675339] Dynamic subtest rcs0: SKIP (0.012s)
[277.684398] Starting dynamic subtest: bcs0
[277.687321] Dynamic subtest bcs0: SKIP (0.012s)
[277.696363] Starting dynamic subtest: vcs0
[277.698831] Dynamic subtest vcs0: SKIP (0.000s)
[277.707480] Starting dynamic subtest: vcs1
[277.709573] Dynamic subtest vcs1: SKIP (0.000s)
[277.718470] Starting dynamic subtest: vecs0
[277.720622] Dynamic subtest vecs0: SKIP (0.000s)
[277.729665] Starting dynamic subtest: vecs1
[277.732083] Dynamic subtest vecs1: SKIP (0.000s)
[277.741649] Starting dynamic subtest: ccs0
[277.744314] Dynamic subtest ccs0: SKIP (0.000s)
[277.746118] Subtest isolation: SKIP (0.026s)
[277.787653] [014/131] (753s left) gem_softpin (allocator-basic)
[277.871152] Starting subtest: allocator-basic
[278.098091] Subtest allocator-basic: SUCCESS (0.226s)
[278.267541] [015/131] (753s left) kms_psr (psr-basic)
[278.469437] Subtest psr-basic: SKIP (0.000s)
[278.532243] [016/131] (753s left) gem_vm_create (create-ext)
[278.616511] Starting subtest: create-ext
[278.621196] Subtest create-ext: SUCCESS (0.005s)
[278.775621] [017/131] (752s left) perf (gen12-group-concurrent-oa-buffer-read)
[279.149007] Starting subtest: gen12-group-concurrent-oa-buffer-read
[289.196120] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.045s)
[289.255167] [018/131] (742s left) kms_psr (fbc-pr-basic)
[289.460362] Subtest fbc-pr-basic: SKIP (0.000s)
[289.527109] [019/131] (742s left) kms_cursor_edge_walk (64x64-left-edge)
[289.722238] Starting subtest: 64x64-left-edge
[289.723197] Starting dynamic subtest: pipe-A-DP-3
[293.222172] Dynamic subtest pipe-A-DP-3: SUCCESS (3.497s)
[293.233598] Starting dynamic subtest: pipe-D-DP-3
[296.556273] Dynamic subtest pipe-D-DP-3: SUCCESS (3.332s)
[296.557299] Subtest 64x64-left-edge: SUCCESS (6.832s)
[296.835676] [020/131] (735s left) kms_scaling_modes (scaling-mode-center)
[297.030214] Starting subtest: scaling-mode-center
[297.035390] Subtest scaling-mode-center: SKIP (0.001s)
[297.139695] [021/131] (734s left) gem_eio (wait-1us)
[297.468974] Starting subtest: wait-1us
[298.084560] Subtest wait-1us: SUCCESS (0.616s)
[298.309602] [022/131] (733s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[298.514674] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[298.516420] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[298.657927] [023/131] (733s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[298.736798] Starting subtest: multi-wait-all-for-submit-signaled
[298.737658] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[298.874527] [024/131] (733s left) kms_vrr (lobf)
[299.068207] Starting subtest: lobf
[299.070073] Subtest lobf: SKIP (0.000s)
[299.176055] [025/131] (733s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[299.373186] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[299.374156] Starting dynamic subtest: pipe-A-DP-3
[299.383811] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[299.393058] Starting dynamic subtest: pipe-B-DP-3
[299.402739] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[299.411733] Starting dynamic subtest: pipe-C-DP-3
[299.420936] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[299.430048] Starting dynamic subtest: pipe-D-DP-3
[299.441453] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[299.443441] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[299.832398] [026/131] (732s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[300.038563] Starting subtest: psr-rgb565-draw-mmap-gtt
[300.040261] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[300.165145] [027/131] (732s left) kms_invalid_mode (uint-max-clock)
[300.359056] Starting subtest: uint-max-clock
[300.359942] Starting dynamic subtest: pipe-A-DP-3
[300.443176] Dynamic subtest pipe-A-DP-3: SUCCESS (0.083s)
[300.455841] Starting dynamic subtest: pipe-B-DP-3
[300.457049] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[300.469470] Starting dynamic subtest: pipe-C-DP-3
[300.470600] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[300.482549] Starting dynamic subtest: pipe-D-DP-3
[300.483479] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[300.484394] Subtest uint-max-clock: SUCCESS (0.090s)
[300.686428] [028/131] (731s left) kms_cursor_crc (cursor-sliding-32x10)
[300.997359] Starting subtest: cursor-sliding-32x10
[301.048053] Subtest cursor-sliding-32x10: SKIP (0.048s)
[301.430854] [029/131] (731s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[301.648466] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[302.932730] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.283s)
[303.078630] [030/131] (729s left) gem_wait (write-wait)
[303.169882] Starting subtest: write-wait
[303.170788] Starting dynamic subtest: all-engines
[304.314609] Dynamic subtest all-engines: SUCCESS (1.144s)
[304.327115] Starting dynamic subtest: rcs0
[305.374446] Dynamic subtest rcs0: SUCCESS (1.059s)
[305.387080] Starting dynamic subtest: bcs0
[306.434873] Dynamic subtest bcs0: SUCCESS (1.059s)
[306.473743] Starting dynamic subtest: vcs0
[307.511819] Dynamic subtest vcs0: SUCCESS (1.076s)
[307.550834] Starting dynamic subtest: vcs1
[308.584855] Dynamic subtest vcs1: SUCCESS (1.072s)
[308.598781] Starting dynamic subtest: vecs0
[309.644790] Dynamic subtest vecs0: SUCCESS (1.059s)
[309.659154] Starting dynamic subtest: vecs1
[310.706057] Dynamic subtest vecs1: SUCCESS (1.060s)
[310.720641] Starting dynamic subtest: ccs0
[311.765790] Dynamic subtest ccs0: SUCCESS (1.059s)
[311.767723] Subtest write-wait: SUCCESS (8.594s)
[312.030889] [031/131] (720s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[312.229539] Starting subtest: flip-vs-cursor-legacy
[322.081614] Subtest flip-vs-cursor-legacy: SUCCESS (9.848s)
[322.348281] [032/131] (710s left) dmabuf_sync_file (import-multiple-read-only)
[322.404672] Starting subtest: import-multiple-read-only
[322.408139] Subtest import-multiple-read-only: SUCCESS (0.004s)
[322.486175] [033/131] (710s left) kms_cursor_crc (cursor-onscreen-128x42)
[322.889751] Starting subtest: cursor-onscreen-128x42
[322.894495] Starting dynamic subtest: pipe-A-DP-3
[325.671456] Dynamic subtest pipe-A-DP-3: SUCCESS (2.775s)
[325.706451] Starting dynamic subtest: pipe-D-DP-3
[328.405242] Dynamic subtest pipe-D-DP-3: SUCCESS (2.707s)
[328.406241] Subtest cursor-onscreen-128x42: SUCCESS (5.514s)
[328.786191] [034/131] (704s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[328.989140] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[334.805890] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.816s)
[335.015679] [035/131] (697s left) prime_self_import (basic-with_fd_dup)
[335.061120] Starting subtest: basic-with_fd_dup
[335.111177] Subtest basic-with_fd_dup: SUCCESS (0.050s)
[335.244944] [036/131] (697s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[335.445456] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[335.446429] Starting dynamic subtest: pipe-A-DP-3
[335.450152] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[335.460598] Starting dynamic subtest: pipe-B-DP-3
[335.463986] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[335.473379] Starting dynamic subtest: pipe-C-DP-3
[335.476917] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[335.486359] Starting dynamic subtest: pipe-D-DP-3
[335.489931] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[335.491585] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[335.911017] [037/131] (697s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[336.119991] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[336.121673] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[336.266682] [038/131] (696s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[336.462182] Starting subtest: fb-8bpc-vs-panel-6bpc
[336.463137] Starting dynamic subtest: pipe-A-DP-3
[336.888526] Dynamic subtest pipe-A-DP-3: SUCCESS (0.423s)
[336.889844] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (0.424s)
[337.152356] [039/131] (696s left) i915_selftest (live)
[338.444783] Starting subtest: live
[338.445865] Starting dynamic subtest: sanitycheck
[340.090084] Dynamic subtest sanitycheck: SUCCESS (1.645s)
[340.098291] Starting dynamic subtest: uncore
[341.636991] Dynamic subtest uncore: SUCCESS (1.546s)
[341.645524] Starting dynamic subtest: workarounds
[357.848706] Dynamic subtest workarounds: FAIL (16.001s)
[357.855767] Starting dynamic subtest: gt_engines
[360.004013] Dynamic subtest gt_engines: SUCCESS (2.362s)
[360.012050] Starting dynamic subtest: gt_timelines
[379.577508] Dynamic subtest gt_timelines: SUCCESS (19.571s)
[379.587224] Starting dynamic subtest: gt_contexts
[381.182129] Dynamic subtest gt_contexts: SUCCESS (1.604s)
[381.190143] Starting dynamic subtest: gt_lrc
[387.513817] Dynamic subtest gt_lrc: SUCCESS (6.330s)
[387.524822] Starting dynamic subtest: gt_mocs
[390.449521] Dynamic subtest gt_mocs: SUCCESS (2.935s)
[390.457821] Starting dynamic subtest: gt_pm
[394.597381] Dynamic subtest gt_pm: SUCCESS (4.147s)
[394.605662] Starting dynamic subtest: gt_heartbeat
[396.203244] Dynamic subtest gt_heartbeat: SUCCESS (1.605s)
[396.211737] Starting dynamic subtest: gt_tlb
[408.869689] Dynamic subtest gt_tlb: SUCCESS (12.665s)
[408.878452] Starting dynamic subtest: requests
[422.421300] Dynamic subtest requests: SUCCESS (13.550s)
[422.438152] Starting dynamic subtest: migrate
[427.666192] Dynamic subtest migrate: SUCCESS (5.244s)
[427.674712] Starting dynamic subtest: active
[429.266048] Dynamic subtest active: SUCCESS (1.599s)
[429.275634] Starting dynamic subtest: objects
[431.630105] Dynamic subtest objects: SUCCESS (2.363s)
[431.638603] Starting dynamic subtest: mman
[438.265115] Dynamic subtest mman: SUCCESS (6.634s)
[438.273984] Starting dynamic subtest: dmabuf
[439.954192] Dynamic subtest dmabuf: SUCCESS (1.688s)
[439.962956] Starting dynamic subtest: vma
[441.511054] Dynamic subtest vma: SUCCESS (1.556s)
[441.519808] Starting dynamic subtest: coherency
[445.905250] Dynamic subtest coherency: SUCCESS (4.393s)
[445.913937] Starting dynamic subtest: gtt
[456.078656] Dynamic subtest gtt: SUCCESS (10.171s)
[456.092457] Starting dynamic subtest: gem
[457.930291] Dynamic subtest gem: SUCCESS (1.849s)
[457.939334] Starting dynamic subtest: evict
[460.910772] Dynamic subtest evict: SUCCESS (2.979s)
[460.920490] Starting dynamic subtest: hugepages
[479.450087] Dynamic subtest hugepages: SUCCESS (18.537s)
[479.461128] Starting dynamic subtest: gem_contexts
[511.858266] Dynamic subtest gem_contexts: SUCCESS (32.405s)
[511.867587] Starting dynamic subtest: client
[513.520673] Dynamic subtest client: SUCCESS (1.662s)
[513.530174] Starting dynamic subtest: gem_migrate
[517.076448] Dynamic subtest gem_migrate: SUCCESS (3.554s)
[517.085790] Starting dynamic subtest: reset
[518.727936] Dynamic subtest reset: SUCCESS (1.650s)
[518.736232] Starting dynamic subtest: memory_region
[521.962606] Dynamic subtest memory_region: SUCCESS (3.234s)
[521.975243] Starting dynamic subtest: hangcheck
[552.194150] Dynamic subtest hangcheck: SUCCESS (30.229s)
[552.211166] Starting dynamic subtest: execlists
[553.777221] Dynamic subtest execlists: SUCCESS (1.581s)
[553.786445] Starting dynamic subtest: ring_submission
[555.403265] Dynamic subtest ring_submission: SUCCESS (1.625s)
[555.413357] Starting dynamic subtest: perf
[557.127972] Dynamic subtest perf: SUCCESS (1.724s)
[557.137196] Starting dynamic subtest: slpc
[564.364255] Dynamic subtest slpc: SUCCESS (7.235s)
[564.372954] Starting dynamic subtest: guc
[567.311311] Dynamic subtest guc: SUCCESS (2.946s)
[567.320985] Starting dynamic subtest: guc_multi_lrc
[568.942231] Dynamic subtest guc_multi_lrc: SUCCESS (1.630s)
[568.951323] Starting dynamic subtest: guc_hang
[571.332112] Dynamic subtest guc_hang: SUCCESS (2.388s)
[571.341052] Starting dynamic subtest: late_gt_pm
[573.017111] Dynamic subtest late_gt_pm: SUCCESS (1.684s)
[573.018147] Subtest live: FAIL (234.558s)
[573.050908] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[573.051880] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[573.053922] [040/131] (460s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[574.742798] Starting subtest: 2x-long-flip-vs-cursor-legacy
[574.745991] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[574.894873] [FACT kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[574.897138] [FACT kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)] new: kernel.kmod_is_loaded.i915: true
[574.899914] [041/131] (458s left) gem_pxp (verify-pxp-stale-buf-execution)
[577.506861] Starting subtest: verify-pxp-stale-buf-execution
[577.508623] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[577.607453] [042/131] (455s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[577.811317] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[577.813047] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[577.937396] [043/131] (455s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[578.137555] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[578.139445] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[578.422098] [044/131] (455s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[578.505399] Starting subtest: invalid-single-wait-unsubmitted
[578.506376] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[578.643285] [045/131] (454s left) gem_ctx_sseu (invalid-sseu)
[578.729441] Subtest invalid-sseu: SKIP (0.000s)
[578.841795] [046/131] (454s left) kms_plane_multiple (2x-tiling-none)
[579.038495] Starting subtest: 2x-tiling-none
[579.040353] Subtest 2x-tiling-none: SKIP (0.000s)
[579.139502] [047/131] (454s left) gem_tiled_fence_blits (basic)
[579.228527] Subtest basic: SKIP (0.000s)
[579.294916] [048/131] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[579.496057] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[579.497914] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[579.643020] [049/131] (454s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[579.847116] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[580.567669] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.721s)
[580.832200] [050/131] (453s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[581.043080] Starting subtest: yf-tiled-64bpp-rotate-90
[581.044944] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[581.204644] [051/131] (452s left) gem_lmem_swapping (heavy-multi)
[583.906453] Starting subtest: heavy-multi
[583.907315] Starting dynamic subtest: lmem0
[589.311558] Dynamic subtest lmem0: SUCCESS (5.405s)
[589.312452] Subtest heavy-multi: SUCCESS (5.407s)
[590.618995] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[590.620432] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[590.622721] [052/131] (443s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[592.213796] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[592.270409] [FACT gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[592.272749] [FACT gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)] new: kernel.kmod_is_loaded.i915: true
[592.276380] [053/131] (441s left) gen9_exec_parse (bb-chained)
[592.364444] Subtest bb-chained: SKIP (0.000s)
[592.425778] [054/131] (441s left) gem_exec_balancer (individual)
[592.513914] Starting subtest: individual
[594.544249] Subtest individual: SUCCESS (2.030s)
[594.970352] [055/131] (439s left) i915_pm_rps (waitboost)
[595.059083] Starting subtest: waitboost
[597.649806] Subtest waitboost: SUCCESS (2.591s)
[597.771027] [056/131] (436s left) gem_mmap_gtt (basic-small-bo)
[597.850256] Subtest basic-small-bo: SKIP (0.000s)
[597.924947] [057/131] (436s left) gem_eio (in-flight-contexts-1us)
[598.233422] Starting subtest: in-flight-contexts-1us
[611.942407] Subtest in-flight-contexts-1us: SUCCESS (13.709s)
[612.157348] [058/131] (422s left) prime_mmap (test_aperture_limit)
[612.232893] Starting subtest: test_aperture_limit
[612.233769] Starting dynamic subtest: test_aperture_limit-smem
[612.245203] Dynamic subtest test_aperture_limit-smem: SKIP (0.011s)
[612.247166] Subtest test_aperture_limit: SKIP (0.012s)
[612.339795] [059/131] (422s left) kms_rotation_crc (bad-tiling)
[612.533486] Starting subtest: bad-tiling
[612.536899] Subtest bad-tiling: SKIP (0.001s)
[612.648080] [060/131] (421s left) kms_cursor_crc (cursor-size-change)
[612.845611] Starting subtest: cursor-size-change
[612.848133] Starting dynamic subtest: pipe-A-DP-3
[613.745220] Dynamic subtest pipe-A-DP-3: SUCCESS (0.895s)
[613.758160] Starting dynamic subtest: pipe-D-DP-3
[614.523349] Dynamic subtest pipe-D-DP-3: SUCCESS (0.774s)
[614.524342] Subtest cursor-size-change: SUCCESS (1.677s)
[615.186277] [061/131] (419s left) kms_color (ctm-0-75)
[615.388542] Starting subtest: ctm-0-75
[615.389449] Starting dynamic subtest: pipe-A-DP-3
[617.739044] Dynamic subtest pipe-A-DP-3: SUCCESS (2.347s)
[617.760526] Starting dynamic subtest: pipe-B-DP-3
[619.933588] Dynamic subtest pipe-B-DP-3: SUCCESS (2.195s)
[619.945393] Starting dynamic subtest: pipe-C-DP-3
[622.125532] Dynamic subtest pipe-C-DP-3: SUCCESS (2.190s)
[622.137315] Starting dynamic subtest: pipe-D-DP-3
[624.301457] Dynamic subtest pipe-D-DP-3: SUCCESS (2.174s)
[624.302401] Subtest ctm-0-75: SUCCESS (8.912s)
[624.581313] [062/131] (410s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[624.662369] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[624.663281] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[624.800506] [063/131] (409s left) gem_ctx_param (invalid-get-ringsize)
[624.881778] Starting subtest: invalid-get-ringsize
[624.884187] Subtest invalid-get-ringsize: SUCCESS (0.002s)
[625.053580] [064/131] (409s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[625.245663] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[625.248164] Starting dynamic subtest: pipe-A-valid-mode
[627.160546] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.910s)
[627.161957] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.913s)
[627.413695] [065/131] (407s left) kms_psr (pr-cursor-plane-onoff)
[627.613234] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[627.669523] [066/131] (407s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[627.868566] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[627.871121] Starting dynamic subtest: pipe-A-DP-3
[636.865978] Dynamic subtest pipe-A-DP-3: SUCCESS (8.991s)
[636.880593] Starting dynamic subtest: pipe-B-DP-3
[637.633466] Dynamic subtest pipe-B-DP-3: SUCCESS (0.762s)
[637.671613] Starting dynamic subtest: pipe-C-DP-3
[638.450677] Dynamic subtest pipe-C-DP-3: SUCCESS (0.809s)
[638.488903] Starting dynamic subtest: pipe-D-DP-3
[639.264460] Dynamic subtest pipe-D-DP-3: SUCCESS (0.806s)
[639.266467] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (11.392s)
[639.613156] [067/131] (395s left) gem_sync (basic-all)
[639.703503] Starting subtest: basic-all
[642.770364] Subtest basic-all: SUCCESS (3.067s)
[642.993168] [068/131] (392s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[643.195652] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[643.249335] [069/131] (391s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[643.450159] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[643.451914] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[643.604933] [070/131] (391s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render)
[643.805113] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render
[643.806801] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[643.948979] [071/131] (391s left) gem_ctx_exec (basic-nohangcheck)
[644.030430] Starting subtest: basic-nohangcheck
[644.335821] Subtest basic-nohangcheck: SUCCESS (0.305s)
[644.495965] [072/131] (390s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[644.691636] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[644.694132] Starting dynamic subtest: pipe-A-valid-mode
[647.192022] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.498s)
[647.193471] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SUCCESS (2.501s)
[647.464692] [073/131] (387s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[647.662125] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[647.663851] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[647.786744] [074/131] (387s left) sysfs_timeslice_duration (duration)
[647.872639] Starting subtest: duration
[647.873469] Starting dynamic subtest: vecs0
[661.050642] Dynamic subtest vecs0: SUCCESS (13.176s)
[661.063433] Starting dynamic subtest: ccs0
[674.184612] Dynamic subtest ccs0: SUCCESS (13.132s)
[674.197224] Starting dynamic subtest: vcs0
[687.337293] Dynamic subtest vcs0: SUCCESS (13.150s)
[687.380486] Starting dynamic subtest: bcs0
[700.512441] Dynamic subtest bcs0: SUCCESS (13.170s)
[700.524808] Starting dynamic subtest: vecs1
[713.666111] Dynamic subtest vecs1: SUCCESS (13.151s)
[713.679653] Starting dynamic subtest: rcs0
[726.814584] Dynamic subtest rcs0: SUCCESS (13.145s)
[726.827689] Starting dynamic subtest: vcs1
[739.959442] Dynamic subtest vcs1: SUCCESS (13.143s)
[739.960403] Subtest duration: SUCCESS (92.085s)
[740.073409] [075/131] (295s left) kms_async_flips (invalid-async-flip-atomic)
[740.267767] Starting subtest: invalid-async-flip-atomic
[740.269523] Subtest invalid-async-flip-atomic: SKIP (0.000s)
[740.709567] [076/131] (294s left) kms_getfb (getfb-handle-zero)
[740.907591] Starting subtest: getfb-handle-zero
[740.908490] Subtest getfb-handle-zero: SUCCESS (0.000s)
[741.058388] [077/131] (294s left) gem_exec_flush (basic-batch-kernel-default-uc)
[741.144257] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[741.234540] [078/131] (294s left) gem_workarounds (reset)
[741.331055] Starting subtest: reset
[741.527170] Subtest reset: SUCCESS (0.196s)
[741.701995] [079/131] (294s left) kms_frontbuffer_tracking (fbc-tiling-y)
[741.905235] Starting subtest: fbc-tiling-y
[741.906972] Subtest fbc-tiling-y: SKIP (0.000s)
[742.045860] [080/131] (293s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[742.252188] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[742.253990] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[742.406468] [081/131] (293s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[742.683046] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[742.867972] [082/131] (293s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[742.946442] Starting subtest: single-wait-for-submit-available-submitted
[742.947429] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[743.097630] [083/131] (292s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[743.293516] Starting subtest: primary-y-tiled-reflect-x-90
[743.295252] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[743.387113] [084/131] (292s left) gem_exec_params (rel-constants-invalid-ring)
[743.475227] Starting subtest: rel-constants-invalid-ring
[743.476191] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[743.613317] [085/131] (292s left) kms_psr (pr-suspend)
[743.811233] Subtest pr-suspend: SKIP (0.000s)
[743.877845] [086/131] (292s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[744.080123] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[744.081895] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[744.229367] [087/131] (292s left) kms_flip (flip-vs-fences)
[744.424041] Starting subtest: flip-vs-fences
[744.425857] Subtest flip-vs-fences: SKIP (0.000s)
[744.581941] [088/131] (291s left) gem_exec_fence (submit)
[744.786533] Starting subtest: submit
[744.788460] Subtest submit: SKIP (0.000s)
[745.480948] [089/131] (290s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[745.685067] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[745.686710] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[745.824310] [090/131] (290s left) perf_pmu (render-node-busy-idle)
[745.931661] Starting subtest: render-node-busy-idle
[745.932524] Starting dynamic subtest: rcs0
[746.646472] Dynamic subtest rcs0: SUCCESS (0.714s)
[746.661515] Starting dynamic subtest: bcs0
[747.307096] Dynamic subtest bcs0: SUCCESS (0.658s)
[747.353118] Starting dynamic subtest: vcs0
[747.992148] Dynamic subtest vcs0: SUCCESS (0.680s)
[748.010618] Starting dynamic subtest: vcs1
[748.656888] Dynamic subtest vcs1: SUCCESS (0.660s)
[748.674215] Starting dynamic subtest: vecs0
[749.324088] Dynamic subtest vecs0: SUCCESS (0.662s)
[749.341015] Starting dynamic subtest: vecs1
[749.988116] Dynamic subtest vecs1: SUCCESS (0.659s)
[750.007258] Starting dynamic subtest: ccs0
[750.654052] Dynamic subtest ccs0: SUCCESS (0.661s)
[750.660451] Subtest render-node-busy-idle: SUCCESS (4.724s)
[750.752168] [091/131] (285s left) gem_exec_schedule (implicit-write-read)
[750.841027] Starting subtest: implicit-write-read
[750.841948] Starting dynamic subtest: rcs0
[751.133221] Dynamic subtest rcs0: SUCCESS (0.291s)
[751.143959] Starting dynamic subtest: bcs0
[751.340246] Dynamic subtest bcs0: SUCCESS (0.206s)
[751.350851] Starting dynamic subtest: vcs0
[751.554282] Dynamic subtest vcs0: SUCCESS (0.213s)
[751.576126] Starting dynamic subtest: vcs1
[751.779159] Dynamic subtest vcs1: SUCCESS (0.223s)
[751.789789] Starting dynamic subtest: vecs0
[751.991287] Dynamic subtest vecs0: SUCCESS (0.211s)
[752.001673] Starting dynamic subtest: vecs1
[752.203038] Dynamic subtest vecs1: SUCCESS (0.211s)
[752.213708] Starting dynamic subtest: ccs0
[752.416607] Dynamic subtest ccs0: SUCCESS (0.213s)
[752.417431] Subtest implicit-write-read: SUCCESS (1.576s)
[752.902710] [092/131] (283s left) gem_ccs (block-multicopy-compressed)
[752.989392] Starting subtest: block-multicopy-compressed
[752.990356] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[753.037398] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.047s)
[753.048250] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[753.133207] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.095s)
[753.145414] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[753.150506] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[753.161238] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[753.250886] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[753.263089] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[753.268378] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[753.280452] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[753.369429] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.100s)
[753.381599] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[753.387018] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[753.397596] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[753.491288] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.103s)
[753.492225] Subtest block-multicopy-compressed: SUCCESS (0.502s)
[753.643366] [093/131] (283s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[753.849156] Starting subtest: fbc-rgb565-draw-pwrite
[758.384943] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.535s)
[758.577622] [094/131] (278s left) kms_lease (lease-revoke)
[758.772495] Starting subtest: lease-revoke
[758.774927] Starting dynamic subtest: pipe-A-DP-3
[758.880446] Dynamic subtest pipe-A-DP-3: SUCCESS (0.105s)
[758.891125] Starting dynamic subtest: pipe-B-DP-3
[758.961402] Dynamic subtest pipe-B-DP-3: SUCCESS (0.079s)
[758.971902] Starting dynamic subtest: pipe-C-DP-3
[759.040351] Dynamic subtest pipe-C-DP-3: SUCCESS (0.078s)
[759.050814] Starting dynamic subtest: pipe-D-DP-3
[759.116515] Dynamic subtest pipe-D-DP-3: SUCCESS (0.075s)
[759.117439] Subtest lease-revoke: SUCCESS (0.345s)
[759.294248] [095/131] (277s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[759.501156] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[759.502883] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[759.656278] [096/131] (277s left) api_intel_bb (object-noreloc-keep-cache-simple)
[759.737672] Starting subtest: object-noreloc-keep-cache-simple
[759.770073] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.034s)
[759.946094] [097/131] (277s left) gem_ctx_bad_destroy (double-destroy)
[760.026728] Starting subtest: double-destroy
[760.027597] Subtest double-destroy: SUCCESS (0.000s)
[760.125762] [098/131] (276s left) gem_exec_fence (syncobj-unused-fence)
[760.674286] Starting subtest: syncobj-unused-fence
[760.707050] Subtest syncobj-unused-fence: SUCCESS (0.034s)
[761.135083] [099/131] (276s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[761.337965] Starting subtest: cursorA-vs-flipA-varying-size
[772.309712] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.970s)
[772.567782] [100/131] (264s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[772.778067] Starting subtest: 4-tiled-8bpp-rotate-270
[772.835974] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.057s)
[773.016440] [101/131] (264s left) kms_flip (dpms-vs-vblank-race-interruptible)
[773.220057] Starting subtest: dpms-vs-vblank-race-interruptible
[773.224934] Starting dynamic subtest: A-DP3
[776.483394] Dynamic subtest A-DP3: SUCCESS (3.257s)
[776.498439] Starting dynamic subtest: B-DP3
[779.511985] Dynamic subtest B-DP3: SUCCESS (3.027s)
[779.525680] Starting dynamic subtest: C-DP3
[782.571251] Dynamic subtest C-DP3: SUCCESS (3.057s)
[782.588316] Starting dynamic subtest: D-DP3
[785.647138] Dynamic subtest D-DP3: SUCCESS (3.075s)
[785.649748] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.428s)
[785.953260] [102/131] (251s left) gem_mmap_gtt (pf-nonblock)
[786.037271] Subtest pf-nonblock: SKIP (0.000s)
[786.141098] [103/131] (251s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[786.222541] Starting subtest: yf-tiled-to-vebox-y-tiled
[786.224575] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[786.425011] [104/131] (251s left) kms_prop_blob (blob-prop-lifetime)
[786.500420] Starting subtest: blob-prop-lifetime
[786.516470] Subtest blob-prop-lifetime: SUCCESS (0.016s)
[786.649543] [105/131] (251s left) kms_legacy_colorkey (invalid-plane)
[786.847512] Starting subtest: invalid-plane
[786.848440] Starting dynamic subtest: zero-id
[786.849344] Dynamic subtest zero-id: SUCCESS (0.000s)
[786.860210] Starting dynamic subtest: outrange-id
[786.861445] Dynamic subtest outrange-id: SUCCESS (0.000s)
[786.862537] Subtest invalid-plane: SUCCESS (0.002s)
[786.943763] [106/131] (250s left) gem_exec_schedule (preempt-queue-contexts-chain)
[787.037163] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[787.472908] [107/131] (250s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[787.550404] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[787.668858] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[787.786451] [108/131] (250s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[787.981490] Starting subtest: plane-upscale-20x20-with-modifiers
[787.982425] Starting dynamic subtest: pipe-A
[788.558858] Dynamic subtest pipe-A: SUCCESS (0.577s)
[788.585636] Starting dynamic subtest: pipe-B
[789.228400] Dynamic subtest pipe-B: SUCCESS (0.668s)
[789.254562] Starting dynamic subtest: pipe-C
[789.897158] Dynamic subtest pipe-C: SUCCESS (0.667s)
[789.916455] Starting dynamic subtest: pipe-D
[790.528599] Dynamic subtest pipe-D: SUCCESS (0.630s)
[790.529749] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (2.548s)
[790.848350] [109/131] (247s left) prime_busy (hang)
[790.933122] Starting subtest: hang
[790.935419] Starting dynamic subtest: rcs0
[817.514095] Dynamic subtest rcs0: SUCCESS (26.577s)
[817.525251] Starting dynamic subtest: bcs0
[824.601107] Dynamic subtest bcs0: SUCCESS (7.086s)
[824.612251] Starting dynamic subtest: vcs0
[831.657614] Dynamic subtest vcs0: SUCCESS (7.054s)
[831.668688] Starting dynamic subtest: vcs1
[838.628580] Dynamic subtest vcs1: SUCCESS (6.971s)
[838.639643] Starting dynamic subtest: vecs0
[845.595653] Dynamic subtest vecs0: SUCCESS (6.966s)
[845.606666] Starting dynamic subtest: vecs1
[852.643633] Dynamic subtest vecs1: SUCCESS (7.045s)
[852.654644] Starting dynamic subtest: ccs0
[866.475440] Dynamic subtest ccs0: SUCCESS (13.830s)
[866.476375] Subtest hang: SUCCESS (75.539s)
[866.604445] [110/131] (171s left) perf (non-sampling-read-error)
[866.969321] Starting subtest: non-sampling-read-error
[866.986509] Subtest non-sampling-read-error: SUCCESS (0.018s)
[867.046948] [111/131] (171s left) kms_flip (basic-flip-vs-modeset)
[867.243033] Starting subtest: basic-flip-vs-modeset
[867.247529] Starting dynamic subtest: A-DP3
[868.122352] Dynamic subtest A-DP3: SUCCESS (0.871s)
[868.143061] Starting dynamic subtest: B-DP3
[868.946281] Dynamic subtest B-DP3: SUCCESS (0.822s)
[868.965946] Starting dynamic subtest: C-DP3
[869.774418] Dynamic subtest C-DP3: SUCCESS (0.827s)
[869.799182] Starting dynamic subtest: D-DP3
[870.626487] Dynamic subtest D-DP3: SUCCESS (0.848s)
[870.629724] Subtest basic-flip-vs-modeset: SUCCESS (3.386s)
[870.911980] [112/131] (167s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[871.125075] Starting subtest: y-tiled-8bpp-rotate-0
[871.126588] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[871.286080] [113/131] (167s left) kms_pm_rpm (legacy-planes)
[873.037131] Starting subtest: legacy-planes
[873.039067] Starting dynamic subtest: plane-43
[875.886971] Dynamic subtest plane-43: SUCCESS (2.851s)
[875.902365] Starting dynamic subtest: plane-53
[878.731598] Dynamic subtest plane-53: SUCCESS (2.840s)
[878.777208] Starting dynamic subtest: plane-63
[881.558123] Dynamic subtest plane-63: SUCCESS (2.821s)
[881.605283] Starting dynamic subtest: plane-73
[884.534576] Dynamic subtest plane-73: SUCCESS (2.971s)
[884.541160] Subtest legacy-planes: SUCCESS (11.503s)
[884.927999] [114/131] (153s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[885.124507] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[885.126936] Starting dynamic subtest: pipe-A-DP-3
[885.135417] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[885.146550] Starting dynamic subtest: pipe-B-DP-3
[885.155210] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[885.165785] Starting dynamic subtest: pipe-C-DP-3
[885.174118] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[885.184771] Starting dynamic subtest: pipe-D-DP-3
[885.194951] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[885.197120] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[885.587967] [115/131] (152s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[885.784022] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[888.243106] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (2.458s)
[888.480699] [116/131] (150s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[888.682851] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[888.732174] [117/131] (149s left) kms_chamelium_edid (dp-mode-timings)
[889.015329] Subtest dp-mode-timings: SKIP (0.000s)
[889.173395] [118/131] (149s left) gem_exec_whisper (basic-normal)
[889.264009] Starting subtest: basic-normal
[892.869710] Subtest basic-normal: SUCCESS (3.604s)
[893.086151] [119/131] (145s left) api_intel_bb (simple-bb-ctx)
[893.165494] Starting subtest: simple-bb-ctx
[893.201484] Subtest simple-bb-ctx: SUCCESS (0.036s)
[893.349465] [120/131] (145s left) gem_render_copy (linear)
[893.442974] Starting subtest: linear
[893.443928] Starting dynamic subtest: smem
[893.554413] Dynamic subtest smem: SUCCESS (0.111s)
[893.565481] Starting dynamic subtest: lmem0
[893.826630] Dynamic subtest lmem0: SUCCESS (0.271s)
[893.827492] Subtest linear: SUCCESS (0.384s)
[894.080828] [121/131] (144s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[894.275550] Starting subtest: plane-scaler-unity-scaling-with-rotation
[894.276420] Starting dynamic subtest: pipe-A
[894.647737] Dynamic subtest pipe-A: SUCCESS (0.372s)
[894.668876] Starting dynamic subtest: pipe-B
[895.130977] Dynamic subtest pipe-B: SUCCESS (0.481s)
[895.151991] Starting dynamic subtest: pipe-C
[895.615151] Dynamic subtest pipe-C: SUCCESS (0.482s)
[895.645515] Starting dynamic subtest: pipe-D
[896.114172] Dynamic subtest pipe-D: SUCCESS (0.497s)
[896.115383] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (1.839s)
[896.440048] [122/131] (142s left) gem_softpin (softpin)
[896.529574] Starting subtest: softpin
[928.927141] Subtest softpin: SUCCESS (32.395s)
[929.064998] [123/131] (109s left) kms_cursor_crc (cursor-offscreen-256x85)
[929.521169] Starting subtest: cursor-offscreen-256x85
[929.526480] Starting dynamic subtest: pipe-A-DP-3
[932.114269] Dynamic subtest pipe-A-DP-3: SUCCESS (2.587s)
[932.164448] Starting dynamic subtest: pipe-D-DP-3
[934.642622] Dynamic subtest pipe-D-DP-3: SUCCESS (2.488s)
[934.643514] Subtest cursor-offscreen-256x85: SUCCESS (5.122s)
[934.970603] [124/131] (104s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[935.174926] Starting subtest: x-tiled-16bpp-rotate-180
[936.937096] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.762s)
[937.138477] [125/131] (101s left) kms_flip (flip-vs-suspend-interruptible)
[937.338168] Starting subtest: flip-vs-suspend-interruptible
[937.342982] Starting dynamic subtest: A-DP3
[977.025798] Dynamic subtest A-DP3: SUCCESS (7.767s)
[977.041580] Starting dynamic subtest: B-DP3
[1016.219346] Dynamic subtest B-DP3: SUCCESS (7.250s)
[1016.234982] Starting dynamic subtest: C-DP3
[1055.431719] Dynamic subtest C-DP3: SUCCESS (7.162s)
[1055.446737] Starting dynamic subtest: D-DP3
[1094.603657] Dynamic subtest D-DP3: SUCCESS (7.137s)
[1094.607935] Subtest flip-vs-suspend-interruptible: SUCCESS (29.329s)
[1094.821999] Overall timeout time exceeded, stopping.
[1094.850832] Closing watchdogs
results: parsing output: 0/ for test: kms_vblank
results: parsing output: 1/ for test: gem_ctx_param
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: vgem_basic
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: i915_pm_rc6_residency
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: i915_drm_fdinfo
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_vm_create
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_cursor_edge_walk
results: parsing output: 19/ for test: kms_scaling_modes
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_vrr
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_invalid_mode
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_wait
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: dmabuf_sync_file
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: prime_self_import
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_dither
results: parsing output: 38/ for test: i915_selftest
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: gem_pxp
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_ctx_sseu
results: parsing output: 45/ for test: kms_plane_multiple
results: parsing output: 46/ for test: gem_tiled_fence_blits
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: gem_fenced_exec_thrash
results: parsing output: 52/ for test: gen9_exec_parse
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: i915_pm_rps
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: gem_eio
results: parsing output: 57/ for test: prime_mmap
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_color
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gem_sync
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_ctx_exec
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: sysfs_timeslice_duration
results: parsing output: 74/ for test: kms_async_flips
results: parsing output: 75/ for test: kms_getfb
results: parsing output: 76/ for test: gem_exec_flush
results: parsing output: 77/ for test: gem_workarounds
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_chamelium_hpd
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: gem_ccs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_lease
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: gem_ctx_bad_destroy
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_prop_blob
results: parsing output: 104/ for test: kms_legacy_colorkey
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: prime_busy
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_chamelium_edid
results: parsing output: 117/ for test: gem_exec_whisper
results: parsing output: 118/ for test: api_intel_bb
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 126/ for test: kms_rotation_crc
results: no output, setting notrun
results: parsing output: 127/ for test: gem_exec_params
results: no output, setting notrun
results: parsing output: 128/ for test: gem_ctx_sseu
results: no output, setting notrun
results: parsing output: 129/ for test: syncobj_basic
results: no output, setting notrun
results: parsing output: 130/ for test: gem_mmap_offset
results: no output, setting notrun
Done.