[57.096432] Initializing watchdogs
[57.096478]   /dev/watchdog0
[57.110748] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.115242] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.117924] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.121560] [001/133] (960s left) gem_softpin (noreloc-s3)
[57.218760] Starting subtest: noreloc-S3
[77.207449] Subtest noreloc-S3: SUCCESS (5.424s)
[77.324872] [002/133] (940s left) perf_pmu (gt-awake)
[77.385035] Starting subtest: gt-awake
[86.326037] Subtest gt-awake: SUCCESS (8.795s)
[86.415227] [003/133] (931s left) kms_invalid_mode (zero-hdisplay)
[86.528461] Starting subtest: zero-hdisplay
[86.530819] Starting dynamic subtest: pipe-A-eDP-1
[86.817715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[86.825947] Starting dynamic subtest: pipe-B-eDP-1
[86.828111] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[86.835705] Starting dynamic subtest: pipe-C-eDP-1
[86.837892] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[86.845092] Starting dynamic subtest: pipe-D-eDP-1
[86.847069] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[86.848909] Subtest zero-hdisplay: SUCCESS (0.290s)
[87.619606] [004/133] (930s left) kms_prop_blob (invalid-set-prop-any)
[87.673872] Starting subtest: invalid-set-prop-any
[87.676101] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[87.776989] [005/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[87.865840] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[95.414341] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.516s)
[95.554193] [006/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[95.657411] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[95.661354] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[95.758903] [007/133] (922s left) kms_cursor_legacy (torture-move)
[95.882492] Starting subtest: torture-move
[95.884829] Starting dynamic subtest: pipe-A
[101.651980] Dynamic subtest pipe-A: SUCCESS (5.753s)
[101.662768] Starting dynamic subtest: pipe-B
[109.414322] Dynamic subtest pipe-B: SUCCESS (7.758s)
[109.429285] Starting dynamic subtest: pipe-C
[116.250033] Dynamic subtest pipe-C: SUCCESS (6.833s)
[116.260663] Starting dynamic subtest: pipe-D
[123.877902] Dynamic subtest pipe-D: SUCCESS (7.623s)
[123.888128] Starting dynamic subtest: all-pipes
[130.354593] Dynamic subtest all-pipes: SUCCESS (6.473s)
[130.357180] Subtest torture-move: SUCCESS (34.444s)
[130.515873] [008/133] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[130.627644] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[134.197650] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.572s)
[135.418785] [009/133] (882s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[135.512187] Starting subtest: fbc-rgb101010-draw-blt
[140.102895] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.589s)
[141.202570] [010/133] (876s left) gem_pxp (create-regular-context-2)
[141.320631] Starting subtest: create-regular-context-2
[141.323066] Subtest create-regular-context-2: SUCCESS (0.002s)
[141.435712] [011/133] (876s left) kms_flip (2x-flip-vs-panning-interruptible)
[141.522763] Starting subtest: 2x-flip-vs-panning-interruptible
[141.533542] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[141.634242] [012/133] (876s left) kms_plane_alpha_blend (constant-alpha-max)
[141.722361] Starting subtest: constant-alpha-max
[142.005923] Starting dynamic subtest: pipe-A-eDP-1
[143.062922] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.055s)
[143.072373] Starting dynamic subtest: pipe-D-eDP-1
[144.689873] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.625s)
[144.692472] Subtest constant-alpha-max: SUCCESS (2.967s)
[145.563976] [013/133] (872s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[145.668265] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[145.696440] Starting dynamic subtest: pipe-A-plane-0
[145.985143] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[145.994968] Starting dynamic subtest: pipe-A-plane-3
[146.218919] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[146.227458] Starting dynamic subtest: pipe-A-plane-5
[146.232069] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[147.348029] Starting dynamic subtest: pipe-B-plane-0
[147.651453] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[147.661859] Starting dynamic subtest: pipe-B-plane-3
[147.885838] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[147.895190] Starting dynamic subtest: pipe-B-plane-5
[147.899744] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[148.192412] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.521s)
[149.011679] [014/133] (869s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[149.074725] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[149.138025] [015/133] (869s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[149.205747] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[149.265220] [016/133] (868s left) gem_vm_create (invalid-destroy)
[149.339007] Starting subtest: invalid-destroy
[149.341477] Subtest invalid-destroy: SUCCESS (0.002s)
[149.447477] [017/133] (868s left) gem_lmem_swapping (heavy-verify-random-ccs)
[149.487026] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[149.520172] [018/133] (868s left) kms_feature_discovery (display-2x)
[149.612447] Starting subtest: display-2x
[149.616915] Subtest display-2x: SKIP (0.000s)
[149.681881] [019/133] (868s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[149.779125] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[149.781421] Starting dynamic subtest: pipe-A-eDP-1
[149.804001] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.814506] Starting dynamic subtest: pipe-B-eDP-1
[149.835973] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.844133] Starting dynamic subtest: pipe-C-eDP-1
[149.865291] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.873455] Starting dynamic subtest: pipe-D-eDP-1
[149.895245] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.899374] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[151.995323] [020/133] (866s left) gem_mmap_offset (blt-coherency)
[152.045472] Starting subtest: blt-coherency
[152.050029] Subtest blt-coherency: SUCCESS (0.007s)
[152.192991] [021/133] (866s left) gem_pxp (hw-rejects-pxp-context)
[152.253137] Starting subtest: hw-rejects-pxp-context
[152.257646] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[152.346887] [022/133] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[152.451303] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[159.072870] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.622s)
[159.184091] [023/133] (859s left) kms_psr (pr-sprite-mmap-gtt)
[159.281587] Starting subtest: pr-sprite-mmap-gtt
[159.286015] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[159.361375] [024/133] (859s left) gem_exec_reloc (basic-write-gtt-noreloc)
[159.431076] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[159.498830] [025/133] (859s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[159.586367] Starting subtest: plane-lut1d-ctm3x4
[159.710080] Starting dynamic subtest: pipe-A-plane-0
[159.854490] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[159.863958] Starting dynamic subtest: pipe-A-plane-1
[159.987892] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[159.996972] Starting dynamic subtest: pipe-A-plane-2
[160.121210] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[161.311686] Starting dynamic subtest: pipe-B-plane-0
[161.457989] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[161.468146] Starting dynamic subtest: pipe-B-plane-1
[161.602478] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[161.611917] Starting dynamic subtest: pipe-B-plane-2
[161.746863] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[162.956171] Starting dynamic subtest: pipe-C-plane-0
[163.094369] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[163.108657] Starting dynamic subtest: pipe-C-plane-1
[163.260291] Dynamic subtest pipe-C-plane-1: SUCCESS (0.165s)
[163.269480] Starting dynamic subtest: pipe-C-plane-2
[163.405124] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[164.595325] Starting dynamic subtest: pipe-D-plane-0
[164.733152] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[164.742081] Starting dynamic subtest: pipe-D-plane-1
[164.877866] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[164.887105] Starting dynamic subtest: pipe-D-plane-2
[165.011100] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[165.302726] Subtest plane-lut1d-ctm3x4: SUCCESS (5.714s)
[166.160124] [026/133] (852s left) gem_exec_schedule (preempt-hang)
[166.341907] Starting subtest: preempt-hang
[166.344727] Starting dynamic subtest: rcs0
[166.577479] Dynamic subtest rcs0: SUCCESS (0.234s)
[166.589834] Starting dynamic subtest: bcs0
[166.804730] Dynamic subtest bcs0: SUCCESS (0.226s)
[166.818110] Starting dynamic subtest: vcs0
[167.026843] Dynamic subtest vcs0: SUCCESS (0.221s)
[167.034896] Starting dynamic subtest: vcs1
[167.245575] Dynamic subtest vcs1: SUCCESS (0.217s)
[167.254002] Starting dynamic subtest: vecs0
[167.474462] Dynamic subtest vecs0: SUCCESS (0.228s)
[167.484904] Starting dynamic subtest: ccs0
[167.702285] Dynamic subtest ccs0: SUCCESS (0.227s)
[167.704577] Subtest preempt-hang: SUCCESS (1.359s)
[168.392407] [027/133] (850s left) kms_psr (psr-cursor-mmap-cpu)
[168.500961] Starting subtest: psr-cursor-mmap-cpu
[168.503369] Starting dynamic subtest: eDP-1
[170.263033] Dynamic subtest eDP-1: SUCCESS (1.764s)
[170.265475] Subtest psr-cursor-mmap-cpu: SUCCESS (1.765s)
[171.130830] [028/133] (847s left) gem_exec_whisper (basic-contexts-priority-all)
[171.205946] Starting subtest: basic-contexts-priority-all
[194.204970] Subtest basic-contexts-priority-all: SUCCESS (22.948s)
[194.338766] [029/133] (824s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[194.400785] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[194.462951] [030/133] (824s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[194.578830] Starting subtest: cursorB-vs-flipA-atomic-transitions
[194.583344] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[194.734125] [031/133] (824s left) gem_exec_params (rel-constants-invalid)
[194.783452] Starting subtest: rel-constants-invalid
[194.785415] Subtest rel-constants-invalid: SUCCESS (0.000s)
[194.901665] [032/133] (823s left) kms_joiner (invalid-modeset-ultra-joiner)
[194.993239] Starting subtest: invalid-modeset-ultra-joiner
[194.997736] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[195.062211] [033/133] (823s left) syncobj_wait (invalid-signal-bad-pad)
[195.110818] Starting subtest: invalid-signal-bad-pad
[195.113201] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[195.205601] [034/133] (823s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[195.296600] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[195.307480] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[195.383871] [035/133] (823s left) gem_eio (in-flight-contexts-1us)
[195.595002] Starting subtest: in-flight-contexts-1us
[207.373917] Subtest in-flight-contexts-1us: SUCCESS (11.778s)
[207.549192] [036/133] (811s left) kms_pm_lpsp (kms-lpsp)
[208.642320] Starting subtest: kms-lpsp
[208.644547] Starting dynamic subtest: pipe-A-eDP-1
[208.828956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.186s)
[209.111520] Subtest kms-lpsp: SUCCESS (0.471s)
[209.943972] [037/133] (809s left) i915_drm_fdinfo (busy-check-all)
[209.981758] Starting subtest: busy-check-all
[209.983723] Starting dynamic subtest: rcs0
[209.988159] Dynamic subtest rcs0: SKIP (0.005s)
[209.997960] Starting dynamic subtest: bcs0
[210.002303] Dynamic subtest bcs0: SKIP (0.000s)
[210.011299] Starting dynamic subtest: vcs0
[210.015376] Dynamic subtest vcs0: SKIP (0.000s)
[210.023976] Starting dynamic subtest: vcs1
[210.028073] Dynamic subtest vcs1: SKIP (0.000s)
[210.036782] Starting dynamic subtest: vecs0
[210.040833] Dynamic subtest vecs0: SKIP (0.000s)
[210.049539] Starting dynamic subtest: ccs0
[210.054096] Dynamic subtest ccs0: SKIP (0.000s)
[210.058501] Subtest busy-check-all: SKIP (0.010s)
[210.095786] [038/133] (808s left) drm_read (fault-buffer)
[210.239315] Starting subtest: fault-buffer
[210.241562] Subtest fault-buffer: SUCCESS (0.001s)
[210.361689] [039/133] (808s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[210.467655] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[211.512712] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.045s)
[211.624752] [040/133] (807s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[211.718538] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[211.720461] Starting dynamic subtest: pipe-A-eDP-1
[212.529737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[212.539331] Starting dynamic subtest: pipe-B-eDP-1
[214.082209] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s)
[214.094116] Starting dynamic subtest: pipe-C-eDP-1
[215.564138] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.482s)
[215.574685] Starting dynamic subtest: pipe-D-eDP-1
[217.024398] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.459s)
[217.026730] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.298s)
[218.187947] [041/133] (801s left) gem_ctx_shared (create-shared-gtt)
[218.251016] Starting subtest: create-shared-gtt
[220.456531] Subtest create-shared-gtt: SUCCESS (2.152s)
[220.749035] [042/133] (798s left) gem_sync (basic-store-each)
[220.816844] Starting subtest: basic-store-each
[223.388279] Subtest basic-store-each: SUCCESS (2.581s)
[223.624376] [043/133] (795s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[223.723002] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[223.725249] Starting dynamic subtest: A-eDP1
[232.623764] Dynamic subtest A-eDP1: SUCCESS (8.898s)
[232.635454] Starting dynamic subtest: B-eDP1
[241.562543] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[241.571675] Starting dynamic subtest: C-eDP1
[250.530005] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[250.540117] Starting dynamic subtest: D-eDP1
[259.457093] Dynamic subtest D-eDP1: SUCCESS (8.920s)
[259.459621] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.683s)
[260.657098] [044/133] (758s left) i915_pm_freq_api (freq-basic-api)
[260.726005] Starting subtest: freq-basic-api
[260.728402] Starting dynamic subtest: gt0
[260.730774] Dynamic subtest gt0: SUCCESS (0.003s)
[260.744331] Starting dynamic subtest: gt1
[260.746665] Dynamic subtest gt1: SUCCESS (0.002s)
[260.748553] Subtest freq-basic-api: SUCCESS (0.006s)
[260.831437] [045/133] (758s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[260.926679] Starting subtest: plane-use-after-nonblocking-unbind
[260.928925] Starting dynamic subtest: pipe-A-eDP-1
[260.986513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[261.293674] Starting dynamic subtest: pipe-B-eDP-1
[262.052011] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.768s)
[262.341759] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.414s)
[263.213130] [046/133] (756s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[263.316227] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[263.320614] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[263.408021] [047/133] (756s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[263.502999] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[263.507156] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[263.594269] [048/133] (755s left) kms_getfb (getfb2-handle-closed)
[263.679897] Starting subtest: getfb2-handle-closed
[263.682204] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[263.777471] [049/133] (755s left) kms_psr (fbc-pr-no-drrs)
[263.883735] Starting subtest: fbc-pr-no-drrs
[263.888074] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[263.956810] [050/133] (755s left) drm_read (short-buffer-nonblock)
[264.097255] Starting subtest: short-buffer-nonblock
[264.099738] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[264.234256] [051/133] (755s left) gen9_exec_parse (bb-secure)
[264.288895] Subtest bb-secure: SKIP (0.000s)
[264.344572] [052/133] (755s left) kms_psr (fbc-pr-sprite-render)
[264.428333] Starting subtest: fbc-pr-sprite-render
[264.432143] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[264.497826] [053/133] (755s left) kms_big_fb (linear-64bpp-rotate-0)
[264.612288] Starting subtest: linear-64bpp-rotate-0
[266.318281] Subtest linear-64bpp-rotate-0: SUCCESS (1.705s)
[266.484128] [054/133] (753s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[266.577105] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[266.580712] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[266.652407] [055/133] (753s left) gem_exec_balancer (full)
[266.699028] Starting subtest: full
[271.172370] Subtest full: SUCCESS (4.471s)
[271.492075] [056/133] (748s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[271.591657] Starting subtest: plane-upscale-20x20-with-pixel-format
[271.593773] Starting dynamic subtest: pipe-A
[272.641376] Dynamic subtest pipe-A: SUCCESS (1.049s)
[272.652223] Starting dynamic subtest: pipe-B
[274.732857] Dynamic subtest pipe-B: SUCCESS (2.089s)
[274.742611] Starting dynamic subtest: pipe-C
[275.931660] Dynamic subtest pipe-C: SUCCESS (1.197s)
[275.941086] Starting dynamic subtest: pipe-D
[277.074965] Dynamic subtest pipe-D: SUCCESS (1.142s)
[277.077221] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.483s)
[278.281876] [057/133] (741s left) kms_flip (modeset-vs-vblank-race-interruptible)
[278.384734] Starting subtest: modeset-vs-vblank-race-interruptible
[278.387047] Starting dynamic subtest: A-eDP1
[283.118149] Dynamic subtest A-eDP1: SUCCESS (4.732s)
[283.131653] Starting dynamic subtest: B-eDP1
[287.734916] Dynamic subtest B-eDP1: SUCCESS (4.612s)
[287.745757] Starting dynamic subtest: C-eDP1
[292.255816] Dynamic subtest C-eDP1: SUCCESS (4.517s)
[292.268444] Starting dynamic subtest: D-eDP1
[296.878033] Dynamic subtest D-eDP1: SUCCESS (4.620s)
[296.883472] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.493s)
[298.042389] [058/133] (721s left) i915_pm_rps (engine-order)
[298.109170] Starting subtest: engine-order
[303.266442] Subtest engine-order: SUCCESS (5.157s)
[303.383500] [059/133] (716s left) kms_plane_cursor (overlay)
[303.480532] Starting subtest: overlay
[303.484436] Starting dynamic subtest: pipe-A-eDP-1-size-64
[305.972828] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.495s)
[306.031461] Starting dynamic subtest: pipe-A-eDP-1-size-128
[308.427055] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.404s)
[308.488938] Starting dynamic subtest: pipe-A-eDP-1-size-256
[310.949900] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.472s)
[311.299770] Starting dynamic subtest: pipe-B-eDP-1-size-64
[314.462915] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.176s)
[314.525019] Starting dynamic subtest: pipe-B-eDP-1-size-128
[317.018037] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.505s)
[317.080013] Starting dynamic subtest: pipe-B-eDP-1-size-256
[319.552121] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.482s)
[319.904760] Starting dynamic subtest: pipe-C-eDP-1-size-64
[322.665374] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.774s)
[322.704050] Starting dynamic subtest: pipe-C-eDP-1-size-128
[324.999559] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.303s)
[325.040909] Starting dynamic subtest: pipe-C-eDP-1-size-256
[327.120463] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.092s)
[327.456333] Starting dynamic subtest: pipe-D-eDP-1-size-64
[330.185572] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.741s)
[330.223340] Starting dynamic subtest: pipe-D-eDP-1-size-128
[332.295665] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.080s)
[332.333570] Starting dynamic subtest: pipe-D-eDP-1-size-256
[334.395920] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.070s)
[334.715109] Subtest overlay: SUCCESS (31.239s)
[335.577068] [060/133] (684s left) kms_sequence (queue-busy)
[335.668575] Starting subtest: queue-busy
[335.670944] Starting dynamic subtest: pipe-A-eDP-1
[337.600055] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[337.610603] Starting dynamic subtest: pipe-B-eDP-1
[340.185515] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.583s)
[340.195777] Starting dynamic subtest: pipe-C-eDP-1
[342.802499] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.617s)
[342.813515] Starting dynamic subtest: pipe-D-eDP-1
[345.350461] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[345.352741] Subtest queue-busy: SUCCESS (9.685s)
[346.142389] [061/133] (673s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[346.239663] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[346.241593] Starting dynamic subtest: A-eDP1
[349.867447] Dynamic subtest A-eDP1: SUCCESS (3.626s)
[349.880838] Starting dynamic subtest: B-eDP1
[353.057138] Dynamic subtest B-eDP1: SUCCESS (3.191s)
[353.076753] Starting dynamic subtest: C-eDP1
[356.145904] Dynamic subtest C-eDP1: SUCCESS (3.089s)
[356.156613] Starting dynamic subtest: D-eDP1
[359.233925] Dynamic subtest D-eDP1: SUCCESS (3.086s)
[359.235884] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.999s)
[360.039363] [062/133] (660s left) gem_flink_basic (double-flink)
[360.094036] Starting subtest: double-flink
[360.096010] Subtest double-flink: SUCCESS (0.000s)
[360.200314] [063/133] (659s left) gem_ctx_isolation (dirty-switch)
[360.253270] Starting subtest: dirty-switch
[360.255561] Starting dynamic subtest: rcs0
[360.441525] Dynamic subtest rcs0: SUCCESS (0.188s)
[360.451687] Starting dynamic subtest: bcs0
[360.640588] Dynamic subtest bcs0: SUCCESS (0.198s)
[360.652316] Starting dynamic subtest: vcs0
[360.851596] Dynamic subtest vcs0: SUCCESS (0.210s)
[360.862848] Starting dynamic subtest: vcs1
[362.522147] Dynamic subtest vcs1: SUCCESS (1.669s)
[362.531510] Starting dynamic subtest: vecs0
[364.574648] Dynamic subtest vecs0: SUCCESS (2.052s)
[364.583861] Starting dynamic subtest: ccs0
[366.538864] Dynamic subtest ccs0: SUCCESS (1.963s)
[366.541205] Subtest dirty-switch: SUCCESS (6.286s)
[366.755515] [064/133] (653s left) kms_cursor_edge_walk (64x64-top-edge)
[366.858201] Starting subtest: 64x64-top-edge
[366.860032] Starting dynamic subtest: pipe-A-eDP-1
[370.310281] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.448s)
[370.330626] Starting dynamic subtest: pipe-D-eDP-1
[373.446488] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[373.448808] Subtest 64x64-top-edge: SUCCESS (6.588s)
[374.276964] [065/133] (645s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[374.370296] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[374.372466] Starting dynamic subtest: pipe-A-eDP-1
[374.396502] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[374.406738] Starting dynamic subtest: pipe-B-eDP-1
[374.429515] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[374.438085] Starting dynamic subtest: pipe-C-eDP-1
[374.460764] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[374.469555] Starting dynamic subtest: pipe-D-eDP-1
[374.493816] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[374.498041] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[376.539923] [066/133] (643s left) gem_eio (hibernate)
[376.772287] Starting subtest: hibernate
[391.504667] Subtest hibernate: SUCCESS (14.729s)
[399.651203] [067/133] (628s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[399.771766] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[399.783367] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[399.861313] [068/133] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[399.958722] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[399.962970] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[400.060515] [069/133] (628s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[400.174626] Starting subtest: extended-modeset-hang-newfb-with-reset
[400.176475] Starting dynamic subtest: pipe-A
[414.960134] Dynamic subtest pipe-A: SUCCESS (14.780s)
[414.971065] Starting dynamic subtest: pipe-D
[429.421268] Dynamic subtest pipe-D: SUCCESS (14.458s)
[429.423618] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.244s)
[430.218793] [070/133] (598s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[430.309632] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[430.313895] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[430.394778] [071/133] (598s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[430.492550] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[434.220009] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.730s)
[435.408474] [072/133] (593s left) sysfs_preempt_timeout (invalid)
[435.458232] Starting subtest: invalid
[435.460752] Starting dynamic subtest: vecs0
[435.463040] Dynamic subtest vecs0: SUCCESS (0.000s)
[435.473744] Starting dynamic subtest: ccs0
[435.476012] Dynamic subtest ccs0: SUCCESS (0.000s)
[435.489919] Starting dynamic subtest: vcs0
[435.492010] Dynamic subtest vcs0: SUCCESS (0.000s)
[435.513972] Starting dynamic subtest: bcs0
[435.516371] Dynamic subtest bcs0: SUCCESS (0.000s)
[435.537672] Starting dynamic subtest: rcs0
[435.540275] Dynamic subtest rcs0: SUCCESS (0.000s)
[435.560589] Starting dynamic subtest: vcs1
[435.563226] Dynamic subtest vcs1: SUCCESS (0.000s)
[435.565546] Subtest invalid: SUCCESS (0.006s)
[435.643372] [073/133] (592s left) gem_exec_big (single)
[435.706848] Starting subtest: single
[441.099323] Subtest single: SUCCESS (5.389s)
[441.361279] [074/133] (587s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[441.518173] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[441.520363] Starting dynamic subtest: pipe-A-eDP-1
[441.577181] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[441.588032] Starting dynamic subtest: pipe-B-eDP-1
[441.642433] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[441.653038] Starting dynamic subtest: pipe-C-eDP-1
[441.708419] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[441.719723] Starting dynamic subtest: pipe-D-eDP-1
[441.775749] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[441.779822] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[443.750532] [075/133] (584s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[443.858135] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[444.972181] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.112s)
[445.090707] [076/133] (583s left) kms_chamelium_hpd (dp-hpd-storm)
[445.468605] Subtest dp-hpd-storm: SKIP (0.000s)
[446.261909] [077/133] (582s left) i915_query (query-topology-kernel-writes)
[446.321039] Starting subtest: query-topology-kernel-writes
[446.323059] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[446.426155] [078/133] (582s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[446.528701] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[446.532879] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[446.600980] [079/133] (582s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[446.658248] Starting subtest: invalid-bsd2-flag-on-blt
[446.660555] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[446.769880] [080/133] (582s left) sw_sync (sync_busy_fork)
[446.817416] Starting subtest: sync_busy_fork
[447.830140] Subtest sync_busy_fork: SUCCESS (1.011s)
[447.895667] [081/133] (581s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[447.960234] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[447.962567] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[448.068207] [082/133] (580s left) kms_chamelium_frames (hdmi-crc-fast)
[448.456603] Subtest hdmi-crc-fast: SKIP (0.000s)
[449.300818] [083/133] (579s left) gem_flink_basic (flink-lifetime)
[449.357886] Starting subtest: flink-lifetime
[449.360307] Subtest flink-lifetime: SUCCESS (0.002s)
[449.451373] [084/133] (579s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[449.544894] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[449.548888] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[449.642298] [085/133] (579s left) kms_prop_blob (basic)
[449.694321] Starting subtest: basic
[449.696222] Subtest basic: SUCCESS (0.000s)
[449.785485] [086/133] (579s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[449.841368] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[449.951081] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[450.032018] [087/133] (579s left) perf (blocking-parameterized)
[450.160731] Starting subtest: blocking-parameterized
[470.236360] Subtest blocking-parameterized: SUCCESS (20.018s)
[470.274155] [088/133] (558s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[470.336512] Starting subtest: etime-multi-wait-all-submitted-signaled
[470.439740] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[470.523493] [089/133] (558s left) gem_exec_fence (submit-chain)
[470.702152] Starting subtest: submit-chain
[470.735429] Subtest submit-chain: SUCCESS (0.033s)
[472.363512] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[472.367782] [090/133] (556s left) gem_exec_params (mmapped)
[472.431528] Starting subtest: mmapped
[472.436667] Subtest mmapped: SUCCESS (0.005s)
[472.550730] [091/133] (556s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[472.669926] Starting subtest: x-tiled-32bpp-rotate-180
[474.122297] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.456s)
[474.244268] [092/133] (555s left) sw_sync (sync_expired_merge)
[474.281310] Starting subtest: sync_expired_merge
[475.357309] Subtest sync_expired_merge: SUCCESS (1.074s)
[475.422020] [093/133] (553s left) prime_vgem (basic-fence-mmap)
[475.482227] Starting subtest: basic-fence-mmap
[475.487186] Subtest basic-fence-mmap: SKIP (0.000s)
[475.597393] [094/133] (553s left) gem_ctx_shared (disjoint-timelines)
[475.676233] Starting subtest: disjoint-timelines
[475.695061] Subtest disjoint-timelines: SUCCESS (0.019s)
[475.936105] [095/133] (553s left) kms_psr (psr-dpms)
[476.031808] Starting subtest: psr-dpms
[476.034239] Starting dynamic subtest: eDP-1
[479.069839] Dynamic subtest eDP-1: SUCCESS (3.036s)
[479.072135] Subtest psr-dpms: SUCCESS (3.037s)
[479.927657] [096/133] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[480.020708] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[487.422261] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.406s)
[487.571047] [097/133] (542s left) gem_softpin (allocator-nopin)
[487.629045] Starting subtest: allocator-nopin
[487.714913] Subtest allocator-nopin: SUCCESS (0.086s)
[487.825858] [098/133] (541s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[487.926504] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[487.928694] Starting dynamic subtest: pipe-A-default-mode
[489.051369] Dynamic subtest pipe-A-default-mode: SKIP (1.124s)
[489.055844] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.125s)
[489.199789] [099/133] (540s left) gem_exec_flush (basic-wb-pro-default)
[489.264459] Starting subtest: basic-wb-pro-default
[494.746478] Subtest basic-wb-pro-default: SUCCESS (5.456s)
[494.913619] [100/133] (534s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[495.026493] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[495.028785] Starting dynamic subtest: pipe-A-eDP-1
[495.118201] Dynamic subtest pipe-A-eDP-1: SKIP (0.092s)
[495.132195] Starting dynamic subtest: pipe-B-eDP-1
[496.296467] Dynamic subtest pipe-B-eDP-1: SKIP (1.176s)
[496.301040] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.271s)
[497.483773] [101/133] (532s left) syncobj_timeline (single-wait-available-submitted)
[497.547962] Starting subtest: single-wait-available-submitted
[497.550158] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[497.629589] [102/133] (532s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[497.698618] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[497.703129] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[497.887355] [103/133] (531s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[497.998352] Starting subtest: psr-rgb101010-draw-pwrite
[505.667715] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.674s)
[505.783256] [104/133] (524s left) perf (gen8-unprivileged-single-ctx-counters)
[505.885958] Starting subtest: gen8-unprivileged-single-ctx-counters
[505.890573] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[505.933685] [105/133] (523s left) api_intel_allocator (standalone)
[505.987550] Starting subtest: standalone
[506.004554] Subtest standalone: SUCCESS (0.019s)
[506.140841] [106/133] (523s left) kms_getfb (getfb-handle-closed)
[506.238525] Starting subtest: getfb-handle-closed
[506.240677] Subtest getfb-handle-closed: SUCCESS (0.000s)
[506.355099] [107/133] (523s left) perf (mi-rpc)
[506.459625] Starting subtest: mi-rpc
[506.464132] Subtest mi-rpc: SKIP (0.000s)
[506.508460] [108/133] (523s left) kms_async_flips (async-flip-dpms)
[506.593449] Starting subtest: async-flip-dpms
[506.969334] Starting dynamic subtest: pipe-A-eDP-1
[510.833184] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.862s)
[511.203573] Starting dynamic subtest: pipe-B-eDP-1
[513.991842] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.798s)
[514.362234] Starting dynamic subtest: pipe-C-eDP-1
[517.165453] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.810s)
[517.545060] Starting dynamic subtest: pipe-D-eDP-1
[520.332883] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[520.335297] Subtest async-flip-dpms: SUCCESS (13.737s)
[521.514408] [109/133] (508s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[521.600473] Starting subtest: y-tiled-64bpp-rotate-180
[521.605113] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[521.692857] [110/133] (508s left) gem_close_race (multigpu-basic-process)
[521.753019] Starting subtest: multigpu-basic-process
[521.757340] Subtest multigpu-basic-process: SKIP (0.000s)
[521.990997] [111/133] (508s left) kms_cursor_crc (cursor-offscreen-32x10)
[522.150205] Starting subtest: cursor-offscreen-32x10
[522.197768] Subtest cursor-offscreen-32x10: SKIP (0.041s)
[522.472812] [112/133] (507s left) gem_exec_flush (basic-wb-rw-default)
[522.542076] Starting subtest: basic-wb-rw-default
[528.031475] Subtest basic-wb-rw-default: SUCCESS (5.452s)
[528.185327] [113/133] (502s left) dmabuf_sync_file (export-before-signal)
[528.224080] Starting subtest: export-before-signal
[528.226003] Subtest export-before-signal: SUCCESS (0.001s)
[528.283949] [114/133] (502s left) gem_exec_schedule (preempt-queue-contexts-chain)
[528.358481] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[528.650803] [115/133] (501s left) perf_pmu (semaphore-wait)
[528.690497] Starting subtest: semaphore-wait
[528.692782] Starting dynamic subtest: rcs0
[529.205721] Dynamic subtest rcs0: SUCCESS (0.515s)
[529.218122] Starting dynamic subtest: bcs0
[529.721365] Dynamic subtest bcs0: SUCCESS (0.512s)
[529.734954] Starting dynamic subtest: vcs0
[530.237819] Dynamic subtest vcs0: SUCCESS (0.513s)
[530.251199] Starting dynamic subtest: vcs1
[530.752771] Dynamic subtest vcs1: SUCCESS (0.512s)
[530.766404] Starting dynamic subtest: vecs0
[531.268796] Dynamic subtest vecs0: SUCCESS (0.513s)
[531.282574] Starting dynamic subtest: ccs0
[531.784614] Dynamic subtest ccs0: SUCCESS (0.512s)
[531.787425] Subtest semaphore-wait: SUCCESS (3.095s)
[531.906582] [116/133] (498s left) gem_basic (multigpu-create-close)
[531.967447] Starting subtest: multigpu-create-close
[531.971681] Subtest multigpu-create-close: SKIP (0.000s)
[532.077706] [117/133] (498s left) kms_vblank (query-idle)
[532.181118] Starting subtest: query-idle
[532.182948] Starting dynamic subtest: pipe-A-eDP-1
[533.924166] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.741s)
[533.939448] Starting dynamic subtest: pipe-D-eDP-1
[536.348524] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s)
[536.350978] Subtest query-idle: SUCCESS (4.168s)
[537.185861] [118/133] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[537.280630] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[537.284561] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[537.380989] [119/133] (493s left) syncobj_timeline (reset-during-wait-for-submit)
[537.431147] Starting subtest: reset-during-wait-for-submit
[537.535151] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[537.613875] [120/133] (492s left) i915_suspend (basic-s3-without-i915)
[537.655457] Starting subtest: basic-s3-without-i915
[539.405569] Subtest basic-s3-without-i915: SKIP (1.744s)
[541.037645] [121/133] (489s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[541.144257] Starting subtest: plane-primary-toggle-with-vblank-wait
[541.146627] Starting dynamic subtest: pipe-A-eDP-1
[541.317656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[541.638046] Starting dynamic subtest: pipe-B-eDP-1
[542.511434] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.881s)
[542.810309] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.665s)
[543.660290] [122/133] (487s left) kms_psr (fbc-psr-primary-blt)
[543.767657] Starting subtest: fbc-psr-primary-blt
[543.770044] Starting dynamic subtest: eDP-1
[543.774354] Dynamic subtest eDP-1: SKIP (0.000s)
[543.778628] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[543.851325] [123/133] (486s left) gem_mmap (bad-offset)
[543.907463] Subtest bad-offset: SKIP (0.000s)
[543.975988] [124/133] (486s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[544.074134] Starting subtest: yf-tiled-8bpp-rotate-0
[544.078586] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[544.172332] [125/133] (486s left) gem_exec_flush (basic-batch-kernel-default-wb)
[544.233643] Starting subtest: basic-batch-kernel-default-wb
[551.612142] Subtest basic-batch-kernel-default-wb: SUCCESS (7.379s)
[551.804722] [126/133] (479s left) perf (invalid-oa-format-id)
[551.918309] Starting subtest: invalid-oa-format-id
[551.929751] Subtest invalid-oa-format-id: SUCCESS (0.012s)
[551.977010] [127/133] (478s left) kms_async_flips (test-time-stamp)
[552.072229] Starting subtest: test-time-stamp
[552.438406] Starting dynamic subtest: pipe-A-eDP-1
[553.266190] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.826s)
[553.647672] Starting dynamic subtest: pipe-B-eDP-1
[554.398535] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[554.766209] Starting dynamic subtest: pipe-C-eDP-1
[555.525628] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[555.897277] Starting dynamic subtest: pipe-D-eDP-1
[556.658344] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[556.660818] Subtest test-time-stamp: SUCCESS (4.585s)
[557.817769] [128/133] (473s left) kms_content_protection (legacy-hdcp14)
[557.953880] Starting subtest: legacy-hdcp14
[557.958329] Subtest legacy-hdcp14: SKIP (0.000s)
[558.063798] [129/133] (472s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[558.165379] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[558.167661] Starting dynamic subtest: pipe-A-eDP-1
[574.473984] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.623s)
[574.483969] Starting dynamic subtest: pipe-B-eDP-1
[592.270977] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.407s)
[592.281331] Starting dynamic subtest: pipe-C-eDP-1
[609.241202] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.326s)
[609.253824] Starting dynamic subtest: pipe-D-eDP-1
[626.218205] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.355s)
[626.220453] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.716s)
[627.416198] [130/133] (403s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[627.529134] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[634.593287] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.897s)
[634.711841] [131/133] (396s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[635.009059] Starting subtest: cursor-rapid-movement-max-size
[635.015525] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[635.140251] [132/133] (395s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[635.242197] Starting subtest: fbcpsr-suspend
[675.842108] Subtest fbcpsr-suspend: SUCCESS (10.096s)
[675.970786] [133/133] (355s left) api_intel_bb (reset-flags)
[676.037360] Starting subtest: reset-flags
[676.044163] Subtest reset-flags: SUCCESS (0.009s)
[676.156941] 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.