[59.032611] Initializing watchdogs
[59.032658]   /dev/watchdog0
[59.046820] [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]
[59.051099] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.053916] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.057177] [001/133] (960s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[59.187100] Starting subtest: psr-indfb-scaledprimary
[64.937982] Subtest psr-indfb-scaledprimary: SUCCESS (5.748s)
[65.065132] [002/133] (954s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[65.175604] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[65.179988] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[65.273445] [003/133] (954s left) syncobj_timeline (single-wait-available-submitted)
[65.330806] Starting subtest: single-wait-available-submitted
[65.333153] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[65.416887] [004/133] (954s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[65.500808] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[65.527049] Starting dynamic subtest: pipe-A-plane-0
[66.149171] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[66.157945] Starting dynamic subtest: pipe-A-plane-3
[66.572468] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[67.639663] Starting dynamic subtest: pipe-B-plane-0
[68.354909] Dynamic subtest pipe-B-plane-0: SUCCESS (0.722s)
[68.363383] Starting dynamic subtest: pipe-B-plane-3
[68.776886] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s)
[69.086661] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.585s)
[69.916449] [005/133] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[70.024826] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[76.879094] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.856s)
[77.027757] [006/133] (942s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[77.162048] Starting subtest: flip-vs-cursor-busy-crc-atomic
[78.006138] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.844s)
[78.890231] [007/133] (940s left) kms_addfb_basic (tile-pitch-mismatch)
[78.941743] Starting subtest: tile-pitch-mismatch
[78.945897] Subtest tile-pitch-mismatch: SKIP (0.000s)
[79.081079] [008/133] (940s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[79.168736] Starting subtest: fbc-psr2-sprite-plane-onoff
[79.170969] Starting dynamic subtest: eDP-1
[79.175111] Dynamic subtest eDP-1: SKIP (0.000s)
[79.179198] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[79.235152] [009/133] (940s left) kms_pm_rpm (basic-pci-d3-state)
[81.075433] Starting subtest: basic-pci-d3-state
[82.544904] Subtest basic-pci-d3-state: SUCCESS (1.473s)
[82.660193] [010/133] (937s left) gem_basic (create-fd-close)
[82.715450] Starting subtest: create-fd-close
[82.719470] Subtest create-fd-close: SUCCESS (0.000s)
[82.819173] [011/133] (937s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[82.906495] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[82.916999] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[82.993701] [012/133] (936s left) gen9_exec_parse (basic-rejected)
[83.057835] Subtest basic-rejected: SKIP (0.000s)
[83.135109] [013/133] (936s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[83.191077] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[83.299381] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s)
[83.380694] [014/133] (936s left) gem_fenced_exec_thrash (no-spare-fences)
[83.442932] Subtest no-spare-fences: SKIP (0.000s)
[83.518050] [015/133] (936s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[83.598458] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[83.600790] Starting dynamic subtest: pipe-A-eDP-1
[83.624059] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.633614] Starting dynamic subtest: pipe-B-eDP-1
[83.655142] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.662074] Starting dynamic subtest: pipe-C-eDP-1
[83.682478] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.689275] Starting dynamic subtest: pipe-D-eDP-1
[83.710761] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.715153] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[85.782496] [016/133] (934s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[85.838103] Starting subtest: wait-all-for-submit-delayed-submit
[85.941362] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[86.024790] [017/133] (934s left) perf (gen12-group-exclusive-stream-ctx-handle)
[86.156532] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[86.182054] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.024s)
[86.228172] [018/133] (933s left) kms_scaling_modes (scaling-mode-full)
[87.901832] Starting subtest: scaling-mode-full
[87.904416] Starting dynamic subtest: pipe-A-eDP-1
[87.993896] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[88.005581] Starting dynamic subtest: pipe-B-eDP-1
[89.204129] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.209s)
[89.213324] Starting dynamic subtest: pipe-C-eDP-1
[90.325676] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[90.336619] Starting dynamic subtest: pipe-D-eDP-1
[91.454088] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[91.456497] Subtest scaling-mode-full: SUCCESS (3.554s)
[92.611744] [019/133] (927s left) gem_exec_schedule (preempt-queue-contexts-chain)
[92.690096] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[92.989121] [020/133] (927s left) kms_lease (simple-lease)
[93.091712] Starting subtest: simple-lease
[93.094083] Starting dynamic subtest: pipe-A-eDP-1
[93.609745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.517s)
[93.617420] Starting dynamic subtest: pipe-B-eDP-1
[95.065658] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.453s)
[95.074644] Starting dynamic subtest: pipe-C-eDP-1
[96.459475] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[96.467993] Starting dynamic subtest: pipe-D-eDP-1
[97.860500] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.399s)
[97.862768] Subtest simple-lease: SUCCESS (4.768s)
[98.663286] [021/133] (921s left) i915_query (query-regions-sanity-check)
[98.715900] Starting subtest: query-regions-sanity-check
[98.725070] Subtest query-regions-sanity-check: SUCCESS (0.011s)
[98.837083] [022/133] (921s left) kms_invalid_mode (bad-hsync-start)
[98.935287] Starting subtest: bad-hsync-start
[98.939606] Starting dynamic subtest: pipe-A-eDP-1
[99.232817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[99.242073] Starting dynamic subtest: pipe-B-eDP-1
[99.244188] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[99.251570] Starting dynamic subtest: pipe-C-eDP-1
[99.253769] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[99.261145] Starting dynamic subtest: pipe-D-eDP-1
[99.263347] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[99.265479] Subtest bad-hsync-start: SUCCESS (0.309s)
[100.097870] [023/133] (920s left) kms_flip (flip-vs-panning)
[100.185989] Starting subtest: flip-vs-panning
[100.188432] Starting dynamic subtest: A-eDP1
[108.921924] Dynamic subtest A-eDP1: SUCCESS (8.737s)
[108.931948] Starting dynamic subtest: B-eDP1
[117.644500] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[117.653864] Starting dynamic subtest: C-eDP1
[126.362779] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[126.370234] Starting dynamic subtest: D-eDP1
[135.093800] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[135.097966] Subtest flip-vs-panning: SUCCESS (34.914s)
[136.253049] [024/133] (884s left) kms_plane_scaling (intel-max-src-size)
[136.332801] Starting subtest: intel-max-src-size
[136.339655] Subtest intel-max-src-size: SKIP (0.000s)
[136.440548] [025/133] (884s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[136.532065] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[136.536427] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[136.610870] [026/133] (883s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[136.711244] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[136.715545] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[136.800486] [027/133] (883s left) kms_flip (basic-flip-vs-dpms)
[136.897046] Starting subtest: basic-flip-vs-dpms
[136.899423] Starting dynamic subtest: A-eDP1
[139.457863] Dynamic subtest A-eDP1: SUCCESS (2.560s)
[139.468927] Starting dynamic subtest: B-eDP1
[141.624765] Dynamic subtest B-eDP1: SUCCESS (2.166s)
[141.632816] Starting dynamic subtest: C-eDP1
[143.715029] Dynamic subtest C-eDP1: SUCCESS (2.087s)
[143.722673] Starting dynamic subtest: D-eDP1
[145.819063] Dynamic subtest D-eDP1: SUCCESS (2.105s)
[145.824088] Subtest basic-flip-vs-dpms: SUCCESS (8.931s)
[146.686672] [028/133] (873s left) kms_plane_lowres (tiling-x)
[146.791520] Starting subtest: tiling-x
[146.793780] Starting dynamic subtest: pipe-A-eDP-1
[146.798211] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.089194] Starting dynamic subtest: pipe-B-eDP-1
[147.093659] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.101258] Starting dynamic subtest: pipe-C-eDP-1
[147.105863] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.113376] Starting dynamic subtest: pipe-D-eDP-1
[147.117926] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.122236] Subtest tiling-x: SKIP (0.296s)
[147.912037] [029/133] (872s left) kms_content_protection (dp-mst-type-1)
[148.062484] Starting subtest: dp-mst-type-1
[148.066835] Subtest dp-mst-type-1: SKIP (0.000s)
[148.182826] [030/133] (872s left) sysfs_timeslice_duration (timeout)
[148.243956] Starting subtest: timeout
[148.246331] Starting dynamic subtest: vecs0
[157.906446] Dynamic subtest vecs0: SUCCESS (9.659s)
[157.916584] Starting dynamic subtest: ccs0
[159.192911] Dynamic subtest ccs0: SUCCESS (1.285s)
[159.203378] Starting dynamic subtest: vcs0
[168.915487] Dynamic subtest vcs0: SUCCESS (9.720s)
[168.924849] Starting dynamic subtest: bcs0
[169.559821] Dynamic subtest bcs0: SUCCESS (0.645s)
[169.573056] Starting dynamic subtest: rcs0
[170.787872] Dynamic subtest rcs0: SUCCESS (1.226s)
[170.798959] Starting dynamic subtest: vcs1
[179.926569] Dynamic subtest vcs1: SUCCESS (9.135s)
[179.929031] Subtest timeout: SUCCESS (31.679s)
[179.994755] [031/133] (840s left) prime_self_import (basic-llseek-size)
[180.032453] Starting subtest: basic-llseek-size
[180.054546] Subtest basic-llseek-size: SUCCESS (0.024s)
[180.181317] [032/133] (840s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[180.311326] Starting subtest: flip-vs-cursor-crc-atomic
[181.006920] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.697s)
[181.834117] [033/133] (838s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[181.929168] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[181.931500] Starting dynamic subtest: pipe-A-default-mode
[183.115596] Dynamic subtest pipe-A-default-mode: SKIP (1.183s)
[183.119964] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.185s)
[183.243716] [034/133] (837s left) drm_read (empty-nonblock)
[183.387539] Starting subtest: empty-nonblock
[183.390580] Subtest empty-nonblock: SUCCESS (0.000s)
[183.597957] [035/133] (837s left) kms_psr (fbc-pr-basic)
[183.694809] Starting subtest: fbc-pr-basic
[183.699171] Subtest fbc-pr-basic: SKIP (0.000s)
[183.761630] [036/133] (837s left) core_getclient (basic)
[183.821701] Starting subtest: basic
[183.823826] Subtest basic: SUCCESS (0.000s)
[183.923847] [037/133] (836s left) kms_flip (dpms-vs-vblank-race)
[184.004970] Starting subtest: dpms-vs-vblank-race
[184.007091] Starting dynamic subtest: A-eDP1
[189.150637] Dynamic subtest A-eDP1: SUCCESS (5.142s)
[189.159262] Starting dynamic subtest: B-eDP1
[193.773198] Dynamic subtest B-eDP1: SUCCESS (4.621s)
[193.781898] Starting dynamic subtest: C-eDP1
[198.395725] Dynamic subtest C-eDP1: SUCCESS (4.622s)
[198.403733] Starting dynamic subtest: D-eDP1
[203.030505] Dynamic subtest D-eDP1: SUCCESS (4.631s)
[203.035566] Subtest dpms-vs-vblank-race: SUCCESS (19.029s)
[203.906231] [038/133] (817s left) kms_cursor_crc (cursor-sliding-256x256)
[204.140798] Starting subtest: cursor-sliding-256x256
[204.145889] Starting dynamic subtest: pipe-A-eDP-1
[210.260727] Dynamic subtest pipe-A-eDP-1: FAIL (5.621s)
[210.271066] Starting dynamic subtest: pipe-D-eDP-1
[217.597458] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.799s)
[217.599301] Subtest cursor-sliding-256x256: FAIL (13.454s)
[219.238661] [039/133] (801s left) perf_pmu (most-busy-check-all)
[219.282897] Starting subtest: most-busy-check-all
[219.285463] Starting dynamic subtest: rcs0
[220.887617] Dynamic subtest rcs0: SUCCESS (1.603s)
[220.898186] Starting dynamic subtest: bcs0
[222.871767] Dynamic subtest bcs0: SUCCESS (1.981s)
[222.882958] Starting dynamic subtest: vcs0
[224.919530] Dynamic subtest vcs0: SUCCESS (2.045s)
[224.931326] Starting dynamic subtest: vcs1
[226.902978] Dynamic subtest vcs1: SUCCESS (1.980s)
[226.914381] Starting dynamic subtest: vecs0
[228.886838] Dynamic subtest vecs0: SUCCESS (1.981s)
[228.898259] Starting dynamic subtest: ccs0
[230.936291] Dynamic subtest ccs0: SUCCESS (2.046s)
[230.939157] Subtest most-busy-check-all: SUCCESS (11.654s)
[231.048671] [040/133] (789s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[231.136232] Starting subtest: primary-y-tiled-reflect-x-270
[231.140699] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[231.212094] [041/133] (789s left) gem_ccs (block-multicopy-compressed)
[231.273136] Starting subtest: block-multicopy-compressed
[231.277328] Subtest block-multicopy-compressed: SKIP (0.000s)
[231.374644] [042/133] (789s left) gem_ringfill (engines-basic)
[236.891205] Starting subtest: engines-basic
[236.893789] Starting dynamic subtest: rcs0
[236.949358] Dynamic subtest rcs0: SUCCESS (0.058s)
[236.963107] Starting dynamic subtest: bcs0
[236.992882] Dynamic subtest bcs0: SUCCESS (0.042s)
[237.002514] Starting dynamic subtest: vcs0
[237.035091] Dynamic subtest vcs0: SUCCESS (0.040s)
[237.044501] Starting dynamic subtest: vcs1
[237.078261] Dynamic subtest vcs1: SUCCESS (0.041s)
[237.088272] Starting dynamic subtest: vecs0
[237.120846] Dynamic subtest vecs0: SUCCESS (0.041s)
[237.130571] Starting dynamic subtest: ccs0
[237.164968] Dynamic subtest ccs0: SUCCESS (0.042s)
[237.167907] Subtest engines-basic: SUCCESS (0.276s)
[237.245524] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[237.249185] [043/133] (783s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[237.347869] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[237.352370] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[238.470849] [044/133] (782s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[238.536457] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[238.643225] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[238.730736] [045/133] (782s left) gem_exec_whisper (basic-contexts-forked)
[238.812829] Starting subtest: basic-contexts-forked
[262.606813] Subtest basic-contexts-forked: SUCCESS (23.789s)
[262.802452] [046/133] (758s left) gen3_render_mixed_blits
[262.937198] [047/133] (758s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[263.034071] Starting subtest: plane-upscale-20x20-with-pixel-format
[263.036369] Starting dynamic subtest: pipe-A
[264.139774] Dynamic subtest pipe-A: SUCCESS (1.108s)
[264.148616] Starting dynamic subtest: pipe-B
[266.277845] Dynamic subtest pipe-B: SUCCESS (2.137s)
[266.288660] Starting dynamic subtest: pipe-C
[267.476024] Dynamic subtest pipe-C: SUCCESS (1.197s)
[267.485393] Starting dynamic subtest: pipe-D
[268.630248] Dynamic subtest pipe-D: SUCCESS (1.153s)
[268.632583] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.599s)
[269.823069] [048/133] (751s left) gem_mmap_gtt (cpuset-medium-copy)
[269.882527] Subtest cpuset-medium-copy: SKIP (0.000s)
[269.958972] [049/133] (751s left) prime_busy (hang-wait)
[270.029497] Starting subtest: hang-wait
[270.031793] Starting dynamic subtest: rcs0
[297.398059] Dynamic subtest rcs0: SUCCESS (27.362s)
[297.415236] Starting dynamic subtest: bcs0
[304.488862] Dynamic subtest bcs0: SUCCESS (7.089s)
[304.498774] Starting dynamic subtest: vcs0
[311.521457] Dynamic subtest vcs0: SUCCESS (7.033s)
[311.532986] Starting dynamic subtest: vcs1
[318.503765] Dynamic subtest vcs1: SUCCESS (6.978s)
[318.511934] Starting dynamic subtest: vecs0
[325.536858] Dynamic subtest vecs0: SUCCESS (7.033s)
[325.547224] Starting dynamic subtest: ccs0
[339.377723] Dynamic subtest ccs0: SUCCESS (13.836s)
[339.379779] Subtest hang-wait: SUCCESS (69.343s)
[339.503202] [050/133] (681s left) kms_hdr (bpc-switch)
[339.598185] Starting subtest: bpc-switch
[340.689249] Starting dynamic subtest: pipe-A-eDP-1
[344.070285] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.382s)
[344.072495] Subtest bpc-switch: SUCCESS (4.471s)
[344.196763] [051/133] (677s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[344.301789] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[344.306196] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[344.408656] [052/133] (677s left) kms_chamelium_color (degamma)
[344.498088] Subtest degamma: SKIP (0.000s)
[344.559327] [053/133] (676s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[344.654610] Starting subtest: pr-plane-move-sf-dmg-area
[344.658638] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[344.729171] [054/133] (676s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[344.826691] Starting subtest: fbc-rgb101010-draw-blt
[349.423067] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.599s)
[350.540190] [055/133] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[350.633763] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[350.638966] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[350.744379] [056/133] (670s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[350.879354] Starting subtest: modeset-atomic-cursor-hotspot
[350.883864] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[351.031083] [057/133] (670s left) kms_getfb (getfb-repeated-different-handles)
[351.134851] Starting subtest: getfb-repeated-different-handles
[351.137187] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[351.245920] [058/133] (670s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[351.352482] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[358.018280] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.668s)
[358.179897] [059/133] (663s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[358.293125] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[365.599854] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.308s)
[365.724779] [060/133] (656s left) gem_exec_fence (syncobj-import)
[366.180400] Starting subtest: syncobj-import
[366.185840] Subtest syncobj-import: SUCCESS (0.005s)
[367.974449] [061/133] (653s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[368.071724] Starting subtest: yf-tiled-16bpp-rotate-90
[368.076183] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[368.180616] [062/133] (653s left) gen7_exec_parse (basic-allowed)
[368.240816] Subtest basic-allowed: SKIP (0.000s)
[368.323543] [063/133] (653s left) gem_eio (hibernate)
[368.518999] Starting subtest: hibernate
[383.215364] Subtest hibernate: SUCCESS (14.696s)
[391.383562] [064/133] (638s left) syncobj_wait (multi-wait-all-submitted)
[391.460516] Starting subtest: multi-wait-all-submitted
[391.561844] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[391.640079] [065/133] (638s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[391.756946] Starting subtest: bad-aux-stride-yf-tiled-ccs
[391.759261] Starting dynamic subtest: pipe-A-eDP-1
[391.781734] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[391.792972] Starting dynamic subtest: pipe-B-eDP-1
[391.815251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[391.824205] Starting dynamic subtest: pipe-C-eDP-1
[391.844890] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[391.854122] Starting dynamic subtest: pipe-D-eDP-1
[391.875613] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[391.879871] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.008s)
[393.993551] [066/133] (636s left) testdisplay
[394.285679] [067/133] (635s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[394.383376] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[395.329964] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.945s)
[395.500506] [068/133] (634s left) kms_universal_plane (disable-primary-vs-flip)
[395.605159] Starting subtest: disable-primary-vs-flip
[395.607209] Starting dynamic subtest: pipe-A-eDP-1
[397.177659] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.569s)
[397.188179] Starting dynamic subtest: pipe-B-eDP-1
[399.441220] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.263s)
[399.451604] Starting dynamic subtest: pipe-C-eDP-1
[401.668493] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.225s)
[401.679214] Starting dynamic subtest: pipe-D-eDP-1
[403.834924] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.168s)
[403.837389] Subtest disable-primary-vs-flip: SUCCESS (8.231s)
[404.633359] [069/133] (625s left) gem_exec_fence (syncobj-timeline-unused-fence)
[405.159840] Starting subtest: syncobj-timeline-unused-fence
[405.163502] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[405.975017] [070/133] (624s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[406.034288] Starting subtest: invalid-single-wait-unsubmitted
[406.036157] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[406.139938] [071/133] (624s left) gem_ctx_persistence (legacy-engines-mixed-process)
[406.202766] Starting subtest: legacy-engines-mixed-process
[406.205125] Starting dynamic subtest: render
[407.904928] Dynamic subtest render: SUCCESS (1.701s)
[407.917103] Starting dynamic subtest: bsd1
[409.892937] Dynamic subtest bsd1: SUCCESS (1.986s)
[409.908156] Starting dynamic subtest: bsd2
[411.861889] Dynamic subtest bsd2: SUCCESS (1.966s)
[411.873818] Starting dynamic subtest: blt
[413.924787] Dynamic subtest blt: SUCCESS (2.058s)
[413.936034] Starting dynamic subtest: vebox
[415.908758] Dynamic subtest vebox: SUCCESS (1.985s)
[415.911173] Subtest legacy-engines-mixed-process: SUCCESS (9.706s)
[415.990292] [072/133] (614s left) kms_psr (psr-cursor-render)
[416.085924] Starting subtest: psr-cursor-render
[416.088187] Starting dynamic subtest: eDP-1
[417.829373] Dynamic subtest eDP-1: SUCCESS (1.742s)
[417.831661] Subtest psr-cursor-render: SUCCESS (1.744s)
[418.692195] [073/133] (611s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[418.746409] Starting subtest: multi-wait-all-for-submit-unsubmitted
[418.850838] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[418.927990] [074/133] (611s left) gem_render_copy (linear-to-vebox-yf-tiled)
[418.979533] Starting subtest: linear-to-vebox-yf-tiled
[418.983786] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[419.177124] [075/133] (611s left) kms_vblank (ts-continuation-modeset)
[419.264965] Starting subtest: ts-continuation-modeset
[419.267138] Starting dynamic subtest: pipe-A-eDP-1
[420.759960] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.495s)
[420.775287] Starting dynamic subtest: pipe-D-eDP-1
[422.930994] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.169s)
[422.933659] Subtest ts-continuation-modeset: SUCCESS (3.668s)
[423.743034] [076/133] (606s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[423.837169] Starting subtest: y-tiled-16bpp-rotate-270
[423.841518] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[423.944955] [077/133] (606s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[424.056782] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[425.081283] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.024s)
[425.196480] [078/133] (605s left) kms_chamelium_color (ctm-negative)
[425.295073] Subtest ctm-negative: SKIP (0.000s)
[425.343076] [079/133] (605s left) gem_create (create-massive)
[425.394681] Starting subtest: create-massive
[425.396344] Subtest create-massive: SUCCESS (0.000s)
[425.580594] [080/133] (605s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[425.637189] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[425.639504] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[425.737392] [081/133] (605s left) gem_fence_thrash (bo-write-verify-y)
[425.783129] Starting subtest: bo-write-verify-y
[425.812276] Subtest bo-write-verify-y: SKIP (0.027s)
[425.887046] [082/133] (604s left) kms_cursor_crc (cursor-size-hints)
[426.026776] Starting subtest: cursor-size-hints
[426.028956] Starting dynamic subtest: pipe-A-eDP-1
[426.633989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[426.645032] Starting dynamic subtest: pipe-D-eDP-1
[427.912096] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.277s)
[427.914367] Subtest cursor-size-hints: SUCCESS (1.887s)
[428.712963] [083/133] (602s left) kms_async_flips (invalid-async-flip-atomic)
[428.796827] Starting subtest: invalid-async-flip-atomic
[429.183320] Starting dynamic subtest: pipe-A-eDP-1
[430.040254] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.858s)
[430.407985] Starting dynamic subtest: pipe-B-eDP-1
[431.181978] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.783s)
[431.536773] Starting dynamic subtest: pipe-C-eDP-1
[432.291110] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s)
[432.645027] Starting dynamic subtest: pipe-D-eDP-1
[433.415305] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[433.417603] Subtest invalid-async-flip-atomic: SUCCESS (4.619s)
[434.569102] [084/133] (596s left) gem_exec_flush (basic-batch-kernel-default-wb)
[434.627044] Starting subtest: basic-batch-kernel-default-wb
[441.993960] Subtest basic-batch-kernel-default-wb: SUCCESS (7.367s)
[442.199860] [085/133] (588s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[442.321594] Starting subtest: basic-flip-after-cursor-varying-size
[443.250806] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.929s)
[444.097702] [086/133] (586s left) i915_pm_rps (basic-api)
[444.159465] Starting subtest: basic-api
[444.164208] Subtest basic-api: SKIP (0.000s)
[444.262444] [087/133] (586s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[444.353477] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[444.357611] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[444.434139] [088/133] (586s left) kms_psr (fbc-pr-primary-page-flip)
[444.527755] Starting subtest: fbc-pr-primary-page-flip
[444.532217] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[444.604507] [089/133] (586s left) kms_draw_crc (draw-method-mmap-cpu)
[444.705937] Starting subtest: draw-method-mmap-cpu
[444.708150] Starting dynamic subtest: xrgb8888-untiled
[444.915803] Dynamic subtest xrgb8888-untiled: SUCCESS (0.211s)
[444.926093] Starting dynamic subtest: rgb565-untiled
[445.126722] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[445.136467] Starting dynamic subtest: xrgb2101010-untiled
[445.340485] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[445.350359] Starting dynamic subtest: xbgr16161616f-untiled
[445.571315] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[445.581374] Starting dynamic subtest: xrgb8888-xtiled
[445.704820] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[445.716749] Starting dynamic subtest: rgb565-xtiled
[445.849050] Dynamic subtest rgb565-xtiled: SUCCESS (0.141s)
[445.858795] Starting dynamic subtest: xrgb2101010-xtiled
[445.971461] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[445.981104] Starting dynamic subtest: xbgr16161616f-xtiled
[446.094425] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[446.108636] Starting dynamic subtest: xrgb8888-4tiled
[446.229291] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.131s)
[446.238375] Starting dynamic subtest: rgb565-4tiled
[446.371422] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s)
[446.381450] Starting dynamic subtest: xrgb2101010-4tiled
[446.504799] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[446.514577] Starting dynamic subtest: xbgr16161616f-4tiled
[446.649293] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[446.651089] Subtest draw-method-mmap-cpu: SUCCESS (1.945s)
[446.758393] [090/133] (584s left) kms_cursor_crc (cursor-onscreen-256x256)
[446.999208] Starting subtest: cursor-onscreen-256x256
[447.006503] Starting dynamic subtest: pipe-A-eDP-1
[449.140777] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.132s)
[449.167944] Starting dynamic subtest: pipe-D-eDP-1
[451.869654] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.711s)
[451.872099] Subtest cursor-onscreen-256x256: SUCCESS (4.870s)
[452.675185] [091/133] (578s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[452.781193] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[452.785192] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[452.873800] [092/133] (578s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[452.980328] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[452.984411] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[453.089749] [093/133] (578s left) i915_drm_fdinfo (busy)
[453.127096] Starting subtest: busy
[453.129410] Starting dynamic subtest: rcs0
[453.158961] Dynamic subtest rcs0: SKIP (0.033s)
[453.171255] Starting dynamic subtest: bcs0
[453.175574] Dynamic subtest bcs0: SKIP (0.000s)
[453.184418] Starting dynamic subtest: vcs0
[453.188840] Dynamic subtest vcs0: SKIP (0.000s)
[453.198039] Starting dynamic subtest: vcs1
[453.202210] Dynamic subtest vcs1: SKIP (0.000s)
[453.211227] Starting dynamic subtest: vecs0
[453.215363] Dynamic subtest vecs0: SKIP (0.000s)
[453.224465] Starting dynamic subtest: ccs0
[453.228743] Dynamic subtest ccs0: SKIP (0.000s)
[453.233099] Subtest busy: SKIP (0.037s)
[453.269400] [094/133] (578s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[453.655733] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[454.490079] [095/133] (576s left) gem_ctx_param (set-priority-not-supported)
[454.547945] Starting subtest: set-priority-not-supported
[454.552739] Subtest set-priority-not-supported: SKIP (0.000s)
[454.617281] [096/133] (576s left) kms_addfb_basic (clobberred-modifier)
[454.681980] Starting subtest: clobberred-modifier
[454.686306] Subtest clobberred-modifier: SKIP (0.000s)
[454.809934] [097/133] (576s left) sw_sync (timeline_closed_signaled)
[454.845713] Starting subtest: timeline_closed_signaled
[454.848108] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[454.910934] [098/133] (576s left) api_intel_allocator (gem-pool)
[454.976610] Starting subtest: gem-pool
[454.984735] Subtest gem-pool: SUCCESS (0.009s)
[455.120038] [099/133] (576s left) gem_spin_batch (resubmit-all)
[455.174038] Starting subtest: resubmit-all
[455.176271] Starting dynamic subtest: rcs0
[455.185674] Dynamic subtest rcs0: SUCCESS (0.012s)
[455.196670] Starting dynamic subtest: bcs0
[455.198902] Dynamic subtest bcs0: SUCCESS (0.002s)
[455.208181] Starting dynamic subtest: vcs0
[455.210337] Dynamic subtest vcs0: SUCCESS (0.002s)
[455.219437] Starting dynamic subtest: vcs1
[455.221620] Dynamic subtest vcs1: SUCCESS (0.002s)
[455.230814] Starting dynamic subtest: vecs0
[455.233043] Dynamic subtest vecs0: SUCCESS (0.002s)
[455.242105] Starting dynamic subtest: ccs0
[455.244257] Dynamic subtest ccs0: SUCCESS (0.002s)
[455.246403] Subtest resubmit-all: SUCCESS (0.025s)
[456.958051] [100/133] (574s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[457.061051] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[457.065185] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[457.151917] [101/133] (574s left) gem_ctx_isolation (nonpriv-switch)
[457.212859] Starting subtest: nonpriv-switch
[457.214973] Starting dynamic subtest: rcs0
[457.475519] Dynamic subtest rcs0: SUCCESS (0.265s)
[457.487149] Starting dynamic subtest: bcs0
[457.787487] Dynamic subtest bcs0: SUCCESS (0.311s)
[457.799256] Starting dynamic subtest: vcs0
[458.066761] Dynamic subtest vcs0: SUCCESS (0.279s)
[458.081724] Starting dynamic subtest: vcs1
[459.163480] Dynamic subtest vcs1: SUCCESS (1.095s)
[459.172937] Starting dynamic subtest: vecs0
[461.200881] Dynamic subtest vecs0: SUCCESS (2.036s)
[461.211426] Starting dynamic subtest: ccs0
[463.208116] Dynamic subtest ccs0: SUCCESS (2.006s)
[463.210358] Subtest nonpriv-switch: SUCCESS (5.998s)
[463.440577] [102/133] (568s left) kms_psr (pr-primary-mmap-cpu)
[463.537166] Starting subtest: pr-primary-mmap-cpu
[463.541709] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[463.608137] [103/133] (568s left) gem_tiled_wc
[463.721990] [104/133] (568s left) kms_big_fb (yf-tiled-addfb)
[463.818687] Starting subtest: yf-tiled-addfb
[463.823259] Subtest yf-tiled-addfb: SKIP (0.000s)
[463.923343] [105/133] (567s left) gem_mmap_gtt (fault-concurrent-y)
[463.994662] Subtest fault-concurrent-Y: SKIP (0.000s)
[464.058725] [106/133] (567s left) i915_module_load (reload-no-display)
[464.095875] Starting subtest: reload-no-display
[468.426598] Subtest reload-no-display: SUCCESS (4.331s)
[468.459218] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[468.459955] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[468.463205] [107/133] (563s left) kms_flip (flip-vs-rmfb)
[469.999765] Starting subtest: flip-vs-rmfb
[470.002215] Starting dynamic subtest: A-eDP1
[478.645730] Dynamic subtest A-eDP1: SUCCESS (8.646s)
[478.655844] Starting dynamic subtest: B-eDP1
[487.286707] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[487.298100] Starting dynamic subtest: C-eDP1
[495.917023] Dynamic subtest C-eDP1: SUCCESS (8.627s)
[495.927713] Starting dynamic subtest: D-eDP1
[504.550950] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[504.555711] Subtest flip-vs-rmfb: SUCCESS (34.559s)
[505.758994] [FACT kms_flip (flip-vs-rmfb)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[505.760223] [FACT kms_flip (flip-vs-rmfb)] new: kernel.kmod_is_loaded.i915: true
[505.763737] [108/133] (526s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[505.866986] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[505.871369] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[505.958851] [109/133] (525s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[506.050290] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[506.054170] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[506.147258] [110/133] (525s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[506.237529] Starting subtest: fbc-farfromfence-mmap-gtt
[506.241646] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[506.337885] [111/133] (525s left) gem_exec_endless (dispatch)
[506.408044] Starting subtest: dispatch
[506.410045] Starting dynamic subtest: rcs0
[506.417903] Dynamic subtest rcs0: SUCCESS (0.010s)
[506.427817] Starting dynamic subtest: bcs0
[506.432314] Dynamic subtest bcs0: SUCCESS (0.005s)
[506.441559] Starting dynamic subtest: vcs0
[506.446111] Dynamic subtest vcs0: SUCCESS (0.004s)
[506.454655] Starting dynamic subtest: vcs1
[506.459050] Dynamic subtest vcs1: SUCCESS (0.004s)
[506.467450] Starting dynamic subtest: vecs0
[506.471695] Dynamic subtest vecs0: SUCCESS (0.004s)
[506.480440] Starting dynamic subtest: ccs0
[506.484678] Dynamic subtest ccs0: SUCCESS (0.004s)
[506.486796] Subtest dispatch: SUCCESS (0.038s)
[507.969368] [112/133] (524s left) gem_mmap_gtt (basic-copy)
[508.036299] Subtest basic-copy: SKIP (0.000s)
[508.100545] [113/133] (524s left) gem_exec_schedule (implicit-read-write)
[508.173302] Starting subtest: implicit-read-write
[508.175698] Starting dynamic subtest: rcs0
[508.272579] Dynamic subtest rcs0: SUCCESS (0.110s)
[508.284490] Starting dynamic subtest: vcs0
[508.361096] Dynamic subtest vcs0: SUCCESS (0.088s)
[508.371931] Starting dynamic subtest: vcs1
[508.438836] Dynamic subtest vcs1: SUCCESS (0.076s)
[508.449688] Starting dynamic subtest: vecs0
[508.518234] Dynamic subtest vecs0: SUCCESS (0.077s)
[508.528755] Starting dynamic subtest: ccs0
[508.608549] Dynamic subtest ccs0: SUCCESS (0.090s)
[508.610969] Subtest implicit-read-write: SUCCESS (0.447s)
[509.990689] [114/133] (522s left) drm_read (short-buffer-block)
[510.154087] Starting subtest: short-buffer-block
[510.156383] Subtest short-buffer-block: SUCCESS (0.000s)
[510.288303] [115/133] (521s left) kms_color (ctm-0-50)
[510.373768] Starting subtest: ctm-0-50
[510.375964] Starting dynamic subtest: pipe-A-eDP-1
[513.943563] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.571s)
[513.953220] Starting dynamic subtest: pipe-B-eDP-1
[518.149906] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.204s)
[518.164324] Starting dynamic subtest: pipe-C-eDP-1
[522.106969] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.957s)
[522.119199] Starting dynamic subtest: pipe-D-eDP-1
[526.146208] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.038s)
[526.148543] Subtest ctm-0-50: SUCCESS (15.774s)
[526.977558] [116/133] (505s left) gem_ppgtt (shrink-vs-evict-pinned)
[527.045469] Starting subtest: shrink-vs-evict-pinned
[532.914066] Subtest shrink-vs-evict-pinned: SUCCESS (5.866s)
[532.995319] [117/133] (499s left) gem_exec_whisper (basic-queues-forked-all)
[533.054340] Starting subtest: basic-queues-forked-all
[553.107567] Subtest basic-queues-forked-all: SUCCESS (20.048s)
[553.293360] [118/133] (479s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[553.396804] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[553.398723] Starting dynamic subtest: pipe-A-eDP-1
[554.220792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[554.232080] Starting dynamic subtest: pipe-B-eDP-1
[555.779678] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.559s)
[555.790120] Starting dynamic subtest: pipe-C-eDP-1
[557.289752] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.510s)
[557.300931] Starting dynamic subtest: pipe-D-eDP-1
[558.840151] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.547s)
[558.842291] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.435s)
[559.997130] [119/133] (472s left) kms_pm_rpm (system-suspend-idle)
[562.035868] Starting subtest: system-suspend-idle
[581.651878] Subtest system-suspend-idle: SUCCESS (4.609s)
[582.023941] [120/133] (450s left) perf (invalid-open-flags)
[582.166832] Starting subtest: invalid-open-flags
[582.169225] Subtest invalid-open-flags: SUCCESS (0.000s)
[582.219567] [121/133] (450s left) prime_mmap (test_invalid_sync_flags)
[582.289640] Starting subtest: test_invalid_sync_flags
[582.292039] Starting dynamic subtest: test_invalid_sync_flags-smem
[582.294037] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[582.296035] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[582.401260] [122/133] (450s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[582.498582] Starting subtest: stress-xrgb8888-yftiled
[582.502757] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[582.580559] [123/133] (449s left) kms_async_flips (alternate-sync-async-flip-atomic)
[582.671689] Starting subtest: alternate-sync-async-flip-atomic
[583.045923] Starting dynamic subtest: pipe-A-eDP-1
[585.802771] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.742s)
[586.185361] Starting dynamic subtest: pipe-B-eDP-1
[588.940346] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.754s)
[589.327016] Starting dynamic subtest: pipe-C-eDP-1
[592.075144] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.748s)
[592.443199] Starting dynamic subtest: pipe-D-eDP-1
[595.213654] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[595.215783] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.499s)
[596.403167] [124/133] (436s left) gem_exec_balancer (parallel-balancer)
[596.660407] Starting subtest: parallel-balancer
[597.550269] Subtest parallel-balancer: SUCCESS (0.888s)
[597.655028] [125/133] (434s left) dumb_buffer (invalid-bpp)
[597.703910] Starting subtest: invalid-bpp
[597.705828] Subtest invalid-bpp: SUCCESS (0.000s)
[597.812487] [126/133] (434s left) gem_gtt_cpu_tlb
[597.946018] [127/133] (434s left) kms_big_fb (linear-16bpp-rotate-270)
[598.053453] Starting subtest: linear-16bpp-rotate-270
[598.072632] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[598.193458] [128/133] (434s left) gem_exec_alignment (pi)
[598.248447] Starting subtest: pi
[650.961161] Subtest pi: SUCCESS (52.676s)
[652.019549] [129/133] (380s left) syncobj_timeline (reset-multiple-signaled)
[652.126313] Starting subtest: reset-multiple-signaled
[652.128580] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[652.235414] [130/133] (380s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[652.341665] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[652.345963] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[652.435473] [131/133] (380s left) gem_fence_thrash (bo-write-verify-none)
[652.476945] Starting subtest: bo-write-verify-none
[652.493527] Subtest bo-write-verify-none: SKIP (0.017s)
[652.552130] [132/133] (380s left) kms_frontbuffer_tracking (fbc-tiling-4)
[652.650677] Starting subtest: fbc-tiling-4
[656.835859] Subtest fbc-tiling-4: SUCCESS (4.186s)
[658.039935] [133/133] (374s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[658.153366] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[658.157879] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[658.243992] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: gem_basic
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gen9_exec_parse
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_fenced_exec_thrash
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_scaling_modes
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: i915_query
results: parsing output: 21/ for test: kms_invalid_mode
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_plane_lowres
results: parsing output: 28/ for test: kms_content_protection
results: parsing output: 29/ for test: sysfs_timeslice_duration
results: parsing output: 30/ for test: prime_self_import
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: drm_read
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: core_getclient
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_rotation_crc
results: parsing output: 40/ for test: gem_ccs
results: parsing output: 41/ for test: gem_ringfill
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: gen3_render_mixed_blits
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: prime_busy
results: parsing output: 49/ for test: kms_hdr
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_chamelium_color
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_getfb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gen7_exec_parse
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: testdisplay
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_universal_plane
results: parsing output: 68/ for test: gem_exec_fence
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: kms_vblank
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_chamelium_color
results: parsing output: 78/ for test: gem_create
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gem_fence_thrash
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_async_flips
results: parsing output: 83/ for test: gem_exec_flush
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: i915_pm_rps
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_draw_crc
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: i915_drm_fdinfo
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: gem_ctx_param
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: sw_sync
results: parsing output: 97/ for test: api_intel_allocator
results: parsing output: 98/ for test: gem_spin_batch
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_ctx_isolation
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_tiled_wc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: i915_module_load
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_endless
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: drm_read
results: parsing output: 114/ for test: kms_color
results: parsing output: 115/ for test: gem_ppgtt
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: prime_mmap
results: parsing output: 121/ for test: kms_pipe_stress
results: parsing output: 122/ for test: kms_async_flips
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: dumb_buffer
results: parsing output: 125/ for test: gem_gtt_cpu_tlb
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_exec_alignment
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_fence_thrash
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_big_fb
Done.