[60.163879] Initializing watchdogs
[60.163924]   /dev/watchdog0
[60.177320] [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]
[60.181715] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.183874] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.187254] [001/133] (960s left) gem_softpin (noreloc-s3)
[60.271807] Starting subtest: noreloc-S3
[81.040799] Subtest noreloc-S3: SUCCESS (5.397s)
[81.155181] [002/133] (939s left) perf_pmu (gt-awake)
[81.202532] Starting subtest: gt-awake
[89.429422] Subtest gt-awake: SUCCESS (8.341s)
[89.525195] [003/133] (931s left) kms_invalid_mode (zero-hdisplay)
[89.636727] Starting subtest: zero-hdisplay
[89.638954] Starting dynamic subtest: pipe-A-eDP-1
[89.932893] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[89.942116] Starting dynamic subtest: pipe-B-eDP-1
[89.943988] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[89.951559] Starting dynamic subtest: pipe-C-eDP-1
[89.953687] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[89.961335] Starting dynamic subtest: pipe-D-eDP-1
[89.963433] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[89.965638] Subtest zero-hdisplay: SUCCESS (0.302s)
[90.805620] [004/133] (929s left) kms_prop_blob (invalid-set-prop-any)
[90.861233] Starting subtest: invalid-set-prop-any
[90.863441] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[90.944660] [005/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[91.037358] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[98.518090] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.518s)
[98.686365] [006/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[98.779827] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[98.784136] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[98.895338] [007/133] (922s left) kms_cursor_legacy (torture-move)
[99.020215] Starting subtest: torture-move
[99.022481] Starting dynamic subtest: pipe-A
[105.038409] Dynamic subtest pipe-A: SUCCESS (6.025s)
[105.050195] Starting dynamic subtest: pipe-B
[111.180159] Dynamic subtest pipe-B: SUCCESS (6.145s)
[111.189719] Starting dynamic subtest: pipe-C
[117.372972] Dynamic subtest pipe-C: SUCCESS (6.190s)
[117.384669] Starting dynamic subtest: pipe-D
[123.311108] Dynamic subtest pipe-D: SUCCESS (5.935s)
[123.321414] Starting dynamic subtest: all-pipes
[130.674964] Dynamic subtest all-pipes: SUCCESS (7.362s)
[130.677686] Subtest torture-move: SUCCESS (31.661s)
[130.827533] [008/133] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[130.942126] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[134.575906] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.637s)
[135.787693] [009/133] (885s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[135.887425] Starting subtest: fbc-rgb101010-draw-blt
[140.477567] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.595s)
[141.586259] [010/133] (879s left) gem_pxp (create-regular-context-2)
[141.698544] Starting subtest: create-regular-context-2
[141.701050] Subtest create-regular-context-2: SUCCESS (0.002s)
[141.816123] [011/133] (879s left) kms_flip (2x-flip-vs-panning-interruptible)
[141.918682] Starting subtest: 2x-flip-vs-panning-interruptible
[141.930772] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[142.005923] [012/133] (879s left) kms_plane_alpha_blend (constant-alpha-max)
[142.090235] Starting subtest: constant-alpha-max
[142.367735] Starting dynamic subtest: pipe-A-eDP-1
[143.404419] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.035s)
[143.414741] Starting dynamic subtest: pipe-D-eDP-1
[144.968862] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.563s)
[144.971237] Subtest constant-alpha-max: SUCCESS (2.879s)
[145.848476] [013/133] (875s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[145.946055] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[145.972545] Starting dynamic subtest: pipe-A-plane-0
[146.272456] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[146.282382] Starting dynamic subtest: pipe-A-plane-3
[146.505944] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[146.515527] Starting dynamic subtest: pipe-A-plane-5
[146.520096] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[147.633092] Starting dynamic subtest: pipe-B-plane-0
[147.927029] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[147.941811] Starting dynamic subtest: pipe-B-plane-3
[148.158747] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[148.167649] Starting dynamic subtest: pipe-B-plane-5
[148.171931] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[148.470874] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.525s)
[149.302326] [014/133] (871s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[149.362777] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[149.434044] [015/133] (871s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[149.498144] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[149.572583] [016/133] (871s left) gem_vm_create (invalid-destroy)
[149.641207] Starting subtest: invalid-destroy
[149.643613] Subtest invalid-destroy: SUCCESS (0.002s)
[149.746314] [017/133] (871s left) gem_lmem_swapping (heavy-verify-random-ccs)
[149.790378] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[149.830083] [018/133] (871s left) kms_feature_discovery (display-2x)
[149.931205] Starting subtest: display-2x
[149.936055] Subtest display-2x: SKIP (0.000s)
[150.000352] [019/133] (871s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[150.093264] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[150.095410] Starting dynamic subtest: pipe-A-eDP-1
[150.117435] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[150.127659] Starting dynamic subtest: pipe-B-eDP-1
[150.148773] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[150.156643] Starting dynamic subtest: pipe-C-eDP-1
[150.177181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[150.185116] Starting dynamic subtest: pipe-D-eDP-1
[150.205799] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[150.209636] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[152.357957] [020/133] (869s left) gem_mmap_offset (blt-coherency)
[152.428109] Starting subtest: blt-coherency
[152.433009] Subtest blt-coherency: SUCCESS (0.006s)
[152.561948] [021/133] (868s left) gem_pxp (hw-rejects-pxp-context)
[152.616328] Starting subtest: hw-rejects-pxp-context
[152.620754] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[152.706745] [022/133] (868s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[152.795569] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[159.304081] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.514s)
[159.438027] [023/133] (862s left) kms_psr (pr-sprite-mmap-gtt)
[159.554403] Starting subtest: pr-sprite-mmap-gtt
[159.558780] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[159.624537] [024/133] (861s left) gem_exec_reloc (basic-write-gtt-noreloc)
[159.687246] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[159.756404] [025/133] (861s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[159.839385] Starting subtest: plane-lut1d-ctm3x4
[159.973570] Starting dynamic subtest: pipe-A-plane-0
[160.117804] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[160.126250] Starting dynamic subtest: pipe-A-plane-1
[160.250945] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[160.259390] Starting dynamic subtest: pipe-A-plane-2
[160.384802] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[161.560935] Starting dynamic subtest: pipe-B-plane-0
[161.702319] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[161.711604] Starting dynamic subtest: pipe-B-plane-1
[161.835484] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[161.844579] Starting dynamic subtest: pipe-B-plane-2
[161.968782] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[163.189881] Starting dynamic subtest: pipe-C-plane-0
[163.359911] Dynamic subtest pipe-C-plane-0: SUCCESS (0.178s)
[163.368363] Starting dynamic subtest: pipe-C-plane-1
[163.515809] Dynamic subtest pipe-C-plane-1: SUCCESS (0.154s)
[163.525783] Starting dynamic subtest: pipe-C-plane-2
[163.659774] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[164.834677] Starting dynamic subtest: pipe-D-plane-0
[164.990859] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[165.002900] Starting dynamic subtest: pipe-D-plane-1
[165.156563] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[165.170368] Starting dynamic subtest: pipe-D-plane-2
[165.290155] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[165.582596] Subtest plane-lut1d-ctm3x4: SUCCESS (5.745s)
[166.397579] [026/133] (855s left) gem_exec_schedule (preempt-hang)
[166.583024] Starting subtest: preempt-hang
[166.585430] Starting dynamic subtest: rcs0
[166.819687] Dynamic subtest rcs0: SUCCESS (0.236s)
[166.830409] Starting dynamic subtest: bcs0
[167.049080] Dynamic subtest bcs0: SUCCESS (0.227s)
[167.059492] Starting dynamic subtest: vcs0
[167.270060] Dynamic subtest vcs0: SUCCESS (0.220s)
[167.290646] Starting dynamic subtest: vcs1
[167.487559] Dynamic subtest vcs1: SUCCESS (0.217s)
[167.499392] Starting dynamic subtest: vecs0
[167.709877] Dynamic subtest vecs0: SUCCESS (0.221s)
[167.720138] Starting dynamic subtest: ccs0
[167.937520] Dynamic subtest ccs0: SUCCESS (0.226s)
[167.939774] Subtest preempt-hang: SUCCESS (1.355s)
[168.481560] [027/133] (853s left) kms_psr (psr-cursor-mmap-cpu)
[168.572216] Starting subtest: psr-cursor-mmap-cpu
[168.574502] Starting dynamic subtest: eDP-1
[170.289051] Dynamic subtest eDP-1: SUCCESS (1.717s)
[170.291329] Subtest psr-cursor-mmap-cpu: SUCCESS (1.718s)
[171.167531] [028/133] (850s left) gem_exec_whisper (basic-contexts-priority-all)
[171.226751] Starting subtest: basic-contexts-priority-all
[193.554235] Subtest basic-contexts-priority-all: SUCCESS (22.264s)
[193.713942] [029/133] (828s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[193.772627] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[193.855497] [030/133] (828s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[193.979791] Starting subtest: cursorB-vs-flipA-atomic-transitions
[193.984371] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[194.149750] [031/133] (827s left) gem_exec_params (rel-constants-invalid)
[194.201234] Starting subtest: rel-constants-invalid
[194.203136] Subtest rel-constants-invalid: SUCCESS (0.000s)
[194.355965] [032/133] (827s left) kms_joiner (invalid-modeset-ultra-joiner)
[194.450593] Starting subtest: invalid-modeset-ultra-joiner
[194.454802] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[194.527166] [033/133] (827s left) syncobj_wait (invalid-signal-bad-pad)
[194.592641] Starting subtest: invalid-signal-bad-pad
[194.594491] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[194.690680] [034/133] (827s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[194.776007] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[194.788593] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[194.865338] [035/133] (827s left) gem_eio (in-flight-contexts-1us)
[195.094157] Starting subtest: in-flight-contexts-1us
[206.447678] Subtest in-flight-contexts-1us: SUCCESS (11.353s)
[206.611497] [036/133] (815s left) kms_pm_lpsp (kms-lpsp)
[207.703489] Starting subtest: kms-lpsp
[207.705779] Starting dynamic subtest: pipe-A-eDP-1
[207.879832] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.178s)
[208.178797] Subtest kms-lpsp: SUCCESS (0.474s)
[208.995944] [037/133] (813s left) i915_drm_fdinfo (busy-check-all)
[209.036218] Starting subtest: busy-check-all
[209.038468] Starting dynamic subtest: rcs0
[209.043235] Dynamic subtest rcs0: SKIP (0.004s)
[209.052241] Starting dynamic subtest: bcs0
[209.056216] Dynamic subtest bcs0: SKIP (0.000s)
[209.064926] Starting dynamic subtest: vcs0
[209.069255] Dynamic subtest vcs0: SKIP (0.000s)
[209.077455] Starting dynamic subtest: vcs1
[209.081324] Dynamic subtest vcs1: SKIP (0.000s)
[209.089443] Starting dynamic subtest: vecs0
[209.093278] Dynamic subtest vecs0: SKIP (0.001s)
[209.101382] Starting dynamic subtest: ccs0
[209.105238] Dynamic subtest ccs0: SKIP (0.000s)
[209.109148] Subtest busy-check-all: SKIP (0.009s)
[209.143572] [038/133] (813s left) drm_read (fault-buffer)
[209.277490] Starting subtest: fault-buffer
[209.279906] Subtest fault-buffer: SUCCESS (0.000s)
[209.391819] [039/133] (812s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[209.498126] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[210.567718] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.070s)
[210.672785] [040/133] (811s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[210.765528] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[210.767113] Starting dynamic subtest: pipe-A-eDP-1
[211.552512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.780s)
[211.561528] Starting dynamic subtest: pipe-B-eDP-1
[213.112083] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.557s)
[213.122526] Starting dynamic subtest: pipe-C-eDP-1
[214.589344] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.476s)
[214.599975] Starting dynamic subtest: pipe-D-eDP-1
[216.058867] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.469s)
[216.061166] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.287s)
[217.225427] [041/133] (805s left) gem_ctx_shared (create-shared-gtt)
[217.292933] Starting subtest: create-shared-gtt
[219.499606] Subtest create-shared-gtt: SUCCESS (2.151s)
[219.778919] [042/133] (802s left) gem_sync (basic-store-each)
[219.853687] Starting subtest: basic-store-each
[222.558462] Subtest basic-store-each: SUCCESS (2.715s)
[222.740739] [043/133] (799s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[222.840109] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[222.842462] Starting dynamic subtest: A-eDP1
[231.771890] Dynamic subtest A-eDP1: SUCCESS (8.932s)
[231.784790] Starting dynamic subtest: B-eDP1
[240.695469] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[240.706504] Starting dynamic subtest: C-eDP1
[249.666913] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[249.681893] Starting dynamic subtest: D-eDP1
[258.590847] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[258.593084] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.715s)
[259.758335] [044/133] (762s left) i915_pm_freq_api (freq-basic-api)
[259.827937] Starting subtest: freq-basic-api
[259.830338] Starting dynamic subtest: gt0
[259.832716] Dynamic subtest gt0: SUCCESS (0.003s)
[259.843856] Starting dynamic subtest: gt1
[259.845754] Dynamic subtest gt1: SUCCESS (0.002s)
[259.847692] Subtest freq-basic-api: SUCCESS (0.006s)
[259.922786] [045/133] (762s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[260.020142] Starting subtest: plane-use-after-nonblocking-unbind
[260.022402] Starting dynamic subtest: pipe-A-eDP-1
[260.079747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[260.385882] Starting dynamic subtest: pipe-B-eDP-1
[261.159423] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[261.458944] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.439s)
[262.320575] [046/133] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[262.408536] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[262.412614] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[262.511879] [047/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[262.606548] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[262.610558] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[262.704944] [048/133] (759s left) kms_getfb (getfb2-handle-closed)
[262.782466] Starting subtest: getfb2-handle-closed
[262.784780] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[262.874644] [049/133] (759s left) kms_psr (fbc-pr-no-drrs)
[262.961381] Starting subtest: fbc-pr-no-drrs
[262.965768] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[263.034389] [050/133] (759s left) drm_read (short-buffer-nonblock)
[263.197977] Starting subtest: short-buffer-nonblock
[263.200232] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[263.307484] [051/133] (759s left) gen9_exec_parse (bb-secure)
[263.360092] Subtest bb-secure: SKIP (0.000s)
[263.425777] [052/133] (759s left) kms_psr (fbc-pr-sprite-render)
[263.516685] Starting subtest: fbc-pr-sprite-render
[263.520319] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[263.587867] [053/133] (759s left) kms_big_fb (linear-64bpp-rotate-0)
[263.679118] Starting subtest: linear-64bpp-rotate-0
[265.190980] Subtest linear-64bpp-rotate-0: SUCCESS (1.512s)
[265.380696] [054/133] (757s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[265.486973] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[265.491105] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[265.558665] [055/133] (757s left) gem_exec_balancer (full)
[265.621855] Starting subtest: full
[270.240667] Subtest full: SUCCESS (4.620s)
[270.556182] [056/133] (752s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[270.662157] Starting subtest: plane-upscale-20x20-with-pixel-format
[270.664370] Starting dynamic subtest: pipe-A
[271.711920] Dynamic subtest pipe-A: SUCCESS (1.052s)
[271.726553] Starting dynamic subtest: pipe-B
[273.815732] Dynamic subtest pipe-B: SUCCESS (2.103s)
[273.826881] Starting dynamic subtest: pipe-C
[275.011906] Dynamic subtest pipe-C: SUCCESS (1.195s)
[275.021828] Starting dynamic subtest: pipe-D
[276.153762] Dynamic subtest pipe-D: SUCCESS (1.141s)
[276.156114] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.496s)
[277.346956] [057/133] (745s left) kms_flip (modeset-vs-vblank-race-interruptible)
[277.458700] Starting subtest: modeset-vs-vblank-race-interruptible
[277.461081] Starting dynamic subtest: A-eDP1
[282.160667] Dynamic subtest A-eDP1: SUCCESS (4.702s)
[282.172967] Starting dynamic subtest: B-eDP1
[286.794228] Dynamic subtest B-eDP1: SUCCESS (4.633s)
[286.810079] Starting dynamic subtest: C-eDP1
[291.221049] Dynamic subtest C-eDP1: SUCCESS (4.426s)
[291.232120] Starting dynamic subtest: D-eDP1
[295.755494] Dynamic subtest D-eDP1: SUCCESS (4.534s)
[295.760704] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.305s)
[296.909835] [058/133] (726s left) i915_pm_rps (engine-order)
[296.982745] Starting subtest: engine-order
[301.925998] Subtest engine-order: SUCCESS (4.947s)
[302.044200] [059/133] (721s left) kms_plane_cursor (overlay)
[302.142072] Starting subtest: overlay
[302.146456] Starting dynamic subtest: pipe-A-eDP-1-size-64
[304.591900] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.450s)
[304.653460] Starting dynamic subtest: pipe-A-eDP-1-size-128
[307.083078] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.438s)
[307.143031] Starting dynamic subtest: pipe-A-eDP-1-size-256
[309.607456] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s)
[309.957704] Starting dynamic subtest: pipe-B-eDP-1-size-64
[312.997127] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.050s)
[313.058109] Starting dynamic subtest: pipe-B-eDP-1-size-128
[315.533009] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.482s)
[315.592952] Starting dynamic subtest: pipe-B-eDP-1-size-256
[318.058010] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.474s)
[318.405038] Starting dynamic subtest: pipe-C-eDP-1-size-64
[321.257318] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.861s)
[321.295422] Starting dynamic subtest: pipe-C-eDP-1-size-128
[323.379500] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.092s)
[323.418164] Starting dynamic subtest: pipe-C-eDP-1-size-256
[325.480213] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.070s)
[325.810895] Starting dynamic subtest: pipe-D-eDP-1-size-64
[328.525761] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.727s)
[328.564422] Starting dynamic subtest: pipe-D-eDP-1-size-128
[330.737343] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.180s)
[330.775480] Starting dynamic subtest: pipe-D-eDP-1-size-256
[332.982689] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[333.300790] Subtest overlay: SUCCESS (31.149s)
[334.133702] [060/133] (689s left) kms_sequence (queue-busy)
[334.228531] Starting subtest: queue-busy
[334.230756] Starting dynamic subtest: pipe-A-eDP-1
[336.167232] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[336.176691] Starting dynamic subtest: pipe-B-eDP-1
[338.739228] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.570s)
[338.748768] Starting dynamic subtest: pipe-C-eDP-1
[341.352678] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.611s)
[341.362675] Starting dynamic subtest: pipe-D-eDP-1
[343.979907] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.625s)
[343.981982] Subtest queue-busy: SUCCESS (9.751s)
[344.863160] [061/133] (678s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[344.959372] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[344.961616] Starting dynamic subtest: A-eDP1
[348.625910] Dynamic subtest A-eDP1: SUCCESS (3.665s)
[348.635398] Starting dynamic subtest: B-eDP1
[351.912472] Dynamic subtest B-eDP1: SUCCESS (3.286s)
[351.922260] Starting dynamic subtest: C-eDP1
[355.013391] Dynamic subtest C-eDP1: SUCCESS (3.096s)
[355.023901] Starting dynamic subtest: D-eDP1
[358.130567] Dynamic subtest D-eDP1: SUCCESS (3.115s)
[358.132903] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.172s)
[358.936084] [062/133] (664s left) gem_flink_basic (double-flink)
[358.990534] Starting subtest: double-flink
[358.992496] Subtest double-flink: SUCCESS (0.000s)
[359.078677] [063/133] (664s left) gem_ctx_isolation (dirty-switch)
[359.139803] Starting subtest: dirty-switch
[359.142250] Starting dynamic subtest: rcs0
[359.321976] Dynamic subtest rcs0: SUCCESS (0.182s)
[359.331996] Starting dynamic subtest: bcs0
[359.552961] Dynamic subtest bcs0: SUCCESS (0.230s)
[359.562633] Starting dynamic subtest: vcs0
[359.746352] Dynamic subtest vcs0: SUCCESS (0.192s)
[359.757314] Starting dynamic subtest: vcs1
[361.575659] Dynamic subtest vcs1: SUCCESS (1.828s)
[361.589928] Starting dynamic subtest: vecs0
[363.616143] Dynamic subtest vecs0: SUCCESS (2.039s)
[363.627045] Starting dynamic subtest: ccs0
[365.610363] Dynamic subtest ccs0: SUCCESS (1.993s)
[365.612867] Subtest dirty-switch: SUCCESS (6.471s)
[365.834298] [064/133] (657s left) kms_cursor_edge_walk (64x64-top-edge)
[365.943706] Starting subtest: 64x64-top-edge
[365.948819] Starting dynamic subtest: pipe-A-eDP-1
[369.394671] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.448s)
[369.405138] Starting dynamic subtest: pipe-D-eDP-1
[372.526165] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[372.528121] Subtest 64x64-top-edge: SUCCESS (6.580s)
[373.350550] [065/133] (649s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[373.433475] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[373.435787] Starting dynamic subtest: pipe-A-eDP-1
[373.460718] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[373.472945] Starting dynamic subtest: pipe-B-eDP-1
[373.496926] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[373.506213] Starting dynamic subtest: pipe-C-eDP-1
[373.529676] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[373.540944] Starting dynamic subtest: pipe-D-eDP-1
[373.565072] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[373.569409] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[375.618609] [066/133] (647s left) gem_eio (hibernate)
[375.837747] Starting subtest: hibernate
[390.489525] Subtest hibernate: SUCCESS (14.651s)
[398.614124] [067/133] (632s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[398.734062] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[398.745663] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[398.824529] [068/133] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[398.927550] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[398.931762] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[399.024838] [069/133] (632s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[399.146867] Starting subtest: extended-modeset-hang-newfb-with-reset
[399.149160] Starting dynamic subtest: pipe-A
[414.366572] Dynamic subtest pipe-A: SUCCESS (15.217s)
[414.377429] Starting dynamic subtest: pipe-D
[430.465298] Dynamic subtest pipe-D: SUCCESS (16.098s)
[430.467458] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.319s)
[431.266870] [070/133] (600s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[431.360555] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[431.364739] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[431.439615] [071/133] (600s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[431.533818] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[435.247253] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.717s)
[436.371970] [072/133] (595s left) sysfs_preempt_timeout (invalid)
[436.423728] Starting subtest: invalid
[436.426065] Starting dynamic subtest: vecs0
[436.428457] Dynamic subtest vecs0: SUCCESS (0.000s)
[436.438819] Starting dynamic subtest: ccs0
[436.440808] Dynamic subtest ccs0: SUCCESS (0.000s)
[436.449881] Starting dynamic subtest: vcs0
[436.451788] Dynamic subtest vcs0: SUCCESS (0.000s)
[436.462647] Starting dynamic subtest: bcs0
[436.464721] Dynamic subtest bcs0: SUCCESS (0.000s)
[436.476225] Starting dynamic subtest: rcs0
[436.478394] Dynamic subtest rcs0: SUCCESS (0.000s)
[436.488148] Starting dynamic subtest: vcs1
[436.490069] Dynamic subtest vcs1: SUCCESS (0.000s)
[436.492143] Subtest invalid: SUCCESS (0.005s)
[436.531623] [073/133] (595s left) gem_exec_big (single)
[436.587446] Starting subtest: single
[441.409221] Subtest single: SUCCESS (4.823s)
[441.676475] [074/133] (590s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[441.814069] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[441.816423] Starting dynamic subtest: pipe-A-eDP-1
[441.874903] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[441.885104] Starting dynamic subtest: pipe-B-eDP-1
[441.942456] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[441.953216] Starting dynamic subtest: pipe-C-eDP-1
[442.012956] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[442.024396] Starting dynamic subtest: pipe-D-eDP-1
[442.081361] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[442.085936] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[444.118816] [075/133] (587s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[444.225512] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[445.270291] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.044s)
[445.381463] [076/133] (586s left) kms_chamelium_hpd (dp-hpd-storm)
[445.757494] Subtest dp-hpd-storm: SKIP (0.000s)
[446.612939] [077/133] (585s left) i915_query (query-topology-kernel-writes)
[446.673313] Starting subtest: query-topology-kernel-writes
[446.675573] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[446.782026] [078/133] (585s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[446.872531] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[446.876939] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[446.944122] [079/133] (584s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[447.002946] Starting subtest: invalid-bsd2-flag-on-blt
[447.004845] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[447.094449] [080/133] (584s left) sw_sync (sync_busy_fork)
[447.134405] Starting subtest: sync_busy_fork
[448.146536] Subtest sync_busy_fork: SUCCESS (1.010s)
[448.222356] [081/133] (583s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[448.273750] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[448.275788] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[448.367500] [082/133] (583s left) kms_chamelium_frames (hdmi-crc-fast)
[448.753749] Subtest hdmi-crc-fast: SKIP (0.000s)
[449.556536] [083/133] (582s left) gem_flink_basic (flink-lifetime)
[449.611294] Starting subtest: flink-lifetime
[449.613594] Subtest flink-lifetime: SUCCESS (0.002s)
[449.710570] [084/133] (582s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[449.801999] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[449.806262] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[449.885608] [085/133] (582s left) kms_prop_blob (basic)
[449.937976] Starting subtest: basic
[449.940342] Subtest basic: SUCCESS (0.000s)
[450.027424] [086/133] (582s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[450.080309] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[450.182222] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[450.257911] [087/133] (581s left) perf (blocking-parameterized)
[450.407440] Starting subtest: blocking-parameterized
[470.481723] Subtest blocking-parameterized: SUCCESS (20.024s)
[470.557869] [088/133] (561s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[470.619270] Starting subtest: etime-multi-wait-all-submitted-signaled
[470.727135] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[470.827839] [089/133] (561s left) gem_exec_fence (submit-chain)
[471.008150] Starting subtest: submit-chain
[471.038072] Subtest submit-chain: SUCCESS (0.030s)
[473.435731] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[473.439239] [090/133] (558s left) gem_exec_params (mmapped)
[473.512680] Starting subtest: mmapped
[473.518685] Subtest mmapped: SUCCESS (0.006s)
[473.640565] [091/133] (558s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[473.751422] Starting subtest: x-tiled-32bpp-rotate-180
[475.283703] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.536s)
[475.415055] [092/133] (557s left) sw_sync (sync_expired_merge)
[475.455850] Starting subtest: sync_expired_merge
[476.529537] Subtest sync_expired_merge: SUCCESS (1.074s)
[476.595393] [093/133] (555s left) prime_vgem (basic-fence-mmap)
[476.673267] Starting subtest: basic-fence-mmap
[476.678088] Subtest basic-fence-mmap: SKIP (0.000s)
[476.783491] [094/133] (555s left) gem_ctx_shared (disjoint-timelines)
[476.847909] Starting subtest: disjoint-timelines
[476.868145] Subtest disjoint-timelines: SUCCESS (0.020s)
[477.106209] [095/133] (555s left) kms_psr (psr-dpms)
[477.221325] Starting subtest: psr-dpms
[477.223467] Starting dynamic subtest: eDP-1
[480.192944] Dynamic subtest eDP-1: SUCCESS (2.971s)
[480.194818] Subtest psr-dpms: SUCCESS (2.972s)
[481.050980] [096/133] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[481.159809] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[488.532510] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.377s)
[488.680147] [097/133] (544s left) gem_softpin (allocator-nopin)
[488.740972] Starting subtest: allocator-nopin
[488.829502] Subtest allocator-nopin: SUCCESS (0.088s)
[488.962503] [098/133] (543s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[489.057122] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[489.059442] Starting dynamic subtest: pipe-A-default-mode
[490.233111] Dynamic subtest pipe-A-default-mode: SKIP (1.172s)
[490.237073] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.173s)
[490.377141] [099/133] (542s left) gem_exec_flush (basic-wb-pro-default)
[490.443201] Starting subtest: basic-wb-pro-default
[495.930787] Subtest basic-wb-pro-default: SUCCESS (5.465s)
[496.098003] [100/133] (536s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[496.192195] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[496.194517] Starting dynamic subtest: pipe-A-eDP-1
[496.284653] Dynamic subtest pipe-A-eDP-1: SKIP (0.092s)
[496.296062] Starting dynamic subtest: pipe-B-eDP-1
[497.383402] Dynamic subtest pipe-B-eDP-1: SKIP (1.099s)
[497.387696] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.193s)
[498.567481] [101/133] (534s left) syncobj_timeline (single-wait-available-submitted)
[498.621142] Starting subtest: single-wait-available-submitted
[498.623336] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[498.715049] [102/133] (534s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[498.768462] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[498.772542] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[498.962990] [103/133] (534s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[499.070049] Starting subtest: psr-rgb101010-draw-pwrite
[506.568601] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.504s)
[506.690981] [104/133] (526s left) perf (gen8-unprivileged-single-ctx-counters)
[506.782247] Starting subtest: gen8-unprivileged-single-ctx-counters
[506.786672] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[506.828741] [105/133] (526s left) api_intel_allocator (standalone)
[506.882425] Starting subtest: standalone
[506.896347] Subtest standalone: SUCCESS (0.017s)
[507.026381] [106/133] (526s left) kms_getfb (getfb-handle-closed)
[507.140297] Starting subtest: getfb-handle-closed
[507.142485] Subtest getfb-handle-closed: SUCCESS (0.000s)
[507.257191] [107/133] (525s left) perf (mi-rpc)
[507.347680] Starting subtest: mi-rpc
[507.352331] Subtest mi-rpc: SKIP (0.000s)
[507.398046] [108/133] (525s left) kms_async_flips (async-flip-dpms)
[507.490482] Starting subtest: async-flip-dpms
[507.861272] Starting dynamic subtest: pipe-A-eDP-1
[511.664046] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.803s)
[512.033184] Starting dynamic subtest: pipe-B-eDP-1
[514.927599] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.902s)
[515.337513] Starting dynamic subtest: pipe-C-eDP-1
[518.097760] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[518.486791] Starting dynamic subtest: pipe-D-eDP-1
[521.275097] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[521.277440] Subtest async-flip-dpms: SUCCESS (13.787s)
[522.469039] [109/133] (510s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[522.578255] Starting subtest: y-tiled-64bpp-rotate-180
[522.582581] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[522.675999] [110/133] (510s left) gem_close_race (multigpu-basic-process)
[522.743411] Starting subtest: multigpu-basic-process
[522.748018] Subtest multigpu-basic-process: SKIP (0.000s)
[522.978782] [111/133] (510s left) kms_cursor_crc (cursor-offscreen-32x10)
[523.128191] Starting subtest: cursor-offscreen-32x10
[523.178084] Subtest cursor-offscreen-32x10: SKIP (0.045s)
[523.480786] [112/133] (509s left) gem_exec_flush (basic-wb-rw-default)
[523.538509] Starting subtest: basic-wb-rw-default
[529.010923] Subtest basic-wb-rw-default: SUCCESS (5.473s)
[529.199934] [113/133] (504s left) dmabuf_sync_file (export-before-signal)
[529.250245] Starting subtest: export-before-signal
[529.252606] Subtest export-before-signal: SUCCESS (0.001s)
[529.312998] [114/133] (504s left) gem_exec_schedule (preempt-queue-contexts-chain)
[529.390443] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[529.682594] [115/133] (503s left) perf_pmu (semaphore-wait)
[529.725998] Starting subtest: semaphore-wait
[529.728778] Starting dynamic subtest: rcs0
[530.237053] Dynamic subtest rcs0: SUCCESS (0.512s)
[530.250902] Starting dynamic subtest: bcs0
[530.754237] Dynamic subtest bcs0: SUCCESS (0.514s)
[530.768006] Starting dynamic subtest: vcs0
[531.269026] Dynamic subtest vcs0: SUCCESS (0.512s)
[531.282826] Starting dynamic subtest: vcs1
[531.783763] Dynamic subtest vcs1: SUCCESS (0.512s)
[531.796290] Starting dynamic subtest: vecs0
[532.299609] Dynamic subtest vecs0: SUCCESS (0.511s)
[532.312513] Starting dynamic subtest: ccs0
[532.815049] Dynamic subtest ccs0: SUCCESS (0.513s)
[532.818219] Subtest semaphore-wait: SUCCESS (3.093s)
[532.932826] [116/133] (500s left) gem_basic (multigpu-create-close)
[533.000715] Starting subtest: multigpu-create-close
[533.005317] Subtest multigpu-create-close: SKIP (0.000s)
[533.087511] [117/133] (500s left) kms_vblank (query-idle)
[533.184071] Starting subtest: query-idle
[533.186242] Starting dynamic subtest: pipe-A-eDP-1
[534.940390] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.756s)
[534.955997] Starting dynamic subtest: pipe-D-eDP-1
[537.397363] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.453s)
[537.399636] Subtest query-idle: SUCCESS (4.213s)
[538.228988] [118/133] (495s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[538.317516] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[538.321852] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[538.411234] [119/133] (495s left) syncobj_timeline (reset-during-wait-for-submit)
[538.461576] Starting subtest: reset-during-wait-for-submit
[538.563483] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[538.644833] [120/133] (495s left) i915_suspend (basic-s3-without-i915)
[538.679735] Starting subtest: basic-s3-without-i915
[541.931154] Subtest basic-s3-without-i915: SKIP (3.247s)
[543.518120] [121/133] (490s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[543.618248] Starting subtest: plane-primary-toggle-with-vblank-wait
[543.620547] Starting dynamic subtest: pipe-A-eDP-1
[543.788783] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.172s)
[544.107643] Starting dynamic subtest: pipe-B-eDP-1
[545.006205] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.907s)
[545.307964] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.688s)
[546.180903] [122/133] (487s left) kms_psr (fbc-psr-primary-blt)
[546.277284] Starting subtest: fbc-psr-primary-blt
[546.279628] Starting dynamic subtest: eDP-1
[546.283954] Dynamic subtest eDP-1: SKIP (0.000s)
[546.288326] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[546.367121] [123/133] (487s left) gem_mmap (bad-offset)
[546.418313] Subtest bad-offset: SKIP (0.000s)
[546.487392] [124/133] (487s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[546.588999] Starting subtest: yf-tiled-8bpp-rotate-0
[546.593139] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[546.694600] [125/133] (487s left) gem_exec_flush (basic-batch-kernel-default-wb)
[546.774710] Starting subtest: basic-batch-kernel-default-wb
[554.025287] Subtest basic-batch-kernel-default-wb: SUCCESS (7.251s)
[554.214215] [126/133] (479s left) perf (invalid-oa-format-id)
[554.328228] Starting subtest: invalid-oa-format-id
[554.341526] Subtest invalid-oa-format-id: SUCCESS (0.012s)
[554.391115] [127/133] (479s left) kms_async_flips (test-time-stamp)
[554.488799] Starting subtest: test-time-stamp
[554.861540] Starting dynamic subtest: pipe-A-eDP-1
[555.666095] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.804s)
[556.050931] Starting dynamic subtest: pipe-B-eDP-1
[556.810462] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[557.178271] Starting dynamic subtest: pipe-C-eDP-1
[557.929954] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.759s)
[558.295299] Starting dynamic subtest: pipe-D-eDP-1
[559.061234] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[559.063867] Subtest test-time-stamp: SUCCESS (4.573s)
[560.218553] [128/133] (473s left) kms_content_protection (legacy-hdcp14)
[560.369427] Starting subtest: legacy-hdcp14
[560.373901] Subtest legacy-hdcp14: SKIP (0.000s)
[560.508768] [129/133] (473s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[560.606421] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[560.608648] Starting dynamic subtest: pipe-A-eDP-1
[577.376739] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.423s)
[577.387830] Starting dynamic subtest: pipe-B-eDP-1
[594.311371] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.424s)
[594.323664] Starting dynamic subtest: pipe-C-eDP-1
[611.275970] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.342s)
[611.288891] Starting dynamic subtest: pipe-D-eDP-1
[628.301634] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.366s)
[628.303856] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.561s)
[629.515586] [130/133] (404s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[629.612982] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[636.167233] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.683s)
[636.279897] [131/133] (397s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[636.583232] Starting subtest: cursor-rapid-movement-max-size
[636.589472] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[636.705749] [132/133] (397s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[636.801799] Starting subtest: fbcpsr-suspend
[677.703881] Subtest fbcpsr-suspend: SUCCESS (10.061s)
[677.846306] [133/133] (356s left) api_intel_bb (reset-flags)
[677.902287] Starting subtest: reset-flags
[677.909310] Subtest reset-flags: SUCCESS (0.009s)
[678.019366] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_invalid_mode
results: parsing output: 3/ for test: kms_prop_blob
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_pxp
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_plane_alpha_blend
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: kms_pipe_b_c_ivb
results: parsing output: 15/ for test: gem_vm_create
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: kms_feature_discovery
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: kms_color_pipeline
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_exec_whisper
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: kms_joiner
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: kms_pm_lpsp
results: parsing output: 36/ for test: i915_drm_fdinfo
results: parsing output: 37/ for test: drm_read
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_ctx_shared
results: parsing output: 41/ for test: gem_sync
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: i915_pm_freq_api
results: parsing output: 44/ for test: kms_atomic_transition
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_getfb
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: drm_read
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: i915_pm_rps
results: parsing output: 58/ for test: kms_plane_cursor
results: parsing output: 59/ for test: kms_sequence
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: gem_flink_basic
results: parsing output: 62/ for test: gem_ctx_isolation
results: parsing output: 63/ for test: kms_cursor_edge_walk
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_busy
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: sysfs_preempt_timeout
results: parsing output: 72/ for test: gem_exec_big
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_chamelium_hpd
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: sw_sync
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_chamelium_frames
results: parsing output: 82/ for test: gem_flink_basic
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_prop_blob
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: sw_sync
results: parsing output: 92/ for test: prime_vgem
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_softpin
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gem_exec_flush
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: api_intel_allocator
results: parsing output: 105/ for test: kms_getfb
results: parsing output: 106/ for test: perf
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_close_race
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: gem_exec_flush
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: gem_basic
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: i915_suspend
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_mmap
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: kms_content_protection
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: api_intel_bb
Done.