[58.679200] Initializing watchdogs
[58.679338]   /dev/watchdog0
[58.695244] [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.699901] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.702450] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.706115] [001/133] (960s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[59.002893] Starting subtest: cursor-rapid-movement-256x85
[59.061544] Subtest cursor-rapid-movement-256x85: SKIP (0.051s)
[59.233571] [002/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[59.327820] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[59.332039] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[59.394534] [003/133] (959s left) kms_plane_alpha_blend (alpha-transparent-fb)
[59.489598] Starting subtest: alpha-transparent-fb
[59.775807] Starting dynamic subtest: pipe-A-eDP-1
[60.464036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s)
[60.472556] Starting dynamic subtest: pipe-D-eDP-1
[61.775461] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.310s)
[61.777681] Subtest alpha-transparent-fb: SUCCESS (2.285s)
[62.585307] [004/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[62.688682] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[62.692997] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[62.778674] [005/133] (956s left) gem_softpin (allocator-fork)
[62.842689] Starting subtest: allocator-fork
[65.060969] Subtest allocator-fork: SUCCESS (2.217s)
[65.164996] [006/133] (954s left) perf_pmu (semaphore-busy)
[65.202992] Starting subtest: semaphore-busy
[65.205310] Starting dynamic subtest: rcs0
[66.851112] Dynamic subtest rcs0: SUCCESS (1.645s)
[66.860561] Starting dynamic subtest: bcs0
[68.644231] Dynamic subtest bcs0: SUCCESS (1.791s)
[68.654417] Starting dynamic subtest: vcs0
[72.403067] Dynamic subtest vcs0: SUCCESS (3.758s)
[72.413350] Starting dynamic subtest: vcs1
[78.419339] Dynamic subtest vcs1: SUCCESS (6.015s)
[78.431418] Starting dynamic subtest: vecs0
[84.434626] Dynamic subtest vecs0: SUCCESS (6.014s)
[84.444224] Starting dynamic subtest: ccs0
[87.510366] Dynamic subtest ccs0: SUCCESS (3.075s)
[87.512608] Subtest semaphore-busy: SUCCESS (22.305s)
[87.651290] [007/133] (931s left) api_intel_bb (blit-noreloc-purge-cache)
[87.719966] Starting subtest: blit-noreloc-purge-cache
[87.733635] Subtest blit-noreloc-purge-cache: SUCCESS (0.016s)
[87.831217] [008/133] (931s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[87.940054] Starting subtest: psr-2p-primscrn-cur-indfb-move
[87.944401] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[88.084623] [009/133] (931s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[88.191438] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[88.195854] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[88.288587] [010/133] (931s left) gem_softpin (invalid)
[88.358703] Starting subtest: invalid
[88.366972] Subtest invalid: SUCCESS (0.008s)
[88.495081] [011/133] (931s left) sysfs_heartbeat_interval (invalid)
[88.559504] Starting subtest: invalid
[88.561470] Starting dynamic subtest: vecs0
[88.563577] Dynamic subtest vecs0: SUCCESS (0.000s)
[88.572805] Starting dynamic subtest: ccs0
[88.574616] Dynamic subtest ccs0: SUCCESS (0.000s)
[88.582074] Starting dynamic subtest: vcs0
[88.583860] Dynamic subtest vcs0: SUCCESS (0.000s)
[88.591108] Starting dynamic subtest: bcs0
[88.592888] Dynamic subtest bcs0: SUCCESS (0.000s)
[88.601612] Starting dynamic subtest: rcs0
[88.603311] Dynamic subtest rcs0: SUCCESS (0.000s)
[88.610176] Starting dynamic subtest: vcs1
[88.611921] Dynamic subtest vcs1: SUCCESS (0.000s)
[88.613697] Subtest invalid: SUCCESS (0.003s)
[88.705529] [012/133] (930s left) kms_vrr (flip-dpms)
[88.815085] Starting subtest: flip-dpms
[88.820366] Subtest flip-dpms: SKIP (0.000s)
[88.886486] [013/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[88.989555] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[96.147890] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.163s)
[96.281328] [014/133] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[96.389822] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[96.394251] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[96.494025] [015/133] (923s left) kms_pm_dc (dc6-psr)
[97.590972] Starting subtest: dc6-psr
[100.471066] Subtest dc6-psr: SUCCESS (2.879s)
[101.350654] [016/133] (918s left) kms_plane_scaling (intel-max-src-size)
[101.452066] Starting subtest: intel-max-src-size
[101.458893] Subtest intel-max-src-size: SKIP (0.001s)
[101.576782] [017/133] (918s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[101.664921] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[101.670056] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[101.743430] [018/133] (918s left) prime_vgem (coherency-blt)
[101.900685] Starting subtest: coherency-blt
[103.030053] Subtest coherency-blt: SUCCESS (1.128s)
[103.142593] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[103.146311] [019/133] (916s left) i915_drm_fdinfo (virtual-busy-idle-all)
[103.194298] Starting subtest: virtual-busy-idle-all
[103.198643] Subtest virtual-busy-idle-all: SKIP (0.000s)
[103.279838] [020/133] (916s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[103.332692] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[103.334805] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[103.416801] [021/133] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[103.505499] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[103.507787] Starting dynamic subtest: pipe-A-eDP-1
[103.579305] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[103.589696] Starting dynamic subtest: pipe-B-eDP-1
[104.716265] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[104.721173] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.214s)
[105.902422] [022/133] (914s left) prime_self_import (basic-llseek-size)
[105.943973] Starting subtest: basic-llseek-size
[105.958977] Subtest basic-llseek-size: SUCCESS (0.017s)
[106.060082] [023/133] (914s left) kms_lease (invalid-create-leases)
[106.155909] Starting subtest: invalid-create-leases
[106.166582] Subtest invalid-create-leases: SUCCESS (0.010s)
[106.294435] [024/133] (913s left) syncobj_timeline (invalid-signal-illegal-point)
[106.357822] Starting subtest: invalid-signal-illegal-point
[106.360578] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[106.477810] [025/133] (913s left) kms_psr (psr-sprite-mmap-gtt)
[106.577563] Starting subtest: psr-sprite-mmap-gtt
[106.579722] Starting dynamic subtest: eDP-1
[108.050271] Dynamic subtest eDP-1: SKIP (1.468s)
[108.055033] Subtest psr-sprite-mmap-gtt: SKIP (1.470s)
[108.188074] [026/133] (912s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[108.237896] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[108.339103] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[108.428897] [027/133] (911s left) gem_request_retire (retire-vma-not-inactive)
[108.480576] Starting subtest: retire-vma-not-inactive
[108.539389] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[108.654168] [028/133] (911s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[108.757093] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[108.759307] Starting dynamic subtest: pipe-A-eDP-1
[108.768059] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[108.778397] Starting dynamic subtest: pipe-B-eDP-1
[108.787301] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[108.795764] Starting dynamic subtest: pipe-C-eDP-1
[108.803843] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[108.812188] Starting dynamic subtest: pipe-D-eDP-1
[108.820605] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[108.824864] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[111.024482] [029/133] (909s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[111.117028] Starting subtest: plane-upscale-20x20-with-rotation
[111.119372] Starting dynamic subtest: pipe-A
[111.347387] Dynamic subtest pipe-A: SUCCESS (0.232s)
[111.358233] Starting dynamic subtest: pipe-B
[112.615930] Dynamic subtest pipe-B: SUCCESS (1.268s)
[112.624404] Starting dynamic subtest: pipe-C
[113.941980] Dynamic subtest pipe-C: SUCCESS (1.325s)
[113.950573] Starting dynamic subtest: pipe-D
[115.284040] Dynamic subtest pipe-D: SUCCESS (1.342s)
[115.286481] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.169s)
[116.452161] [030/133] (904s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[116.548969] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[116.551897] Starting dynamic subtest: pipe-A-eDP-1
[116.575586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[116.585713] Starting dynamic subtest: pipe-B-eDP-1
[116.605273] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[116.613671] Starting dynamic subtest: pipe-C-eDP-1
[116.632807] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[116.640918] Starting dynamic subtest: pipe-D-eDP-1
[116.661297] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[116.663602] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s)
[118.934694] [031/133] (901s left) kms_vrr (max-min)
[119.040031] Starting subtest: max-min
[119.046774] Subtest max-min: SKIP (0.000s)
[119.123303] [032/133] (901s left) gem_pxp (create-regular-buffer)
[119.244791] Starting subtest: create-regular-buffer
[119.246721] Subtest create-regular-buffer: SUCCESS (0.000s)
[119.362435] [033/133] (901s left) kms_pm_rpm (modeset-non-lpsp-stress)
[121.119885] Starting subtest: modeset-non-lpsp-stress
[122.274114] Subtest modeset-non-lpsp-stress: SKIP (1.154s)
[122.652140] [034/133] (897s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[122.776182] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[122.780937] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[122.921854] [035/133] (897s left) gem_exec_schedule (u-fairslice-all)
[122.997180] Starting subtest: u-fairslice-all
[125.051591] Subtest u-fairslice-all: SUCCESS (2.061s)
[125.353445] [036/133] (895s left) perf (blocking)
[125.492563] Starting subtest: blocking
[125.494800] Starting dynamic subtest: 0-rcs0
[135.524854] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[135.533972] Starting dynamic subtest: 1-vcs1
[145.549098] Dynamic subtest 1-vcs1: SUCCESS (10.023s)
[145.552132] Subtest blocking: SUCCESS (20.056s)
[145.597549] [037/133] (875s left) kms_cursor_edge_walk (128x128-top-edge)
[145.689639] Starting subtest: 128x128-top-edge
[145.691883] Starting dynamic subtest: pipe-A-eDP-1
[149.179360] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[149.189237] Starting dynamic subtest: pipe-D-eDP-1
[152.317758] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s)
[152.319927] Subtest 128x128-top-edge: SUCCESS (6.629s)
[153.138828] [038/133] (867s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[153.193872] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[153.300425] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[153.387836] [039/133] (867s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[153.486517] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[153.488799] Starting dynamic subtest: pipe-A-eDP-1
[153.573060] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[153.583586] Starting dynamic subtest: pipe-B-eDP-1
[154.705179] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[154.709764] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.222s)
[155.903797] [040/133] (864s left) kms_addfb_basic (unused-pitches)
[155.962864] Starting subtest: unused-pitches
[155.965549] Subtest unused-pitches: SUCCESS (0.000s)
[156.124828] [041/133] (864s left) kms_busy (extended-pageflip-hang-newfb)
[156.230616] Starting subtest: extended-pageflip-hang-newfb
[156.232643] Starting dynamic subtest: pipe-A
[182.713842] Dynamic subtest pipe-A: SUCCESS (26.480s)
[182.723695] Starting dynamic subtest: pipe-D
[197.685309] Dynamic subtest pipe-D: SUCCESS (14.969s)
[197.687715] Subtest extended-pageflip-hang-newfb: SUCCESS (41.454s)
[198.569516] [042/133] (822s left) kms_hdr (static-toggle-dpms)
[198.674434] Starting subtest: static-toggle-dpms
[198.680513] Subtest static-toggle-dpms: SKIP (0.000s)
[198.759087] [043/133] (822s left) gem_mmap_gtt (cpuset-big-copy-odd)
[198.829558] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[198.891776] [044/133] (822s left) gem_exec_whisper (basic-contexts-priority-all)
[198.947553] Starting subtest: basic-contexts-priority-all
[221.661242] Subtest basic-contexts-priority-all: SUCCESS (22.708s)
[221.846531] [045/133] (799s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[221.918657] Starting subtest: basic-batch-kernel-default-cmd
[221.923066] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[222.103771] [046/133] (799s left) kms_color_pipeline (plane-lut1d-lut1d)
[222.207034] Starting subtest: plane-lut1d-lut1d
[222.386194] Starting dynamic subtest: pipe-A-plane-0
[222.775765] Dynamic subtest pipe-A-plane-0: FAIL (0.217s)
[222.786322] Starting dynamic subtest: pipe-A-plane-1
[223.008239] Dynamic subtest pipe-A-plane-1: FAIL (0.179s)
[223.017566] Starting dynamic subtest: pipe-A-plane-2
[223.226227] Dynamic subtest pipe-A-plane-2: FAIL (0.188s)
[224.177580] Starting dynamic subtest: pipe-B-plane-0
[224.623835] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[224.632954] Starting dynamic subtest: pipe-B-plane-1
[224.939040] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[224.948505] Starting dynamic subtest: pipe-B-plane-2
[225.235726] Dynamic subtest pipe-B-plane-2: FAIL (0.189s)
[225.922813] Starting dynamic subtest: pipe-C-plane-0
[226.451239] Dynamic subtest pipe-C-plane-0: FAIL (0.161s)
[226.461052] Starting dynamic subtest: pipe-C-plane-1
[226.846392] Dynamic subtest pipe-C-plane-1: FAIL (0.622s)
[226.855518] Starting dynamic subtest: pipe-C-plane-2
[227.234014] Dynamic subtest pipe-C-plane-2: FAIL (0.176s)
[228.029849] Starting dynamic subtest: pipe-D-plane-0
[228.630941] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[228.641439] Starting dynamic subtest: pipe-D-plane-1
[229.116940] Dynamic subtest pipe-D-plane-1: FAIL (0.642s)
[229.126064] Starting dynamic subtest: pipe-D-plane-2
[229.559829] Dynamic subtest pipe-D-plane-2: FAIL (0.553s)
[229.670876] Subtest plane-lut1d-lut1d: FAIL (7.464s)
[230.488124] [047/133] (790s left) kms_psr (pr-dpms)
[230.590198] Starting subtest: pr-dpms
[230.594562] Subtest pr-dpms: SKIP (0.000s)
[230.678879] [048/133] (790s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[230.797041] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[230.801069] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[230.908544] [049/133] (790s left) kms_rotation_crc (sprite-rotation-270)
[231.000283] Starting subtest: sprite-rotation-270
[231.004339] Subtest sprite-rotation-270: SKIP (0.001s)
[231.078918] [050/133] (790s left) kms_plane_multiple (tiling-y)
[231.169633] Starting subtest: tiling-y
[231.173729] Subtest tiling-y: SKIP (0.000s)
[231.242048] [051/133] (790s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[231.352021] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[232.187709] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s)
[232.357088] [052/133] (789s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[232.461096] Starting subtest: 2x-flip-vs-modeset-vs-hang
[232.470569] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[232.551173] [053/133] (788s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[232.658328] Starting subtest: 4-tiled-64bpp-rotate-90
[232.684306] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.022s)
[232.801805] [054/133] (788s left) gem_lmem_swapping (heavy-verify-random-ccs)
[232.853675] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[232.902603] [055/133] (788s left) kms_psr (fbc-psr-cursor-plane-move)
[232.996289] Starting subtest: fbc-psr-cursor-plane-move
[232.998614] Starting dynamic subtest: eDP-1
[233.002780] Dynamic subtest eDP-1: SKIP (0.000s)
[233.007029] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[233.073426] [056/133] (788s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[233.136420] Starting subtest: yf-tiled-ccs-to-yf-tiled
[233.140228] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[233.332188] [057/133] (788s left) kms_getfb (getfb2-handle-closed)
[233.444368] Starting subtest: getfb2-handle-closed
[233.446800] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[233.558391] [058/133] (788s left) gem_ctx_persistence (legacy-engines-queued)
[233.627974] Starting subtest: legacy-engines-queued
[233.630334] Starting dynamic subtest: render
[233.705414] Dynamic subtest render: SUCCESS (0.077s)
[233.717404] Starting dynamic subtest: bsd1
[234.872149] Dynamic subtest bsd1: SUCCESS (1.162s)
[234.885349] Starting dynamic subtest: bsd2
[236.853528] Dynamic subtest bsd2: SUCCESS (1.977s)
[236.865931] Starting dynamic subtest: blt
[236.900646] Dynamic subtest blt: SUCCESS (0.046s)
[236.911249] Starting dynamic subtest: vebox
[238.901458] Dynamic subtest vebox: SUCCESS (1.997s)
[238.904588] Subtest legacy-engines-queued: SUCCESS (5.273s)
[239.027406] [059/133] (782s left) kms_flip (2x-flip-vs-dpms-on-nop)
[239.134056] Starting subtest: 2x-flip-vs-dpms-on-nop
[239.143277] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[239.224565] [060/133] (782s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[239.326403] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[239.330909] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[239.426058] [061/133] (782s left) kms_big_fb (x-tiled-addfb)
[239.531457] Starting subtest: x-tiled-addfb
[239.533763] Subtest x-tiled-addfb: SUCCESS (0.000s)
[239.636992] [062/133] (782s left) gem_exec_reloc (basic-gtt-read-active)
[239.699976] Subtest basic-gtt-read-active: SKIP (0.000s)
[239.789385] [063/133] (782s left) kms_content_protection (atomic)
[239.940163] Starting subtest: atomic
[239.943796] Subtest atomic: SKIP (0.000s)
[240.078411] [064/133] (781s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[240.169401] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[240.172843] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[240.267486] [065/133] (781s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[240.380233] Starting subtest: basic-flip-before-cursor-legacy
[241.294928] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.914s)
[242.126612] [066/133] (779s left) gem_exec_fence (expired-history)
[242.603706] Starting subtest: expired-history
[249.612471] Subtest expired-history: SUCCESS (7.010s)
[250.186071] [067/133] (771s left) gem_exec_balancer (individual)
[250.251530] Starting subtest: individual
[251.928581] Subtest individual: SUCCESS (1.675s)
[252.248206] [068/133] (769s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[252.364779] Starting subtest: fbc-psr2-primary-mmap-gtt
[252.366998] Starting dynamic subtest: eDP-1
[252.371053] Dynamic subtest eDP-1: SKIP (0.000s)
[252.375206] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[252.438630] [069/133] (769s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[252.502404] Starting subtest: multi-wait-available-unsubmitted-signaled
[252.504663] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[252.612937] [070/133] (769s left) kms_flip (blocking-absolute-wf_vblank)
[252.701142] Starting subtest: blocking-absolute-wf_vblank
[252.703336] Starting dynamic subtest: A-eDP1
[261.474522] Dynamic subtest A-eDP1: SUCCESS (8.776s)
[261.485519] Starting dynamic subtest: B-eDP1
[270.201615] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[270.216208] Starting dynamic subtest: C-eDP1
[278.916991] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[278.931555] Starting dynamic subtest: D-eDP1
[287.644254] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[287.649791] Subtest blocking-absolute-wf_vblank: SUCCESS (34.949s)
[288.869144] [071/133] (733s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[288.926764] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[289.035499] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[289.111559] [072/133] (733s left) kms_psr (psr2-sprite-render)
[289.197100] Starting subtest: psr2-sprite-render
[289.199309] Starting dynamic subtest: eDP-1
[290.969378] Dynamic subtest eDP-1: SUCCESS (1.770s)
[290.971952] Subtest psr2-sprite-render: SUCCESS (1.771s)
[291.852765] [073/133] (730s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[291.941768] Starting subtest: fbc-rgb101010-draw-render
[296.548997] Subtest fbc-rgb101010-draw-render: SUCCESS (4.610s)
[297.723998] [074/133] (724s left) i915_pm_rps (waitboost)
[297.786329] Starting subtest: waitboost
[303.887193] Subtest waitboost: SUCCESS (6.086s)
[304.015264] [075/133] (718s left) gem_exec_schedule (preempt-other-chain)
[304.099658] Starting subtest: preempt-other-chain
[304.102097] Starting dynamic subtest: rcs0
[304.229538] Dynamic subtest rcs0: SUCCESS (0.139s)
[304.243255] Starting dynamic subtest: bcs0
[304.361855] Dynamic subtest bcs0: SUCCESS (0.132s)
[304.373329] Starting dynamic subtest: vcs0
[304.502633] Dynamic subtest vcs0: SUCCESS (0.140s)
[304.516202] Starting dynamic subtest: vcs1
[304.634419] Dynamic subtest vcs1: SUCCESS (0.131s)
[304.645494] Starting dynamic subtest: vecs0
[304.769804] Dynamic subtest vecs0: SUCCESS (0.135s)
[304.784674] Starting dynamic subtest: ccs0
[304.908098] Dynamic subtest ccs0: SUCCESS (0.138s)
[304.910566] Subtest preempt-other-chain: SUCCESS (0.819s)
[305.956672] [076/133] (716s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[306.076037] Starting subtest: flip-vs-cursor-crc-legacy
[306.735450] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.657s)
[307.543382] [077/133] (715s left) kms_draw_crc (draw-method-blt)
[307.640157] Starting subtest: draw-method-blt
[307.642071] Starting dynamic subtest: xrgb8888-untiled
[307.871233] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[307.880759] Starting dynamic subtest: rgb565-untiled
[308.093631] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[308.103218] Starting dynamic subtest: xrgb2101010-untiled
[308.304510] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.209s)
[308.313662] Starting dynamic subtest: xbgr16161616f-untiled
[308.537477] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[308.552192] Starting dynamic subtest: xrgb8888-xtiled
[308.661058] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[308.669872] Starting dynamic subtest: rgb565-xtiled
[308.770699] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[308.779622] Starting dynamic subtest: xrgb2101010-xtiled
[308.882081] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[308.890933] Starting dynamic subtest: xbgr16161616f-xtiled
[308.993091] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[309.004331] Starting dynamic subtest: xrgb8888-4tiled
[309.115603] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.120s)
[309.128908] Starting dynamic subtest: rgb565-4tiled
[309.226627] Dynamic subtest rgb565-4tiled: SUCCESS (0.109s)
[309.237890] Starting dynamic subtest: xrgb2101010-4tiled
[309.337616] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.109s)
[309.349967] Starting dynamic subtest: xbgr16161616f-4tiled
[309.460716] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s)
[309.462688] Subtest draw-method-blt: SUCCESS (1.823s)
[309.587711] [078/133] (713s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[309.700862] Starting subtest: y-tiled-32bpp-rotate-180
[309.704619] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[309.817483] [079/133] (712s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[309.911272] Starting subtest: bad-aux-stride-y-tiled-ccs
[309.913140] Starting dynamic subtest: pipe-A-eDP-1
[309.931537] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[309.941815] Starting dynamic subtest: pipe-B-eDP-1
[309.958732] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[309.966712] Starting dynamic subtest: pipe-C-eDP-1
[309.985312] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[309.993422] Starting dynamic subtest: pipe-D-eDP-1
[310.011840] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[310.015432] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[312.206737] [080/133] (710s left) template (b)
[312.261501] Starting subtest: B
[312.263745] Subtest B: SUCCESS (0.000s)
[312.351807] [081/133] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[312.446584] Starting subtest: psr-1p-primscrn-cur-indfb-move
[319.829385] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.385s)
[319.954538] [082/133] (702s left) kms_dp_link_training (non-uhbr-mst)
[320.062217] Starting subtest: non-uhbr-mst
[320.071028] Subtest non-uhbr-mst: SKIP (0.000s)
[320.134465] [083/133] (702s left) perf (polling)
[320.217223] Starting subtest: polling
[320.219550] Starting dynamic subtest: 0-rcs0
[330.233339] Dynamic subtest 0-rcs0: SUCCESS (10.017s)
[330.243454] Starting dynamic subtest: 1-vcs0
[340.252967] Dynamic subtest 1-vcs0: SUCCESS (10.018s)
[340.255922] Subtest polling: SUCCESS (20.038s)
[340.310764] [084/133] (682s left) gem_ccs (block-copy-compressed)
[340.379730] Starting subtest: block-copy-compressed
[340.384300] Subtest block-copy-compressed: SKIP (0.000s)
[340.483754] [085/133] (682s left) gem_exec_params (invalid-bsd2-flag-on-render)
[340.543872] Starting subtest: invalid-bsd2-flag-on-render
[340.546340] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[340.646646] [086/133] (682s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[340.751145] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[340.844092] [087/133] (682s left) gem_exec_reloc (basic-cpu-read)
[340.902781] Subtest basic-cpu-read: SKIP (0.000s)
[340.976764] [088/133] (682s left) kms_chamelium_color (ctm-negative)
[341.067625] Subtest ctm-negative: SKIP (0.000s)
[341.115697] [089/133] (681s left) kms_rmfb (close-fd)
[341.199354] Starting subtest: close-fd
[341.201327] Starting dynamic subtest: pipe-A-eDP-1
[341.306897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[341.317271] Starting dynamic subtest: pipe-B-eDP-1
[342.500395] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.193s)
[342.510568] Starting dynamic subtest: pipe-C-eDP-1
[343.621422] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[343.632099] Starting dynamic subtest: pipe-D-eDP-1
[344.762771] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[344.765090] Subtest close-fd: SUCCESS (3.564s)
[345.883940] [090/133] (677s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[345.981417] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[345.985599] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[346.103619] [091/133] (677s left) gem_flink_race (flink_name)
[346.143295] Starting subtest: flink_name
[351.529297] Subtest flink_name: SUCCESS (5.386s)
[351.642577] [092/133] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[351.753440] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[358.676081] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.923s)
[358.826836] [093/133] (664s left) gem_ringfill (basic-all)
[364.892524] Starting subtest: basic-all
[366.056450] Subtest basic-all: SUCCESS (1.163s)
[366.199880] [094/133] (657s left) i915_pm_rps (basic-api)
[366.267381] Starting subtest: basic-api
[366.271656] Subtest basic-api: SKIP (0.001s)
[366.373009] [095/133] (656s left) gem_wait (write-wait)
[366.430845] Starting subtest: write-wait
[366.433220] Starting dynamic subtest: all-engines
[367.558154] Dynamic subtest all-engines: SUCCESS (1.127s)
[367.575957] Starting dynamic subtest: rcs0
[368.614472] Dynamic subtest rcs0: SUCCESS (1.054s)
[368.630931] Starting dynamic subtest: bcs0
[369.670336] Dynamic subtest bcs0: SUCCESS (1.054s)
[369.686867] Starting dynamic subtest: vcs0
[370.723387] Dynamic subtest vcs0: SUCCESS (1.050s)
[370.738715] Starting dynamic subtest: vcs1
[371.779460] Dynamic subtest vcs1: SUCCESS (1.054s)
[371.795106] Starting dynamic subtest: vecs0
[372.835475] Dynamic subtest vecs0: SUCCESS (1.054s)
[372.852047] Starting dynamic subtest: ccs0
[373.893339] Dynamic subtest ccs0: SUCCESS (1.056s)
[373.896124] Subtest write-wait: SUCCESS (7.463s)
[374.094830] [096/133] (649s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[374.199703] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[377.877496] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.682s)
[379.027750] [097/133] (644s left) gem_ctx_shared (detached-shared-gtt)
[379.086945] Starting subtest: detached-shared-gtt
[381.237420] Subtest detached-shared-gtt: SUCCESS (2.151s)
[381.635839] [098/133] (641s left) gem_linear_blits (basic)
[382.033518] Starting subtest: basic
[382.036454] Subtest basic: SUCCESS (0.008s)
[382.204104] [099/133] (641s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[382.371304] Starting subtest: short-flip-before-cursor-atomic-transitions
[383.365563] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.995s)
[384.229337] [100/133] (639s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[384.618932] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[385.438603] [101/133] (638s left) gem_exec_gttfill (engines)
[385.518447] Starting subtest: engines
[385.520439] Starting dynamic subtest: rcs0
[408.087724] Dynamic subtest rcs0: SUCCESS (22.570s)
[408.099932] Starting dynamic subtest: bcs0
[431.363800] Dynamic subtest bcs0: SUCCESS (23.273s)
[431.376290] Starting dynamic subtest: vcs0
[454.621434] Dynamic subtest vcs0: SUCCESS (23.255s)
[454.630995] Starting dynamic subtest: vcs1
[477.895301] Dynamic subtest vcs1: SUCCESS (23.271s)
[477.907895] Starting dynamic subtest: vecs0
[501.177930] Dynamic subtest vecs0: SUCCESS (23.279s)
[501.188855] Starting dynamic subtest: ccs0
[524.513635] Dynamic subtest ccs0: SUCCESS (23.332s)
[524.516688] Subtest engines: SUCCESS (138.995s)
[524.719393] [102/133] (498s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[524.863207] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[524.867681] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[524.978224] [103/133] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[525.083497] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[525.087575] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[525.197142] [104/133] (498s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[525.287226] Starting subtest: 2x-flip-vs-rmfb-interruptible
[525.297946] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[525.375681] [105/133] (498s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[525.468579] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[525.473085] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[525.566754] [106/133] (498s left) core_getversion (all-cards)
[525.611436] Starting subtest: all-cards
[525.628523] Subtest all-cards: SUCCESS (0.023s)
[525.672958] [107/133] (498s left) gem_ctx_exec (basic-nohangcheck)
[525.734832] Starting subtest: basic-nohangcheck
[525.975401] Subtest basic-nohangcheck: SUCCESS (0.242s)
[526.103419] [108/133] (497s left) kms_psr (fbc-pr-no-drrs)
[526.207849] Starting subtest: fbc-pr-no-drrs
[526.211657] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[526.280757] [109/133] (497s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[526.341084] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[526.403033] [110/133] (497s left) i915_drm_fdinfo (most-busy-check-all)
[526.441551] Starting subtest: most-busy-check-all
[526.443820] Starting dynamic subtest: rcs0
[526.448126] Dynamic subtest rcs0: SKIP (0.004s)
[526.459453] Starting dynamic subtest: bcs0
[526.463548] Dynamic subtest bcs0: SKIP (0.000s)
[526.472817] Starting dynamic subtest: vcs0
[526.477222] Dynamic subtest vcs0: SKIP (0.001s)
[526.486389] Starting dynamic subtest: vcs1
[526.490402] Dynamic subtest vcs1: SKIP (0.001s)
[526.498880] Starting dynamic subtest: vecs0
[526.502971] Dynamic subtest vecs0: SKIP (0.001s)
[526.511473] Starting dynamic subtest: ccs0
[526.515583] Dynamic subtest ccs0: SKIP (0.000s)
[526.519674] Subtest most-busy-check-all: SKIP (0.014s)
[526.559428] [111/133] (497s left) gen3_render_tiledy_blits
[526.706075] [112/133] (497s left) gem_softpin (evict-active)
[526.769728] Starting subtest: evict-active
[526.775064] Subtest evict-active: SUCCESS (0.005s)
[526.882208] [113/133] (497s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[526.966391] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[526.970043] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[527.070196] [114/133] (497s left) gem_exec_params (invalid-bsd1-flag-on-render)
[527.133229] Starting subtest: invalid-bsd1-flag-on-render
[527.135292] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[527.247673] [115/133] (496s left) kms_atomic (crtc-invalid-params)
[527.346058] Starting subtest: crtc-invalid-params
[527.347940] Starting dynamic subtest: pipe-A-eDP-1
[527.723771] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s)
[527.725879] Subtest crtc-invalid-params: SUCCESS (0.377s)
[528.570042] [116/133] (495s left) gem_exec_fence (parallel)
[528.749030] Starting subtest: parallel
[528.751391] Starting dynamic subtest: rcs0
[530.902062] Dynamic subtest rcs0: SUCCESS (2.153s)
[530.912077] Starting dynamic subtest: bcs0
[533.062308] Dynamic subtest bcs0: SUCCESS (2.159s)
[533.072706] Starting dynamic subtest: vcs0
[535.211351] Dynamic subtest vcs0: SUCCESS (2.149s)
[535.222057] Starting dynamic subtest: vcs1
[537.360918] Dynamic subtest vcs1: SUCCESS (2.149s)
[537.371902] Starting dynamic subtest: vecs0
[539.515078] Dynamic subtest vecs0: SUCCESS (2.153s)
[539.526092] Starting dynamic subtest: ccs0
[541.671333] Dynamic subtest ccs0: SUCCESS (2.155s)
[541.673397] Subtest parallel: SUCCESS (12.922s)
[543.993214] [117/133] (480s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[544.100202] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[545.200301] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.521s)
[545.241629] [118/133] (479s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[545.336690] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[545.340939] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[545.430037] [119/133] (478s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[545.529485] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[545.533059] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[545.624465] [120/133] (478s left) kms_cursor_crc (cursor-onscreen-512x512)
[545.893137] Starting subtest: cursor-onscreen-512x512
[545.897060] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[546.047264] [121/133] (478s left) gem_ctx_engines (execute-allforone)
[546.106761] Starting subtest: execute-allforone
[546.120494] Subtest execute-allforone: SUCCESS (0.014s)
[548.010077] [122/133] (476s left) gen9_exec_parse (bb-start-far)
[548.070697] Subtest bb-start-far: SKIP (0.000s)
[548.143712] [123/133] (476s left) gem_exec_fence (basic-busy-all)
[548.202955] Starting subtest: basic-busy-all
[548.294760] Subtest basic-busy-all: SUCCESS (0.093s)
[549.995258] [124/133] (474s left) gem_caching (read-writes)
[550.053321] Subtest read-writes: SKIP (0.000s)
[550.127433] [125/133] (474s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[550.179057] Starting subtest: single-wait-all-for-submit-available-signaled
[550.181282] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[550.278720] [126/133] (474s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[550.391322] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[550.395225] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[550.490692] [127/133] (474s left) gem_mmap_offset (bad-flags)
[550.552075] Starting subtest: bad-flags
[550.554419] Subtest bad-flags: SUCCESS (0.000s)
[550.652881] [128/133] (474s left) kms_vblank (invalid)
[550.751272] Starting subtest: invalid
[550.753195] Starting dynamic subtest: pipe-A-eDP-1
[551.160517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[551.162782] Subtest invalid: SUCCESS (0.410s)
[552.005390] [129/133] (472s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[552.109481] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[552.111878] Starting dynamic subtest: pipe-A-eDP-1
[552.136396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[552.148744] Starting dynamic subtest: pipe-B-eDP-1
[552.169305] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[552.180121] Starting dynamic subtest: pipe-C-eDP-1
[552.198647] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[552.207629] Starting dynamic subtest: pipe-D-eDP-1
[552.227038] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[552.228970] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[554.358983] [130/133] (470s left) syncobj_wait (invalid-signal-one-illegal-handle)
[554.426100] Starting subtest: invalid-signal-one-illegal-handle
[554.428383] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[554.528250] [131/133] (470s left) api_intel_bb (simple-bb-ctx)
[554.593839] Starting subtest: simple-bb-ctx
[554.601408] Subtest simple-bb-ctx: SUCCESS (0.007s)
[554.718740] [132/133] (470s left) kms_chamelium_color (gamma)
[554.820154] Subtest gamma: SKIP (0.000s)
[554.868469] [133/133] (470s left) gem_ctx_param (set-priority-not-supported)
[554.924747] Starting subtest: set-priority-not-supported
[554.928959] Subtest set-priority-not-supported: SKIP (0.000s)
[555.003230] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: kms_plane_alpha_blend
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: sysfs_heartbeat_interval
results: parsing output: 11/ for test: kms_vrr
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_pm_dc
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: prime_vgem
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: gem_request_retire
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_vrr
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: kms_cursor_edge_walk
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: kms_hdr
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: gem_exec_flush
results: parsing output: 45/ for test: kms_color_pipeline
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_plane_multiple
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_lmem_swapping
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: kms_getfb
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_draw_crc
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: template
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_dp_link_training
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: gem_ccs
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_chamelium_color
results: parsing output: 88/ for test: kms_rmfb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_flink_race
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_ringfill
results: parsing output: 93/ for test: i915_pm_rps
results: parsing output: 94/ for test: gem_wait
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ctx_shared
results: parsing output: 97/ for test: gem_linear_blits
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: gem_exec_gttfill
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: core_getversion
results: parsing output: 106/ for test: gem_ctx_exec
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_pipe_b_c_ivb
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: gen3_render_tiledy_blits
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_atomic
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_ctx_engines
results: parsing output: 121/ for test: gen9_exec_parse
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_caching
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_mmap_offset
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: kms_chamelium_color
results: parsing output: 132/ for test: gem_ctx_param
Done.