[57.773143] Initializing watchdogs
[57.773287]   /dev/watchdog0
[57.789437] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.793903] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.796358] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.799835] [001/132] (960s left) kms_dp_linktrain_fallback (dsc-fallback)
[57.917880] Starting subtest: dsc-fallback
[57.924272] Subtest dsc-fallback: SKIP (0.000s)
[57.999119] [002/132] (960s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[58.122970] Starting subtest: cursorA-vs-flipA-legacy
[69.320543] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.188s)
[70.122310] [003/132] (948s left) gem_gpgpu_fill (offset-16x16)
[70.183874] Starting subtest: offset-16x16
[70.189781] Subtest offset-16x16: SUCCESS (0.007s)
[70.318195] [004/132] (948s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[70.381121] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[70.442807] [005/132] (948s left) gem_create (create-clear)
[70.493698] Starting subtest: create-clear
[70.496412] Starting dynamic subtest: smem0
[103.239044] Dynamic subtest smem0: SUCCESS (32.739s)
[103.241057] Subtest create-clear: SUCCESS (32.739s)
[103.425432] [006/132] (915s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[103.538291] Starting subtest: psr2-cursor-plane-update-sf
[103.540600] Starting dynamic subtest: pipe-A-eDP-1
[104.109544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[104.119200] Starting dynamic subtest: pipe-B-eDP-1
[105.415659] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.304s)
[105.418060] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.883s)
[106.282421] [007/132] (912s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[106.387434] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[106.391948] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[106.487138] [008/132] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[106.576586] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[113.466612] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.892s)
[113.603578] [009/132] (905s left) gem_exec_gttfill (engines)
[113.658958] Starting subtest: engines
[113.661446] Starting dynamic subtest: rcs0
[136.532750] Dynamic subtest rcs0: SUCCESS (22.872s)
[136.542874] Starting dynamic subtest: bcs0
[159.747785] Dynamic subtest bcs0: SUCCESS (23.213s)
[159.758818] Starting dynamic subtest: vcs0
[183.051396] Dynamic subtest vcs0: SUCCESS (23.304s)
[183.062474] Starting dynamic subtest: vcs1
[206.355303] Dynamic subtest vcs1: SUCCESS (23.302s)
[206.366469] Starting dynamic subtest: vecs0
[229.666995] Dynamic subtest vecs0: SUCCESS (23.309s)
[229.677234] Starting dynamic subtest: ccs0
[252.996823] Dynamic subtest ccs0: SUCCESS (23.330s)
[252.999206] Subtest engines: SUCCESS (139.337s)
[253.183133] [010/132] (765s left) gem_render_copy_redux (normal)
[253.292717] Starting subtest: normal
[253.651597] Subtest normal: SUCCESS (0.359s)
[253.769340] [011/132] (764s left) syncobj_timeline (host-signal-ordered)
[253.827552] Starting subtest: host-signal-ordered
[253.829913] Subtest host-signal-ordered: SUCCESS (0.001s)
[253.944937] [012/132] (764s left) kms_plane_alpha_blend (alpha-7efc)
[254.048197] Starting subtest: alpha-7efc
[254.355240] Starting dynamic subtest: pipe-A-eDP-1
[254.956044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[254.984482] Starting dynamic subtest: pipe-D-eDP-1
[256.323998] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[256.326406] Subtest alpha-7efc: SUCCESS (2.276s)
[257.156798] [013/132] (761s left) prime_vgem (basic-blt)
[257.316348] Starting subtest: basic-blt
[257.345595] Subtest basic-blt: SUCCESS (0.029s)
[257.476177] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true
[257.479391] [014/132] (761s left) kms_chamelium_hpd (common-hpd-after-suspend)
[257.851628] Subtest common-hpd-after-suspend: SKIP (0.000s)
[258.660816] [015/132] (760s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[258.769375] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[258.773471] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[258.844424] [016/132] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[258.936997] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[258.941561] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[259.040523] [017/132] (759s left) kms_atomic_transition (modeset-transition-nonblocking)
[259.138012] Starting subtest: modeset-transition-nonblocking
[259.140023] Starting dynamic subtest: 1x-outputs
[270.268081] Dynamic subtest 1x-outputs: SUCCESS (11.131s)
[270.270698] Subtest modeset-transition-nonblocking: SUCCESS (11.132s)
[271.137656] [018/132] (747s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[271.206877] Starting subtest: mixed-tiled-to-y-tiled-ccs
[271.212700] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[271.414450] [019/132] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[271.505349] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[275.679811] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.177s)
[276.837183] [020/132] (742s left) kms_flip (2x-flip-vs-modeset)
[276.927071] Starting subtest: 2x-flip-vs-modeset
[276.935787] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[277.047241] [021/132] (742s left) gem_exec_flush (basic-batch-kernel-default-uc)
[277.107095] Starting subtest: basic-batch-kernel-default-uc
[284.400891] Subtest basic-batch-kernel-default-uc: SUCCESS (7.296s)
[284.599357] [022/132] (734s left) vgem_basic (second-client)
[284.652500] Starting subtest: second-client
[284.672423] Subtest second-client: SUCCESS (0.022s)
[284.732080] [023/132] (734s left) gem_userptr_blits (process-exit-busy)
[284.793985] Starting subtest: process-exit-busy
[284.811699] Subtest process-exit-busy: SUCCESS (0.020s)
[284.950217] [024/132] (734s left) kms_plane_lowres (tiling-x)
[285.048890] Starting subtest: tiling-x
[285.051335] Starting dynamic subtest: pipe-A-eDP-1
[285.056174] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.342717] Starting dynamic subtest: pipe-B-eDP-1
[285.347287] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.356266] Starting dynamic subtest: pipe-C-eDP-1
[285.360634] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.368839] Starting dynamic subtest: pipe-D-eDP-1
[285.373101] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.377152] Subtest tiling-x: SKIP (0.292s)
[286.164216] [025/132] (733s left) vgem_basic (setversion)
[286.212296] Starting subtest: setversion
[286.216246] Subtest setversion: SUCCESS (0.000s)
[286.267103] [026/132] (733s left) kms_chamelium_frames (hdmi-frame-dump)
[286.651462] Subtest hdmi-frame-dump: SKIP (0.000s)
[287.459147] [027/132] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[287.561414] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[287.565762] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[287.659816] [028/132] (731s left) gem_ctx_param (get-priority-new-ctx)
[287.723479] Starting subtest: get-priority-new-ctx
[287.725765] Subtest get-priority-new-ctx: SUCCESS (0.002s)
[287.833707] [029/132] (731s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[287.929891] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[288.732269] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.804s)
[288.905467] [030/132] (730s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[288.998705] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[289.002625] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[289.103617] [031/132] (730s left) api_intel_allocator (fork-simple-stress-signal)
[289.157748] Starting subtest: fork-simple-stress-signal
[294.565662] Subtest fork-simple-stress-signal: SUCCESS (5.407s)
[294.669159] [032/132] (724s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[294.769417] Starting subtest: plane-lut1d-ctm3x4
[294.916046] Starting dynamic subtest: pipe-A-plane-0
[295.105251] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[295.114380] Starting dynamic subtest: pipe-A-plane-1
[295.271623] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[295.281292] Starting dynamic subtest: pipe-A-plane-2
[295.416377] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[296.563066] Starting dynamic subtest: pipe-B-plane-0
[296.721596] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[296.731585] Starting dynamic subtest: pipe-B-plane-1
[296.865646] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[296.875071] Starting dynamic subtest: pipe-B-plane-2
[297.010113] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[298.189788] Starting dynamic subtest: pipe-C-plane-0
[298.338231] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[298.350247] Starting dynamic subtest: pipe-C-plane-1
[298.482533] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[298.491691] Starting dynamic subtest: pipe-C-plane-2
[298.626795] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[299.824875] Starting dynamic subtest: pipe-D-plane-0
[299.972511] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[299.981920] Starting dynamic subtest: pipe-D-plane-1
[300.128076] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[300.136662] Starting dynamic subtest: pipe-D-plane-2
[300.272721] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[300.559388] Subtest plane-lut1d-ctm3x4: SUCCESS (5.789s)
[301.403462] [033/132] (718s left) gem_exec_reloc (basic-cpu-wc-active)
[301.474943] Subtest basic-cpu-wc-active: SKIP (0.000s)
[301.551131] [034/132] (718s left) gem_exec_fence (keep-in-fence)
[301.718722] Starting subtest: keep-in-fence
[301.721262] Starting dynamic subtest: rcs0
[301.774080] Dynamic subtest rcs0: SUCCESS (0.055s)
[301.787610] Starting dynamic subtest: bcs0
[301.827227] Dynamic subtest bcs0: SUCCESS (0.052s)
[301.837209] Starting dynamic subtest: vcs0
[302.934876] Dynamic subtest vcs0: SUCCESS (1.104s)
[302.946759] Starting dynamic subtest: vcs1
[304.917220] Dynamic subtest vcs1: SUCCESS (1.981s)
[304.928878] Starting dynamic subtest: vecs0
[306.901717] Dynamic subtest vecs0: SUCCESS (1.982s)
[306.913996] Starting dynamic subtest: ccs0
[307.144411] Dynamic subtest ccs0: SUCCESS (0.243s)
[307.146737] Subtest keep-in-fence: SUCCESS (5.427s)
[308.952040] [035/132] (710s left) gem_basic (create-close)
[309.011348] Starting subtest: create-close
[309.015916] Subtest create-close: SUCCESS (0.000s)
[309.114007] [036/132] (710s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[309.227854] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[309.276754] [037/132] (710s left) gem_exec_schedule (noreorder-corked)
[309.458043] Starting subtest: noreorder-corked
[309.460931] Starting dynamic subtest: rcs0
[310.606073] Dynamic subtest rcs0: SUCCESS (1.149s)
[310.617986] Starting dynamic subtest: vcs0
[311.891870] Dynamic subtest vcs0: SUCCESS (1.283s)
[311.903400] Starting dynamic subtest: vcs1
[313.874446] Dynamic subtest vcs1: SUCCESS (1.981s)
[313.887757] Starting dynamic subtest: vecs0
[315.923751] Dynamic subtest vecs0: SUCCESS (2.048s)
[315.939810] Starting dynamic subtest: ccs0
[317.081738] Dynamic subtest ccs0: SUCCESS (1.158s)
[317.084297] Subtest noreorder-corked: SUCCESS (7.625s)
[317.264007] [038/132] (702s left) gem_mmap_wc (bad-offset)
[317.328354] Subtest bad-offset: SKIP (0.000s)
[317.384634] [039/132] (702s left) kms_prime (basic-crc-vgem)
[317.483947] Starting subtest: basic-crc-vgem
[317.486233] Starting dynamic subtest: second-to-first
[318.422258] Dynamic subtest second-to-first: SUCCESS (0.942s)
[318.423966] Subtest basic-crc-vgem: SUCCESS (0.943s)
[318.540301] [040/132] (701s left) vgem_basic (bad-pad)
[318.590863] Starting subtest: bad-pad
[318.592625] Subtest bad-pad: SUCCESS (0.000s)
[318.653024] [041/132] (701s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[318.785526] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[319.796310] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.011s)
[319.933140] [042/132] (700s left) gem_exec_whisper (basic-normal)
[319.992476] Starting subtest: basic-normal
[323.441487] Subtest basic-normal: SUCCESS (3.446s)
[323.629832] [043/132] (696s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[323.761963] Starting subtest: basic-flip-before-cursor-legacy
[324.677786] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.913s)
[325.542579] [044/132] (694s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[325.606052] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[325.608420] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[325.717548] [045/132] (694s left) kms_flip (2x-plain-flip-ts-check)
[325.814086] Starting subtest: 2x-plain-flip-ts-check
[325.824246] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[325.906018] [046/132] (694s left) kms_psr (fbc-psr-cursor-blt)
[326.005679] Starting subtest: fbc-psr-cursor-blt
[326.007816] Starting dynamic subtest: eDP-1
[326.011814] Dynamic subtest eDP-1: SKIP (0.000s)
[326.015773] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[326.091519] [047/132] (694s left) kms_hdr (bpc-switch-suspend)
[326.191661] Starting subtest: bpc-switch-suspend
[327.221729] Starting dynamic subtest: pipe-A-eDP-1
[346.867824] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.948s)
[346.870343] Subtest bpc-switch-suspend: SUCCESS (6.980s)
[357.014042] [048/132] (673s left) i915_drm_fdinfo (memory-info-idle)
[357.082824] Starting subtest: memory-info-idle
[357.085256] Starting dynamic subtest: smem0
[357.123649] Dynamic subtest smem0: SUCCESS (0.040s)
[357.126237] Subtest memory-info-idle: SUCCESS (0.041s)
[357.212526] [049/132] (673s left) gem_exec_flush (basic-uc-rw-default)
[357.265622] Starting subtest: basic-uc-rw-default
[362.777635] Subtest basic-uc-rw-default: SUCCESS (5.482s)
[362.978632] [050/132] (667s left) gem_lmem_swapping (parallel-random-verify-ccs)
[363.032661] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[363.079129] [051/132] (667s left) kms_psr (psr2-basic)
[363.182940] Starting subtest: psr2-basic
[363.185247] Starting dynamic subtest: eDP-1
[364.822553] Dynamic subtest eDP-1: SUCCESS (1.632s)
[364.824715] Subtest psr2-basic: SUCCESS (1.633s)
[365.630732] [052/132] (664s left) kms_atomic_interruptible (universal-setplane-cursor)
[365.733825] Starting subtest: universal-setplane-cursor
[365.736043] Starting dynamic subtest: pipe-A-eDP-1
[373.132396] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.381s)
[373.134721] Subtest universal-setplane-cursor: SUCCESS (7.382s)
[374.006448] [053/132] (656s left) kms_addfb_basic (invalid-get-prop-any)
[374.068469] Starting subtest: invalid-get-prop-any
[374.070782] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[374.189135] [054/132] (656s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[374.282027] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[374.286169] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[374.353583] [055/132] (656s left) syncobj_timeline (single-wait-all-signaled)
[374.422897] Starting subtest: single-wait-all-signaled
[374.425160] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[374.539505] [056/132] (656s left) kms_feature_discovery (dp-mst)
[374.631866] Starting subtest: dp-mst
[374.636376] Subtest dp-mst: SKIP (0.000s)
[374.711397] [057/132] (655s left) kms_pm_dc (dc5-dpms-negative)
[375.825024] Starting subtest: dc5-dpms-negative
[375.829590] Subtest dc5-dpms-negative: SKIP (0.000s)
[375.911834] [058/132] (654s left) gen9_exec_parse (batch-zero-length)
[375.988736] Subtest batch-zero-length: SKIP (0.000s)
[376.070266] [059/132] (654s left) kms_big_fb (linear-addfb)
[376.179146] Starting subtest: linear-addfb
[376.181388] Subtest linear-addfb: SUCCESS (0.000s)
[376.275082] [060/132] (654s left) kms_psr (psr2-primary-render)
[376.371760] Starting subtest: psr2-primary-render
[376.374011] Starting dynamic subtest: eDP-1
[378.099087] Dynamic subtest eDP-1: SUCCESS (1.725s)
[378.101230] Subtest psr2-primary-render: SUCCESS (1.726s)
[378.978873] [061/132] (651s left) kms_flip (flip-vs-rmfb-interruptible)
[379.078846] Starting subtest: flip-vs-rmfb-interruptible
[379.081249] Starting dynamic subtest: A-eDP1
[387.773582] Dynamic subtest A-eDP1: SUCCESS (8.686s)
[387.783195] Starting dynamic subtest: B-eDP1
[396.403792] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[396.416000] Starting dynamic subtest: C-eDP1
[405.038056] Dynamic subtest C-eDP1: SUCCESS (8.627s)
[405.050053] Starting dynamic subtest: D-eDP1
[413.665308] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[413.669783] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.571s)
[414.853732] [062/132] (616s left) kms_scaling_modes (scaling-mode-full)
[414.950015] Starting subtest: scaling-mode-full
[414.952278] Starting dynamic subtest: pipe-A-eDP-1
[415.047357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.099s)
[415.060052] Starting dynamic subtest: pipe-B-eDP-1
[416.187757] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[416.200997] Starting dynamic subtest: pipe-C-eDP-1
[417.320061] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[417.332624] Starting dynamic subtest: pipe-D-eDP-1
[418.436266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.113s)
[418.438585] Subtest scaling-mode-full: SUCCESS (3.487s)
[419.613717] [063/132] (611s left) api_intel_bb (misplaced-blitter)
[419.687468] Starting subtest: misplaced-blitter
[419.703982] Subtest misplaced-blitter: SUCCESS (0.016s)
[419.822542] [064/132] (611s left) kms_content_protection (mei-interface)
[419.977714] Starting subtest: mei-interface
[419.982309] Subtest mei-interface: SKIP (0.001s)
[420.104975] [065/132] (610s left) gem_exec_reloc (basic-wc-read)
[420.165457] Subtest basic-wc-read: SKIP (0.000s)
[420.236432] [066/132] (610s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[420.337037] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[427.218583] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.881s)
[427.338652] [067/132] (603s left) kms_plane_scaling (invalid-parameters)
[427.439695] Starting subtest: invalid-parameters
[427.441926] Starting dynamic subtest: less-than-1-height-src
[427.454717] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[427.464796] Starting dynamic subtest: less-than-1-width-src
[427.467122] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[427.469346] Subtest invalid-parameters: SUCCESS (0.028s)
[427.572830] [068/132] (603s left) i915_suspend (debugfs-reader)
[427.641470] Starting subtest: debugfs-reader
[445.726232] Subtest debugfs-reader: SUCCESS (3.565s)
[453.904172] [069/132] (585s left) kms_flip (flip-vs-fences-interruptible)
[454.010485] Starting subtest: flip-vs-fences-interruptible
[454.014665] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[454.114927] [070/132] (585s left) kms_psr (fbc-psr2-primary-page-flip)
[454.200037] Starting subtest: fbc-psr2-primary-page-flip
[454.202260] Starting dynamic subtest: eDP-1
[454.206336] Dynamic subtest eDP-1: SKIP (0.000s)
[454.210444] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[454.279320] [071/132] (585s left) gem_userptr_blits (coherency-unsync)
[454.353559] Subtest coherency-unsync: SKIP (0.000s)
[454.484282] [072/132] (584s left) syncobj_timeline (multi-wait-all-available-signaled)
[454.541021] Starting subtest: multi-wait-all-available-signaled
[454.543277] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[454.664607] [073/132] (584s left) perf (blocking)
[454.807926] Starting subtest: blocking
[454.810167] Starting dynamic subtest: 0-rcs0
[464.820421] Dynamic subtest 0-rcs0: SUCCESS (9.966s)
[464.831201] Starting dynamic subtest: 1-vcs1
[474.832369] Dynamic subtest 1-vcs1: SUCCESS (9.995s)
[474.834951] Subtest blocking: SUCCESS (19.964s)
[474.884475] [074/132] (564s left) kms_cursor_crc (cursor-sliding-256x85)
[475.149678] Starting subtest: cursor-sliding-256x85
[475.199227] Subtest cursor-sliding-256x85: SKIP (0.044s)
[475.355931] [075/132] (564s left) perf (global-sseu-config-invalid)
[475.456886] Starting subtest: global-sseu-config-invalid
[475.461577] Subtest global-sseu-config-invalid: SKIP (0.000s)
[475.500150] [076/132] (564s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[475.595990] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[475.598269] Starting dynamic subtest: pipe-A-eDP-1
[476.437780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[476.449784] Starting dynamic subtest: pipe-B-eDP-1
[478.116807] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.680s)
[478.127111] Starting dynamic subtest: pipe-C-eDP-1
[479.575562] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.455s)
[479.586633] Starting dynamic subtest: pipe-D-eDP-1
[481.101996] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.526s)
[481.103911] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.496s)
[482.283462] [077/132] (557s left) syncobj_basic (bad-create-flags)
[482.343889] Starting subtest: bad-create-flags
[482.346149] Subtest bad-create-flags: SUCCESS (0.000s)
[482.457205] [078/132] (557s left) kms_invalid_mode (overflow-vrefresh)
[482.559252] Starting subtest: overflow-vrefresh
[482.561543] Starting dynamic subtest: pipe-A-eDP-1
[482.861692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.303s)
[482.871763] Starting dynamic subtest: pipe-B-eDP-1
[482.873935] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[482.883742] Starting dynamic subtest: pipe-C-eDP-1
[482.886023] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[482.895454] Starting dynamic subtest: pipe-D-eDP-1
[482.897732] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[482.899966] Subtest overflow-vrefresh: SUCCESS (0.309s)
[483.720786] [079/132] (556s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[483.819606] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[483.821895] Starting dynamic subtest: pipe-A-eDP-1
[483.843172] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[483.855173] Starting dynamic subtest: pipe-B-eDP-1
[483.874826] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[483.884840] Starting dynamic subtest: pipe-C-eDP-1
[483.904586] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[483.914181] Starting dynamic subtest: pipe-D-eDP-1
[483.933842] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[483.936069] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[486.077763] [080/132] (553s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[486.181348] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[486.183652] Starting dynamic subtest: pipe-A-eDP-1
[486.206475] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[486.218359] Starting dynamic subtest: pipe-B-eDP-1
[486.239569] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[486.249269] Starting dynamic subtest: pipe-C-eDP-1
[486.270577] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[486.280180] Starting dynamic subtest: pipe-D-eDP-1
[486.303609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[486.308055] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[488.435470] [081/132] (551s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[488.543004] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[488.547388] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.664588] [082/132] (551s left) sw_sync (sync_multi_timeline_wait)
[488.701528] Starting subtest: sync_multi_timeline_wait
[488.703827] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[488.763853] [083/132] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[488.866099] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[488.870181] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[488.959002] [084/132] (551s left) i915_query (query-topology-known-pci-ids)
[489.023372] Starting subtest: query-topology-known-pci-ids
[489.027402] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[489.122950] [085/132] (550s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[489.173706] Starting subtest: etime-multi-wait-all-available-unsubmitted
[489.282186] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[489.359363] [086/132] (550s left) gem_exec_balancer (bonded-true-hang)
[489.613127] Starting subtest: bonded-true-hang
[489.618723] Subtest bonded-true-hang: SKIP (0.000s)
[489.714380] [087/132] (550s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[489.811453] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[489.813784] Starting dynamic subtest: pipe-A-default-mode
[492.578108] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[492.580425] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.768s)
[493.456857] [088/132] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[493.556975] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[493.561508] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[493.662137] [089/132] (546s left) kms_cursor_crc (cursor-onscreen-max-size)
[493.966844] Starting subtest: cursor-onscreen-max-size
[493.973556] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[494.094611] [090/132] (546s left) gem_spin_batch (resubmit)
[494.143227] Starting subtest: resubmit
[494.145520] Starting dynamic subtest: rcs0
[494.150168] Dynamic subtest rcs0: SUCCESS (0.006s)
[494.160876] Starting dynamic subtest: bcs0
[494.163135] Dynamic subtest bcs0: SUCCESS (0.002s)
[494.173133] Starting dynamic subtest: vcs0
[494.174972] Dynamic subtest vcs0: SUCCESS (0.002s)
[494.184074] Starting dynamic subtest: vcs1
[494.185925] Dynamic subtest vcs1: SUCCESS (0.002s)
[494.195093] Starting dynamic subtest: vecs0
[494.197132] Dynamic subtest vecs0: SUCCESS (0.003s)
[494.208595] Starting dynamic subtest: ccs0
[494.210453] Dynamic subtest ccs0: SUCCESS (0.002s)
[494.212287] Subtest resubmit: SUCCESS (0.021s)
[494.392599] [091/132] (545s left) kms_cursor_crc (cursor-random-128x128)
[494.599519] Starting subtest: cursor-random-128x128
[494.601325] Starting dynamic subtest: pipe-A-eDP-1
[498.016851] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.414s)
[498.046051] Starting dynamic subtest: pipe-D-eDP-1
[502.045958] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.008s)
[502.048479] Subtest cursor-random-128x128: SUCCESS (7.448s)
[502.912118] [092/132] (537s left) kms_busy (basic-hang)
[503.008595] Starting subtest: basic-hang
[503.010538] Starting dynamic subtest: flip-pipe-A
[503.598586] Dynamic subtest flip-pipe-A: SUCCESS (0.591s)
[503.610008] Starting dynamic subtest: modeset-pipe-A
[507.038410] Dynamic subtest modeset-pipe-A: SUCCESS (3.438s)
[507.052639] Starting dynamic subtest: flip-pipe-D
[508.249853] Dynamic subtest flip-pipe-D: SUCCESS (1.206s)
[508.262012] Starting dynamic subtest: modeset-pipe-D
[511.669284] Dynamic subtest modeset-pipe-D: SUCCESS (3.417s)
[511.671522] Subtest basic-hang: SUCCESS (8.660s)
[512.466442] [093/132] (527s left) gem_render_copy_redux (interruptible)
[512.521400] Starting subtest: interruptible
[512.805382] Subtest interruptible: SUCCESS (0.285s)
[512.918778] [094/132] (527s left) kms_properties (plane-properties-atomic)
[513.008467] Starting subtest: plane-properties-atomic
[513.010799] Starting dynamic subtest: pipe-A-eDP-1
[513.560388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[513.573038] Starting dynamic subtest: pipe-B-eDP-1
[514.833835] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.273s)
[514.844365] Starting dynamic subtest: pipe-C-eDP-1
[516.067416] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.230s)
[516.077516] Starting dynamic subtest: pipe-D-eDP-1
[517.303553] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[517.305786] Subtest plane-properties-atomic: SUCCESS (4.296s)
[518.098528] [095/132] (522s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[518.200912] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[518.203030] Starting dynamic subtest: pipe-A-eDP-1
[518.211921] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[518.222781] Starting dynamic subtest: pipe-B-eDP-1
[518.231790] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[518.241434] Starting dynamic subtest: pipe-C-eDP-1
[518.250409] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[518.260200] Starting dynamic subtest: pipe-D-eDP-1
[518.269133] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[518.273599] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.015s)
[520.476318] [096/132] (520s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[520.577010] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[528.079654] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.503s)
[528.216520] [097/132] (512s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[528.318124] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[528.322562] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[528.420276] [098/132] (512s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[528.522543] Starting subtest: pr-cursor-plane-move-continuous-sf
[528.526714] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[528.591733] [099/132] (512s left) i915_pm_rpm (debugfs-read)
[530.226801] Starting subtest: debugfs-read
[531.381631] Subtest debugfs-read: SUCCESS (1.147s)
[531.753109] [100/132] (508s left) sw_sync (timeline_closed_signaled)
[531.793428] Starting subtest: timeline_closed_signaled
[531.795343] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[531.860160] [101/132] (508s left) gem_userptr_blits (sd-probe)
[531.920356] Starting subtest: sd-probe
[531.922223] Subtest sd-probe: SUCCESS (0.000s)
[532.058665] [102/132] (508s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[532.159743] Starting subtest: 2x-flip-vs-modeset-vs-hang
[532.168512] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[532.249781] [103/132] (508s left) gem_ccs (ctrl-surf-copy-new-ctx)
[532.314777] Starting subtest: ctrl-surf-copy-new-ctx
[532.319002] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[532.423050] [104/132] (508s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[532.520351] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[532.619188] [105/132] (508s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[532.718998] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[539.480588] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.760s)
[539.657806] [106/132] (501s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[539.749904] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[539.754293] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[539.851495] [107/132] (501s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[539.947759] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[539.952106] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[540.057547] [108/132] (500s left) kms_flip (dpms-vs-vblank-race)
[540.160914] Starting subtest: dpms-vs-vblank-race
[540.163175] Starting dynamic subtest: A-eDP1
[544.003050] Dynamic subtest A-eDP1: SUCCESS (3.842s)
[544.019327] Starting dynamic subtest: B-eDP1
[547.516150] Dynamic subtest B-eDP1: SUCCESS (3.508s)
[547.526349] Starting dynamic subtest: C-eDP1
[552.156123] Dynamic subtest C-eDP1: SUCCESS (4.638s)
[552.166984] Starting dynamic subtest: D-eDP1
[556.780000] Dynamic subtest D-eDP1: SUCCESS (4.624s)
[556.782471] Subtest dpms-vs-vblank-race: SUCCESS (16.622s)
[557.668770] [109/132] (483s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[557.783225] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[557.785419] Starting dynamic subtest: pipe-A
[557.802977] Dynamic subtest pipe-A: SKIP (0.017s)
[557.814161] Starting dynamic subtest: pipe-B
[557.834619] Dynamic subtest pipe-B: SKIP (0.031s)
[557.849494] Starting dynamic subtest: pipe-C
[557.866888] Dynamic subtest pipe-C: SKIP (0.031s)
[557.877011] Starting dynamic subtest: pipe-D
[557.899714] Dynamic subtest pipe-D: SKIP (0.032s)
[557.903930] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.114s)
[558.001056] [110/132] (483s left) kms_force_connector_basic (force-connector-state)
[558.075068] Starting subtest: force-connector-state
[558.696917] Subtest force-connector-state: SUCCESS (0.624s)
[559.628774] [111/132] (481s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[559.687494] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[559.689926] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[559.779053] [112/132] (481s left) kms_vblank (ts-continuation-idle)
[559.877177] Starting subtest: ts-continuation-idle
[559.879397] Starting dynamic subtest: pipe-A-eDP-1
[560.285077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[560.300984] Starting dynamic subtest: pipe-D-eDP-1
[561.369983] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.080s)
[561.371941] Subtest ts-continuation-idle: SUCCESS (1.492s)
[562.203502] [113/132] (479s left) kms_legacy_colorkey (basic)
[562.291542] Starting subtest: basic
[562.293400] Starting dynamic subtest: pipe-A
[562.334435] Dynamic subtest pipe-A: SUCCESS (0.045s)
[562.347059] Starting dynamic subtest: pipe-B
[562.349290] Dynamic subtest pipe-B: SUCCESS (0.001s)
[562.358990] Starting dynamic subtest: pipe-C
[562.360945] Dynamic subtest pipe-C: SUCCESS (0.000s)
[562.370322] Starting dynamic subtest: pipe-D
[562.372206] Dynamic subtest pipe-D: SUCCESS (0.000s)
[562.374124] Subtest basic: SUCCESS (0.050s)
[562.413503] [114/132] (478s left) gem_ctx_param (invalid-get-no-zeromap)
[562.468647] Starting subtest: invalid-get-no-zeromap
[562.471033] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[562.572359] [115/132] (478s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[562.681129] Starting subtest: basic-busy-flip-before-cursor-atomic
[562.685508] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[562.827256] [116/132] (478s left) gem_render_copy (yf-tiled-to-vebox-linear)
[562.904444] Starting subtest: yf-tiled-to-vebox-linear
[562.908603] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[563.087224] [117/132] (478s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[563.199655] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[563.203726] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[563.274979] [118/132] (478s left) gem_eio (in-flight-internal-1us)
[563.501465] Starting subtest: in-flight-internal-1us
[565.212889] Subtest in-flight-internal-1us: SUCCESS (1.712s)
[565.355958] [119/132] (476s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[565.422628] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[565.501467] [120/132] (476s left) kms_big_fb (y-tiled-addfb)
[565.607032] Starting subtest: y-tiled-addfb
[565.611435] Subtest y-tiled-addfb: SKIP (0.000s)
[565.703645] [121/132] (475s left) gem_exec_capture (capture)
[565.779267] Starting subtest: capture
[565.782138] Starting dynamic subtest: rcs0-smem
[566.617171] Dynamic subtest rcs0-smem: SUCCESS (0.838s)
[566.629257] Starting dynamic subtest: bcs0-smem
[567.937687] Dynamic subtest bcs0-smem: SUCCESS (1.320s)
[567.948911] Starting dynamic subtest: vcs0-smem
[568.759464] Dynamic subtest vcs0-smem: SUCCESS (0.821s)
[568.771490] Starting dynamic subtest: vcs1-smem
[570.085116] Dynamic subtest vcs1-smem: SUCCESS (1.324s)
[570.096288] Starting dynamic subtest: vecs0-smem
[570.976146] Dynamic subtest vecs0-smem: FAIL (0.834s)
[570.990765] Starting dynamic subtest: ccs0-smem
[572.238553] Dynamic subtest ccs0-smem: SUCCESS (1.319s)
[572.240544] Subtest capture: FAIL (6.460s)
[572.364060] [122/132] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[572.467385] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[572.471554] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[572.559369] [123/132] (469s left) kms_rmfb (close-fd)
[572.655355] Starting subtest: close-fd
[572.657188] Starting dynamic subtest: pipe-A-eDP-1
[572.762893] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[572.781472] Starting dynamic subtest: pipe-B-eDP-1
[573.936436] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.174s)
[573.947405] Starting dynamic subtest: pipe-C-eDP-1
[575.120488] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s)
[575.131453] Starting dynamic subtest: pipe-D-eDP-1
[576.314445] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.193s)
[576.316624] Subtest close-fd: SUCCESS (3.660s)
[577.503353] [124/132] (464s left) kms_chamelium_color (ctm-green-to-red)
[577.603844] Subtest ctm-green-to-red: SKIP (0.000s)
[577.649766] [125/132] (464s left) gem_ctx_persistence (legacy-engines-persistence)
[577.707251] Starting subtest: legacy-engines-persistence
[577.709438] Starting dynamic subtest: render
[578.507239] Dynamic subtest render: SUCCESS (0.801s)
[578.520367] Starting dynamic subtest: bsd1
[579.273036] Dynamic subtest bsd1: SUCCESS (0.763s)
[579.287640] Starting dynamic subtest: bsd2
[580.034245] Dynamic subtest bsd2: SUCCESS (0.758s)
[580.047118] Starting dynamic subtest: blt
[580.788707] Dynamic subtest blt: SUCCESS (0.752s)
[580.801084] Starting dynamic subtest: vebox
[581.559354] Dynamic subtest vebox: SUCCESS (0.768s)
[581.562066] Subtest legacy-engines-persistence: SUCCESS (3.855s)
[581.695997] [126/132] (460s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[581.752103] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[581.754538] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[581.850998] [127/132] (460s left) i915_hangman (engine-error-state-capture)
[581.906224] Starting subtest: engine-error-state-capture
[581.908472] Starting dynamic subtest: rcs0
[585.068778] Dynamic subtest rcs0: SUCCESS (3.161s)
[585.083790] Starting dynamic subtest: bcs0
[591.084982] Dynamic subtest bcs0: SUCCESS (6.013s)
[591.098646] Starting dynamic subtest: vcs0
[597.035840] Dynamic subtest vcs0: SUCCESS (5.948s)
[597.049963] Starting dynamic subtest: vcs1
[602.027999] Dynamic subtest vcs1: SUCCESS (4.988s)
[602.045703] Starting dynamic subtest: vecs0
[607.021538] Dynamic subtest vecs0: SUCCESS (4.990s)
[607.034513] Starting dynamic subtest: ccs0
[612.076595] Dynamic subtest ccs0: SUCCESS (5.051s)
[612.079377] Subtest engine-error-state-capture: SUCCESS (30.167s)
[612.224973] [128/132] (429s left) core_hotunplug (unbind-rebind)
[612.313920] Starting subtest: unbind-rebind
[618.255887] Subtest unbind-rebind: SUCCESS (5.941s)
[618.298142] [129/132] (423s left) gem_mmap_gtt (basic-write-read)
[620.084990] Subtest basic-write-read: SKIP (0.000s)
[620.167729] [130/132] (421s left) perf_pmu (init-sema)
[620.212659] Starting subtest: init-sema
[620.214921] Starting dynamic subtest: rcs0
[620.217156] Dynamic subtest rcs0: SUCCESS (0.002s)
[620.228560] Starting dynamic subtest: bcs0
[620.230630] Dynamic subtest bcs0: SUCCESS (0.000s)
[620.240585] Starting dynamic subtest: vcs0
[620.242677] Dynamic subtest vcs0: SUCCESS (0.001s)
[620.252714] Starting dynamic subtest: vcs1
[620.254908] Dynamic subtest vcs1: SUCCESS (0.001s)
[620.264811] Starting dynamic subtest: vecs0
[620.266714] Dynamic subtest vecs0: SUCCESS (0.001s)
[620.276959] Starting dynamic subtest: ccs0
[620.279137] Dynamic subtest ccs0: SUCCESS (0.000s)
[620.281031] Subtest init-sema: SUCCESS (0.009s)
[620.330665] [131/132] (421s left) gem_mmap_offset (perf)
[620.397366] Starting subtest: perf
[620.399347] Starting dynamic subtest: smem0
[620.748602] Dynamic subtest smem0: SUCCESS (0.348s)
[620.751256] Subtest perf: SUCCESS (0.349s)
[620.859795] [132/132] (421s left) gem_exec_schedule (semaphore-power)
[621.048122] Subtest semaphore-power: SKIP (0.000s)
[621.227113] Closing watchdogs
results: parsing output: 0/ for test: kms_dp_linktrain_fallback
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: gem_gpgpu_fill
results: parsing output: 3/ for test: kms_pipe_b_c_ivb
results: parsing output: 4/ for test: gem_create
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_gttfill
results: parsing output: 9/ for test: gem_render_copy_redux
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_plane_alpha_blend
results: parsing output: 12/ for test: prime_vgem
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_atomic_transition
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_exec_flush
results: parsing output: 21/ for test: vgem_basic
results: parsing output: 22/ for test: gem_userptr_blits
results: parsing output: 23/ for test: kms_plane_lowres
results: parsing output: 24/ for test: vgem_basic
results: parsing output: 25/ for test: kms_chamelium_frames
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_ctx_param
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: api_intel_allocator
results: parsing output: 31/ for test: kms_color_pipeline
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: gem_basic
results: parsing output: 35/ for test: kms_tiled_display
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: gem_mmap_wc
results: parsing output: 38/ for test: kms_prime
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_exec_whisper
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_hdr
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: gem_exec_flush
results: parsing output: 49/ for test: gem_lmem_swapping
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_atomic_interruptible
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_feature_discovery
results: parsing output: 56/ for test: kms_pm_dc
results: parsing output: 57/ for test: gen9_exec_parse
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_scaling_modes
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: i915_suspend
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: syncobj_basic
results: parsing output: 77/ for test: kms_invalid_mode
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: sw_sync
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: i915_query
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_busy
results: parsing output: 92/ for test: gem_render_copy_redux
results: parsing output: 93/ for test: kms_properties
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: i915_pm_rpm
results: parsing output: 99/ for test: sw_sync
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: gem_ccs
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: kms_force_connector_basic
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: kms_legacy_colorkey
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_capture
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_rmfb
results: parsing output: 123/ for test: kms_chamelium_color
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: i915_hangman
results: parsing output: 127/ for test: core_hotunplug
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: gem_mmap_offset
results: parsing output: 131/ for test: gem_exec_schedule
Done.