[61.851129] Initializing watchdogs
[61.851174]   /dev/watchdog0
[61.865463] [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]
[61.869665] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.872025] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.875614] [001/132] (960s left) i915_hangman (gt-engine-hang)
[61.956841] Starting subtest: gt-engine-hang
[61.958887] Starting dynamic subtest: rcs0
[63.862583] Dynamic subtest rcs0: SUCCESS (1.905s)
[63.872774] Starting dynamic subtest: bcs0
[65.908468] Dynamic subtest bcs0: SUCCESS (2.045s)
[65.920566] Starting dynamic subtest: vcs0
[67.892681] Dynamic subtest vcs0: SUCCESS (1.983s)
[67.904379] Starting dynamic subtest: vcs1
[69.876734] Dynamic subtest vcs1: SUCCESS (1.983s)
[69.888939] Starting dynamic subtest: vecs0
[71.862026] Dynamic subtest vecs0: SUCCESS (1.984s)
[71.871567] Starting dynamic subtest: ccs0
[73.908861] Dynamic subtest ccs0: SUCCESS (2.046s)
[73.911781] Subtest gt-engine-hang: SUCCESS (11.953s)
[74.027477] [002/132] (948s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[74.129486] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[75.174478] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.045s)
[75.291045] [003/132] (947s left) kms_draw_crc (draw-method-mmap-cpu)
[75.383576] Starting subtest: draw-method-mmap-cpu
[75.385709] Starting dynamic subtest: xrgb8888-untiled
[75.614380] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[75.621725] Starting dynamic subtest: rgb565-untiled
[75.825447] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[75.832075] Starting dynamic subtest: xrgb2101010-untiled
[76.037100] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[76.046087] Starting dynamic subtest: xbgr16161616f-untiled
[76.270249] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[76.276649] Starting dynamic subtest: xrgb8888-xtiled
[76.405948] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[76.414849] Starting dynamic subtest: rgb565-xtiled
[76.525671] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[76.533842] Starting dynamic subtest: xrgb2101010-xtiled
[76.637101] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[76.645081] Starting dynamic subtest: xbgr16161616f-xtiled
[76.758864] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[76.766244] Starting dynamic subtest: xrgb8888-4tiled
[76.892606] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[76.901890] Starting dynamic subtest: rgb565-4tiled
[77.025653] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[77.033697] Starting dynamic subtest: xrgb2101010-4tiled
[77.158991] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[77.167064] Starting dynamic subtest: xbgr16161616f-4tiled
[77.304325] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[77.306481] Subtest draw-method-mmap-cpu: SUCCESS (1.922s)
[77.404781] [004/132] (945s left) gem_create (create-invalid-size)
[77.457046] Starting subtest: create-invalid-size
[77.458903] Subtest create-invalid-size: SUCCESS (0.000s)
[77.639100] [005/132] (944s left) kms_hdr (static-toggle-suspend)
[77.722687] Starting subtest: static-toggle-suspend
[77.729184] Subtest static-toggle-suspend: SKIP (0.000s)
[77.801720] [006/132] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[77.896642] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[77.901146] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[78.000015] [007/132] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[78.095264] Starting subtest: fbcpsr-2p-rte
[78.099258] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[78.218029] [008/132] (944s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[78.344741] Starting subtest: cursorA-vs-flipA-toggle
[89.498845] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.152s)
[90.295139] [009/132] (932s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[90.366815] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[90.431374] [010/132] (932s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[90.487973] Starting subtest: etime-single-wait-available-unsubmitted
[90.594073] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[90.678594] [011/132] (932s left) gem_blits (basic)
[90.742215] Starting subtest: basic
[92.092029] Subtest basic: SUCCESS (1.350s)
[92.193543] [012/132] (930s left) kms_chamelium_frames (hdmi-aspect-ratio)
[92.581900] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[93.398916] [013/132] (929s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[93.500337] Starting subtest: fbc-psr2-sprite-plane-onoff
[93.502313] Starting dynamic subtest: eDP-1
[93.506490] Dynamic subtest eDP-1: SKIP (0.000s)
[93.510607] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[93.570738] [014/132] (929s left) kms_atomic_transition (modeset-transition)
[93.659599] Starting subtest: modeset-transition
[93.661610] Starting dynamic subtest: 1x-outputs
[104.455412] Dynamic subtest 1x-outputs: SUCCESS (10.797s)
[104.457817] Subtest modeset-transition: SUCCESS (10.798s)
[105.323999] [015/132] (917s left) gem_eio (in-flight-10ms)
[105.557234] Starting subtest: in-flight-10ms
[113.627701] Subtest in-flight-10ms: SUCCESS (8.071s)
[113.752629] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[113.756506] [016/132] (909s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[113.858577] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[113.862585] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[113.992548] [017/132] (909s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[114.100448] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[121.476015] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.379s)
[121.612692] [018/132] (901s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[121.765643] Starting subtest: cursor-rapid-movement-32x10
[121.814409] Subtest cursor-rapid-movement-32x10: SKIP (0.044s)
[122.087937] [019/132] (901s left) kms_flip (flip-vs-wf_vblank-interruptible)
[122.181033] Starting subtest: flip-vs-wf_vblank-interruptible
[122.183357] Starting dynamic subtest: A-eDP1
[124.097500] Dynamic subtest A-eDP1: SUCCESS (1.915s)
[124.105763] Starting dynamic subtest: B-eDP1
[126.032059] Dynamic subtest B-eDP1: SUCCESS (1.933s)
[126.042078] Starting dynamic subtest: C-eDP1
[127.948539] Dynamic subtest C-eDP1: SUCCESS (1.916s)
[127.956931] Starting dynamic subtest: D-eDP1
[129.800131] Dynamic subtest D-eDP1: SUCCESS (1.851s)
[129.802402] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.622s)
[131.046728] [020/132] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[131.151693] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[131.156167] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[131.259755] [021/132] (891s left) kms_setmode (invalid-clone-single-crtc)
[131.320238] Starting subtest: invalid-clone-single-crtc
[131.326556] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[131.430998] [022/132] (891s left) gem_render_copy (linear-to-vebox-yf-tiled)
[131.493703] Starting subtest: linear-to-vebox-yf-tiled
[131.498325] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[131.689216] [023/132] (891s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[131.780374] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[131.782791] Starting dynamic subtest: pipe-A
[131.800418] Dynamic subtest pipe-A: SKIP (0.017s)
[131.808851] Starting dynamic subtest: pipe-B
[131.830333] Dynamic subtest pipe-B: SKIP (0.030s)
[131.837971] Starting dynamic subtest: pipe-C
[131.861097] Dynamic subtest pipe-C: SKIP (0.030s)
[131.868363] Starting dynamic subtest: pipe-D
[131.889261] Dynamic subtest pipe-D: SKIP (0.030s)
[131.893480] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.107s)
[132.009147] [024/132] (891s left) kms_cursor_legacy (torture-move)
[132.126548] Starting subtest: torture-move
[132.128763] Starting dynamic subtest: pipe-A
[138.405772] Dynamic subtest pipe-A: SUCCESS (6.277s)
[138.415466] Starting dynamic subtest: pipe-B
[144.778784] Dynamic subtest pipe-B: SUCCESS (6.371s)
[144.791168] Starting dynamic subtest: pipe-C
[151.592603] Dynamic subtest pipe-C: SUCCESS (6.812s)
[151.603058] Starting dynamic subtest: pipe-D
[157.291793] Dynamic subtest pipe-D: SUCCESS (5.699s)
[157.301986] Starting dynamic subtest: all-pipes
[164.747930] Dynamic subtest all-pipes: SUCCESS (7.448s)
[164.750908] Subtest torture-move: SUCCESS (32.614s)
[164.899033] [025/132] (858s left) syncobj_eventfd (binary-wait)
[164.954170] Starting subtest: binary-wait
[164.962830] Subtest binary-wait: SUCCESS (0.010s)
[165.033789] [026/132] (858s left) gem_exec_store (cachelines)
[165.096949] Starting subtest: cachelines
[165.099289] Starting dynamic subtest: rcs0
[165.160513] Dynamic subtest rcs0: SUCCESS (0.066s)
[165.171047] Starting dynamic subtest: bcs0
[165.214659] Dynamic subtest bcs0: SUCCESS (0.053s)
[165.225060] Starting dynamic subtest: vcs0
[165.267479] Dynamic subtest vcs0: SUCCESS (0.051s)
[165.276970] Starting dynamic subtest: vcs1
[165.324202] Dynamic subtest vcs1: SUCCESS (0.056s)
[165.333798] Starting dynamic subtest: vecs0
[165.377153] Dynamic subtest vecs0: SUCCESS (0.052s)
[165.386638] Starting dynamic subtest: ccs0
[165.428237] Dynamic subtest ccs0: SUCCESS (0.050s)
[165.430752] Subtest cachelines: SUCCESS (0.335s)
[165.612534] [027/132] (857s left) kms_cursor_crc (cursor-onscreen-128x42)
[165.861940] Starting subtest: cursor-onscreen-128x42
[165.916316] Subtest cursor-onscreen-128x42: SKIP (0.048s)
[166.124961] [028/132] (857s left) kms_plane_cursor (primary)
[166.217885] Starting subtest: primary
[166.222042] Starting dynamic subtest: pipe-A-eDP-1-size-64
[168.838105] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.622s)
[168.861335] Starting dynamic subtest: pipe-A-eDP-1-size-128
[171.438470] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[171.462034] Starting dynamic subtest: pipe-A-eDP-1-size-256
[174.005985] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[174.321073] Starting dynamic subtest: pipe-B-eDP-1-size-64
[177.692049] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.378s)
[177.715094] Starting dynamic subtest: pipe-B-eDP-1-size-128
[180.282014] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s)
[180.304785] Starting dynamic subtest: pipe-B-eDP-1-size-256
[182.926227] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.627s)
[183.247935] Starting dynamic subtest: pipe-C-eDP-1-size-64
[186.227246] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.988s)
[186.259598] Starting dynamic subtest: pipe-C-eDP-1-size-128
[188.615235] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.368s)
[188.640880] Starting dynamic subtest: pipe-C-eDP-1-size-256
[190.893354] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.258s)
[191.214817] Starting dynamic subtest: pipe-D-eDP-1-size-64
[194.110318] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.903s)
[194.135278] Starting dynamic subtest: pipe-D-eDP-1-size-128
[196.354346] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s)
[196.379111] Starting dynamic subtest: pipe-D-eDP-1-size-256
[198.621172] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.247s)
[198.930395] Subtest primary: SUCCESS (32.710s)
[199.755275] [029/132] (823s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[199.858333] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[203.949067] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.093s)
[205.144589] [030/132] (818s left) kms_busy (extended-modeset-hang-newfb)
[205.236446] Starting subtest: extended-modeset-hang-newfb
[205.238742] Starting dynamic subtest: pipe-A
[240.800248] Dynamic subtest pipe-A: SUCCESS (35.563s)
[240.808449] Starting dynamic subtest: pipe-D
[263.822093] Dynamic subtest pipe-D: SUCCESS (23.017s)
[263.824444] Subtest extended-modeset-hang-newfb: SUCCESS (58.585s)
[264.617525] [031/132] (758s left) gem_sync (basic-store-all)
[264.693953] Starting subtest: basic-store-all
[268.964165] Subtest basic-store-all: SUCCESS (4.280s)
[269.154867] [032/132] (754s left) kms_addfb_basic (size-max)
[269.250885] Starting subtest: size-max
[269.253184] Subtest size-max: SUCCESS (0.000s)
[269.350906] [033/132] (754s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[269.447332] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[269.450079] Starting dynamic subtest: pipe-A-eDP-1
[269.533704] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[269.542748] Starting dynamic subtest: pipe-B-eDP-1
[270.707402] Dynamic subtest pipe-B-eDP-1: SKIP (1.160s)
[270.711735] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.251s)
[271.894029] [034/132] (751s left) gem_ctx_bad_destroy (invalid-pad)
[271.944908] Starting subtest: invalid-pad
[271.947390] Subtest invalid-pad: SUCCESS (0.000s)
[272.031375] [035/132] (751s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[272.292856] Starting subtest: parallel-dmabuf-import-out-fence
[273.429498] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.137s)
[273.516868] [036/132] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[273.617044] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[273.621340] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[273.713892] [037/132] (750s left) kms_plane_alpha_blend (constant-alpha-max)
[273.820431] Starting subtest: constant-alpha-max
[274.108721] Starting dynamic subtest: pipe-A-eDP-1
[275.156471] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.045s)
[275.164758] Starting dynamic subtest: pipe-D-eDP-1
[276.813820] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.657s)
[276.816258] Subtest constant-alpha-max: SUCCESS (2.995s)
[277.638470] [038/132] (746s left) kms_prime (basic-modeset-hybrid)
[277.725993] Subtest basic-modeset-hybrid: SKIP (0.000s)
[277.833182] [039/132] (746s left) api_intel_bb (delta-check)
[277.895372] Starting subtest: delta-check
[277.899994] Subtest delta-check: SUCCESS (0.006s)
[278.021778] [040/132] (745s left) kms_flip (dpms-vs-vblank-race-interruptible)
[278.117218] Starting subtest: dpms-vs-vblank-race-interruptible
[278.119533] Starting dynamic subtest: A-eDP1
[283.028438] Dynamic subtest A-eDP1: SUCCESS (4.908s)
[283.036762] Starting dynamic subtest: B-eDP1
[286.535280] Dynamic subtest B-eDP1: SUCCESS (3.504s)
[286.546298] Starting dynamic subtest: C-eDP1
[291.140941] Dynamic subtest C-eDP1: SUCCESS (4.603s)
[291.149837] Starting dynamic subtest: D-eDP1
[295.780308] Dynamic subtest D-eDP1: SUCCESS (4.640s)
[295.785744] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.666s)
[296.643998] [041/132] (727s left) gem_userptr_blits (readonly-pwrite-unsync)
[296.705350] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[296.819117] [042/132] (727s left) kms_plane_scaling (2x-scaler-multi-pipe)
[296.903122] Starting subtest: 2x-scaler-multi-pipe
[296.907610] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[297.012802] [043/132] (727s left) gem_ctx_persistence (many-contexts)
[297.056723] Starting subtest: many-contexts
[342.230202] Subtest many-contexts: SUCCESS (45.171s)
[342.333257] [044/132] (681s left) i915_drm_fdinfo (basics)
[342.369962] Starting subtest: basics
[342.372310] Subtest basics: SUCCESS (0.000s)
[342.445520] [045/132] (681s left) api_intel_allocator (simple-allocator)
[342.498038] Starting subtest: simple-allocator
[342.499980] Starting dynamic subtest: basic
[342.502636] Dynamic subtest basic: SUCCESS (0.005s)
[342.519014] Starting dynamic subtest: parallel-one
[342.690664] Dynamic subtest parallel-one: SUCCESS (0.188s)
[342.700077] Starting dynamic subtest: print
[342.702232] Dynamic subtest print: SUCCESS (0.000s)
[342.713614] Starting dynamic subtest: reuse
[342.715819] Dynamic subtest reuse: SUCCESS (0.000s)
[342.726297] Starting dynamic subtest: reserve
[342.728566] Dynamic subtest reserve: SUCCESS (0.000s)
[342.736261] Starting dynamic subtest: fork-reopen-allocator
[342.738523] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[342.740766] Subtest simple-allocator: SUCCESS (0.212s)
[342.849113] [046/132] (681s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[342.941409] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[342.945769] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[343.042567] [047/132] (681s left) dumb_buffer (create-valid-dumb)
[343.104493] Starting subtest: create-valid-dumb
[343.106601] Subtest create-valid-dumb: SUCCESS (0.000s)
[343.208681] [048/132] (681s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[343.308102] Starting subtest: async-flip-with-page-flip-events-tiled
[343.687710] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[346.414203] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.725s)
[346.422423] Starting dynamic subtest: pipe-A-eDP-1-4
[348.589029] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[348.597025] Starting dynamic subtest: pipe-A-eDP-1-4
[350.599161] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[350.607497] Starting dynamic subtest: pipe-A-eDP-1-x
[352.789432] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[353.179098] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[355.942691] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[355.952177] Starting dynamic subtest: pipe-B-eDP-1-4
[358.129407] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[358.140271] Starting dynamic subtest: pipe-B-eDP-1-4
[360.139290] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[360.149848] Starting dynamic subtest: pipe-B-eDP-1-x
[362.328823] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[362.704937] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[365.482382] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.783s)
[365.492397] Starting dynamic subtest: pipe-C-eDP-1-4
[367.646017] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[367.654156] Starting dynamic subtest: pipe-C-eDP-1-4
[369.656539] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[369.664757] Starting dynamic subtest: pipe-C-eDP-1-x
[371.824453] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s)
[372.184675] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[374.919349] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.740s)
[374.928054] Starting dynamic subtest: pipe-D-eDP-1-4
[377.094499] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[377.103088] Starting dynamic subtest: pipe-D-eDP-1-4
[379.105041] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[379.116032] Starting dynamic subtest: pipe-D-eDP-1-x
[381.283062] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[381.285419] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (37.975s)
[382.509214] [049/132] (641s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[382.604548] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[389.403090] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.801s)
[389.549065] [050/132] (634s left) kms_cdclk (mode-transition-all-outputs)
[389.648867] Starting subtest: mode-transition-all-outputs
[389.937267] Subtest mode-transition-all-outputs: SKIP (0.287s)
[390.752479] [051/132] (633s left) gem_exec_schedule (noreorder)
[390.926880] Starting subtest: noreorder
[390.929631] Starting dynamic subtest: rcs0
[390.974929] Dynamic subtest rcs0: SUCCESS (0.049s)
[390.985571] Starting dynamic subtest: vcs0
[392.908892] Dynamic subtest vcs0: SUCCESS (1.931s)
[392.918962] Starting dynamic subtest: vcs1
[394.899571] Dynamic subtest vcs1: SUCCESS (1.988s)
[394.910690] Starting dynamic subtest: vecs0
[396.861347] Dynamic subtest vecs0: SUCCESS (1.959s)
[396.872624] Starting dynamic subtest: ccs0
[396.933201] Dynamic subtest ccs0: SUCCESS (0.071s)
[396.936060] Subtest noreorder: SUCCESS (6.008s)
[397.117750] [052/132] (627s left) gem_mmap_gtt (bad-object)
[397.185927] Subtest bad-object: SKIP (0.000s)
[397.248700] [053/132] (627s left) gem_pwrite (basic-random)
[397.300037] Subtest basic-random: SKIP (0.000s)
[397.355777] [054/132] (627s left) kms_psr (psr2-cursor-plane-onoff)
[397.450769] Starting subtest: psr2-cursor-plane-onoff
[397.453424] Starting dynamic subtest: eDP-1
[399.134872] Dynamic subtest eDP-1: SUCCESS (1.684s)
[399.137123] Subtest psr2-cursor-plane-onoff: SUCCESS (1.685s)
[399.935445] [055/132] (624s left) syncobj_wait (wait-any-complex)
[399.997569] Starting subtest: wait-any-complex
[400.058412] Subtest wait-any-complex: SUCCESS (0.062s)
[400.134586] [056/132] (624s left) gem_exec_async (forked-writes)
[400.191229] Starting subtest: forked-writes
[400.193108] Starting dynamic subtest: rcs0
[400.215271] Dynamic subtest rcs0: SUCCESS (0.025s)
[400.225667] Starting dynamic subtest: bcs0
[400.240378] Dynamic subtest bcs0: SUCCESS (0.023s)
[400.248858] Starting dynamic subtest: vcs0
[400.263430] Dynamic subtest vcs0: SUCCESS (0.022s)
[400.274948] Starting dynamic subtest: vcs1
[400.285969] Dynamic subtest vcs1: SUCCESS (0.022s)
[400.294017] Starting dynamic subtest: vecs0
[400.309396] Dynamic subtest vecs0: SUCCESS (0.022s)
[400.317469] Starting dynamic subtest: ccs0
[400.332654] Dynamic subtest ccs0: SUCCESS (0.022s)
[400.334845] Subtest forked-writes: SUCCESS (0.144s)
[400.570564] [057/132] (624s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[400.677702] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[401.490388] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.814s)
[401.652196] [058/132] (623s left) kms_flip (basic-flip-vs-dpms)
[401.749443] Starting subtest: basic-flip-vs-dpms
[401.751723] Starting dynamic subtest: A-eDP1
[404.336645] Dynamic subtest A-eDP1: SUCCESS (2.583s)
[404.344826] Starting dynamic subtest: B-eDP1
[406.533650] Dynamic subtest B-eDP1: SUCCESS (2.194s)
[406.542692] Starting dynamic subtest: C-eDP1
[408.685999] Dynamic subtest C-eDP1: SUCCESS (2.152s)
[408.695300] Starting dynamic subtest: D-eDP1
[410.784390] Dynamic subtest D-eDP1: SUCCESS (2.095s)
[410.786663] Subtest basic-flip-vs-dpms: SUCCESS (9.037s)
[411.581927] [059/132] (613s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[411.697931] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[413.148784] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.451s)
[413.951976] [060/132] (610s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[414.044298] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[414.048811] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[414.157264] [061/132] (610s left) gen9_exec_parse (bb-large)
[414.212801] Subtest bb-large: SKIP (0.000s)
[414.291710] [062/132] (610s left) gem_mmap_gtt (fault-concurrent)
[414.338149] Subtest fault-concurrent: SKIP (0.000s)
[414.396961] [063/132] (610s left) kms_content_protection (uevent)
[414.537499] Starting subtest: uevent
[414.542017] Subtest uevent: SKIP (0.000s)
[414.666645] [064/132] (610s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[414.763452] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[414.765614] Starting dynamic subtest: pipe-A-eDP-1
[415.026231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.238s)
[415.035197] Starting dynamic subtest: pipe-B-eDP-1
[416.328440] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.296s)
[416.337975] Starting dynamic subtest: pipe-C-eDP-1
[417.614268] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.285s)
[417.624067] Starting dynamic subtest: pipe-D-eDP-1
[418.834600] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[418.836534] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.044s)
[419.958396] [065/132] (605s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[420.062920] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[420.921337] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.859s)
[421.079646] [066/132] (603s left) kms_rotation_crc (primary-rotation-180)
[421.173648] Starting subtest: primary-rotation-180
[428.174042] Subtest primary-rotation-180: SUCCESS (7.001s)
[429.358437] [067/132] (595s left) gem_exec_params (larger-than-life-batch)
[429.416938] Starting subtest: larger-than-life-batch
[431.821104] Subtest larger-than-life-batch: SUCCESS (2.404s)
[432.966387] [068/132] (592s left) kms_color (legacy-gamma-reset)
[433.105259] Starting subtest: legacy-gamma-reset
[433.107087] Starting dynamic subtest: pipe-A-eDP-1
[433.478383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.374s)
[433.487056] Starting dynamic subtest: pipe-B-eDP-1
[433.492251] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[433.502971] Starting dynamic subtest: pipe-C-eDP-1
[433.505147] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[433.513198] Starting dynamic subtest: pipe-D-eDP-1
[433.517851] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[433.520119] Subtest legacy-gamma-reset: SUCCESS (0.412s)
[434.357725] [069/132] (590s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[434.737695] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[435.567535] [070/132] (589s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[435.671680] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[435.676271] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[435.789785] [071/132] (589s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[435.899608] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[443.143262] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.246s)
[443.267666] [072/132] (582s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[443.361094] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[443.365053] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[443.453931] [073/132] (581s left) gem_exec_params (invalid-bsd2-flag-on-render)
[443.508799] Starting subtest: invalid-bsd2-flag-on-render
[443.511070] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[443.605721] [074/132] (581s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[443.697161] Starting subtest: fbc-psr2-primary-mmap-cpu
[443.698988] Starting dynamic subtest: eDP-1
[443.703063] Dynamic subtest eDP-1: SKIP (0.000s)
[443.706975] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[443.783345] [075/132] (581s left) syncobj_timeline (multi-wait-signaled)
[443.844790] Starting subtest: multi-wait-signaled
[443.847153] Subtest multi-wait-signaled: SUCCESS (0.001s)
[443.940841] [076/132] (581s left) kms_lease (invalid-create-leases)
[444.038216] Starting subtest: invalid-create-leases
[444.042891] Subtest invalid-create-leases: SUCCESS (0.005s)
[444.152891] [077/132] (581s left) gem_wait (write-wait)
[444.208912] Starting subtest: write-wait
[444.210891] Starting dynamic subtest: all-engines
[445.349565] Dynamic subtest all-engines: SUCCESS (1.139s)
[445.372219] Starting dynamic subtest: rcs0
[446.425385] Dynamic subtest rcs0: SUCCESS (1.073s)
[446.438842] Starting dynamic subtest: bcs0
[447.484187] Dynamic subtest bcs0: SUCCESS (1.056s)
[447.499605] Starting dynamic subtest: vcs0
[448.541377] Dynamic subtest vcs0: SUCCESS (1.055s)
[448.557474] Starting dynamic subtest: vcs1
[449.594315] Dynamic subtest vcs1: SUCCESS (1.051s)
[449.610437] Starting dynamic subtest: vecs0
[450.648253] Dynamic subtest vecs0: SUCCESS (1.052s)
[450.664248] Starting dynamic subtest: ccs0
[451.704319] Dynamic subtest ccs0: SUCCESS (1.055s)
[451.706826] Subtest write-wait: SUCCESS (7.496s)
[451.906030] [078/132] (573s left) syncobj_wait (wait-all-for-submit-complex)
[451.964087] Starting subtest: wait-all-for-submit-complex
[452.177969] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[452.271397] [079/132] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[452.370758] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[456.687425] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.320s)
[457.832927] [080/132] (567s left) perf_pmu (init-wait)
[457.884399] Starting subtest: init-wait
[457.886676] Starting dynamic subtest: rcs0
[457.888987] Dynamic subtest rcs0: SUCCESS (0.001s)
[457.898209] Starting dynamic subtest: bcs0
[457.900093] Dynamic subtest bcs0: SUCCESS (0.000s)
[457.908115] Starting dynamic subtest: vcs0
[457.909986] Dynamic subtest vcs0: SUCCESS (0.001s)
[457.918061] Starting dynamic subtest: vcs1
[457.920072] Dynamic subtest vcs1: SUCCESS (0.001s)
[457.930391] Starting dynamic subtest: vecs0
[457.932373] Dynamic subtest vecs0: SUCCESS (0.001s)
[457.939974] Starting dynamic subtest: ccs0
[457.941940] Dynamic subtest ccs0: SUCCESS (0.000s)
[457.944322] Subtest init-wait: SUCCESS (0.008s)
[458.004285] [081/132] (567s left) kms_psr (psr-primary-render)
[458.099207] Starting subtest: psr-primary-render
[458.101537] Starting dynamic subtest: eDP-1
[459.825408] Dynamic subtest eDP-1: SUCCESS (1.725s)
[459.827725] Subtest psr-primary-render: SUCCESS (1.726s)
[460.678824] [082/132] (565s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[460.779871] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[460.784292] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[460.864509] [083/132] (564s left) syncobj_timeline (invalid-query-bad-pad)
[460.931584] Starting subtest: invalid-query-bad-pad
[460.933516] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[461.036890] [084/132] (564s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[461.134662] Starting subtest: yf-tiled-64bpp-rotate-90
[461.139024] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[461.217202] [085/132] (564s left) sw_sync (sync_multi_consumer_producer)
[461.252242] Starting subtest: sync_multi_consumer_producer
[461.581671] Subtest sync_multi_consumer_producer: SUCCESS (0.329s)
[461.648937] [086/132] (564s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[461.745679] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[468.714438] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.971s)
[468.837492] [087/132] (557s left) gem_exec_fence (keep-in-fence)
[469.017527] Starting subtest: keep-in-fence
[469.019823] Starting dynamic subtest: rcs0
[469.070299] Dynamic subtest rcs0: SUCCESS (0.053s)
[469.084031] Starting dynamic subtest: bcs0
[469.125055] Dynamic subtest bcs0: SUCCESS (0.052s)
[469.135997] Starting dynamic subtest: vcs0
[470.933863] Dynamic subtest vcs0: SUCCESS (1.805s)
[470.945813] Starting dynamic subtest: vcs1
[472.917227] Dynamic subtest vcs1: SUCCESS (1.980s)
[472.930296] Starting dynamic subtest: vecs0
[474.902823] Dynamic subtest vecs0: SUCCESS (1.982s)
[474.914867] Starting dynamic subtest: ccs0
[475.143628] Dynamic subtest ccs0: SUCCESS (0.238s)
[475.146348] Subtest keep-in-fence: SUCCESS (6.127s)
[476.938496] [088/132] (549s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[477.047306] Starting subtest: primary-y-tiled-reflect-x-0
[477.109051] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[477.214199] [089/132] (548s left) gem_mmap_offset (bad-extensions)
[477.276608] Starting subtest: bad-extensions
[477.278568] Subtest bad-extensions: SUCCESS (0.000s)
[477.385366] [090/132] (548s left) gem_workarounds (suspend-resume-fd)
[477.449399] Starting subtest: suspend-resume-fd
[493.580457] Subtest suspend-resume-fd: SUCCESS (2.023s)
[493.725809] [091/132] (532s left) prime_vgem (shrink)
[493.806950] Starting subtest: shrink
[493.818895] Subtest shrink: SUCCESS (0.012s)
[493.923202] [092/132] (532s left) vgem_basic (debugfs)
[493.978873] Starting subtest: debugfs
[493.981137] Subtest debugfs: SUCCESS (0.000s)
[494.034169] [093/132] (532s left) kms_vrr (seamless-rr-switch-vrr)
[494.134270] Starting subtest: seamless-rr-switch-vrr
[494.140296] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[494.221624] [094/132] (531s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[494.325642] Starting subtest: fbc-pr-cursor-plane-update-sf
[494.330054] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[494.404357] [095/132] (531s left) i915_query (engine-info-invalid)
[494.462239] Starting subtest: engine-info-invalid
[494.464453] Subtest engine-info-invalid: SUCCESS (0.000s)
[494.560491] [096/132] (531s left) gem_exec_balancer (invalid-balancer)
[494.623691] Starting subtest: invalid-balancer
[495.495172] Subtest invalid-balancer: SUCCESS (0.871s)
[495.786942] [097/132] (530s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[495.878069] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[495.880394] Starting dynamic subtest: pipe-A-eDP-1
[496.310309] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[496.321934] Starting dynamic subtest: pipe-B-eDP-1
[496.342130] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[496.351789] Starting dynamic subtest: pipe-C-eDP-1
[496.370609] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[496.378959] Starting dynamic subtest: pipe-D-eDP-1
[496.398040] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[496.399949] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.447s)
[498.614853] [098/132] (527s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[498.724320] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[499.348716] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[499.521370] [099/132] (526s left) i915_pm_rps (reset)
[499.583401] Starting subtest: reset
[508.010008] Subtest reset: SUCCESS (8.423s)
[508.128909] [100/132] (518s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[508.234943] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[508.237188] Starting dynamic subtest: pipe-A-eDP-1
[509.121627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.880s)
[509.131070] Starting dynamic subtest: pipe-B-eDP-1
[510.768305] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.644s)
[510.778154] Starting dynamic subtest: pipe-C-eDP-1
[512.260897] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.491s)
[512.271146] Starting dynamic subtest: pipe-D-eDP-1
[513.760869] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.495s)
[513.763140] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.515s)
[514.947793] [101/132] (511s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[515.045157] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[515.049443] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[515.164136] [102/132] (511s left) gem_tiling_max_stride
[515.284762] [103/132] (511s left) syncobj_wait (invalid-reset-bad-pad)
[515.333440] Starting subtest: invalid-reset-bad-pad
[515.335563] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[515.431647] [104/132] (511s left) vgem_basic (second-client)
[515.471754] Starting subtest: second-client
[515.493962] Subtest second-client: SUCCESS (0.022s)
[515.551046] [105/132] (511s left) kms_psr (pr-cursor-mmap-gtt)
[515.653883] Starting subtest: pr-cursor-mmap-gtt
[515.658179] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[515.729161] [106/132] (510s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[515.849278] Starting subtest: plane-primary-toggle-with-vblank-wait
[515.851500] Starting dynamic subtest: pipe-A-eDP-1
[516.023137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[516.334074] Starting dynamic subtest: pipe-B-eDP-1
[517.245249] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.921s)
[517.548971] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.699s)
[518.409723] [107/132] (508s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[518.501789] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[518.504012] Starting dynamic subtest: pipe-A
[518.852251] Dynamic subtest pipe-A: SUCCESS (0.352s)
[518.862634] Starting dynamic subtest: pipe-B
[520.323947] Dynamic subtest pipe-B: SUCCESS (1.471s)
[520.336635] Starting dynamic subtest: pipe-C
[521.741811] Dynamic subtest pipe-C: SUCCESS (1.416s)
[521.756890] Starting dynamic subtest: pipe-D
[523.157158] Dynamic subtest pipe-D: SUCCESS (1.415s)
[523.159560] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.657s)
[524.335109] [108/132] (502s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[524.440056] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[531.044316] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.604s)
[531.181999] [109/132] (495s left) kms_flip (absolute-wf_vblank)
[531.289579] Starting subtest: absolute-wf_vblank
[531.291849] Starting dynamic subtest: A-eDP1
[540.026074] Dynamic subtest A-eDP1: SUCCESS (8.736s)
[540.035685] Starting dynamic subtest: B-eDP1
[548.752866] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[548.762993] Starting dynamic subtest: C-eDP1
[557.476733] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[557.487192] Starting dynamic subtest: D-eDP1
[566.213525] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[566.215877] Subtest absolute-wf_vblank: SUCCESS (34.922s)
[567.435562] [110/132] (459s left) kms_force_connector_basic (force-edid)
[567.512888] Starting subtest: force-edid
[567.877391] Subtest force-edid: SUCCESS (0.367s)
[568.013307] [111/132] (458s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[568.114540] Starting subtest: y-tiled-addfb-size-offset-overflow
[568.118610] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[568.209316] [112/132] (458s left) gem_userptr_blits (create-destroy-unsync)
[568.268722] Subtest create-destroy-unsync: SKIP (0.000s)
[568.377697] [113/132] (458s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[568.468625] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[568.472040] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[568.539375] [114/132] (458s left) vgem_basic (sysfs)
[568.582466] Starting subtest: sysfs
[568.584277] Subtest sysfs: SUCCESS (0.000s)
[568.634846] [115/132] (458s left) gem_exec_schedule (submit-early-slice)
[568.703583] Starting subtest: submit-early-slice
[568.705464] Starting dynamic subtest: rcs0
[568.740799] Dynamic subtest rcs0: SUCCESS (0.042s)
[568.752047] Starting dynamic subtest: bcs0
[568.788977] Dynamic subtest bcs0: SUCCESS (0.047s)
[568.799304] Starting dynamic subtest: vcs0
[568.834801] Dynamic subtest vcs0: SUCCESS (0.045s)
[568.848350] Starting dynamic subtest: vcs1
[568.882337] Dynamic subtest vcs1: SUCCESS (0.046s)
[568.896045] Starting dynamic subtest: vecs0
[568.925458] Dynamic subtest vecs0: SUCCESS (0.042s)
[568.942603] Starting dynamic subtest: ccs0
[568.978002] Dynamic subtest ccs0: SUCCESS (0.050s)
[568.980194] Subtest submit-early-slice: SUCCESS (0.280s)
[570.113664] [116/132] (457s left) kms_cursor_crc (cursor-sliding-512x170)
[570.444014] Starting subtest: cursor-sliding-512x170
[570.448003] Subtest cursor-sliding-512x170: SKIP (0.001s)
[570.594365] [117/132] (456s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[570.653610] Starting subtest: y-tiled-to-vebox-y-tiled
[570.662532] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[570.852508] [118/132] (456s left) gem_create (create-ext-cpu-access-big)
[571.016118] Starting subtest: create-ext-cpu-access-big
[571.021561] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[571.088651] [119/132] (456s left) gem_lmem_swapping (heavy-random)
[571.138733] Subtest heavy-random: SKIP (0.000s)
[571.177864] [120/132] (456s left) gem_mmap_wc (read-write)
[571.241914] Subtest read-write: SKIP (0.000s)
[571.306497] [121/132] (456s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[571.404298] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[571.406538] Starting dynamic subtest: pipe-A-default-mode
[574.148045] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[574.150024] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.743s)
[574.948058] [122/132] (452s left) kms_vblank (query-busy)
[575.042996] Starting subtest: query-busy
[575.045360] Starting dynamic subtest: pipe-A-eDP-1
[576.936233] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.891s)
[576.950743] Starting dynamic subtest: pipe-D-eDP-1
[579.471368] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[579.473848] Subtest query-busy: SUCCESS (4.428s)
[580.344260] [123/132] (447s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[580.435203] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[580.437532] Starting dynamic subtest: pipe-A-eDP-1
[580.460784] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[580.476141] Starting dynamic subtest: pipe-B-eDP-1
[580.499723] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[580.510451] Starting dynamic subtest: pipe-C-eDP-1
[580.532349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[580.541550] Starting dynamic subtest: pipe-D-eDP-1
[580.563593] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[580.567820] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[582.649376] [124/132] (444s left) sysfs_timeslice_duration (invalid)
[582.713294] Starting subtest: invalid
[582.715637] Starting dynamic subtest: vecs0
[582.717848] Dynamic subtest vecs0: SUCCESS (0.000s)
[582.731443] Starting dynamic subtest: ccs0
[582.733740] Dynamic subtest ccs0: SUCCESS (0.000s)
[582.742140] Starting dynamic subtest: vcs0
[582.744349] Dynamic subtest vcs0: SUCCESS (0.000s)
[582.753047] Starting dynamic subtest: bcs0
[582.755191] Dynamic subtest bcs0: SUCCESS (0.000s)
[582.763749] Starting dynamic subtest: rcs0
[582.765820] Dynamic subtest rcs0: SUCCESS (0.000s)
[582.774522] Starting dynamic subtest: vcs1
[582.776670] Dynamic subtest vcs1: SUCCESS (0.000s)
[582.778720] Subtest invalid: SUCCESS (0.006s)
[582.817499] [125/132] (444s left) gem_softpin (safe-alignment)
[582.876099] Starting subtest: safe-alignment
[582.897623] Subtest safe-alignment: SUCCESS (0.021s)
[584.087270] [126/132] (443s left) kms_pm_rpm (fences)
[586.213042] Starting subtest: fences
[586.218066] Subtest fences: SKIP (0.000s)
[586.577053] [127/132] (440s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[586.672691] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[586.676959] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[586.797749] [128/132] (440s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[586.899195] Starting subtest: psr2-overlay-plane-move-continuous-sf
[586.901449] Starting dynamic subtest: pipe-A-eDP-1
[592.865424] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.971s)
[592.875475] Starting dynamic subtest: pipe-B-eDP-1
[599.515773] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.649s)
[599.518225] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.623s)
[600.343973] [129/132] (427s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[600.446356] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[600.450291] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[600.539563] [130/132] (427s left) syncobj_timeline (single-wait-signaled)
[600.602523] Starting subtest: single-wait-signaled
[600.604483] Subtest single-wait-signaled: SUCCESS (0.000s)
[600.689410] [131/132] (427s left) gem_ctx_isolation (preservation)
[600.744710] Starting subtest: preservation
[600.746920] Starting dynamic subtest: rcs0
[600.901106] Dynamic subtest rcs0: SUCCESS (0.155s)
[600.912787] Starting dynamic subtest: bcs0
[601.049049] Dynamic subtest bcs0: SUCCESS (0.148s)
[601.058938] Starting dynamic subtest: vcs0
[601.184050] Dynamic subtest vcs0: SUCCESS (0.134s)
[601.193822] Starting dynamic subtest: vcs1
[603.115891] Dynamic subtest vcs1: SUCCESS (1.930s)
[603.125862] Starting dynamic subtest: vecs0
[605.156507] Dynamic subtest vecs0: SUCCESS (2.040s)
[605.169095] Starting dynamic subtest: ccs0
[607.156972] Dynamic subtest ccs0: SUCCESS (1.999s)
[607.160608] Subtest preservation: SUCCESS (6.413s)
[607.440928] [132/132] (420s left) kms_vblank (query-forked-hang)
[607.547054] Starting subtest: query-forked-hang
[607.549000] Starting dynamic subtest: pipe-A-eDP-1
[633.768745] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.219s)
[633.783304] Starting dynamic subtest: pipe-D-eDP-1
[658.807981] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.035s)
[658.810220] Subtest query-forked-hang: SUCCESS (51.259s)
[659.641694] Closing watchdogs
results: parsing output: 0/ for test: i915_hangman
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_draw_crc
results: parsing output: 3/ for test: gem_create
results: parsing output: 4/ for test: kms_hdr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_blits
results: parsing output: 11/ for test: kms_chamelium_frames
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_atomic_transition
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: syncobj_eventfd
results: parsing output: 25/ for test: gem_exec_store
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_plane_cursor
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_busy
results: parsing output: 30/ for test: gem_sync
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: gem_ctx_bad_destroy
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_plane_alpha_blend
results: parsing output: 37/ for test: kms_prime
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: i915_drm_fdinfo
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: dumb_buffer
results: parsing output: 47/ for test: kms_async_flips
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_cdclk
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: gem_pwrite
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: gem_exec_async
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gen9_exec_parse
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: gem_exec_params
results: parsing output: 67/ for test: kms_color
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: gem_wait
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: sw_sync
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: gem_workarounds
results: parsing output: 90/ for test: prime_vgem
results: parsing output: 91/ for test: vgem_basic
results: parsing output: 92/ for test: kms_vrr
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: i915_query
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: i915_pm_rps
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_tiling_max_stride
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_force_connector_basic
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: vgem_basic
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: gem_render_copy
results: parsing output: 117/ for test: gem_create
results: parsing output: 118/ for test: gem_lmem_swapping
results: parsing output: 119/ for test: gem_mmap_wc
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_vblank
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: sysfs_timeslice_duration
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: kms_pm_rpm
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_ctx_isolation
results: parsing output: 131/ for test: kms_vblank
Done.