[58.267110] Initializing watchdogs
[58.267158]   /dev/watchdog0
[58.281561] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.286041] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.288175] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.291792] [001/133] (960s left) perf_pmu (busy)
[58.365816] Starting subtest: busy
[58.367817] Starting dynamic subtest: rcs0
[58.962873] Dynamic subtest rcs0: SUCCESS (0.603s)
[58.973104] Starting dynamic subtest: bcs0
[59.538904] Dynamic subtest bcs0: SUCCESS (0.578s)
[59.550498] Starting dynamic subtest: vcs0
[61.316811] Dynamic subtest vcs0: SUCCESS (1.785s)
[61.327503] Starting dynamic subtest: vcs1
[63.298476] Dynamic subtest vcs1: SUCCESS (1.987s)
[63.308883] Starting dynamic subtest: vecs0
[65.283452] Dynamic subtest vecs0: SUCCESS (1.990s)
[65.293475] Starting dynamic subtest: ccs0
[65.845424] Dynamic subtest ccs0: SUCCESS (0.564s)
[65.848084] Subtest busy: SUCCESS (7.514s)
[65.948983] [002/133] (952s left) gem_busy (parallel)
[66.149257] Starting subtest: parallel
[66.151637] Starting dynamic subtest: rcs0
[67.267436] Dynamic subtest rcs0: SUCCESS (1.118s)
[67.278799] Starting dynamic subtest: bcs0
[69.315897] Dynamic subtest bcs0: SUCCESS (2.051s)
[69.327814] Starting dynamic subtest: vcs0
[71.299966] Dynamic subtest vcs0: SUCCESS (1.985s)
[71.310931] Starting dynamic subtest: vcs1
[73.283391] Dynamic subtest vcs1: SUCCESS (1.984s)
[73.294720] Starting dynamic subtest: vecs0
[75.266941] Dynamic subtest vecs0: SUCCESS (1.984s)
[75.279770] Starting dynamic subtest: ccs0
[77.315759] Dynamic subtest ccs0: SUCCESS (2.048s)
[77.318986] Subtest parallel: SUCCESS (11.179s)
[77.551802] [003/133] (941s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[77.655550] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[84.414285] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.763s)
[84.535199] [004/133] (934s left) i915_hangman (error-state-basic)
[84.599950] Starting subtest: error-state-basic
[84.712807] Subtest error-state-basic: SUCCESS (0.113s)
[84.780894] [005/133] (934s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[84.869957] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[84.872289] Starting dynamic subtest: pipe-A-eDP-1
[84.894783] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[84.903597] Starting dynamic subtest: pipe-B-eDP-1
[84.924648] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[84.932611] Starting dynamic subtest: pipe-C-eDP-1
[84.954169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[84.962220] Starting dynamic subtest: pipe-D-eDP-1
[84.984132] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[84.988138] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[87.149141] [006/133] (931s left) kms_cursor_crc (cursor-sliding-max-size)
[87.457977] Starting subtest: cursor-sliding-max-size
[87.465112] Subtest cursor-sliding-max-size: SKIP (0.000s)
[87.566766] [007/133] (931s left) gem_workarounds (reset-fd)
[87.636310] Starting subtest: reset-fd
[87.788114] Subtest reset-fd: SUCCESS (0.151s)
[87.895237] [008/133] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[87.982310] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[94.697144] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.718s)
[94.841814] [009/133] (924s left) gem_ctx_persistence (engines-mixed-process)
[94.899121] Starting subtest: engines-mixed-process
[94.901385] Starting dynamic subtest: rcs0
[96.326783] Dynamic subtest rcs0: SUCCESS (1.428s)
[96.336853] Starting dynamic subtest: bcs0
[98.226063] Dynamic subtest bcs0: SUCCESS (1.898s)
[98.236097] Starting dynamic subtest: vcs0
[100.313912] Dynamic subtest vcs0: SUCCESS (2.088s)
[100.326059] Starting dynamic subtest: vcs1
[102.297059] Dynamic subtest vcs1: SUCCESS (1.982s)
[102.308070] Starting dynamic subtest: vecs0
[104.272658] Dynamic subtest vecs0: SUCCESS (1.975s)
[104.282597] Starting dynamic subtest: ccs0
[106.288267] Dynamic subtest ccs0: SUCCESS (2.013s)
[106.290833] Subtest engines-mixed-process: SUCCESS (11.388s)
[106.367873] [010/133] (912s left) gem_mmap_gtt (big-copy-odd)
[106.429565] Subtest big-copy-odd: SKIP (0.000s)
[106.489035] [011/133] (912s left) kms_vblank (wait-idle)
[106.578182] Starting subtest: wait-idle
[106.580499] Starting dynamic subtest: pipe-A-eDP-1
[108.350948] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.771s)
[108.365435] Starting dynamic subtest: pipe-D-eDP-1
[110.792699] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.439s)
[110.795022] Subtest wait-idle: SUCCESS (4.214s)
[111.599932] [012/133] (907s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[111.698318] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[118.322024] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.626s)
[118.445496] [013/133] (900s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[118.566338] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[119.578225] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.012s)
[119.698689] [014/133] (899s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[119.793603] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[119.798081] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[119.888636] [015/133] (899s left) kms_psr (psr2-cursor-mmap-gtt)
[119.978701] Starting subtest: psr2-cursor-mmap-gtt
[119.980710] Starting dynamic subtest: eDP-1
[121.692733] Dynamic subtest eDP-1: SUCCESS (1.713s)
[121.695128] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.714s)
[122.479535] [016/133] (896s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[122.578113] Starting subtest: yf-tiled-32bpp-rotate-90
[122.582253] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[122.665606] [017/133] (896s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[122.723173] Starting subtest: legacy-engines-hostile-preempt
[122.725561] Starting dynamic subtest: render
[122.763439] Dynamic subtest render: SUCCESS (0.040s)
[122.774161] Starting dynamic subtest: bsd1
[124.288683] Dynamic subtest bsd1: SUCCESS (1.496s)
[124.300031] Starting dynamic subtest: bsd2
[126.272802] Dynamic subtest bsd2: SUCCESS (2.008s)
[126.283977] Starting dynamic subtest: blt
[126.330464] Dynamic subtest blt: SUCCESS (0.057s)
[126.340555] Starting dynamic subtest: vebox
[128.316196] Dynamic subtest vebox: SUCCESS (1.983s)
[128.318862] Subtest legacy-engines-hostile-preempt: SUCCESS (5.592s)
[128.397684] [018/133] (891s left) i915_drm_fdinfo (all-busy-check-all)
[128.436147] Starting subtest: all-busy-check-all
[128.443597] Subtest all-busy-check-all: SKIP (0.004s)
[128.504545] [019/133] (890s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[128.903039] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[129.692906] [020/133] (889s left) kms_universal_plane (universal-plane-pageflip-windowed)
[129.799492] Starting subtest: universal-plane-pageflip-windowed
[129.801920] Starting dynamic subtest: pipe-A-eDP-1
[130.394675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[130.404778] Starting dynamic subtest: pipe-B-eDP-1
[131.645655] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.250s)
[131.658778] Starting dynamic subtest: pipe-C-eDP-1
[132.849118] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[132.859126] Starting dynamic subtest: pipe-D-eDP-1
[134.074489] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[134.076439] Subtest universal-plane-pageflip-windowed: SUCCESS (4.272s)
[134.915160] [021/133] (884s left) gem_eio (wait-wedge-10ms)
[135.123415] Starting subtest: wait-wedge-10ms
[136.386078] Subtest wait-wedge-10ms: SUCCESS (1.263s)
[136.523616] [022/133] (883s left) gem_mmap (bad-object)
[136.576266] Subtest bad-object: SKIP (0.000s)
[136.631601] [023/133] (883s left) gem_exec_params (invalid-fence-in)
[136.701104] Starting subtest: invalid-fence-in
[136.703504] Subtest invalid-fence-in: SUCCESS (0.000s)
[136.817159] [024/133] (882s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[136.910271] Starting subtest: plane-upscale-20x20-with-modifiers
[136.912610] Starting dynamic subtest: pipe-A
[137.246068] Dynamic subtest pipe-A: SUCCESS (0.338s)
[137.256890] Starting dynamic subtest: pipe-B
[138.631471] Dynamic subtest pipe-B: SUCCESS (1.385s)
[138.641393] Starting dynamic subtest: pipe-C
[140.041443] Dynamic subtest pipe-C: SUCCESS (1.409s)
[140.050691] Starting dynamic subtest: pipe-D
[141.472329] Dynamic subtest pipe-D: SUCCESS (1.430s)
[141.474575] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.564s)
[142.631687] [025/133] (877s left) kms_draw_crc (draw-method-pwrite)
[142.738801] Starting subtest: draw-method-pwrite
[142.740654] Starting dynamic subtest: xrgb8888-untiled
[143.303841] Dynamic subtest xrgb8888-untiled: SUCCESS (0.566s)
[143.313627] Starting dynamic subtest: rgb565-untiled
[143.737544] Dynamic subtest rgb565-untiled: SUCCESS (0.433s)
[143.746235] Starting dynamic subtest: xrgb2101010-untiled
[144.281973] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[144.295562] Starting dynamic subtest: xbgr16161616f-untiled
[145.093151] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.810s)
[145.102581] Starting dynamic subtest: xrgb8888-xtiled
[146.883495] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.788s)
[146.892258] Starting dynamic subtest: rgb565-xtiled
[147.970838] Dynamic subtest rgb565-xtiled: SUCCESS (1.087s)
[147.979629] Starting dynamic subtest: xrgb2101010-xtiled
[149.826983] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.854s)
[149.835679] Starting dynamic subtest: xbgr16161616f-xtiled
[153.126365] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.298s)
[153.135092] Starting dynamic subtest: xrgb8888-4tiled
[154.226571] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.098s)
[154.238170] Starting dynamic subtest: rgb565-4tiled
[154.793399] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s)
[154.803588] Starting dynamic subtest: xrgb2101010-4tiled
[155.882282] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.088s)
[155.891445] Starting dynamic subtest: xbgr16161616f-4tiled
[158.882396] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.999s)
[158.884777] Subtest draw-method-pwrite: SUCCESS (16.146s)
[158.987116] [026/133] (860s left) perf_pmu (event-wait)
[159.032297] Starting subtest: event-wait
[159.034732] Starting dynamic subtest: rcs0
[159.039204] Dynamic subtest rcs0: SKIP (0.000s)
[159.043599] Subtest event-wait: SKIP (0.000s)
[159.137767] [027/133] (860s left) gem_ppgtt (shrink-vs-evict-pinned)
[159.193835] Starting subtest: shrink-vs-evict-pinned
[165.275888] Subtest shrink-vs-evict-pinned: SUCCESS (6.080s)
[165.382491] [028/133] (854s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[165.490293] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[169.951499] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.464s)
[171.132665] [029/133] (848s left) i915_suspend (sysfs-reader)
[171.187198] Starting subtest: sysfs-reader
[189.644030] Subtest sysfs-reader: SUCCESS (3.229s)
[189.732773] [030/133] (830s left) gem_exec_params (sol-reset-invalid)
[189.800159] Starting subtest: sol-reset-invalid
[189.804190] Subtest sol-reset-invalid: SUCCESS (0.003s)
[191.626410] [031/133] (828s left) sysfs_timeslice_duration (timeout)
[191.680786] Starting subtest: timeout
[191.683100] Starting dynamic subtest: vecs0
[201.534176] Dynamic subtest vecs0: SUCCESS (9.900s)
[201.546260] Starting dynamic subtest: ccs0
[202.730442] Dynamic subtest ccs0: SUCCESS (1.200s)
[202.743692] Starting dynamic subtest: vcs0
[212.553150] Dynamic subtest vcs0: SUCCESS (9.835s)
[212.565338] Starting dynamic subtest: bcs0
[213.090916] Dynamic subtest bcs0: SUCCESS (0.538s)
[213.103328] Starting dynamic subtest: rcs0
[214.295249] Dynamic subtest rcs0: SUCCESS (1.200s)
[214.308030] Starting dynamic subtest: vcs1
[223.548538] Dynamic subtest vcs1: SUCCESS (9.253s)
[223.551263] Subtest timeout: SUCCESS (31.938s)
[223.630674] [032/133] (796s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[223.740682] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[228.017123] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.278s)
[229.127592] [033/133] (790s left) kms_psr (pr-primary-blt)
[229.232007] Starting subtest: pr-primary-blt
[229.236405] Subtest pr-primary-blt: SKIP (0.000s)
[229.302780] [034/133] (790s left) kms_atomic_transition (modeset-transition-nonblocking)
[229.395256] Starting subtest: modeset-transition-nonblocking
[229.397452] Starting dynamic subtest: 1x-outputs
[240.391797] Dynamic subtest 1x-outputs: SUCCESS (10.996s)
[240.394279] Subtest modeset-transition-nonblocking: SUCCESS (10.998s)
[241.258999] [035/133] (778s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[241.351540] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[245.487022] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.139s)
[246.676254] [036/133] (773s left) kms_flip (2x-busy-flip)
[246.775743] Starting subtest: 2x-busy-flip
[246.784131] Subtest 2x-busy-flip: SKIP (0.011s)
[246.865478] [037/133] (773s left) gem_reg_read (bad-register)
[246.914506] Starting subtest: bad-register
[246.916330] Subtest bad-register: SUCCESS (0.000s)
[247.010768] [038/133] (773s left) syncobj_wait (multi-wait-for-submit-submitted)
[247.063077] Starting subtest: multi-wait-for-submit-submitted
[247.172206] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s)
[247.247871] [039/133] (773s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[247.793902] Starting subtest: syncobj-stationary-timeline-chain-engines
[247.904431] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.109s)
[249.618963] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[249.623491] [040/133] (770s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[249.711930] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[249.716300] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[250.811339] [041/133] (769s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[250.919542] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[259.554707] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.640s)
[259.657679] [042/133] (760s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[259.779510] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[259.784277] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[259.926726] [043/133] (760s left) kms_addfb_basic (tile-pitch-mismatch)
[259.983665] Starting subtest: tile-pitch-mismatch
[259.987945] Subtest tile-pitch-mismatch: SKIP (0.000s)
[260.137714] [044/133] (760s left) gem_lmem_swapping (verify)
[260.181879] Subtest verify: SKIP (0.000s)
[260.222477] [045/133] (760s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[260.343704] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[260.348277] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[260.501368] [046/133] (760s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[260.604209] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[260.606229] Starting dynamic subtest: pipe-A-eDP-1
[260.678382] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[260.689592] Starting dynamic subtest: pipe-B-eDP-1
[261.769056] Dynamic subtest pipe-B-eDP-1: SKIP (1.089s)
[261.773427] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.168s)
[262.969519] [047/133] (757s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[263.069969] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[266.614525] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.550s)
[267.781426] [048/133] (752s left) kms_pm_backlight (basic-brightness)
[267.871466] Starting subtest: basic-brightness
[267.919163] Starting dynamic subtest: eDP-1
[268.425737] Dynamic subtest eDP-1: SUCCESS (0.505s)
[268.427955] Subtest basic-brightness: SUCCESS (0.556s)
[269.288952] [049/133] (751s left) gen9_exec_parse (bb-large)
[269.351611] Subtest bb-large: SKIP (0.000s)
[269.426553] [050/133] (751s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[269.528258] Starting subtest: 4-tiled-8bpp-rotate-270
[269.550793] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s)
[269.658376] [051/133] (751s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[269.740238] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[269.742352] Starting dynamic subtest: pipe-A-default-mode
[270.861403] Dynamic subtest pipe-A-default-mode: SKIP (1.118s)
[270.865483] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.119s)
[270.998689] [052/133] (749s left) kms_plane (plane-position-hole-dpms)
[271.093292] Starting subtest: plane-position-hole-dpms
[271.608576] Starting dynamic subtest: pipe-A-plane-1
[274.006035] Dynamic subtest pipe-A-plane-1: SUCCESS (2.398s)
[274.016898] Starting dynamic subtest: pipe-A-plane-2
[276.360276] Dynamic subtest pipe-A-plane-2: SUCCESS (2.357s)
[276.372272] Starting dynamic subtest: pipe-A-plane-3
[278.733608] Dynamic subtest pipe-A-plane-3: SUCCESS (2.370s)
[278.744893] Starting dynamic subtest: pipe-A-plane-4
[281.082825] Dynamic subtest pipe-A-plane-4: SUCCESS (2.348s)
[281.098281] Starting dynamic subtest: pipe-A-plane-5
[281.108903] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[282.267387] Starting dynamic subtest: pipe-B-plane-1
[284.620962] Dynamic subtest pipe-B-plane-1: SUCCESS (2.364s)
[284.631850] Starting dynamic subtest: pipe-B-plane-2
[286.899897] Dynamic subtest pipe-B-plane-2: SUCCESS (2.278s)
[286.911907] Starting dynamic subtest: pipe-B-plane-3
[289.283538] Dynamic subtest pipe-B-plane-3: SUCCESS (2.382s)
[289.293622] Starting dynamic subtest: pipe-B-plane-4
[291.634205] Dynamic subtest pipe-B-plane-4: SUCCESS (2.347s)
[291.645654] Starting dynamic subtest: pipe-B-plane-5
[291.659112] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[291.661421] Subtest plane-position-hole-dpms: SUCCESS (20.566s)
[292.446445] [053/133] (728s left) gem_ctx_shared (exec-shared-gtt)
[292.513145] Starting subtest: exec-shared-gtt
[292.515547] Starting dynamic subtest: rcs0
[292.518833] Dynamic subtest rcs0: SUCCESS (0.008s)
[292.530576] Starting dynamic subtest: bcs0
[292.532546] Dynamic subtest bcs0: SUCCESS (0.006s)
[292.543145] Starting dynamic subtest: vcs0
[292.545444] Dynamic subtest vcs0: SUCCESS (0.007s)
[292.555737] Starting dynamic subtest: vcs1
[292.557649] Dynamic subtest vcs1: SUCCESS (0.006s)
[292.569304] Starting dynamic subtest: vecs0
[292.571185] Dynamic subtest vecs0: SUCCESS (0.006s)
[292.580627] Starting dynamic subtest: ccs0
[292.582531] Dynamic subtest ccs0: SUCCESS (0.005s)
[292.584363] Subtest exec-shared-gtt: SUCCESS (0.041s)
[292.742726] [054/133] (728s left) gem_exec_balancer (hang)
[293.004177] Starting subtest: hang
[294.682419] Subtest hang: SUCCESS (1.682s)
[294.795776] [055/133] (726s left) api_intel_allocator (reopen-fork)
[294.849278] Starting subtest: reopen-fork
[298.109452] Subtest reopen-fork: SUCCESS (3.260s)
[298.204916] [056/133] (722s left) gem_mmap_gtt (basic-write-read)
[298.257837] Subtest basic-write-read: SKIP (0.000s)
[298.317227] [057/133] (722s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[298.370617] Starting subtest: etime-single-wait-for-submit-unsubmitted
[298.476403] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[298.554791] [058/133] (722s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[298.661878] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[298.666442] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[298.756105] [059/133] (722s left) kms_prime (d3hot)
[298.830489] Subtest D3hot: SKIP (0.000s)
[298.926991] [060/133] (722s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[298.998778] Starting subtest: y-tiled-to-vebox-yf-tiled
[299.003614] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[299.197152] [061/133] (722s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[299.294079] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[306.604337] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.313s)
[306.721582] [062/133] (714s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[306.821233] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[306.823548] Starting dynamic subtest: pipe-A-eDP-1
[318.149657] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.332s)
[318.159727] Starting dynamic subtest: pipe-B-eDP-1
[330.181144] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.030s)
[330.183634] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.365s)
[331.031484] [063/133] (690s left) kms_atomic_interruptible (legacy-cursor)
[331.120310] Starting subtest: legacy-cursor
[331.122533] Starting dynamic subtest: pipe-A-eDP-1
[338.531620] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.411s)
[338.533775] Subtest legacy-cursor: SUCCESS (7.412s)
[339.371019] [064/133] (682s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[339.465293] Starting subtest: primary-x-tiled-reflect-x-180
[346.318195] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.856s)
[347.542876] [065/133] (673s left) kms_chamelium_edid (hdmi-edid-read)
[347.940794] Subtest hdmi-edid-read: SKIP (0.000s)
[348.744398] [066/133] (672s left) syncobj_timeline (device-signal-unordered)
[348.800090] Starting subtest: device-signal-unordered
[348.802443] Subtest device-signal-unordered: SUCCESS (0.001s)
[348.898838] [067/133] (672s left) syncobj_wait (single-wait-for-submit-submitted)
[348.946282] Starting subtest: single-wait-for-submit-submitted
[349.052678] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[349.131476] [068/133] (672s left) gem_userptr_blits (unsync-overlap)
[349.206527] Subtest unsync-overlap: SKIP (0.000s)
[349.319609] [069/133] (672s left) gem_spin_batch (user-each)
[349.372401] Starting subtest: user-each
[352.642747] Subtest user-each: SUCCESS (3.264s)
[354.600737] [070/133] (667s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[354.652650] Starting subtest: invalid-signal-one-illegal-handle
[354.654957] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[354.756980] [071/133] (666s left) kms_cursor_crc (cursor-offscreen-128x128)
[354.959097] Starting subtest: cursor-offscreen-128x128
[354.964080] Starting dynamic subtest: pipe-A-eDP-1
[356.899124] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[356.927866] Starting dynamic subtest: pipe-D-eDP-1
[359.476921] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[359.479172] Subtest cursor-offscreen-128x128: SUCCESS (4.519s)
[360.325547] [072/133] (661s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[360.420433] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[360.422671] Starting dynamic subtest: pipe-A-eDP-1
[360.442396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[360.454797] Starting dynamic subtest: pipe-B-eDP-1
[360.473945] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[360.484387] Starting dynamic subtest: pipe-C-eDP-1
[360.503970] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[360.513915] Starting dynamic subtest: pipe-D-eDP-1
[360.533272] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[360.535438] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[362.604304] [073/133] (659s left) kms_plane (pixel-format-linear-modifier)
[362.693497] Starting subtest: pixel-format-linear-modifier
[362.720847] Starting dynamic subtest: pipe-A-plane-0
[366.308306] Dynamic subtest pipe-A-plane-0: SUCCESS (3.589s)
[366.325157] Starting dynamic subtest: pipe-A-plane-3
[367.953033] Dynamic subtest pipe-A-plane-3: SUCCESS (1.643s)
[367.966283] Starting dynamic subtest: pipe-A-plane-5
[368.174734] Dynamic subtest pipe-A-plane-5: SUCCESS (0.220s)
[369.300923] Starting dynamic subtest: pipe-B-plane-0
[372.821594] Dynamic subtest pipe-B-plane-0: SUCCESS (3.533s)
[372.841656] Starting dynamic subtest: pipe-B-plane-3
[374.523004] Dynamic subtest pipe-B-plane-3: SUCCESS (1.698s)
[374.534307] Starting dynamic subtest: pipe-B-plane-5
[374.731465] Dynamic subtest pipe-B-plane-5: SUCCESS (0.208s)
[375.046312] Subtest pixel-format-linear-modifier: SUCCESS (12.354s)
[375.865264] [074/133] (645s left) kms_big_fb (linear-8bpp-rotate-270)
[375.972941] Starting subtest: linear-8bpp-rotate-270
[375.993665] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[376.113556] [075/133] (645s left) kms_psr (fbc-pr-sprite-plane-onoff)
[376.208653] Starting subtest: fbc-pr-sprite-plane-onoff
[376.213022] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[376.296864] [076/133] (645s left) gem_exec_whisper (basic-queues-priority-all)
[376.353864] Starting subtest: basic-queues-priority-all
[397.851250] Subtest basic-queues-priority-all: SUCCESS (21.499s)
[398.034070] [077/133] (623s left) core_setmaster (master-drop-set-shared-fd)
[398.115135] Starting subtest: master-drop-set-shared-fd
[398.137008] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[398.174198] [078/133] (623s left) gem_exec_capture (capture-recoverable)
[398.239889] Starting subtest: capture-recoverable
[398.241909] Subtest capture-recoverable: SUCCESS (0.005s)
[398.369462] [079/133] (623s left) kms_psr (psr-no-drrs)
[398.472191] Starting subtest: psr-no-drrs
[398.474487] Starting dynamic subtest: eDP-1
[400.138140] Dynamic subtest eDP-1: SUCCESS (1.668s)
[400.140472] Subtest psr-no-drrs: SUCCESS (1.669s)
[401.026620] [080/133] (621s left) gem_partial_pwrite_pread (write-uncached)
[401.087555] Subtest write-uncached: SKIP (0.000s)
[401.155166] [081/133] (620s left) gem_exec_params (batch-first)
[401.207402] Starting subtest: batch-first
[401.215601] Subtest batch-first: SUCCESS (0.008s)
[401.362400] [082/133] (620s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[401.427720] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[401.430137] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[401.543618] [083/133] (620s left) gen3_render_tiledy_blits
[401.660289] [084/133] (620s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[401.714661] Subtest writes-after-reads-uncached: SKIP (0.000s)
[401.782945] [085/133] (620s left) kms_flip (2x-flip-vs-suspend-interruptible)
[401.877449] Starting subtest: 2x-flip-vs-suspend-interruptible
[401.881950] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[401.987696] [086/133] (620s left) perf (polling-parameterized)
[402.100481] Starting subtest: polling-parameterized
[422.123035] Subtest polling-parameterized: SUCCESS (20.022s)
[422.174058] [087/133] (600s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[422.236863] Starting subtest: multi-wait-all-for-submit-submitted
[422.340460] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[422.417851] [088/133] (600s left) gem_exec_schedule (u-submit-late-slice)
[422.482070] Starting subtest: u-submit-late-slice
[422.483978] Starting dynamic subtest: rcs0
[422.531798] Dynamic subtest rcs0: SUCCESS (0.058s)
[422.543905] Starting dynamic subtest: bcs0
[422.579398] Dynamic subtest bcs0: SUCCESS (0.047s)
[422.591630] Starting dynamic subtest: vcs0
[422.633045] Dynamic subtest vcs0: SUCCESS (0.051s)
[422.645931] Starting dynamic subtest: vcs1
[422.671184] Dynamic subtest vcs1: SUCCESS (0.038s)
[422.686087] Starting dynamic subtest: vecs0
[422.721901] Dynamic subtest vecs0: SUCCESS (0.050s)
[422.734318] Starting dynamic subtest: ccs0
[422.769624] Dynamic subtest ccs0: SUCCESS (0.046s)
[422.772114] Subtest u-submit-late-slice: SUCCESS (0.298s)
[424.613904] [089/133] (597s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[424.706257] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[424.708564] Starting dynamic subtest: pipe-A-eDP-1
[424.731549] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[424.743075] Starting dynamic subtest: pipe-B-eDP-1
[424.764588] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[424.775524] Starting dynamic subtest: pipe-C-eDP-1
[424.796962] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[424.809181] Starting dynamic subtest: pipe-D-eDP-1
[424.830730] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[424.834830] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[426.891150] [090/133] (595s left) syncobj_timeline (transfer-timeline-point)
[426.941539] Starting subtest: transfer-timeline-point
[426.943814] Subtest transfer-timeline-point: SUCCESS (0.000s)
[427.068679] [091/133] (595s left) gem_tiled_partial_pwrite_pread (reads)
[427.129568] Subtest reads: SKIP (0.000s)
[427.202184] [092/133] (595s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[427.307866] Starting subtest: y-tiled-64bpp-rotate-180
[427.312314] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[427.401106] [093/133] (595s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[427.501806] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[427.506009] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[427.593090] [094/133] (595s left) kms_cursor_crc (cursor-random-64x21)
[427.783114] Starting subtest: cursor-random-64x21
[427.826378] Subtest cursor-random-64x21: SKIP (0.040s)
[428.069627] [095/133] (594s left) kms_color (invalid-degamma-lut-sizes)
[428.158653] Starting subtest: invalid-degamma-lut-sizes
[428.160525] Starting dynamic subtest: pipe-A
[428.446828] Dynamic subtest pipe-A: SUCCESS (0.286s)
[428.460271] Starting dynamic subtest: pipe-B
[428.462623] Dynamic subtest pipe-B: SUCCESS (0.000s)
[428.473020] Starting dynamic subtest: pipe-C
[428.475391] Dynamic subtest pipe-C: SUCCESS (0.000s)
[428.485348] Starting dynamic subtest: pipe-D
[428.487236] Dynamic subtest pipe-D: SUCCESS (0.000s)
[428.489198] Subtest invalid-degamma-lut-sizes: SUCCESS (0.290s)
[429.318976] [096/133] (593s left) i915_pm_rc6_residency (rc6-fence)
[429.381261] Starting subtest: rc6-fence
[429.397886] Starting dynamic subtest: gt0
[441.715834] Dynamic subtest gt0: SUCCESS (12.314s)
[441.728586] Starting dynamic subtest: gt1
[457.480467] Dynamic subtest gt1: SUCCESS (15.758s)
[457.483045] Subtest rc6-fence: SUCCESS (28.094s)
[457.572085] [097/133] (565s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[457.706382] Starting subtest: cursorA-vs-flipB-legacy
[457.710888] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[457.872369] [098/133] (564s left) gem_exec_schedule (preempt-engines)
[457.945840] Starting subtest: preempt-engines
[457.948011] Starting dynamic subtest: rcs0
[460.184530] Dynamic subtest rcs0: SUCCESS (2.246s)
[460.200985] Starting dynamic subtest: bcs0
[462.433557] Dynamic subtest bcs0: SUCCESS (2.246s)
[462.446388] Starting dynamic subtest: vcs0
[464.714640] Dynamic subtest vcs0: SUCCESS (2.280s)
[464.725890] Starting dynamic subtest: vcs1
[466.986501] Dynamic subtest vcs1: SUCCESS (2.269s)
[467.001304] Starting dynamic subtest: vecs0
[469.251768] Dynamic subtest vecs0: SUCCESS (2.262s)
[469.277103] Starting dynamic subtest: ccs0
[471.550937] Dynamic subtest ccs0: SUCCESS (2.297s)
[471.554058] Subtest preempt-engines: SUCCESS (13.611s)
[471.853474] [099/133] (551s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[471.961559] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[471.963898] Starting dynamic subtest: A-eDP1
[480.858692] Dynamic subtest A-eDP1: SUCCESS (8.896s)
[480.873360] Starting dynamic subtest: B-eDP1
[489.788276] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[489.799545] Starting dynamic subtest: C-eDP1
[498.705337] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[498.718810] Starting dynamic subtest: D-eDP1
[507.628174] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[507.632998] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.672s)
[508.847653] [100/133] (514s left) kms_lease (lease-invalid-crtc)
[508.952416] Starting subtest: lease-invalid-crtc
[508.954637] Starting dynamic subtest: pipe-A-eDP-1
[508.956897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[508.967767] Starting dynamic subtest: pipe-B-eDP-1
[508.969940] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[508.980928] Starting dynamic subtest: pipe-C-eDP-1
[508.983073] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[508.996202] Starting dynamic subtest: pipe-D-eDP-1
[508.998376] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[509.000535] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[509.039876] [101/133] (513s left) kms_chamelium_audio (dp-audio-edid)
[509.414733] Subtest dp-audio-edid: SKIP (0.000s)
[510.257392] [102/133] (512s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[510.355597] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[510.360144] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[510.444308] [103/133] (512s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[510.539275] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[510.543983] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[510.646008] [104/133] (512s left) gem_ctx_engines (execute-oneforall)
[510.703637] Starting subtest: execute-oneforall
[511.228823] Subtest execute-oneforall: SUCCESS (0.525s)
[512.625147] [105/133] (510s left) api_intel_bb (object-reloc-keep-cache)
[512.684625] Starting subtest: object-reloc-keep-cache
[512.689066] Subtest object-reloc-keep-cache: SKIP (0.003s)
[512.801397] [106/133] (510s left) core_auth (many-magics)
[512.858838] Starting subtest: many-magics
[513.579938] Subtest many-magics: SUCCESS (0.724s)
[513.794827] [107/133] (509s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[513.902820] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[513.907253] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[514.006840] [108/133] (509s left) kms_content_protection (atomic-dpms)
[514.156920] Starting subtest: atomic-dpms
[514.161290] Subtest atomic-dpms: SKIP (0.000s)
[514.289038] [109/133] (509s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[514.383684] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[514.387964] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[514.480663] [110/133] (508s left) gem_exec_params (invalid-flag)
[514.534606] Starting subtest: invalid-flag
[514.537010] Subtest invalid-flag: SUCCESS (0.000s)
[514.670846] [111/133] (508s left) prime_mmap (test_correct)
[514.726704] Starting subtest: test_correct
[514.728668] Starting dynamic subtest: test_correct-smem
[514.754355] Dynamic subtest test_correct-smem: SUCCESS (0.030s)
[514.756273] Subtest test_correct: SUCCESS (0.031s)
[514.860316] [112/133] (508s left) kms_psr (fbc-psr-sprite-plane-move)
[514.947716] Starting subtest: fbc-psr-sprite-plane-move
[514.949593] Starting dynamic subtest: eDP-1
[514.952952] Dynamic subtest eDP-1: SKIP (0.000s)
[514.956317] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[515.021192] [113/133] (508s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[515.121508] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[515.124954] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[515.211946] [114/133] (508s left) gem_wait (wait)
[515.278291] Starting subtest: wait
[515.280276] Starting dynamic subtest: all-engines
[516.488372] Dynamic subtest all-engines: SUCCESS (1.207s)
[516.503608] Starting dynamic subtest: rcs0
[517.533209] Dynamic subtest rcs0: SUCCESS (1.044s)
[517.546904] Starting dynamic subtest: bcs0
[518.579599] Dynamic subtest bcs0: SUCCESS (1.045s)
[518.593177] Starting dynamic subtest: vcs0
[519.624648] Dynamic subtest vcs0: SUCCESS (1.043s)
[519.636475] Starting dynamic subtest: vcs1
[520.670708] Dynamic subtest vcs1: SUCCESS (1.044s)
[520.683973] Starting dynamic subtest: vecs0
[521.715968] Dynamic subtest vecs0: SUCCESS (1.043s)
[521.729079] Starting dynamic subtest: ccs0
[522.763645] Dynamic subtest ccs0: SUCCESS (1.046s)
[522.766338] Subtest wait: SUCCESS (7.486s)
[522.967699] [115/133] (500s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[523.099431] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[523.103233] Starting dynamic subtest: A-eDP1
[526.694854] Dynamic subtest A-eDP1: SUCCESS (3.590s)
[526.706709] Starting dynamic subtest: B-eDP1
[529.929953] Dynamic subtest B-eDP1: SUCCESS (3.236s)
[529.941962] Starting dynamic subtest: C-eDP1
[533.110525] Dynamic subtest C-eDP1: SUCCESS (3.179s)
[533.124805] Starting dynamic subtest: D-eDP1
[536.217464] Dynamic subtest D-eDP1: SUCCESS (3.105s)
[536.219844] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.122s)
[537.041108] [116/133] (486s left) kms_joiner (basic-force-ultra-joiner)
[537.141522] Starting subtest: basic-force-ultra-joiner
[537.145852] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[537.210180] [117/133] (486s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[537.312738] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[541.040967] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.732s)
[542.211807] [118/133] (481s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[542.311550] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[542.313967] Starting dynamic subtest: pipe-A-eDP-1
[542.427998] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s)
[542.440840] Starting dynamic subtest: pipe-B-eDP-1
[543.591461] Dynamic subtest pipe-B-eDP-1: SKIP (1.162s)
[543.596027] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.285s)
[544.765176] [119/133] (478s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[544.869871] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[545.961247] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.093s)
[546.096046] [120/133] (477s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[546.203362] Starting subtest: stress-xrgb8888-xtiled
[551.994736] Subtest stress-xrgb8888-xtiled: SUCCESS (5.792s)
[552.055956] [121/133] (471s left) gem_pxp (reject-modify-context-protection-off-3)
[552.173260] Starting subtest: reject-modify-context-protection-off-3
[552.175360] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[552.282741] [122/133] (471s left) kms_plane_multiple (2x-tiling-4)
[552.368728] Starting subtest: 2x-tiling-4
[552.372431] Subtest 2x-tiling-4: SKIP (0.000s)
[552.442131] [123/133] (471s left) vgem_basic (second-client)
[552.482825] Starting subtest: second-client
[552.504271] Subtest second-client: SUCCESS (0.022s)
[552.566981] [124/133] (471s left) gem_mmap_gtt (basic-read-write)
[552.618737] Subtest basic-read-write: SKIP (0.000s)
[552.676308] [125/133] (471s left) gem_exec_schedule (preempt-user)
[552.747081] Starting subtest: preempt-user
[552.748732] Starting dynamic subtest: rcs0
[552.766114] Dynamic subtest rcs0: SUCCESS (0.023s)
[552.780006] Starting dynamic subtest: bcs0
[552.784107] Dynamic subtest bcs0: SUCCESS (0.018s)
[552.794182] Starting dynamic subtest: vcs0
[552.803832] Dynamic subtest vcs0: SUCCESS (0.019s)
[552.813954] Starting dynamic subtest: vcs1
[552.825144] Dynamic subtest vcs1: SUCCESS (0.021s)
[552.835363] Starting dynamic subtest: vecs0
[552.845608] Dynamic subtest vecs0: SUCCESS (0.020s)
[552.856016] Starting dynamic subtest: ccs0
[552.868575] Dynamic subtest ccs0: SUCCESS (0.022s)
[552.870397] Subtest preempt-user: SUCCESS (0.126s)
[554.574321] [126/133] (469s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[554.669304] Starting subtest: addfb25-y-tiled-legacy
[554.671454] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[554.757533] [127/133] (469s left) gem_exec_params (rs-invalid)
[554.820757] Starting subtest: rs-invalid
[554.825946] Subtest rs-invalid: SUCCESS (0.003s)
[554.938622] [128/133] (469s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[555.028389] Starting subtest: psr-rgb101010-draw-mmap-wc
[562.081990] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.057s)
[562.199403] [129/133] (461s left) gem_mmap_offset (bad-object)
[562.271502] Starting subtest: bad-object
[562.273778] Subtest bad-object: SUCCESS (0.001s)
[562.358380] [130/133] (461s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[562.451822] Starting subtest: fbcpsr-shrfb-scaledprimary
[568.277844] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.829s)
[568.450516] [131/133] (455s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[568.544894] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[568.549042] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[568.639630] [132/133] (455s left) kms_atomic_transition (plane-all-transition-nonblocking)
[568.733770] Starting subtest: plane-all-transition-nonblocking
[568.736045] Starting dynamic subtest: pipe-A-eDP-1
[571.226316] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[571.534221] Starting dynamic subtest: pipe-B-eDP-1
[574.732663] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.207s)
[575.039097] Subtest plane-all-transition-nonblocking: SUCCESS (6.306s)
[575.850740] [133/133] (448s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[575.946643] Starting subtest: sprite-rotation-90-pos-100-0
[575.950709] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[576.017518] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_busy
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: i915_hangman
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: gem_workarounds
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_ctx_persistence
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: i915_drm_fdinfo
results: parsing output: 18/ for test: kms_chamelium_hpd
results: parsing output: 19/ for test: kms_universal_plane
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: gem_mmap
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: kms_draw_crc
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: gem_ppgtt
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: i915_suspend
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: sysfs_timeslice_duration
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_atomic_transition
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: gem_reg_read
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_pm_backlight
results: parsing output: 48/ for test: gen9_exec_parse
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: gem_ctx_shared
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: api_intel_allocator
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_prime
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_atomic_interruptible
results: parsing output: 63/ for test: kms_rotation_crc
results: parsing output: 64/ for test: kms_chamelium_edid
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: gem_spin_batch
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: core_setmaster
results: parsing output: 77/ for test: gem_exec_capture
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_partial_pwrite_pread
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gen3_render_tiledy_blits
results: parsing output: 83/ for test: gem_partial_pwrite_pread
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: i915_pm_rc6_residency
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: kms_chamelium_audio
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_engines
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: core_auth
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: prime_mmap
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_wait
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_joiner
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_pipe_stress
results: parsing output: 120/ for test: gem_pxp
results: parsing output: 121/ for test: kms_plane_multiple
results: parsing output: 122/ for test: vgem_basic
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_mmap_offset
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_atomic_transition
results: parsing output: 132/ for test: kms_rotation_crc
Done.