[58.881896] Initializing watchdogs
[58.881941]   /dev/watchdog0
[58.896117] [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]
[58.900789] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.903083] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.906716] [001/133] (960s left) kms_flip (2x-plain-flip-interruptible)
[59.032360] Starting subtest: 2x-plain-flip-interruptible
[59.044094] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[59.127912] [002/133] (960s left) kms_pm_rpm (modeset-non-lpsp-stress)
[61.083761] Starting subtest: modeset-non-lpsp-stress
[62.226789] Subtest modeset-non-lpsp-stress: SKIP (1.145s)
[62.610219] [003/133] (956s left) kms_plane_scaling (2x-scaler-multi-pipe)
[62.706211] Starting subtest: 2x-scaler-multi-pipe
[62.710820] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[62.822964] [004/133] (956s left) kms_vblank (query-busy)
[62.920685] Starting subtest: query-busy
[62.922638] Starting dynamic subtest: pipe-A-eDP-1
[64.821339] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.900s)
[64.834485] Starting dynamic subtest: pipe-D-eDP-1
[67.352683] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.530s)
[67.355218] Subtest query-busy: SUCCESS (4.432s)
[68.146633] [005/133] (951s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[68.251966] Starting subtest: 4-tiled-32bpp-rotate-270
[68.271100] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.018s)
[68.414379] [006/133] (951s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[68.519265] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[68.523354] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[68.655817] [007/133] (950s left) kms_atomic_interruptible (atomic-setmode)
[68.738989] Starting subtest: atomic-setmode
[68.741582] Starting dynamic subtest: pipe-A-eDP-1
[75.642575] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.902s)
[75.644600] Subtest atomic-setmode: SUCCESS (6.903s)
[76.516912] [008/133] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[76.625303] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[76.629261] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[76.749563] [009/133] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[76.846601] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[76.850801] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[76.961126] [010/133] (942s left) gem_mmap_gtt (basic-short)
[77.017839] Subtest basic-short: SKIP (0.000s)
[77.076357] [011/133] (942s left) i915_query (query-topology-coherent-slice-mask)
[77.134862] Starting subtest: query-topology-coherent-slice-mask
[77.139315] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[77.256120] [012/133] (942s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[77.352639] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[77.357026] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[77.432314] [013/133] (942s left) syncobj_wait (wait-all-complex)
[77.496998] Starting subtest: wait-all-complex
[77.711777] Subtest wait-all-complex: SUCCESS (0.213s)
[77.805110] [014/133] (942s left) prime_vgem (wait)
[77.921078] Starting subtest: wait
[77.923619] Starting dynamic subtest: rcs0
[77.967664] Dynamic subtest rcs0: SUCCESS (0.047s)
[77.974900] Starting dynamic subtest: bcs0
[78.053468] Dynamic subtest bcs0: SUCCESS (0.085s)
[78.060392] Starting dynamic subtest: vcs0
[78.100725] Dynamic subtest vcs0: SUCCESS (0.047s)
[78.107659] Starting dynamic subtest: vcs1
[78.146857] Dynamic subtest vcs1: SUCCESS (0.046s)
[78.153842] Starting dynamic subtest: vecs0
[78.191716] Dynamic subtest vecs0: SUCCESS (0.044s)
[78.198738] Starting dynamic subtest: ccs0
[78.238348] Dynamic subtest ccs0: SUCCESS (0.046s)
[78.240662] Subtest wait: SUCCESS (0.318s)
[78.380099] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[78.385714] [015/133] (941s left) kms_flip (absolute-wf_vblank-interruptible)
[78.488551] Starting subtest: absolute-wf_vblank-interruptible
[78.490980] Starting dynamic subtest: A-eDP1
[87.178592] Dynamic subtest A-eDP1: SUCCESS (8.686s)
[87.188192] Starting dynamic subtest: B-eDP1
[95.906489] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[95.916530] Starting dynamic subtest: C-eDP1
[104.640830] Dynamic subtest C-eDP1: SUCCESS (8.733s)
[104.648412] Starting dynamic subtest: D-eDP1
[113.366072] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[113.368522] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.876s)
[114.589091] [016/133] (905s left) sw_sync (sync_busy_fork)
[114.635122] Starting subtest: sync_busy_fork
[115.646308] Subtest sync_busy_fork: SUCCESS (1.011s)
[115.717520] [017/133] (904s left) i915_drm_fdinfo (virtual-busy-idle-all)
[115.754597] Starting subtest: virtual-busy-idle-all
[115.759251] Subtest virtual-busy-idle-all: SKIP (0.000s)
[115.829224] [018/133] (904s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[116.010626] Starting subtest: cursor-rapid-movement-64x64
[116.012955] Starting dynamic subtest: pipe-A-eDP-1
[116.556282] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[116.582617] Starting dynamic subtest: pipe-D-eDP-1
[117.797283] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[117.799296] Subtest cursor-rapid-movement-64x64: SUCCESS (1.786s)
[118.649623] [019/133] (901s left) kms_cursor_crc (cursor-suspend)
[118.772776] Starting subtest: cursor-suspend
[118.775142] Starting dynamic subtest: pipe-A-eDP-1
[151.850696] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.493s)
[151.860365] Starting dynamic subtest: pipe-D-eDP-1
[185.850211] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.749s)
[185.853474] Subtest cursor-suspend: SUCCESS (7.245s)
[186.713112] [020/133] (833s left) kms_psr (fbc-psr-cursor-plane-onoff)
[186.810873] Starting subtest: fbc-psr-cursor-plane-onoff
[186.813077] Starting dynamic subtest: eDP-1
[186.817092] Dynamic subtest eDP-1: SKIP (0.000s)
[186.821087] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[186.898293] [021/133] (833s left) kms_hdr (brightness-with-hdr)
[186.990590] Starting subtest: brightness-with-hdr
[186.996980] Subtest brightness-with-hdr: SKIP (0.000s)
[187.064252] [022/133] (833s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[187.450901] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[188.304437] [023/133] (831s left) i915_suspend (basic-s2idle-without-i915)
[188.350935] Starting subtest: basic-s2idle-without-i915
[209.822507] Subtest basic-s2idle-without-i915: SUCCESS (5.726s)
[209.948960] [024/133] (810s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[210.064515] Starting subtest: y-tiled-addfb-size-offset-overflow
[210.068559] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[210.175181] [025/133] (810s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[210.274152] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[210.276340] Starting dynamic subtest: pipe-A-eDP-1
[210.285008] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.294796] Starting dynamic subtest: pipe-B-eDP-1
[210.304011] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.314405] Starting dynamic subtest: pipe-C-eDP-1
[210.322678] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.329686] Starting dynamic subtest: pipe-D-eDP-1
[210.338355] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.342231] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[212.544711] [026/133] (807s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[212.654872] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[212.657096] Starting dynamic subtest: pipe-A-default-mode
[215.379923] Dynamic subtest pipe-A-default-mode: SUCCESS (2.724s)
[215.381884] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.726s)
[216.223651] [027/133] (804s left) gem_userptr_blits (stress-mm-invalidate-close)
[216.282578] Starting subtest: stress-mm-invalidate-close
[218.432764] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[218.606503] [028/133] (801s left) gem_userptr_blits (relocations)
[218.676864] Starting subtest: relocations
[218.681263] Subtest relocations: SKIP (0.001s)
[218.839175] [029/133] (801s left) syncobj_eventfd (timeline-wait-signaled)
[218.898485] Starting subtest: timeline-wait-signaled
[218.900749] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[219.027337] [030/133] (801s left) kms_rotation_crc (exhaust-fences)
[219.134786] Starting subtest: exhaust-fences
[219.138774] Subtest exhaust-fences: SKIP (0.000s)
[219.216564] [031/133] (801s left) kms_addfb_basic (addfb25-4-tiled)
[219.320430] Starting subtest: addfb25-4-tiled
[219.322668] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[219.438197] [032/133] (801s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[219.568133] Starting subtest: cursorB-vs-flipA-legacy
[219.571755] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[219.723262] [033/133] (800s left) gem_partial_pwrite_pread (reads-display)
[219.795950] Subtest reads-display: SKIP (0.000s)
[219.880905] [034/133] (800s left) gem_softpin (evict-active-interruptible)
[219.949949] Starting subtest: evict-active-interruptible
[219.959310] Subtest evict-active-interruptible: SUCCESS (0.009s)
[220.100819] [035/133] (800s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[220.197043] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[220.200488] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[220.279566] [036/133] (800s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[220.369985] Starting subtest: fb-8bpc-vs-panel-8bpc
[220.371870] Starting dynamic subtest: pipe-A-eDP-1
[221.774254] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.402s)
[221.776487] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.403s)
[222.596831] [037/133] (798s left) syncobj_timeline (wait-all-snapshot)
[222.652237] Starting subtest: wait-all-snapshot
[222.732725] Subtest wait-all-snapshot: SUCCESS (0.081s)
[222.821771] [038/133] (798s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[222.925319] Starting subtest: fbcpsr-2p-rte
[222.929226] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[223.043130] [039/133] (797s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[223.145230] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[223.147593] Starting dynamic subtest: pipe-A-eDP-1
[223.382663] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.206s)
[223.393596] Starting dynamic subtest: pipe-B-eDP-1
[224.655098] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.273s)
[224.664247] Starting dynamic subtest: pipe-C-eDP-1
[225.846568] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.188s)
[225.856967] Starting dynamic subtest: pipe-D-eDP-1
[227.075313] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[227.077401] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.899s)
[228.308488] [040/133] (792s left) sw_sync (sync_busy_fork_unixsocket)
[228.351843] Starting subtest: sync_busy_fork_unixsocket
[228.358150] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[228.448366] [041/133] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[228.558549] Starting subtest: psr-2p-primscrn-cur-indfb-move
[228.562940] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[228.684888] [042/133] (792s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[228.791673] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[228.795814] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[228.873907] [043/133] (792s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[228.982420] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[228.986389] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[229.105373] [044/133] (792s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[229.219863] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[230.177604] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.958s)
[230.334081] [045/133] (790s left) kms_vblank (ts-continuation-modeset-hang)
[230.435465] Starting subtest: ts-continuation-modeset-hang
[230.437432] Starting dynamic subtest: pipe-A-eDP-1
[257.218531] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.780s)
[257.232135] Starting dynamic subtest: pipe-D-eDP-1
[282.247795] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.025s)
[282.250140] Subtest ts-continuation-modeset-hang: SUCCESS (51.810s)
[283.113907] [046/133] (738s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[283.213903] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[283.218397] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[283.329105] [047/133] (737s left) gem_spin_batch (engines)
[283.390288] Starting subtest: engines
[283.392665] Starting dynamic subtest: rcs0
[286.632344] Dynamic subtest rcs0: SUCCESS (3.237s)
[286.642409] Starting dynamic subtest: bcs0
[289.868117] Dynamic subtest bcs0: SUCCESS (3.234s)
[289.878949] Starting dynamic subtest: vcs0
[293.105210] Dynamic subtest vcs0: SUCCESS (3.235s)
[293.115484] Starting dynamic subtest: vcs1
[296.340193] Dynamic subtest vcs1: SUCCESS (3.233s)
[296.350761] Starting dynamic subtest: vecs0
[299.577212] Dynamic subtest vecs0: SUCCESS (3.234s)
[299.586593] Starting dynamic subtest: ccs0
[302.814955] Dynamic subtest ccs0: SUCCESS (3.236s)
[302.817363] Subtest engines: SUCCESS (19.419s)
[303.087221] [048/133] (718s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[303.158101] Subtest no-spare-fences-busy: SKIP (0.000s)
[303.272384] [049/133] (718s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[303.328875] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[303.331274] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[303.442968] [050/133] (717s left) gem_exec_schedule (submit-golden-slice)
[303.519383] Starting subtest: submit-golden-slice
[303.521306] Starting dynamic subtest: rcs0
[303.578794] Dynamic subtest rcs0: SUCCESS (0.065s)
[303.593649] Starting dynamic subtest: bcs0
[303.628907] Dynamic subtest bcs0: SUCCESS (0.049s)
[303.641588] Starting dynamic subtest: vcs0
[303.681587] Dynamic subtest vcs0: SUCCESS (0.051s)
[303.692254] Starting dynamic subtest: vcs1
[303.731541] Dynamic subtest vcs1: SUCCESS (0.050s)
[303.743315] Starting dynamic subtest: vecs0
[303.773439] Dynamic subtest vecs0: SUCCESS (0.041s)
[303.785106] Starting dynamic subtest: ccs0
[303.818190] Dynamic subtest ccs0: SUCCESS (0.044s)
[303.820518] Subtest submit-golden-slice: SUCCESS (0.306s)
[305.610864] [051/133] (715s left) perf (oa-formats)
[305.734756] Starting subtest: oa-formats
[305.737107] Starting dynamic subtest: 0-rcs0
[305.748018] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[305.756735] Starting dynamic subtest: 1-vecs0
[305.770508] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[305.772856] Subtest oa-formats: SUCCESS (0.038s)
[305.823467] [052/133] (715s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[305.928508] Starting subtest: plane-all-modeset-transition-fencing
[305.932700] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[306.048068] [053/133] (715s left) api_intel_allocator (open-vm)
[306.118359] Starting subtest: open-vm
[306.123546] Subtest open-vm: SUCCESS (0.003s)
[306.272964] [054/133] (715s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[306.368470] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[306.370827] Starting dynamic subtest: pipe-A-eDP-1
[307.190266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.813s)
[307.200974] Starting dynamic subtest: pipe-B-eDP-1
[308.702659] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.511s)
[308.712140] Starting dynamic subtest: pipe-C-eDP-1
[310.216301] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.510s)
[310.226393] Starting dynamic subtest: pipe-D-eDP-1
[311.741897] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.525s)
[311.744638] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.363s)
[312.937254] [055/133] (708s left) kms_panel_fitting (legacy)
[313.046520] Starting subtest: legacy
[313.048933] Starting dynamic subtest: pipe-A-eDP-1
[313.575368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s)
[313.603590] Starting dynamic subtest: pipe-B-eDP-1
[315.173306] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.577s)
[315.199943] Starting dynamic subtest: pipe-C-eDP-1
[316.688496] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.495s)
[316.712467] Starting dynamic subtest: pipe-D-eDP-1
[318.210112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.504s)
[318.212217] Subtest legacy: SUCCESS (5.167s)
[319.469711] [056/133] (702s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[319.569309] Starting subtest: psr-rgb101010-draw-mmap-wc
[326.686266] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.120s)
[326.799930] [057/133] (694s left) gem_wait (busy)
[326.888493] Starting subtest: busy
[326.890870] Starting dynamic subtest: all-engines
[328.452941] Dynamic subtest all-engines: SUCCESS (1.562s)
[328.462782] Starting dynamic subtest: rcs0
[328.996649] Dynamic subtest rcs0: SUCCESS (0.542s)
[329.007014] Starting dynamic subtest: bcs0
[329.536734] Dynamic subtest bcs0: SUCCESS (0.539s)
[329.547591] Starting dynamic subtest: vcs0
[331.462121] Dynamic subtest vcs0: SUCCESS (1.923s)
[331.473058] Starting dynamic subtest: vcs1
[333.444337] Dynamic subtest vcs1: SUCCESS (1.979s)
[333.455524] Starting dynamic subtest: vecs0
[335.492484] Dynamic subtest vecs0: SUCCESS (2.046s)
[335.504465] Starting dynamic subtest: ccs0
[336.034626] Dynamic subtest ccs0: SUCCESS (0.541s)
[336.037390] Subtest busy: SUCCESS (9.146s)
[336.243501] [058/133] (685s left) perf_pmu (module-unload)
[336.353085] Starting subtest: module-unload
[343.010883] Subtest module-unload: FAIL (6.551s)
[343.043361] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[343.044097] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[343.047243] [059/133] (678s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[344.612627] Starting subtest: multi-wait-for-submit-available-signaled
[344.615137] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[344.714531] [FACT syncobj_timeline (multi-wait-for-submit-available-signaled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[344.715799] [FACT syncobj_timeline (multi-wait-for-submit-available-signaled)] new: kernel.kmod_is_loaded.i915: true
[344.719554] [060/133] (677s left) i915_pm_rc6_residency (rc6-fence)
[344.783142] Starting subtest: rc6-fence
[344.808015] Starting dynamic subtest: gt0
[357.136632] Dynamic subtest gt0: SUCCESS (12.327s)
[357.147779] Starting dynamic subtest: gt1
[370.436592] Dynamic subtest gt1: SUCCESS (13.295s)
[370.439449] Subtest rc6-fence: SUCCESS (25.653s)
[370.526155] [061/133] (651s left) kms_plane_alpha_blend (alpha-transparent-fb)
[370.625793] Starting subtest: alpha-transparent-fb
[370.912638] Starting dynamic subtest: pipe-A-eDP-1
[371.548892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[371.557533] Starting dynamic subtest: pipe-D-eDP-1
[372.903019] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[372.905350] Subtest alpha-transparent-fb: SUCCESS (2.277s)
[373.723228] [062/133] (648s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[373.839516] Starting subtest: yf-tiled-64bpp-rotate-270
[373.844150] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[373.973059] [063/133] (647s left) perf (buffer-fill)
[374.099093] Starting subtest: buffer-fill
[374.101617] Starting dynamic subtest: 0-rcs0
[376.352176] Dynamic subtest 0-rcs0: SUCCESS (2.253s)
[376.360838] Starting dynamic subtest: 1-vcs0
[380.795817] Dynamic subtest 1-vcs0: SUCCESS (4.442s)
[380.798412] Subtest buffer-fill: SUCCESS (6.698s)
[380.844571] [064/133] (641s left) gen9_exec_parse (unaligned-access)
[380.907273] Subtest unaligned-access: SKIP (0.000s)
[380.987980] [065/133] (641s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[381.096389] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[381.100770] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[381.225328] [066/133] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[381.330489] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[381.334602] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[381.447030] [067/133] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[381.562097] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[381.566219] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[381.668546] [068/133] (640s left) gem_mmap_gtt (big-bo)
[381.727286] Subtest big-bo: SKIP (0.000s)
[381.790340] [069/133] (640s left) kms_lease (multimaster-lease)
[381.879606] Starting subtest: multimaster-lease
[381.883584] Subtest multimaster-lease: SUCCESS (0.007s)
[382.003338] [070/133] (640s left) gem_exec_params (cliprects_ptr-dirt)
[382.066136] Starting subtest: cliprects_ptr-dirt
[382.068022] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[382.181096] [071/133] (640s left) kms_chamelium_audio (dp-audio)
[382.567967] Subtest dp-audio: SKIP (0.000s)
[383.430029] [072/133] (638s left) kms_atomic (plane-overlay-legacy)
[383.519146] Starting subtest: plane-overlay-legacy
[383.521363] Starting dynamic subtest: pipe-A-eDP-1
[383.944026] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.425s)
[383.946280] Subtest plane-overlay-legacy: SUCCESS (0.426s)
[384.789194] [073/133] (637s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[384.882150] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[384.884352] Starting dynamic subtest: pipe-A-eDP-1
[384.906952] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[384.919144] Starting dynamic subtest: pipe-B-eDP-1
[384.940366] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[384.948151] Starting dynamic subtest: pipe-C-eDP-1
[384.969251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[384.976750] Starting dynamic subtest: pipe-D-eDP-1
[384.999488] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[385.003753] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[387.142846] [074/133] (635s left) gem_exec_reloc (basic-write-cpu)
[387.207904] Subtest basic-write-cpu: SKIP (0.000s)
[387.280435] [075/133] (635s left) gem_ctx_isolation (preservation-s3)
[387.339510] Starting subtest: preservation-S3
[387.341894] Starting dynamic subtest: rcs0
[403.460837] Dynamic subtest rcs0: SUCCESS (1.402s)
[403.476188] Starting dynamic subtest: bcs0
[419.431524] Dynamic subtest bcs0: SUCCESS (1.372s)
[419.442058] Starting dynamic subtest: vcs0
[435.422275] Dynamic subtest vcs0: SUCCESS (2.428s)
[435.431429] Starting dynamic subtest: vcs1
[453.416647] Dynamic subtest vcs1: SUCCESS (4.991s)
[453.427673] Starting dynamic subtest: vecs0
[471.436651] Dynamic subtest vecs0: SUCCESS (5.032s)
[471.445976] Starting dynamic subtest: ccs0
[489.437813] Dynamic subtest ccs0: SUCCESS (3.198s)
[489.440155] Subtest preservation-S3: SUCCESS (18.431s)
[489.710453] [076/133] (532s left) kms_psr (pr-primary-mmap-gtt)
[489.822137] Starting subtest: pr-primary-mmap-gtt
[489.826632] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[489.916593] [077/133] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[490.023049] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[513.003632] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.960s)
[513.148715] [078/133] (509s left) gem_ringfill (engines-basic)
[519.104539] Starting subtest: engines-basic
[519.107242] Starting dynamic subtest: rcs0
[519.175241] Dynamic subtest rcs0: SUCCESS (0.071s)
[519.187678] Starting dynamic subtest: bcs0
[519.220564] Dynamic subtest bcs0: SUCCESS (0.044s)
[519.231167] Starting dynamic subtest: vcs0
[519.264015] Dynamic subtest vcs0: SUCCESS (0.042s)
[519.274148] Starting dynamic subtest: vcs1
[519.307315] Dynamic subtest vcs1: SUCCESS (0.041s)
[519.317378] Starting dynamic subtest: vecs0
[519.351632] Dynamic subtest vecs0: SUCCESS (0.042s)
[519.362059] Starting dynamic subtest: ccs0
[519.397313] Dynamic subtest ccs0: SUCCESS (0.044s)
[519.399638] Subtest engines-basic: SUCCESS (0.296s)
[519.487688] [079/133] (503s left) gem_exec_fence (keep-in-fence)
[519.675174] Starting subtest: keep-in-fence
[519.677899] Starting dynamic subtest: rcs0
[519.767042] Dynamic subtest rcs0: SUCCESS (0.092s)
[519.778932] Starting dynamic subtest: bcs0
[519.824771] Dynamic subtest bcs0: SUCCESS (0.056s)
[519.836025] Starting dynamic subtest: vcs0
[521.085145] Dynamic subtest vcs0: SUCCESS (1.257s)
[521.097112] Starting dynamic subtest: vcs1
[523.132607] Dynamic subtest vcs1: SUCCESS (2.046s)
[523.145928] Starting dynamic subtest: vecs0
[525.117405] Dynamic subtest vecs0: SUCCESS (1.982s)
[525.129992] Starting dynamic subtest: ccs0
[525.352272] Dynamic subtest ccs0: SUCCESS (0.233s)
[525.355167] Subtest keep-in-fence: SUCCESS (5.681s)
[527.233986] [080/133] (495s left) syncobj_timeline (etime-single-wait-submitted)
[527.310810] Starting subtest: etime-single-wait-submitted
[527.417053] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[527.515514] [081/133] (495s left) fbdev (write)
[527.556986] Starting subtest: write
[528.135793] Subtest write: SUCCESS (0.576s)
[528.212617] [082/133] (494s left) gem_ctx_shared (create-shared-gtt)
[528.288980] Starting subtest: create-shared-gtt
[530.444426] Subtest create-shared-gtt: SUCCESS (2.154s)
[530.753402] [083/133] (492s left) kms_frontbuffer_tracking (basic)
[530.848896] Starting subtest: basic
[534.126919] Subtest basic: SUCCESS (3.283s)
[534.268103] [084/133] (488s left) gem_exec_balancer (bonded-semaphore)
[534.338181] Starting subtest: bonded-semaphore
[534.342174] Subtest bonded-semaphore: SKIP (0.000s)
[534.674476] [085/133] (488s left) kms_chamelium_edid (hdmi-edid-read)
[535.066432] Subtest hdmi-edid-read: SKIP (0.000s)
[535.866051] [086/133] (487s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[535.974653] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[542.728349] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.755s)
[542.900204] [087/133] (480s left) gem_exec_capture (capture-invisible)
[542.963252] Starting subtest: capture-invisible
[542.965561] Starting dynamic subtest: smem0
[542.969872] Dynamic subtest smem0: SKIP (0.000s)
[542.974227] Subtest capture-invisible: SKIP (0.001s)
[543.106712] [088/133] (479s left) kms_dsc (dsc-with-output-formats-with-bpc)
[543.209130] Starting subtest: dsc-with-output-formats-with-bpc
[543.264171] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[543.302968] [089/133] (479s left) api_intel_bb (purge-bb)
[543.371473] Starting subtest: purge-bb
[543.377584] Subtest purge-bb: SUCCESS (0.005s)
[543.529449] [090/133] (479s left) kms_flip (flip-vs-suspend-interruptible)
[543.618664] Starting subtest: flip-vs-suspend-interruptible
[543.620975] Starting dynamic subtest: A-eDP1
[592.396830] Dynamic subtest A-eDP1: SUCCESS (4.536s)
[592.410904] Starting dynamic subtest: B-eDP1
[641.397021] Dynamic subtest B-eDP1: SUCCESS (4.489s)
[641.411251] Starting dynamic subtest: C-eDP1
[690.400645] Dynamic subtest C-eDP1: SUCCESS (4.536s)
[690.415204] Starting dynamic subtest: D-eDP1
[739.414833] Dynamic subtest D-eDP1: SUCCESS (4.590s)
[739.417215] Subtest flip-vs-suspend-interruptible: SUCCESS (18.162s)
[740.569781] [091/133] (282s left) gem_shrink (reclaim)
[740.651097] Starting subtest: reclaim
[743.125860] Subtest reclaim: SUCCESS (2.475s)
[743.274072] [092/133] (279s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[743.384646] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[743.387359] Starting dynamic subtest: pipe-A-eDP-1
[749.252910] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.869s)
[749.263030] Starting dynamic subtest: pipe-B-eDP-1
[755.896972] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.639s)
[755.899578] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.511s)
[756.785888] [093/133] (266s left) kms_flip (flip-vs-fences)
[756.887041] Starting subtest: flip-vs-fences
[756.891858] Subtest flip-vs-fences: SKIP (0.000s)
[757.008506] [094/133] (266s left) kms_content_protection (srm)
[757.150260] Starting subtest: srm
[757.158190] Subtest srm: SKIP (0.003s)
[757.301300] [095/133] (265s left) kms_color (degamma)
[757.401267] Starting subtest: degamma
[757.403612] Starting dynamic subtest: pipe-A-eDP-1
[758.186987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s)
[758.199079] Starting dynamic subtest: pipe-B-eDP-1
[759.625834] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.440s)
[759.636254] Starting dynamic subtest: pipe-C-eDP-1
[760.974619] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.346s)
[760.986044] Starting dynamic subtest: pipe-D-eDP-1
[762.309644] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[762.312094] Subtest degamma: SUCCESS (4.906s)
[763.122725] [096/133] (260s left) kms_atomic_transition (plane-toggle-modeset-transition)
[763.215075] Starting subtest: plane-toggle-modeset-transition
[763.217517] Starting dynamic subtest: pipe-A-eDP-1
[775.969432] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.758s)
[775.981692] Starting dynamic subtest: pipe-B-eDP-1
[788.402447] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.430s)
[788.405419] Subtest plane-toggle-modeset-transition: SUCCESS (25.192s)
[789.235109] [097/133] (234s left) prime_mmap (test_aperture_limit)
[789.298973] Starting subtest: test_aperture_limit
[789.301076] Starting dynamic subtest: test_aperture_limit-smem
[789.309838] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[789.315245] Subtest test_aperture_limit: SKIP (0.009s)
[789.427636] [098/133] (233s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[789.522016] Starting subtest: fbc-psr2-primary-mmap-gtt
[789.524859] Starting dynamic subtest: eDP-1
[789.529902] Dynamic subtest eDP-1: SKIP (0.000s)
[789.534721] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[789.607577] [099/133] (233s left) gem_pxp (reject-modify-context-protection-off-1)
[789.732287] Starting subtest: reject-modify-context-protection-off-1
[789.735151] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[789.869661] [100/133] (233s left) vgem_basic (bad-handle)
[789.909115] Starting subtest: bad-handle
[789.911699] Subtest bad-handle: SUCCESS (0.000s)
[789.978505] [101/133] (233s left) kms_psr (psr2-dpms)
[790.063668] Starting subtest: psr2-dpms
[790.065983] Starting dynamic subtest: eDP-1
[792.957809] Dynamic subtest eDP-1: SUCCESS (2.894s)
[792.960774] Subtest psr2-dpms: SUCCESS (2.895s)
[793.846653] [102/133] (229s left) core_setmaster (master-drop-set-user)
[793.937138] Starting subtest: master-drop-set-user
[793.952057] Subtest master-drop-set-user: SUCCESS (0.014s)
[794.003977] [103/133] (229s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[794.106259] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[794.111826] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[794.232763] [104/133] (229s left) gem_exec_fence (syncobj-wait)
[794.667792] Starting subtest: syncobj-wait
[795.729739] Subtest syncobj-wait: SUCCESS (1.063s)
[796.112377] [105/133] (227s left) gem_close_race (multigpu-basic-threads)
[796.171255] Starting subtest: multigpu-basic-threads
[796.176829] Subtest multigpu-basic-threads: SKIP (0.000s)
[796.446597] [106/133] (227s left) gem_exec_schedule (preemptive-hang)
[796.635171] Starting subtest: preemptive-hang
[796.637957] Starting dynamic subtest: rcs0
[805.878497] Dynamic subtest rcs0: SUCCESS (9.239s)
[805.888680] Starting dynamic subtest: bcs0
[814.902087] Dynamic subtest bcs0: SUCCESS (9.016s)
[814.914799] Starting dynamic subtest: vcs0
[823.859286] Dynamic subtest vcs0: SUCCESS (8.954s)
[823.869839] Starting dynamic subtest: vcs1
[832.822041] Dynamic subtest vcs1: SUCCESS (8.958s)
[832.831814] Starting dynamic subtest: vecs0
[841.842394] Dynamic subtest vecs0: SUCCESS (9.014s)
[841.858583] Starting dynamic subtest: ccs0
[850.867376] Dynamic subtest ccs0: SUCCESS (9.022s)
[850.870260] Subtest preemptive-hang: SUCCESS (54.212s)
[851.140944] [107/133] (172s left) gem_mmap_wc (write-wc-read-gtt)
[851.211255] Subtest write-wc-read-gtt: SKIP (0.000s)
[851.273506] [108/133] (172s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[851.382272] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[858.699988] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.318s)
[858.869658] [109/133] (165s left) gem_lmem_swapping (massive-random)
[858.909317] Subtest massive-random: SKIP (0.000s)
[858.956577] [110/133] (164s left) gem_exec_async (forked-writes)
[859.019118] Starting subtest: forked-writes
[859.021984] Starting dynamic subtest: rcs0
[859.047159] Dynamic subtest rcs0: SUCCESS (0.027s)
[859.058074] Starting dynamic subtest: bcs0
[859.071239] Dynamic subtest bcs0: SUCCESS (0.023s)
[859.081055] Starting dynamic subtest: vcs0
[859.090991] Dynamic subtest vcs0: SUCCESS (0.019s)
[859.101304] Starting dynamic subtest: vcs1
[859.115308] Dynamic subtest vcs1: SUCCESS (0.023s)
[859.125386] Starting dynamic subtest: vecs0
[859.137064] Dynamic subtest vecs0: SUCCESS (0.021s)
[859.147079] Starting dynamic subtest: ccs0
[859.160342] Dynamic subtest ccs0: SUCCESS (0.022s)
[859.163151] Subtest forked-writes: SUCCESS (0.141s)
[859.418572] [111/133] (164s left) gem_exec_params (secure-non-master)
[859.482275] Starting subtest: secure-non-master
[859.487898] Subtest secure-non-master: SKIP (0.000s)
[859.597762] [112/133] (164s left) kms_invalid_mode (uint-max-clock)
[859.693914] Starting subtest: uint-max-clock
[859.696419] Starting dynamic subtest: pipe-A-eDP-1
[859.977696] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[859.988190] Starting dynamic subtest: pipe-B-eDP-1
[859.990657] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[860.000188] Starting dynamic subtest: pipe-C-eDP-1
[860.003110] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[860.012285] Starting dynamic subtest: pipe-D-eDP-1
[860.015249] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[860.018312] Subtest uint-max-clock: SUCCESS (0.291s)
[860.797103] [113/133] (163s left) perf (invalid-create-userspace-config)
[860.900409] Starting subtest: invalid-create-userspace-config
[860.903270] Subtest invalid-create-userspace-config: SUCCESS (0.002s)
[860.944918] [114/133] (163s left) gem_mmap_offset (mmap-unmap)
[861.000993] Starting subtest: mmap-unmap
[861.003280] Starting dynamic subtest: smem0
[884.321544] Dynamic subtest smem0: SUCCESS (23.328s)
[884.324281] Subtest mmap-unmap: SUCCESS (23.330s)
[884.481418] [115/133] (139s left) gem_exec_suspend (basic-s0)
[884.540849] Starting subtest: basic-S0
[884.543305] Starting dynamic subtest: smem
[904.269701] Dynamic subtest smem: SUCCESS (6.151s)
[904.274443] Subtest basic-S0: SUCCESS (6.153s)
[904.463885] [116/133] (119s left) prime_self_import (basic-with_one_bo)
[904.513162] Starting subtest: basic-with_one_bo
[904.535454] Subtest basic-with_one_bo: SUCCESS (0.025s)
[904.675872] [117/133] (119s left) kms_cursor_crc (cursor-onscreen-max-size)
[904.975930] Starting subtest: cursor-onscreen-max-size
[904.982753] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[905.133880] [118/133] (119s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[905.270412] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[905.275594] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[905.398990] [119/133] (118s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[905.490189] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[905.492793] Starting dynamic subtest: pipe-A
[905.826618] Dynamic subtest pipe-A: SUCCESS (0.338s)
[905.836027] Starting dynamic subtest: pipe-B
[907.267612] Dynamic subtest pipe-B: SUCCESS (1.436s)
[907.277435] Starting dynamic subtest: pipe-C
[908.703643] Dynamic subtest pipe-C: SUCCESS (1.432s)
[908.713425] Starting dynamic subtest: pipe-D
[910.139209] Dynamic subtest pipe-D: SUCCESS (1.432s)
[910.141840] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.642s)
[911.313312] [120/133] (113s left) kms_addfb_basic (small-bo)
[911.419453] Starting subtest: small-bo
[911.422135] Subtest small-bo: SUCCESS (0.000s)
[911.545220] [121/133] (112s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[911.660335] Starting subtest: fbc-rgb101010-draw-mmap-wc
[916.240488] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.579s)
[917.436670] [122/133] (107s left) kms_psr (psr-primary-blt)
[917.534218] Starting subtest: psr-primary-blt
[917.536534] Starting dynamic subtest: eDP-1
[919.308787] Dynamic subtest eDP-1: SUCCESS (1.773s)
[919.311344] Subtest psr-primary-blt: SUCCESS (1.774s)
[920.195043] [123/133] (104s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[920.305571] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[920.308129] Starting dynamic subtest: pipe-A-eDP-1
[920.437279] Dynamic subtest pipe-A-eDP-1: SKIP (0.134s)
[920.447715] Starting dynamic subtest: pipe-B-eDP-1
[921.648862] Dynamic subtest pipe-B-eDP-1: SKIP (1.207s)
[921.654483] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.343s)
[922.948123] [124/133] (101s left) kms_pm_rpm (basic-rte)
[922.992320] Starting subtest: basic-rte
[925.940475] Subtest basic-rte: SUCCESS (2.947s)
[927.735133] [125/133] ( 96s left) gen9_exec_parse (batch-without-end)
[927.796024] Subtest batch-without-end: SKIP (0.000s)
[927.876676] [126/133] ( 96s left) gem_workarounds (basic-read-fd)
[927.940358] Starting subtest: basic-read-fd
[927.954336] Subtest basic-read-fd: SUCCESS (0.013s)
[928.102610] [127/133] ( 96s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[928.193389] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[928.199031] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[928.282207] [128/133] ( 96s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[928.384889] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[928.389379] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[928.491501] [129/133] ( 96s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[928.603615] Starting subtest: x-tiled-16bpp-rotate-0
[929.839348] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.234s)
[929.963961] [130/133] ( 94s left) gem_lmem_swapping (random-engines)
[930.008786] Subtest random-engines: SKIP (0.000s)
[930.057085] [131/133] ( 94s left) perf (global-sseu-config)
[930.156579] Starting subtest: global-sseu-config
[930.160570] Subtest global-sseu-config: SKIP (0.000s)
[930.198678] [132/133] ( 94s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[930.302978] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[931.117616] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s)
[931.305868] [133/133] ( 93s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[931.357690] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[931.360097] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[931.478271] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_vblank
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_atomic_interruptible
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: i915_query
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: prime_vgem
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: sw_sync
results: parsing output: 16/ for test: i915_drm_fdinfo
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_hdr
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: i915_suspend
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: gem_userptr_blits
results: parsing output: 28/ for test: syncobj_eventfd
results: parsing output: 29/ for test: kms_rotation_crc
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: gem_softpin
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_dither
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: gem_fenced_exec_thrash
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: kms_atomic_transition
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_panel_fitting
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_wait
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: i915_pm_rc6_residency
results: parsing output: 60/ for test: kms_plane_alpha_blend
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_chamelium_audio
results: parsing output: 71/ for test: kms_atomic
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: gem_ctx_isolation
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ringfill
results: parsing output: 78/ for test: gem_exec_fence
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: gem_ctx_shared
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: kms_chamelium_edid
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_capture
results: parsing output: 87/ for test: kms_dsc
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_shrink
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_content_protection
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: prime_mmap
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: vgem_basic
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: core_setmaster
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: gem_close_race
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_lmem_swapping
results: parsing output: 109/ for test: gem_exec_async
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_invalid_mode
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: gem_mmap_offset
results: parsing output: 114/ for test: gem_exec_suspend
results: parsing output: 115/ for test: prime_self_import
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: gem_workarounds
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: perf
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: syncobj_wait
Done.