[57.133808] Initializing watchdogs
[57.133854]   /dev/watchdog0
[57.147593] [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.152134] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.154259] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.157826] [001/133] (960s left) gem_softpin (noreloc-s3)
[57.253353] Starting subtest: noreloc-S3
[77.545655] Subtest noreloc-S3: SUCCESS (5.427s)
[77.678513] [002/133] (940s left) perf_pmu (gt-awake)
[77.742058] Starting subtest: gt-awake
[86.668359] Subtest gt-awake: SUCCESS (8.834s)
[86.792913] [003/133] (930s left) kms_invalid_mode (zero-hdisplay)
[86.889762] Starting subtest: zero-hdisplay
[86.892189] Starting dynamic subtest: pipe-A-eDP-1
[87.930819] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.035s)
[87.940463] Starting dynamic subtest: pipe-B-eDP-1
[87.942752] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[87.950401] Starting dynamic subtest: pipe-C-eDP-1
[87.952753] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[87.960243] Starting dynamic subtest: pipe-D-eDP-1
[87.962554] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[87.964831] Subtest zero-hdisplay: SUCCESS (1.040s)
[88.292545] [004/133] (929s left) kms_prop_blob (invalid-set-prop-any)
[88.343275] Starting subtest: invalid-set-prop-any
[88.345191] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[88.457132] [005/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[88.548624] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[96.093778] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.524s)
[96.226327] [006/133] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[96.318763] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[96.322770] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[96.409733] [007/133] (921s left) kms_cursor_legacy (torture-move)
[96.532999] Starting subtest: torture-move
[96.535027] Starting dynamic subtest: pipe-A
[103.030715] Dynamic subtest pipe-A: SUCCESS (6.485s)
[103.042885] Starting dynamic subtest: pipe-B
[109.816221] Dynamic subtest pipe-B: SUCCESS (6.787s)
[109.828740] Starting dynamic subtest: pipe-C
[116.995370] Dynamic subtest pipe-C: SUCCESS (7.176s)
[117.006595] Starting dynamic subtest: pipe-D
[124.753945] Dynamic subtest pipe-D: SUCCESS (7.757s)
[124.766557] Starting dynamic subtest: all-pipes
[131.327409] Dynamic subtest all-pipes: SUCCESS (6.571s)
[131.330839] Subtest torture-move: SUCCESS (34.779s)
[131.478896] [008/133] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[131.599485] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[135.181234] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.587s)
[136.386635] [009/133] (881s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[136.488577] Starting subtest: fbc-rgb101010-draw-blt
[141.110857] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.623s)
[142.281838] [010/133] (875s left) gem_pxp (create-regular-context-2)
[142.399894] Starting subtest: create-regular-context-2
[142.402307] Subtest create-regular-context-2: SUCCESS (0.002s)
[142.520594] [011/133] (875s left) kms_flip (2x-flip-vs-panning-interruptible)
[142.614268] Starting subtest: 2x-flip-vs-panning-interruptible
[142.625210] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[142.697812] [012/133] (875s left) kms_plane_alpha_blend (constant-alpha-max)
[142.796182] Starting subtest: constant-alpha-max
[143.080332] Starting dynamic subtest: pipe-A-eDP-1
[144.127489] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.046s)
[144.137456] Starting dynamic subtest: pipe-D-eDP-1
[145.772062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.642s)
[145.774453] Subtest constant-alpha-max: SUCCESS (2.976s)
[146.635717] [013/133] (871s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[146.723735] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[146.751757] Starting dynamic subtest: pipe-A-plane-0
[147.037968] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[147.047338] Starting dynamic subtest: pipe-A-plane-3
[147.271377] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[147.281118] Starting dynamic subtest: pipe-A-plane-5
[147.286486] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[148.422460] Starting dynamic subtest: pipe-B-plane-0
[148.714652] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[148.724259] Starting dynamic subtest: pipe-B-plane-3
[148.959203] Dynamic subtest pipe-B-plane-3: SUCCESS (0.243s)
[148.967459] Starting dynamic subtest: pipe-B-plane-5
[148.971906] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[149.281860] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.556s)
[150.101140] [014/133] (868s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[150.152843] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[150.220475] [015/133] (867s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[150.284899] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[150.343966] [016/133] (867s left) gem_vm_create (invalid-destroy)
[150.405294] Starting subtest: invalid-destroy
[150.407765] Subtest invalid-destroy: SUCCESS (0.002s)
[150.533541] [017/133] (867s left) gem_lmem_swapping (heavy-verify-random-ccs)
[150.583408] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[150.628369] [018/133] (867s left) kms_feature_discovery (display-2x)
[150.724440] Starting subtest: display-2x
[150.728831] Subtest display-2x: SKIP (0.000s)
[150.794537] [019/133] (867s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[150.885957] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[150.888333] Starting dynamic subtest: pipe-A-eDP-1
[150.911899] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[150.922753] Starting dynamic subtest: pipe-B-eDP-1
[150.944499] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[150.952999] Starting dynamic subtest: pipe-C-eDP-1
[150.975131] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[150.984071] Starting dynamic subtest: pipe-D-eDP-1
[151.006625] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.011038] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[153.178782] [020/133] (865s left) gem_mmap_offset (blt-coherency)
[153.238164] Starting subtest: blt-coherency
[153.243324] Subtest blt-coherency: SUCCESS (0.006s)
[153.361825] [021/133] (865s left) gem_pxp (hw-rejects-pxp-context)
[153.439933] Starting subtest: hw-rejects-pxp-context
[153.444440] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[153.545441] [022/133] (864s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[153.650530] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[161.175583] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (7.526s)
[161.289386] [023/133] (857s left) kms_psr (pr-sprite-mmap-gtt)
[161.386796] Starting subtest: pr-sprite-mmap-gtt
[161.391365] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[161.456171] [024/133] (857s left) gem_exec_reloc (basic-write-gtt-noreloc)
[161.531015] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[161.609269] [025/133] (856s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[161.702019] Starting subtest: plane-lut1d-ctm3x4
[161.827824] Starting dynamic subtest: pipe-A-plane-0
[161.983658] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[161.993425] Starting dynamic subtest: pipe-A-plane-1
[162.116448] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[162.125279] Starting dynamic subtest: pipe-A-plane-2
[162.249923] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[163.431222] Starting dynamic subtest: pipe-B-plane-0
[163.569467] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[163.578879] Starting dynamic subtest: pipe-B-plane-1
[163.714308] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[163.725957] Starting dynamic subtest: pipe-B-plane-2
[163.846853] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[165.061823] Starting dynamic subtest: pipe-C-plane-0
[165.187546] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[165.196494] Starting dynamic subtest: pipe-C-plane-1
[165.332332] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[165.340893] Starting dynamic subtest: pipe-C-plane-2
[165.476813] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[166.706150] Starting dynamic subtest: pipe-D-plane-0
[166.866251] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[166.875381] Starting dynamic subtest: pipe-D-plane-1
[167.021716] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[167.030331] Starting dynamic subtest: pipe-D-plane-2
[167.177947] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[167.462882] Subtest plane-lut1d-ctm3x4: SUCCESS (5.757s)
[168.261862] [026/133] (850s left) gem_exec_schedule (preempt-hang)
[168.443980] Starting subtest: preempt-hang
[168.446719] Starting dynamic subtest: rcs0
[168.691492] Dynamic subtest rcs0: SUCCESS (0.245s)
[168.702638] Starting dynamic subtest: bcs0
[168.933166] Dynamic subtest bcs0: SUCCESS (0.243s)
[168.942707] Starting dynamic subtest: vcs0
[169.152791] Dynamic subtest vcs0: SUCCESS (0.218s)
[169.164670] Starting dynamic subtest: vcs1
[169.374394] Dynamic subtest vcs1: SUCCESS (0.222s)
[169.383564] Starting dynamic subtest: vecs0
[169.600904] Dynamic subtest vecs0: SUCCESS (0.225s)
[169.612161] Starting dynamic subtest: ccs0
[169.827439] Dynamic subtest ccs0: SUCCESS (0.226s)
[169.829385] Subtest preempt-hang: SUCCESS (1.383s)
[170.790392] [027/133] (847s left) kms_psr (psr-cursor-mmap-cpu)
[170.891732] Starting subtest: psr-cursor-mmap-cpu
[170.894020] Starting dynamic subtest: eDP-1
[172.654581] Dynamic subtest eDP-1: SUCCESS (1.763s)
[172.656821] Subtest psr-cursor-mmap-cpu: SUCCESS (1.764s)
[173.515081] [028/133] (845s left) gem_exec_whisper (basic-contexts-priority-all)
[173.583029] Starting subtest: basic-contexts-priority-all
[196.613300] Subtest basic-contexts-priority-all: SUCCESS (22.978s)
[196.740218] [029/133] (822s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[196.814288] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[196.884837] [030/133] (821s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[196.997138] Starting subtest: cursorB-vs-flipA-atomic-transitions
[197.001895] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[197.137056] [031/133] (821s left) gem_exec_params (rel-constants-invalid)
[197.195969] Starting subtest: rel-constants-invalid
[197.198217] Subtest rel-constants-invalid: SUCCESS (0.000s)
[197.314058] [032/133] (821s left) kms_joiner (invalid-modeset-ultra-joiner)
[197.410471] Starting subtest: invalid-modeset-ultra-joiner
[197.414658] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[197.474176] [033/133] (821s left) syncobj_wait (invalid-signal-bad-pad)
[197.531794] Starting subtest: invalid-signal-bad-pad
[197.534144] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[197.645394] [034/133] (821s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[197.735145] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[197.746369] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[197.835528] [035/133] (821s left) gem_eio (in-flight-contexts-1us)
[198.042406] Starting subtest: in-flight-contexts-1us
[209.696536] Subtest in-flight-contexts-1us: SUCCESS (11.653s)
[209.873016] [036/133] (809s left) kms_pm_lpsp (kms-lpsp)
[210.965858] Starting subtest: kms-lpsp
[210.968350] Starting dynamic subtest: pipe-A-eDP-1
[211.130076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.169s)
[211.438017] Subtest kms-lpsp: SUCCESS (0.476s)
[212.241091] [037/133] (806s left) i915_drm_fdinfo (busy-check-all)
[212.274356] Starting subtest: busy-check-all
[212.276676] Starting dynamic subtest: rcs0
[212.281330] Dynamic subtest rcs0: SKIP (0.003s)
[212.291892] Starting dynamic subtest: bcs0
[212.296226] Dynamic subtest bcs0: SKIP (0.000s)
[212.305857] Starting dynamic subtest: vcs0
[212.309935] Dynamic subtest vcs0: SKIP (0.000s)
[212.319704] Starting dynamic subtest: vcs1
[212.324475] Dynamic subtest vcs1: SKIP (0.000s)
[212.333662] Starting dynamic subtest: vecs0
[212.338076] Dynamic subtest vecs0: SKIP (0.000s)
[212.347294] Starting dynamic subtest: ccs0
[212.351568] Dynamic subtest ccs0: SKIP (0.000s)
[212.355880] Subtest busy-check-all: SKIP (0.008s)
[212.395041] [038/133] (806s left) drm_read (fault-buffer)
[212.558480] Starting subtest: fault-buffer
[212.560767] Subtest fault-buffer: SUCCESS (0.000s)
[212.672181] [039/133] (806s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[212.775108] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[213.844058] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.069s)
[213.962185] [040/133] (805s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[214.050190] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[214.052212] Starting dynamic subtest: pipe-A-eDP-1
[214.846294] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.791s)
[214.859225] Starting dynamic subtest: pipe-B-eDP-1
[216.388522] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.538s)
[216.399068] Starting dynamic subtest: pipe-C-eDP-1
[217.889692] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.500s)
[217.899858] Starting dynamic subtest: pipe-D-eDP-1
[219.400964] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.511s)
[219.403327] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.344s)
[220.579314] [041/133] (798s left) gem_ctx_shared (create-shared-gtt)
[220.634495] Starting subtest: create-shared-gtt
[222.840379] Subtest create-shared-gtt: SUCCESS (2.152s)
[223.109061] [042/133] (796s left) gem_sync (basic-store-each)
[223.180112] Starting subtest: basic-store-each
[225.837920] Subtest basic-store-each: SUCCESS (2.668s)
[226.019537] [043/133] (793s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[226.124899] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[226.127254] Starting dynamic subtest: A-eDP1
[235.029679] Dynamic subtest A-eDP1: SUCCESS (8.903s)
[235.042232] Starting dynamic subtest: B-eDP1
[243.965278] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[243.977611] Starting dynamic subtest: C-eDP1
[252.939541] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[252.950958] Starting dynamic subtest: D-eDP1
[261.877254] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[261.879407] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.700s)
[263.059357] [044/133] (756s left) i915_pm_freq_api (freq-basic-api)
[263.117573] Starting subtest: freq-basic-api
[263.119806] Starting dynamic subtest: gt0
[263.121958] Dynamic subtest gt0: SUCCESS (0.003s)
[263.131499] Starting dynamic subtest: gt1
[263.133638] Dynamic subtest gt1: SUCCESS (0.003s)
[263.135765] Subtest freq-basic-api: SUCCESS (0.007s)
[263.219373] [045/133] (756s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[263.309927] Starting subtest: plane-use-after-nonblocking-unbind
[263.312213] Starting dynamic subtest: pipe-A-eDP-1
[263.369034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[263.685986] Starting dynamic subtest: pipe-B-eDP-1
[264.468343] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.791s)
[264.758151] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.450s)
[265.626253] [046/133] (753s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[265.736839] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[265.741190] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[265.857219] [047/133] (753s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[265.956099] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[265.960394] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[266.050939] [048/133] (753s left) kms_getfb (getfb2-handle-closed)
[266.135733] Starting subtest: getfb2-handle-closed
[266.137659] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[266.231349] [049/133] (753s left) kms_psr (fbc-pr-no-drrs)
[266.311228] Starting subtest: fbc-pr-no-drrs
[266.315314] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[266.382782] [050/133] (753s left) drm_read (short-buffer-nonblock)
[266.521562] Starting subtest: short-buffer-nonblock
[266.523829] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[266.646575] [051/133] (752s left) gen9_exec_parse (bb-secure)
[266.705348] Subtest bb-secure: SKIP (0.000s)
[266.769103] [052/133] (752s left) kms_psr (fbc-pr-sprite-render)
[266.855810] Starting subtest: fbc-pr-sprite-render
[266.859396] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[266.925817] [053/133] (752s left) kms_big_fb (linear-64bpp-rotate-0)
[267.014843] Starting subtest: linear-64bpp-rotate-0
[268.588919] Subtest linear-64bpp-rotate-0: SUCCESS (1.573s)
[268.752509] [054/133] (750s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[268.841034] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[268.845432] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[268.911718] [055/133] (750s left) gem_exec_balancer (full)
[268.977999] Starting subtest: full
[273.524497] Subtest full: SUCCESS (4.548s)
[273.849177] [056/133] (745s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[273.940488] Starting subtest: plane-upscale-20x20-with-pixel-format
[273.942652] Starting dynamic subtest: pipe-A
[274.988747] Dynamic subtest pipe-A: SUCCESS (1.050s)
[274.997592] Starting dynamic subtest: pipe-B
[277.135944] Dynamic subtest pipe-B: SUCCESS (2.146s)
[277.147391] Starting dynamic subtest: pipe-C
[278.335208] Dynamic subtest pipe-C: SUCCESS (1.196s)
[278.346378] Starting dynamic subtest: pipe-D
[279.486734] Dynamic subtest pipe-D: SUCCESS (1.150s)
[279.489069] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.547s)
[280.683763] [057/133] (739s left) kms_flip (modeset-vs-vblank-race-interruptible)
[280.791722] Starting subtest: modeset-vs-vblank-race-interruptible
[280.793978] Starting dynamic subtest: A-eDP1
[285.506388] Dynamic subtest A-eDP1: SUCCESS (4.710s)
[285.525951] Starting dynamic subtest: B-eDP1
[290.148074] Dynamic subtest B-eDP1: SUCCESS (4.637s)
[290.163621] Starting dynamic subtest: C-eDP1
[294.772879] Dynamic subtest C-eDP1: SUCCESS (4.620s)
[294.784334] Starting dynamic subtest: D-eDP1
[299.223053] Dynamic subtest D-eDP1: SUCCESS (4.449s)
[299.225343] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.430s)
[300.384074] [058/133] (719s left) i915_pm_rps (engine-order)
[300.448222] Starting subtest: engine-order
[305.305028] Subtest engine-order: SUCCESS (4.856s)
[305.424798] [059/133] (714s left) kms_plane_cursor (overlay)
[305.531433] Starting subtest: overlay
[305.535660] Starting dynamic subtest: pipe-A-eDP-1-size-64
[307.938152] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.408s)
[307.999229] Starting dynamic subtest: pipe-A-eDP-1-size-128
[310.452077] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.461s)
[310.509478] Starting dynamic subtest: pipe-A-eDP-1-size-256
[313.050162] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[313.399121] Starting dynamic subtest: pipe-B-eDP-1-size-64
[316.520664] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.131s)
[316.580764] Starting dynamic subtest: pipe-B-eDP-1-size-128
[319.152958] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.582s)
[319.215377] Starting dynamic subtest: pipe-B-eDP-1-size-256
[321.632259] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.427s)
[321.991899] Starting dynamic subtest: pipe-C-eDP-1-size-64
[324.825804] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.847s)
[324.863347] Starting dynamic subtest: pipe-C-eDP-1-size-128
[326.947787] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.092s)
[326.986229] Starting dynamic subtest: pipe-C-eDP-1-size-256
[329.059228] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.081s)
[330.109912] Starting dynamic subtest: pipe-D-eDP-1-size-64
[332.412352] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.316s)
[332.451877] Starting dynamic subtest: pipe-D-eDP-1-size-128
[334.555384] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.114s)
[334.595707] Starting dynamic subtest: pipe-D-eDP-1-size-256
[336.754991] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s)
[337.077587] Subtest overlay: SUCCESS (31.553s)
[337.915910] [060/133] (682s left) kms_sequence (queue-busy)
[338.004580] Starting subtest: queue-busy
[338.007434] Starting dynamic subtest: pipe-A-eDP-1
[339.943078] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[339.953546] Starting dynamic subtest: pipe-B-eDP-1
[342.520157] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.574s)
[342.530939] Starting dynamic subtest: pipe-C-eDP-1
[345.121758] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.602s)
[345.132044] Starting dynamic subtest: pipe-D-eDP-1
[347.741593] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.619s)
[347.743829] Subtest queue-busy: SUCCESS (9.739s)
[348.547166] [061/133] (671s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[348.646116] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[348.648392] Starting dynamic subtest: A-eDP1
[352.264363] Dynamic subtest A-eDP1: SUCCESS (3.619s)
[352.275444] Starting dynamic subtest: B-eDP1
[355.464337] Dynamic subtest B-eDP1: SUCCESS (3.198s)
[355.474565] Starting dynamic subtest: C-eDP1
[358.585030] Dynamic subtest C-eDP1: SUCCESS (3.122s)
[358.595474] Starting dynamic subtest: D-eDP1
[361.705018] Dynamic subtest D-eDP1: SUCCESS (3.117s)
[361.707318] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.063s)
[362.520096] [062/133] (657s left) gem_flink_basic (double-flink)
[362.588411] Starting subtest: double-flink
[362.590506] Subtest double-flink: SUCCESS (0.000s)
[362.698656] [063/133] (657s left) gem_ctx_isolation (dirty-switch)
[362.757621] Starting subtest: dirty-switch
[362.759987] Starting dynamic subtest: rcs0
[362.963747] Dynamic subtest rcs0: SUCCESS (0.206s)
[362.975099] Starting dynamic subtest: bcs0
[363.178349] Dynamic subtest bcs0: SUCCESS (0.214s)
[363.188551] Starting dynamic subtest: vcs0
[363.390970] Dynamic subtest vcs0: SUCCESS (0.211s)
[363.401998] Starting dynamic subtest: vcs1
[364.851926] Dynamic subtest vcs1: SUCCESS (1.460s)
[364.861520] Starting dynamic subtest: vecs0
[366.862781] Dynamic subtest vecs0: SUCCESS (2.010s)
[366.874185] Starting dynamic subtest: ccs0
[368.857591] Dynamic subtest ccs0: SUCCESS (1.994s)
[368.860053] Subtest dirty-switch: SUCCESS (6.100s)
[369.111025] [064/133] (650s left) kms_cursor_edge_walk (64x64-top-edge)
[369.201454] Starting subtest: 64x64-top-edge
[369.203890] Starting dynamic subtest: pipe-A-eDP-1
[372.674106] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.473s)
[372.684433] Starting dynamic subtest: pipe-D-eDP-1
[375.789900] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s)
[375.792147] Subtest 64x64-top-edge: SUCCESS (6.590s)
[376.611263] [065/133] (643s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[376.694572] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[376.696714] Starting dynamic subtest: pipe-A-eDP-1
[376.720150] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[376.729930] Starting dynamic subtest: pipe-B-eDP-1
[376.752022] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[376.760787] Starting dynamic subtest: pipe-C-eDP-1
[376.783428] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[376.792371] Starting dynamic subtest: pipe-D-eDP-1
[376.815158] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[376.819352] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[378.970848] [066/133] (641s left) gem_eio (hibernate)
[379.191971] Starting subtest: hibernate
[394.062792] Subtest hibernate: SUCCESS (14.869s)
[401.211827] [067/133] (626s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[401.344193] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[401.356315] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[401.446672] [068/133] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[401.553095] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[401.557251] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[401.646365] [069/133] (625s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[401.753479] Starting subtest: extended-modeset-hang-newfb-with-reset
[401.755828] Starting dynamic subtest: pipe-A
[416.733605] Dynamic subtest pipe-A: SUCCESS (14.976s)
[416.744050] Starting dynamic subtest: pipe-D
[432.716355] Dynamic subtest pipe-D: SUCCESS (15.978s)
[432.718666] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.959s)
[433.501593] [070/133] (593s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[433.603460] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[433.607775] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[433.674788] [071/133] (593s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[433.781982] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[437.508070] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.729s)
[438.702132] [072/133] (588s left) sysfs_preempt_timeout (invalid)
[438.757363] Starting subtest: invalid
[438.759865] Starting dynamic subtest: vecs0
[438.762294] Dynamic subtest vecs0: SUCCESS (0.000s)
[438.774426] Starting dynamic subtest: ccs0
[438.776330] Dynamic subtest ccs0: SUCCESS (0.000s)
[438.786735] Starting dynamic subtest: vcs0
[438.788642] Dynamic subtest vcs0: SUCCESS (0.000s)
[438.797633] Starting dynamic subtest: bcs0
[438.799573] Dynamic subtest bcs0: SUCCESS (0.000s)
[438.808895] Starting dynamic subtest: rcs0
[438.811095] Dynamic subtest rcs0: SUCCESS (0.000s)
[438.822120] Starting dynamic subtest: vcs1
[438.824022] Dynamic subtest vcs1: SUCCESS (0.000s)
[438.826005] Subtest invalid: SUCCESS (0.006s)
[438.875886] [073/133] (588s left) gem_exec_big (single)
[438.931598] Starting subtest: single
[443.750400] Subtest single: SUCCESS (4.816s)
[444.009976] [074/133] (583s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[444.158610] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[444.160969] Starting dynamic subtest: pipe-A-eDP-1
[444.220361] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[444.232177] Starting dynamic subtest: pipe-B-eDP-1
[444.290802] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[444.302105] Starting dynamic subtest: pipe-C-eDP-1
[444.359309] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[444.369846] Starting dynamic subtest: pipe-D-eDP-1
[444.427839] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[444.432055] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[446.452879] [075/133] (581s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[446.549667] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[447.561641] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.012s)
[447.692467] [076/133] (579s left) kms_chamelium_hpd (dp-hpd-storm)
[448.085201] Subtest dp-hpd-storm: SKIP (0.000s)
[448.867235] [077/133] (578s left) i915_query (query-topology-kernel-writes)
[448.919285] Starting subtest: query-topology-kernel-writes
[448.921272] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[449.012385] [078/133] (578s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[449.110845] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[449.115271] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[449.185160] [079/133] (578s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[449.246903] Starting subtest: invalid-bsd2-flag-on-blt
[449.249328] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[449.357434] [080/133] (578s left) sw_sync (sync_busy_fork)
[449.403980] Starting subtest: sync_busy_fork
[450.417458] Subtest sync_busy_fork: SUCCESS (1.011s)
[450.492904] [081/133] (577s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[450.549540] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[450.551948] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[450.657834] [082/133] (577s left) kms_chamelium_frames (hdmi-crc-fast)
[451.056117] Subtest hdmi-crc-fast: SKIP (0.000s)
[451.901141] [083/133] (575s left) gem_flink_basic (flink-lifetime)
[451.955955] Starting subtest: flink-lifetime
[451.958283] Subtest flink-lifetime: SUCCESS (0.002s)
[452.055618] [084/133] (575s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[452.159345] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[452.163468] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[452.256929] [085/133] (575s left) kms_prop_blob (basic)
[452.313588] Starting subtest: basic
[452.315822] Subtest basic: SUCCESS (0.000s)
[452.403638] [086/133] (575s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[452.464111] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[452.572677] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[452.649484] [087/133] (575s left) perf (blocking-parameterized)
[452.799190] Starting subtest: blocking-parameterized
[472.879784] Subtest blocking-parameterized: SUCCESS (20.026s)
[472.919850] [088/133] (555s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[472.979338] Starting subtest: etime-multi-wait-all-submitted-signaled
[473.084955] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[473.179230] [089/133] (554s left) gem_exec_fence (submit-chain)
[473.364679] Starting subtest: submit-chain
[473.397397] Subtest submit-chain: SUCCESS (0.032s)
[474.793517] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[474.796853] [090/133] (553s left) gem_exec_params (mmapped)
[474.847705] Starting subtest: mmapped
[474.851738] Subtest mmapped: SUCCESS (0.006s)
[474.982816] [091/133] (553s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[475.086738] Starting subtest: x-tiled-32bpp-rotate-180
[476.612538] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.525s)
[476.744612] [092/133] (551s left) sw_sync (sync_expired_merge)
[476.788361] Starting subtest: sync_expired_merge
[477.865036] Subtest sync_expired_merge: SUCCESS (1.074s)
[477.927028] [093/133] (550s left) prime_vgem (basic-fence-mmap)
[478.014502] Starting subtest: basic-fence-mmap
[478.019021] Subtest basic-fence-mmap: SKIP (0.000s)
[478.118752] [094/133] (550s left) gem_ctx_shared (disjoint-timelines)
[478.180777] Starting subtest: disjoint-timelines
[478.198261] Subtest disjoint-timelines: SUCCESS (0.020s)
[478.447014] [095/133] (549s left) kms_psr (psr-dpms)
[478.531964] Starting subtest: psr-dpms
[478.534260] Starting dynamic subtest: eDP-1
[481.463801] Dynamic subtest eDP-1: SUCCESS (2.931s)
[481.466020] Subtest psr-dpms: SUCCESS (2.932s)
[482.317603] [096/133] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[482.415206] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[489.701872] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.288s)
[489.827604] [097/133] (538s left) gem_softpin (allocator-nopin)
[489.889027] Starting subtest: allocator-nopin
[489.976238] Subtest allocator-nopin: SUCCESS (0.087s)
[490.096450] [098/133] (538s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[490.191668] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[490.193909] Starting dynamic subtest: pipe-A-default-mode
[491.306166] Dynamic subtest pipe-A-default-mode: SKIP (1.111s)
[491.310761] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.113s)
[491.441961] [099/133] (537s left) gem_exec_flush (basic-wb-pro-default)
[491.510162] Starting subtest: basic-wb-pro-default
[496.992994] Subtest basic-wb-pro-default: SUCCESS (5.463s)
[497.164276] [100/133] (531s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[497.274858] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[497.277135] Starting dynamic subtest: pipe-A-eDP-1
[497.363742] Dynamic subtest pipe-A-eDP-1: SKIP (0.092s)
[497.374417] Starting dynamic subtest: pipe-B-eDP-1
[498.554270] Dynamic subtest pipe-B-eDP-1: SKIP (1.187s)
[498.558788] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.282s)
[499.753140] [101/133] (528s left) syncobj_timeline (single-wait-available-submitted)
[499.815413] Starting subtest: single-wait-available-submitted
[499.818255] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[499.918536] [102/133] (528s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[499.978108] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[499.982357] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[500.174992] [103/133] (528s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[500.278737] Starting subtest: psr-rgb101010-draw-pwrite
[507.971577] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.696s)
[508.088242] [104/133] (520s left) perf (gen8-unprivileged-single-ctx-counters)
[508.162757] Starting subtest: gen8-unprivileged-single-ctx-counters
[508.167507] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[508.212769] [105/133] (520s left) api_intel_allocator (standalone)
[508.278515] Starting subtest: standalone
[508.294061] Subtest standalone: SUCCESS (0.017s)
[508.426252] [106/133] (520s left) kms_getfb (getfb-handle-closed)
[508.513182] Starting subtest: getfb-handle-closed
[508.515211] Subtest getfb-handle-closed: SUCCESS (0.000s)
[508.614736] [107/133] (520s left) perf (mi-rpc)
[508.704017] Starting subtest: mi-rpc
[508.708675] Subtest mi-rpc: SKIP (0.000s)
[508.753117] [108/133] (520s left) kms_async_flips (async-flip-dpms)
[508.842637] Starting subtest: async-flip-dpms
[509.218135] Starting dynamic subtest: pipe-A-eDP-1
[513.000197] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.782s)
[513.376013] Starting dynamic subtest: pipe-B-eDP-1
[516.174535] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.806s)
[516.568754] Starting dynamic subtest: pipe-C-eDP-1
[519.353467] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.792s)
[519.747220] Starting dynamic subtest: pipe-D-eDP-1
[522.544608] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.805s)
[522.547003] Subtest async-flip-dpms: SUCCESS (13.702s)
[523.723647] [109/133] (505s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[523.829495] Starting subtest: y-tiled-64bpp-rotate-180
[523.833951] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[523.927504] [110/133] (505s left) gem_close_race (multigpu-basic-process)
[523.990352] Starting subtest: multigpu-basic-process
[523.994826] Subtest multigpu-basic-process: SKIP (0.000s)
[524.216846] [111/133] (504s left) kms_cursor_crc (cursor-offscreen-32x10)
[524.375502] Starting subtest: cursor-offscreen-32x10
[524.425466] Subtest cursor-offscreen-32x10: SKIP (0.044s)
[524.701207] [112/133] (504s left) gem_exec_flush (basic-wb-rw-default)
[524.766119] Starting subtest: basic-wb-rw-default
[530.258946] Subtest basic-wb-rw-default: SUCCESS (5.456s)
[530.407845] [113/133] (498s left) dmabuf_sync_file (export-before-signal)
[530.449435] Starting subtest: export-before-signal
[530.451715] Subtest export-before-signal: SUCCESS (0.001s)
[530.503793] [114/133] (498s left) gem_exec_schedule (preempt-queue-contexts-chain)
[530.590200] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[530.885148] [115/133] (498s left) perf_pmu (semaphore-wait)
[530.930575] Starting subtest: semaphore-wait
[530.932568] Starting dynamic subtest: rcs0
[531.451255] Dynamic subtest rcs0: SUCCESS (0.519s)
[531.465210] Starting dynamic subtest: bcs0
[531.967471] Dynamic subtest bcs0: SUCCESS (0.512s)
[531.981317] Starting dynamic subtest: vcs0
[532.486055] Dynamic subtest vcs0: SUCCESS (0.513s)
[532.500750] Starting dynamic subtest: vcs1
[533.002148] Dynamic subtest vcs1: SUCCESS (0.513s)
[533.016830] Starting dynamic subtest: vecs0
[533.518258] Dynamic subtest vecs0: SUCCESS (0.513s)
[533.533098] Starting dynamic subtest: ccs0
[534.037888] Dynamic subtest ccs0: SUCCESS (0.514s)
[534.040799] Subtest semaphore-wait: SUCCESS (3.107s)
[534.161297] [116/133] (495s left) gem_basic (multigpu-create-close)
[534.218898] Starting subtest: multigpu-create-close
[534.223320] Subtest multigpu-create-close: SKIP (0.000s)
[534.306000] [117/133] (495s left) kms_vblank (query-idle)
[534.397660] Starting subtest: query-idle
[534.399531] Starting dynamic subtest: pipe-A-eDP-1
[536.152078] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[536.168256] Starting dynamic subtest: pipe-D-eDP-1
[538.572662] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.419s)
[538.575125] Subtest query-idle: SUCCESS (4.176s)
[539.406122] [118/133] (489s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[539.500905] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[539.504824] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[539.652012] [119/133] (489s left) syncobj_timeline (reset-during-wait-for-submit)
[539.705196] Starting subtest: reset-during-wait-for-submit
[539.810172] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[539.893297] [120/133] (489s left) i915_suspend (basic-s3-without-i915)
[539.933234] Starting subtest: basic-s3-without-i915
[543.221187] Subtest basic-s3-without-i915: SKIP (3.286s)
[544.847012] [121/133] (484s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[544.959995] Starting subtest: plane-primary-toggle-with-vblank-wait
[544.962239] Starting dynamic subtest: pipe-A-eDP-1
[545.133231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[546.172718] Starting dynamic subtest: pipe-B-eDP-1
[546.590082] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.430s)
[546.888987] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.929s)
[547.748315] [122/133] (481s left) kms_psr (fbc-psr-primary-blt)
[547.841644] Starting subtest: fbc-psr-primary-blt
[547.843979] Starting dynamic subtest: eDP-1
[547.848345] Dynamic subtest eDP-1: SKIP (0.000s)
[547.852738] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[547.917655] [123/133] (481s left) gem_mmap (bad-offset)
[547.979454] Subtest bad-offset: SKIP (0.000s)
[548.039814] [124/133] (481s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[548.138969] Starting subtest: yf-tiled-8bpp-rotate-0
[548.143195] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[548.232436] [125/133] (481s left) gem_exec_flush (basic-batch-kernel-default-wb)
[548.315268] Starting subtest: basic-batch-kernel-default-wb
[555.763043] Subtest basic-batch-kernel-default-wb: SUCCESS (7.449s)
[555.963301] [126/133] (473s left) perf (invalid-oa-format-id)
[556.078433] Starting subtest: invalid-oa-format-id
[556.090565] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[556.131440] [127/133] (473s left) kms_async_flips (test-time-stamp)
[556.222238] Starting subtest: test-time-stamp
[556.595657] Starting dynamic subtest: pipe-A-eDP-1
[557.351927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s)
[557.724162] Starting dynamic subtest: pipe-B-eDP-1
[558.479793] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s)
[558.843772] Starting dynamic subtest: pipe-C-eDP-1
[559.611900] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[559.995043] Starting dynamic subtest: pipe-D-eDP-1
[560.755927] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[560.758546] Subtest test-time-stamp: SUCCESS (4.533s)
[561.916267] [128/133] (467s left) kms_content_protection (legacy-hdcp14)
[562.060983] Starting subtest: legacy-hdcp14
[562.065446] Subtest legacy-hdcp14: SKIP (0.000s)
[562.175418] [129/133] (467s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[562.268878] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[562.271201] Starting dynamic subtest: pipe-A-eDP-1
[578.872247] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.669s)
[578.882306] Starting dynamic subtest: pipe-B-eDP-1
[596.594108] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.352s)
[596.605074] Starting dynamic subtest: pipe-C-eDP-1
[613.599293] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.354s)
[613.611705] Starting dynamic subtest: pipe-D-eDP-1
[630.584960] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.367s)
[630.587556] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.746s)
[631.743554] [130/133] (398s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[631.852990] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[638.679623] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.718s)
[638.797614] [131/133] (391s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[639.190747] Starting subtest: cursor-rapid-movement-max-size
[639.199467] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[639.331029] [132/133] (390s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[639.434993] Starting subtest: fbcpsr-suspend
[680.081469] Subtest fbcpsr-suspend: SUCCESS (10.320s)
[680.230149] [133/133] (349s left) api_intel_bb (reset-flags)
[680.295025] Starting subtest: reset-flags
[680.302804] Subtest reset-flags: SUCCESS (0.010s)
[680.422521] 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.