[73.454167] Initializing watchdogs
[73.454250]   /dev/watchdog0
[73.472642] [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]
[73.478026] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.480311] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.483614] [001/134] (960s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[73.625898] Starting subtest: async-flip-with-page-flip-events-linear
[74.002131] Starting dynamic subtest: pipe-A-eDP-1
[76.743604] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.741s)
[77.118090] Starting dynamic subtest: pipe-B-eDP-1
[79.877183] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[80.241787] Starting dynamic subtest: pipe-C-eDP-1
[83.024589] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.771s)
[83.382020] Starting dynamic subtest: pipe-D-eDP-1
[86.145735] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[86.148183] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.520s)
[87.331467] [002/134] (946s left) gem_fenced_exec_thrash (no-spare-fences)
[87.396106] Subtest no-spare-fences: SKIP (0.000s)
[87.437320] [003/134] (946s left) kms_psr (fbc-pr-cursor-render)
[87.524983] Starting subtest: fbc-pr-cursor-render
[87.529507] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[87.595702] [004/134] (946s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[87.685456] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[87.689609] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[87.784861] [005/134] (946s left) gem_workarounds (reset-fd)
[87.848671] Starting subtest: reset-fd
[87.952473] Subtest reset-fd: SUCCESS (0.103s)
[88.076139] [006/134] (946s left) kms_colorspace (colorspace-crc-oprgb)
[88.171080] Starting subtest: colorspace-crc-opRGB
[88.814440] Subtest colorspace-crc-opRGB: SUCCESS (0.645s)
[89.655528] [007/134] (944s left) gem_spin_batch (resubmit)
[89.708948] Starting subtest: resubmit
[89.711580] Starting dynamic subtest: rcs0
[89.716231] Dynamic subtest rcs0: SUCCESS (0.006s)
[89.725719] Starting dynamic subtest: bcs0
[89.728042] Dynamic subtest bcs0: SUCCESS (0.003s)
[89.736466] Starting dynamic subtest: vcs0
[89.738688] Dynamic subtest vcs0: SUCCESS (0.002s)
[89.748271] Starting dynamic subtest: vcs1
[89.750449] Dynamic subtest vcs1: SUCCESS (0.002s)
[89.758390] Starting dynamic subtest: vecs0
[89.760648] Dynamic subtest vecs0: SUCCESS (0.003s)
[89.768421] Starting dynamic subtest: ccs0
[89.770633] Dynamic subtest ccs0: SUCCESS (0.002s)
[89.772879] Subtest resubmit: SUCCESS (0.021s)
[89.980349] [008/134] (944s left) kms_pm_rpm (modeset-non-lpsp-stress)
[91.513855] Starting subtest: modeset-non-lpsp-stress
[92.684786] Subtest modeset-non-lpsp-stress: SKIP (1.172s)
[93.089426] [009/134] (941s left) kms_pm_rpm (system-suspend-modeset)
[94.610330] Starting subtest: system-suspend-modeset
[114.036599] Subtest system-suspend-modeset: SUCCESS (4.728s)
[114.428460] [010/134] (919s left) kms_content_protection (atomic-hdcp14)
[114.588756] Starting subtest: atomic-hdcp14
[114.593224] Subtest atomic-hdcp14: SKIP (0.000s)
[114.725484] [011/134] (919s left) kms_flip (2x-nonexisting-fb-interruptible)
[114.825086] Starting subtest: 2x-nonexisting-fb-interruptible
[114.838022] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.012s)
[114.912315] [012/134] (919s left) kms_flip (2x-flip-vs-dpms-on-nop)
[115.003114] Starting subtest: 2x-flip-vs-dpms-on-nop
[115.014439] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[115.091166] [013/134] (919s left) gem_mmap_offset (perf)
[115.149972] Starting subtest: perf
[115.151931] Starting dynamic subtest: smem0
[115.509437] Dynamic subtest smem0: SUCCESS (0.357s)
[115.511896] Subtest perf: SUCCESS (0.357s)
[115.615006] [014/134] (918s left) kms_color (ctm-max)
[115.717145] Starting subtest: ctm-max
[115.719475] Starting dynamic subtest: pipe-A-eDP-1
[116.442278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s)
[116.451223] Starting dynamic subtest: pipe-B-eDP-1
[117.842498] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[117.851304] Starting dynamic subtest: pipe-C-eDP-1
[119.239056] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[119.248259] Starting dynamic subtest: pipe-D-eDP-1
[120.644525] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s)
[120.646813] Subtest ctm-max: SUCCESS (4.928s)
[121.456846] [015/134] (913s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[121.559676] Starting subtest: yf-tiled-8bpp-rotate-180
[121.564198] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[121.652256] [016/134] (912s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[121.755216] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[121.757521] Starting dynamic subtest: pipe-A-eDP-1
[121.830096] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[121.839777] Starting dynamic subtest: pipe-B-eDP-1
[122.923798] Dynamic subtest pipe-B-eDP-1: SKIP (1.093s)
[122.928350] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.174s)
[124.118517] [017/134] (910s left) kms_cursor_crc (cursor-dpms)
[124.244063] Starting subtest: cursor-dpms
[124.246059] Starting dynamic subtest: pipe-A-eDP-1
[127.297235] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.054s)
[127.307025] Starting dynamic subtest: pipe-D-eDP-1
[130.910511] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.613s)
[130.912675] Subtest cursor-dpms: SUCCESS (6.670s)
[131.738844] [018/134] (902s left) perf_pmu (frequency)
[131.781969] Starting subtest: frequency
[131.786250] Starting dynamic subtest: gt0
[133.928492] Dynamic subtest gt0: SUCCESS (2.137s)
[133.938613] Starting dynamic subtest: idle-gt0
[134.434303] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[134.444060] Starting dynamic subtest: gt1
[139.001487] Dynamic subtest gt1: SUCCESS (4.564s)
[139.013035] Starting dynamic subtest: idle-gt1
[139.505651] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[139.508193] Subtest frequency: SUCCESS (7.726s)
[139.614208] [019/134] (895s left) dumb_buffer (invalid-bpp)
[139.663201] Starting subtest: invalid-bpp
[139.665611] Subtest invalid-bpp: SUCCESS (0.000s)
[139.775932] [020/134] (894s left) gem_mmap_wc (copy)
[139.824418] Subtest copy: SKIP (0.000s)
[139.884543] [021/134] (894s left) kms_big_fb (linear-addfb)
[139.983702] Starting subtest: linear-addfb
[139.985604] Subtest linear-addfb: SUCCESS (0.000s)
[140.104515] [022/134] (894s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[140.214175] Starting subtest: x-tiled-32bpp-rotate-0
[141.605606] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.391s)
[141.749143] [023/134] (893s left) syncobj_wait (single-wait-all-for-submit-signaled)
[141.799054] Starting subtest: single-wait-all-for-submit-signaled
[141.801066] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[141.909558] [024/134] (893s left) gem_exec_reloc (basic-cpu-gtt)
[141.960044] Subtest basic-cpu-gtt: SKIP (0.000s)
[142.022711] [025/134] (892s left) kms_psr (fbc-psr2-no-drrs)
[142.110962] Starting subtest: fbc-psr2-no-drrs
[142.113100] Starting dynamic subtest: eDP-1
[142.116732] Dynamic subtest eDP-1: SKIP (0.000s)
[142.120406] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[142.180963] [026/134] (892s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[142.289258] Starting subtest: cursorA-vs-flipA-legacy
[153.430755] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.141s)
[154.250989] [027/134] (880s left) gem_exec_fence (syncobj-channel)
[154.707220] Starting subtest: syncobj-channel
[155.725813] Subtest syncobj-channel: SUCCESS (1.015s)
[156.065487] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[156.068692] [028/134] (879s left) syncobj_timeline (multi-wait-all-available-submitted)
[156.120503] Starting subtest: multi-wait-all-available-submitted
[156.122888] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[156.216976] [029/134] (878s left) gem_exec_reloc (basic-cpu-wc-active)
[156.278944] Subtest basic-cpu-wc-active: SKIP (0.000s)
[156.350023] [030/134] (878s left) kms_cursor_crc (cursor-tearing-position-change)
[156.459082] Starting subtest: cursor-tearing-position-change
[156.461439] Starting dynamic subtest: pipe-A-eDP-1
[157.047987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[157.057729] Starting dynamic subtest: pipe-D-eDP-1
[158.309599] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[158.311642] Subtest cursor-tearing-position-change: SUCCESS (1.848s)
[159.136187] [031/134] (876s left) gem_userptr_blits (invalid-null-pointer)
[159.192204] Starting subtest: invalid-null-pointer
[159.194369] Subtest invalid-null-pointer: SUCCESS (0.001s)
[159.306151] [032/134] (875s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[159.409791] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[159.414186] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[159.501160] [033/134] (875s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[159.563457] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[159.565668] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[159.659549] [034/134] (875s left) vgem_basic (unload)
[159.693441] Starting subtest: unload
[188.721818] Subtest unload: SUCCESS (29.028s)
[188.820272] [035/134] (846s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[188.912974] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[188.915794] Starting dynamic subtest: pipe-A-eDP-1
[189.837361] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.917s)
[189.848030] Starting dynamic subtest: pipe-B-eDP-1
[191.488020] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.647s)
[191.499257] Starting dynamic subtest: pipe-C-eDP-1
[193.013708] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.526s)
[193.024919] Starting dynamic subtest: pipe-D-eDP-1
[194.531300] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.516s)
[194.533698] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.611s)
[195.763360] [036/134] (839s left) prime_vgem (wait)
[195.852502] Starting subtest: wait
[195.854824] Starting dynamic subtest: rcs0
[195.898093] Dynamic subtest rcs0: SUCCESS (0.046s)
[195.907866] Starting dynamic subtest: bcs0
[195.958704] Dynamic subtest bcs0: SUCCESS (0.060s)
[195.968152] Starting dynamic subtest: vcs0
[196.004750] Dynamic subtest vcs0: SUCCESS (0.045s)
[196.014193] Starting dynamic subtest: vcs1
[196.051221] Dynamic subtest vcs1: SUCCESS (0.046s)
[196.060675] Starting dynamic subtest: vecs0
[196.098148] Dynamic subtest vecs0: SUCCESS (0.046s)
[196.108057] Starting dynamic subtest: ccs0
[196.145150] Dynamic subtest ccs0: SUCCESS (0.046s)
[196.147320] Subtest wait: SUCCESS (0.294s)
[196.273782] [037/134] (839s left) gem_reg_read (timestamp-monotonic)
[196.331957] Starting subtest: timestamp-monotonic
[200.985336] Subtest timestamp-monotonic: SUCCESS (4.653s)
[201.057343] [038/134] (834s left) gem_ctx_persistence (engines-mixed)
[201.106375] Starting subtest: engines-mixed
[201.108813] Starting dynamic subtest: rcs0
[201.203663] Dynamic subtest rcs0: SUCCESS (0.096s)
[201.218366] Starting dynamic subtest: bcs0
[201.278895] Dynamic subtest bcs0: SUCCESS (0.074s)
[201.289305] Starting dynamic subtest: vcs0
[201.334963] Dynamic subtest vcs0: SUCCESS (0.054s)
[201.348594] Starting dynamic subtest: vcs1
[201.387707] Dynamic subtest vcs1: SUCCESS (0.051s)
[201.398150] Starting dynamic subtest: vecs0
[201.425338] Dynamic subtest vecs0: SUCCESS (0.036s)
[201.435108] Starting dynamic subtest: ccs0
[201.523929] Dynamic subtest ccs0: SUCCESS (0.098s)
[201.526651] Subtest engines-mixed: SUCCESS (0.418s)
[201.607022] [039/134] (833s left) gem_ctx_param (get-priority-new-ctx)
[201.661957] Starting subtest: get-priority-new-ctx
[201.664405] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[201.770341] [040/134] (833s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[201.873495] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[201.877960] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[201.971935] [041/134] (833s left) kms_vrr (seamless-rr-switch-virtual)
[202.071586] Starting subtest: seamless-rr-switch-virtual
[202.076969] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[202.142893] [042/134] (833s left) kms_universal_plane (universal-plane-sanity)
[202.228642] Starting subtest: universal-plane-sanity
[202.230379] Starting dynamic subtest: pipe-A-eDP-1
[202.852143] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.622s)
[202.862564] Starting dynamic subtest: pipe-B-eDP-1
[204.098503] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.245s)
[204.109054] Starting dynamic subtest: pipe-C-eDP-1
[205.300509] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[205.310585] Starting dynamic subtest: pipe-D-eDP-1
[206.541027] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[206.543481] Subtest universal-plane-sanity: SUCCESS (4.313s)
[207.384651] [043/134] (828s left) kms_frontbuffer_tracking (psr-suspend)
[207.475827] Starting subtest: psr-suspend
[246.087656] Subtest psr-suspend: SUCCESS (8.163s)
[246.203420] [044/134] (789s left) api_intel_bb (bb-with-allocator)
[246.259889] Starting subtest: bb-with-allocator
[246.263454] Subtest bb-with-allocator: SUCCESS (0.006s)
[246.385293] [045/134] (789s left) gem_tiled_pread_pwrite
[246.493922] [046/134] (789s left) gem_pxp (reject-modify-context-protection-on)
[246.611446] Starting subtest: reject-modify-context-protection-on
[246.614043] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[246.718415] [047/134] (789s left) kms_fbcon_fbt (fbc-suspend)
[246.779157] Starting subtest: fbc-suspend
[295.636710] Subtest fbc-suspend: SUCCESS (18.964s)
[296.952782] [048/134] (738s left) kms_addfb_basic (bo-too-small)
[297.052305] Starting subtest: bo-too-small
[297.054875] Subtest bo-too-small: SUCCESS (0.000s)
[297.150041] [049/134] (738s left) gem_exec_whisper (basic-normal-all)
[297.206159] Starting subtest: basic-normal-all
[299.473160] Subtest basic-normal-all: SUCCESS (2.264s)
[299.657569] [050/134] (736s left) kms_psr (fbc-psr-primary-mmap-gtt)
[299.747792] Starting subtest: fbc-psr-primary-mmap-gtt
[299.750504] Starting dynamic subtest: eDP-1
[299.755809] Dynamic subtest eDP-1: SKIP (0.000s)
[299.761083] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[299.823403] [051/134] (736s left) kms_invalid_mode (clock-too-high)
[299.908862] Starting subtest: clock-too-high
[299.911451] Starting dynamic subtest: pipe-A-eDP-1
[300.200195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[300.211048] Starting dynamic subtest: pipe-B-eDP-1
[300.215953] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[300.226914] Starting dynamic subtest: pipe-C-eDP-1
[300.232926] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[300.250284] Starting dynamic subtest: pipe-D-eDP-1
[300.255806] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[300.258363] Subtest clock-too-high: SUCCESS (0.296s)
[301.002720] [052/134] (735s left) gem_ctx_param (invalid-ctx-get)
[301.060339] Starting subtest: invalid-ctx-get
[301.063309] Subtest invalid-ctx-get: SUCCESS (0.000s)
[301.144499] [053/134] (734s left) kms_plane_scaling (intel-max-src-size)
[301.221781] Starting subtest: intel-max-src-size
[301.229777] Subtest intel-max-src-size: SKIP (0.000s)
[301.308529] [054/134] (734s left) gem_exec_reloc (basic-write-cpu-active)
[301.368908] Subtest basic-write-cpu-active: SKIP (0.000s)
[301.432709] [055/134] (734s left) syncobj_wait (single-wait-signaled)
[301.479798] Starting subtest: single-wait-signaled
[301.482443] Subtest single-wait-signaled: SUCCESS (0.000s)
[301.576319] [056/134] (734s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[301.675626] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[301.681014] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[301.768948] [057/134] (734s left) kms_chamelium_color (ctm-limited-range)
[301.873858] Subtest ctm-limited-range: SKIP (0.000s)
[301.918995] [058/134] (734s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[302.034574] Starting subtest: cursorA-vs-flipB-legacy
[302.038609] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[302.194540] [059/134] (734s left) sw_sync (alloc_fence)
[302.231705] Starting subtest: alloc_fence
[302.233839] Subtest alloc_fence: SUCCESS (0.000s)
[302.290433] [060/134] (734s left) gem_vm_create (create-ext)
[302.349496] Starting subtest: create-ext
[302.356902] Subtest create-ext: SUCCESS (0.007s)
[302.462837] [061/134] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[302.560372] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[302.564795] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[302.654309] [062/134] (733s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[302.745180] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[306.763928] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.022s)
[307.906807] [063/134] (728s left) i915_pm_rps (thresholds)
[307.967072] Starting subtest: thresholds
[307.972795] Subtest thresholds: SKIP (0.001s)
[308.078987] [064/134] (728s left) gem_exec_balancer (indices)
[308.143828] Starting subtest: indices
[310.285039] Subtest indices: SUCCESS (2.140s)
[310.583909] [065/134] (726s left) gem_userptr_blits (stress-mm-invalidate-close)
[310.668243] Starting subtest: stress-mm-invalidate-close
[312.816802] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[312.954480] [066/134] (723s left) kms_cursor_crc (cursor-onscreen-128x42)
[313.191358] Starting subtest: cursor-onscreen-128x42
[313.240900] Subtest cursor-onscreen-128x42: SKIP (0.043s)
[313.449503] [067/134] (723s left) gem_exec_schedule (smoketest-all)
[313.535573] Starting subtest: smoketest-all
[345.932583] Subtest smoketest-all: SUCCESS (32.346s)
[346.481864] [068/134] (690s left) vgem_basic (setversion)
[346.530300] Starting subtest: setversion
[346.535144] Subtest setversion: SUCCESS (0.000s)
[346.585533] [069/134] (690s left) gem_pxp (hw-rejects-pxp-buffer)
[346.696460] Starting subtest: hw-rejects-pxp-buffer
[346.701919] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[346.806341] [070/134] (690s left) kms_flip (flip-vs-expired-vblank)
[346.906534] Starting subtest: flip-vs-expired-vblank
[346.908908] Starting dynamic subtest: A-eDP1
[355.590052] Dynamic subtest A-eDP1: SUCCESS (8.682s)
[355.601643] Starting dynamic subtest: B-eDP1
[364.227206] Dynamic subtest B-eDP1: SUCCESS (8.635s)
[364.239187] Starting dynamic subtest: C-eDP1
[372.864914] Dynamic subtest C-eDP1: SUCCESS (8.635s)
[372.878172] Starting dynamic subtest: D-eDP1
[381.489660] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[381.492215] Subtest flip-vs-expired-vblank: SUCCESS (34.587s)
[382.665840] [071/134] (654s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[382.754793] Starting subtest: plane-scaler-unity-scaling-with-rotation
[382.757322] Starting dynamic subtest: pipe-A
[382.981743] Dynamic subtest pipe-A: SUCCESS (0.229s)
[382.992031] Starting dynamic subtest: pipe-B
[384.251297] Dynamic subtest pipe-B: SUCCESS (1.269s)
[384.265683] Starting dynamic subtest: pipe-C
[385.579032] Dynamic subtest pipe-C: SUCCESS (1.326s)
[385.589803] Starting dynamic subtest: pipe-D
[386.903333] Dynamic subtest pipe-D: SUCCESS (1.323s)
[386.905906] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.151s)
[388.104520] [072/134] (648s left) kms_psr (pr-sprite-plane-onoff)
[388.197173] Starting subtest: pr-sprite-plane-onoff
[388.202565] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[388.271316] [073/134] (648s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[388.321009] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[388.377775] [074/134] (648s left) prime_vgem (coherency-gtt)
[388.441303] Starting subtest: coherency-gtt
[388.446039] Subtest coherency-gtt: SKIP (0.000s)
[388.549456] [075/134] (648s left) kms_lease (lease-uevent)
[388.636995] Starting subtest: lease-uevent
[389.647154] Subtest lease-uevent: SUCCESS (1.011s)
[389.727101] [076/134] (647s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[389.833556] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[389.836286] Starting dynamic subtest: pipe-A-default-mode
[390.968445] Dynamic subtest pipe-A-default-mode: SKIP (1.131s)
[390.973435] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.133s)
[391.104569] [077/134] (646s left) gem_exec_schedule (promotion)
[391.182758] Starting subtest: promotion
[391.185047] Starting dynamic subtest: rcs0
[391.281059] Dynamic subtest rcs0: SUCCESS (0.109s)
[391.297713] Starting dynamic subtest: vcs0
[391.387648] Dynamic subtest vcs0: SUCCESS (0.103s)
[391.397751] Starting dynamic subtest: vcs1
[391.476652] Dynamic subtest vcs1: SUCCESS (0.088s)
[391.488719] Starting dynamic subtest: vecs0
[391.554037] Dynamic subtest vecs0: SUCCESS (0.076s)
[391.567522] Starting dynamic subtest: ccs0
[391.650922] Dynamic subtest ccs0: SUCCESS (0.097s)
[391.654057] Subtest promotion: SUCCESS (0.480s)
[393.414919] [078/134] (643s left) gem_exec_reloc (basic-range-active)
[393.472863] Subtest basic-range-active: SKIP (0.000s)
[393.550023] [079/134] (643s left) kms_atomic (plane-primary-legacy)
[393.638591] Starting subtest: plane-primary-legacy
[393.641014] Starting dynamic subtest: pipe-A-eDP-1
[394.083199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[394.085843] Subtest plane-primary-legacy: SUCCESS (0.445s)
[394.959389] [080/134] (642s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[395.044922] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[395.047758] Starting dynamic subtest: pipe-A-eDP-1
[395.115460] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[395.126856] Starting dynamic subtest: pipe-B-eDP-1
[395.193763] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[395.205262] Starting dynamic subtest: pipe-C-eDP-1
[395.273934] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[395.286207] Starting dynamic subtest: pipe-D-eDP-1
[395.351024] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[395.356163] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[397.313716] [081/134] (640s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[397.409008] Starting subtest: y-tiled-64bpp-rotate-180
[397.414474] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[397.505324] [082/134] (639s left) gem_ctx_shared (detached-shared-gtt)
[397.562713] Starting subtest: detached-shared-gtt
[399.714761] Subtest detached-shared-gtt: SUCCESS (2.150s)
[400.081042] [083/134] (637s left) gem_ctx_engines (invalid-engines)
[400.143938] Starting subtest: invalid-engines
[400.155288] Subtest invalid-engines: SUCCESS (0.012s)
[400.382339] [084/134] (637s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[400.485851] Starting subtest: fbc-rgb565-draw-mmap-wc
[404.597898] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.116s)
[405.735464] [085/134] (631s left) i915_drm_fdinfo (memory-info-idle)
[405.776442] Starting subtest: memory-info-idle
[405.778843] Starting dynamic subtest: smem0
[405.827911] Dynamic subtest smem0: SUCCESS (0.051s)
[405.830819] Subtest memory-info-idle: SUCCESS (0.051s)
[405.905750] [086/134] (631s left) i915_suspend (fence-restore-untiled)
[405.963603] Starting subtest: fence-restore-untiled
[405.968731] Subtest fence-restore-untiled: SKIP (0.000s)
[406.082004] [087/134] (631s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[406.170641] Starting subtest: flip-primary-invalidate-overlay
[417.816565] Subtest flip-primary-invalidate-overlay: SUCCESS (11.648s)
[417.954421] [088/134] (619s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[418.057400] Starting subtest: fbcpsr-indfb-scaledprimary
[423.826059] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.772s)
[423.962896] [089/134] (613s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[424.067933] Starting subtest: psr-rgb565-draw-mmap-gtt
[424.073454] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[424.161428] [090/134] (613s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[424.224025] Starting subtest: y-tiled-to-vebox-x-tiled
[424.229009] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[424.409671] [091/134] (613s left) prime_mmap (test_dup)
[424.454681] Starting subtest: test_dup
[424.457219] Starting dynamic subtest: test_dup-smem
[424.488777] Dynamic subtest test_dup-smem: SUCCESS (0.035s)
[424.491794] Subtest test_dup: SUCCESS (0.036s)
[424.565303] [092/134] (613s left) kms_atomic_interruptible (legacy-pageflip)
[424.655061] Starting subtest: legacy-pageflip
[424.657925] Starting dynamic subtest: pipe-A-eDP-1
[432.055536] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.400s)
[432.058183] Subtest legacy-pageflip: SUCCESS (7.402s)
[432.909523] [093/134] (604s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[433.023298] Starting subtest: yf-tiled-32bpp-rotate-180
[433.027900] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[433.132608] [094/134] (604s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[433.234042] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[433.239538] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[433.325797] [095/134] (604s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[433.369789] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[433.411323] [096/134] (604s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[433.508741] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[433.513302] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[433.583524] [097/134] (604s left) gem_exec_schedule (preempt-engines)
[433.656201] Starting subtest: preempt-engines
[433.658850] Starting dynamic subtest: rcs0
[435.902419] Dynamic subtest rcs0: SUCCESS (2.256s)
[435.916761] Starting dynamic subtest: bcs0
[438.113239] Dynamic subtest bcs0: SUCCESS (2.209s)
[438.126741] Starting dynamic subtest: vcs0
[440.493777] Dynamic subtest vcs0: SUCCESS (2.379s)
[440.505288] Starting dynamic subtest: vcs1
[442.833633] Dynamic subtest vcs1: SUCCESS (2.337s)
[442.844583] Starting dynamic subtest: vecs0
[445.167323] Dynamic subtest vecs0: SUCCESS (2.332s)
[445.178033] Starting dynamic subtest: ccs0
[447.537437] Dynamic subtest ccs0: SUCCESS (2.368s)
[447.540325] Subtest preempt-engines: SUCCESS (13.892s)
[447.843132] [098/134] (590s left) kms_draw_crc (draw-method-mmap-wc)
[447.933067] Starting subtest: draw-method-mmap-wc
[447.935389] Starting dynamic subtest: xrgb8888-untiled
[448.188380] Dynamic subtest xrgb8888-untiled: SUCCESS (0.256s)
[448.200854] Starting dynamic subtest: rgb565-untiled
[448.422015] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[448.433307] Starting dynamic subtest: xrgb2101010-untiled
[448.643661] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[448.654796] Starting dynamic subtest: xbgr16161616f-untiled
[448.854611] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[448.865315] Starting dynamic subtest: xrgb8888-xtiled
[448.987525] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[448.997870] Starting dynamic subtest: rgb565-xtiled
[449.121571] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[449.135408] Starting dynamic subtest: xrgb2101010-xtiled
[449.254569] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[449.265372] Starting dynamic subtest: xbgr16161616f-xtiled
[449.387720] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[449.404162] Starting dynamic subtest: xrgb8888-4tiled
[449.554273] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.164s)
[449.564436] Starting dynamic subtest: rgb565-4tiled
[449.700700] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[449.711028] Starting dynamic subtest: xrgb2101010-4tiled
[449.843637] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s)
[449.859150] Starting dynamic subtest: xbgr16161616f-4tiled
[450.021232] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[450.023574] Subtest draw-method-mmap-wc: SUCCESS (2.090s)
[450.142724] [099/134] (587s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[450.239674] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[450.886736] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s)
[451.039365] [100/134] (587s left) gem_exec_schedule (fairslice)
[451.108023] Starting subtest: fairslice
[451.110848] Starting dynamic subtest: rcs0
[453.123552] Dynamic subtest rcs0: SUCCESS (2.022s)
[453.135070] Starting dynamic subtest: bcs0
[455.148871] Dynamic subtest bcs0: SUCCESS (2.025s)
[455.160295] Starting dynamic subtest: vcs0
[457.170290] Dynamic subtest vcs0: SUCCESS (2.020s)
[457.183504] Starting dynamic subtest: vcs1
[459.192867] Dynamic subtest vcs1: SUCCESS (2.020s)
[459.205427] Starting dynamic subtest: vecs0
[461.213766] Dynamic subtest vecs0: SUCCESS (2.020s)
[461.224203] Starting dynamic subtest: ccs0
[463.235633] Dynamic subtest ccs0: SUCCESS (2.021s)
[463.238361] Subtest fairslice: SUCCESS (12.137s)
[463.534766] [101/134] (574s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[463.922872] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[464.718736] [102/134] (573s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[464.820636] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[464.825160] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[464.917851] [103/134] (573s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[464.982690] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[465.081813] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.101s)
[465.164686] [104/134] (573s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[465.267725] Starting subtest: fbcpsr-tiling-y
[465.272653] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[465.366041] [105/134] (573s left) kms_plane_multiple (2x-tiling-x)
[465.450804] Starting subtest: 2x-tiling-x
[465.455578] Subtest 2x-tiling-x: SKIP (0.000s)
[465.522824] [106/134] (572s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[465.637807] Starting subtest: flip-vs-cursor-busy-crc-legacy
[466.453557] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.815s)
[467.262287] [107/134] (571s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[467.353642] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[467.358613] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[467.446193] [108/134] (571s left) perf_pmu (busy-idle)
[467.480650] Starting subtest: busy-idle
[467.483459] Starting dynamic subtest: rcs0
[468.158826] Dynamic subtest rcs0: SUCCESS (0.678s)
[468.172793] Starting dynamic subtest: bcs0
[468.823119] Dynamic subtest bcs0: SUCCESS (0.661s)
[468.837305] Starting dynamic subtest: vcs0
[470.382496] Dynamic subtest vcs0: SUCCESS (1.556s)
[470.394138] Starting dynamic subtest: vcs1
[472.366181] Dynamic subtest vcs1: SUCCESS (1.981s)
[472.378906] Starting dynamic subtest: vecs0
[474.351642] Dynamic subtest vecs0: SUCCESS (1.982s)
[474.365640] Starting dynamic subtest: ccs0
[475.020180] Dynamic subtest ccs0: SUCCESS (0.667s)
[475.023045] Subtest busy-idle: SUCCESS (7.542s)
[475.129712] [109/134] (563s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[475.239724] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[482.762592] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.527s)
[482.899692] [110/134] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[483.002380] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[490.325633] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.327s)
[490.440216] [111/134] (548s left) i915_hangman (engine-engine-hang)
[490.503654] Starting subtest: engine-engine-hang
[490.506012] Starting dynamic subtest: rcs0
[492.304068] Dynamic subtest rcs0: SUCCESS (1.801s)
[492.315901] Starting dynamic subtest: bcs0
[494.349245] Dynamic subtest bcs0: SUCCESS (2.042s)
[494.365003] Starting dynamic subtest: vcs0
[496.334224] Dynamic subtest vcs0: SUCCESS (1.982s)
[496.347557] Starting dynamic subtest: vcs1
[498.318053] Dynamic subtest vcs1: SUCCESS (1.982s)
[498.333375] Starting dynamic subtest: vecs0
[500.300907] Dynamic subtest vecs0: SUCCESS (1.980s)
[500.314800] Starting dynamic subtest: ccs0
[502.285943] Dynamic subtest ccs0: SUCCESS (1.981s)
[502.288962] Subtest engine-engine-hang: SUCCESS (11.785s)
[502.428307] [112/134] (536s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[502.525695] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[502.530928] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[502.594898] [113/134] (536s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[502.699278] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[509.811805] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.117s)
[509.940248] [114/134] (528s left) kms_pm_backlight (fade-with-dpms)
[510.038803] Starting subtest: fade-with-dpms
[512.135355] Starting dynamic subtest: eDP-1
[515.155644] Dynamic subtest eDP-1: SUCCESS (3.019s)
[515.158305] Subtest fade-with-dpms: SUCCESS (5.117s)
[516.026600] [115/134] (522s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[516.094603] Starting subtest: basic-batch-kernel-default-cmd
[516.099019] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[516.297864] [116/134] (522s left) gen9_exec_parse (basic-rejected)
[516.356175] Subtest basic-rejected: SKIP (0.000s)
[516.429031] [117/134] (522s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[516.819874] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[517.644656] [118/134] (521s left) sysfs_defaults (readonly)
[517.705987] Starting subtest: readonly
[517.708774] Starting dynamic subtest: vecs0
[517.711540] Dynamic subtest vecs0: SUCCESS (0.000s)
[517.722399] Starting dynamic subtest: ccs0
[517.724915] Dynamic subtest ccs0: SUCCESS (0.000s)
[517.735550] Starting dynamic subtest: vcs0
[517.737997] Dynamic subtest vcs0: SUCCESS (0.000s)
[517.748669] Starting dynamic subtest: bcs0
[517.751277] Dynamic subtest bcs0: SUCCESS (0.000s)
[517.761872] Starting dynamic subtest: rcs0
[517.764531] Dynamic subtest rcs0: SUCCESS (0.000s)
[517.777652] Starting dynamic subtest: vcs1
[517.780488] Dynamic subtest vcs1: SUCCESS (0.000s)
[517.783100] Subtest readonly: SUCCESS (0.006s)
[517.823923] [119/134] (521s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[517.926817] Starting subtest: fbc-1p-pri-indfb-multidraw
[531.058672] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.143s)
[532.414709] [120/134] (506s left) syncobj_timeline (reset-unsignaled)
[532.470617] Starting subtest: reset-unsignaled
[532.473311] Subtest reset-unsignaled: SUCCESS (0.000s)
[532.572878] [121/134] (506s left) gem_mmap_gtt (basic-read)
[532.622555] Subtest basic-read: SKIP (0.000s)
[532.680854] [122/134] (506s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[532.768955] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[532.771817] Starting dynamic subtest: pipe-A-eDP-1
[532.795800] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[532.809018] Starting dynamic subtest: pipe-B-eDP-1
[532.831840] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[532.842283] Starting dynamic subtest: pipe-C-eDP-1
[532.865008] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[532.878293] Starting dynamic subtest: pipe-D-eDP-1
[532.901387] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[532.903906] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[535.074226] [123/134] (504s left) api_intel_bb (intel-bb-blit-x)
[535.130032] Starting subtest: intel-bb-blit-x
[538.622551] Subtest intel-bb-blit-x: SUCCESS (3.493s)
[538.744400] [124/134] (500s left) kms_cursor_edge_walk (128x128-right-edge)
[538.839661] Starting subtest: 128x128-right-edge
[538.842203] Starting dynamic subtest: pipe-A-eDP-1
[542.335506] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.497s)
[542.347459] Starting dynamic subtest: pipe-D-eDP-1
[545.449237] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s)
[545.451919] Subtest 128x128-right-edge: SUCCESS (6.610s)
[546.256881] [125/134] (492s left) kms_psr (psr-cursor-render)
[546.340922] Starting subtest: psr-cursor-render
[546.344000] Starting dynamic subtest: eDP-1
[548.042000] Dynamic subtest eDP-1: SUCCESS (1.700s)
[548.044823] Subtest psr-cursor-render: SUCCESS (1.701s)
[548.913123] [126/134] (490s left) gem_userptr_blits (input-checking)
[548.976306] Starting subtest: input-checking
[548.978799] Subtest input-checking: SUCCESS (0.000s)
[549.092449] [127/134] (490s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[549.188771] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[549.191416] Starting dynamic subtest: pipe-A-eDP-1
[549.201477] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[549.214412] Starting dynamic subtest: pipe-B-eDP-1
[549.224391] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[549.235862] Starting dynamic subtest: pipe-C-eDP-1
[549.245957] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[549.256041] Starting dynamic subtest: pipe-D-eDP-1
[549.266004] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[549.270780] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[551.467625] [128/134] (487s left) kms_joiner (basic-ultra-joiner)
[551.572873] Starting subtest: basic-ultra-joiner
[551.577754] Subtest basic-ultra-joiner: SKIP (0.000s)
[551.640816] [129/134] (487s left) kms_flip (blocking-wf_vblank)
[551.728299] Starting subtest: blocking-wf_vblank
[551.730934] Starting dynamic subtest: A-eDP1
[560.620290] Dynamic subtest A-eDP1: SUCCESS (8.891s)
[560.632047] Starting dynamic subtest: B-eDP1
[569.558504] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[569.574408] Starting dynamic subtest: C-eDP1
[578.484569] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[578.496557] Starting dynamic subtest: D-eDP1
[587.421597] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[587.427284] Subtest blocking-wf_vblank: SUCCESS (35.697s)
[588.642119] [130/134] (450s left) prime_busy (hang-wait)
[588.697301] Starting subtest: hang-wait
[588.699926] Starting dynamic subtest: rcs0
[614.862764] Dynamic subtest rcs0: SUCCESS (26.162s)
[614.875843] Starting dynamic subtest: bcs0
[621.952285] Dynamic subtest bcs0: SUCCESS (7.084s)
[621.964422] Starting dynamic subtest: vcs0
[628.926002] Dynamic subtest vcs0: SUCCESS (6.974s)
[628.937802] Starting dynamic subtest: vcs1
[636.030050] Dynamic subtest vcs1: SUCCESS (7.102s)
[636.040842] Starting dynamic subtest: vecs0
[642.940665] Dynamic subtest vecs0: SUCCESS (6.908s)
[642.951202] Starting dynamic subtest: ccs0
[656.844007] Dynamic subtest ccs0: SUCCESS (13.900s)
[656.847865] Subtest hang-wait: SUCCESS (68.144s)
[656.969805] [131/134] (382s left) gem_exec_balancer (semaphore)
[657.036392] Starting subtest: semaphore
[658.343330] Subtest semaphore: SUCCESS (1.309s)
[658.643683] [132/134] (380s left) kms_plane_multiple (tiling-none)
[658.742792] Starting subtest: tiling-none
[658.745631] Starting dynamic subtest: pipe-A-eDP-1
[662.478463] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.733s)
[662.489520] Starting dynamic subtest: pipe-B-eDP-1
[666.899839] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.421s)
[666.911750] Starting dynamic subtest: pipe-C-eDP-1
[671.238773] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.338s)
[671.249931] Starting dynamic subtest: pipe-D-eDP-1
[675.583832] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.343s)
[675.586658] Subtest tiling-none: SUCCESS (16.841s)
[676.400415] [133/134] (363s left) gem_ccs (block-multicopy-inplace)
[676.457872] Starting subtest: block-multicopy-inplace
[676.463124] Subtest block-multicopy-inplace: SKIP (0.000s)
[676.548451] [134/134] (363s left) gem_ctx_sseu (engines)
[676.607898] Subtest engines: SKIP (0.000s)
[676.668649] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: gem_fenced_exec_thrash
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_workarounds
results: parsing output: 5/ for test: kms_colorspace
results: parsing output: 6/ for test: gem_spin_batch
results: parsing output: 7/ for test: kms_pm_rpm
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: kms_content_protection
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gem_mmap_offset
results: parsing output: 13/ for test: kms_color
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: dumb_buffer
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: vgem_basic
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: prime_vgem
results: parsing output: 36/ for test: gem_reg_read
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: gem_ctx_param
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_vrr
results: parsing output: 41/ for test: kms_universal_plane
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: api_intel_bb
results: parsing output: 44/ for test: gem_tiled_pread_pwrite
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_fbcon_fbt
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_invalid_mode
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_chamelium_color
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: gem_vm_create
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: i915_pm_rps
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: gem_pxp
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: prime_vgem
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: kms_atomic
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_ctx_shared
results: parsing output: 82/ for test: gem_ctx_engines
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: i915_suspend
results: parsing output: 86/ for test: kms_psr_stress_test
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: prime_mmap
results: parsing output: 91/ for test: kms_atomic_interruptible
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_draw_crc
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_chamelium_frames
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_plane_multiple
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: i915_hangman
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_pm_backlight
results: parsing output: 114/ for test: gem_exec_flush
results: parsing output: 115/ for test: gen9_exec_parse
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: sysfs_defaults
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: kms_cursor_edge_walk
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_joiner
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: prime_busy
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_plane_multiple
results: parsing output: 132/ for test: gem_ccs
results: parsing output: 133/ for test: gem_ctx_sseu
Done.