[45.796977] Initializing watchdogs
[45.797056]   /dev/watchdog0
[45.805664] [001/130] (960s left) gem_ctx_persistence (legacy-engines-mixed-process)
[45.855162] Starting subtest: legacy-engines-mixed-process
[45.855938] Starting dynamic subtest: render
[46.244528] Dynamic subtest render: SUCCESS (0.381s)
[46.253687] Starting dynamic subtest: bsd1
[46.632323] Dynamic subtest bsd1: SUCCESS (0.379s)
[46.640704] Starting dynamic subtest: bsd2
[47.025148] Dynamic subtest bsd2: SUCCESS (0.385s)
[47.039156] Starting dynamic subtest: blt
[47.425144] Dynamic subtest blt: SUCCESS (0.392s)
[47.436447] Starting dynamic subtest: vebox
[47.802728] Dynamic subtest vebox: SUCCESS (0.371s)
[47.803911] Subtest legacy-engines-mixed-process: SUCCESS (1.911s)
[47.847544] [002/130] (958s left) core_hotunplug (unbind-rebind)
[47.932776] Starting subtest: unbind-rebind
[51.105028] Subtest unbind-rebind: SUCCESS (3.131s)
[51.117941] [003/130] (955s left) i915_pipe_stress (stress-xrgb8888-ytiled)
[51.224252] Starting subtest: stress-xrgb8888-ytiled
[58.707548] Subtest stress-xrgb8888-ytiled: SUCCESS (7.433s)
[58.818286] [004/130] (947s left) gem_readwrite (read-write)
[58.858458] Starting subtest: read-write
[58.861161] Subtest read-write: SUCCESS (0.000s)
[58.940464] [005/130] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[59.041817] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[59.043270] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.123177] [006/130] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[59.225770] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[59.227147] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[59.304303] [007/130] (947s left) gem_exec_fence (basic-await)
[59.486427] Starting subtest: basic-await
[59.487315] Starting dynamic subtest: rcs0
[59.572088] Dynamic subtest rcs0: SUCCESS (0.085s)
[59.583618] Starting dynamic subtest: bcs0
[59.663310] Dynamic subtest bcs0: SUCCESS (0.091s)
[59.675219] Starting dynamic subtest: vcs0
[59.755265] Dynamic subtest vcs0: SUCCESS (0.091s)
[59.767147] Starting dynamic subtest: vcs1
[59.848754] Dynamic subtest vcs1: SUCCESS (0.093s)
[59.860777] Starting dynamic subtest: vecs0
[59.941054] Dynamic subtest vecs0: SUCCESS (0.090s)
[59.942412] Subtest basic-await: SUCCESS (0.452s)
[60.419428] [008/130] (946s left) gem_exec_gttfill (all-engines)
[60.477315] Starting subtest: all-engines
[84.004699] Subtest all-engines: SUCCESS (23.504s)
[84.165486] [009/130] (922s left) syncobj_wait (wait-all-snapshot)
[84.265617] Starting subtest: wait-all-snapshot
[84.348728] Subtest wait-all-snapshot: SUCCESS (0.082s)
[84.394541] [010/130] (922s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[84.494746] Starting subtest: drrs-dirtyfb-ioctl
[84.496128] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[84.565804] [011/130] (922s left) gem_ctx_sseu (invalid-sseu)
[84.611870] Subtest invalid-sseu: SKIP (0.000s)
[84.633355] [012/130] (922s left) kms_pipe_crc_basic (suspend-read-crc)
[84.722517] Starting subtest: suspend-read-crc
[84.723236] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.895220] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.828s)
[101.902099] Starting dynamic subtest: pipe-B-HDMI-A-1
[118.901741] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.771s)
[118.909321] Starting dynamic subtest: pipe-C-HDMI-A-1
[135.857645] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.728s)
[135.864366] Starting dynamic subtest: pipe-D-HDMI-A-1
[152.856516] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.700s)
[152.857240] Subtest suspend-read-crc: SUCCESS (7.032s)
[158.999004] [013/130] (914s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[159.105850] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[159.106726] Starting dynamic subtest: pipe-A
[159.510947] Dynamic subtest pipe-A: SUCCESS (0.406s)
[159.517588] Starting dynamic subtest: pipe-B
[159.962142] Dynamic subtest pipe-B: SUCCESS (0.451s)
[159.972484] Starting dynamic subtest: pipe-C
[160.414187] Dynamic subtest pipe-C: SUCCESS (0.452s)
[160.423301] Starting dynamic subtest: pipe-D
[160.866749] Dynamic subtest pipe-D: SUCCESS (0.452s)
[160.868138] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (1.762s)
[161.024716] [014/130] (912s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[161.118790] Starting subtest: cursorA-vs-flipB-atomic-transitions
[161.120267] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[161.158059] [015/130] (912s left) kms_psr (fbc-pr-no-drrs)
[161.249302] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[161.272334] [016/130] (912s left) gen3_mixed_blits
[161.338917] [017/130] (912s left) kms_hdr (static-toggle-suspend)
[161.428330] Starting subtest: static-toggle-suspend
[161.430516] Subtest static-toggle-suspend: SKIP (0.000s)
[161.466516] [018/130] (912s left) gem_exec_whisper (basic-queues-priority-all)
[161.515974] Starting subtest: basic-queues-priority-all
[164.169638] Subtest basic-queues-priority-all: SUCCESS (2.652s)
[164.344236] [019/130] (909s left) kms_feature_discovery (display)
[164.440297] Starting subtest: display
[164.440985] Subtest display: SUCCESS (0.000s)
[164.501767] [020/130] (909s left) drm_fdinfo (most-busy-check-all)
[164.554904] Starting subtest: most-busy-check-all
[164.555671] Starting dynamic subtest: rcs0
[165.106117] Dynamic subtest rcs0: SUCCESS (0.551s)
[165.116299] Starting dynamic subtest: bcs0
[165.654245] Dynamic subtest bcs0: SUCCESS (0.547s)
[165.664291] Starting dynamic subtest: vcs0
[166.197208] Dynamic subtest vcs0: SUCCESS (0.542s)
[166.207455] Starting dynamic subtest: vcs1
[166.746232] Dynamic subtest vcs1: SUCCESS (0.548s)
[166.756435] Starting dynamic subtest: vecs0
[167.283381] Dynamic subtest vecs0: SUCCESS (0.536s)
[167.284557] Subtest most-busy-check-all: SUCCESS (2.728s)
[167.340186] [021/130] (906s left) perf_pmu (pmu-read)
[167.386382] Starting subtest: pmu-read
[167.388983] Subtest pmu-read: SUCCESS (0.003s)
[167.432939] [022/130] (906s left) prime_vgem (basic-fence-read)
[167.501965] Starting subtest: basic-fence-read
[167.548097] Subtest basic-fence-read: SUCCESS (0.046s)
[167.631306] [023/130] (906s left) kms_flip (wf_vblank-ts-check-interruptible)
[167.731872] Starting subtest: wf_vblank-ts-check-interruptible
[167.734349] Starting dynamic subtest: A-HDMI-A1
[175.569447] Dynamic subtest A-HDMI-A1: SUCCESS (7.834s)
[175.576728] Starting dynamic subtest: B-HDMI-A1
[183.078368] Dynamic subtest B-HDMI-A1: FAIL (7.355s)
[183.085711] Starting dynamic subtest: C-HDMI-A1
[190.003251] Dynamic subtest C-HDMI-A1: FAIL (6.851s)
[190.013536] Starting dynamic subtest: D-HDMI-A1
[200.948459] Dynamic subtest D-HDMI-A1: FAIL (10.842s)
[200.949153] Subtest wf_vblank-ts-check-interruptible: FAIL (32.891s)
[200.971156] [024/130] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[201.068727] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[201.070111] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[201.106092] [025/130] (873s left) gem_ctx_persistence (file)
[201.147083] Starting subtest: file
[201.233987] Subtest file: SUCCESS (0.086s)
[201.297181] [026/130] (872s left) kms_lease (multimaster-lease)
[201.388416] Starting subtest: multimaster-lease
[201.390049] Subtest multimaster-lease: SUCCESS (0.002s)
[201.406762] [027/130] (872s left) gem_exec_reloc (basic-write-cpu-active)
[201.447868] Starting subtest: basic-write-cpu-active
[201.576670] Subtest basic-write-cpu-active: SUCCESS (0.119s)
[201.649027] [028/130] (872s left) gem_exec_balancer (full)
[201.697431] Starting subtest: full
[203.099057] Subtest full: SUCCESS (1.399s)
[203.242646] [029/130] (871s left) gem_ctx_param (invalid-param-get)
[203.283285] Starting subtest: invalid-param-get
[203.284005] Subtest invalid-param-get: SUCCESS (0.000s)
[203.301081] [030/130] (871s left) gem_softpin (overlap)
[203.344222] Starting subtest: overlap
[204.109577] Subtest overlap: SUCCESS (0.755s)
[204.204299] [031/130] (870s left) gem_madvise (dontneed-before-mmap)
[204.239540] Starting subtest: dontneed-before-mmap
[204.244830] Subtest dontneed-before-mmap: SUCCESS (0.005s)
[204.307900] [032/130] (870s left) gem_tiled_swapping (non-threaded)
[216.581375] Starting subtest: non-threaded
[218.301534] Subtest non-threaded: FAIL (1.709s)
[220.600921] [033/130] (853s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[220.746637] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[220.768089] [034/130] (853s left) kms_color (ctm-negative)
[220.859310] Starting subtest: ctm-negative
[220.860019] Starting dynamic subtest: pipe-A-HDMI-A-1
[221.181597] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.321s)
[221.193084] Starting dynamic subtest: pipe-B-HDMI-A-1
[221.469016] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.287s)
[221.477931] Starting dynamic subtest: pipe-C-HDMI-A-1
[221.755781] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.287s)
[221.767008] Starting dynamic subtest: pipe-D-HDMI-A-1
[222.046800] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.290s)
[222.047489] Subtest ctm-negative: SUCCESS (1.188s)
[222.163405] [035/130] (852s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[222.271747] Starting subtest: x-tiled-16bpp-rotate-270
[222.355121] Subtest x-tiled-16bpp-rotate-270: SKIP (0.083s)
[222.433669] [036/130] (852s left) kms_busy (extended-pageflip-hang-newfb)
[222.531662] Starting subtest: extended-pageflip-hang-newfb
[222.533272] Starting dynamic subtest: pipe-A
[236.931110] Dynamic subtest pipe-A: SUCCESS (14.395s)
[236.944573] Starting dynamic subtest: pipe-D
[250.741635] Dynamic subtest pipe-D: SUCCESS (13.802s)
[250.743138] Subtest extended-pageflip-hang-newfb: SUCCESS (28.204s)
[250.830994] [037/130] (823s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[250.878872] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[250.879647] Starting dynamic subtest: smem
[250.962526] Dynamic subtest smem: SUCCESS (0.083s)
[250.963238] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (0.084s)
[251.120131] [038/130] (823s left) prime_mmap_coherency (write)
[251.162398] Starting subtest: write
[256.559619] Subtest write: SUCCESS (5.386s)
[256.630192] [039/130] (817s left) gem_exec_schedule (preempt-queue-contexts-chain)
[256.694676] Starting subtest: preempt-queue-contexts-chain
[256.695411] Starting dynamic subtest: rcs0
[257.000339] Dynamic subtest rcs0: SUCCESS (0.297s)
[257.010390] Starting dynamic subtest: bcs0
[257.307365] Dynamic subtest bcs0: SUCCESS (0.306s)
[257.317579] Starting dynamic subtest: vcs0
[257.597075] Dynamic subtest vcs0: SUCCESS (0.289s)
[257.606987] Starting dynamic subtest: vcs1
[257.888532] Dynamic subtest vcs1: SUCCESS (0.291s)
[257.898245] Starting dynamic subtest: vecs0
[258.181466] Dynamic subtest vecs0: SUCCESS (0.292s)
[258.182379] Subtest preempt-queue-contexts-chain: SUCCESS (1.478s)
[258.455106] [040/130] (816s left) i915_query (engine-info-invalid)
[258.494053] Starting subtest: engine-info-invalid
[258.494774] Subtest engine-info-invalid: SUCCESS (0.000s)
[258.517218] [041/130] (816s left) kms_joiner (basic-force-ultra-joiner)
[258.612734] Starting subtest: basic-force-ultra-joiner
[258.614056] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[258.632169] [042/130] (815s left) gem_pxp (reject-modify-context-protection-on)
[258.740692] Starting subtest: reject-modify-context-protection-on
[258.741799] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[259.844952] [043/130] (814s left) kms_flip (2x-modeset-vs-vblank-race)
[259.936967] Starting subtest: 2x-modeset-vs-vblank-race
[259.952656] Subtest 2x-modeset-vs-vblank-race: SKIP (0.016s)
[259.982356] [044/130] (814s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[260.080263] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[260.081667] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[260.165969] [045/130] (814s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[260.208264] Starting subtest: basic-gtt-cpu-noreloc
[260.211537] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.003s)
[260.291922] [046/130] (814s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[260.331434] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[260.353527] [047/130] (814s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[260.449434] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[261.576878] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.127s)
[261.650333] [048/130] (813s left) gem_softpin (evict-prime)
[261.692340] Starting subtest: evict-prime
[261.693101] Starting dynamic subtest: rcs0
[262.831589] Dynamic subtest rcs0: SUCCESS (1.138s)
[262.861242] Starting dynamic subtest: bcs0
[263.963702] Dynamic subtest bcs0: SUCCESS (1.130s)
[263.988125] Starting dynamic subtest: vcs0
[265.087527] Dynamic subtest vcs0: SUCCESS (1.122s)
[265.118392] Starting dynamic subtest: vcs1
[266.228746] Dynamic subtest vcs1: SUCCESS (1.139s)
[266.258246] Starting dynamic subtest: vecs0
[267.352511] Dynamic subtest vecs0: SUCCESS (1.122s)
[267.380488] Starting dynamic subtest: all
[268.498779] Dynamic subtest all: SUCCESS (1.144s)
[268.500072] Subtest evict-prime: SUCCESS (6.804s)
[268.553508] [049/130] (806s left) syncobj_timeline (wait-for-submit-snapshot)
[268.611673] Starting subtest: wait-for-submit-snapshot
[268.695512] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[268.734791] [050/130] (806s left) kms_psr (pr-sprite-blt)
[268.830782] Subtest pr-sprite-blt: SKIP (0.000s)
[268.853228] [051/130] (805s left) gem_exec_gttfill (multigpu-basic)
[269.018110] Starting subtest: multigpu-basic
[282.443707] Subtest multigpu-basic: SUCCESS (13.425s)
[282.487414] [052/130] (792s left) kms_rotation_crc (exhaust-fences)
[282.633745] Starting subtest: exhaust-fences
[284.014368] Subtest exhaust-fences: SUCCESS (1.381s)
[284.089036] [053/130] (790s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[284.185488] Starting subtest: cursorB-vs-flipB-atomic-transitions
[284.186876] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[284.206155] [054/130] (790s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[284.305330] Starting subtest: cursor-rapid-movement-64x21
[284.309587] Starting dynamic subtest: pipe-A-HDMI-A-1
[284.582012] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.272s)
[284.630028] Starting dynamic subtest: pipe-D-HDMI-A-1
[284.831142] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.209s)
[284.831959] Subtest cursor-rapid-movement-64x21: SUCCESS (0.526s)
[284.939993] [055/130] (789s left) kms_psr (psr2-sprite-blt)
[285.044776] Subtest psr2-sprite-blt: SKIP (0.000s)
[285.069295] [056/130] (789s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[285.213884] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[285.281672] [057/130] (789s left) kms_flip (nonexisting-fb-interruptible)
[285.379201] Starting subtest: nonexisting-fb-interruptible
[285.381847] Starting dynamic subtest: A-HDMI-A1
[285.532901] Dynamic subtest A-HDMI-A1: SUCCESS (0.151s)
[285.541947] Starting dynamic subtest: B-HDMI-A1
[285.663773] Dynamic subtest B-HDMI-A1: SUCCESS (0.130s)
[285.675873] Starting dynamic subtest: C-HDMI-A1
[285.809572] Dynamic subtest C-HDMI-A1: SUCCESS (0.145s)
[285.820991] Starting dynamic subtest: D-HDMI-A1
[285.958699] Dynamic subtest D-HDMI-A1: SUCCESS (0.148s)
[285.960900] Subtest nonexisting-fb-interruptible: SUCCESS (0.582s)
[286.107936] [058/130] (788s left) kms_sequence (get-forked-busy)
[286.203812] Starting subtest: get-forked-busy
[286.204566] Starting dynamic subtest: pipe-A-HDMI-A-1
[287.520165] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.316s)
[287.531809] Starting dynamic subtest: pipe-B-HDMI-A-1
[288.820082] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.297s)
[288.832123] Starting dynamic subtest: pipe-C-HDMI-A-1
[290.122740] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.301s)
[290.131460] Starting dynamic subtest: pipe-D-HDMI-A-1
[291.428789] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.305s)
[291.429583] Subtest get-forked-busy: SUCCESS (5.227s)
[291.508059] [059/130] (783s left) gem_create (create-ext-set-pat)
[291.677058] Starting subtest: create-ext-set-pat
[291.679015] Subtest create-ext-set-pat: SKIP (0.000s)
[291.709237] [060/130] (783s left) kms_atomic (plane-overlay-legacy)
[291.803745] Starting subtest: plane-overlay-legacy
[291.804474] Starting dynamic subtest: pipe-A-HDMI-A-1
[291.974250] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.169s)
[291.974983] Subtest plane-overlay-legacy: SUCCESS (0.171s)
[292.066785] [061/130] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[292.163327] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[292.164749] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[292.196049] [062/130] (782s left) kms_flip (2x-flip-vs-fences-interruptible)
[292.293203] Starting subtest: 2x-flip-vs-fences-interruptible
[292.302794] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.009s)
[292.329421] [063/130] (782s left) gem_lmem_swapping (heavy-verify-random-ccs)
[292.377623] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[292.400499] [064/130] (782s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[292.495563] Starting subtest: fbc-indfb-scaledprimary
[295.280694] Subtest fbc-indfb-scaledprimary: SUCCESS (2.786s)
[295.379472] [065/130] (779s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[295.477275] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[295.478698] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[295.601590] [066/130] (779s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[295.695447] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[295.720620] [067/130] (779s left) kms_cursor_crc (cursor-onscreen-max-size)
[295.819746] Starting subtest: cursor-onscreen-max-size
[295.821878] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[295.884119] [068/130] (779s left) gem_pread (self)
[295.923275] Starting subtest: self
[295.928297] Subtest self: SUCCESS (0.005s)
[295.958224] [069/130] (779s left) kms_cursor_edge_walk (128x128-top-edge)
[296.048749] Starting subtest: 128x128-top-edge
[296.049470] Starting dynamic subtest: pipe-A-HDMI-A-1
[297.809233] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.760s)
[297.819260] Starting dynamic subtest: pipe-D-HDMI-A-1
[299.505831] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.695s)
[299.506618] Subtest 128x128-top-edge: SUCCESS (3.458s)
[299.594583] [070/130] (775s left) kms_vblank (ts-continuation-modeset-hang)
[299.712754] Starting subtest: ts-continuation-modeset-hang
[299.714514] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.704750] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.990s)
[313.719514] Starting dynamic subtest: pipe-D-HDMI-A-1
[328.014782] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.302s)
[328.015604] Subtest ts-continuation-modeset-hang: SUCCESS (28.302s)
[328.120907] [071/130] (747s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[328.270187] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[328.338157] [072/130] (746s left) kms_big_fb (y-tiled-addfb)
[328.453049] Starting subtest: y-tiled-addfb
[328.453819] Subtest y-tiled-addfb: SUCCESS (0.000s)
[328.504292] [073/130] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[328.602755] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[329.775016] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.172s)
[329.856983] [074/130] (745s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[329.958471] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[329.980990] [075/130] (745s left) kms_setmode (basic)
[330.020622] Starting subtest: basic
[330.094570] Starting dynamic subtest: pipe-A-HDMI-A-1
[331.185238] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.083s)
[331.267237] Starting dynamic subtest: pipe-B-HDMI-A-1
[332.339284] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.071s)
[332.388651] Subtest basic: SUCCESS (2.367s)
[332.492867] [076/130] (742s left) perf_pmu (busy-hang)
[332.537497] Starting subtest: busy-hang
[332.538295] Starting dynamic subtest: rcs0
[333.589549] Dynamic subtest rcs0: SUCCESS (1.051s)
[333.604507] Starting dynamic subtest: bcs0
[334.631424] Dynamic subtest bcs0: SUCCESS (1.039s)
[334.643338] Starting dynamic subtest: vcs0
[335.660384] Dynamic subtest vcs0: SUCCESS (1.027s)
[335.674168] Starting dynamic subtest: vcs1
[336.712640] Dynamic subtest vcs1: SUCCESS (1.050s)
[336.724732] Starting dynamic subtest: vecs0
[337.763349] Dynamic subtest vecs0: SUCCESS (1.047s)
[337.764756] Subtest busy-hang: SUCCESS (5.226s)
[337.801455] [077/130] (737s left) gem_tiled_blits (normal)
[337.927580] Starting subtest: normal
[353.645461] Subtest normal: SUCCESS (15.715s)
[353.752433] [078/130] (721s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[353.894643] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[353.896130] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[353.932303] [079/130] (721s left) api_intel_allocator (fork-simple-stress-signal)
[353.974763] Starting subtest: fork-simple-stress-signal
[359.412370] Subtest fork-simple-stress-signal: SUCCESS (5.429s)
[359.428577] [080/130] (715s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[359.496248] Starting subtest: invalid-bsd1-flag-on-blt
[359.497345] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.001s)
[359.575963] [081/130] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[359.674060] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[359.675417] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[359.735190] [082/130] (715s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[359.827589] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[359.829446] Starting dynamic subtest: pipe-A-HDMI-A-1
[359.836149] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[359.844991] Starting dynamic subtest: pipe-B-HDMI-A-1
[359.851869] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[359.860705] Starting dynamic subtest: pipe-C-HDMI-A-1
[359.867458] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[359.875880] Starting dynamic subtest: pipe-D-HDMI-A-1
[359.882763] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[359.884123] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s)
[360.051287] [083/130] (715s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[360.147786] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[360.148523] Starting dynamic subtest: pipe-A-HDMI-A-1
[360.155649] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[360.164552] Starting dynamic subtest: pipe-B-HDMI-A-1
[360.171829] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[360.180408] Starting dynamic subtest: pipe-C-HDMI-A-1
[360.187570] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[360.195997] Starting dynamic subtest: pipe-D-HDMI-A-1
[360.203251] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[360.204655] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.007s)
[360.357341] [084/130] (715s left) gem_mmap_gtt (basic-wc)
[360.396819] Starting subtest: basic-wc
[361.034644] Subtest basic-wc: SUCCESS (0.630s)
[361.075385] [085/130] (714s left) kms_pm_backlight (basic-brightness)
[361.167361] Subtest basic-brightness: SKIP (0.000s)
[361.192092] [086/130] (714s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[361.294857] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[361.614089] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.319s)
[361.719423] [087/130] (713s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[361.817588] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[362.130813] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.313s)
[362.224096] [088/130] (713s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[362.320404] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[363.682441] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (1.361s)
[363.768681] [089/130] (711s left) syncobj_timeline (single-wait-available-signaled)
[363.815976] Starting subtest: single-wait-available-signaled
[363.816693] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[363.845122] [090/130] (711s left) syncobj_timeline (etime-single-wait-submitted)
[363.883981] Starting subtest: etime-single-wait-submitted
[363.988258] Subtest etime-single-wait-submitted: SUCCESS (0.102s)
[364.030101] [091/130] (711s left) gem_wait (write-wait)
[364.084788] Starting subtest: write-wait
[364.085553] Starting dynamic subtest: all-engines
[365.112936] Dynamic subtest all-engines: SUCCESS (1.027s)
[365.125566] Starting dynamic subtest: rcs0
[366.149402] Dynamic subtest rcs0: SUCCESS (1.034s)
[366.161582] Starting dynamic subtest: bcs0
[367.182016] Dynamic subtest bcs0: SUCCESS (1.030s)
[367.199334] Starting dynamic subtest: vcs0
[368.215071] Dynamic subtest vcs0: SUCCESS (1.031s)
[368.227262] Starting dynamic subtest: vcs1
[369.241977] Dynamic subtest vcs1: SUCCESS (1.024s)
[369.254403] Starting dynamic subtest: vecs0
[370.272032] Dynamic subtest vecs0: SUCCESS (1.029s)
[370.272972] Subtest write-wait: SUCCESS (6.187s)
[370.432833] [092/130] (705s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[370.531732] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[371.918840] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.387s)
[372.012486] [093/130] (703s left) sriov_basic (enable-vfs-autoprobe-off)
[372.055273] Starting subtest: enable-vfs-autoprobe-off
[372.056135] Starting dynamic subtest: numvfs-1
[372.085148] Dynamic subtest numvfs-1: FAIL (0.016s)
[372.094272] Starting dynamic subtest: numvfs-2
[372.117437] Dynamic subtest numvfs-2: FAIL (0.006s)
[372.126165] Starting dynamic subtest: numvfs-3
[372.148139] Dynamic subtest numvfs-3: FAIL (0.006s)
[372.156617] Starting dynamic subtest: numvfs-4
[372.180213] Dynamic subtest numvfs-4: FAIL (0.005s)
[372.194076] Starting dynamic subtest: numvfs-5
[372.217885] Dynamic subtest numvfs-5: FAIL (0.005s)
[372.231689] Starting dynamic subtest: numvfs-6
[372.255662] Dynamic subtest numvfs-6: FAIL (0.006s)
[372.269213] Starting dynamic subtest: numvfs-7
[372.293073] Dynamic subtest numvfs-7: FAIL (0.006s)
[372.307276] Starting dynamic subtest: numvfs-random
[372.338227] Dynamic subtest numvfs-random: FAIL (0.006s)
[372.353810] Starting dynamic subtest: numvfs-all
[372.378589] Dynamic subtest numvfs-all: FAIL (0.005s)
[372.379622] Subtest enable-vfs-autoprobe-off: FAIL (0.069s)
[372.398840] [094/130] (703s left) gen9_exec_parse (cmd-crossing-page)
[372.441545] Subtest cmd-crossing-page: SKIP (0.000s)
[372.466574] [095/130] (703s left) kms_vrr (flipline)
[372.559857] Starting subtest: flipline
[372.562030] Subtest flipline: SKIP (0.000s)
[372.584479] [096/130] (703s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[372.680110] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[372.681556] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[372.728073] [097/130] (703s left) kms_async_flips (invalid-async-flip)
[372.822724] Starting subtest: invalid-async-flip
[372.944422] Starting dynamic subtest: pipe-A-HDMI-A-1
[373.072341] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.128s)
[373.188844] Starting dynamic subtest: pipe-B-HDMI-A-1
[373.284584] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.103s)
[373.392114] Starting dynamic subtest: pipe-C-HDMI-A-1
[373.487775] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.106s)
[373.607571] Starting dynamic subtest: pipe-D-HDMI-A-1
[373.698775] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.099s)
[373.699538] Subtest invalid-async-flip: SUCCESS (0.877s)
[373.875359] [098/130] (701s left) prime_mmap (test_reprime)
[373.916034] Starting subtest: test_reprime
[373.916754] Starting dynamic subtest: test_reprime-smem
[373.918696] Dynamic subtest test_reprime-smem: SUCCESS (0.003s)
[373.919444] Subtest test_reprime: SUCCESS (0.004s)
[373.994518] [099/130] (701s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[374.095763] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[374.097121] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[374.216252] [100/130] (701s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[374.307591] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[374.308305] Starting dynamic subtest: pipe-A
[374.431868] Dynamic subtest pipe-A: SUCCESS (0.124s)
[374.443106] Starting dynamic subtest: pipe-B
[374.574782] Dynamic subtest pipe-B: SUCCESS (0.142s)
[374.586186] Starting dynamic subtest: pipe-C
[374.717825] Dynamic subtest pipe-C: SUCCESS (0.142s)
[374.727989] Starting dynamic subtest: pipe-D
[374.879985] Dynamic subtest pipe-D: SUCCESS (0.161s)
[374.880699] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.573s)
[375.044631] [101/130] (700s left) kms_content_protection (uevent)
[375.141288] Starting subtest: uevent
[375.484581] Subtest uevent: SKIP (0.341s)
[375.631556] [102/130] (700s left) device_reset (cold-reset-bound)
[375.682923] Starting subtest: cold-reset-bound
[375.684413] Subtest cold-reset-bound: SKIP (0.000s)
[375.706776] [103/130] (700s left) sw_sync (sync_busy_fork_unixsocket)
[375.746166] Starting subtest: sync_busy_fork_unixsocket
[375.757443] Subtest sync_busy_fork_unixsocket: SUCCESS (0.012s)
[375.777167] [104/130] (700s left) prime_self_import (basic-with_fd_dup)
[375.815861] Starting subtest: basic-with_fd_dup
[375.817292] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[375.866044] [105/130] (700s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[375.960539] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[375.961932] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[376.031967] [106/130] (699s left) i915_pm_rpm (system-suspend-devices)
[377.443778] Starting subtest: system-suspend-devices
[385.120396] Subtest system-suspend-devices: SUCCESS (7.675s)
[392.267322] [107/130] (690s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[392.367558] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[392.376404] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.009s)
[392.411538] [108/130] (690s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[392.508743] Starting subtest: y-tiled-16bpp-rotate-0
[393.596407] Subtest y-tiled-16bpp-rotate-0: SUCCESS (1.087s)
[393.718449] [109/130] (689s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[393.757722] Starting subtest: multi-wait-for-submit-available-signaled
[393.758447] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[393.778467] [110/130] (689s left) gem_mmap_gtt (isolation)
[393.817590] Starting subtest: isolation
[393.819747] Subtest isolation: SUCCESS (0.001s)
[393.894177] [111/130] (689s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[393.991469] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[393.992828] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[394.038223] [112/130] (689s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[394.132619] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[394.134050] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[394.184186] [113/130] (688s left) kms_addfb_basic (basic)
[394.225909] Starting subtest: basic
[394.226631] Subtest basic: SUCCESS (0.000s)
[394.312370] [114/130] (688s left) gem_exec_schedule (u-semaphore-user)
[394.365617] Starting subtest: u-semaphore-user
[394.371765] Subtest u-semaphore-user: SUCCESS (0.006s)
[394.654456] [115/130] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[394.748257] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[394.749747] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[394.827585] [116/130] (688s left) kms_prime (basic-modeset-hybrid)
[397.262391] Subtest basic-modeset-hybrid: SKIP (0.000s)
[397.280035] [117/130] (685s left) kms_fbcon_fbt (fbc)
[397.319989] Starting subtest: fbc
[400.692157] Subtest fbc: SUCCESS (3.363s)
[400.715383] [118/130] (682s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[400.821353] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[400.822687] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[400.884150] [119/130] (682s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[400.922341] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[401.026513] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[401.075380] [120/130] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[401.169827] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[401.171257] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[401.218830] [121/130] (682s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[401.311520] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[401.312199] Starting dynamic subtest: pipe-A-valid-mode
[402.279896] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.967s)
[402.280678] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.968s)
[402.389640] [122/130] (680s left) kms_addfb_basic (bad-pitch-63)
[402.429523] Starting subtest: bad-pitch-63
[402.430211] Subtest bad-pitch-63: SUCCESS (0.000s)
[402.557594] [123/130] (680s left) syncobj_basic (test-valid-cycle)
[402.595275] Starting subtest: test-valid-cycle
[402.596001] Subtest test-valid-cycle: SUCCESS (0.000s)
[402.620992] [124/130] (680s left) gem_exec_alignment (single)
[402.662414] Starting subtest: single
[402.665087] Subtest single: SUCCESS (0.003s)
[402.742553] [125/130] (680s left) gem_mmap_wc (bad-object)
[402.786051] Starting subtest: bad-object
[402.786828] Subtest bad-object: SUCCESS (0.000s)
[402.844665] [126/130] (680s left) kms_pm_rpm (legacy-planes-dpms)
[404.259882] Starting subtest: legacy-planes-dpms
[404.261058] Starting dynamic subtest: plane-41
[412.552222] Dynamic subtest plane-41: SUCCESS (8.291s)
[412.567484] Starting dynamic subtest: plane-50
[420.960590] Dynamic subtest plane-50: SUCCESS (8.398s)
[420.971997] Starting dynamic subtest: plane-59
[429.269094] Dynamic subtest plane-59: SUCCESS (8.312s)
[429.281774] Starting dynamic subtest: plane-68
[437.646691] Dynamic subtest plane-68: SUCCESS (8.376s)
[437.658032] Starting dynamic subtest: plane-77
[446.056067] Dynamic subtest plane-77: SUCCESS (8.398s)
[446.075163] Starting dynamic subtest: plane-86
[454.356406] Dynamic subtest plane-86: SUCCESS (8.305s)
[454.357548] Subtest legacy-planes-dpms: SUCCESS (50.094s)
[454.506021] [127/130] (628s left) gem_mmap_gtt (basic-write-gtt)
[454.547183] Starting subtest: basic-write-gtt
[454.684181] Subtest basic-write-gtt: SUCCESS (0.129s)
[454.711731] [128/130] (628s left) kms_psr (psr-cursor-render)
[454.803826] Subtest psr-cursor-render: SKIP (0.000s)
[454.822617] [129/130] (628s left) gem_ccs (block-copy-uncompressed)
[454.863351] Starting subtest: block-copy-uncompressed
[454.865176] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[454.885126] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[454.897614] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[454.908682] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[454.909495] Subtest block-copy-uncompressed: SUCCESS (0.046s)
[454.991822] [130/130] (628s left) gem_madvise (dontneed-before-pwrite)
[455.029931] Starting subtest: dontneed-before-pwrite
[455.031476] Subtest dontneed-before-pwrite: SUCCESS (0.002s)
[455.089236] Closing watchdogs
Done.