[102.536290] Initializing watchdogs
[102.536334]   /dev/watchdog0
[102.551092] [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]
[102.555553] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[102.558174] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[102.561849] [001/133] (960s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[102.679552] Starting subtest: flip-vs-dpms-on-nop-interruptible
[102.681916] Starting dynamic subtest: A-eDP1
[104.603036] Dynamic subtest A-eDP1: SUCCESS (1.921s)
[104.612755] Starting dynamic subtest: B-eDP1
[106.440076] Dynamic subtest B-eDP1: SUCCESS (1.835s)
[106.449302] Starting dynamic subtest: C-eDP1
[108.260420] Dynamic subtest C-eDP1: SUCCESS (1.819s)
[108.268277] Starting dynamic subtest: D-eDP1
[110.097294] Dynamic subtest D-eDP1: SUCCESS (1.837s)
[110.099759] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.420s)
[111.284221] [002/133] (951s left) kms_joiner (invalid-modeset-big-joiner)
[111.378467] Starting subtest: invalid-modeset-big-joiner
[111.382665] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[111.441650] [003/133] (951s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[111.829757] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[112.685886] [004/133] (950s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[112.797327] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[112.801664] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[112.862900] [005/133] (950s left) gem_exec_params (batch-first)
[112.937300] Starting subtest: batch-first
[112.939802] Subtest batch-first: SUCCESS (0.006s)
[113.050610] [006/133] (950s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[113.147405] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[113.149709] Starting dynamic subtest: pipe-A-eDP-1
[113.172652] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[113.182080] Starting dynamic subtest: pipe-B-eDP-1
[113.203235] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[113.210699] Starting dynamic subtest: pipe-C-eDP-1
[113.232498] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[113.239919] Starting dynamic subtest: pipe-D-eDP-1
[113.262027] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[113.266127] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[115.478194] [007/133] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[115.595140] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[115.599752] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[115.688833] [008/133] (947s left) i915_drm_fdinfo (virtual-idle)
[115.731158] Starting subtest: virtual-idle
[118.788618] Subtest virtual-idle: SUCCESS (3.055s)
[118.858714] [009/133] (944s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[118.956857] Starting subtest: plane-scaler-unity-scaling-with-rotation
[118.959118] Starting dynamic subtest: pipe-A
[119.184958] Dynamic subtest pipe-A: SUCCESS (0.230s)
[119.192640] Starting dynamic subtest: pipe-B
[120.468884] Dynamic subtest pipe-B: SUCCESS (1.283s)
[120.480557] Starting dynamic subtest: pipe-C
[121.793541] Dynamic subtest pipe-C: SUCCESS (1.324s)
[121.802297] Starting dynamic subtest: pipe-D
[123.137298] Dynamic subtest pipe-D: SUCCESS (1.343s)
[123.139676] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.182s)
[124.316074] [010/133] (939s left) perf_pmu (busy-check-all)
[124.356975] Starting subtest: busy-check-all
[124.362866] Starting dynamic subtest: rcs0
[124.911594] Dynamic subtest rcs0: SUCCESS (0.555s)
[124.927905] Starting dynamic subtest: bcs0
[125.461834] Dynamic subtest bcs0: SUCCESS (0.548s)
[125.472067] Starting dynamic subtest: vcs0
[126.871411] Dynamic subtest vcs0: SUCCESS (1.409s)
[126.882196] Starting dynamic subtest: vcs1
[128.919158] Dynamic subtest vcs1: SUCCESS (2.045s)
[128.929718] Starting dynamic subtest: vecs0
[130.903396] Dynamic subtest vecs0: SUCCESS (1.983s)
[130.913348] Starting dynamic subtest: ccs0
[131.456400] Dynamic subtest ccs0: SUCCESS (0.553s)
[131.458877] Subtest busy-check-all: SUCCESS (7.100s)
[131.573935] [011/133] (931s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[131.681202] Starting subtest: x-tiled-64bpp-rotate-180
[133.237050] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.557s)
[133.413987] [012/133] (930s left) gem_exec_params (no-blt)
[133.470155] Starting subtest: no-blt
[133.472581] Subtest no-blt: SUCCESS (0.002s)
[133.589772] [013/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[133.685166] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[133.688827] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[133.790537] [014/133] (929s left) kms_cursor_edge_walk (64x64-right-edge)
[133.886932] Starting subtest: 64x64-right-edge
[133.889050] Starting dynamic subtest: pipe-A-eDP-1
[137.360541] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[137.371996] Starting dynamic subtest: pipe-D-eDP-1
[140.487586] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[140.489866] Subtest 64x64-right-edge: SUCCESS (6.599s)
[141.301229] [015/133] (922s left) gem_mmap_gtt (hang)
[141.359664] Subtest hang: SKIP (0.000s)
[141.420121] [016/133] (922s left) kms_psr (fbc-psr-sprite-blt)
[141.518922] Starting subtest: fbc-psr-sprite-blt
[141.520878] Starting dynamic subtest: eDP-1
[141.525074] Dynamic subtest eDP-1: SKIP (0.000s)
[141.529119] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[141.598176] [017/133] (922s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[141.689480] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[141.691823] Starting dynamic subtest: pipe-A-default-mode
[142.867034] Dynamic subtest pipe-A-default-mode: SKIP (1.173s)
[142.871288] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.175s)
[142.997683] [018/133] (920s left) gem_pwrite (basic-exhaustion)
[143.047168] Subtest basic-exhaustion: SKIP (0.000s)
[143.118097] [019/133] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[143.214695] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[147.821377] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.615s)
[148.952881] [020/133] (914s left) kms_big_fb (linear-8bpp-rotate-270)
[149.057484] Starting subtest: linear-8bpp-rotate-270
[149.077512] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[149.177946] [021/133] (914s left) vgem_basic (second-client)
[149.266176] Starting subtest: second-client
[149.288214] Subtest second-client: SUCCESS (0.022s)
[149.355790] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[149.358969] [022/133] (914s left) gem_mmap (short-mmap)
[149.408205] Subtest short-mmap: SKIP (0.000s)
[149.467491] [023/133] (914s left) kms_hdr (bpc-switch-suspend)
[149.564044] Starting subtest: bpc-switch-suspend
[150.615808] Starting dynamic subtest: pipe-A-eDP-1
[170.382209] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.724s)
[170.384805] Subtest bpc-switch-suspend: SUCCESS (5.774s)
[170.498148] [024/133] (893s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[170.604203] Starting subtest: stress-xrgb8888-xtiled
[176.637670] Subtest stress-xrgb8888-xtiled: SUCCESS (5.944s)
[176.695177] [025/133] (887s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[176.756029] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[176.758272] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[176.876433] [026/133] (887s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[176.967461] Starting subtest: plane-ctm3x4-lut1d
[177.148035] Starting dynamic subtest: pipe-A-plane-0
[177.350441] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[177.361040] Starting dynamic subtest: pipe-A-plane-1
[177.518614] Dynamic subtest pipe-A-plane-1: SUCCESS (0.165s)
[177.527164] Starting dynamic subtest: pipe-A-plane-2
[177.686620] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[178.869927] Starting dynamic subtest: pipe-B-plane-0
[179.041804] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[179.050894] Starting dynamic subtest: pipe-B-plane-1
[179.209787] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[179.218830] Starting dynamic subtest: pipe-B-plane-2
[179.377600] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[180.609976] Starting dynamic subtest: pipe-C-plane-0
[180.758543] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[180.768283] Starting dynamic subtest: pipe-C-plane-1
[180.925990] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[180.935106] Starting dynamic subtest: pipe-C-plane-2
[181.082187] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[182.274217] Starting dynamic subtest: pipe-D-plane-0
[182.400646] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[182.411276] Starting dynamic subtest: pipe-D-plane-1
[182.546083] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[182.554803] Starting dynamic subtest: pipe-D-plane-2
[182.702127] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[183.002929] Subtest plane-ctm3x4-lut1d: SUCCESS (5.994s)
[183.833322] [027/133] (880s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[183.931341] Starting subtest: addfb25-yf-tiled-legacy
[183.933200] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[184.026099] [028/133] (880s left) kms_chamelium_edid (dp-mode-timings)
[184.417702] Subtest dp-mode-timings: SKIP (0.000s)
[185.237416] [029/133] (878s left) gem_lmem_swapping (parallel-random-verify-ccs)
[185.279868] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[185.322181] [030/133] (878s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[185.418117] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[185.420486] Starting dynamic subtest: pipe-A-eDP-1
[185.429574] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[185.438307] Starting dynamic subtest: pipe-B-eDP-1
[185.447308] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[185.456344] Starting dynamic subtest: pipe-C-eDP-1
[185.465003] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[185.473190] Starting dynamic subtest: pipe-D-eDP-1
[185.481951] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[185.486352] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[187.630348] [031/133] (876s left) gem_exec_balancer (busy)
[187.685650] Starting subtest: busy
[188.934295] Subtest busy: SUCCESS (1.244s)
[189.239233] [032/133] (875s left) kms_cursor_crc (cursor-onscreen-64x21)
[189.429803] Starting subtest: cursor-onscreen-64x21
[189.478281] Subtest cursor-onscreen-64x21: SKIP (0.044s)
[189.720922] [033/133] (874s left) kms_plane_multiple (2x-tiling-yf)
[189.836087] Starting subtest: 2x-tiling-yf
[189.840127] Subtest 2x-tiling-yf: SKIP (0.000s)
[189.919887] [034/133] (874s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[189.971793] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[190.078115] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[190.153120] [035/133] (874s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[190.254404] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[194.258741] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.000s)
[195.469364] [036/133] (868s left) gem_mmap_wc (coherency)
[195.523800] Subtest coherency: SKIP (0.000s)
[195.588591] [037/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[195.682689] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[195.686776] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[195.770027] [038/133] (868s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[195.870669] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[195.874671] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[195.966478] [039/133] (868s left) gem_eio (wait-wedge-10ms)
[196.207124] Starting subtest: wait-wedge-10ms
[198.033324] Subtest wait-wedge-10ms: SUCCESS (1.824s)
[198.194415] [040/133] (866s left) perf_pmu (semaphore-busy)
[198.249185] Starting subtest: semaphore-busy
[198.252706] Starting dynamic subtest: rcs0
[199.887464] Dynamic subtest rcs0: SUCCESS (1.634s)
[199.898238] Starting dynamic subtest: bcs0
[201.520828] Dynamic subtest bcs0: SUCCESS (1.631s)
[201.532222] Starting dynamic subtest: vcs0
[205.444983] Dynamic subtest vcs0: SUCCESS (3.921s)
[205.456389] Starting dynamic subtest: vcs1
[211.460211] Dynamic subtest vcs1: SUCCESS (6.011s)
[211.472033] Starting dynamic subtest: vecs0
[217.475960] Dynamic subtest vecs0: SUCCESS (6.009s)
[217.487896] Starting dynamic subtest: ccs0
[220.551840] Dynamic subtest ccs0: SUCCESS (3.072s)
[220.554090] Subtest semaphore-busy: SUCCESS (22.297s)
[220.680322] [041/133] (843s left) gem_exec_whisper (basic-contexts-all)
[220.755380] Starting subtest: basic-contexts-all
[232.567719] Subtest basic-contexts-all: SUCCESS (11.804s)
[232.748167] [042/133] (831s left) gem_pxp (reject-modify-context-protection-on)
[232.868391] Starting subtest: reject-modify-context-protection-on
[232.870841] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[232.987635] [043/133] (831s left) gem_exec_params (sol-reset-not-gen7)
[233.056397] Starting subtest: sol-reset-not-gen7
[233.058660] Subtest sol-reset-not-gen7: SUCCESS (0.004s)
[233.168334] [044/133] (831s left) kms_pm_rpm (pm-caching)
[235.104871] Starting subtest: pm-caching
[235.110390] Subtest pm-caching: SKIP (0.000s)
[235.484805] [045/133] (829s left) api_intel_bb (bb-with-allocator)
[235.542972] Starting subtest: bb-with-allocator
[235.545189] Subtest bb-with-allocator: SUCCESS (0.005s)
[235.673015] [046/133] (829s left) gem_exec_reloc (basic-concurrent16)
[235.727982] Subtest basic-concurrent16: SKIP (0.000s)
[235.804698] [047/133] (829s left) gem_exec_whisper (basic-queues-priority)
[235.879141] Starting subtest: basic-queues-priority
[258.940865] Subtest basic-queues-priority: SUCCESS (23.047s)
[259.131614] [048/133] (805s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[259.257610] Starting subtest: flip-vs-cursor-busy-crc-legacy
[260.059654] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.802s)
[260.906172] [049/133] (804s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[261.021493] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[262.167337] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.147s)
[262.292458] [050/133] (802s left) kms_big_fb (yf-tiled-addfb)
[262.395756] Starting subtest: yf-tiled-addfb
[262.399261] Subtest yf-tiled-addfb: SKIP (0.000s)
[262.505333] [051/133] (802s left) vgem_basic (bad-handle)
[262.555598] Starting subtest: bad-handle
[262.557621] Subtest bad-handle: SUCCESS (0.000s)
[262.615329] [052/133] (802s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[262.712598] Starting subtest: fbc-pr-cursor-mmap-gtt
[262.716373] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[262.784320] [053/133] (802s left) drm_read (short-buffer-wakeup)
[262.937697] Starting subtest: short-buffer-wakeup
[295.149612] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[295.286483] [054/133] (769s left) kms_pm_rpm (basic-pci-d3-state)
[297.117746] Starting subtest: basic-pci-d3-state
[298.584096] Subtest basic-pci-d3-state: SUCCESS (1.470s)
[298.685433] [055/133] (766s left) kms_plane (pixel-format-4-tiled-modifier)
[298.780146] Starting subtest: pixel-format-4-tiled-modifier
[298.810795] Starting dynamic subtest: pipe-A-plane-0
[299.510119] Dynamic subtest pipe-A-plane-0: SUCCESS (0.699s)
[299.519465] Starting dynamic subtest: pipe-A-plane-3
[299.977001] Dynamic subtest pipe-A-plane-3: SUCCESS (0.466s)
[299.989155] Starting dynamic subtest: pipe-A-plane-5
[299.993595] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[301.143829] Starting dynamic subtest: pipe-B-plane-0
[301.857107] Dynamic subtest pipe-B-plane-0: SUCCESS (0.722s)
[301.869766] Starting dynamic subtest: pipe-B-plane-3
[302.312701] Dynamic subtest pipe-B-plane-3: SUCCESS (0.453s)
[302.324566] Starting dynamic subtest: pipe-B-plane-5
[302.328424] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[302.627182] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.847s)
[303.442312] [056/133] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[303.546934] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[303.551205] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[303.646441] [057/133] (761s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[303.741209] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[303.743502] Starting dynamic subtest: pipe-A-eDP-1
[303.766488] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[303.777565] Starting dynamic subtest: pipe-B-eDP-1
[303.799291] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[303.808097] Starting dynamic subtest: pipe-C-eDP-1
[303.829826] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[303.841885] Starting dynamic subtest: pipe-D-eDP-1
[303.864416] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[303.868878] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[305.999094] [058/133] (759s left) gem_ctx_isolation (preservation)
[306.062297] Starting subtest: preservation
[306.064592] Starting dynamic subtest: rcs0
[306.195734] Dynamic subtest rcs0: SUCCESS (0.132s)
[306.206728] Starting dynamic subtest: bcs0
[306.347011] Dynamic subtest bcs0: SUCCESS (0.151s)
[306.357974] Starting dynamic subtest: vcs0
[306.491771] Dynamic subtest vcs0: SUCCESS (0.144s)
[306.501338] Starting dynamic subtest: vcs1
[308.035462] Dynamic subtest vcs1: SUCCESS (1.542s)
[308.045768] Starting dynamic subtest: vecs0
[310.084827] Dynamic subtest vecs0: SUCCESS (2.048s)
[310.096497] Starting dynamic subtest: ccs0
[312.074094] Dynamic subtest ccs0: SUCCESS (1.988s)
[312.076729] Subtest preservation: SUCCESS (6.011s)
[312.314666] [059/133] (753s left) kms_selftest (drm_plane_helper)
[312.351304] Starting subtest: drm_plane_helper
[312.398578] Starting dynamic subtest: drm_test_check_plane_state
[312.510717] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.111s)
[312.521487] Starting dynamic subtest: drm_test_check_invalid_plane_state
[312.618206] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.108s)
[312.620595] Subtest drm_plane_helper: SUCCESS (0.266s)
[312.763223] [060/133] (752s left) gem_exec_reloc (basic-write-cpu-noreloc)
[312.826648] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[312.915213] [061/133] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[313.013746] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[313.018201] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[313.114515] [062/133] (752s left) gen7_exec_parse (basic-rejected)
[313.176383] Subtest basic-rejected: SKIP (0.000s)
[313.248667] [063/133] (752s left) gem_spin_batch (resubmit-new-all)
[313.312692] Starting subtest: resubmit-new-all
[313.315128] Starting dynamic subtest: rcs0
[313.326927] Dynamic subtest rcs0: SUCCESS (0.014s)
[313.338349] Starting dynamic subtest: bcs0
[313.340670] Dynamic subtest bcs0: SUCCESS (0.010s)
[313.350227] Starting dynamic subtest: vcs0
[313.352553] Dynamic subtest vcs0: SUCCESS (0.009s)
[313.361918] Starting dynamic subtest: vcs1
[313.363864] Dynamic subtest vcs1: SUCCESS (0.008s)
[313.373253] Starting dynamic subtest: vecs0
[313.375495] Dynamic subtest vecs0: SUCCESS (0.010s)
[313.384936] Starting dynamic subtest: ccs0
[313.386860] Dynamic subtest ccs0: SUCCESS (0.011s)
[313.388807] Subtest resubmit-new-all: SUCCESS (0.068s)
[315.034163] [064/133] (750s left) kms_lease (lease-revoke)
[315.126117] Starting subtest: lease-revoke
[315.128373] Starting dynamic subtest: pipe-A-eDP-1
[315.153945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[315.164588] Starting dynamic subtest: pipe-B-eDP-1
[315.181089] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.025s)
[315.193655] Starting dynamic subtest: pipe-C-eDP-1
[315.218352] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.031s)
[315.228167] Starting dynamic subtest: pipe-D-eDP-1
[315.244505] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[315.246730] Subtest lease-revoke: SUCCESS (0.122s)
[315.372203] [065/133] (750s left) kms_flip (2x-flip-vs-modeset)
[315.478237] Starting subtest: 2x-flip-vs-modeset
[315.488300] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[315.601139] [066/133] (750s left) tools_test (sysfs_l3_parity)
[315.662087] Starting subtest: sysfs_l3_parity
[315.734500] Subtest sysfs_l3_parity: SKIP (0.086s)
[315.790914] [067/133] (750s left) gem_eio (in-flight-internal-10ms)
[316.026248] Starting subtest: in-flight-internal-10ms
[317.011998] Subtest in-flight-internal-10ms: SUCCESS (0.985s)
[317.178204] [068/133] (748s left) kms_cursor_crc (cursor-random-512x170)
[317.490752] Starting subtest: cursor-random-512x170
[317.494955] Subtest cursor-random-512x170: SKIP (0.001s)
[317.643950] [069/133] (748s left) gem_wait (write-wait)
[317.715695] Starting subtest: write-wait
[317.718113] Starting dynamic subtest: all-engines
[318.826777] Dynamic subtest all-engines: SUCCESS (1.110s)
[318.843407] Starting dynamic subtest: rcs0
[319.883927] Dynamic subtest rcs0: SUCCESS (1.055s)
[319.901669] Starting dynamic subtest: bcs0
[320.941510] Dynamic subtest bcs0: SUCCESS (1.055s)
[320.958096] Starting dynamic subtest: vcs0
[321.994525] Dynamic subtest vcs0: SUCCESS (1.050s)
[322.011262] Starting dynamic subtest: vcs1
[323.046728] Dynamic subtest vcs1: SUCCESS (1.050s)
[323.064241] Starting dynamic subtest: vecs0
[324.099387] Dynamic subtest vecs0: SUCCESS (1.050s)
[324.116392] Starting dynamic subtest: ccs0
[325.155637] Dynamic subtest ccs0: SUCCESS (1.054s)
[325.158285] Subtest write-wait: SUCCESS (7.439s)
[325.356689] [070/133] (740s left) kms_flip (dpms-off-confusion)
[325.452354] Starting subtest: dpms-off-confusion
[325.454539] Starting dynamic subtest: A-eDP1
[334.109565] Dynamic subtest A-eDP1: SUCCESS (8.656s)
[334.120721] Starting dynamic subtest: B-eDP1
[342.748463] Dynamic subtest B-eDP1: SUCCESS (8.635s)
[342.758498] Starting dynamic subtest: C-eDP1
[351.380707] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[351.391592] Starting dynamic subtest: D-eDP1
[360.011144] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[360.016855] Subtest dpms-off-confusion: SUCCESS (34.556s)
[361.181349] [071/133] (704s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[361.278123] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[361.280256] Starting dynamic subtest: pipe-A-eDP-1
[361.300442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[361.312478] Starting dynamic subtest: pipe-B-eDP-1
[361.331714] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[361.341133] Starting dynamic subtest: pipe-C-eDP-1
[361.359981] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[361.369126] Starting dynamic subtest: pipe-D-eDP-1
[361.387713] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[361.389784] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[363.535981] [072/133] (702s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[363.635794] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[363.639833] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[363.738134] [073/133] (702s left) gem_ctx_persistence (heartbeat-many)
[363.795986] Starting subtest: heartbeat-many
[363.800468] Subtest heartbeat-many: SKIP (0.000s)
[363.896224] [074/133] (702s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[366.127726] Starting subtest: gem-execbuf-stress-pc8
[366.167450] Subtest gem-execbuf-stress-pc8: SKIP (0.042s)
[366.499421] [075/133] (699s left) gem_exec_fence (basic-wait)
[366.679389] Starting subtest: basic-wait
[366.681735] Starting dynamic subtest: rcs0
[366.764107] Dynamic subtest rcs0: SUCCESS (0.086s)
[366.775650] Starting dynamic subtest: bcs0
[366.823722] Dynamic subtest bcs0: SUCCESS (0.058s)
[366.835258] Starting dynamic subtest: vcs0
[366.880227] Dynamic subtest vcs0: SUCCESS (0.054s)
[366.891549] Starting dynamic subtest: vcs1
[366.945708] Dynamic subtest vcs1: SUCCESS (0.063s)
[366.956881] Starting dynamic subtest: vecs0
[367.016256] Dynamic subtest vecs0: SUCCESS (0.069s)
[367.027344] Starting dynamic subtest: ccs0
[367.079105] Dynamic subtest ccs0: SUCCESS (0.061s)
[367.081561] Subtest basic-wait: SUCCESS (0.404s)
[368.980264] [076/133] (697s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[369.111577] Starting subtest: 2x-cursor-vs-flip-atomic
[369.116239] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[369.259460] [077/133] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[369.362787] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[369.366760] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[369.457562] [078/133] (696s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[369.522426] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[369.580113] [079/133] (696s left) gen9_exec_parse (unaligned-access)
[369.639486] Subtest unaligned-access: SKIP (0.000s)
[369.728259] [080/133] (696s left) kms_properties (invalid-properties-atomic)
[369.826281] Starting subtest: invalid-properties-atomic
[370.135263] Subtest invalid-properties-atomic: SUCCESS (0.309s)
[370.207234] [081/133] (696s left) gem_ctx_shared (q-in-order)
[370.270911] Starting subtest: Q-in-order
[370.273343] Starting dynamic subtest: rcs0
[370.387868] Dynamic subtest rcs0: SUCCESS (0.114s)
[370.405934] Starting dynamic subtest: vcs0
[370.472286] Dynamic subtest vcs0: SUCCESS (0.084s)
[370.489450] Starting dynamic subtest: vcs1
[370.548312] Dynamic subtest vcs1: SUCCESS (0.074s)
[370.565539] Starting dynamic subtest: vecs0
[370.627967] Dynamic subtest vecs0: SUCCESS (0.079s)
[370.646088] Starting dynamic subtest: ccs0
[370.727276] Dynamic subtest ccs0: SUCCESS (0.098s)
[370.730000] Subtest Q-in-order: SUCCESS (0.457s)
[372.003422] [082/133] (694s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[372.108873] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[372.112771] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[372.203641] [083/133] (694s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[372.300558] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[372.302836] Starting dynamic subtest: pipe-A-eDP-1
[373.278828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.972s)
[373.290711] Starting dynamic subtest: pipe-B-eDP-1
[375.291121] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.010s)
[375.300730] Starting dynamic subtest: pipe-C-eDP-1
[377.328720] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.036s)
[377.339534] Starting dynamic subtest: pipe-D-eDP-1
[379.358872] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.028s)
[379.360902] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (7.050s)
[380.550704] [084/133] (686s left) kms_feature_discovery (chamelium)
[380.642380] Starting subtest: chamelium
[380.646709] Subtest chamelium: SKIP (0.000s)
[380.719603] [085/133] (685s left) gem_ctx_engines (none)
[380.780216] Starting subtest: none
[380.782542] Subtest none: SUCCESS (0.001s)
[380.978525] [086/133] (685s left) kms_flip (dpms-vs-vblank-race-interruptible)
[381.068301] Starting subtest: dpms-vs-vblank-race-interruptible
[381.070498] Starting dynamic subtest: A-eDP1
[384.985456] Dynamic subtest A-eDP1: SUCCESS (3.913s)
[384.995730] Starting dynamic subtest: B-eDP1
[389.596884] Dynamic subtest B-eDP1: SUCCESS (4.609s)
[389.607126] Starting dynamic subtest: C-eDP1
[394.215977] Dynamic subtest C-eDP1: SUCCESS (4.614s)
[394.228977] Starting dynamic subtest: D-eDP1
[398.832264] Dynamic subtest D-eDP1: SUCCESS (4.616s)
[398.834609] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.765s)
[399.718513] [087/133] (666s left) api_intel_bb (simple-bb-ctx)
[399.776684] Starting subtest: simple-bb-ctx
[399.783563] Subtest simple-bb-ctx: SUCCESS (0.008s)
[399.897936] [088/133] (666s left) gem_fenced_exec_thrash (too-many-fences)
[399.957331] Subtest too-many-fences: SKIP (0.000s)
[400.027741] [089/133] (666s left) gem_exec_schedule (semaphore-resolve)
[400.097869] Starting subtest: semaphore-resolve
[400.140228] Subtest semaphore-resolve: SUCCESS (0.049s)
[400.506483] [090/133] (666s left) kms_psr (pr-no-drrs)
[400.604244] Starting subtest: pr-no-drrs
[400.608674] Subtest pr-no-drrs: SKIP (0.000s)
[400.679487] [091/133] (666s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[400.785571] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[400.789955] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[400.892472] [092/133] (666s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[400.992261] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[400.994590] Starting dynamic subtest: pipe-A-eDP-1
[401.088306] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[401.102375] Starting dynamic subtest: pipe-B-eDP-1
[402.199990] Dynamic subtest pipe-B-eDP-1: SKIP (1.111s)
[402.204715] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.214s)
[403.384192] [093/133] (663s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[403.912590] Starting subtest: syncobj-stationary-timeline-chain-engines
[404.040635] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.128s)
[405.034088] [094/133] (662s left) kms_dp_link_training (non-uhbr-mst)
[405.127940] Starting subtest: non-uhbr-mst
[405.136235] Subtest non-uhbr-mst: SKIP (0.000s)
[405.201577] [095/133] (661s left) gem_userptr_blits (create-destroy-sync)
[405.269051] Starting subtest: create-destroy-sync
[410.276726] Subtest create-destroy-sync: SUCCESS (5.009s)
[410.396597] [096/133] (656s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[410.457640] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[410.459875] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[410.563243] [097/133] (656s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[410.658962] Starting subtest: 2x-plain-flip-ts-check-interruptible
[410.671525] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[410.749660] [098/133] (656s left) kms_psr (psr2-primary-blt)
[410.838367] Starting subtest: psr2-primary-blt
[410.840662] Starting dynamic subtest: eDP-1
[412.580096] Dynamic subtest eDP-1: SUCCESS (1.741s)
[412.582516] Subtest psr2-primary-blt: SUCCESS (1.742s)
[413.451219] [099/133] (653s left) i915_pm_rps (waitboost)
[413.509186] Starting subtest: waitboost
[419.592897] Subtest waitboost: SUCCESS (6.087s)
[419.716692] [100/133] (647s left) perf_pmu (rc6)
[419.756561] Starting subtest: rc6
[419.758512] Starting dynamic subtest: gt0
[426.110478] Dynamic subtest gt0: SUCCESS (6.354s)
[426.122462] Starting dynamic subtest: runtime-pm-gt0
[433.836592] Dynamic subtest runtime-pm-gt0: SUCCESS (7.725s)
[433.848767] Starting dynamic subtest: runtime-pm-long-gt0
[446.271384] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.433s)
[446.284124] Starting dynamic subtest: other-idle-gt0
[452.613698] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[452.624104] Starting dynamic subtest: gt1
[458.955938] Dynamic subtest gt1: SUCCESS (6.339s)
[458.966703] Starting dynamic subtest: runtime-pm-gt1
[466.475603] Dynamic subtest runtime-pm-gt1: SUCCESS (7.516s)
[466.488404] Starting dynamic subtest: runtime-pm-long-gt1
[478.966406] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.488s)
[478.979046] Starting dynamic subtest: other-idle-gt1
[485.309608] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[485.312529] Subtest rc6: SUCCESS (65.552s)
[486.450939] [101/133] (580s left) sw_sync (timeline_closed_signaled)
[486.492704] Starting subtest: timeline_closed_signaled
[486.494638] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[486.532151] [102/133] (580s left) kms_atomic (test-only)
[486.614470] Starting subtest: test-only
[486.663094] Starting dynamic subtest: pipe-A-eDP-1
[489.167648] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s)
[489.169531] Subtest test-only: SUCCESS (2.553s)
[490.018627] [103/133] (577s left) kms_psr (fbc-pr-sprite-plane-onoff)
[490.122346] Starting subtest: fbc-pr-sprite-plane-onoff
[490.126348] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[490.173994] [104/133] (577s left) gem_fence_thrash (bo-write-verify-x)
[490.212983] Starting subtest: bo-write-verify-x
[490.236623] Subtest bo-write-verify-x: SKIP (0.021s)
[490.304052] [105/133] (577s left) perf_pmu (busy-hang)
[490.343937] Starting subtest: busy-hang
[490.346181] Starting dynamic subtest: rcs0
[491.616753] Dynamic subtest rcs0: SUCCESS (1.272s)
[491.628226] Starting dynamic subtest: bcs0
[492.853221] Dynamic subtest bcs0: SUCCESS (1.234s)
[492.865963] Starting dynamic subtest: vcs0
[495.435518] Dynamic subtest vcs0: SUCCESS (2.583s)
[495.445672] Starting dynamic subtest: vcs1
[497.491133] Dynamic subtest vcs1: SUCCESS (2.051s)
[497.501799] Starting dynamic subtest: vecs0
[499.466509] Dynamic subtest vecs0: SUCCESS (1.976s)
[499.478887] Starting dynamic subtest: ccs0
[500.709260] Dynamic subtest ccs0: SUCCESS (1.237s)
[500.711632] Subtest busy-hang: SUCCESS (10.365s)
[500.786980] [106/133] (566s left) gem_exec_suspend (basic)
[500.850697] Starting subtest: basic
[500.852957] Starting dynamic subtest: smem
[502.921588] Dynamic subtest smem: SUCCESS (2.068s)
[502.924566] Subtest basic: SUCCESS (2.070s)
[503.085500] [107/133] (564s left) sw_sync (alloc_fence)
[503.127698] Starting subtest: alloc_fence
[503.129686] Subtest alloc_fence: SUCCESS (0.000s)
[503.169210] [108/133] (564s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[503.281885] Starting subtest: psr-rgb101010-draw-pwrite
[510.976748] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.697s)
[511.058424] [109/133] (556s left) testdisplay
[511.348320] [110/133] (556s left) gem_eio (wait-immediate)
[511.597781] Starting subtest: wait-immediate
[511.993854] Subtest wait-immediate: SUCCESS (0.397s)
[512.126629] [111/133] (555s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[512.223359] Starting subtest: psr-1p-pri-indfb-multidraw
[535.405453] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.180s)
[535.495547] [112/133] (532s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[535.554150] Starting subtest: invalid-multi-wait-unsubmitted
[535.556051] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[535.630012] [113/133] (532s left) gem_ccs (block-copy-compressed)
[535.688996] Starting subtest: block-copy-compressed
[535.692955] Subtest block-copy-compressed: SKIP (0.000s)
[535.757880] [114/133] (532s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[535.863157] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[539.540941] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.679s)
[540.707208] [115/133] (527s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[540.816304] Starting subtest: y-tiled-8bpp-rotate-270
[540.820825] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[540.911518] [116/133] (527s left) syncobj_timeline (single-wait-all-signaled)
[540.971991] Starting subtest: single-wait-all-signaled
[540.974328] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[541.051400] [117/133] (526s left) kms_addfb_basic (invalid-get-prop)
[541.107110] Starting subtest: invalid-get-prop
[541.108974] Subtest invalid-get-prop: SUCCESS (0.000s)
[541.224995] [118/133] (526s left) gem_render_copy (y-tiled-to-vebox-linear)
[541.289993] Starting subtest: y-tiled-to-vebox-linear
[541.294644] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[541.453335] [119/133] (526s left) kms_busy (extended-pageflip-hang-oldfb)
[541.557147] Starting subtest: extended-pageflip-hang-oldfb
[541.559413] Starting dynamic subtest: pipe-A
[541.965536] Dynamic subtest pipe-A: SUCCESS (0.408s)
[541.976097] Starting dynamic subtest: pipe-D
[543.081765] Dynamic subtest pipe-D: SUCCESS (1.112s)
[543.084135] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.525s)
[543.887117] [120/133] (524s left) kms_vblank (ts-continuation-idle-hang)
[543.971390] Starting subtest: ts-continuation-idle-hang
[543.973539] Starting dynamic subtest: pipe-A-eDP-1
[570.709240] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.731s)
[570.724171] Starting dynamic subtest: pipe-D-eDP-1
[585.675854] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.959s)
[585.678197] Subtest ts-continuation-idle-hang: SUCCESS (41.695s)
[586.464366] [121/133] (481s left) kms_scaling_modes (scaling-mode-full)
[586.562121] Starting subtest: scaling-mode-full
[586.564268] Starting dynamic subtest: pipe-A-eDP-1
[586.655388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[586.666257] Starting dynamic subtest: pipe-B-eDP-1
[587.814918] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s)
[587.827524] Starting dynamic subtest: pipe-C-eDP-1
[588.939882] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[588.952915] Starting dynamic subtest: pipe-D-eDP-1
[590.086955] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[590.089236] Subtest scaling-mode-full: SUCCESS (3.527s)
[591.242503] [122/133] (476s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[591.321923] Starting subtest: etime-single-wait-for-submit-unsubmitted
[591.422806] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[591.475978] [123/133] (476s left) kms_content_protection (dp-mst-type-0)
[591.613951] Starting subtest: dp-mst-type-0
[591.619148] Subtest dp-mst-type-0: SKIP (0.000s)
[591.720503] [124/133] (476s left) gem_exec_schedule (preempt-hang)
[591.907290] Starting subtest: preempt-hang
[591.909609] Starting dynamic subtest: rcs0
[592.120921] Dynamic subtest rcs0: SUCCESS (0.216s)
[592.132824] Starting dynamic subtest: bcs0
[592.341760] Dynamic subtest bcs0: SUCCESS (0.219s)
[592.351957] Starting dynamic subtest: vcs0
[592.582642] Dynamic subtest vcs0: SUCCESS (0.241s)
[592.594973] Starting dynamic subtest: vcs1
[592.815102] Dynamic subtest vcs1: SUCCESS (0.231s)
[592.827595] Starting dynamic subtest: vecs0
[593.047659] Dynamic subtest vecs0: SUCCESS (0.231s)
[593.058775] Starting dynamic subtest: ccs0
[593.275002] Dynamic subtest ccs0: SUCCESS (0.227s)
[593.276927] Subtest preempt-hang: SUCCESS (1.371s)
[594.004280] [125/133] (474s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[594.118620] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[601.515988] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.399s)
[601.644004] [126/133] (466s left) gem_sync (basic-many-each)
[601.723586] Starting subtest: basic-many-each
[603.994049] Subtest basic-many-each: SUCCESS (2.279s)
[604.152997] [127/133] (464s left) gem_userptr_blits (coherency-unsync)
[604.217938] Subtest coherency-unsync: SKIP (0.000s)
[604.326118] [128/133] (464s left) syncobj_wait (multi-wait-all-signaled)
[604.377200] Starting subtest: multi-wait-all-signaled
[604.379419] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[604.464155] [129/133] (464s left) syncobj_wait (invalid-signal-one-illegal-handle)
[604.526460] Starting subtest: invalid-signal-one-illegal-handle
[604.528772] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[604.616574] [130/133] (463s left) gem_mmap_offset (clear)
[604.663787] Starting subtest: clear
[604.666542] Starting dynamic subtest: smem0
[628.484399] Dynamic subtest smem0: SUCCESS (23.815s)
[628.486691] Subtest clear: SUCCESS (23.816s)
[628.598669] [131/133] (439s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[628.752567] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[628.756514] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[628.829267] [132/133] (439s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[628.923992] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[628.926198] Starting dynamic subtest: pipe-A
[628.988637] Dynamic subtest pipe-A: SUCCESS (0.067s)
[628.999629] Starting dynamic subtest: pipe-B
[630.123115] Dynamic subtest pipe-B: SUCCESS (1.133s)
[630.133863] Starting dynamic subtest: pipe-C
[631.223965] Dynamic subtest pipe-C: SUCCESS (1.099s)
[631.241589] Starting dynamic subtest: pipe-D
[632.344352] Dynamic subtest pipe-D: SUCCESS (1.119s)
[632.346535] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.422s)
[633.494899] [133/133] (435s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[633.599382] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[634.290952] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[634.441154] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_joiner
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_edge_walk
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: gem_pwrite
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: vgem_basic
results: parsing output: 21/ for test: gem_mmap
results: parsing output: 22/ for test: kms_hdr
results: parsing output: 23/ for test: kms_pipe_stress
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_color_pipeline
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_chamelium_edid
results: parsing output: 28/ for test: gem_lmem_swapping
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_balancer
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_plane_multiple
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: gem_exec_whisper
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: gem_exec_whisper
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: vgem_basic
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: drm_read
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_ctx_isolation
results: parsing output: 58/ for test: kms_selftest
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gen7_exec_parse
results: parsing output: 62/ for test: gem_spin_batch
results: parsing output: 63/ for test: kms_lease
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: tools_test
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: gem_wait
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pipe_b_c_ivb
results: parsing output: 78/ for test: gen9_exec_parse
results: parsing output: 79/ for test: kms_properties
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_feature_discovery
results: parsing output: 84/ for test: gem_ctx_engines
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: api_intel_bb
results: parsing output: 87/ for test: gem_fenced_exec_thrash
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_dp_link_training
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: i915_pm_rps
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_fence_thrash
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_exec_suspend
results: parsing output: 106/ for test: sw_sync
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: testdisplay
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_ccs
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: kms_scaling_modes
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_sync
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_mmap_offset
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: kms_big_fb
Done.