[60.983475] Initializing watchdogs
[60.983520]   /dev/watchdog0
[60.998127] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[61.002645] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.006737] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.008930] [001/133] (960s left) kms_flip (2x-plain-flip-interruptible)
[61.111554] Starting subtest: 2x-plain-flip-interruptible
[61.123301] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[61.235989] [002/133] (960s left) kms_pm_rpm (modeset-non-lpsp-stress)
[64.303089] Starting subtest: modeset-non-lpsp-stress
[65.460248] Subtest modeset-non-lpsp-stress: SKIP (1.154s)
[65.841068] [003/133] (955s left) kms_plane_scaling (2x-scaler-multi-pipe)
[65.948802] Starting subtest: 2x-scaler-multi-pipe
[65.950799] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[66.066254] [004/133] (955s left) kms_vblank (query-busy)
[66.157054] Starting subtest: query-busy
[66.157997] Starting dynamic subtest: pipe-A-eDP-1
[68.057063] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[68.065714] Starting dynamic subtest: pipe-D-eDP-1
[70.607127] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[70.608147] Subtest query-busy: SUCCESS (4.440s)
[71.400912] [005/133] (950s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[71.512604] Starting subtest: 4-tiled-32bpp-rotate-270
[71.531086] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.018s)
[71.671967] [006/133] (949s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[71.759409] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[71.761376] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[71.866350] [007/133] (949s left) kms_atomic_interruptible (atomic-setmode)
[71.967517] Starting subtest: atomic-setmode
[71.968459] Starting dynamic subtest: pipe-A-eDP-1
[78.871902] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.896s)
[78.873043] Subtest atomic-setmode: SUCCESS (6.897s)
[79.680973] [008/133] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[79.775030] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[79.776842] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[79.908519] [009/133] (941s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[80.006299] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[80.007997] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[80.116030] [010/133] (941s left) gem_mmap_gtt (basic-short)
[80.170023] Subtest basic-short: SKIP (0.000s)
[80.229102] [011/133] (941s left) i915_query (query-topology-coherent-slice-mask)
[80.277143] Starting subtest: query-topology-coherent-slice-mask
[80.279031] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[80.377612] [012/133] (941s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[80.471959] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[80.473831] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[80.559270] [013/133] (941s left) syncobj_wait (wait-all-complex)
[80.610141] Starting subtest: wait-all-complex
[80.831878] Subtest wait-all-complex: SUCCESS (0.212s)
[80.901926] [014/133] (940s left) prime_vgem (wait)
[80.994106] Starting subtest: wait
[80.995222] Starting dynamic subtest: rcs0
[81.053157] Dynamic subtest rcs0: SUCCESS (0.060s)
[81.058776] Starting dynamic subtest: bcs0
[81.124165] Dynamic subtest bcs0: SUCCESS (0.071s)
[81.129945] Starting dynamic subtest: vcs0
[81.170206] Dynamic subtest vcs0: SUCCESS (0.046s)
[81.175898] Starting dynamic subtest: vcs1
[81.215084] Dynamic subtest vcs1: SUCCESS (0.044s)
[81.220898] Starting dynamic subtest: vecs0
[81.259219] Dynamic subtest vecs0: SUCCESS (0.044s)
[81.264900] Starting dynamic subtest: ccs0
[81.306678] Dynamic subtest ccs0: SUCCESS (0.047s)
[81.307667] Subtest wait: SUCCESS (0.314s)
[81.450811] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[81.452391] [015/133] (940s left) kms_flip (absolute-wf_vblank-interruptible)
[81.549834] Starting subtest: absolute-wf_vblank-interruptible
[81.551131] Starting dynamic subtest: A-eDP1
[90.261153] Dynamic subtest A-eDP1: SUCCESS (8.678s)
[90.269588] Starting dynamic subtest: B-eDP1
[99.001309] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[99.009251] Starting dynamic subtest: C-eDP1
[107.733958] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[107.742603] Starting dynamic subtest: D-eDP1
[116.428990] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[116.432482] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.867s)
[117.658009] [016/133] (904s left) sw_sync (sync_busy_fork)
[117.695984] Starting subtest: sync_busy_fork
[118.717084] Subtest sync_busy_fork: SUCCESS (1.011s)
[118.785607] [017/133] (903s left) i915_drm_fdinfo (virtual-busy-idle-all)
[118.828523] Starting subtest: virtual-busy-idle-all
[118.830465] Subtest virtual-busy-idle-all: SKIP (0.000s)
[118.896642] [018/133] (903s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[119.076072] Starting subtest: cursor-rapid-movement-64x64
[119.078059] Starting dynamic subtest: pipe-A-eDP-1
[119.619309] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[119.645995] Starting dynamic subtest: pipe-D-eDP-1
[120.854774] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[120.855684] Subtest cursor-rapid-movement-64x64: SUCCESS (1.779s)
[121.728180] [019/133] (900s left) kms_cursor_crc (cursor-suspend)
[121.856729] Starting subtest: cursor-suspend
[121.857812] Starting dynamic subtest: pipe-A-eDP-1
[156.125479] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.016s)
[156.133093] Starting dynamic subtest: pipe-D-eDP-1
[191.135785] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.551s)
[191.136759] Subtest cursor-suspend: SUCCESS (8.569s)
[197.036481] [020/133] (830s left) kms_psr (fbc-psr-cursor-plane-onoff)
[197.135704] Starting subtest: fbc-psr-cursor-plane-onoff
[197.136685] Starting dynamic subtest: eDP-1
[197.138445] Dynamic subtest eDP-1: SKIP (0.000s)
[197.140168] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[197.216561] [021/133] (829s left) kms_hdr (brightness-with-hdr)
[197.300475] Starting subtest: brightness-with-hdr
[197.303304] Subtest brightness-with-hdr: SKIP (0.000s)
[197.385928] [022/133] (829s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[197.781124] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[198.648581] [023/133] (828s left) i915_suspend (basic-s2idle-without-i915)
[198.679608] Starting subtest: basic-s2idle-without-i915
[220.190692] Subtest basic-s2idle-without-i915: SUCCESS (6.066s)
[224.365288] [024/133] (806s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[224.477664] Starting subtest: y-tiled-addfb-size-offset-overflow
[224.479673] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[224.581328] [025/133] (806s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[224.678625] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[224.679610] Starting dynamic subtest: pipe-A-eDP-1
[224.683273] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.693911] Starting dynamic subtest: pipe-B-eDP-1
[224.697799] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.706662] Starting dynamic subtest: pipe-C-eDP-1
[224.710325] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.716493] Starting dynamic subtest: pipe-D-eDP-1
[224.720041] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.721753] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[226.875633] [026/133] (804s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[226.974544] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[226.975460] Starting dynamic subtest: pipe-A-default-mode
[229.790783] Dynamic subtest pipe-A-default-mode: SUCCESS (2.758s)
[229.791594] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.760s)
[230.657806] [027/133] (800s left) gem_userptr_blits (stress-mm-invalidate-close)
[230.730507] Starting subtest: stress-mm-invalidate-close
[232.952745] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[233.053441] [028/133] (798s left) gem_userptr_blits (relocations)
[233.116405] Starting subtest: relocations
[233.118065] Subtest relocations: SKIP (0.000s)
[233.266561] [029/133] (798s left) syncobj_eventfd (timeline-wait-signaled)
[233.324443] Starting subtest: timeline-wait-signaled
[233.325489] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[233.443963] [030/133] (798s left) kms_rotation_crc (exhaust-fences)
[233.536509] Starting subtest: exhaust-fences
[233.538234] Subtest exhaust-fences: SKIP (0.000s)
[233.632386] [031/133] (797s left) kms_addfb_basic (addfb25-4-tiled)
[233.731507] Starting subtest: addfb25-4-tiled
[233.732488] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[233.858796] [032/133] (797s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[233.985813] Starting subtest: cursorB-vs-flipA-legacy
[233.988737] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[234.140893] [033/133] (797s left) gem_partial_pwrite_pread (reads-display)
[234.197819] Subtest reads-display: SKIP (0.000s)
[234.271571] [034/133] (797s left) gem_softpin (evict-active-interruptible)
[234.334610] Starting subtest: evict-active-interruptible
[234.340747] Subtest evict-active-interruptible: SUCCESS (0.006s)
[234.490415] [035/133] (797s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[234.585526] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[234.587410] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[234.664230] [036/133] (797s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[234.756750] Starting subtest: fb-8bpc-vs-panel-8bpc
[234.757944] Starting dynamic subtest: pipe-A-eDP-1
[236.151177] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.382s)
[236.152117] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.384s)
[236.969083] [037/133] (794s left) syncobj_timeline (wait-all-snapshot)
[237.028903] Starting subtest: wait-all-snapshot
[237.110559] Subtest wait-all-snapshot: SUCCESS (0.081s)
[237.204875] [038/133] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[237.305995] Starting subtest: fbcpsr-2p-rte
[237.307990] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[237.445510] [039/133] (794s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[237.545491] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[237.546413] Starting dynamic subtest: pipe-A-eDP-1
[237.776626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.219s)
[237.785515] Starting dynamic subtest: pipe-B-eDP-1
[239.015203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s)
[239.022624] Starting dynamic subtest: pipe-C-eDP-1
[240.253156] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.231s)
[240.260482] Starting dynamic subtest: pipe-D-eDP-1
[241.475485] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[241.476238] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.900s)
[242.725521] [040/133] (789s left) sw_sync (sync_busy_fork_unixsocket)
[242.755738] Starting subtest: sync_busy_fork_unixsocket
[242.762243] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[242.829436] [041/133] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[242.924985] Starting subtest: psr-2p-primscrn-cur-indfb-move
[242.926906] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[243.040887] [042/133] (788s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[243.139432] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[243.141041] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[243.229433] [043/133] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[243.318926] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[243.320533] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[243.449775] [044/133] (788s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[243.553598] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[244.558002] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.002s)
[244.699809] [045/133] (787s left) kms_vblank (ts-continuation-modeset-hang)
[244.793592] Starting subtest: ts-continuation-modeset-hang
[244.795137] Starting dynamic subtest: pipe-A-eDP-1
[271.744134] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.931s)
[271.752918] Starting dynamic subtest: pipe-D-eDP-1
[286.712945] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.961s)
[286.714066] Subtest ts-continuation-modeset-hang: SUCCESS (41.897s)
[287.584129] [046/133] (744s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[287.688580] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[287.690353] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[287.806106] [047/133] (744s left) gem_spin_batch (engines)
[287.875900] Starting subtest: engines
[287.876957] Starting dynamic subtest: rcs0
[291.126483] Dynamic subtest rcs0: SUCCESS (3.238s)
[291.135564] Starting dynamic subtest: bcs0
[294.399383] Dynamic subtest bcs0: SUCCESS (3.233s)
[294.408584] Starting dynamic subtest: vcs0
[297.635187] Dynamic subtest vcs0: SUCCESS (3.233s)
[297.644501] Starting dynamic subtest: vcs1
[300.873055] Dynamic subtest vcs1: SUCCESS (3.234s)
[300.882601] Starting dynamic subtest: vecs0
[304.112424] Dynamic subtest vecs0: SUCCESS (3.236s)
[304.121671] Starting dynamic subtest: ccs0
[307.349484] Dynamic subtest ccs0: SUCCESS (3.233s)
[307.350845] Subtest engines: SUCCESS (19.420s)
[307.594645] [048/133] (724s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[307.668321] Subtest no-spare-fences-busy: SKIP (0.000s)
[307.753663] [049/133] (724s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[307.810506] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[307.811652] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[307.912978] [050/133] (724s left) gem_exec_schedule (submit-golden-slice)
[307.972110] Starting subtest: submit-golden-slice
[307.973038] Starting dynamic subtest: rcs0
[308.028829] Dynamic subtest rcs0: SUCCESS (0.056s)
[308.040776] Starting dynamic subtest: bcs0
[308.077349] Dynamic subtest bcs0: SUCCESS (0.048s)
[308.087684] Starting dynamic subtest: vcs0
[308.128970] Dynamic subtest vcs0: SUCCESS (0.051s)
[308.137229] Starting dynamic subtest: vcs1
[308.174783] Dynamic subtest vcs1: SUCCESS (0.045s)
[308.184411] Starting dynamic subtest: vecs0
[308.217130] Dynamic subtest vecs0: SUCCESS (0.042s)
[308.226013] Starting dynamic subtest: ccs0
[308.259992] Dynamic subtest ccs0: SUCCESS (0.042s)
[308.261023] Subtest submit-golden-slice: SUCCESS (0.288s)
[309.997321] [051/133] (722s left) perf (oa-formats)
[310.122561] Starting subtest: oa-formats
[310.123466] Starting dynamic subtest: 0-rcs0
[310.138106] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[310.145356] Starting dynamic subtest: 1-vcs1
[310.161561] Dynamic subtest 1-vcs1: SUCCESS (0.023s)
[310.162669] Subtest oa-formats: SUCCESS (0.040s)
[310.208640] [052/133] (722s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[310.305238] Starting subtest: plane-all-modeset-transition-fencing
[310.306870] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[310.391341] [053/133] (721s left) api_intel_allocator (open-vm)
[310.447299] Starting subtest: open-vm
[310.450488] Subtest open-vm: SUCCESS (0.003s)
[310.574829] [054/133] (721s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[310.665571] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[310.666501] Starting dynamic subtest: pipe-A-eDP-1
[311.471529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.803s)
[311.478805] Starting dynamic subtest: pipe-B-eDP-1
[313.010343] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.537s)
[313.017434] Starting dynamic subtest: pipe-C-eDP-1
[314.480428] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.468s)
[314.487534] Starting dynamic subtest: pipe-D-eDP-1
[315.966993] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.484s)
[315.967938] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.297s)
[317.213500] [055/133] (715s left) kms_panel_fitting (legacy)
[317.308354] Starting subtest: legacy
[317.309161] Starting dynamic subtest: pipe-A-eDP-1
[317.838188] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[317.865890] Starting dynamic subtest: pipe-B-eDP-1
[319.361298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s)
[319.387381] Starting dynamic subtest: pipe-C-eDP-1
[320.863878] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.480s)
[320.892240] Starting dynamic subtest: pipe-D-eDP-1
[322.415037] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[322.416003] Subtest legacy: SUCCESS (5.107s)
[323.643305] [056/133] (708s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[323.747963] Starting subtest: psr-rgb101010-draw-mmap-wc
[330.781256] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.037s)
[330.902988] [057/133] (701s left) gem_wait (busy)
[330.973510] Starting subtest: busy
[330.974597] Starting dynamic subtest: all-engines
[332.923052] Dynamic subtest all-engines: SUCCESS (1.941s)
[332.931939] Starting dynamic subtest: rcs0
[333.458967] Dynamic subtest rcs0: SUCCESS (0.542s)
[333.468384] Starting dynamic subtest: bcs0
[333.999064] Dynamic subtest bcs0: SUCCESS (0.539s)
[334.008913] Starting dynamic subtest: vcs0
[335.867696] Dynamic subtest vcs0: SUCCESS (1.859s)
[335.876857] Starting dynamic subtest: vcs1
[337.914719] Dynamic subtest vcs1: SUCCESS (2.044s)
[337.923410] Starting dynamic subtest: vecs0
[339.898442] Dynamic subtest vecs0: SUCCESS (1.981s)
[339.907472] Starting dynamic subtest: ccs0
[340.432775] Dynamic subtest ccs0: SUCCESS (0.541s)
[340.433946] Subtest busy: SUCCESS (9.462s)
[340.636551] [058/133] (691s left) perf_pmu (module-unload)
[340.737346] Starting subtest: module-unload
[347.609512] Subtest module-unload: FAIL (6.840s)
[347.629393] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[347.630111] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[347.631536] [059/133] (684s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[349.126637] Starting subtest: multi-wait-for-submit-available-signaled
[349.127667] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[349.211973] [FACT syncobj_timeline (multi-wait-for-submit-available-signaled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[349.213331] [FACT syncobj_timeline (multi-wait-for-submit-available-signaled)] new: kernel.kmod_is_loaded.i915: true
[349.215854] [060/133] (683s left) i915_pm_rc6_residency (rc6-fence)
[349.272523] Starting subtest: rc6-fence
[349.302671] Starting dynamic subtest: gt0
[361.641249] Dynamic subtest gt0: SUCCESS (12.328s)
[361.649172] Starting dynamic subtest: gt1
[375.867476] Dynamic subtest gt1: SUCCESS (14.221s)
[375.868623] Subtest rc6-fence: SUCCESS (26.585s)
[375.942033] [061/133] (656s left) kms_plane_alpha_blend (alpha-transparent-fb)
[376.057267] Starting subtest: alpha-transparent-fb
[376.370047] Starting dynamic subtest: pipe-A-eDP-1
[377.004717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s)
[377.011940] Starting dynamic subtest: pipe-D-eDP-1
[378.397530] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.390s)
[378.398397] Subtest alpha-transparent-fb: SUCCESS (2.340s)
[379.195961] [062/133] (653s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[379.294860] Starting subtest: yf-tiled-64bpp-rotate-270
[379.296843] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[379.412964] [063/133] (653s left) perf (buffer-fill)
[379.534124] Starting subtest: buffer-fill
[379.534981] Starting dynamic subtest: 0-rcs0
[381.792017] Dynamic subtest 0-rcs0: SUCCESS (2.257s)
[381.799810] Starting dynamic subtest: 1-vecs0
[386.240736] Dynamic subtest 1-vecs0: SUCCESS (4.439s)
[386.241672] Subtest buffer-fill: SUCCESS (6.698s)
[386.276682] [064/133] (646s left) gen9_exec_parse (unaligned-access)
[386.330571] Subtest unaligned-access: SKIP (0.000s)
[386.409479] [065/133] (646s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[386.508706] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[386.510591] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[386.610070] [066/133] (646s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[386.701281] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[386.702980] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[386.807147] [067/133] (645s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[386.911699] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[386.913413] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[387.027869] [068/133] (645s left) gem_mmap_gtt (big-bo)
[387.075818] Subtest big-bo: SKIP (0.000s)
[387.141968] [069/133] (645s left) kms_lease (multimaster-lease)
[387.231361] Starting subtest: multimaster-lease
[387.233159] Subtest multimaster-lease: SUCCESS (0.003s)
[387.360765] [070/133] (645s left) gem_exec_params (cliprects_ptr-dirt)
[387.423104] Starting subtest: cliprects_ptr-dirt
[387.424344] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[387.539932] [071/133] (645s left) kms_chamelium_audio (dp-audio)
[387.921093] Subtest dp-audio: SKIP (0.000s)
[388.697927] [072/133] (644s left) kms_atomic (plane-overlay-legacy)
[388.801222] Starting subtest: plane-overlay-legacy
[388.802312] Starting dynamic subtest: pipe-A-eDP-1
[389.227477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[389.228366] Subtest plane-overlay-legacy: SUCCESS (0.427s)
[390.075831] [073/133] (642s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[390.186207] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[390.187098] Starting dynamic subtest: pipe-A-eDP-1
[390.195499] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[390.203122] Starting dynamic subtest: pipe-B-eDP-1
[390.211686] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[390.219067] Starting dynamic subtest: pipe-C-eDP-1
[390.227418] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[390.234129] Starting dynamic subtest: pipe-D-eDP-1
[390.242568] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[390.244285] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.011s)
[392.460461] [074/133] (640s left) gem_exec_reloc (basic-write-cpu)
[392.520988] Subtest basic-write-cpu: SKIP (0.000s)
[392.593634] [075/133] (640s left) gem_ctx_isolation (preservation-s3)
[392.644302] Starting subtest: preservation-S3
[392.645148] Starting dynamic subtest: rcs0
[408.708207] Dynamic subtest rcs0: SUCCESS (1.703s)
[408.717097] Starting dynamic subtest: bcs0
[425.716323] Dynamic subtest bcs0: SUCCESS (1.748s)
[425.726216] Starting dynamic subtest: vcs0
[442.723162] Dynamic subtest vcs0: SUCCESS (3.242s)
[442.731538] Starting dynamic subtest: vcs1
[460.723986] Dynamic subtest vcs1: SUCCESS (4.993s)
[460.733001] Starting dynamic subtest: vecs0
[478.726528] Dynamic subtest vecs0: SUCCESS (5.075s)
[478.734048] Starting dynamic subtest: ccs0
[496.724356] Dynamic subtest ccs0: SUCCESS (3.160s)
[496.725357] Subtest preservation-S3: SUCCESS (19.926s)
[503.029699] [076/133] (536s left) kms_psr (pr-primary-mmap-gtt)
[503.137082] Starting subtest: pr-primary-mmap-gtt
[503.139051] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[503.225403] [077/133] (535s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[503.332153] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[526.619200] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.970s)
[526.763228] [078/133] (512s left) gem_ringfill (engines-basic)
[532.085442] Starting subtest: engines-basic
[532.086490] Starting dynamic subtest: rcs0
[532.133302] Dynamic subtest rcs0: SUCCESS (0.054s)
[532.144811] Starting dynamic subtest: bcs0
[532.176228] Dynamic subtest bcs0: SUCCESS (0.041s)
[532.186269] Starting dynamic subtest: vcs0
[532.218404] Dynamic subtest vcs0: SUCCESS (0.040s)
[532.228407] Starting dynamic subtest: vcs1
[532.262543] Dynamic subtest vcs1: SUCCESS (0.042s)
[532.272617] Starting dynamic subtest: vecs0
[532.305423] Dynamic subtest vecs0: SUCCESS (0.041s)
[532.315698] Starting dynamic subtest: ccs0
[532.351802] Dynamic subtest ccs0: SUCCESS (0.044s)
[532.353548] Subtest engines-basic: SUCCESS (0.274s)
[532.434959] [079/133] (506s left) gem_exec_fence (keep-in-fence)
[532.629494] Starting subtest: keep-in-fence
[532.630361] Starting dynamic subtest: rcs0
[532.715869] Dynamic subtest rcs0: SUCCESS (0.091s)
[532.727590] Starting dynamic subtest: bcs0
[532.772933] Dynamic subtest bcs0: SUCCESS (0.055s)
[532.784666] Starting dynamic subtest: vcs0
[534.066647] Dynamic subtest vcs0: SUCCESS (1.281s)
[534.074826] Starting dynamic subtest: vcs1
[536.050624] Dynamic subtest vcs1: SUCCESS (1.980s)
[536.059324] Starting dynamic subtest: vecs0
[538.034559] Dynamic subtest vecs0: SUCCESS (1.981s)
[538.043225] Starting dynamic subtest: ccs0
[538.251362] Dynamic subtest ccs0: SUCCESS (0.223s)
[538.252772] Subtest keep-in-fence: SUCCESS (5.625s)
[540.183653] [080/133] (499s left) syncobj_timeline (etime-single-wait-submitted)
[540.240656] Starting subtest: etime-single-wait-submitted
[540.349801] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[540.433971] [081/133] (498s left) fbdev (write)
[540.478457] Starting subtest: write
[540.930885] Subtest write: SUCCESS (0.443s)
[540.996141] [082/133] (498s left) gem_ctx_shared (create-shared-gtt)
[541.063731] Starting subtest: create-shared-gtt
[543.262249] Subtest create-shared-gtt: SUCCESS (2.154s)
[543.507181] [083/133] (495s left) kms_frontbuffer_tracking (basic)
[543.601617] Starting subtest: basic
[546.885147] Subtest basic: SUCCESS (3.283s)
[547.021217] [084/133] (492s left) gem_exec_balancer (bonded-semaphore)
[547.078108] Starting subtest: bonded-semaphore
[547.079774] Subtest bonded-semaphore: SKIP (0.000s)
[547.410645] [085/133] (491s left) kms_chamelium_edid (hdmi-edid-read)
[547.784028] Subtest hdmi-edid-read: SKIP (0.000s)
[548.628204] [086/133] (490s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[548.725976] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[555.502424] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.774s)
[555.643331] [087/133] (483s left) gem_exec_capture (capture-invisible)
[555.709098] Starting subtest: capture-invisible
[555.710120] Starting dynamic subtest: smem0
[555.712891] Dynamic subtest smem0: SKIP (0.000s)
[555.714659] Subtest capture-invisible: SKIP (0.001s)
[555.837026] [088/133] (483s left) kms_dsc (dsc-with-output-formats-with-bpc)
[555.932787] Starting subtest: dsc-with-output-formats-with-bpc
[555.953600] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[556.012399] [089/133] (483s left) api_intel_bb (purge-bb)
[556.065210] Starting subtest: purge-bb
[556.072184] Subtest purge-bb: SUCCESS (0.007s)
[556.219148] [090/133] (483s left) kms_flip (flip-vs-suspend-interruptible)
[556.304861] Starting subtest: flip-vs-suspend-interruptible
[556.307072] Starting dynamic subtest: A-eDP1
[589.694280] Dynamic subtest A-eDP1: SUCCESS (4.191s)
[589.703325] Starting dynamic subtest: B-eDP1
[623.697259] Dynamic subtest B-eDP1: SUCCESS (4.158s)
[623.709139] Starting dynamic subtest: C-eDP1
[657.699560] Dynamic subtest C-eDP1: SUCCESS (4.181s)
[657.708537] Starting dynamic subtest: D-eDP1
[691.703577] Dynamic subtest D-eDP1: SUCCESS (4.177s)
[691.707258] Subtest flip-vs-suspend-interruptible: SUCCESS (16.717s)
[697.942560] [091/133] (346s left) gem_shrink (reclaim)
[698.012350] Starting subtest: reclaim
[700.569598] Subtest reclaim: SUCCESS (2.461s)
[700.734379] [092/133] (343s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[700.839946] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[700.841058] Starting dynamic subtest: pipe-A-eDP-1
[706.783441] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.798s)
[706.793856] Starting dynamic subtest: pipe-B-eDP-1
[713.536566] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.675s)
[713.538007] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.476s)
[714.423221] [093/133] (330s left) kms_flip (flip-vs-fences)
[714.526930] Starting subtest: flip-vs-fences
[714.528995] Subtest flip-vs-fences: SKIP (0.000s)
[714.658887] [094/133] (330s left) kms_content_protection (srm)
[714.806671] Starting subtest: srm
[714.809912] Subtest srm: SKIP (0.002s)
[714.964646] [095/133] (329s left) kms_color (degamma)
[715.052857] Starting subtest: degamma
[715.053848] Starting dynamic subtest: pipe-A-eDP-1
[715.777863] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[715.790146] Starting dynamic subtest: pipe-B-eDP-1
[717.293832] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.509s)
[717.301894] Starting dynamic subtest: pipe-C-eDP-1
[718.637226] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.330s)
[718.647808] Starting dynamic subtest: pipe-D-eDP-1
[719.978993] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[719.980368] Subtest degamma: SUCCESS (4.904s)
[720.775863] [096/133] (324s left) kms_atomic_transition (plane-toggle-modeset-transition)
[720.860120] Starting subtest: plane-toggle-modeset-transition
[720.861205] Starting dynamic subtest: pipe-A-eDP-1
[733.685837] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.805s)
[733.695356] Starting dynamic subtest: pipe-B-eDP-1
[746.161519] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.468s)
[746.162948] Subtest plane-toggle-modeset-transition: SUCCESS (25.278s)
[746.971803] [097/133] (297s left) prime_mmap (test_aperture_limit)
[747.034080] Starting subtest: test_aperture_limit
[747.035043] Starting dynamic subtest: test_aperture_limit-smem
[747.043567] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[747.045740] Subtest test_aperture_limit: SKIP (0.009s)
[747.166912] [098/133] (297s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[747.267161] Starting subtest: fbc-psr2-primary-mmap-gtt
[747.268012] Starting dynamic subtest: eDP-1
[747.269812] Dynamic subtest eDP-1: SKIP (0.000s)
[747.271676] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[747.347595] [099/133] (297s left) gem_pxp (reject-modify-context-protection-off-1)
[747.471794] Starting subtest: reject-modify-context-protection-off-1
[747.473138] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[747.610945] [100/133] (297s left) vgem_basic (bad-handle)
[747.648045] Starting subtest: bad-handle
[747.649211] Subtest bad-handle: SUCCESS (0.000s)
[747.718116] [101/133] (297s left) kms_psr (psr2-dpms)
[747.814020] Starting subtest: psr2-dpms
[747.814987] Starting dynamic subtest: eDP-1
[750.679900] Dynamic subtest eDP-1: SUCCESS (2.863s)
[750.681164] Subtest psr2-dpms: SUCCESS (2.864s)
[751.556618] [102/133] (293s left) core_setmaster (master-drop-set-user)
[751.643843] Starting subtest: master-drop-set-user
[751.658318] Subtest master-drop-set-user: SUCCESS (0.015s)
[751.689362] [103/133] (293s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[751.785456] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[751.787769] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[751.903732] [104/133] (293s left) gem_exec_fence (syncobj-wait)
[752.326250] Starting subtest: syncobj-wait
[753.789168] Subtest syncobj-wait: SUCCESS (1.452s)
[755.760888] [105/133] (289s left) gem_close_race (multigpu-basic-threads)
[755.825247] Starting subtest: multigpu-basic-threads
[755.828064] Subtest multigpu-basic-threads: SKIP (0.000s)
[756.084019] [106/133] (289s left) gem_exec_schedule (preemptive-hang)
[756.266477] Starting subtest: preemptive-hang
[756.268271] Starting dynamic subtest: rcs0
[765.867920] Dynamic subtest rcs0: SUCCESS (9.605s)
[765.877264] Starting dynamic subtest: bcs0
[774.900912] Dynamic subtest bcs0: SUCCESS (9.026s)
[774.910219] Starting dynamic subtest: vcs0
[783.913035] Dynamic subtest vcs0: SUCCESS (9.005s)
[783.922211] Starting dynamic subtest: vcs1
[792.871100] Dynamic subtest vcs1: SUCCESS (8.952s)
[792.880810] Starting dynamic subtest: vecs0
[801.830972] Dynamic subtest vecs0: SUCCESS (8.962s)
[801.840295] Starting dynamic subtest: ccs0
[810.855858] Dynamic subtest ccs0: SUCCESS (9.027s)
[810.857452] Subtest preemptive-hang: SUCCESS (54.587s)
[811.121659] [107/133] (234s left) gem_mmap_wc (write-wc-read-gtt)
[811.185399] Subtest write-wc-read-gtt: SKIP (0.000s)
[811.235173] [108/133] (233s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[811.331959] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[818.998960] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.669s)
[819.169827] [109/133] (226s left) gem_lmem_swapping (massive-random)
[819.205722] Subtest massive-random: SKIP (0.000s)
[819.254925] [110/133] (226s left) gem_exec_async (forked-writes)
[819.322358] Starting subtest: forked-writes
[819.323828] Starting dynamic subtest: rcs0
[819.349076] Dynamic subtest rcs0: SUCCESS (0.026s)
[819.358547] Starting dynamic subtest: bcs0
[819.374387] Dynamic subtest bcs0: SUCCESS (0.024s)
[819.382986] Starting dynamic subtest: vcs0
[819.396192] Dynamic subtest vcs0: SUCCESS (0.022s)
[819.405338] Starting dynamic subtest: vcs1
[819.418259] Dynamic subtest vcs1: SUCCESS (0.021s)
[819.427148] Starting dynamic subtest: vecs0
[819.438396] Dynamic subtest vecs0: SUCCESS (0.019s)
[819.447241] Starting dynamic subtest: ccs0
[819.460342] Dynamic subtest ccs0: SUCCESS (0.021s)
[819.461634] Subtest forked-writes: SUCCESS (0.138s)
[819.711291] [111/133] (225s left) gem_exec_params (secure-non-master)
[819.760102] Starting subtest: secure-non-master
[819.762313] Subtest secure-non-master: SKIP (0.000s)
[819.861229] [112/133] (225s left) kms_invalid_mode (uint-max-clock)
[819.957077] Starting subtest: uint-max-clock
[819.958231] Starting dynamic subtest: pipe-A-eDP-1
[820.242122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[820.250665] Starting dynamic subtest: pipe-B-eDP-1
[820.251825] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[820.260455] Starting dynamic subtest: pipe-C-eDP-1
[820.261716] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[820.269704] Starting dynamic subtest: pipe-D-eDP-1
[820.270701] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[820.271619] Subtest uint-max-clock: SUCCESS (0.292s)
[821.110778] [113/133] (224s left) perf (invalid-create-userspace-config)
[821.203219] Starting subtest: invalid-create-userspace-config
[821.204719] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[821.242551] [114/133] (224s left) gem_mmap_offset (mmap-unmap)
[821.301433] Starting subtest: mmap-unmap
[821.303034] Starting dynamic subtest: smem0
[845.202486] Dynamic subtest smem0: SUCCESS (23.891s)
[845.203957] Subtest mmap-unmap: SUCCESS (23.892s)
[845.335255] [115/133] (200s left) gem_exec_suspend (basic-s0)
[845.391199] Starting subtest: basic-S0
[845.392378] Starting dynamic subtest: smem
[865.223802] Dynamic subtest smem: SUCCESS (6.317s)
[865.225330] Subtest basic-S0: SUCCESS (6.319s)
[871.428363] [116/133] (180s left) prime_self_import (basic-with_one_bo)
[871.466262] Starting subtest: basic-with_one_bo
[871.494601] Subtest basic-with_one_bo: SUCCESS (0.027s)
[871.608547] [117/133] (179s left) kms_cursor_crc (cursor-onscreen-max-size)
[871.934063] Starting subtest: cursor-onscreen-max-size
[871.937577] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[872.051567] [118/133] (179s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[872.138602] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[872.140643] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[872.261956] [119/133] (179s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[872.356285] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[872.357742] Starting dynamic subtest: pipe-A
[872.699877] Dynamic subtest pipe-A: SUCCESS (0.338s)
[872.708617] Starting dynamic subtest: pipe-B
[874.171041] Dynamic subtest pipe-B: SUCCESS (1.445s)
[874.182364] Starting dynamic subtest: pipe-C
[875.623870] Dynamic subtest pipe-C: SUCCESS (1.427s)
[875.634522] Starting dynamic subtest: pipe-D
[877.081099] Dynamic subtest pipe-D: SUCCESS (1.442s)
[877.082623] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.657s)
[878.266681] [120/133] (173s left) kms_addfb_basic (small-bo)
[878.360179] Starting subtest: small-bo
[878.361617] Subtest small-bo: SUCCESS (0.000s)
[878.462510] [121/133] (173s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[878.554997] Starting subtest: fbc-rgb101010-draw-mmap-wc
[883.200331] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.615s)
[884.418744] [122/133] (167s left) kms_psr (psr-primary-blt)
[884.497662] Starting subtest: psr-primary-blt
[884.498456] Starting dynamic subtest: eDP-1
[887.092916] Dynamic subtest eDP-1: SUCCESS (2.574s)
[887.097159] Subtest psr-primary-blt: SUCCESS (2.575s)
[887.488570] [123/133] (164s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[887.585904] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[887.586883] Starting dynamic subtest: pipe-A-eDP-1
[887.726826] Dynamic subtest pipe-A-eDP-1: SKIP (0.140s)
[887.737149] Starting dynamic subtest: pipe-B-eDP-1
[888.869657] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[888.871574] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.280s)
[890.078594] [124/133] (161s left) kms_pm_rpm (basic-rte)
[890.112183] Starting subtest: basic-rte
[893.055195] Subtest basic-rte: SUCCESS (2.940s)
[894.881504] [125/133] (156s left) gen9_exec_parse (batch-without-end)
[894.938828] Subtest batch-without-end: SKIP (0.000s)
[895.016588] [126/133] (156s left) gem_workarounds (basic-read-fd)
[895.084336] Starting subtest: basic-read-fd
[895.095735] Subtest basic-read-fd: SUCCESS (0.011s)
[895.245045] [127/133] (156s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[895.337965] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[895.339845] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[895.430689] [128/133] (156s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[895.528827] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[895.530501] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[895.658727] [129/133] (156s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[895.759769] Starting subtest: x-tiled-16bpp-rotate-0
[897.050755] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.290s)
[897.180995] [130/133] (154s left) gem_lmem_swapping (random-engines)
[897.222519] Subtest random-engines: SKIP (0.000s)
[897.265051] [131/133] (154s left) perf (global-sseu-config)
[897.362048] Starting subtest: global-sseu-config
[897.364750] Subtest global-sseu-config: SKIP (0.000s)
[897.399840] [132/133] (154s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[897.494783] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[898.298973] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.804s)
[898.467650] [133/133] (153s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[898.525513] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[898.526783] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[898.642511] 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.