[59.981880] Initializing watchdogs
[59.981927]   /dev/watchdog0
[59.995844] [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]
[59.999961] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.002555] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.005910] [001/131] (960s left) gem_create (create-size-update)
[60.092205] Starting subtest: create-size-update
[60.094462] Subtest create-size-update: SUCCESS (0.000s)
[60.342927] [002/131] (960s left) kms_color (ctm-blue-to-red)
[60.453039] Starting subtest: ctm-blue-to-red
[60.454978] Starting dynamic subtest: pipe-A-eDP-1
[61.189877] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[61.199385] Starting dynamic subtest: pipe-B-eDP-1
[62.611548] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.427s)
[62.619504] Starting dynamic subtest: pipe-C-eDP-1
[63.949520] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.343s)
[63.957348] Starting dynamic subtest: pipe-D-eDP-1
[65.259697] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[65.262289] Subtest ctm-blue-to-red: SUCCESS (4.831s)
[66.126345] [003/131] (954s left) kms_draw_crc (draw-method-mmap-wc)
[66.219993] Starting subtest: draw-method-mmap-wc
[66.222019] Starting dynamic subtest: xrgb8888-untiled
[66.484443] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[66.493321] Starting dynamic subtest: rgb565-untiled
[66.695597] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[66.704628] Starting dynamic subtest: xrgb2101010-untiled
[66.927809] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[66.935097] Starting dynamic subtest: xbgr16161616f-untiled
[67.171847] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[67.179046] Starting dynamic subtest: xrgb8888-xtiled
[67.304335] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[67.311482] Starting dynamic subtest: rgb565-xtiled
[67.448494] Dynamic subtest rgb565-xtiled: SUCCESS (0.143s)
[67.455764] Starting dynamic subtest: xrgb2101010-xtiled
[67.581500] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[67.590215] Starting dynamic subtest: xbgr16161616f-xtiled
[67.714480] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[67.721871] Starting dynamic subtest: xrgb8888-4tiled
[67.858836] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[67.866491] Starting dynamic subtest: rgb565-4tiled
[68.014701] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[68.021774] Starting dynamic subtest: xrgb2101010-4tiled
[68.158350] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[68.166594] Starting dynamic subtest: xbgr16161616f-4tiled
[68.348248] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.189s)
[68.350088] Subtest draw-method-mmap-wc: SUCCESS (2.135s)
[68.457187] [004/131] (952s left) kms_dp_aux_dev
[68.837032] [005/131] (951s left) gem_eio (reset-stress)
[69.009689] Starting subtest: reset-stress
[69.011906] Starting dynamic subtest: render
[72.963518] Dynamic subtest render: SUCCESS (3.958s)
[72.978161] Starting dynamic subtest: bsd1
[91.307605] Dynamic subtest bsd1: SUCCESS (18.351s)
[91.321508] Starting dynamic subtest: bsd2
[109.269366] Dynamic subtest bsd2: SUCCESS (17.963s)
[109.283812] Starting dynamic subtest: blt
[109.287770] Dynamic subtest blt: SKIP (0.000s)
[109.295613] Starting dynamic subtest: vebox
[127.331557] Dynamic subtest vebox: SUCCESS (18.063s)
[127.333610] Subtest reset-stress: SUCCESS (58.337s)
[128.974142] [FACT gem_eio (reset-stress)] new: kernel.kmod_is_loaded.vgem: true
[128.977561] [006/131] (891s left) gem_ctx_sseu (invalid-sseu)
[129.051847] Subtest invalid-sseu: SKIP (0.000s)
[129.145930] [007/131] (891s left) kms_big_fb (linear-64bpp-rotate-0)
[129.258078] Starting subtest: linear-64bpp-rotate-0
[130.813910] Subtest linear-64bpp-rotate-0: SUCCESS (1.556s)
[131.046909] [008/131] (889s left) kms_cursor_crc (cursor-random-32x32)
[131.206476] Starting subtest: cursor-random-32x32
[131.283161] Subtest cursor-random-32x32: SKIP (0.071s)
[131.607624] [009/131] (889s left) syncobj_wait (invalid-single-wait-unsubmitted)
[131.675830] Starting subtest: invalid-single-wait-unsubmitted
[131.678228] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[131.813195] [010/131] (889s left) i915_pm_freq_mult (media-freq)
[131.875229] Starting subtest: media-freq
[131.877489] Starting dynamic subtest: gt0
[131.881865] Dynamic subtest gt0: SKIP (0.000s)
[131.889504] Starting dynamic subtest: gt1
[131.893883] Dynamic subtest gt1: SKIP (0.000s)
[131.898183] Subtest media-freq: SKIP (0.001s)
[132.017125] [011/131] (888s left) kms_plane_scaling (2x-scaler-multi-pipe)
[132.119169] Starting subtest: 2x-scaler-multi-pipe
[132.122958] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[132.262425] [012/131] (888s left) gem_fence_thrash (bo-write-verify-threaded-y)
[132.295176] Starting subtest: bo-write-verify-threaded-y
[132.324050] Subtest bo-write-verify-threaded-y: SKIP (0.028s)
[132.389572] [013/131] (888s left) kms_plane (planar-pixel-format-settings)
[132.485117] Starting subtest: planar-pixel-format-settings
[132.527203] Subtest planar-pixel-format-settings: SUCCESS (0.043s)
[132.646259] [014/131] (888s left) kms_invalid_mode (bad-hsync-start)
[132.739613] Starting subtest: bad-hsync-start
[132.741492] Starting dynamic subtest: pipe-A-eDP-1
[133.026105] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[133.037630] Starting dynamic subtest: pipe-B-eDP-1
[133.040068] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[133.050164] Starting dynamic subtest: pipe-C-eDP-1
[133.052083] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[133.059343] Starting dynamic subtest: pipe-D-eDP-1
[133.061246] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[133.063115] Subtest bad-hsync-start: SUCCESS (0.289s)
[133.927830] [015/131] (887s left) gem_exec_params (invalid-fence-in-submit)
[133.997710] Starting subtest: invalid-fence-in-submit
[134.002329] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[134.166400] [016/131] (886s left) gem_ctx_param (invalid-get-ringsize)
[134.228772] Starting subtest: invalid-get-ringsize
[134.231116] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[134.364615] [017/131] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[134.473533] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[134.478060] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[134.610278] [018/131] (886s left) syncobj_eventfd (timeline-wait-before-signal)
[134.669460] Starting subtest: timeline-wait-before-signal
[134.700197] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[134.801872] [019/131] (886s left) gem_exec_schedule (reorder-wide)
[134.998772] Subtest reorder-wide: SKIP (0.000s)
[135.203111] [020/131] (886s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[135.264205] Starting subtest: etime-single-wait-all-for-submit-submitted
[135.370416] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[135.467242] [021/131] (885s left) kms_cursor_crc (cursor-size-change)
[135.575145] Starting subtest: cursor-size-change
[135.577151] Starting dynamic subtest: pipe-A-eDP-1
[136.373082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s)
[136.382303] Starting dynamic subtest: pipe-D-eDP-1
[137.858690] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.484s)
[137.860706] Subtest cursor-size-change: SUCCESS (2.285s)
[138.693762] [022/131] (882s left) gem_exec_fence (long-history)
[139.120466] Starting subtest: long-history
[146.661611] Subtest long-history: SUCCESS (7.540s)
[147.137513] [023/131] (874s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[147.269223] Starting subtest: basic-flip-after-cursor-varying-size
[148.211461] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.942s)
[149.033140] [024/131] (872s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[154.002353] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[154.007086] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.003s)
[154.864294] [025/131] (866s left) kms_psr (fbc-psr2-dpms)
[154.968098] Starting subtest: fbc-psr2-dpms
[154.970439] Starting dynamic subtest: eDP-1
[154.974810] Dynamic subtest eDP-1: SKIP (0.000s)
[154.979224] Subtest fbc-psr2-dpms: SKIP (0.001s)
[155.061433] [026/131] (866s left) perf (oa-exponents)
[155.191493] Starting subtest: oa-exponents
[155.193787] Starting dynamic subtest: 0-rcs0
[156.949706] Dynamic subtest 0-rcs0: SUCCESS (1.756s)
[156.958811] Starting dynamic subtest: 1-vcs0
[158.752064] Dynamic subtest 1-vcs0: SUCCESS (1.801s)
[158.754714] Subtest oa-exponents: SUCCESS (3.559s)
[158.822415] [027/131] (862s left) gem_userptr_blits (access-control)
[158.902944] Starting subtest: access-control
[158.907402] Subtest access-control: SKIP (0.000s)
[159.050230] [028/131] (862s left) syncobj_timeline (wait-zero-handles)
[159.113322] Starting subtest: wait-zero-handles
[159.115583] Subtest wait-zero-handles: SUCCESS (0.000s)
[159.228072] [029/131] (862s left) gem_ctx_persistence (engines-queued)
[159.287892] Starting subtest: engines-queued
[159.289874] Starting dynamic subtest: rcs0
[159.380908] Dynamic subtest rcs0: SUCCESS (0.095s)
[159.392076] Starting dynamic subtest: bcs0
[159.434613] Dynamic subtest bcs0: SUCCESS (0.053s)
[159.444811] Starting dynamic subtest: vcs0
[160.886660] Dynamic subtest vcs0: SUCCESS (1.449s)
[160.897063] Starting dynamic subtest: vcs1
[162.867959] Dynamic subtest vcs1: SUCCESS (1.979s)
[162.878630] Starting dynamic subtest: vecs0
[164.851677] Dynamic subtest vecs0: SUCCESS (1.981s)
[164.862372] Starting dynamic subtest: ccs0
[165.039171] Dynamic subtest ccs0: SUCCESS (0.188s)
[165.041885] Subtest engines-queued: SUCCESS (5.753s)
[165.197362] [030/131] (856s left) i915_query (query-topology-garbage-items)
[165.267069] Starting subtest: query-topology-garbage-items
[165.269434] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[165.404541] [031/131] (856s left) gen9_exec_parse (shadow-peek)
[165.459783] Subtest shadow-peek: SKIP (0.000s)
[165.534853] [032/131] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[165.637263] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[172.971190] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.335s)
[173.132152] [033/131] (848s left) gem_mmap_wc (read)
[173.197207] Subtest read: SKIP (0.000s)
[173.258077] [034/131] (848s left) gem_exec_whisper (basic-normal)
[173.313798] Starting subtest: basic-normal
[178.336345] Subtest basic-normal: SUCCESS (5.019s)
[178.541116] [035/131] (843s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[178.660552] Starting subtest: extended-modeset-hang-newfb-with-reset
[178.662771] Starting dynamic subtest: pipe-A
[194.078934] Dynamic subtest pipe-A: SUCCESS (15.416s)
[194.089591] Starting dynamic subtest: pipe-D
[209.572803] Dynamic subtest pipe-D: SUCCESS (15.488s)
[209.575181] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.909s)
[210.395022] [036/131] (811s left) kms_psr (fbc-psr-primary-render)
[210.491084] Starting subtest: fbc-psr-primary-render
[210.493292] Starting dynamic subtest: eDP-1
[210.497459] Dynamic subtest eDP-1: SKIP (0.000s)
[210.501628] Subtest fbc-psr-primary-render: SKIP (0.001s)
[210.589488] [037/131] (811s left) kms_psr (fbc-pr-primary-mmap-gtt)
[210.684142] Starting subtest: fbc-pr-primary-mmap-gtt
[210.688343] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[210.777327] [038/131] (811s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[210.891433] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[214.996548] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.108s)
[216.187675] [039/131] (805s left) gem_mmap (big-bo)
[216.255886] Subtest big-bo: SKIP (0.000s)
[216.322098] [040/131] (805s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[216.419167] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[216.421472] Starting dynamic subtest: pipe-A-eDP-1
[216.444706] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[216.456026] Starting dynamic subtest: pipe-B-eDP-1
[216.477620] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[216.486156] Starting dynamic subtest: pipe-C-eDP-1
[216.507835] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[216.516332] Starting dynamic subtest: pipe-D-eDP-1
[216.538851] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[216.543369] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[218.657794] [041/131] (803s left) gem_eio (unwedge-stress)
[218.861744] Starting subtest: unwedge-stress
[218.864417] Starting dynamic subtest: render
[223.710814] Dynamic subtest render: SUCCESS (4.850s)
[223.726710] Starting dynamic subtest: bsd1
[241.398498] Dynamic subtest bsd1: SUCCESS (17.685s)
[241.413687] Starting dynamic subtest: bsd2
[259.387916] Dynamic subtest bsd2: SUCCESS (17.989s)
[259.404315] Starting dynamic subtest: blt
[259.408587] Dynamic subtest blt: SKIP (0.000s)
[259.417083] Starting dynamic subtest: vebox
[277.374887] Dynamic subtest vebox: SUCCESS (17.985s)
[277.376956] Subtest unwedge-stress: SUCCESS (58.512s)
[279.010057] [042/131] (743s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[279.113603] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[279.117716] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[279.245061] [043/131] (742s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[279.309386] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[279.313475] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[279.515714] [044/131] (742s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[279.642749] Starting subtest: cursorB-vs-flipA-atomic
[279.647624] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[279.812062] [045/131] (742s left) kms_vrr (seamless-rr-switch-vrr)
[279.916956] Starting subtest: seamless-rr-switch-vrr
[279.923737] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[280.011255] [046/131] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[280.124790] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[280.129228] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[280.262488] [047/131] (742s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[280.363520] Starting subtest: crc-primary-basic-y-tiled-ccs
[280.365903] Starting dynamic subtest: pipe-A-eDP-1
[280.388934] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[280.400769] Starting dynamic subtest: pipe-B-eDP-1
[280.422174] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[280.431646] Starting dynamic subtest: pipe-C-eDP-1
[280.449769] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[280.458311] Starting dynamic subtest: pipe-D-eDP-1
[280.477224] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[280.480826] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[282.629373] [048/131] (739s left) gem_ctx_param (non-root-set)
[282.685049] Starting subtest: non-root-set
[282.712626] Subtest non-root-set: SUCCESS (0.028s)
[282.826294] [049/131] (739s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[282.928695] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[289.509220] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.581s)
[289.657490] [050/131] (732s left) fbdev (pan)
[289.696090] Starting subtest: pan
[289.727468] Subtest pan: SUCCESS (0.033s)
[289.822071] [051/131] (732s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[289.885528] Starting subtest: invalid-single-wait-unsubmitted
[289.887788] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[290.016296] [052/131] (732s left) kms_flip (bo-too-big)
[290.127782] Starting subtest: bo-too-big
[290.130057] Starting dynamic subtest: A-eDP1
[291.471904] Dynamic subtest A-eDP1: SUCCESS (1.346s)
[291.483647] Starting dynamic subtest: B-eDP1
[292.805217] Dynamic subtest B-eDP1: SUCCESS (1.332s)
[292.814349] Starting dynamic subtest: C-eDP1
[294.150655] Dynamic subtest C-eDP1: SUCCESS (1.345s)
[294.162069] Starting dynamic subtest: D-eDP1
[295.488427] Dynamic subtest D-eDP1: SUCCESS (1.337s)
[295.493317] Subtest bo-too-big: SUCCESS (5.370s)
[296.722844] [053/131] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[296.826674] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[296.830948] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[296.945291] [054/131] (725s left) syncobj_timeline (reset-unsignaled)
[297.012608] Starting subtest: reset-unsignaled
[297.014561] Subtest reset-unsignaled: SUCCESS (0.000s)
[297.133320] [055/131] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[297.228090] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[304.169300] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.942s)
[304.352967] [056/131] (718s left) gem_exec_schedule (preempt-queue)
[304.442264] Subtest preempt-queue: SKIP (0.000s)
[304.752799] [057/131] (718s left) gem_exec_balancer (bonded-false-hang)
[305.012018] Starting subtest: bonded-false-hang
[305.017040] Subtest bonded-false-hang: SKIP (0.000s)
[305.153611] [058/131] (717s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[305.249022] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[305.251199] Starting dynamic subtest: pipe-A
[305.475276] Dynamic subtest pipe-A: SUCCESS (0.229s)
[305.484395] Starting dynamic subtest: pipe-B
[306.821465] Dynamic subtest pipe-B: SUCCESS (1.345s)
[306.832721] Starting dynamic subtest: pipe-C
[308.153477] Dynamic subtest pipe-C: SUCCESS (1.331s)
[308.163660] Starting dynamic subtest: pipe-D
[309.452589] Dynamic subtest pipe-D: SUCCESS (1.298s)
[309.454978] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.206s)
[310.656899] [059/131] (712s left) gem_exec_create (madvise)
[310.721416] Starting subtest: madvise
[310.723825] Starting dynamic subtest: smem
[331.988324] Dynamic subtest smem: SUCCESS (21.263s)
[331.990860] Subtest madvise: SUCCESS (21.264s)
[333.011518] [060/131] (689s left) perf_pmu (init-sema)
[333.062244] Starting subtest: init-sema
[333.064434] Starting dynamic subtest: rcs0
[333.066653] Dynamic subtest rcs0: SUCCESS (0.003s)
[333.080918] Starting dynamic subtest: bcs0
[333.083253] Dynamic subtest bcs0: SUCCESS (0.001s)
[333.094333] Starting dynamic subtest: vcs0
[333.096354] Dynamic subtest vcs0: SUCCESS (0.001s)
[333.108452] Starting dynamic subtest: vcs1
[333.110670] Dynamic subtest vcs1: SUCCESS (0.001s)
[333.119080] Starting dynamic subtest: vecs0
[333.121394] Dynamic subtest vecs0: SUCCESS (0.000s)
[333.129833] Starting dynamic subtest: ccs0
[333.132101] Dynamic subtest ccs0: SUCCESS (0.000s)
[333.134269] Subtest init-sema: SUCCESS (0.013s)
[333.189275] [061/131] (689s left) kms_chamelium_color (ctm-negative)
[333.286680] Subtest ctm-negative: SKIP (0.000s)
[333.336955] [062/131] (689s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[333.386985] Subtest no-spare-fences-busy: SKIP (0.000s)
[333.460425] [063/131] (689s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[333.554125] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[333.556341] Starting dynamic subtest: pipe-A-eDP-1
[333.576645] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[333.587748] Starting dynamic subtest: pipe-B-eDP-1
[333.607077] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[333.615869] Starting dynamic subtest: pipe-C-eDP-1
[333.635371] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[333.644100] Starting dynamic subtest: pipe-D-eDP-1
[333.663509] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[333.665686] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[335.813427] [064/131] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[335.915830] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[335.919979] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[336.035532] [065/131] (687s left) core_setmaster (master-drop-set-user)
[336.143378] Starting subtest: master-drop-set-user
[336.154317] Subtest master-drop-set-user: SUCCESS (0.013s)
[336.192079] [066/131] (686s left) kms_color (legacy-gamma-reset)
[336.289095] Starting subtest: legacy-gamma-reset
[336.290951] Starting dynamic subtest: pipe-A-eDP-1
[336.677060] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[336.692664] Starting dynamic subtest: pipe-B-eDP-1
[336.695137] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[336.706155] Starting dynamic subtest: pipe-C-eDP-1
[336.708473] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[336.717380] Starting dynamic subtest: pipe-D-eDP-1
[336.719770] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[336.722061] Subtest legacy-gamma-reset: SUCCESS (0.428s)
[337.547405] [067/131] (685s left) kms_selftest (drm_plane_helper)
[337.586024] Starting subtest: drm_plane_helper
[337.632870] Starting dynamic subtest: drm_test_check_plane_state
[337.797206] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.165s)
[337.808168] Starting dynamic subtest: drm_test_check_invalid_plane_state
[337.926496] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.127s)
[337.928788] Subtest drm_plane_helper: SUCCESS (0.339s)
[338.125963] [068/131] (685s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[338.220822] Starting subtest: psr-1p-primscrn-spr-indfb-move
[345.797441] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.578s)
[345.960466] [069/131] (677s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[346.063319] Starting subtest: yf-tiled-64bpp-rotate-180
[346.067398] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[346.200949] [070/131] (677s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[346.325546] Starting subtest: short-flip-before-cursor-atomic-transitions
[347.291299] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.964s)
[348.114442] [071/131] (675s left) sw_sync (sync_busy)
[348.153825] Starting subtest: sync_busy
[348.156098] Subtest sync_busy: SUCCESS (0.002s)
[348.231361] [072/131] (675s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[348.330078] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[348.332172] Starting dynamic subtest: pipe-A-eDP-1
[350.575988] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.247s)
[350.593999] Starting dynamic subtest: pipe-B-eDP-1
[352.884629] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.305s)
[352.893881] Starting dynamic subtest: pipe-C-eDP-1
[355.060046] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.176s)
[355.069168] Starting dynamic subtest: pipe-D-eDP-1
[357.120462] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.059s)
[357.122425] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.792s)
[358.332305] [073/131] (665s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[358.428207] Starting subtest: basic-modeset-with-all-modifiers-formats
[358.800067] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[359.587281] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.787s)
[359.596639] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[359.609311] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[359.618109] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[359.631753] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[359.640586] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[359.787446] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[359.796703] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[359.810055] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[359.819166] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[359.831683] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[359.840720] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[359.854213] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[359.863099] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[359.876367] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[359.885364] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[359.898546] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[359.907588] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[359.920847] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[359.929907] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[359.943133] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[359.951973] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[359.965378] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[359.974386] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[360.120887] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[360.130062] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[360.143131] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[360.152211] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[360.165277] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[360.174230] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[360.187540] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[360.196392] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[360.209827] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[360.219224] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[360.232060] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[360.241303] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[360.254268] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[360.263170] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[360.276064] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[360.284862] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[360.298630] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[360.307075] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[360.454230] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[360.463196] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[360.476448] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[360.485051] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[360.498672] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[360.507198] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[360.520987] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[360.529506] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[360.543148] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[360.551749] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[360.565370] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[360.574601] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[360.587557] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[360.595977] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[360.609822] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[360.618341] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[360.632080] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[361.026825] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.600s)
[361.915576] [074/131] (661s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[362.026711] Starting subtest: cursorB-vs-flipA-legacy
[362.031288] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[362.196815] [075/131] (661s left) gem_mmap_wc (pf-nonblock)
[362.273731] Subtest pf-nonblock: SKIP (0.000s)
[362.329106] [076/131] (661s left) kms_psr (psr-primary-render)
[362.418983] Starting subtest: psr-primary-render
[362.421113] Starting dynamic subtest: eDP-1
[364.176172] Dynamic subtest eDP-1: SUCCESS (1.756s)
[364.178419] Subtest psr-primary-render: SUCCESS (1.757s)
[365.055420] [077/131] (658s left) kms_flip (flip-vs-panning-interruptible)
[365.162404] Starting subtest: flip-vs-panning-interruptible
[365.167330] Starting dynamic subtest: A-eDP1
[373.942416] Dynamic subtest A-eDP1: SUCCESS (8.777s)
[373.951896] Starting dynamic subtest: B-eDP1
[382.671496] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[382.684190] Starting dynamic subtest: C-eDP1
[391.384073] Dynamic subtest C-eDP1: SUCCESS (8.709s)
[391.396499] Starting dynamic subtest: D-eDP1
[400.120360] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[400.122314] Subtest flip-vs-panning-interruptible: SUCCESS (34.959s)
[401.317400] [078/131] (622s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[401.432213] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[401.436235] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[401.549189] [079/131] (622s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[401.645320] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[401.647611] Starting dynamic subtest: pipe-A-default-mode
[402.768330] Dynamic subtest pipe-A-default-mode: SKIP (1.120s)
[402.772421] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.121s)
[402.960116] [080/131] (620s left) kms_psr (pr-sprite-plane-move)
[403.068035] Starting subtest: pr-sprite-plane-move
[403.072472] Subtest pr-sprite-plane-move: SKIP (0.000s)
[403.173488] [081/131] (620s left) api_intel_bb (object-reloc-keep-cache)
[403.231941] Starting subtest: object-reloc-keep-cache
[403.236472] Subtest object-reloc-keep-cache: SKIP (0.003s)
[403.385749] [082/131] (620s left) gem_spin_batch (legacy-resubmit-new)
[403.450218] Starting subtest: legacy-resubmit-new
[403.452105] Starting dynamic subtest: default
[403.456922] Dynamic subtest default: SUCCESS (0.007s)
[403.468113] Starting dynamic subtest: render
[403.470313] Dynamic subtest render: SUCCESS (0.003s)
[403.479449] Starting dynamic subtest: bsd
[403.481272] Dynamic subtest bsd: SUCCESS (0.004s)
[403.490311] Starting dynamic subtest: bsd1
[403.492490] Dynamic subtest bsd1: SUCCESS (0.003s)
[403.501397] Starting dynamic subtest: bsd2
[403.503558] Dynamic subtest bsd2: SUCCESS (0.004s)
[403.512567] Starting dynamic subtest: blt
[403.514649] Dynamic subtest blt: SUCCESS (0.004s)
[403.523607] Starting dynamic subtest: vebox
[403.525707] Dynamic subtest vebox: SUCCESS (0.005s)
[403.527881] Subtest legacy-resubmit-new: SUCCESS (0.035s)
[404.960371] [083/131] (618s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[405.056743] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[405.061135] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[405.200024] [084/131] (618s left) kms_pm_rpm (modeset-lpsp-stress)
[407.125437] Starting subtest: modeset-lpsp-stress
[424.086626] Subtest modeset-lpsp-stress: SUCCESS (16.964s)
[424.203387] [085/131] (599s left) i915_hangman (gt-error-state-capture)
[424.273578] Starting subtest: gt-error-state-capture
[424.275730] Starting dynamic subtest: rcs0
[435.892456] Dynamic subtest rcs0: SUCCESS (11.618s)
[435.904816] Starting dynamic subtest: bcs0
[447.860268] Dynamic subtest bcs0: SUCCESS (11.965s)
[447.872422] Starting dynamic subtest: vcs0
[459.827660] Dynamic subtest vcs0: SUCCESS (11.964s)
[459.840015] Starting dynamic subtest: vcs1
[470.836597] Dynamic subtest vcs1: SUCCESS (11.006s)
[470.848636] Starting dynamic subtest: vecs0
[482.803719] Dynamic subtest vecs0: SUCCESS (11.964s)
[482.815879] Starting dynamic subtest: ccs0
[493.876804] Dynamic subtest ccs0: SUCCESS (11.070s)
[493.879442] Subtest gt-error-state-capture: SUCCESS (69.603s)
[493.981933] [086/131] (530s left) kms_psr (psr-no-drrs)
[494.089061] Starting subtest: psr-no-drrs
[494.091350] Starting dynamic subtest: eDP-1
[495.721896] Dynamic subtest eDP-1: SUCCESS (1.632s)
[495.724248] Subtest psr-no-drrs: SUCCESS (1.633s)
[496.614373] [087/131] (527s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[496.739780] Starting subtest: pipe-fbc-rte
[496.746821] Starting dynamic subtest: pipe-B-eDP-1
[502.259037] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.522s)
[502.267084] Subtest pipe-fbc-rte: SUCCESS (5.525s)
[504.615524] [088/131] (519s left) kms_vrr (max-min)
[504.715115] Starting subtest: max-min
[504.721431] Subtest max-min: SKIP (0.000s)
[504.812322] [089/131] (519s left) kms_atomic (plane-primary-legacy)
[504.898091] Starting subtest: plane-primary-legacy
[504.900328] Starting dynamic subtest: pipe-A-eDP-1
[505.351618] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[505.353553] Subtest plane-primary-legacy: SUCCESS (0.450s)
[506.246059] [090/131] (517s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[506.359732] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[507.418463] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.058s)
[507.589069] [091/131] (516s left) syncobj_wait (reset-multiple-signaled)
[507.656035] Starting subtest: reset-multiple-signaled
[507.658076] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[507.791055] [092/131] (516s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[507.896789] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[508.987929] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.090s)
[509.166402] [093/131] (515s left) kms_cursor_crc (cursor-offscreen-512x170)
[509.474461] Starting subtest: cursor-offscreen-512x170
[509.478888] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[509.666953] [094/131] (514s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[509.719327] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[509.721461] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[509.854222] [095/131] (514s left) gem_mmap_offset (bad-extensions)
[509.911149] Starting subtest: bad-extensions
[509.913071] Subtest bad-extensions: SUCCESS (0.000s)
[510.049015] [096/131] (514s left) kms_flip (flip-vs-absolute-wf_vblank)
[510.136262] Starting subtest: flip-vs-absolute-wf_vblank
[510.138215] Starting dynamic subtest: A-eDP1
[519.076789] Dynamic subtest A-eDP1: SUCCESS (8.939s)
[519.086545] Starting dynamic subtest: B-eDP1
[528.002484] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[528.019224] Starting dynamic subtest: C-eDP1
[536.922766] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[536.932077] Starting dynamic subtest: D-eDP1
[545.855809] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[545.861095] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.725s)
[547.102553] [097/131] (477s left) gem_exec_whisper (basic-queues-priority-all)
[547.182603] Starting subtest: basic-queues-priority-all
[569.378301] Subtest basic-queues-priority-all: SUCCESS (22.193s)
[569.588876] [098/131] (454s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[569.652762] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[569.713231] [099/131] (454s left) gem_eio (in-flight-external)
[569.959733] Starting subtest: in-flight-external
[570.993724] Subtest in-flight-external: SUCCESS (1.032s)
[571.171576] [100/131] (453s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[571.275909] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[571.280232] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[571.390176] [101/131] (453s left) gem_exec_fence (basic-busy-all)
[571.450714] Starting subtest: basic-busy-all
[571.555291] Subtest basic-busy-all: SUCCESS (0.106s)
[573.068845] [102/131] (451s left) gem_render_copy (linear-to-vebox-y-tiled)
[573.129734] Starting subtest: linear-to-vebox-y-tiled
[573.134264] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[573.329348] [103/131] (451s left) kms_plane_alpha_blend (alpha-transparent-fb)
[573.441391] Starting subtest: alpha-transparent-fb
[573.742839] Starting dynamic subtest: pipe-A-eDP-1
[574.369563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s)
[574.379765] Starting dynamic subtest: pipe-D-eDP-1
[575.751877] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.380s)
[575.754254] Subtest alpha-transparent-fb: SUCCESS (2.311s)
[576.654901] [104/131] (448s left) prime_vgem (shrink)
[576.725626] Starting subtest: shrink
[576.738168] Subtest shrink: SUCCESS (0.013s)
[576.890043] [105/131] (447s left) kms_cursor_crc (cursor-sliding-256x256)
[577.135091] Starting subtest: cursor-sliding-256x256
[577.140079] Starting dynamic subtest: pipe-A-eDP-1
[580.368618] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.230s)
[580.400296] Starting dynamic subtest: pipe-D-eDP-1
[584.301631] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.909s)
[584.304055] Subtest cursor-sliding-256x256: SUCCESS (7.166s)
[585.201510] [106/131] (439s left) gen9_exec_parse (bb-start-far)
[585.267076] Subtest bb-start-far: SKIP (0.000s)
[585.344684] [107/131] (439s left) kms_addfb_basic (bad-pitch-1024)
[585.405943] Starting subtest: bad-pitch-1024
[585.408542] Subtest bad-pitch-1024: SUCCESS (0.000s)
[585.578747] [108/131] (439s left) gem_ctx_create (basic)
[585.644126] Starting subtest: basic
[585.646455] Subtest basic: SUCCESS (0.000s)
[585.851652] [109/131] (439s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[585.954794] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[585.958838] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[586.102782] [110/131] (438s left) gem_exec_reloc (basic-write-wc-active)
[586.172945] Subtest basic-write-wc-active: SKIP (0.000s)
[586.271598] [111/131] (438s left) kms_pm_dc (dc6-psr)
[587.374553] Starting subtest: dc6-psr
[590.256504] Subtest dc6-psr: SUCCESS (2.880s)
[591.134054] [112/131] (433s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[591.235162] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[591.237342] Starting dynamic subtest: pipe-A
[591.273234] Dynamic subtest pipe-A: SKIP (0.034s)
[591.282481] Starting dynamic subtest: pipe-B
[591.309987] Dynamic subtest pipe-B: SKIP (0.034s)
[591.319294] Starting dynamic subtest: pipe-C
[591.343736] Dynamic subtest pipe-C: SKIP (0.033s)
[591.353665] Starting dynamic subtest: pipe-D
[591.377524] Dynamic subtest pipe-D: SKIP (0.033s)
[591.381760] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.139s)
[591.527912] [113/131] (433s left) prime_mmap (test_refcounting)
[591.586269] Starting subtest: test_refcounting
[591.588144] Starting dynamic subtest: test_refcounting-smem
[591.615024] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s)
[591.617427] Subtest test_refcounting: SUCCESS (0.032s)
[591.744412] [114/131] (433s left) prime_vgem (basic-fence-flip)
[591.815786] Starting subtest: basic-fence-flip
[592.118727] Subtest basic-fence-flip: SUCCESS (0.303s)
[592.262581] [115/131] (432s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[592.360691] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[592.364829] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[592.497285] [116/131] (432s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[592.593279] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[592.597612] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[592.723481] [117/131] (432s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[592.781977] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[592.783957] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[592.900020] [118/131] (432s left) gem_userptr_blits (vma-merge)
[592.975775] Starting subtest: vma-merge
[593.016177] Subtest vma-merge: SUCCESS (0.040s)
[593.177996] [119/131] (432s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[593.283508] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[593.287064] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[593.406018] [120/131] (432s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[593.503227] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[593.506751] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[593.645864] [121/131] (431s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[593.735181] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[593.737067] Starting dynamic subtest: pipe-A-default-mode
[596.436412] Dynamic subtest pipe-A-default-mode: SUCCESS (2.701s)
[596.438830] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.702s)
[597.339405] [122/131] (428s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[597.397840] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[597.506211] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[597.607985] [123/131] (427s left) gem_lmem_swapping (verify)
[597.654410] Subtest verify: SKIP (0.000s)
[597.704859] [124/131] (427s left) kms_chamelium_frames (dp-frame-dump)
[598.096236] Subtest dp-frame-dump: SKIP (0.000s)
[598.915454] [125/131] (426s left) syncobj_timeline (wait-all-interrupted)
[598.967294] Starting subtest: wait-all-interrupted
[599.073806] Subtest wait-all-interrupted: SUCCESS (0.106s)
[599.174496] [126/131] (426s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[599.281671] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[606.629525] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.350s)
[606.802231] [127/131] (418s left) api_intel_allocator (open-vm)
[606.866261] Starting subtest: open-vm
[606.868646] Subtest open-vm: SUCCESS (0.003s)
[607.041638] [128/131] (418s left) gem_exec_balancer (semaphore)
[607.100437] Starting subtest: semaphore
[608.899789] Subtest semaphore: SUCCESS (1.797s)
[609.247446] [129/131] (416s left) prime_vgem (basic-fence-mmap)
[609.315740] Starting subtest: basic-fence-mmap
[609.320081] Subtest basic-fence-mmap: SKIP (0.000s)
[609.450966] [130/131] (416s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[614.430350] Starting subtest: psr2-overlay-plane-move-continuous-sf
[614.432278] Starting dynamic subtest: pipe-A-eDP-1
[621.139870] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.708s)
[621.150598] Starting dynamic subtest: pipe-B-eDP-1
[627.869668] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.727s)
[627.871979] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.440s)
[628.768779] [131/131] (397s left) kms_lease (lease-again)
[628.873977] Starting subtest: lease-again
[628.876290] Starting dynamic subtest: pipe-A-eDP-1
[628.878449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[628.888264] Starting dynamic subtest: pipe-B-eDP-1
[628.890389] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[628.899609] Starting dynamic subtest: pipe-C-eDP-1
[628.901800] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[628.911073] Starting dynamic subtest: pipe-D-eDP-1
[628.913196] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[628.915322] Subtest lease-again: SUCCESS (0.013s)
[629.026853] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: kms_color
results: parsing output: 2/ for test: kms_draw_crc
results: parsing output: 3/ for test: kms_dp_aux_dev
results: parsing output: 4/ for test: gem_eio
results: parsing output: 5/ for test: gem_ctx_sseu
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: i915_pm_freq_mult
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: gem_fence_thrash
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_invalid_mode
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: gem_ctx_param
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_eventfd
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: kms_busy
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_mmap
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_vrr
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_ctx_param
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: fbdev
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: gem_exec_create
results: parsing output: 59/ for test: perf_pmu
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: gem_fenced_exec_thrash
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: core_setmaster
results: parsing output: 65/ for test: kms_color
results: parsing output: 66/ for test: kms_selftest
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: sw_sync
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gem_mmap_wc
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: gem_spin_batch
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: i915_hangman
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_vrr
results: parsing output: 88/ for test: kms_atomic
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: gem_mmap_offset
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: kms_pipe_b_c_ivb
results: parsing output: 98/ for test: gem_eio
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: kms_plane_alpha_blend
results: parsing output: 103/ for test: prime_vgem
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: gen9_exec_parse
results: parsing output: 106/ for test: kms_addfb_basic
results: parsing output: 107/ for test: gem_ctx_create
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_pm_dc
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: prime_mmap
results: parsing output: 113/ for test: prime_vgem
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_lmem_swapping
results: parsing output: 123/ for test: kms_chamelium_frames
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_lease
Done.