[58.866986] Initializing watchdogs
[58.867107]   /dev/watchdog0
[58.882572] [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]
[58.887237] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.889737] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.892929] [001/133] (960s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[59.023609] Starting subtest: flip-vs-dpms-on-nop-interruptible
[59.025820] Starting dynamic subtest: A-eDP1
[60.908648] Dynamic subtest A-eDP1: SUCCESS (1.884s)
[60.920759] Starting dynamic subtest: B-eDP1
[62.744527] Dynamic subtest B-eDP1: SUCCESS (1.835s)
[62.752473] Starting dynamic subtest: C-eDP1
[64.556434] Dynamic subtest C-eDP1: SUCCESS (1.811s)
[64.565082] Starting dynamic subtest: D-eDP1
[66.385363] Dynamic subtest D-eDP1: SUCCESS (1.829s)
[66.390257] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.367s)
[67.576744] [002/133] (951s left) kms_joiner (invalid-modeset-big-joiner)
[67.764585] Starting subtest: invalid-modeset-big-joiner
[67.768995] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[67.840209] [003/133] (951s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[68.251984] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[69.067310] [004/133] (950s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[69.157788] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[69.162363] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[69.221327] [005/133] (950s left) gem_exec_params (batch-first)
[69.277713] Starting subtest: batch-first
[69.280718] Subtest batch-first: SUCCESS (0.005s)
[69.373623] [006/133] (950s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[69.465675] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[69.468022] Starting dynamic subtest: pipe-A-eDP-1
[69.490237] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[69.498848] Starting dynamic subtest: pipe-B-eDP-1
[69.520516] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[69.527831] Starting dynamic subtest: pipe-C-eDP-1
[69.548490] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[69.555586] Starting dynamic subtest: pipe-D-eDP-1
[69.577165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[69.581344] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[71.747539] [007/133] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[71.839531] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[71.843960] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.925453] [008/133] (947s left) i915_drm_fdinfo (virtual-idle)
[71.965107] Starting subtest: virtual-idle
[75.022861] Subtest virtual-idle: SUCCESS (3.058s)
[75.096981] [009/133] (944s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[75.189805] Starting subtest: plane-scaler-unity-scaling-with-rotation
[75.192100] Starting dynamic subtest: pipe-A
[75.427116] Dynamic subtest pipe-A: SUCCESS (0.239s)
[75.436771] Starting dynamic subtest: pipe-B
[76.731944] Dynamic subtest pipe-B: SUCCESS (1.304s)
[76.739628] Starting dynamic subtest: pipe-C
[78.071440] Dynamic subtest pipe-C: SUCCESS (1.339s)
[78.080733] Starting dynamic subtest: pipe-D
[79.393778] Dynamic subtest pipe-D: SUCCESS (1.322s)
[79.396086] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.206s)
[80.580334] [010/133] (939s left) perf_pmu (busy-check-all)
[80.620356] Starting subtest: busy-check-all
[80.622635] Starting dynamic subtest: rcs0
[81.173139] Dynamic subtest rcs0: SUCCESS (0.553s)
[81.183390] Starting dynamic subtest: bcs0
[81.723960] Dynamic subtest bcs0: SUCCESS (0.550s)
[81.734702] Starting dynamic subtest: vcs0
[82.903067] Dynamic subtest vcs0: SUCCESS (1.177s)
[82.915038] Starting dynamic subtest: vcs1
[84.887854] Dynamic subtest vcs1: SUCCESS (1.983s)
[84.901255] Starting dynamic subtest: vecs0
[86.871114] Dynamic subtest vecs0: SUCCESS (1.982s)
[86.882663] Starting dynamic subtest: ccs0
[87.426248] Dynamic subtest ccs0: SUCCESS (0.556s)
[87.428973] Subtest busy-check-all: SUCCESS (6.807s)
[87.537705] [011/133] (932s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[87.645251] Starting subtest: x-tiled-64bpp-rotate-180
[89.290775] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.647s)
[89.455980] [012/133] (930s left) gem_exec_params (no-blt)
[89.518424] Starting subtest: no-blt
[89.520920] Subtest no-blt: SUCCESS (0.002s)
[89.656410] [013/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[89.762386] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[89.765915] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[89.851213] [014/133] (930s left) kms_cursor_edge_walk (64x64-right-edge)
[89.961448] Starting subtest: 64x64-right-edge
[89.963358] Starting dynamic subtest: pipe-A-eDP-1
[93.454655] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.493s)
[93.464524] Starting dynamic subtest: pipe-D-eDP-1
[96.656311] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.201s)
[96.658543] Subtest 64x64-right-edge: SUCCESS (6.696s)
[97.494806] [015/133] (922s left) gem_mmap_gtt (hang)
[97.550511] Subtest hang: SKIP (0.000s)
[97.617461] [016/133] (922s left) kms_psr (fbc-psr-sprite-blt)
[97.708698] Starting subtest: fbc-psr-sprite-blt
[97.711038] Starting dynamic subtest: eDP-1
[97.715245] Dynamic subtest eDP-1: SKIP (0.000s)
[97.719443] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[97.780259] [017/133] (922s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[97.871560] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[97.873848] Starting dynamic subtest: pipe-A-default-mode
[99.047229] Dynamic subtest pipe-A-default-mode: SKIP (1.172s)
[99.051701] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.174s)
[99.178137] [018/133] (920s left) gem_pwrite (basic-exhaustion)
[99.229384] Subtest basic-exhaustion: SKIP (0.000s)
[99.288822] [019/133] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[99.400081] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[104.037806] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.642s)
[105.231324] [020/133] (914s left) kms_big_fb (linear-8bpp-rotate-270)
[105.347897] Starting subtest: linear-8bpp-rotate-270
[105.368121] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[105.480783] [021/133] (914s left) vgem_basic (second-client)
[105.568056] Starting subtest: second-client
[105.590093] Subtest second-client: SUCCESS (0.022s)
[105.649195] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[105.652283] [022/133] (914s left) gem_mmap (short-mmap)
[105.721614] Subtest short-mmap: SKIP (0.000s)
[105.791108] [023/133] (914s left) kms_hdr (bpc-switch-suspend)
[105.882677] Starting subtest: bpc-switch-suspend
[106.911738] Starting dynamic subtest: pipe-A-eDP-1
[126.216745] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.439s)
[126.219191] Subtest bpc-switch-suspend: SUCCESS (6.468s)
[126.342490] [024/133] (893s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[126.455699] Starting subtest: stress-xrgb8888-xtiled
[132.313355] Subtest stress-xrgb8888-xtiled: SUCCESS (5.863s)
[132.370068] [025/133] (888s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[132.424566] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[132.426568] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[132.511976] [026/133] (887s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[132.609460] Starting subtest: plane-ctm3x4-lut1d
[132.777722] Starting dynamic subtest: pipe-A-plane-0
[132.978714] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[132.987312] Starting dynamic subtest: pipe-A-plane-1
[133.166486] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[133.175155] Starting dynamic subtest: pipe-A-plane-2
[133.322039] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[134.579041] Starting dynamic subtest: pipe-B-plane-0
[134.749651] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[134.758733] Starting dynamic subtest: pipe-B-plane-1
[134.906074] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[134.917237] Starting dynamic subtest: pipe-B-plane-2
[135.071750] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[136.300254] Starting dynamic subtest: pipe-C-plane-0
[136.459268] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[136.468918] Starting dynamic subtest: pipe-C-plane-1
[136.603547] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[136.612872] Starting dynamic subtest: pipe-C-plane-2
[136.770013] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[137.962958] Starting dynamic subtest: pipe-D-plane-0
[138.122325] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[138.131357] Starting dynamic subtest: pipe-D-plane-1
[138.266522] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[138.275344] Starting dynamic subtest: pipe-D-plane-2
[138.411214] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[138.700497] Subtest plane-ctm3x4-lut1d: SUCCESS (6.094s)
[139.509664] [027/133] (880s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[139.603478] Starting subtest: addfb25-yf-tiled-legacy
[139.605506] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[139.690126] [028/133] (880s left) kms_chamelium_edid (dp-mode-timings)
[140.088292] Subtest dp-mode-timings: SKIP (0.000s)
[140.904668] [029/133] (879s left) gem_lmem_swapping (parallel-random-verify-ccs)
[140.955024] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[141.000151] [030/133] (879s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[141.082024] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[141.084310] Starting dynamic subtest: pipe-A-eDP-1
[141.092945] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[141.102554] Starting dynamic subtest: pipe-B-eDP-1
[141.111189] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[141.119845] Starting dynamic subtest: pipe-C-eDP-1
[141.128275] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[141.136361] Starting dynamic subtest: pipe-D-eDP-1
[141.144684] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[141.148834] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[143.383436] [031/133] (877s left) gem_exec_balancer (busy)
[143.448075] Starting subtest: busy
[144.771328] Subtest busy: SUCCESS (1.324s)
[145.100575] [032/133] (875s left) kms_cursor_crc (cursor-onscreen-64x21)
[145.301809] Starting subtest: cursor-onscreen-64x21
[145.355422] Subtest cursor-onscreen-64x21: SKIP (0.050s)
[145.592640] [033/133] (875s left) kms_plane_multiple (2x-tiling-yf)
[145.686921] Starting subtest: 2x-tiling-yf
[145.691231] Subtest 2x-tiling-yf: SKIP (0.000s)
[145.760013] [034/133] (874s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[145.820031] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[145.926894] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s)
[146.003637] [035/133] (874s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[146.102919] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[150.080395] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.982s)
[151.308576] [036/133] (869s left) gem_mmap_wc (coherency)
[151.368779] Subtest coherency: SKIP (0.000s)
[151.430695] [037/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[151.544933] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[151.549219] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[151.651093] [038/133] (869s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[151.757840] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[151.761955] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[151.847866] [039/133] (869s left) gem_eio (wait-wedge-10ms)
[152.098990] Starting subtest: wait-wedge-10ms
[153.799454] Subtest wait-wedge-10ms: SUCCESS (1.700s)
[153.927676] [040/133] (867s left) perf_pmu (semaphore-busy)
[153.968814] Starting subtest: semaphore-busy
[153.971173] Starting dynamic subtest: rcs0
[155.608467] Dynamic subtest rcs0: SUCCESS (1.636s)
[155.620206] Starting dynamic subtest: bcs0
[157.241952] Dynamic subtest bcs0: SUCCESS (1.631s)
[157.253782] Starting dynamic subtest: vcs0
[161.277793] Dynamic subtest vcs0: SUCCESS (4.031s)
[161.289082] Starting dynamic subtest: vcs1
[167.294168] Dynamic subtest vcs1: SUCCESS (6.012s)
[167.305187] Starting dynamic subtest: vecs0
[173.309845] Dynamic subtest vecs0: SUCCESS (6.011s)
[173.321074] Starting dynamic subtest: ccs0
[176.383365] Dynamic subtest ccs0: SUCCESS (3.070s)
[176.385893] Subtest semaphore-busy: SUCCESS (22.406s)
[176.500148] [041/133] (844s left) gem_exec_whisper (basic-contexts-all)
[176.563016] Starting subtest: basic-contexts-all
[188.473239] Subtest basic-contexts-all: SUCCESS (11.905s)
[188.653808] [042/133] (832s left) gem_pxp (reject-modify-context-protection-on)
[188.800966] Starting subtest: reject-modify-context-protection-on
[188.803674] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[188.934547] [043/133] (832s left) gem_exec_params (sol-reset-not-gen7)
[189.001627] Starting subtest: sol-reset-not-gen7
[189.010543] Subtest sol-reset-not-gen7: SUCCESS (0.007s)
[189.138310] [044/133] (832s left) kms_pm_rpm (pm-caching)
[190.981912] Starting subtest: pm-caching
[190.986818] Subtest pm-caching: SKIP (0.000s)
[191.415018] [045/133] (829s left) api_intel_bb (bb-with-allocator)
[191.469249] Starting subtest: bb-with-allocator
[191.471351] Subtest bb-with-allocator: SUCCESS (0.005s)
[191.599762] [046/133] (829s left) gem_exec_reloc (basic-concurrent16)
[191.675195] Subtest basic-concurrent16: SKIP (0.000s)
[191.757711] [047/133] (829s left) gem_exec_whisper (basic-queues-priority)
[191.826830] Starting subtest: basic-queues-priority
[214.887149] Subtest basic-queues-priority: SUCCESS (23.059s)
[215.072207] [048/133] (806s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[215.193949] Starting subtest: flip-vs-cursor-busy-crc-legacy
[216.006213] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.812s)
[216.838006] [049/133] (804s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[216.946550] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[217.991590] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.045s)
[218.128615] [050/133] (803s left) kms_big_fb (yf-tiled-addfb)
[218.226467] Starting subtest: yf-tiled-addfb
[218.230097] Subtest yf-tiled-addfb: SKIP (0.000s)
[218.327571] [051/133] (803s left) vgem_basic (bad-handle)
[218.376971] Starting subtest: bad-handle
[218.378799] Subtest bad-handle: SUCCESS (0.000s)
[218.432092] [052/133] (803s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[218.521234] Starting subtest: fbc-pr-cursor-mmap-gtt
[218.524732] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[218.624973] [053/133] (802s left) drm_read (short-buffer-wakeup)
[218.768344] Starting subtest: short-buffer-wakeup
[250.989191] Subtest short-buffer-wakeup: SUCCESS (32.218s)
[251.157122] [054/133] (770s left) kms_pm_rpm (basic-pci-d3-state)
[252.992174] Starting subtest: basic-pci-d3-state
[254.451126] Subtest basic-pci-d3-state: SUCCESS (1.463s)
[254.548961] [055/133] (767s left) kms_plane (pixel-format-4-tiled-modifier)
[254.637207] Starting subtest: pixel-format-4-tiled-modifier
[254.664204] Starting dynamic subtest: pipe-A-plane-0
[255.363857] Dynamic subtest pipe-A-plane-0: SUCCESS (0.700s)
[255.373561] Starting dynamic subtest: pipe-A-plane-3
[255.796980] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[255.806896] Starting dynamic subtest: pipe-A-plane-5
[255.810629] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[256.893297] Starting dynamic subtest: pipe-B-plane-0
[257.572134] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[257.582132] Starting dynamic subtest: pipe-B-plane-3
[257.992964] Dynamic subtest pipe-B-plane-3: SUCCESS (0.419s)
[258.002401] Starting dynamic subtest: pipe-B-plane-5
[258.005949] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[258.312802] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.677s)
[259.177172] [056/133] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[259.274368] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[259.278591] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[259.378701] [057/133] (762s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[259.475885] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[259.478112] Starting dynamic subtest: pipe-A-eDP-1
[259.500136] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[259.513362] Starting dynamic subtest: pipe-B-eDP-1
[259.534299] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[259.543294] Starting dynamic subtest: pipe-C-eDP-1
[259.564040] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[259.573484] Starting dynamic subtest: pipe-D-eDP-1
[259.595261] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[259.599287] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[261.731410] [058/133] (760s left) gem_ctx_isolation (preservation)
[261.801004] Starting subtest: preservation
[261.803393] Starting dynamic subtest: rcs0
[261.946772] Dynamic subtest rcs0: SUCCESS (0.145s)
[261.959372] Starting dynamic subtest: bcs0
[262.102801] Dynamic subtest bcs0: SUCCESS (0.155s)
[262.115331] Starting dynamic subtest: vcs0
[262.272983] Dynamic subtest vcs0: SUCCESS (0.169s)
[262.285983] Starting dynamic subtest: vcs1
[263.853531] Dynamic subtest vcs1: SUCCESS (1.579s)
[263.866963] Starting dynamic subtest: vecs0
[265.919471] Dynamic subtest vecs0: SUCCESS (2.066s)
[265.930335] Starting dynamic subtest: ccs0
[267.901934] Dynamic subtest ccs0: SUCCESS (1.981s)
[267.905313] Subtest preservation: SUCCESS (6.100s)
[268.128458] [059/133] (753s left) kms_selftest (drm_plane_helper)
[268.176204] Starting subtest: drm_plane_helper
[268.221063] Starting dynamic subtest: drm_test_check_plane_state
[268.341050] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.117s)
[268.351465] Starting dynamic subtest: drm_test_check_invalid_plane_state
[268.442447] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.103s)
[268.444811] Subtest drm_plane_helper: SUCCESS (0.266s)
[268.617544] [060/133] (753s left) gem_exec_reloc (basic-write-cpu-noreloc)
[268.684949] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[268.759082] [061/133] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[268.856082] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[268.860315] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[268.955159] [062/133] (753s left) gen7_exec_parse (basic-rejected)
[269.017684] Subtest basic-rejected: SKIP (0.000s)
[269.088856] [063/133] (752s left) gem_spin_batch (resubmit-new-all)
[269.140395] Starting subtest: resubmit-new-all
[269.142546] Starting dynamic subtest: rcs0
[269.154771] Dynamic subtest rcs0: SUCCESS (0.014s)
[269.166340] Starting dynamic subtest: bcs0
[269.168452] Dynamic subtest bcs0: SUCCESS (0.010s)
[269.178364] Starting dynamic subtest: vcs0
[269.180482] Dynamic subtest vcs0: SUCCESS (0.009s)
[269.189709] Starting dynamic subtest: vcs1
[269.191942] Dynamic subtest vcs1: SUCCESS (0.009s)
[269.201451] Starting dynamic subtest: vecs0
[269.203341] Dynamic subtest vecs0: SUCCESS (0.008s)
[269.212719] Starting dynamic subtest: ccs0
[269.214824] Dynamic subtest ccs0: SUCCESS (0.010s)
[269.216919] Subtest resubmit-new-all: SUCCESS (0.066s)
[270.828669] [064/133] (751s left) kms_lease (lease-revoke)
[270.921662] Starting subtest: lease-revoke
[270.923746] Starting dynamic subtest: pipe-A-eDP-1
[270.955475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[270.965767] Starting dynamic subtest: pipe-B-eDP-1
[270.984116] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[270.994416] Starting dynamic subtest: pipe-C-eDP-1
[271.013140] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[271.022884] Starting dynamic subtest: pipe-D-eDP-1
[271.038849] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[271.041165] Subtest lease-revoke: SUCCESS (0.119s)
[271.160218] [065/133] (750s left) kms_flip (2x-flip-vs-modeset)
[271.257038] Starting subtest: 2x-flip-vs-modeset
[271.266802] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[271.347951] [066/133] (750s left) tools_test (sysfs_l3_parity)
[271.398373] Starting subtest: sysfs_l3_parity
[271.470930] Subtest sysfs_l3_parity: SKIP (0.082s)
[271.524311] [067/133] (750s left) gem_eio (in-flight-internal-10ms)
[271.755814] Starting subtest: in-flight-internal-10ms
[272.842480] Subtest in-flight-internal-10ms: SUCCESS (1.086s)
[272.955629] [068/133] (749s left) kms_cursor_crc (cursor-random-512x170)
[273.264201] Starting subtest: cursor-random-512x170
[273.268822] Subtest cursor-random-512x170: SKIP (0.002s)
[273.421382] [069/133] (748s left) gem_wait (write-wait)
[273.493040] Starting subtest: write-wait
[273.495272] Starting dynamic subtest: all-engines
[274.572817] Dynamic subtest all-engines: SUCCESS (1.079s)
[274.589932] Starting dynamic subtest: rcs0
[275.629196] Dynamic subtest rcs0: SUCCESS (1.054s)
[275.646477] Starting dynamic subtest: bcs0
[276.686400] Dynamic subtest bcs0: SUCCESS (1.055s)
[276.703374] Starting dynamic subtest: vcs0
[277.739344] Dynamic subtest vcs0: SUCCESS (1.051s)
[277.756918] Starting dynamic subtest: vcs1
[278.793684] Dynamic subtest vcs1: SUCCESS (1.052s)
[278.810912] Starting dynamic subtest: vecs0
[279.846430] Dynamic subtest vecs0: SUCCESS (1.051s)
[279.863429] Starting dynamic subtest: ccs0
[280.903424] Dynamic subtest ccs0: SUCCESS (1.055s)
[280.905921] Subtest write-wait: SUCCESS (7.411s)
[281.136146] [070/133] (741s left) kms_flip (dpms-off-confusion)
[281.247997] Starting subtest: dpms-off-confusion
[281.250498] Starting dynamic subtest: A-eDP1
[289.932948] Dynamic subtest A-eDP1: SUCCESS (8.686s)
[289.945699] Starting dynamic subtest: B-eDP1
[298.571562] Dynamic subtest B-eDP1: SUCCESS (8.637s)
[298.582182] Starting dynamic subtest: C-eDP1
[307.204076] Dynamic subtest C-eDP1: SUCCESS (8.630s)
[307.214215] Starting dynamic subtest: D-eDP1
[315.835292] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[315.840508] Subtest dpms-off-confusion: SUCCESS (34.596s)
[317.006649] [071/133] (705s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[317.103878] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[317.106074] Starting dynamic subtest: pipe-A-eDP-1
[317.127475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[317.138545] Starting dynamic subtest: pipe-B-eDP-1
[317.158810] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[317.168453] Starting dynamic subtest: pipe-C-eDP-1
[317.188713] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[317.198715] Starting dynamic subtest: pipe-D-eDP-1
[317.218077] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[317.220256] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.011s)
[319.365261] [072/133] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[319.464172] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[319.468348] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[319.558955] [073/133] (702s left) gem_ctx_persistence (heartbeat-many)
[319.615160] Starting subtest: heartbeat-many
[319.619553] Subtest heartbeat-many: SKIP (0.000s)
[319.714111] [074/133] (702s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[321.945527] Starting subtest: gem-execbuf-stress-pc8
[321.986875] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[322.334613] [075/133] (700s left) gem_exec_fence (basic-wait)
[322.510603] Starting subtest: basic-wait
[322.513192] Starting dynamic subtest: rcs0
[322.587431] Dynamic subtest rcs0: SUCCESS (0.078s)
[322.599177] Starting dynamic subtest: bcs0
[322.659971] Dynamic subtest bcs0: SUCCESS (0.070s)
[322.671935] Starting dynamic subtest: vcs0
[322.717530] Dynamic subtest vcs0: SUCCESS (0.055s)
[322.728978] Starting dynamic subtest: vcs1
[322.772408] Dynamic subtest vcs1: SUCCESS (0.053s)
[322.784910] Starting dynamic subtest: vecs0
[322.827442] Dynamic subtest vecs0: SUCCESS (0.053s)
[322.841537] Starting dynamic subtest: ccs0
[322.876864] Dynamic subtest ccs0: SUCCESS (0.049s)
[322.879188] Subtest basic-wait: SUCCESS (0.369s)
[324.911522] [076/133] (697s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[325.040702] Starting subtest: 2x-cursor-vs-flip-atomic
[325.045814] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[325.205738] [077/133] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[325.312920] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[325.317133] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[325.412035] [078/133] (697s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[325.473505] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[325.536798] [079/133] (697s left) gen9_exec_parse (unaligned-access)
[325.607388] Subtest unaligned-access: SKIP (0.000s)
[325.677620] [080/133] (697s left) kms_properties (invalid-properties-atomic)
[325.766629] Starting subtest: invalid-properties-atomic
[326.111150] Subtest invalid-properties-atomic: SUCCESS (0.344s)
[326.194725] [081/133] (696s left) gem_ctx_shared (q-in-order)
[326.260908] Starting subtest: Q-in-order
[326.263321] Starting dynamic subtest: rcs0
[326.360938] Dynamic subtest rcs0: SUCCESS (0.099s)
[326.376519] Starting dynamic subtest: vcs0
[326.447398] Dynamic subtest vcs0: SUCCESS (0.085s)
[326.463917] Starting dynamic subtest: vcs1
[326.523085] Dynamic subtest vcs1: SUCCESS (0.075s)
[326.540672] Starting dynamic subtest: vecs0
[326.606686] Dynamic subtest vecs0: SUCCESS (0.083s)
[326.627074] Starting dynamic subtest: ccs0
[326.701907] Dynamic subtest ccs0: SUCCESS (0.092s)
[326.704704] Subtest Q-in-order: SUCCESS (0.440s)
[327.909805] [082/133] (694s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[328.011413] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[328.015784] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[328.116543] [083/133] (694s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[328.203178] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[328.205369] Starting dynamic subtest: pipe-A-eDP-1
[328.953376] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s)
[328.964752] Starting dynamic subtest: pipe-B-eDP-1
[330.749631] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.795s)
[330.764651] Starting dynamic subtest: pipe-C-eDP-1
[332.572348] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.822s)
[332.581775] Starting dynamic subtest: pipe-D-eDP-1
[334.411387] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.837s)
[334.413734] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.201s)
[335.550500] [084/133] (687s left) kms_feature_discovery (chamelium)
[335.648178] Starting subtest: chamelium
[335.652631] Subtest chamelium: SKIP (0.000s)
[335.731903] [085/133] (687s left) gem_ctx_engines (none)
[335.801067] Starting subtest: none
[335.803534] Subtest none: SUCCESS (0.001s)
[335.999178] [086/133] (687s left) kms_flip (dpms-vs-vblank-race-interruptible)
[336.100421] Starting subtest: dpms-vs-vblank-race-interruptible
[336.102902] Starting dynamic subtest: A-eDP1
[341.025632] Dynamic subtest A-eDP1: SUCCESS (4.924s)
[341.036229] Starting dynamic subtest: B-eDP1
[345.658345] Dynamic subtest B-eDP1: SUCCESS (4.630s)
[345.668315] Starting dynamic subtest: C-eDP1
[350.274220] Dynamic subtest C-eDP1: SUCCESS (4.614s)
[350.284282] Starting dynamic subtest: D-eDP1
[354.905568] Dynamic subtest D-eDP1: SUCCESS (4.629s)
[354.910162] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.810s)
[355.804383] [087/133] (667s left) api_intel_bb (simple-bb-ctx)
[355.876327] Starting subtest: simple-bb-ctx
[355.885004] Subtest simple-bb-ctx: SUCCESS (0.008s)
[356.004149] [088/133] (667s left) gem_fenced_exec_thrash (too-many-fences)
[356.060902] Subtest too-many-fences: SKIP (0.000s)
[356.134662] [089/133] (667s left) gem_exec_schedule (semaphore-resolve)
[356.202323] Starting subtest: semaphore-resolve
[356.233551] Subtest semaphore-resolve: SUCCESS (0.039s)
[356.568368] [090/133] (666s left) kms_psr (pr-no-drrs)
[356.656926] Starting subtest: pr-no-drrs
[356.661319] Subtest pr-no-drrs: SKIP (0.000s)
[356.741956] [091/133] (666s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[356.834405] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[356.838695] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[356.915443] [092/133] (666s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[357.015624] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[357.017924] Starting dynamic subtest: pipe-A-eDP-1
[357.111936] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[357.124912] Starting dynamic subtest: pipe-B-eDP-1
[358.245303] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[358.249844] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.234s)
[359.441279] [093/133] (663s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[359.983779] Starting subtest: syncobj-stationary-timeline-chain-engines
[360.123380] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.140s)
[361.893561] [094/133] (661s left) kms_dp_link_training (non-uhbr-mst)
[361.995173] Starting subtest: non-uhbr-mst
[362.003928] Subtest non-uhbr-mst: SKIP (0.000s)
[362.092729] [095/133] (661s left) gem_userptr_blits (create-destroy-sync)
[362.161350] Starting subtest: create-destroy-sync
[367.177081] Subtest create-destroy-sync: SUCCESS (5.016s)
[367.324503] [096/133] (656s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[367.379242] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[367.381517] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[367.493900] [097/133] (656s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[367.597154] Starting subtest: 2x-plain-flip-ts-check-interruptible
[367.609902] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[367.704684] [098/133] (655s left) kms_psr (psr2-primary-blt)
[367.797058] Starting subtest: psr2-primary-blt
[367.799288] Starting dynamic subtest: eDP-1
[369.554173] Dynamic subtest eDP-1: SUCCESS (1.756s)
[369.556635] Subtest psr2-primary-blt: SUCCESS (1.757s)
[370.422689] [099/133] (653s left) i915_pm_rps (waitboost)
[370.487548] Starting subtest: waitboost
[376.581366] Subtest waitboost: SUCCESS (6.096s)
[376.716453] [100/133] (646s left) perf_pmu (rc6)
[376.767999] Starting subtest: rc6
[376.769888] Starting dynamic subtest: gt0
[383.130909] Dynamic subtest gt0: SUCCESS (6.363s)
[383.143696] Starting dynamic subtest: runtime-pm-gt0
[390.849930] Dynamic subtest runtime-pm-gt0: SUCCESS (7.716s)
[390.862859] Starting dynamic subtest: runtime-pm-long-gt0
[403.355185] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.502s)
[403.367801] Starting dynamic subtest: other-idle-gt0
[409.699152] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[409.711718] Starting dynamic subtest: gt1
[416.039947] Dynamic subtest gt1: SUCCESS (6.339s)
[416.052520] Starting dynamic subtest: runtime-pm-gt1
[423.486682] Dynamic subtest runtime-pm-gt1: SUCCESS (7.444s)
[423.498099] Starting dynamic subtest: runtime-pm-long-gt1
[435.924625] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.435s)
[435.937835] Starting dynamic subtest: other-idle-gt1
[442.268368] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[442.271193] Subtest rc6: SUCCESS (65.502s)
[443.416936] [101/133] (580s left) sw_sync (timeline_closed_signaled)
[443.457394] Starting subtest: timeline_closed_signaled
[443.459727] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[443.500302] [102/133] (580s left) kms_atomic (test-only)
[443.601190] Starting subtest: test-only
[443.650742] Starting dynamic subtest: pipe-A-eDP-1
[446.137878] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.487s)
[446.140139] Subtest test-only: SUCCESS (2.536s)
[446.924734] [103/133] (576s left) kms_psr (fbc-pr-sprite-plane-onoff)
[447.018363] Starting subtest: fbc-pr-sprite-plane-onoff
[447.022361] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[447.068300] [104/133] (576s left) gem_fence_thrash (bo-write-verify-x)
[447.108889] Starting subtest: bo-write-verify-x
[447.135758] Subtest bo-write-verify-x: SKIP (0.023s)
[447.201559] [105/133] (576s left) perf_pmu (busy-hang)
[447.239692] Starting subtest: busy-hang
[447.241997] Starting dynamic subtest: rcs0
[448.505880] Dynamic subtest rcs0: SUCCESS (1.266s)
[448.517267] Starting dynamic subtest: bcs0
[449.744173] Dynamic subtest bcs0: SUCCESS (1.236s)
[449.755448] Starting dynamic subtest: vcs0
[452.293676] Dynamic subtest vcs0: SUCCESS (2.547s)
[452.304171] Starting dynamic subtest: vcs1
[454.282157] Dynamic subtest vcs1: SUCCESS (1.987s)
[454.293728] Starting dynamic subtest: vecs0
[456.262639] Dynamic subtest vecs0: SUCCESS (1.978s)
[456.273908] Starting dynamic subtest: ccs0
[457.500357] Dynamic subtest ccs0: SUCCESS (1.236s)
[457.502669] Subtest busy-hang: SUCCESS (10.262s)
[457.574906] [106/133] (566s left) gem_exec_suspend (basic)
[457.640541] Starting subtest: basic
[457.642777] Starting dynamic subtest: smem
[458.755216] Dynamic subtest smem: SUCCESS (1.113s)
[458.757972] Subtest basic: SUCCESS (1.116s)
[458.921597] [107/133] (565s left) sw_sync (alloc_fence)
[458.960054] Starting subtest: alloc_fence
[458.962283] Subtest alloc_fence: SUCCESS (0.000s)
[459.001096] [108/133] (564s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[459.121597] Starting subtest: psr-rgb101010-draw-pwrite
[466.881978] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.762s)
[466.962855] [109/133] (557s left) testdisplay
[467.277296] [110/133] (556s left) gem_eio (wait-immediate)
[467.534717] Starting subtest: wait-immediate
[467.944761] Subtest wait-immediate: SUCCESS (0.411s)
[468.037755] [111/133] (556s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[468.147073] Starting subtest: psr-1p-pri-indfb-multidraw
[491.076272] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.931s)
[491.174403] [112/133] (532s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[491.253985] Starting subtest: invalid-multi-wait-unsubmitted
[491.255938] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[491.330577] [113/133] (532s left) gem_ccs (block-copy-compressed)
[491.383527] Starting subtest: block-copy-compressed
[491.387087] Subtest block-copy-compressed: SKIP (0.000s)
[491.462843] [114/133] (532s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[491.570758] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[495.302983] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.734s)
[496.462094] [115/133] (527s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[496.556553] Starting subtest: y-tiled-8bpp-rotate-270
[496.561169] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[496.627702] [116/133] (527s left) syncobj_timeline (single-wait-all-signaled)
[496.688764] Starting subtest: single-wait-all-signaled
[496.691095] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[496.766399] [117/133] (527s left) kms_addfb_basic (invalid-get-prop)
[496.838065] Starting subtest: invalid-get-prop
[496.840385] Subtest invalid-get-prop: SUCCESS (0.000s)
[496.958651] [118/133] (527s left) gem_render_copy (y-tiled-to-vebox-linear)
[497.025323] Starting subtest: y-tiled-to-vebox-linear
[497.029332] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[497.180491] [119/133] (527s left) kms_busy (extended-pageflip-hang-oldfb)
[497.279124] Starting subtest: extended-pageflip-hang-oldfb
[497.281475] Starting dynamic subtest: pipe-A
[497.669038] Dynamic subtest pipe-A: SUCCESS (0.388s)
[497.680172] Starting dynamic subtest: pipe-D
[498.784346] Dynamic subtest pipe-D: SUCCESS (1.114s)
[498.786739] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.507s)
[499.609681] [120/133] (524s left) kms_vblank (ts-continuation-idle-hang)
[499.711152] Starting subtest: ts-continuation-idle-hang
[499.713492] Starting dynamic subtest: pipe-A-eDP-1
[526.598064] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.885s)
[526.613909] Starting dynamic subtest: pipe-D-eDP-1
[551.558088] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.954s)
[551.560600] Subtest ts-continuation-idle-hang: SUCCESS (51.848s)
[552.365626] [121/133] (472s left) kms_scaling_modes (scaling-mode-full)
[552.458064] Starting subtest: scaling-mode-full
[552.460474] Starting dynamic subtest: pipe-A-eDP-1
[552.550774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[552.562124] Starting dynamic subtest: pipe-B-eDP-1
[553.718568] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[553.729859] Starting dynamic subtest: pipe-C-eDP-1
[554.838592] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[554.852948] Starting dynamic subtest: pipe-D-eDP-1
[555.970679] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[555.972816] Subtest scaling-mode-full: SUCCESS (3.516s)
[557.115746] [122/133] (467s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[557.180186] Starting subtest: etime-single-wait-for-submit-unsubmitted
[557.286813] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[557.342720] [123/133] (467s left) kms_content_protection (dp-mst-type-0)
[557.482415] Starting subtest: dp-mst-type-0
[557.486858] Subtest dp-mst-type-0: SKIP (0.000s)
[557.580512] [124/133] (467s left) gem_exec_schedule (preempt-hang)
[557.760423] Starting subtest: preempt-hang
[557.763035] Starting dynamic subtest: rcs0
[557.980926] Dynamic subtest rcs0: SUCCESS (0.220s)
[557.991701] Starting dynamic subtest: bcs0
[558.196539] Dynamic subtest bcs0: SUCCESS (0.215s)
[558.208374] Starting dynamic subtest: vcs0
[558.431349] Dynamic subtest vcs0: SUCCESS (0.232s)
[558.442911] Starting dynamic subtest: vcs1
[558.663336] Dynamic subtest vcs1: SUCCESS (0.231s)
[558.674905] Starting dynamic subtest: vecs0
[558.890407] Dynamic subtest vecs0: SUCCESS (0.227s)
[558.905910] Starting dynamic subtest: ccs0
[559.116567] Dynamic subtest ccs0: SUCCESS (0.225s)
[559.118526] Subtest preempt-hang: SUCCESS (1.355s)
[559.879004] [125/133] (464s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[559.981322] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[567.272965] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.294s)
[567.389871] [126/133] (457s left) gem_sync (basic-many-each)
[567.467051] Starting subtest: basic-many-each
[569.741649] Subtest basic-many-each: SUCCESS (2.284s)
[569.905680] [127/133] (454s left) gem_userptr_blits (coherency-unsync)
[569.962879] Subtest coherency-unsync: SKIP (0.000s)
[570.052579] [128/133] (454s left) syncobj_wait (multi-wait-all-signaled)
[570.119773] Starting subtest: multi-wait-all-signaled
[570.122182] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[570.200530] [129/133] (454s left) syncobj_wait (invalid-signal-one-illegal-handle)
[570.248780] Starting subtest: invalid-signal-one-illegal-handle
[570.251135] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[570.328490] [130/133] (454s left) gem_mmap_offset (clear)
[570.382890] Starting subtest: clear
[570.385133] Starting dynamic subtest: smem0
[595.166181] Dynamic subtest smem0: SUCCESS (24.780s)
[595.168521] Subtest clear: SUCCESS (24.781s)
[595.298808] [131/133] (429s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[595.460718] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[595.465155] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[595.542689] [132/133] (429s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[595.648013] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[595.650285] Starting dynamic subtest: pipe-A
[595.711318] Dynamic subtest pipe-A: SUCCESS (0.066s)
[595.724374] Starting dynamic subtest: pipe-B
[596.814009] Dynamic subtest pipe-B: SUCCESS (1.102s)
[596.824910] Starting dynamic subtest: pipe-C
[597.920884] Dynamic subtest pipe-C: SUCCESS (1.105s)
[597.935843] Starting dynamic subtest: pipe-D
[599.058662] Dynamic subtest pipe-D: SUCCESS (1.137s)
[599.061043] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.414s)
[600.209127] [133/133] (424s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[600.317871] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[601.020374] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.703s)
[601.162688] 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.