[57.563929] Initializing watchdogs
[57.563976]   /dev/watchdog0
[57.578731] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.583169] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.585334] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.588731] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[57.702282] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[57.706505] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[57.785055] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[57.880179] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[57.884181] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[57.969796] [003/133] (960s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[58.067548] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[59.126177] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.055s)
[59.236524] [004/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[59.325592] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[65.807866] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.465s)
[65.918212] [005/133] (952s left) gem_exec_balancer (noheartbeat)
[66.188772] Starting subtest: noheartbeat
[66.194031] Subtest noheartbeat: SKIP (0.000s)
[66.301065] [006/133] (951s left) syncobj_wait (multi-wait-submitted-signaled)
[66.351910] Starting subtest: multi-wait-submitted-signaled
[66.354215] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[66.456045] [007/133] (951s left) gen7_exec_parse (batch-without-end)
[66.514067] Subtest batch-without-end: SKIP (0.000s)
[66.584792] [008/133] (951s left) gem_pread (exhaustion)
[66.646572] Subtest exhaustion: SKIP (0.000s)
[66.702470] [009/133] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[66.811300] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[66.815596] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[66.960807] [010/133] (951s left) kms_cursor_crc (cursor-sliding-max-size)
[67.453117] Starting subtest: cursor-sliding-max-size
[67.460276] Subtest cursor-sliding-max-size: SKIP (0.000s)
[67.690325] [011/133] (950s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[67.833721] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[67.838032] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[68.082001] [012/133] (950s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[68.187711] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[68.189985] Starting dynamic subtest: pipe-A-eDP-1
[74.102444] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.915s)
[74.112191] Starting dynamic subtest: pipe-B-eDP-1
[80.798570] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.689s)
[80.800997] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.606s)
[81.653691] [013/133] (936s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[81.766990] Starting subtest: fbc-rgb565-draw-blt
[85.894640] Subtest fbc-rgb565-draw-blt: SUCCESS (4.129s)
[87.070154] [014/133] (931s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[87.166476] Starting subtest: plane-upscale-20x20-with-rotation
[87.168962] Starting dynamic subtest: pipe-A
[87.392822] Dynamic subtest pipe-A: SUCCESS (0.226s)
[87.400284] Starting dynamic subtest: pipe-B
[88.734230] Dynamic subtest pipe-B: SUCCESS (1.340s)
[88.743058] Starting dynamic subtest: pipe-C
[90.055863] Dynamic subtest pipe-C: SUCCESS (1.320s)
[90.064326] Starting dynamic subtest: pipe-D
[91.386396] Dynamic subtest pipe-D: SUCCESS (1.329s)
[91.388799] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.219s)
[92.572165] [015/133] (926s left) gem_exec_flush (basic-wb-ro-before-default)
[92.639864] Starting subtest: basic-wb-ro-before-default
[98.088745] Subtest basic-wb-ro-before-default: SUCCESS (5.450s)
[98.283930] [016/133] (920s left) gem_eio (in-flight-internal-immediate)
[98.505241] Starting subtest: in-flight-internal-immediate
[100.003990] Subtest in-flight-internal-immediate: SUCCESS (1.498s)
[100.118422] [017/133] (918s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[100.219757] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[100.246615] Starting dynamic subtest: pipe-A-plane-0
[100.535273] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[100.545664] Starting dynamic subtest: pipe-A-plane-3
[100.768801] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[101.860396] Starting dynamic subtest: pipe-B-plane-0
[102.141774] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[102.149286] Starting dynamic subtest: pipe-B-plane-3
[102.375167] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[102.688686] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.468s)
[103.533152] [018/133] (915s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[103.800946] Starting subtest: cursor-rapid-movement-256x256
[103.805976] Starting dynamic subtest: pipe-A-eDP-1
[104.376477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[104.404902] Starting dynamic subtest: pipe-D-eDP-1
[105.545470] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.150s)
[105.547950] Subtest cursor-rapid-movement-256x256: SUCCESS (1.744s)
[106.413809] [019/133] (912s left) kms_psr (psr2-sprite-plane-move)
[106.513050] Starting subtest: psr2-sprite-plane-move
[106.515258] Starting dynamic subtest: eDP-1
[108.233224] Dynamic subtest eDP-1: SUCCESS (1.719s)
[108.235580] Subtest psr2-sprite-plane-move: SUCCESS (1.720s)
[109.091250] [020/133] (909s left) kms_invalid_mode (bad-vsync-start)
[109.190541] Starting subtest: bad-vsync-start
[109.192792] Starting dynamic subtest: pipe-A-eDP-1
[109.476191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[109.486958] Starting dynamic subtest: pipe-B-eDP-1
[109.489165] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[109.496645] Starting dynamic subtest: pipe-C-eDP-1
[109.498866] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[109.506305] Starting dynamic subtest: pipe-D-eDP-1
[109.508495] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[109.510802] Subtest bad-vsync-start: SUCCESS (0.289s)
[110.307146] [021/133] (908s left) kms_cursor_crc (cursor-size-change)
[110.387263] Starting subtest: cursor-size-change
[110.389241] Starting dynamic subtest: pipe-A-eDP-1
[111.194920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[111.204559] Starting dynamic subtest: pipe-D-eDP-1
[112.674032] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.478s)
[112.676408] Subtest cursor-size-change: SUCCESS (2.289s)
[113.478028] [022/133] (905s left) kms_addfb_basic (legacy-format)
[113.546502] Starting subtest: legacy-format
[113.586032] Subtest legacy-format: SUCCESS (0.037s)
[113.741766] [023/133] (905s left) gem_exec_schedule (promotion)
[113.813148] Starting subtest: promotion
[113.814947] Starting dynamic subtest: rcs0
[113.919166] Dynamic subtest rcs0: SUCCESS (0.112s)
[113.928267] Starting dynamic subtest: vcs0
[114.016585] Dynamic subtest vcs0: SUCCESS (0.096s)
[114.025502] Starting dynamic subtest: vcs1
[114.118376] Dynamic subtest vcs1: SUCCESS (0.101s)
[114.127071] Starting dynamic subtest: vecs0
[114.248965] Dynamic subtest vecs0: SUCCESS (0.130s)
[114.258728] Starting dynamic subtest: ccs0
[114.351297] Dynamic subtest ccs0: SUCCESS (0.100s)
[114.353559] Subtest promotion: SUCCESS (0.544s)
[114.994332] [024/133] (903s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[115.097979] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[115.102203] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[115.205928] [025/133] (903s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[115.580517] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[116.382298] [026/133] (902s left) gem_exec_schedule (fairslice-all)
[116.464211] Starting subtest: fairslice-all
[118.517326] Subtest fairslice-all: SUCCESS (2.057s)
[118.822978] [027/133] (900s left) kms_lease (implicit-plane-lease)
[118.910091] Starting subtest: implicit-plane-lease
[118.912277] Subtest implicit-plane-lease: SUCCESS (0.002s)
[119.018317] [028/133] (900s left) kms_cursor_crc (cursor-alpha-opaque)
[119.112623] Starting subtest: cursor-alpha-opaque
[119.114817] Starting dynamic subtest: pipe-A-eDP-1
[119.726577] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.613s)
[119.734429] Starting dynamic subtest: pipe-D-eDP-1
[120.977158] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s)
[120.979472] Subtest cursor-alpha-opaque: SUCCESS (1.865s)
[121.762557] [029/133] (897s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[121.855127] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[121.857416] Starting dynamic subtest: pipe-A-eDP-1
[121.880074] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[121.889755] Starting dynamic subtest: pipe-B-eDP-1
[121.910203] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[121.917603] Starting dynamic subtest: pipe-C-eDP-1
[121.938015] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[121.945158] Starting dynamic subtest: pipe-D-eDP-1
[121.965807] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[121.969923] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[124.131824] [030/133] (895s left) syncobj_timeline (reset-signaled)
[124.189100] Starting subtest: reset-signaled
[124.191530] Subtest reset-signaled: SUCCESS (0.000s)
[124.292390] [031/133] (894s left) gem_exec_reloc (basic-cpu-active)
[124.343887] Subtest basic-cpu-active: SKIP (0.000s)
[124.414838] [032/133] (894s left) gem_exec_parallel (fds)
[124.481902] Starting subtest: fds
[124.484387] Starting dynamic subtest: rcs0
[128.067706] Dynamic subtest rcs0: SUCCESS (3.584s)
[128.076994] Starting dynamic subtest: bcs0
[131.774066] Dynamic subtest bcs0: SUCCESS (3.703s)
[131.785335] Starting dynamic subtest: vcs0
[136.157074] Dynamic subtest vcs0: SUCCESS (4.382s)
[136.170908] Starting dynamic subtest: vcs1
[140.213263] Dynamic subtest vcs1: SUCCESS (4.055s)
[140.224055] Starting dynamic subtest: vecs0
[144.237520] Dynamic subtest vecs0: SUCCESS (4.021s)
[144.246698] Starting dynamic subtest: ccs0
[148.527076] Dynamic subtest ccs0: SUCCESS (4.288s)
[148.529979] Subtest fds: SUCCESS (24.044s)
[148.720064] [033/133] (870s left) kms_vblank (wait-busy)
[148.820672] Starting subtest: wait-busy
[148.822529] Starting dynamic subtest: pipe-A-eDP-1
[150.705794] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[150.721910] Starting dynamic subtest: pipe-D-eDP-1
[153.287722] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.579s)
[153.290244] Subtest wait-busy: SUCCESS (4.468s)
[154.083348] [034/133] (865s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[154.184316] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[154.188735] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[154.250293] [035/133] (865s left) kms_sequence (queue-busy)
[154.353234] Starting subtest: queue-busy
[154.355435] Starting dynamic subtest: pipe-A-eDP-1
[156.290691] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[156.300253] Starting dynamic subtest: pipe-B-eDP-1
[158.876676] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.583s)
[158.885752] Starting dynamic subtest: pipe-C-eDP-1
[161.497215] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.619s)
[161.505894] Starting dynamic subtest: pipe-D-eDP-1
[164.128609] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.631s)
[164.131063] Subtest queue-busy: SUCCESS (9.777s)
[164.926239] [036/133] (854s left) gem_exec_whisper (basic-fds-forked-all)
[164.988999] Starting subtest: basic-fds-forked-all
[187.380070] Subtest basic-fds-forked-all: SUCCESS (22.392s)
[187.568249] [037/133] (831s left) kms_cursor_legacy (torture-bo)
[187.676327] Starting subtest: torture-bo
[187.678511] Starting dynamic subtest: pipe-A
[194.198353] Dynamic subtest pipe-A: SUCCESS (6.517s)
[194.209282] Starting dynamic subtest: pipe-B
[202.245977] Dynamic subtest pipe-B: SUCCESS (8.048s)
[202.254778] Starting dynamic subtest: pipe-C
[209.815771] Dynamic subtest pipe-C: SUCCESS (7.567s)
[209.830419] Starting dynamic subtest: pipe-D
[217.263121] Dynamic subtest pipe-D: SUCCESS (7.447s)
[217.271388] Starting dynamic subtest: all-pipes
[225.511708] Dynamic subtest all-pipes: SUCCESS (8.246s)
[225.514310] Subtest torture-bo: SUCCESS (37.832s)
[225.684569] [038/133] (793s left) perf_pmu (most-busy-idle-check-all)
[225.721670] Starting subtest: most-busy-idle-check-all
[225.724022] Starting dynamic subtest: rcs0
[226.904306] Dynamic subtest rcs0: SUCCESS (1.181s)
[226.915807] Starting dynamic subtest: bcs0
[228.886394] Dynamic subtest bcs0: SUCCESS (1.980s)
[228.897108] Starting dynamic subtest: vcs0
[230.934600] Dynamic subtest vcs0: SUCCESS (2.045s)
[230.944063] Starting dynamic subtest: vcs1
[232.918292] Dynamic subtest vcs1: SUCCESS (1.980s)
[232.931367] Starting dynamic subtest: vecs0
[234.902630] Dynamic subtest vecs0: SUCCESS (1.981s)
[234.913818] Starting dynamic subtest: ccs0
[236.888372] Dynamic subtest ccs0: SUCCESS (1.983s)
[236.891300] Subtest most-busy-idle-check-all: SUCCESS (11.167s)
[236.997135] [039/133] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[237.104539] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[243.791176] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.688s)
[243.942546] [040/133] (775s left) gem_exec_fence (basic-wait)
[244.113719] Starting subtest: basic-wait
[244.115995] Starting dynamic subtest: rcs0
[244.198675] Dynamic subtest rcs0: SUCCESS (0.086s)
[244.210569] Starting dynamic subtest: bcs0
[244.256171] Dynamic subtest bcs0: SUCCESS (0.055s)
[244.269680] Starting dynamic subtest: vcs0
[244.313575] Dynamic subtest vcs0: SUCCESS (0.055s)
[244.324912] Starting dynamic subtest: vcs1
[244.375151] Dynamic subtest vcs1: SUCCESS (0.060s)
[244.386125] Starting dynamic subtest: vecs0
[244.438565] Dynamic subtest vecs0: SUCCESS (0.061s)
[244.449224] Starting dynamic subtest: ccs0
[244.500273] Dynamic subtest ccs0: SUCCESS (0.060s)
[244.502684] Subtest basic-wait: SUCCESS (0.389s)
[245.991373] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[245.995578] [041/133] (773s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[246.086081] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[246.088190] Starting dynamic subtest: pipe-A-eDP-1
[246.144558] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[246.154725] Starting dynamic subtest: pipe-B-eDP-1
[246.211284] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[246.221600] Starting dynamic subtest: pipe-C-eDP-1
[246.278975] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[246.288729] Starting dynamic subtest: pipe-D-eDP-1
[246.347598] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[246.351739] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[248.326893] [042/133] (771s left) gem_lmem_swapping (verify-ccs)
[248.372668] Subtest verify-ccs: SKIP (0.000s)
[248.414882] [043/133] (771s left) sw_sync (timeline_closed_signaled)
[248.456997] Starting subtest: timeline_closed_signaled
[248.459146] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[248.507397] [044/133] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[248.608700] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[248.613287] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[248.694304] [045/133] (771s left) kms_prop_blob (invalid-set-prop-any)
[248.757559] Starting subtest: invalid-set-prop-any
[248.759540] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[248.850503] [046/133] (771s left) kms_flip (2x-flip-vs-expired-vblank)
[248.931580] Starting subtest: 2x-flip-vs-expired-vblank
[248.939780] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[249.020463] [047/133] (770s left) gem_lmem_swapping (parallel-random-engines)
[249.060490] Subtest parallel-random-engines: SKIP (0.000s)
[249.104375] [048/133] (770s left) kms_flip (plain-flip-fb-recreate-interruptible)
[249.200694] Starting subtest: plain-flip-fb-recreate-interruptible
[249.202993] Starting dynamic subtest: A-eDP1
[258.019611] Dynamic subtest A-eDP1: SUCCESS (8.818s)
[258.030773] Starting dynamic subtest: B-eDP1
[266.851272] Dynamic subtest B-eDP1: SUCCESS (8.828s)
[266.863487] Starting dynamic subtest: C-eDP1
[275.673254] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[275.682609] Starting dynamic subtest: D-eDP1
[284.498432] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[284.502825] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.302s)
[285.682407] [049/133] (734s left) api_intel_bb (object-reloc-keep-cache)
[285.753615] Starting subtest: object-reloc-keep-cache
[285.758498] Subtest object-reloc-keep-cache: SKIP (0.003s)
[285.880609] [050/133] (734s left) kms_pm_dc (dc5-dpms)
[286.983332] Starting subtest: dc5-dpms
[289.094712] Subtest dc5-dpms: SUCCESS (2.084s)
[289.139825] [051/133] (730s left) kms_plane_cursor (overlay)
[289.224202] Starting subtest: overlay
[289.228626] Starting dynamic subtest: pipe-A-eDP-1-size-64
[291.686256] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.464s)
[291.751848] Starting dynamic subtest: pipe-A-eDP-1-size-128
[294.132904] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.394s)
[294.191484] Starting dynamic subtest: pipe-A-eDP-1-size-256
[296.578871] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.393s)
[296.931315] Starting dynamic subtest: pipe-B-eDP-1-size-64
[300.067755] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.148s)
[300.130225] Starting dynamic subtest: pipe-B-eDP-1-size-128
[302.623996] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.504s)
[302.684344] Starting dynamic subtest: pipe-B-eDP-1-size-256
[305.169711] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.493s)
[305.525145] Starting dynamic subtest: pipe-C-eDP-1-size-64
[308.296875] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.785s)
[308.333999] Starting dynamic subtest: pipe-C-eDP-1-size-128
[310.362737] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.036s)
[310.400262] Starting dynamic subtest: pipe-C-eDP-1-size-256
[312.472988] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.080s)
[312.801697] Starting dynamic subtest: pipe-D-eDP-1-size-64
[315.587930] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.797s)
[315.625618] Starting dynamic subtest: pipe-D-eDP-1-size-128
[317.644598] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.025s)
[317.681206] Starting dynamic subtest: pipe-D-eDP-1-size-256
[319.755115] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.080s)
[320.081020] Subtest overlay: SUCCESS (30.856s)
[320.937612] [052/133] (699s left) gem_exec_reloc (basic-wc-active)
[320.997411] Subtest basic-wc-active: SKIP (0.000s)
[321.068818] [053/133] (699s left) kms_psr (pr-primary-mmap-gtt)
[321.150203] Starting subtest: pr-primary-mmap-gtt
[321.154582] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[321.220946] [054/133] (698s left) gem_exec_schedule (lateslice)
[321.296320] Starting subtest: lateslice
[321.298532] Starting dynamic subtest: rcs0
[321.306895] Dynamic subtest rcs0: SUCCESS (0.020s)
[321.317230] Starting dynamic subtest: bcs0
[321.324319] Dynamic subtest bcs0: SUCCESS (0.017s)
[321.333219] Starting dynamic subtest: vcs0
[321.344666] Dynamic subtest vcs0: SUCCESS (0.019s)
[321.355800] Starting dynamic subtest: vcs1
[321.365792] Dynamic subtest vcs1: SUCCESS (0.019s)
[321.374133] Starting dynamic subtest: vecs0
[321.383665] Dynamic subtest vecs0: SUCCESS (0.018s)
[321.396575] Starting dynamic subtest: ccs0
[321.407643] Dynamic subtest ccs0: SUCCESS (0.022s)
[321.409903] Subtest lateslice: SUCCESS (0.122s)
[322.975198] [055/133] (697s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[323.072442] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[330.534339] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.464s)
[330.660994] [056/133] (689s left) kms_color (ctm-max)
[330.750876] Starting subtest: ctm-max
[330.753035] Starting dynamic subtest: pipe-A-eDP-1
[331.474232] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s)
[331.486830] Starting dynamic subtest: pipe-B-eDP-1
[332.861465] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.383s)
[332.870993] Starting dynamic subtest: pipe-C-eDP-1
[334.233561] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[334.245128] Starting dynamic subtest: pipe-D-eDP-1
[335.568810] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[335.571175] Subtest ctm-max: SUCCESS (4.819s)
[336.362399] [057/133] (683s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[336.426721] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[336.428746] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[336.536469] [058/133] (683s left) gem_eio (reset-stress)
[336.766799] Starting subtest: reset-stress
[336.769113] Starting dynamic subtest: render
[341.704943] Dynamic subtest render: SUCCESS (4.934s)
[341.719922] Starting dynamic subtest: bsd1
[359.485950] Dynamic subtest bsd1: SUCCESS (17.780s)
[359.500525] Starting dynamic subtest: bsd2
[377.429994] Dynamic subtest bsd2: SUCCESS (17.942s)
[377.450600] Starting dynamic subtest: blt
[377.455505] Dynamic subtest blt: SKIP (0.000s)
[377.472818] Starting dynamic subtest: vebox
[395.441304] Dynamic subtest vebox: SUCCESS (18.009s)
[395.443523] Subtest reset-stress: SUCCESS (58.670s)
[396.940961] [059/133] (623s left) kms_addfb_basic (bad-pitch-256)
[397.008520] Starting subtest: bad-pitch-256
[397.010556] Subtest bad-pitch-256: SUCCESS (0.000s)
[397.166153] [060/133] (623s left) kms_addfb_basic (bo-too-small)
[397.255259] Starting subtest: bo-too-small
[397.257386] Subtest bo-too-small: SUCCESS (0.000s)
[397.361593] [061/133] (623s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[397.468567] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[397.473215] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[397.602538] [062/133] (622s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[397.698091] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[397.702568] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[397.769152] [063/133] (622s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[397.865166] Starting subtest: disable-crc-after-crtc
[397.867474] Starting dynamic subtest: pipe-A-eDP-1
[399.486837] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.622s)
[399.501860] Starting dynamic subtest: pipe-B-eDP-1
[401.857519] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.370s)
[401.867281] Starting dynamic subtest: pipe-C-eDP-1
[404.087359] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.227s)
[404.098049] Starting dynamic subtest: pipe-D-eDP-1
[406.348038] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.260s)
[406.350421] Subtest disable-crc-after-crtc: SUCCESS (8.484s)
[407.196769] [064/133] (613s left) kms_chamelium_frames (hdmi-crc-multiple)
[407.574889] Subtest hdmi-crc-multiple: SKIP (0.000s)
[408.434429] [065/133] (612s left) perf (oa-formats)
[408.572668] Starting subtest: oa-formats
[408.574563] Starting dynamic subtest: 0-rcs0
[408.585995] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[408.594624] Starting dynamic subtest: 1-vcs1
[408.607074] Dynamic subtest 1-vcs1: SUCCESS (0.020s)
[408.609350] Subtest oa-formats: SUCCESS (0.036s)
[408.656206] [066/133] (612s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[408.757025] Starting subtest: dsc-fractional-bpp-with-bpc
[408.786748] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[408.830568] [067/133] (611s left) syncobj_eventfd (timeline-wait)
[408.891450] Starting subtest: timeline-wait
[408.900092] Subtest timeline-wait: SUCCESS (0.011s)
[408.974488] [068/133] (611s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[409.062029] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[409.064344] Starting dynamic subtest: pipe-A-eDP-1
[425.176206] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.535s)
[425.185629] Starting dynamic subtest: pipe-B-eDP-1
[442.163354] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.418s)
[442.173947] Starting dynamic subtest: pipe-C-eDP-1
[459.132314] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.312s)
[459.142577] Starting dynamic subtest: pipe-D-eDP-1
[476.112935] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.305s)
[476.115362] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.575s)
[477.292750] [069/133] (543s left) gem_mmap_offset (isolation)
[477.349725] Starting subtest: isolation
[477.368993] Subtest isolation: SUCCESS (0.016s)
[477.473364] [070/133] (543s left) kms_chamelium_color (ctm-negative)
[477.565842] Subtest ctm-negative: SKIP (0.000s)
[477.611249] [071/133] (543s left) kms_hdmi_inject (inject-audio)
[477.977791] Starting subtest: inject-audio
[478.253437] Subtest inject-audio: SUCCESS (0.271s)
[478.877796] [072/133] (542s left) i915_drm_fdinfo (virtual-idle)
[478.916286] Starting subtest: virtual-idle
[482.036641] Subtest virtual-idle: SUCCESS (3.068s)
[482.113685] [073/133] (538s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[482.220036] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[482.224147] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[482.312939] [074/133] (538s left) gem_set_tiling_vs_gtt
[482.425361] [075/133] (538s left) api_intel_allocator (reopen-fork)
[482.487679] Starting subtest: reopen-fork
[485.814551] Subtest reopen-fork: SUCCESS (3.293s)
[485.894428] [076/133] (535s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[485.994617] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[485.996859] Starting dynamic subtest: pipe-A-default-mode
[488.760806] Dynamic subtest pipe-A-default-mode: SUCCESS (2.748s)
[488.763123] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.750s)
[489.577278] [077/133] (531s left) gem_eio (wait-1us)
[489.811645] Starting subtest: wait-1us
[490.172887] Subtest wait-1us: SUCCESS (0.360s)
[490.318858] [078/133] (530s left) gem_exec_create (forked)
[490.375301] Starting subtest: forked
[490.377713] Starting dynamic subtest: smem
[512.151799] Dynamic subtest smem: SUCCESS (21.737s)
[512.154612] Subtest forked: SUCCESS (21.739s)
[512.341578] [079/133] (508s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[512.395711] Starting subtest: etime-single-wait-all-for-submit-submitted
[512.497928] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[512.582896] [080/133] (508s left) gem_exec_params (rel-constants-invalid-ring)
[512.649616] Starting subtest: rel-constants-invalid-ring
[512.651932] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[512.749287] [081/133] (508s left) kms_flip (plain-flip-interruptible)
[512.842691] Starting subtest: plain-flip-interruptible
[512.844999] Starting dynamic subtest: A-eDP1
[514.482199] Dynamic subtest A-eDP1: SUCCESS (1.638s)
[514.497263] Starting dynamic subtest: B-eDP1
[516.199988] Dynamic subtest B-eDP1: SUCCESS (1.715s)
[516.217258] Starting dynamic subtest: C-eDP1
[517.871627] Dynamic subtest C-eDP1: SUCCESS (1.669s)
[517.884882] Starting dynamic subtest: D-eDP1
[519.477301] Dynamic subtest D-eDP1: SUCCESS (1.602s)
[519.479763] Subtest plain-flip-interruptible: SUCCESS (6.637s)
[520.626049] [082/133] (500s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[520.741942] Starting subtest: short-flip-before-cursor-atomic-transitions
[521.700434] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.959s)
[522.520015] [083/133] (498s left) gem_userptr_blits (forbidden-operations)
[522.583120] Starting subtest: forbidden-operations
[522.587355] Subtest forbidden-operations: SKIP (0.000s)
[522.715010] [084/133] (498s left) gem_ctx_engines (invalid-engines)
[522.768418] Starting subtest: invalid-engines
[522.776644] Subtest invalid-engines: SUCCESS (0.008s)
[523.008395] [085/133] (498s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[523.108217] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[523.112675] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[523.204238] [086/133] (498s left) kms_pm_rpm (i2c)
[525.327712] Starting subtest: i2c
[530.329636] Subtest i2c: SUCCESS (5.002s)
[530.418487] [087/133] (491s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[530.510021] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[537.308964] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.800s)
[537.446472] [088/133] (484s left) kms_atomic (plane-overlay-legacy)
[537.547596] Starting subtest: plane-overlay-legacy
[537.549777] Starting dynamic subtest: pipe-A-eDP-1
[537.984938] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s)
[537.987103] Subtest plane-overlay-legacy: SUCCESS (0.437s)
[538.798319] [089/133] (482s left) syncobj_timeline (wait-all-for-submit-complex)
[538.868397] Starting subtest: wait-all-for-submit-complex
[539.080989] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[539.158507] [090/133] (482s left) gem_request_retire (retire-vma-not-inactive)
[539.216153] Starting subtest: retire-vma-not-inactive
[539.277430] Subtest retire-vma-not-inactive: SUCCESS (0.056s)
[539.414627] [091/133] (482s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[539.473614] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[539.477963] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[539.658187] [092/133] (482s left) gem_pxp (reject-modify-context-protection-on)
[539.776859] Starting subtest: reject-modify-context-protection-on
[539.779624] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[539.900983] [093/133] (482s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[539.995683] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[539.997935] Starting dynamic subtest: pipe-A-eDP-1
[540.020460] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[540.033283] Starting dynamic subtest: pipe-B-eDP-1
[540.054652] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[540.064143] Starting dynamic subtest: pipe-C-eDP-1
[540.085409] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[540.094537] Starting dynamic subtest: pipe-D-eDP-1
[540.117168] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[540.121978] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[542.170895] [094/133] (479s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[542.273858] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[542.278001] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[542.347004] [095/133] (479s left) gem_exec_fence (syncobj-export)
[542.800600] Starting subtest: syncobj-export
[542.806417] Subtest syncobj-export: SUCCESS (0.004s)
[544.307845] [096/133] (477s left) dumb_buffer (map-invalid-size)
[544.357149] Starting subtest: map-invalid-size
[544.359167] Subtest map-invalid-size: SUCCESS (0.000s)
[544.457605] [097/133] (477s left) kms_psr (fbc-psr-primary-render)
[544.537750] Starting subtest: fbc-psr-primary-render
[544.539977] Starting dynamic subtest: eDP-1
[544.544007] Dynamic subtest eDP-1: SKIP (0.000s)
[544.548168] Subtest fbc-psr-primary-render: SKIP (0.001s)
[544.621998] [098/133] (477s left) fbdev (eof)
[544.665058] Starting subtest: eof
[544.667268] Subtest eof: SUCCESS (0.000s)
[544.744996] [099/133] (477s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[544.837350] Starting subtest: fbc-rgb101010-draw-pwrite
[550.253912] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.417s)
[551.379372] [100/133] (470s left) kms_vrr (negative-basic)
[551.480511] Starting subtest: negative-basic
[551.487076] Starting dynamic subtest: pipe-A-eDP-1
[557.400832] Dynamic subtest pipe-A-eDP-1: FAIL (5.435s)
[557.402760] Subtest negative-basic: FAIL (5.731s)
[558.024282] [101/133] (464s left) gem_exec_schedule (smoketest-all)
[558.095319] Starting subtest: smoketest-all
[590.460277] Subtest smoketest-all: SUCCESS (32.325s)
[591.239755] [102/133] (431s left) kms_big_fb (y-tiled-addfb-size-overflow)
[591.338067] Starting subtest: y-tiled-addfb-size-overflow
[591.342125] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[591.430411] [103/133] (430s left) vgem_basic (bad-fence)
[591.483266] Starting subtest: bad-fence
[591.485194] Subtest bad-fence: SUCCESS (0.000s)
[591.542210] [104/133] (430s left) gem_ctx_persistence (engines-hostile)
[591.607665] Starting subtest: engines-hostile
[591.609758] Starting dynamic subtest: rcs0
[591.685580] Dynamic subtest rcs0: SUCCESS (0.080s)
[591.698427] Starting dynamic subtest: bcs0
[591.764138] Dynamic subtest bcs0: SUCCESS (0.077s)
[591.775610] Starting dynamic subtest: vcs0
[591.898165] Dynamic subtest vcs0: SUCCESS (0.132s)
[591.909983] Starting dynamic subtest: vcs1
[591.993140] Dynamic subtest vcs1: SUCCESS (0.093s)
[592.005166] Starting dynamic subtest: vecs0
[592.084126] Dynamic subtest vecs0: SUCCESS (0.089s)
[592.101757] Starting dynamic subtest: ccs0
[592.183993] Dynamic subtest ccs0: SUCCESS (0.098s)
[592.186143] Subtest engines-hostile: SUCCESS (0.581s)
[592.276782] [105/133] (430s left) prime_mmap (test_forked)
[592.341578] Starting subtest: test_forked
[592.343254] Starting dynamic subtest: test_forked-smem
[592.379571] Dynamic subtest test_forked-smem: SUCCESS (0.039s)
[592.381607] Subtest test_forked: SUCCESS (0.041s)
[592.490415] [106/133] (430s left) gem_spin_batch (resubmit-all)
[592.545709] Starting subtest: resubmit-all
[592.547521] Starting dynamic subtest: rcs0
[592.562613] Dynamic subtest rcs0: SUCCESS (0.019s)
[592.576979] Starting dynamic subtest: bcs0
[592.578761] Dynamic subtest bcs0: SUCCESS (0.002s)
[592.587854] Starting dynamic subtest: vcs0
[592.589596] Dynamic subtest vcs0: SUCCESS (0.002s)
[592.598274] Starting dynamic subtest: vcs1
[592.599992] Dynamic subtest vcs1: SUCCESS (0.002s)
[592.608700] Starting dynamic subtest: vecs0
[592.610443] Dynamic subtest vecs0: SUCCESS (0.002s)
[592.619362] Starting dynamic subtest: ccs0
[592.621063] Dynamic subtest ccs0: SUCCESS (0.002s)
[592.622747] Subtest resubmit-all: SUCCESS (0.032s)
[594.253011] [107/133] (428s left) i915_drm_fdinfo (busy-idle)
[594.295905] Starting subtest: busy-idle
[594.298212] Starting dynamic subtest: rcs0
[594.313377] Dynamic subtest rcs0: SKIP (0.017s)
[594.327714] Starting dynamic subtest: bcs0
[594.331887] Dynamic subtest bcs0: SKIP (0.001s)
[594.341103] Starting dynamic subtest: vcs0
[594.345141] Dynamic subtest vcs0: SKIP (0.001s)
[594.354060] Starting dynamic subtest: vcs1
[594.358161] Dynamic subtest vcs1: SKIP (0.000s)
[594.367269] Starting dynamic subtest: vecs0
[594.371370] Dynamic subtest vecs0: SKIP (0.000s)
[594.380630] Starting dynamic subtest: ccs0
[594.384732] Dynamic subtest ccs0: SKIP (0.000s)
[594.388822] Subtest busy-idle: SKIP (0.025s)
[594.428403] [108/133] (428s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[594.540257] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[595.341987] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[595.517014] [109/133] (427s left) perf (non-sampling-read-error)
[595.614619] Starting subtest: non-sampling-read-error
[595.624735] Subtest non-sampling-read-error: SUCCESS (0.008s)
[595.671527] [110/133] (427s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[595.761940] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[604.343893] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.584s)
[604.442956] [111/133] (418s left) kms_force_connector_basic (force-load-detect)
[604.545566] Starting subtest: force-load-detect
[604.549936] Subtest force-load-detect: SKIP (0.000s)
[604.658681] [112/133] (418s left) kms_content_protection (lic-type-0-hdcp14)
[604.791019] Starting subtest: lic-type-0-hdcp14
[604.795482] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[604.913908] [113/133] (417s left) gem_ctx_shared (q-in-order)
[604.984121] Starting subtest: Q-in-order
[604.986468] Starting dynamic subtest: rcs0
[605.100232] Dynamic subtest rcs0: SUCCESS (0.114s)
[605.113223] Starting dynamic subtest: vcs0
[605.197578] Dynamic subtest vcs0: SUCCESS (0.095s)
[605.215084] Starting dynamic subtest: vcs1
[605.283621] Dynamic subtest vcs1: SUCCESS (0.086s)
[605.298047] Starting dynamic subtest: vecs0
[605.369627] Dynamic subtest vecs0: SUCCESS (0.085s)
[605.386959] Starting dynamic subtest: ccs0
[605.462584] Dynamic subtest ccs0: SUCCESS (0.091s)
[605.465340] Subtest Q-in-order: SUCCESS (0.479s)
[606.319758] [114/133] (416s left) i915_suspend (basic-s3-without-i915)
[606.358956] Starting subtest: basic-s3-without-i915
[609.641676] Subtest basic-s3-without-i915: SKIP (3.276s)
[611.200303] [115/133] (411s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[611.317512] Starting subtest: yf-tiled-32bpp-rotate-270
[611.321892] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[611.419314] [116/133] (411s left) gem_ctx_persistence (legacy-engines-persistence)
[611.485872] Starting subtest: legacy-engines-persistence
[611.488277] Starting dynamic subtest: render
[612.314286] Dynamic subtest render: SUCCESS (0.827s)
[612.328120] Starting dynamic subtest: bsd1
[613.070601] Dynamic subtest bsd1: SUCCESS (0.753s)
[613.082216] Starting dynamic subtest: bsd2
[613.842262] Dynamic subtest bsd2: SUCCESS (0.769s)
[613.856956] Starting dynamic subtest: blt
[614.613464] Dynamic subtest blt: SUCCESS (0.768s)
[614.628239] Starting dynamic subtest: vebox
[615.382485] Dynamic subtest vebox: SUCCESS (0.766s)
[615.385294] Subtest legacy-engines-persistence: SUCCESS (3.897s)
[615.465065] [117/133] (407s left) kms_rotation_crc (primary-rotation-90)
[615.563718] Starting subtest: primary-rotation-90
[615.568065] Subtest primary-rotation-90: SKIP (0.001s)
[615.636965] [118/133] (407s left) syncobj_wait (multi-wait-all-signaled)
[615.692598] Starting subtest: multi-wait-all-signaled
[615.694904] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[615.804171] [119/133] (407s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[615.894991] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[615.899161] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[615.998176] [120/133] (407s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[616.084813] Starting subtest: fbc-pr-sprite-mmap-gtt
[616.089303] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[616.160442] [121/133] (406s left) kms_force_connector_basic (prune-stale-modes)
[616.244842] Starting subtest: prune-stale-modes
[616.687309] Subtest prune-stale-modes: SUCCESS (0.443s)
[616.833671] [122/133] (406s left) perf (stress-open-close)
[616.949053] Starting subtest: stress-open-close
[616.950926] Starting dynamic subtest: 0-rcs0
[619.114888] Dynamic subtest 0-rcs0: SUCCESS (2.164s)
[619.129659] Starting dynamic subtest: 1-vecs0
[621.278611] Dynamic subtest 1-vecs0: SUCCESS (2.164s)
[621.280603] Subtest stress-open-close: SUCCESS (4.330s)
[621.320156] [123/133] (401s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[621.373585] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[621.375432] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[621.472453] [124/133] (401s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[621.571178] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[621.574421] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[621.672626] [125/133] (401s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[621.776845] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[621.778654] Starting dynamic subtest: pipe-A-eDP-1
[621.900137] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s)
[621.908946] Starting dynamic subtest: pipe-B-eDP-1
[623.028235] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[623.032739] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.251s)
[624.284763] [126/133] (399s left) sw_sync (sync_merge_same)
[624.322247] Starting subtest: sync_merge_same
[624.324352] Subtest sync_merge_same: SUCCESS (0.000s)
[624.369781] [127/133] (398s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[624.469552] Starting subtest: 4-tiled-32bpp-rotate-0
[625.918074] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.449s)
[626.069399] [128/133] (397s left) i915_pm_rc6_residency (media-rc6-accuracy)
[626.124457] Starting subtest: media-rc6-accuracy
[626.128119] Subtest media-rc6-accuracy: SKIP (0.000s)
[626.236268] [129/133] (397s left) kms_psr (psr-primary-render)
[626.327842] Starting subtest: psr-primary-render
[626.329775] Starting dynamic subtest: eDP-1
[628.052880] Dynamic subtest eDP-1: SUCCESS (1.721s)
[628.055170] Subtest psr-primary-render: SUCCESS (1.722s)
[628.878640] [130/133] (394s left) kms_getfb (getfb2-handle-closed)
[628.965108] Starting subtest: getfb2-handle-closed
[628.967254] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[629.062964] [131/133] (394s left) gem_wait (write-busy)
[629.117614] Starting subtest: write-busy
[629.119868] Starting dynamic subtest: all-engines
[629.706726] Dynamic subtest all-engines: SUCCESS (0.588s)
[629.723803] Starting dynamic subtest: rcs0
[630.257865] Dynamic subtest rcs0: SUCCESS (0.550s)
[630.274637] Starting dynamic subtest: bcs0
[630.806297] Dynamic subtest bcs0: SUCCESS (0.547s)
[630.822402] Starting dynamic subtest: vcs0
[632.213962] Dynamic subtest vcs0: SUCCESS (1.405s)
[632.231981] Starting dynamic subtest: vcs1
[634.199227] Dynamic subtest vcs1: SUCCESS (1.983s)
[634.216365] Starting dynamic subtest: vecs0
[636.245946] Dynamic subtest vecs0: SUCCESS (2.044s)
[636.262653] Starting dynamic subtest: ccs0
[636.795690] Dynamic subtest ccs0: SUCCESS (0.549s)
[636.798180] Subtest write-busy: SUCCESS (7.677s)
[637.016388] [132/133] (386s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[637.139826] Starting subtest: cursorB-vs-flipB-legacy
[637.144250] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[637.287030] [133/133] (386s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[637.376778] Starting subtest: primary-x-tiled-reflect-x-0
[644.305938] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.930s)
[645.479781] 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: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: gen7_exec_parse
results: parsing output: 7/ for test: gem_pread
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: gem_eio
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_invalid_mode
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: gem_exec_parallel
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_sequence
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_prop_blob
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_pm_dc
results: parsing output: 50/ for test: kms_plane_cursor
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_color
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_chamelium_frames
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_dsc
results: parsing output: 66/ for test: syncobj_eventfd
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_mmap_offset
results: parsing output: 69/ for test: kms_chamelium_color
results: parsing output: 70/ for test: kms_hdmi_inject
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_set_tiling_vs_gtt
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_exec_create
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_ctx_engines
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_atomic
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_request_retire
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: gem_pxp
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: dumb_buffer
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: fbdev
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_vrr
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: prime_mmap
results: parsing output: 105/ for test: gem_spin_batch
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_force_connector_basic
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_force_connector_basic
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: i915_pm_rc6_residency
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_getfb
results: parsing output: 130/ for test: gem_wait
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_rotation_crc
Done.