[58.630844] Initializing watchdogs
[58.630911]   /dev/watchdog0
[58.638774] [001/131] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[58.869927] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[58.871648] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[58.951531] [002/131] (960s left) kms_hdr (static-swap)
[59.194912] Starting subtest: static-swap
[62.581474] Starting dynamic subtest: pipe-A-DP-4
[63.737698] Dynamic subtest pipe-A-DP-4: SUCCESS (1.159s)
[63.739148] Subtest static-swap: SUCCESS (4.553s)
[64.047922] [003/131] (955s left) kms_cursor_crc (cursor-alpha-opaque)
[64.303428] Starting subtest: cursor-alpha-opaque
[64.304288] Starting dynamic subtest: pipe-A-DP-4
[64.853450] Dynamic subtest pipe-A-DP-4: SUCCESS (0.549s)
[64.866343] Starting dynamic subtest: pipe-D-DP-4
[65.384767] Dynamic subtest pipe-D-DP-4: SUCCESS (0.531s)
[65.385926] Subtest cursor-alpha-opaque: SUCCESS (1.083s)
[65.889300] [004/131] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[66.155869] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[66.157488] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[66.256646] [005/131] (952s left) gem_userptr_blits (coherency-sync)
[66.386233] Starting subtest: coherency-sync
[66.632692] Subtest coherency-sync: SKIP (0.232s)
[66.737203] [006/131] (952s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[66.888725] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[66.889869] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[67.378879] [007/131] (951s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[67.921127] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[68.944048] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.024s)
[69.132257] [008/131] (950s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[69.347960] Starting subtest: plane-all-modeset-transition-internal-panels
[69.349669] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[69.409236] [009/131] (949s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[69.490450] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[69.521305] [010/131] (949s left) gem_exec_reloc (basic-write-gtt-noreloc)
[69.599068] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[69.640222] [011/131] (949s left) kms_psr (fbc-psr2-basic)
[69.873405] Subtest fbc-psr2-basic: SKIP (0.000s)
[69.903706] [012/131] (949s left) gem_close_race (multigpu-basic-process)
[70.008286] Starting subtest: multigpu-basic-process
[70.010251] Subtest multigpu-basic-process: SKIP (0.000s)
[70.260703] [013/131] (949s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[70.360775] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[70.498423] [014/131] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[70.719758] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[70.721444] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[70.822105] [015/131] (948s left) drm_read (fault-buffer)
[71.142401] Starting subtest: fault-buffer
[71.143316] Subtest fault-buffer: SUCCESS (0.001s)
[71.327225] [016/131] (948s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[71.432453] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[71.533603] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[71.634859] [017/131] (947s left) kms_flip (flip-vs-rmfb)
[71.873304] Starting subtest: flip-vs-rmfb
[71.876566] Starting dynamic subtest: A-DP4
[79.711315] Dynamic subtest A-DP4: SUCCESS (7.836s)
[79.743401] Starting dynamic subtest: B-DP4
[87.486881] Dynamic subtest B-DP4: SUCCESS (7.773s)
[87.517162] Starting dynamic subtest: C-DP4
[95.262171] Dynamic subtest C-DP4: SUCCESS (7.773s)
[95.291463] Starting dynamic subtest: D-DP4
[103.043833] Dynamic subtest D-DP4: SUCCESS (7.779s)
[103.048592] Subtest flip-vs-rmfb: SUCCESS (31.176s)
[103.374112] [018/131] (916s left) gem_exec_params (readonly)
[103.470263] Starting subtest: readonly
[103.472387] Subtest readonly: SUCCESS (0.001s)
[103.607137] [019/131] (916s left) api_intel_bb (render-ccs)
[103.694235] Starting subtest: render-ccs
[103.781332] Subtest render-ccs: SUCCESS (0.087s)
[103.916139] [020/131] (915s left) gen9_exec_parse (valid-registers)
[103.988998] Subtest valid-registers: SKIP (0.000s)
[104.023530] [021/131] (915s left) kms_atomic (atomic-invalid-params)
[104.252129] Starting subtest: atomic-invalid-params
[104.253149] Starting dynamic subtest: pipe-A-DP-4
[104.805917] Dynamic subtest pipe-A-DP-4: SUCCESS (0.552s)
[104.807098] Subtest atomic-invalid-params: SUCCESS (0.554s)
[105.066072] [022/131] (914s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[105.320407] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[105.321351] Starting dynamic subtest: pipe-A-DP-4
[105.330034] Dynamic subtest pipe-A-DP-4: SKIP (0.001s)
[105.337436] Starting dynamic subtest: pipe-B-DP-4
[105.345947] Dynamic subtest pipe-B-DP-4: SKIP (0.001s)
[105.353188] Starting dynamic subtest: pipe-C-DP-4
[105.361815] Dynamic subtest pipe-C-DP-4: SKIP (0.001s)
[105.368917] Starting dynamic subtest: pipe-D-DP-4
[105.377338] Dynamic subtest pipe-D-DP-4: SKIP (0.001s)
[105.379039] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.008s)
[105.723984] [023/131] (914s left) i915_pm_freq_api (freq-basic-api)
[105.827404] Starting subtest: freq-basic-api
[105.828458] Starting dynamic subtest: gt0
[105.832780] Dynamic subtest gt0: SUCCESS (0.005s)
[105.833747] Subtest freq-basic-api: SUCCESS (0.006s)
[105.958303] [024/131] (913s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[106.042690] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[106.157641] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[106.222474] [025/131] (913s left) gem_eio (in-flight-internal-1us)
[106.507187] Starting subtest: in-flight-internal-1us
[107.935794] Subtest in-flight-internal-1us: SUCCESS (1.429s)
[108.148610] [026/131] (911s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[108.387799] Starting subtest: bo-too-small-due-to-tiling
[108.389481] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[108.495779] [027/131] (911s left) gem_set_tiling_vs_gtt
[108.626425] [028/131] (911s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[108.861665] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[108.862558] Starting dynamic subtest: pipe-A-valid-mode
[108.940524] Dynamic subtest pipe-A-valid-mode: SKIP (0.078s)
[108.942304] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.079s)
[109.108205] [029/131] (910s left) gem_exec_params (sol-reset-invalid)
[109.215876] Starting subtest: sol-reset-invalid
[109.218022] Subtest sol-reset-invalid: SUCCESS (0.001s)
[109.368879] [030/131] (910s left) i915_suspend (basic-s3-without-i915)
[109.437462] Starting subtest: basic-s3-without-i915
[131.915746] Subtest basic-s3-without-i915: SUCCESS (6.492s)
[133.035221] [031/131] (903s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[133.129742] Starting subtest: single-wait-all-for-submit-available-submitted
[133.130969] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[133.243735] [032/131] (903s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[133.486009] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[133.510783] [033/131] (903s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[133.730572] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[133.732305] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[133.825782] [034/131] (903s left) syncobj_timeline (invalid-signal-bad-pad)
[133.917336] Starting subtest: invalid-signal-bad-pad
[133.918242] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[134.047628] [035/131] (903s left) perf_pmu (most-busy-check-all)
[134.127411] Starting subtest: most-busy-check-all
[134.128324] Starting dynamic subtest: rcs0
[134.734913] Dynamic subtest rcs0: SUCCESS (0.606s)
[134.750350] Starting dynamic subtest: bcs0
[135.293108] Dynamic subtest bcs0: SUCCESS (0.555s)
[135.306164] Starting dynamic subtest: vcs0
[135.849279] Dynamic subtest vcs0: SUCCESS (0.554s)
[135.858814] Starting dynamic subtest: vcs1
[136.399280] Dynamic subtest vcs1: SUCCESS (0.549s)
[136.410044] Starting dynamic subtest: vecs0
[136.949275] Dynamic subtest vecs0: SUCCESS (0.549s)
[136.960037] Starting dynamic subtest: vecs1
[137.502564] Dynamic subtest vecs1: SUCCESS (0.551s)
[137.516721] Starting dynamic subtest: ccs0
[138.056266] Dynamic subtest ccs0: SUCCESS (0.551s)
[138.057168] Subtest most-busy-check-all: SUCCESS (3.929s)
[138.174402] [036/131] (899s left) syncobj_wait (wait-all-snapshot)
[138.243381] Starting subtest: wait-all-snapshot
[138.326690] Subtest wait-all-snapshot: SUCCESS (0.082s)
[138.441081] [037/131] (898s left) prime_mmap (test_userptr)
[138.515218] Starting subtest: test_userptr
[138.516169] Starting dynamic subtest: test_userptr-smem
[138.517066] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[138.517995] Subtest test_userptr: SUCCESS (0.001s)
[138.623105] [038/131] (898s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[138.848770] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[138.850507] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[138.947907] [039/131] (898s left) kms_flip (2x-plain-flip-interruptible)
[139.196973] Starting subtest: 2x-plain-flip-interruptible
[139.210005] Subtest 2x-plain-flip-interruptible: SKIP (0.013s)
[139.267245] [040/131] (898s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[139.506668] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[139.508443] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[139.592668] [041/131] (897s left) gem_workarounds (basic-read-context)
[139.713357] Starting subtest: basic-read-context
[139.746218] Subtest basic-read-context: SUCCESS (0.033s)
[139.845397] [042/131] (897s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[140.212404] Starting subtest: cursor-rapid-movement-64x64
[140.226240] Starting dynamic subtest: pipe-A-DP-4
[140.684339] Dynamic subtest pipe-A-DP-4: SUCCESS (0.457s)
[140.727182] Starting dynamic subtest: pipe-D-DP-4
[141.094669] Dynamic subtest pipe-D-DP-4: SUCCESS (0.376s)
[141.095856] Subtest cursor-rapid-movement-64x64: SUCCESS (0.883s)
[141.512995] [043/131] (895s left) gem_exec_whisper (basic-queues-priority-all)
[141.610301] Starting subtest: basic-queues-priority-all
[163.653288] Subtest basic-queues-priority-all: SUCCESS (21.925s)
[163.868932] [044/131] (873s left) kms_chamelium_audio (dp-audio)
[164.184342] Subtest dp-audio: SKIP (0.000s)
[164.328039] [045/131] (873s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[164.573340] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[164.576993] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.003s)
[164.633318] [046/131] (873s left) kms_cursor_crc (cursor-onscreen-max-size)
[165.084053] Starting subtest: cursor-onscreen-max-size
[165.086811] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[165.301901] [047/131] (872s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[165.553348] Starting subtest: x-tiled-32bpp-rotate-180
[167.203891] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.647s)
[167.372075] [048/131] (870s left) syncobj_timeline (wait-for-submit-snapshot)
[167.446677] Starting subtest: wait-for-submit-snapshot
[167.531105] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[167.604928] [049/131] (870s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[167.859056] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[167.860963] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[168.002172] [050/131] (869s left) gem_sync (basic-each)
[168.098941] Starting subtest: basic-each
[170.357991] Subtest basic-each: SUCCESS (2.256s)
[170.587971] [051/131] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[170.838340] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[170.840220] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[170.938551] [052/131] (867s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[171.183789] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[171.185501] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[171.300867] [053/131] (866s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[171.556984] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[174.311844] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.753s)
[174.448722] [054/131] (863s left) kms_pm_dc (dc5-dpms)
[175.673292] Starting subtest: dc5-dpms
[176.981348] Subtest dc5-dpms: SUCCESS (1.306s)
[177.053932] [055/131] (861s left) kms_cursor_edge_walk (256x256-top-edge)
[177.288453] Starting subtest: 256x256-top-edge
[177.291601] Starting dynamic subtest: pipe-A-DP-4
[180.750179] Dynamic subtest pipe-A-DP-4: SUCCESS (3.459s)
[180.760898] Starting dynamic subtest: pipe-D-DP-4
[184.073915] Dynamic subtest pipe-D-DP-4: SUCCESS (3.323s)
[184.075032] Subtest 256x256-top-edge: SUCCESS (6.787s)
[184.296812] [056/131] (853s left) kms_big_fb (4-tiled-addfb-size-overflow)
[184.529757] Starting subtest: 4-tiled-addfb-size-overflow
[184.530699] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.001s)
[184.642852] [057/131] (853s left) dumb_buffer (create-clear)
[184.732108] Starting subtest: create-clear
[221.354139] Subtest create-clear: SUCCESS (36.615s)
[221.680621] [058/131] (816s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[221.916672] Starting subtest: 2x-flip-vs-modeset-vs-hang
[221.937715] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.021s)
[222.016803] [059/131] (816s left) gem_ppgtt (shrink-vs-evict-any)
[222.100520] Starting subtest: shrink-vs-evict-any
[227.954762] Subtest shrink-vs-evict-any: SUCCESS (5.852s)
[228.046818] [060/131] (810s left) kms_psr (psr-primary-blt)
[228.271312] Subtest psr-primary-blt: SKIP (0.000s)
[228.295662] [061/131] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[228.525235] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[228.527185] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[228.602763] [062/131] (809s left) api_intel_allocator (standalone)
[228.684265] Starting subtest: standalone
[228.722351] Subtest standalone: SUCCESS (0.039s)
[228.886211] [063/131] (809s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[228.968276] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[228.970187] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[229.161731] [064/131] (809s left) gem_exec_schedule (preempt-other-chain)
[229.251884] Starting subtest: preempt-other-chain
[229.252859] Starting dynamic subtest: rcs0
[229.683666] Dynamic subtest rcs0: SUCCESS (0.431s)
[229.694656] Starting dynamic subtest: bcs0
[230.086410] Dynamic subtest bcs0: SUCCESS (0.402s)
[230.097025] Starting dynamic subtest: vcs0
[230.487621] Dynamic subtest vcs0: SUCCESS (0.400s)
[230.498278] Starting dynamic subtest: vcs1
[230.893945] Dynamic subtest vcs1: SUCCESS (0.405s)
[230.905127] Starting dynamic subtest: vecs0
[231.295263] Dynamic subtest vecs0: SUCCESS (0.400s)
[231.306196] Starting dynamic subtest: vecs1
[231.695627] Dynamic subtest vecs1: SUCCESS (0.399s)
[231.706452] Starting dynamic subtest: ccs0
[232.236976] Dynamic subtest ccs0: SUCCESS (0.540s)
[232.238102] Subtest preempt-other-chain: SUCCESS (2.984s)
[232.629819] [065/131] (805s left) kms_rotation_crc (sprite-rotation-180)
[232.865604] Starting subtest: sprite-rotation-180
[240.598887] Subtest sprite-rotation-180: SUCCESS (7.730s)
[240.933700] [066/131] (797s left) gem_tiled_partial_pwrite_pread (reads)
[241.020283] Subtest reads: SKIP (0.000s)
[241.093322] [067/131] (797s left) gen7_exec_parse (basic-offset)
[241.191515] Subtest basic-offset: SKIP (0.000s)
[241.244500] [068/131] (797s left) kms_psr (fbc-psr-primary-render)
[241.468113] Subtest fbc-psr-primary-render: SKIP (0.000s)
[241.495847] [069/131] (797s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[241.727923] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[241.729738] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[241.832335] [070/131] (796s left) gem_sync (basic-store-all)
[241.933395] Starting subtest: basic-store-all
[246.621288] Subtest basic-store-all: SUCCESS (4.689s)
[246.821851] [071/131] (791s left) gem_ctx_bad_destroy (invalid-pad)
[246.890349] Starting subtest: invalid-pad
[246.891269] Subtest invalid-pad: SUCCESS (0.000s)
[246.950748] [072/131] (791s left) kms_big_fb (x-tiled-addfb)
[247.185443] Starting subtest: x-tiled-addfb
[247.186343] Subtest x-tiled-addfb: SUCCESS (0.000s)
[247.316237] [073/131] (791s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[247.571935] Starting subtest: fbcpsr-stridechange
[247.573967] Subtest fbcpsr-stridechange: SKIP (0.000s)
[247.680530] [074/131] (791s left) prime_vgem (fence-flip-hang)
[247.865847] Subtest fence-flip-hang: SKIP (0.000s)
[247.998580] [075/131] (790s left) kms_prime (basic-crc-hybrid)
[250.631487] Subtest basic-crc-hybrid: SKIP (0.000s)
[250.717822] [076/131] (788s left) kms_feature_discovery (display-3x)
[250.944161] Starting subtest: display-3x
[250.946011] Subtest display-3x: SKIP (0.000s)
[251.015710] [077/131] (787s left) perf_pmu (busy-idle)
[251.089725] Starting subtest: busy-idle
[251.090738] Starting dynamic subtest: rcs0
[251.818479] Dynamic subtest rcs0: SUCCESS (0.728s)
[251.833350] Starting dynamic subtest: bcs0
[252.486618] Dynamic subtest bcs0: SUCCESS (0.664s)
[252.501253] Starting dynamic subtest: vcs0
[253.150502] Dynamic subtest vcs0: SUCCESS (0.660s)
[253.169225] Starting dynamic subtest: vcs1
[253.818575] Dynamic subtest vcs1: SUCCESS (0.664s)
[253.837289] Starting dynamic subtest: vecs0
[254.482478] Dynamic subtest vecs0: SUCCESS (0.660s)
[254.501052] Starting dynamic subtest: vecs1
[255.146525] Dynamic subtest vecs1: SUCCESS (0.660s)
[255.161338] Starting dynamic subtest: ccs0
[255.815547] Dynamic subtest ccs0: SUCCESS (0.665s)
[255.817626] Subtest busy-idle: SUCCESS (4.729s)
[255.934880] [078/131] (782s left) gem_cs_tlb (engines)
[256.028146] Starting subtest: engines
[256.029054] Starting dynamic subtest: rcs0
[258.181750] Dynamic subtest rcs0: SUCCESS (2.153s)
[258.192564] Starting dynamic subtest: bcs0
[260.334734] Dynamic subtest bcs0: SUCCESS (2.152s)
[260.345735] Starting dynamic subtest: vcs0
[262.486799] Dynamic subtest vcs0: SUCCESS (2.151s)
[262.497700] Starting dynamic subtest: vcs1
[264.640159] Dynamic subtest vcs1: SUCCESS (2.153s)
[264.651001] Starting dynamic subtest: vecs0
[266.792493] Dynamic subtest vecs0: SUCCESS (2.151s)
[266.803408] Starting dynamic subtest: vecs1
[268.944812] Dynamic subtest vecs1: SUCCESS (2.151s)
[268.955540] Starting dynamic subtest: ccs0
[271.097485] Dynamic subtest ccs0: SUCCESS (2.151s)
[271.098350] Subtest engines: SUCCESS (15.071s)
[271.202118] [079/131] (767s left) kms_pipe_crc_basic (hang-read-crc)
[271.427152] Starting subtest: hang-read-crc
[271.428081] Starting dynamic subtest: pipe-A-DP-4
[272.955808] Dynamic subtest pipe-A-DP-4: SUCCESS (1.525s)
[272.981923] Starting dynamic subtest: pipe-B-DP-4
[274.339980] Dynamic subtest pipe-B-DP-4: SUCCESS (1.380s)
[274.352920] Starting dynamic subtest: pipe-C-DP-4
[275.662347] Dynamic subtest pipe-C-DP-4: SUCCESS (1.321s)
[275.677439] Starting dynamic subtest: pipe-D-DP-4
[277.031525] Dynamic subtest pipe-D-DP-4: SUCCESS (1.367s)
[277.032527] Subtest hang-read-crc: SUCCESS (5.606s)
[277.277160] [080/131] (761s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[277.521019] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[277.522780] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[277.600406] [081/131] (761s left) gem_ringfill (legacy-basic)
[278.089834] Starting subtest: legacy-basic
[278.095830] Starting dynamic subtest: default
[278.210348] Dynamic subtest default: SUCCESS (0.118s)
[278.226528] Starting dynamic subtest: render
[278.253173] Dynamic subtest render: SUCCESS (0.041s)
[278.270622] Starting dynamic subtest: bsd
[278.294339] Dynamic subtest bsd: SUCCESS (0.040s)
[278.318951] Starting dynamic subtest: bsd1
[278.337499] Dynamic subtest bsd1: SUCCESS (0.041s)
[278.361643] Starting dynamic subtest: bsd2
[278.381382] Dynamic subtest bsd2: SUCCESS (0.042s)
[278.399509] Starting dynamic subtest: blt
[278.425306] Dynamic subtest blt: SUCCESS (0.042s)
[278.445268] Starting dynamic subtest: vebox
[278.468445] Dynamic subtest vebox: SUCCESS (0.041s)
[278.469517] Subtest legacy-basic: SUCCESS (0.380s)
[278.586365] [082/131] (760s left) gem_exec_reloc (basic-gtt-active)
[278.670981] Subtest basic-gtt-active: SKIP (0.000s)
[278.725874] [083/131] (760s left) kms_psr (pr-cursor-mmap-gtt)
[278.963230] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[278.990802] [084/131] (760s left) drm_fdinfo (all-busy-idle-check-all)
[279.056790] Starting subtest: all-busy-idle-check-all
[279.082013] Subtest all-busy-idle-check-all: SKIP (0.024s)
[279.147065] [085/131] (759s left) kms_lease (lease-get)
[279.413889] Starting subtest: lease-get
[279.415125] Starting dynamic subtest: pipe-A-DP-4
[279.417720] Dynamic subtest pipe-A-DP-4: SUCCESS (0.002s)
[279.429920] Starting dynamic subtest: pipe-B-DP-4
[279.430804] Dynamic subtest pipe-B-DP-4: SUCCESS (0.002s)
[279.442130] Starting dynamic subtest: pipe-C-DP-4
[279.443052] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[279.453687] Starting dynamic subtest: pipe-D-DP-4
[279.454882] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[279.455984] Subtest lease-get: SUCCESS (0.015s)
[279.515490] [086/131] (759s left) i915_pm_rpm (system-suspend-devices)
[282.035712] Starting subtest: system-suspend-devices
[289.945290] Subtest system-suspend-devices: SUCCESS (7.909s)
[292.286672] [087/131] (748s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[292.537275] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[292.563994] [088/131] (748s left) kms_rotation_crc (primary-rotation-270)
[292.808026] Starting subtest: primary-rotation-270
[292.812303] Subtest primary-rotation-270: SKIP (0.002s)
[292.885056] [089/131] (748s left) syncobj_basic (bad-fd-to-handle)
[292.960210] Starting subtest: bad-fd-to-handle
[292.961258] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[293.086084] [090/131] (748s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[293.323204] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[293.325019] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[293.589439] [091/131] (747s left) kms_chamelium_color (ctm-limited-range)
[293.821390] Subtest ctm-limited-range: SKIP (0.000s)
[293.848722] [092/131] (747s left) gem_exec_balancer (parallel-out-fence)
[294.178136] Starting subtest: parallel-out-fence
[296.088977] Subtest parallel-out-fence: SUCCESS (1.911s)
[296.172021] [093/131] (745s left) gem_userptr_blits (sync-unmap)
[296.260127] Starting subtest: sync-unmap
[296.280179] Subtest sync-unmap: SUCCESS (0.020s)
[296.441019] [094/131] (744s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[296.679982] Starting subtest: flip-vs-dpms-off-vs-modeset
[296.684512] Starting dynamic subtest: A-DP4
[297.498982] Dynamic subtest A-DP4: SUCCESS (0.812s)
[297.528795] Starting dynamic subtest: B-DP4
[298.309078] Dynamic subtest B-DP4: SUCCESS (0.805s)
[298.336242] Starting dynamic subtest: C-DP4
[299.126006] Dynamic subtest C-DP4: SUCCESS (0.815s)
[299.152267] Starting dynamic subtest: D-DP4
[299.923011] Dynamic subtest D-DP4: SUCCESS (0.793s)
[299.924102] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.244s)
[300.189418] [095/131] (741s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[300.432598] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[300.457161] [096/131] (740s left) gem_exec_alignment (forked)
[300.538716] Starting subtest: forked
[341.364293] Subtest forked: SUCCESS (40.811s)
[341.426321] [097/131] (700s left) kms_plane (planar-pixel-format-settings)
[341.695491] Starting subtest: planar-pixel-format-settings
[341.733947] Subtest planar-pixel-format-settings: SUCCESS (0.038s)
[341.840189] [098/131] (699s left) vgem_basic (busy-fence)
[341.935038] Starting subtest: busy-fence
[341.935963] Subtest busy-fence: SUCCESS (0.000s)
[341.993937] [099/131] (699s left) kms_psr (psr2-sprite-plane-move)
[342.224995] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[342.250742] [100/131] (699s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[346.184910] Starting subtest: heavy-verify-multi-ccs
[346.185924] Starting dynamic subtest: lmem0
[354.605943] Dynamic subtest lmem0: SUCCESS (8.418s)
[354.606927] Subtest heavy-verify-multi-ccs: SUCCESS (8.419s)
[357.353037] [101/131] (684s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[359.243973] Starting subtest: fbc-dirtyfb-ioctl
[359.246561] Starting dynamic subtest: A-DP-4
[360.747357] Dynamic subtest A-DP-4: SUCCESS (1.502s)
[360.748246] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.504s)
[360.966211] [102/131] (680s left) kms_color (ctm-0-75)
[361.195665] Starting subtest: ctm-0-75
[361.196572] Starting dynamic subtest: pipe-A-DP-4
[363.413985] Dynamic subtest pipe-A-DP-4: SUCCESS (2.217s)
[363.436056] Starting dynamic subtest: pipe-B-DP-4
[365.546591] Dynamic subtest pipe-B-DP-4: SUCCESS (2.131s)
[365.563671] Starting dynamic subtest: pipe-C-DP-4
[367.635709] Dynamic subtest pipe-C-DP-4: SUCCESS (2.087s)
[367.649513] Starting dynamic subtest: pipe-D-DP-4
[369.735206] Dynamic subtest pipe-D-DP-4: SUCCESS (2.098s)
[369.736173] Subtest ctm-0-75: SUCCESS (8.538s)
[369.989922] [103/131] (671s left) kms_properties (invalid-properties-atomic)
[370.242170] Starting subtest: invalid-properties-atomic
[370.602885] Subtest invalid-properties-atomic: SUCCESS (0.361s)
[370.659328] [104/131] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[370.891224] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[370.893034] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[370.989033] [105/131] (670s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[371.258033] Starting subtest: extended-pageflip-modeset-hang-oldfb
[371.259380] Starting dynamic subtest: pipe-A
[379.100195] Dynamic subtest pipe-A: SUCCESS (7.842s)
[379.112238] Starting dynamic subtest: pipe-D
[386.907193] Dynamic subtest pipe-D: SUCCESS (7.806s)
[386.908095] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.655s)
[387.177223] [106/131] (654s left) gem_ctx_persistence (hang)
[387.257138] Starting subtest: hang
[387.259310] Subtest hang: SKIP (0.000s)
[387.379290] [107/131] (654s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[387.616923] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[387.617735] Starting dynamic subtest: pipe-A
[387.739020] Dynamic subtest pipe-A: SUCCESS (0.123s)
[387.772058] Starting dynamic subtest: pipe-B
[387.974388] Dynamic subtest pipe-B: SUCCESS (0.234s)
[387.994407] Starting dynamic subtest: pipe-C
[388.193125] Dynamic subtest pipe-C: SUCCESS (0.217s)
[388.205481] Starting dynamic subtest: pipe-D
[388.395348] Dynamic subtest pipe-D: SUCCESS (0.201s)
[388.396359] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.780s)
[388.696697] [108/131] (653s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[388.938529] Starting subtest: 4-tiled-16bpp-rotate-0
[390.632717] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.694s)
[390.787898] [109/131] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[391.023823] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[391.025780] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[391.128160] [110/131] (650s left) kms_plane_alpha_blend (constant-alpha-mid)
[391.388060] Starting subtest: constant-alpha-mid
[391.613022] Starting dynamic subtest: pipe-A-DP-4
[392.354953] Dynamic subtest pipe-A-DP-4: SUCCESS (0.741s)
[392.365893] Starting dynamic subtest: pipe-D-DP-4
[393.133751] Dynamic subtest pipe-D-DP-4: SUCCESS (0.777s)
[393.134841] Subtest constant-alpha-mid: SUCCESS (1.746s)
[393.354792] [111/131] (648s left) gem_ctx_persistence (idempotent)
[393.439615] Starting subtest: idempotent
[393.440517] Subtest idempotent: SUCCESS (0.000s)
[393.576755] [112/131] (648s left) kms_chamelium_hpd (hdmi-hpd-fast)
[393.900096] Subtest hdmi-hpd-fast: SKIP (0.000s)
[394.015055] [113/131] (648s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[394.258951] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[394.260519] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[394.360815] [114/131] (647s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[395.124816] Starting subtest: syncobj-timeline-invalid-wait
[395.125997] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[395.387733] [115/131] (646s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[395.623216] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[395.625011] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[395.732150] [116/131] (646s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[395.991931] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[395.993895] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[396.091660] [117/131] (646s left) gem_exec_balancer (semaphore)
[396.197283] Starting subtest: semaphore
[397.436975] Subtest semaphore: SUCCESS (1.240s)
[397.829035] [118/131] (644s left) syncobj_basic (create-signaled)
[397.905127] Starting subtest: create-signaled
[397.906058] Subtest create-signaled: SUCCESS (0.000s)
[398.044669] [119/131] (644s left) gem_softpin (overlap)
[398.128023] Starting subtest: overlap
[400.474558] Subtest overlap: SUCCESS (2.346s)
[400.590026] [120/131] (641s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[400.820039] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[400.821218] Starting dynamic subtest: pipe-A-DP-4
[400.830273] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[400.841279] Starting dynamic subtest: pipe-B-DP-4
[400.850080] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[400.861196] Starting dynamic subtest: pipe-C-DP-4
[400.869756] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[400.880958] Starting dynamic subtest: pipe-D-DP-4
[400.891138] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[400.892920] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[401.222384] [121/131] (641s left) gem_exec_schedule (thriceslice)
[401.316111] Starting subtest: thriceslice
[401.317038] Starting dynamic subtest: rcs0
[401.345605] Dynamic subtest rcs0: SUCCESS (0.029s)
[401.356920] Starting dynamic subtest: bcs0
[401.374961] Dynamic subtest bcs0: SUCCESS (0.028s)
[401.387388] Starting dynamic subtest: vcs0
[401.407532] Dynamic subtest vcs0: SUCCESS (0.031s)
[401.421215] Starting dynamic subtest: vcs1
[401.438956] Dynamic subtest vcs1: SUCCESS (0.030s)
[401.452666] Starting dynamic subtest: vecs0
[401.470799] Dynamic subtest vecs0: SUCCESS (0.031s)
[401.485877] Starting dynamic subtest: vecs1
[401.502349] Dynamic subtest vecs1: SUCCESS (0.031s)
[401.517293] Starting dynamic subtest: ccs0
[401.531390] Dynamic subtest ccs0: SUCCESS (0.028s)
[401.532309] Subtest thriceslice: SUCCESS (0.216s)
[401.929801] [122/131] (640s left) gem_mmap_gtt (fault-concurrent-y)
[402.012074] Subtest fault-concurrent-Y: SKIP (0.000s)
[402.071583] [123/131] (640s left) kms_vrr (seamless-rr-switch-drrs)
[402.313827] Starting subtest: seamless-rr-switch-drrs
[402.316433] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[402.389199] [124/131] (640s left) kms_sequence (get-idle)
[402.629320] Starting subtest: get-idle
[402.630193] Starting dynamic subtest: pipe-A-DP-4
[405.004829] Dynamic subtest pipe-A-DP-4: SUCCESS (2.375s)
[405.016583] Starting dynamic subtest: pipe-B-DP-4
[407.302535] Dynamic subtest pipe-B-DP-4: SUCCESS (2.297s)
[407.317229] Starting dynamic subtest: pipe-C-DP-4
[409.610848] Dynamic subtest pipe-C-DP-4: SUCCESS (2.306s)
[409.625629] Starting dynamic subtest: pipe-D-DP-4
[411.921219] Dynamic subtest pipe-D-DP-4: SUCCESS (2.308s)
[411.922242] Subtest get-idle: SUCCESS (9.295s)
[412.179834] [125/131] (630s left) debugfs_test (read_all_entries)
[412.264570] Starting subtest: read_all_entries
[412.997609] Subtest read_all_entries: SUCCESS (0.732s)
[413.252122] [126/131] (629s left) gem_mmap_wc (bad-object)
[413.342129] Subtest bad-object: SKIP (0.000s)
[413.377847] [127/131] (629s left) gem_caching (writes)
[413.465741] Starting subtest: writes
[417.173914] Subtest writes: SUCCESS (3.708s)
[417.321085] [128/131] (625s left) kms_vblank (wait-busy)
[417.562609] Starting subtest: wait-busy
[417.563487] Starting dynamic subtest: pipe-A-DP-4
[420.052092] Dynamic subtest pipe-A-DP-4: SUCCESS (2.488s)
[420.067014] Starting dynamic subtest: pipe-D-DP-4
[422.479319] Dynamic subtest pipe-D-DP-4: SUCCESS (2.424s)
[422.480258] Subtest wait-busy: SUCCESS (4.918s)
[422.700612] [129/131] (620s left) gem_exec_nop (basic-series)
[422.791174] Starting subtest: basic-series
[427.135871] Subtest basic-series: SUCCESS (4.343s)
[427.357316] [130/131] (615s left) gem_close (many-handles-one-vma)
[427.439197] Starting subtest: many-handles-one-vma
[427.467636] Subtest many-handles-one-vma: SUCCESS (0.028s)
[427.563209] [131/131] (615s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[427.819543] Starting subtest: fbc-modesetfrombusy
[429.090032] Subtest fbc-modesetfrombusy: SUCCESS (1.272s)
[429.241989] Closing watchdogs
Done.