[58.652407] Initializing watchdogs
[58.652451]   /dev/watchdog0
[58.666038] [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.670256] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.672549] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.675926] [001/133] (960s left) prime_mmap (test_reprime)
[58.750199] Starting subtest: test_reprime
[58.752472] Starting dynamic subtest: test_reprime-smem
[58.783236] Dynamic subtest test_reprime-smem: SUCCESS (0.034s)
[58.785795] Subtest test_reprime: SUCCESS (0.035s)
[58.874980] [002/133] (960s left) syncobj_wait (invalid-wait-bad-flags)
[58.922954] Starting subtest: invalid-wait-bad-flags
[58.924897] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[59.036377] [003/133] (960s left) syncobj_timeline (single-wait-signaled)
[59.087569] Starting subtest: single-wait-signaled
[59.089808] Subtest single-wait-signaled: SUCCESS (0.000s)
[59.174963] [004/133] (960s left) kms_chamelium_color (gamma)
[59.274822] Subtest gamma: SKIP (0.000s)
[59.314644] [005/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[59.420552] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[65.891053] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.502s)
[66.012682] [006/133] (953s left) kms_plane (planar-pixel-format-settings)
[66.104905] Starting subtest: planar-pixel-format-settings
[66.180913] Subtest planar-pixel-format-settings: SUCCESS (0.076s)
[66.302812] [007/133] (953s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[66.439118] Starting subtest: flip-vs-cursor-legacy
[74.195825] Subtest flip-vs-cursor-legacy: SUCCESS (7.768s)
[75.007192] [008/133] (944s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[75.105470] Starting subtest: yf-tiled-32bpp-rotate-180
[75.109812] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[75.194666] [009/133] (944s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[75.293294] Starting subtest: 2x-flip-vs-modeset-vs-hang
[75.302096] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s)
[75.391024] [010/133] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[75.498656] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[75.503260] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[75.592491] [011/133] (943s left) drm_buddy (drm_buddy)
[75.628243] Starting subtest: drm_buddy
[75.632314] Subtest drm_buddy: SKIP (0.001s)
[75.683568] [012/133] (943s left) kms_cursor_crc (cursor-random-128x128)
[75.881579] Starting subtest: cursor-random-128x128
[75.883744] Starting dynamic subtest: pipe-A-eDP-1
[79.213674] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.331s)
[79.243900] Starting dynamic subtest: pipe-D-eDP-1
[83.216282] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.979s)
[83.218625] Subtest cursor-random-128x128: SUCCESS (7.338s)
[84.067730] [013/133] (935s left) gem_lmem_swapping (heavy-random)
[84.117025] Subtest heavy-random: SKIP (0.000s)
[84.150255] [014/133] (935s left) kms_vrr (seamless-rr-switch-drrs)
[84.243353] Starting subtest: seamless-rr-switch-drrs
[84.249965] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[84.312668] [015/133] (935s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[84.374587] Starting subtest: multi-wait-available-submitted-signaled
[84.376971] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[84.468235] [016/133] (935s left) sysfs_preempt_timeout (timeout)
[84.527718] Starting subtest: timeout
[84.530102] Starting dynamic subtest: vecs0
[93.904715] Dynamic subtest vecs0: SUCCESS (9.372s)
[93.915043] Starting dynamic subtest: ccs0
[95.226943] Dynamic subtest ccs0: SUCCESS (1.322s)
[95.235986] Starting dynamic subtest: vcs0
[104.913313] Dynamic subtest vcs0: SUCCESS (9.684s)
[104.923516] Starting dynamic subtest: bcs0
[106.196784] Dynamic subtest bcs0: SUCCESS (1.285s)
[106.204694] Starting dynamic subtest: rcs0
[107.384152] Dynamic subtest rcs0: SUCCESS (1.185s)
[107.393176] Starting dynamic subtest: vcs1
[116.878463] Dynamic subtest vcs1: SUCCESS (9.491s)
[116.881059] Subtest timeout: SUCCESS (32.346s)
[116.963047] [017/133] (902s left) gem_exec_whisper (basic-contexts-priority-all)
[117.032761] Starting subtest: basic-contexts-priority-all
[140.035794] Subtest basic-contexts-priority-all: SUCCESS (22.999s)
[140.216176] [018/133] (879s left) kms_lease (possible-crtcs-filtering)
[140.314531] Starting subtest: possible-crtcs-filtering
[140.319597] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[140.428362] [019/133] (879s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[140.519265] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[140.523742] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[140.591114] [020/133] (879s left) gem_pxp (reject-modify-context-protection-off-2)
[140.723233] Starting subtest: reject-modify-context-protection-off-2
[140.725783] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[140.840059] [021/133] (879s left) kms_prop_blob (blob-prop-core)
[140.885516] Starting subtest: blob-prop-core
[140.888301] Subtest blob-prop-core: SUCCESS (0.000s)
[140.994047] [022/133] (878s left) kms_pm_backlight (basic-brightness)
[141.079870] Starting subtest: basic-brightness
[141.130431] Starting dynamic subtest: eDP-1
[141.438800] Dynamic subtest eDP-1: SUCCESS (0.308s)
[141.441407] Subtest basic-brightness: SUCCESS (0.360s)
[142.307903] [023/133] (877s left) kms_addfb_basic (clobberred-modifier)
[142.361931] Starting subtest: clobberred-modifier
[142.366658] Subtest clobberred-modifier: SKIP (0.000s)
[142.508423] [024/133] (877s left) kms_vblank (ts-continuation-dpms-rpm)
[142.596724] Starting subtest: ts-continuation-dpms-rpm
[142.598969] Starting dynamic subtest: pipe-A-eDP-1
[145.093065] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[145.107778] Starting dynamic subtest: pipe-D-eDP-1
[147.346683] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.251s)
[147.348811] Subtest ts-continuation-dpms-rpm: SUCCESS (4.750s)
[148.131203] [025/133] (871s left) gen7_exec_parse (batch-without-end)
[148.195060] Subtest batch-without-end: SKIP (0.000s)
[148.256554] [026/133] (871s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[148.349560] Starting subtest: x-tiled-8bpp-rotate-180
[149.540875] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.193s)
[149.660360] [027/133] (870s left) kms_hdr (invalid-hdr)
[149.753898] Starting subtest: invalid-hdr
[151.852843] Starting dynamic subtest: pipe-A-eDP-1
[154.750446] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.897s)
[154.752810] Subtest invalid-hdr: SUCCESS (4.996s)
[154.864456] [028/133] (865s left) kms_cursor_crc (cursor-size-change)
[154.958185] Starting subtest: cursor-size-change
[154.960503] Starting dynamic subtest: pipe-A-eDP-1
[156.885405] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.927s)
[156.894462] Starting dynamic subtest: pipe-D-eDP-1
[158.325982] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.437s)
[158.328693] Subtest cursor-size-change: SUCCESS (3.368s)
[159.204165] [029/133] (861s left) kms_busy (basic)
[159.303791] Starting subtest: basic
[159.305724] Starting dynamic subtest: flip
[159.926114] Dynamic subtest flip: SUCCESS (0.622s)
[159.934923] Starting dynamic subtest: modeset
[163.572440] Dynamic subtest modeset: SUCCESS (3.645s)
[163.574774] Subtest basic: SUCCESS (4.269s)
[164.367858] [030/133] (855s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[164.465172] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[164.467481] Starting dynamic subtest: pipe-A-eDP-1
[164.490107] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.500808] Starting dynamic subtest: pipe-B-eDP-1
[164.523260] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.533221] Starting dynamic subtest: pipe-C-eDP-1
[164.554528] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.562544] Starting dynamic subtest: pipe-D-eDP-1
[164.584305] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.588685] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[166.736718] [031/133] (853s left) gem_pread (exhaustion)
[166.794188] Subtest exhaustion: SKIP (0.000s)
[166.852345] [032/133] (853s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[166.959564] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[166.961874] Starting dynamic subtest: pipe-A-eDP-1
[173.653629] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.695s)
[173.664556] Starting dynamic subtest: pipe-B-eDP-1
[180.711980] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.057s)
[180.714074] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.754s)
[181.556777] [033/133] (838s left) kms_properties (connector-properties-atomic)
[181.646974] Starting subtest: connector-properties-atomic
[181.648851] Starting dynamic subtest: pipe-A-eDP-1
[189.472723] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.823s)
[189.481947] Starting dynamic subtest: pipe-None-DP-1
[189.486362] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[189.494714] Starting dynamic subtest: pipe-None-HDMI-A-1
[189.499262] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[189.507041] Starting dynamic subtest: pipe-None-DP-2
[189.511109] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[189.519428] Starting dynamic subtest: pipe-None-HDMI-A-2
[189.523929] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[189.532297] Starting dynamic subtest: pipe-None-DP-3
[189.536655] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[189.544945] Starting dynamic subtest: pipe-None-DP-4
[189.549230] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[189.551313] Subtest connector-properties-atomic: SUCCESS (7.834s)
[190.340569] [034/133] (830s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[190.429207] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[190.431368] Starting dynamic subtest: pipe-A-eDP-1
[190.450941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[190.460775] Starting dynamic subtest: pipe-B-eDP-1
[190.480850] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[190.493610] Starting dynamic subtest: pipe-C-eDP-1
[190.513272] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[190.525164] Starting dynamic subtest: pipe-D-eDP-1
[190.545268] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[190.547527] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[192.609402] [035/133] (827s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[192.706157] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[192.708467] Starting dynamic subtest: pipe-A-eDP-1
[192.731747] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[192.742690] Starting dynamic subtest: pipe-B-eDP-1
[192.764287] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[192.772929] Starting dynamic subtest: pipe-C-eDP-1
[192.794888] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[192.803219] Starting dynamic subtest: pipe-D-eDP-1
[192.825129] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[192.829431] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[194.969273] [036/133] (825s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[195.069378] Starting subtest: plane-lut1d-ctm3x4-lut1d
[195.249203] Starting dynamic subtest: pipe-A-plane-0
[195.393129] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[195.403888] Starting dynamic subtest: pipe-A-plane-1
[195.526220] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[195.535309] Starting dynamic subtest: pipe-A-plane-2
[195.659962] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[196.861076] Starting dynamic subtest: pipe-B-plane-0
[197.010591] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[197.019940] Starting dynamic subtest: pipe-B-plane-1
[197.198927] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[197.207591] Starting dynamic subtest: pipe-B-plane-2
[197.365579] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[198.619889] Starting dynamic subtest: pipe-C-plane-0
[198.746571] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[198.756079] Starting dynamic subtest: pipe-C-plane-1
[198.879520] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[198.887773] Starting dynamic subtest: pipe-C-plane-2
[199.013276] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[200.236264] Starting dynamic subtest: pipe-D-plane-0
[200.372942] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[200.381944] Starting dynamic subtest: pipe-D-plane-1
[200.539985] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[200.549820] Starting dynamic subtest: pipe-D-plane-2
[200.695274] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[200.985307] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.916s)
[201.801712] [037/133] (818s left) gem_pwrite_snooped
[201.940126] [038/133] (818s left) gem_wait (await)
[202.009524] Starting subtest: await
[202.011835] Starting dynamic subtest: all-engines
[203.219972] Dynamic subtest all-engines: SUCCESS (1.213s)
[203.236338] Starting dynamic subtest: rcs0
[204.273713] Dynamic subtest rcs0: SUCCESS (1.052s)
[204.292521] Starting dynamic subtest: bcs0
[205.332150] Dynamic subtest bcs0: SUCCESS (1.056s)
[205.347078] Starting dynamic subtest: vcs0
[206.389216] Dynamic subtest vcs0: SUCCESS (1.055s)
[206.407062] Starting dynamic subtest: vcs1
[207.444434] Dynamic subtest vcs1: SUCCESS (1.053s)
[207.460193] Starting dynamic subtest: vecs0
[208.497777] Dynamic subtest vecs0: SUCCESS (1.051s)
[208.513890] Starting dynamic subtest: ccs0
[209.553896] Dynamic subtest ccs0: SUCCESS (1.054s)
[209.556295] Subtest await: SUCCESS (7.548s)
[209.764489] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[209.767828] [039/133] (810s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[209.872441] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[216.955422] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (7.087s)
[217.119090] [040/133] (803s left) gem_render_copy_redux (flink-interruptible)
[217.186188] Starting subtest: flink-interruptible
[217.940950] Subtest flink-interruptible: SUCCESS (0.755s)
[218.060862] [041/133] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[218.155561] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[218.159060] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[218.244153] [042/133] (802s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[218.333475] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[218.335267] Starting dynamic subtest: pipe-A
[218.354079] Dynamic subtest pipe-A: SKIP (0.017s)
[218.362568] Starting dynamic subtest: pipe-B
[218.385464] Dynamic subtest pipe-B: SKIP (0.030s)
[218.395266] Starting dynamic subtest: pipe-C
[218.414327] Dynamic subtest pipe-C: SKIP (0.030s)
[218.422502] Starting dynamic subtest: pipe-D
[218.444805] Dynamic subtest pipe-D: SKIP (0.030s)
[218.448351] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.109s)
[218.559227] [043/133] (802s left) kms_async_flips (alternate-sync-async-flip-atomic)
[218.648598] Starting subtest: alternate-sync-async-flip-atomic
[219.019957] Starting dynamic subtest: pipe-A-eDP-1
[221.826876] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.807s)
[222.206574] Starting dynamic subtest: pipe-B-eDP-1
[224.963152] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s)
[225.330896] Starting dynamic subtest: pipe-C-eDP-1
[228.084682] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[228.456089] Starting dynamic subtest: pipe-D-eDP-1
[231.210755] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[231.212866] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.564s)
[232.376385] [044/133] (788s left) gem_create (hog-create)
[232.433741] Starting subtest: hog-create
[232.436102] Starting dynamic subtest: smem0
[265.949877] Dynamic subtest smem0: SUCCESS (33.513s)
[265.952419] Subtest hog-create: SUCCESS (33.515s)
[266.143149] [045/133] (754s left) perf_pmu (semaphore-busy)
[266.183663] Starting subtest: semaphore-busy
[266.185939] Starting dynamic subtest: rcs0
[267.799979] Dynamic subtest rcs0: SUCCESS (1.612s)
[267.811862] Starting dynamic subtest: bcs0
[269.435956] Dynamic subtest bcs0: SUCCESS (1.632s)
[269.447681] Starting dynamic subtest: vcs0
[273.423973] Dynamic subtest vcs0: SUCCESS (3.986s)
[273.432881] Starting dynamic subtest: vcs1
[279.440459] Dynamic subtest vcs1: SUCCESS (6.013s)
[279.451549] Starting dynamic subtest: vecs0
[285.392509] Dynamic subtest vecs0: SUCCESS (5.949s)
[285.403612] Starting dynamic subtest: ccs0
[288.531040] Dynamic subtest ccs0: SUCCESS (3.135s)
[288.533630] Subtest semaphore-busy: SUCCESS (22.345s)
[288.645358] [046/133] (732s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[288.701066] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[288.762273] [047/133] (732s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[288.825870] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[288.930500] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[289.026989] [048/133] (731s left) syncobj_wait (single-wait-all-signaled)
[289.083615] Starting subtest: single-wait-all-signaled
[289.085919] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[289.176443] [049/133] (731s left) kms_hdr (static-toggle-dpms)
[289.265972] Starting subtest: static-toggle-dpms
[289.272380] Subtest static-toggle-dpms: SKIP (0.000s)
[289.340259] [050/133] (731s left) kms_flip (bo-too-big-interruptible)
[289.437887] Starting subtest: bo-too-big-interruptible
[289.440175] Starting dynamic subtest: A-eDP1
[290.722269] Dynamic subtest A-eDP1: SUCCESS (1.283s)
[290.733695] Starting dynamic subtest: B-eDP1
[291.957922] Dynamic subtest B-eDP1: SUCCESS (1.234s)
[291.968159] Starting dynamic subtest: C-eDP1
[293.206156] Dynamic subtest C-eDP1: SUCCESS (1.247s)
[293.217718] Starting dynamic subtest: D-eDP1
[294.440352] Dynamic subtest D-eDP1: SUCCESS (1.233s)
[294.445893] Subtest bo-too-big-interruptible: SUCCESS (5.009s)
[295.665838] [051/133] (725s left) i915_drm_fdinfo (virtual-busy)
[295.714021] Starting subtest: virtual-busy
[295.718670] Subtest virtual-busy: SKIP (0.000s)
[295.776976] [052/133] (725s left) kms_pm_rpm (universal-planes-dpms)
[298.011109] Starting subtest: universal-planes-dpms
[298.013620] Starting dynamic subtest: plane-35
[306.403897] Dynamic subtest plane-35: SUCCESS (8.395s)
[306.417242] Starting dynamic subtest: plane-65
[314.716526] Dynamic subtest plane-65: SUCCESS (8.310s)
[314.728193] Starting dynamic subtest: plane-95
[323.364473] Dynamic subtest plane-95: SUCCESS (8.644s)
[323.376281] Starting dynamic subtest: plane-125
[331.948052] Dynamic subtest plane-125: SUCCESS (8.581s)
[331.959837] Starting dynamic subtest: plane-135
[340.594847] Dynamic subtest plane-135: SUCCESS (8.644s)
[340.606437] Starting dynamic subtest: plane-145
[349.203395] Dynamic subtest plane-145: SUCCESS (8.606s)
[349.205810] Subtest universal-planes-dpms: SUCCESS (51.196s)
[349.579723] [053/133] (671s left) api_intel_allocator (execbuf-with-allocator)
[349.653186] Starting subtest: execbuf-with-allocator
[349.655765] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[349.781686] [054/133] (671s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[349.872078] Starting subtest: y-tiled-64bpp-rotate-180
[349.876501] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[349.976635] [055/133] (671s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[350.070830] Starting subtest: fbc-psr2-cursor-plane-update-sf
[350.073081] Starting dynamic subtest: pipe-A-eDP-1
[350.156056] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[350.167754] Starting dynamic subtest: pipe-B-eDP-1
[351.255948] Dynamic subtest pipe-B-eDP-1: SKIP (1.097s)
[351.260413] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.189s)
[352.444441] [056/133] (668s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[352.546334] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[352.556058] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s)
[352.636953] [057/133] (668s left) syncobj_wait (wait-for-submit-snapshot)
[352.689452] Starting subtest: wait-for-submit-snapshot
[352.768405] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[352.843447] [058/133] (668s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[352.931858] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[352.934252] Starting dynamic subtest: pipe-A-eDP-1
[352.960325] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[352.972525] Starting dynamic subtest: pipe-B-eDP-1
[352.996848] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[353.005734] Starting dynamic subtest: pipe-C-eDP-1
[353.029502] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[353.039302] Starting dynamic subtest: pipe-D-eDP-1
[353.063293] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[353.067642] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[355.119955] [059/133] (666s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[355.209094] Starting subtest: 4-tiled-8bpp-rotate-90
[355.228721] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[355.343264] [060/133] (666s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[355.467286] Starting subtest: cursorB-vs-flipA-legacy
[355.471662] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[355.630747] [061/133] (665s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[355.701655] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[355.706226] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[355.896384] [062/133] (665s left) kms_selftest (drm_dp_mst_helper)
[355.935160] Starting subtest: drm_dp_mst_helper
[356.000336] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[356.104077] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.106s)
[356.114798] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[356.204184] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.099s)
[356.213192] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[356.326740] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.123s)
[356.329182] Subtest drm_dp_mst_helper: SUCCESS (0.391s)
[356.477889] [063/133] (665s left) kms_psr (psr-dpms)
[356.579172] Starting subtest: psr-dpms
[356.581408] Starting dynamic subtest: eDP-1
[359.536137] Dynamic subtest eDP-1: SUCCESS (2.957s)
[359.538461] Subtest psr-dpms: SUCCESS (2.958s)
[360.404612] [064/133] (661s left) gem_exec_schedule (semaphore-power)
[360.602482] Subtest semaphore-power: SKIP (0.000s)
[360.779352] [065/133] (660s left) kms_plane_lowres (tiling-x)
[360.869194] Starting subtest: tiling-x
[360.871492] Starting dynamic subtest: pipe-A-eDP-1
[360.876081] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[361.161765] Starting dynamic subtest: pipe-B-eDP-1
[361.166507] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[361.175544] Starting dynamic subtest: pipe-C-eDP-1
[361.180257] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[361.189061] Starting dynamic subtest: pipe-D-eDP-1
[361.193286] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[361.197364] Subtest tiling-x: SKIP (0.291s)
[362.024801] [066/133] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[362.123348] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[362.127717] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[362.231469] [067/133] (659s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[362.293027] Starting subtest: invalid-multi-wait-unsubmitted
[362.295156] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[362.383172] [068/133] (659s left) gem_tiled_partial_pwrite_pread (reads)
[362.452056] Subtest reads: SKIP (0.000s)
[362.524329] [069/133] (659s left) kms_flip (2x-flip-vs-suspend)
[362.618081] Starting subtest: 2x-flip-vs-suspend
[362.626591] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[362.707691] [070/133] (659s left) i915_drm_fdinfo (virtual-busy-hang-all)
[362.743960] Starting subtest: virtual-busy-hang-all
[362.748663] Subtest virtual-busy-hang-all: SKIP (0.000s)
[362.807372] [071/133] (659s left) gem_eio (context-create)
[363.011182] Starting subtest: context-create
[363.289080] Subtest context-create: SUCCESS (0.278s)
[363.412452] [072/133] (658s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[363.463779] Starting subtest: invalid-single-wait-unsubmitted
[363.465845] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[363.556376] [073/133] (658s left) gem_exec_balancer (full-pulse)
[363.609191] Starting subtest: full-pulse
[368.730913] Subtest full-pulse: SUCCESS (5.121s)
[369.079209] [074/133] (653s left) gem_exec_schedule (preempt-other)
[369.149809] Starting subtest: preempt-other
[369.152098] Starting dynamic subtest: rcs0
[369.266921] Dynamic subtest rcs0: SUCCESS (0.123s)
[369.279982] Starting dynamic subtest: bcs0
[369.382051] Dynamic subtest bcs0: SUCCESS (0.115s)
[369.397685] Starting dynamic subtest: vcs0
[369.502834] Dynamic subtest vcs0: SUCCESS (0.119s)
[369.514611] Starting dynamic subtest: vcs1
[369.615356] Dynamic subtest vcs1: SUCCESS (0.113s)
[369.627604] Starting dynamic subtest: vecs0
[369.732262] Dynamic subtest vecs0: SUCCESS (0.115s)
[369.744818] Starting dynamic subtest: ccs0
[369.844872] Dynamic subtest ccs0: SUCCESS (0.112s)
[369.847939] Subtest preempt-other: SUCCESS (0.702s)
[370.985712] [075/133] (651s left) sw_sync (alloc_timeline)
[371.025239] Starting subtest: alloc_timeline
[371.027633] Subtest alloc_timeline: SUCCESS (0.000s)
[371.146748] [076/133] (651s left) gem_exec_params (no-vebox)
[371.216031] Starting subtest: no-vebox
[371.218357] Subtest no-vebox: SUCCESS (0.003s)
[372.936904] [077/133] (649s left) perf_pmu (enable-race)
[372.994922] Starting subtest: enable-race
[372.997133] Starting dynamic subtest: rcs0
[385.756463] Dynamic subtest rcs0: SUCCESS (12.763s)
[385.768128] Starting dynamic subtest: bcs0
[398.502535] Dynamic subtest bcs0: SUCCESS (12.743s)
[398.513149] Starting dynamic subtest: vcs0
[413.909835] Dynamic subtest vcs0: SUCCESS (15.403s)
[413.921431] Starting dynamic subtest: vcs1
[429.910212] Dynamic subtest vcs1: SUCCESS (15.997s)
[429.922165] Starting dynamic subtest: vecs0
[445.909615] Dynamic subtest vecs0: SUCCESS (15.996s)
[445.921559] Starting dynamic subtest: ccs0
[458.669526] Dynamic subtest ccs0: SUCCESS (12.758s)
[458.672623] Subtest enable-race: SUCCESS (85.675s)
[458.769720] [078/133] (563s left) tools_test (tools_test)
[458.827663] Starting subtest: tools_test
[458.877362] Subtest tools_test: SUCCESS (0.067s)
[458.949809] [079/133] (563s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[459.044551] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[462.998341] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.957s)
[464.137118] [080/133] (558s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[464.247473] Starting subtest: 4-tiled-16bpp-rotate-0
[465.637583] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.390s)
[465.757470] [081/133] (556s left) syncobj_wait (reset-unsignaled)
[465.808287] Starting subtest: reset-unsignaled
[465.810131] Subtest reset-unsignaled: SUCCESS (0.000s)
[465.898479] [082/133] (556s left) kms_addfb_basic (tile-pitch-mismatch)
[465.952085] Starting subtest: tile-pitch-mismatch
[465.955641] Subtest tile-pitch-mismatch: SKIP (0.000s)
[466.098187] [083/133] (556s left) i915_pm_rpm (gem-evict-pwrite)
[468.037695] Starting subtest: gem-evict-pwrite
[468.042631] Subtest gem-evict-pwrite: SKIP (0.000s)
[468.424999] [084/133] (554s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[468.518205] Starting subtest: psr-rgb565-draw-mmap-gtt
[468.522292] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[468.616968] [085/133] (554s left) syncobj_wait (multi-wait-all-submitted-signaled)
[468.670972] Starting subtest: multi-wait-all-submitted-signaled
[468.778347] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[468.857187] [086/133] (553s left) syncobj_eventfd (binary-wait)
[468.910492] Starting subtest: binary-wait
[468.919408] Subtest binary-wait: SUCCESS (0.011s)
[468.994818] [087/133] (553s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[469.092251] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[469.096242] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[469.186319] [088/133] (553s left) kms_psr (pr-primary-blt)
[469.289255] Starting subtest: pr-primary-blt
[469.293599] Subtest pr-primary-blt: SKIP (0.000s)
[469.361098] [089/133] (553s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[469.454804] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[470.401696] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.947s)
[470.547049] [090/133] (552s left) gem_exec_balancer (parallel-keep-submit-fence)
[470.798934] Starting subtest: parallel-keep-submit-fence
[472.020893] Subtest parallel-keep-submit-fence: SUCCESS (1.222s)
[472.124723] [091/133] (550s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[472.225237] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[476.558669] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.337s)
[477.729160] [092/133] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[477.832875] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[477.837151] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[477.942011] [093/133] (545s left) kms_dsc (dsc-basic)
[478.030038] Starting subtest: dsc-basic
[478.042574] Subtest dsc-basic: SKIP (0.000s)
[478.113412] [094/133] (544s left) gem_exec_flush (basic-wb-pro-default)
[478.173190] Starting subtest: basic-wb-pro-default
[483.628337] Subtest basic-wb-pro-default: SUCCESS (5.455s)
[483.825205] [095/133] (539s left) kms_psr (psr2-cursor-render)
[483.925079] Starting subtest: psr2-cursor-render
[483.927394] Starting dynamic subtest: eDP-1
[485.591340] Dynamic subtest eDP-1: SUCCESS (1.664s)
[485.593307] Subtest psr2-cursor-render: SUCCESS (1.665s)
[486.389443] [096/133] (536s left) kms_addfb_basic (bad-pitch-65536)
[486.438364] Starting subtest: bad-pitch-65536
[486.440601] Subtest bad-pitch-65536: SUCCESS (0.000s)
[486.580747] [097/133] (536s left) gem_eio (in-flight-1us)
[486.810042] Starting subtest: in-flight-1us
[495.860020] Subtest in-flight-1us: SUCCESS (9.048s)
[496.020123] [098/133] (527s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[496.116600] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[496.121069] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[496.186795] [099/133] (527s left) kms_flip (flip-vs-panning-interruptible)
[496.269499] Starting subtest: flip-vs-panning-interruptible
[496.271887] Starting dynamic subtest: A-eDP1
[505.002342] Dynamic subtest A-eDP1: SUCCESS (8.732s)
[505.013122] Starting dynamic subtest: B-eDP1
[513.733750] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[513.747601] Starting dynamic subtest: C-eDP1
[522.462101] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[522.471502] Starting dynamic subtest: D-eDP1
[531.101771] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[531.105898] Subtest flip-vs-panning-interruptible: SUCCESS (34.837s)
[532.266804] [100/133] (490s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[532.364817] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[536.655499] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.294s)
[537.776539] [101/133] (485s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[537.872721] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[537.876930] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[537.967210] [102/133] (485s left) gem_ctx_isolation (nonpriv-switch)
[538.022135] Starting subtest: nonpriv-switch
[538.024510] Starting dynamic subtest: rcs0
[538.293295] Dynamic subtest rcs0: SUCCESS (0.270s)
[538.305412] Starting dynamic subtest: bcs0
[538.570999] Dynamic subtest bcs0: SUCCESS (0.277s)
[538.582866] Starting dynamic subtest: vcs0
[538.867777] Dynamic subtest vcs0: SUCCESS (0.296s)
[538.878472] Starting dynamic subtest: vcs1
[540.180851] Dynamic subtest vcs1: SUCCESS (1.312s)
[540.190383] Starting dynamic subtest: vecs0
[542.192036] Dynamic subtest vecs0: SUCCESS (2.009s)
[542.204654] Starting dynamic subtest: ccs0
[544.209641] Dynamic subtest ccs0: SUCCESS (2.018s)
[544.212043] Subtest nonpriv-switch: SUCCESS (6.187s)
[544.447044] [103/133] (478s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[544.560739] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[548.555461] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.998s)
[549.764074] [104/133] (473s left) i915_query (query-topology-garbage-items)
[549.827617] Starting subtest: query-topology-garbage-items
[549.829612] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[549.924649] [105/133] (473s left) kms_plane_alpha_blend (constant-alpha-min)
[550.013877] Starting subtest: constant-alpha-min
[550.292827] Starting dynamic subtest: pipe-A-eDP-1
[551.003720] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[551.012837] Starting dynamic subtest: pipe-D-eDP-1
[552.523266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.518s)
[552.525537] Subtest constant-alpha-min: SUCCESS (2.512s)
[553.319347] [106/133] (470s left) kms_psr (fbc-pr-primary-render)
[553.429088] Starting subtest: fbc-pr-primary-render
[553.433609] Subtest fbc-pr-primary-render: SKIP (0.000s)
[553.503056] [107/133] (470s left) gem_exec_reloc (basic-write-cpu-noreloc)
[553.559943] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[553.644942] [108/133] (469s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[553.773080] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[553.777259] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[553.924788] [109/133] (469s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[554.017459] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[560.560824] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.546s)
[560.659364] [110/133] (463s left) gem_mmap_gtt (hang)
[560.728569] Subtest hang: SKIP (0.000s)
[560.791584] [111/133] (462s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[560.892691] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[560.901322] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[560.980490] [112/133] (462s left) gem_ctx_param (invalid-param-set)
[561.050575] Starting subtest: invalid-param-set
[561.052817] Subtest invalid-param-set: SUCCESS (0.000s)
[561.125038] [113/133] (462s left) api_intel_bb (purge-bb)
[561.192634] Starting subtest: purge-bb
[561.194535] Subtest purge-bb: SUCCESS (0.004s)
[561.333452] [114/133] (462s left) gem_exec_params (invalid-fence-in-submit)
[561.399468] Starting subtest: invalid-fence-in-submit
[561.404476] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[561.522802] [115/133] (462s left) gem_mmap_offset (isolation)
[561.570198] Starting subtest: isolation
[561.583686] Subtest isolation: SUCCESS (0.006s)
[561.692642] [116/133] (462s left) gem_ctx_persistence (processes)
[561.764039] Starting subtest: processes
[562.904642] Subtest processes: SUCCESS (1.140s)
[562.984994] [117/133] (460s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[563.109513] Starting subtest: flip-vs-cursor-busy-crc-legacy
[563.913693] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.804s)
[564.778256] [118/133] (459s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[564.906761] Starting subtest: fbcpsr-rgb565-draw-pwrite
[571.831416] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.926s)
[571.954449] [119/133] (452s left) gem_softpin (allocator-basic-reserve)
[572.019820] Starting subtest: allocator-basic-reserve
[572.086960] Subtest allocator-basic-reserve: SUCCESS (0.066s)
[572.203256] [120/133] (451s left) kms_content_protection (uevent-hdcp14)
[572.343274] Starting subtest: uevent-hdcp14
[572.347409] Subtest uevent-hdcp14: SKIP (0.000s)
[572.475395] [121/133] (451s left) kms_cursor_crc (cursor-sliding-256x256)
[572.732530] Starting subtest: cursor-sliding-256x256
[572.737601] Starting dynamic subtest: pipe-A-eDP-1
[575.982481] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.244s)
[576.017823] Starting dynamic subtest: pipe-D-eDP-1
[579.858120] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.847s)
[579.860355] Subtest cursor-sliding-256x256: SUCCESS (7.122s)
[580.750176] [122/133] (443s left) gem_exec_fence (long-history)
[581.198632] Starting subtest: long-history
[588.655958] Subtest long-history: SUCCESS (7.458s)
[589.110479] [123/133] (435s left) syncobj_basic (bad-flags-fd-to-handle)
[589.170050] Starting subtest: bad-flags-fd-to-handle
[589.172272] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[589.270788] [124/133] (434s left) kms_psr (fbc-psr-cursor-render)
[589.367767] Starting subtest: fbc-psr-cursor-render
[589.370110] Starting dynamic subtest: eDP-1
[589.374362] Dynamic subtest eDP-1: SKIP (0.000s)
[589.378706] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[589.446734] [125/133] (434s left) kms_chamelium_color (ctm-negative)
[589.532182] Subtest ctm-negative: SKIP (0.000s)
[589.577081] [126/133] (434s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[589.678673] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[589.682713] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[589.781240] [127/133] (434s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[589.886800] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[596.542324] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.657s)
[596.682743] [128/133] (427s left) fbdev (write)
[596.730831] Starting subtest: write
[597.091478] Subtest write: SUCCESS (0.359s)
[597.153442] [129/133] (427s left) kms_panel_fitting (atomic-fastset)
[597.242039] Starting subtest: atomic-fastset
[597.243957] Starting dynamic subtest: pipe-A-eDP-1
[597.379145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[597.390053] Starting dynamic subtest: pipe-B-eDP-1
[598.623859] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s)
[598.635795] Starting dynamic subtest: pipe-C-eDP-1
[599.810397] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.185s)
[599.821171] Starting dynamic subtest: pipe-D-eDP-1
[600.952099] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[600.954439] Subtest atomic-fastset: SUCCESS (3.712s)
[602.196906] [130/133] (422s left) kms_cursor_crc (cursor-onscreen-64x64)
[602.377884] Starting subtest: cursor-onscreen-64x64
[602.382962] Starting dynamic subtest: pipe-A-eDP-1
[604.469814] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.088s)
[604.499613] Starting dynamic subtest: pipe-D-eDP-1
[607.263885] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s)
[607.266149] Subtest cursor-onscreen-64x64: SUCCESS (4.886s)
[608.073086] [131/133] (416s left) kms_flip (plain-flip-interruptible)
[608.170333] Starting subtest: plain-flip-interruptible
[608.172627] Starting dynamic subtest: A-eDP1
[609.870741] Dynamic subtest A-eDP1: SUCCESS (1.699s)
[609.882810] Starting dynamic subtest: B-eDP1
[611.507638] Dynamic subtest B-eDP1: SUCCESS (1.634s)
[611.521880] Starting dynamic subtest: C-eDP1
[613.121163] Dynamic subtest C-eDP1: SUCCESS (1.611s)
[613.132815] Starting dynamic subtest: D-eDP1
[614.747817] Dynamic subtest D-eDP1: SUCCESS (1.624s)
[614.752710] Subtest plain-flip-interruptible: SUCCESS (6.583s)
[615.914871] [132/133] (408s left) kms_chamelium_hpd (dp-hpd-fast)
[616.305525] Subtest dp-hpd-fast: SKIP (0.000s)
[617.126820] [133/133] (407s left) gem_userptr_blits (coherency-sync)
[617.196053] Starting subtest: coherency-sync
[617.632927] Subtest coherency-sync: SKIP (0.400s)
[617.731637] Closing watchdogs
results: parsing output: 0/ for test: prime_mmap
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: drm_buddy
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: gem_lmem_swapping
results: parsing output: 13/ for test: kms_vrr
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: sysfs_preempt_timeout
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: kms_prop_blob
results: parsing output: 21/ for test: kms_pm_backlight
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_vblank
results: parsing output: 24/ for test: gen7_exec_parse
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_hdr
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_busy
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_pread
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_color_pipeline
results: parsing output: 36/ for test: gem_pwrite_snooped
results: parsing output: 37/ for test: gem_wait
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_render_copy_redux
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: gem_create
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_hdr
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: kms_selftest
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_plane_lowres
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: tools_test
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: i915_pm_rpm
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: syncobj_eventfd
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_dsc
results: parsing output: 93/ for test: gem_exec_flush
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_ctx_isolation
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: i915_query
results: parsing output: 104/ for test: kms_plane_alpha_blend
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_ctx_param
results: parsing output: 112/ for test: api_intel_bb
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: gem_mmap_offset
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_softpin
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: syncobj_basic
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_chamelium_color
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: fbdev
results: parsing output: 128/ for test: kms_panel_fitting
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_chamelium_hpd
results: parsing output: 132/ for test: gem_userptr_blits
Done.