[57.339277] Initializing watchdogs
[57.339325]   /dev/watchdog0
[57.352654] [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]
[57.356836] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.359397] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.362723] [001/130] (960s left) kms_getfb (getfb2-accept-ccs)
[57.473226] Starting subtest: getfb2-accept-ccs
[57.475551] Subtest getfb2-accept-ccs: SUCCESS (0.000s)
[57.571422] [002/130] (960s left) gem_exec_schedule (implicit-boths)
[57.647803] Starting subtest: implicit-boths
[57.649892] Starting dynamic subtest: rcs0
[57.831870] Dynamic subtest rcs0: SUCCESS (0.186s)
[57.840729] Starting dynamic subtest: vcs0
[57.938047] Dynamic subtest vcs0: SUCCESS (0.106s)
[57.946332] Starting dynamic subtest: vcs1
[58.045392] Dynamic subtest vcs1: SUCCESS (0.105s)
[58.055561] Starting dynamic subtest: vecs0
[58.149071] Dynamic subtest vecs0: SUCCESS (0.103s)
[58.160298] Starting dynamic subtest: ccs0
[58.270825] Dynamic subtest ccs0: SUCCESS (0.120s)
[58.272845] Subtest implicit-boths: SUCCESS (0.620s)
[58.970585] [003/130] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[59.085579] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[59.089803] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[59.200769] [004/130] (958s left) kms_cursor_crc (cursor-random-512x512)
[59.448428] Starting subtest: cursor-random-512x512
[59.452877] Subtest cursor-random-512x512: SKIP (0.001s)
[59.617838] [005/130] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[59.729381] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[59.734040] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[59.829505] [006/130] (958s left) i915_query (query-topology-coherent-slice-mask)
[59.888838] Starting subtest: query-topology-coherent-slice-mask
[59.893035] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[59.984807] [007/130] (958s left) kms_legacy_colorkey (basic)
[60.085592] Starting subtest: basic
[60.087612] Starting dynamic subtest: pipe-A
[60.131529] Dynamic subtest pipe-A: SUCCESS (0.045s)
[60.140653] Starting dynamic subtest: pipe-B
[60.142591] Dynamic subtest pipe-B: SUCCESS (0.001s)
[60.149181] Starting dynamic subtest: pipe-C
[60.150752] Dynamic subtest pipe-C: SUCCESS (0.000s)
[60.157031] Starting dynamic subtest: pipe-D
[60.158768] Dynamic subtest pipe-D: SUCCESS (0.001s)
[60.160507] Subtest basic: SUCCESS (0.047s)
[60.192281] [008/130] (957s left) vgem_basic (sysfs)
[60.256925] Starting subtest: sysfs
[60.260157] Subtest sysfs: SUCCESS (0.000s)
[60.306346] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[60.309050] [009/130] (957s left) kms_addfb_basic (unused-modifier)
[60.357708] Starting subtest: unused-modifier
[60.359561] Subtest unused-modifier: SUCCESS (0.000s)
[60.513871] [010/130] (957s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[60.568463] Starting subtest: invalid-bsd1-flag-on-blt
[60.570485] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[60.662628] [011/130] (957s left) gem_ctx_persistence (legacy-engines-queued)
[60.714505] Starting subtest: legacy-engines-queued
[60.716744] Starting dynamic subtest: render
[60.797658] Dynamic subtest render: SUCCESS (0.082s)
[60.807325] Starting dynamic subtest: bsd1
[61.898876] Dynamic subtest bsd1: SUCCESS (1.089s)
[61.908931] Starting dynamic subtest: bsd2
[63.882432] Dynamic subtest bsd2: SUCCESS (1.968s)
[63.892902] Starting dynamic subtest: blt
[63.979228] Dynamic subtest blt: SUCCESS (0.097s)
[63.989613] Starting dynamic subtest: vebox
[65.930826] Dynamic subtest vebox: SUCCESS (1.936s)
[65.934369] Subtest legacy-engines-queued: SUCCESS (5.178s)
[66.002181] [012/130] (952s left) kms_vblank (query-busy-hang)
[66.099059] Starting subtest: query-busy-hang
[66.101399] Starting dynamic subtest: pipe-A-eDP-1
[92.711800] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.574s)
[92.729513] Starting dynamic subtest: pipe-D-eDP-1
[107.751846] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.033s)
[107.754076] Subtest query-busy-hang: SUCCESS (41.609s)
[108.612736] [013/130] (909s left) gem_exec_schedule (preempt-user)
[108.676634] Starting subtest: preempt-user
[108.678610] Starting dynamic subtest: rcs0
[108.693324] Dynamic subtest rcs0: SUCCESS (0.022s)
[108.703033] Starting dynamic subtest: bcs0
[108.711462] Dynamic subtest bcs0: SUCCESS (0.018s)
[108.718250] Starting dynamic subtest: vcs0
[108.735499] Dynamic subtest vcs0: SUCCESS (0.024s)
[108.742337] Starting dynamic subtest: vcs1
[108.759663] Dynamic subtest vcs1: SUCCESS (0.024s)
[108.766465] Starting dynamic subtest: vecs0
[108.778581] Dynamic subtest vecs0: SUCCESS (0.019s)
[108.785398] Starting dynamic subtest: ccs0
[108.796189] Dynamic subtest ccs0: SUCCESS (0.017s)
[108.798424] Subtest preempt-user: SUCCESS (0.125s)
[110.006704] [014/130] (908s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[110.101045] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[110.103319] Starting dynamic subtest: pipe-A-eDP-1
[126.200863] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.464s)
[126.210654] Starting dynamic subtest: pipe-B-eDP-1
[143.088716] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.333s)
[143.098404] Starting dynamic subtest: pipe-C-eDP-1
[160.056678] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.302s)
[160.069224] Starting dynamic subtest: pipe-D-eDP-1
[177.072737] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.237s)
[177.075086] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.341s)
[178.303992] [015/130] (898s left) kms_flip (basic-flip-vs-dpms)
[178.424090] Starting subtest: basic-flip-vs-dpms
[178.426763] Starting dynamic subtest: A-eDP1
[181.139324] Dynamic subtest A-eDP1: SUCCESS (2.662s)
[181.149737] Starting dynamic subtest: B-eDP1
[183.328723] Dynamic subtest B-eDP1: SUCCESS (2.161s)
[183.338413] Starting dynamic subtest: C-eDP1
[185.399735] Dynamic subtest C-eDP1: SUCCESS (2.048s)
[185.409388] Starting dynamic subtest: D-eDP1
[187.473953] Dynamic subtest D-eDP1: SUCCESS (2.056s)
[187.476504] Subtest basic-flip-vs-dpms: SUCCESS (8.933s)
[188.266865] [016/130] (888s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[188.369187] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[188.371716] Starting dynamic subtest: pipe-A-eDP-1
[188.878700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.505s)
[188.889035] Starting dynamic subtest: pipe-B-eDP-1
[188.910640] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[188.919137] Starting dynamic subtest: pipe-C-eDP-1
[188.942507] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[188.950560] Starting dynamic subtest: pipe-D-eDP-1
[188.973729] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[188.976569] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.518s)
[191.128428] [017/130] (886s left) gem_pxp (hw-rejects-pxp-context)
[191.251456] Starting subtest: hw-rejects-pxp-context
[191.256633] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[191.350857] [018/130] (885s left) gen9_exec_parse (cmd-crossing-page)
[191.422595] Subtest cmd-crossing-page: SKIP (0.000s)
[191.500537] [019/130] (885s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[191.621508] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[191.626281] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[191.724877] [020/130] (885s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[191.821741] Starting subtest: plane-all-transition-nonblocking-fencing
[191.824355] Starting dynamic subtest: pipe-A-eDP-1
[194.385256] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[194.621696] Starting dynamic subtest: pipe-B-eDP-1
[197.937075] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.263s)
[198.163170] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.325s)
[198.998252] [021/130] (878s left) syncobj_timeline (multi-wait-signaled)
[199.062132] Starting subtest: multi-wait-signaled
[199.064354] Subtest multi-wait-signaled: SUCCESS (0.001s)
[199.170325] [022/130] (878s left) kms_invalid_mode (zero-vdisplay)
[199.278712] Starting subtest: zero-vdisplay
[199.281546] Starting dynamic subtest: pipe-A-eDP-1
[199.559256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s)
[199.567749] Starting dynamic subtest: pipe-B-eDP-1
[199.570302] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[199.578421] Starting dynamic subtest: pipe-C-eDP-1
[199.580950] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[199.588742] Starting dynamic subtest: pipe-D-eDP-1
[199.591243] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[199.593427] Subtest zero-vdisplay: SUCCESS (0.286s)
[200.423313] [023/130] (877s left) i915_pm_rps (thresholds-park)
[200.499601] Starting subtest: thresholds-park
[200.505605] Subtest thresholds-park: SKIP (0.000s)
[200.582172] [024/130] (876s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[200.692624] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[200.695643] Starting dynamic subtest: pipe-A-default-mode
[200.984930] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[200.990721] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.286s)
[201.846006] [025/130] (875s left) perf_pmu (busy-hang)
[201.885042] Starting subtest: busy-hang
[201.887587] Starting dynamic subtest: rcs0
[203.180011] Dynamic subtest rcs0: SUCCESS (1.290s)
[203.189706] Starting dynamic subtest: bcs0
[204.414731] Dynamic subtest bcs0: SUCCESS (1.233s)
[204.425209] Starting dynamic subtest: vcs0
[206.932135] Dynamic subtest vcs0: SUCCESS (2.517s)
[206.947236] Starting dynamic subtest: vcs1
[208.918632] Dynamic subtest vcs1: SUCCESS (1.982s)
[208.928459] Starting dynamic subtest: vecs0
[210.908434] Dynamic subtest vecs0: SUCCESS (1.988s)
[210.917763] Starting dynamic subtest: ccs0
[212.138006] Dynamic subtest ccs0: SUCCESS (1.229s)
[212.140717] Subtest busy-hang: SUCCESS (10.243s)
[212.229300] [026/130] (865s left) gem_exec_params (invalid-flag)
[212.297049] Starting subtest: invalid-flag
[212.300010] Subtest invalid-flag: SUCCESS (0.000s)
[212.416942] [027/130] (865s left) gem_create (create-ext-cpu-access-big)
[212.596693] Starting subtest: create-ext-cpu-access-big
[212.602421] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[212.667495] [028/130] (865s left) kms_pm_rpm (cursor-dpms)
[214.616173] Starting subtest: cursor-dpms
[214.622349] Subtest cursor-dpms: SKIP (0.000s)
[214.993191] [029/130] (862s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[215.125162] Starting subtest: short-busy-flip-before-cursor-toggle
[215.130316] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[215.221443] [030/130] (862s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[215.612736] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[216.390379] [031/130] (861s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[216.515721] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[217.866418] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.351s)
[218.664060] [032/130] (859s left) gem_exec_gttfill (multigpu-basic)
[218.841564] Starting subtest: multigpu-basic
[232.719213] Subtest multigpu-basic: SUCCESS (13.877s)
[232.771725] [033/130] (845s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[232.933424] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[237.673414] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.743s)
[237.806406] [034/130] (840s left) perf_pmu (frequency)
[237.852450] Starting subtest: frequency
[237.855138] Starting dynamic subtest: gt0
[240.008199] Dynamic subtest gt0: SUCCESS (2.148s)
[240.019463] Starting dynamic subtest: idle-gt0
[240.512730] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[240.522382] Starting dynamic subtest: gt1
[245.428539] Dynamic subtest gt1: SUCCESS (4.909s)
[245.439611] Starting dynamic subtest: idle-gt1
[245.930736] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[245.934240] Subtest frequency: SUCCESS (8.078s)
[246.054135] [035/130] (831s left) kms_psr (fbc-psr-cursor-plane-onoff)
[246.160629] Starting subtest: fbc-psr-cursor-plane-onoff
[246.163546] Starting dynamic subtest: eDP-1
[246.169009] Dynamic subtest eDP-1: SKIP (0.000s)
[246.174572] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[246.233041] [036/130] (831s left) kms_chamelium_edid (vga-edid-read)
[246.623418] Subtest vga-edid-read: SKIP (0.000s)
[247.428954] [037/130] (830s left) perf_pmu (semaphore-busy)
[247.473068] Starting subtest: semaphore-busy
[247.475597] Starting dynamic subtest: rcs0
[249.120955] Dynamic subtest rcs0: SUCCESS (1.643s)
[249.131009] Starting dynamic subtest: bcs0
[250.751789] Dynamic subtest bcs0: SUCCESS (1.628s)
[250.762600] Starting dynamic subtest: vcs0
[254.978418] Dynamic subtest vcs0: SUCCESS (4.173s)
[254.990297] Starting dynamic subtest: vcs1
[260.993696] Dynamic subtest vcs1: SUCCESS (6.011s)
[261.005726] Starting dynamic subtest: vecs0
[266.896127] Dynamic subtest vecs0: SUCCESS (5.949s)
[266.907695] Starting dynamic subtest: ccs0
[270.030361] Dynamic subtest ccs0: SUCCESS (3.133s)
[270.032683] Subtest semaphore-busy: SUCCESS (22.545s)
[270.141689] [038/130] (807s left) syncobj_wait (reset-during-wait-for-submit)
[270.223708] Starting subtest: reset-during-wait-for-submit
[270.327155] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[270.401075] [039/130] (807s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[270.453618] Starting subtest: etime-multi-wait-available-unsubmitted
[270.560133] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[270.634301] [040/130] (807s left) i915_pm_rc6_residency (rc6-idle)
[270.690391] Starting subtest: rc6-idle
[270.722327] Starting dynamic subtest: gt0-rcs0
[282.992897] Dynamic subtest gt0-rcs0: SUCCESS (12.221s)
[283.003701] Starting dynamic subtest: gt0-bcs0
[295.196944] Dynamic subtest gt0-bcs0: SUCCESS (12.256s)
[295.206305] Starting dynamic subtest: gt0-ccs0
[307.502756] Dynamic subtest gt0-ccs0: SUCCESS (12.253s)
[307.523622] Starting dynamic subtest: gt1-vcs0
[319.666881] Dynamic subtest gt1-vcs0: SUCCESS (12.213s)
[319.679601] Starting dynamic subtest: gt1-vecs0
[332.554518] Dynamic subtest gt1-vecs0: SUCCESS (12.884s)
[332.557470] Subtest rc6-idle: SUCCESS (61.869s)
[333.369171] [041/130] (744s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[333.437526] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[333.492646] [042/130] (744s left) gem_lmem_swapping (verify)
[333.537636] Subtest verify: SKIP (0.000s)
[333.571820] [043/130] (744s left) kms_big_fb (linear-8bpp-rotate-180)
[333.684503] Starting subtest: linear-8bpp-rotate-180
[334.928557] Subtest linear-8bpp-rotate-180: SUCCESS (1.246s)
[335.069950] [044/130] (743s left) drm_fdinfo (busy-idle-check-all)
[335.121596] Starting subtest: busy-idle-check-all
[335.124235] Starting dynamic subtest: rcs0
[335.129170] Dynamic subtest rcs0: SKIP (0.004s)
[335.137761] Starting dynamic subtest: bcs0
[335.143451] Dynamic subtest bcs0: SKIP (0.000s)
[335.152564] Starting dynamic subtest: vcs0
[335.157687] Dynamic subtest vcs0: SKIP (0.000s)
[335.166208] Starting dynamic subtest: vcs1
[335.171243] Dynamic subtest vcs1: SKIP (0.000s)
[335.180546] Starting dynamic subtest: vecs0
[335.185591] Dynamic subtest vecs0: SKIP (0.000s)
[335.194347] Starting dynamic subtest: ccs0
[335.199495] Dynamic subtest ccs0: SKIP (0.000s)
[335.204686] Subtest busy-idle-check-all: SKIP (0.007s)
[335.235894] [045/130] (743s left) kms_vrr (flipline)
[335.380039] Starting subtest: flipline
[335.387213] Subtest flipline: SKIP (0.000s)
[335.447446] [046/130] (742s left) gem_exec_params (dr1-dirt)
[335.516418] Starting subtest: DR1-dirt
[335.518733] Subtest DR1-dirt: SUCCESS (0.000s)
[335.629877] [047/130] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[335.733749] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[335.737974] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[335.838422] [048/130] (742s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[335.941726] Starting subtest: bo-too-small-due-to-tiling
[335.946565] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[336.033939] [049/130] (742s left) gem_ctx_create (basic-files)
[336.098027] Starting subtest: basic-files
[338.108979] Subtest basic-files: SUCCESS (2.011s)
[339.453055] [050/130] (739s left) gem_exec_schedule (u-lateslice)
[339.540439] Starting subtest: u-lateslice
[339.543237] Starting dynamic subtest: rcs0
[339.561605] Dynamic subtest rcs0: SUCCESS (0.031s)
[339.572741] Starting dynamic subtest: bcs0
[339.584685] Dynamic subtest bcs0: SUCCESS (0.023s)
[339.594385] Starting dynamic subtest: vcs0
[339.609625] Dynamic subtest vcs0: SUCCESS (0.024s)
[339.618711] Starting dynamic subtest: vcs1
[339.632138] Dynamic subtest vcs1: SUCCESS (0.022s)
[339.640950] Starting dynamic subtest: vecs0
[339.655290] Dynamic subtest vecs0: SUCCESS (0.023s)
[339.663761] Starting dynamic subtest: ccs0
[339.682096] Dynamic subtest ccs0: SUCCESS (0.026s)
[339.684802] Subtest u-lateslice: SUCCESS (0.152s)
[341.485613] [051/130] (737s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[341.595617] Starting subtest: verify-pxp-execution-after-suspend-resume
[348.523427] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (6.929s)
[348.657886] [052/130] (729s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[348.782969] Starting subtest: cursorB-vs-flipA-atomic-transitions
[348.787600] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[348.909724] [053/130] (729s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[348.968605] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[348.971400] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[349.074893] [054/130] (729s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[349.187717] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[349.199490] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[349.267307] [055/130] (729s left) gem_eio (wait-wedge-1us)
[349.494405] Starting subtest: wait-wedge-1us
[350.499649] Subtest wait-wedge-1us: SUCCESS (1.005s)
[350.655761] [056/130] (728s left) syncobj_timeline (invalid-query-one-illegal-handle)
[350.717211] Starting subtest: invalid-query-one-illegal-handle
[350.719607] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[350.805968] [057/130] (727s left) gem_mmap_gtt (basic-read)
[350.869210] Subtest basic-read: SKIP (0.000s)
[350.931322] [058/130] (727s left) kms_chamelium_hpd (vga-hpd)
[351.326950] Subtest vga-hpd: SKIP (0.000s)
[352.143629] [059/130] (726s left) kms_flip (busy-flip)
[352.245581] Starting subtest: busy-flip
[352.248381] Starting dynamic subtest: A-eDP1
[353.972996] Dynamic subtest A-eDP1: SUCCESS (1.727s)
[353.983693] Starting dynamic subtest: B-eDP1
[355.703990] Dynamic subtest B-eDP1: SUCCESS (1.730s)
[355.715460] Starting dynamic subtest: C-eDP1
[357.417571] Dynamic subtest C-eDP1: SUCCESS (1.713s)
[357.427958] Starting dynamic subtest: D-eDP1
[359.148739] Dynamic subtest D-eDP1: SUCCESS (1.730s)
[359.151681] Subtest busy-flip: SUCCESS (6.907s)
[360.296953] [060/130] (718s left) template (a)
[360.355723] Starting subtest: A
[360.358692] Subtest A: SUCCESS (0.000s)
[360.461282] [061/130] (718s left) syncobj_eventfd (binary-wait)
[360.519330] Starting subtest: binary-wait
[360.527306] Subtest binary-wait: SUCCESS (0.010s)
[360.605388] [062/130] (718s left) gem_exec_whisper (basic-queues-priority)
[360.676352] Starting subtest: basic-queues-priority
[383.202938] Subtest basic-queues-priority: SUCCESS (22.521s)
[383.382158] [063/130] (695s left) gem_exec_balancer (nohangcheck)
[383.632481] Starting subtest: nohangcheck
[384.399233] Subtest nohangcheck: SUCCESS (0.765s)
[384.523797] [064/130] (694s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[384.639721] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[385.519444] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.881s)
[385.746773] [065/130] (693s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[385.863576] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[385.868464] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[385.967815] [066/130] (693s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[386.069177] Starting subtest: invalidate-primary-flip-overlay
[396.877863] Subtest invalidate-primary-flip-overlay: SUCCESS (10.807s)
[397.021250] [067/130] (682s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[397.137301] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[399.907637] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.774s)
[400.054898] [068/130] (679s left) gem_userptr_blits (nohangcheck)
[400.137594] Starting subtest: nohangcheck
[400.390031] Subtest nohangcheck: SUCCESS (0.247s)
[400.522933] [069/130] (678s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[400.624287] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[400.629106] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[400.732715] [070/130] (678s left) gem_eio (wait-wedge-immediate)
[400.949471] Starting subtest: wait-wedge-immediate
[402.464369] Subtest wait-wedge-immediate: SUCCESS (1.513s)
[402.607617] [071/130] (676s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[402.718408] Starting subtest: yf-tiled-16bpp-rotate-180
[402.722943] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[402.823848] [072/130] (676s left) intel_hwmon (hwmon-read)
[402.878104] Subtest hwmon-read: SKIP (0.000s)
[402.925434] [073/130] (676s left) gem_exec_fence (nb-await)
[403.111500] Starting subtest: nb-await
[403.114535] Starting dynamic subtest: rcs0
[403.181819] Dynamic subtest rcs0: SUCCESS (0.070s)
[403.193605] Starting dynamic subtest: bcs0
[403.245150] Dynamic subtest bcs0: SUCCESS (0.061s)
[403.263876] Starting dynamic subtest: vcs0
[403.303406] Dynamic subtest vcs0: SUCCESS (0.057s)
[403.315870] Starting dynamic subtest: vcs1
[403.362555] Dynamic subtest vcs1: SUCCESS (0.058s)
[403.375070] Starting dynamic subtest: vecs0
[403.421059] Dynamic subtest vecs0: SUCCESS (0.057s)
[403.433540] Starting dynamic subtest: ccs0
[403.480488] Dynamic subtest ccs0: SUCCESS (0.058s)
[403.483529] Subtest nb-await: SUCCESS (0.369s)
[404.470094] [074/130] (674s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[404.563020] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[404.565490] Starting dynamic subtest: pipe-A-eDP-1
[404.595081] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[404.605896] Starting dynamic subtest: pipe-B-eDP-1
[404.634926] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[404.644282] Starting dynamic subtest: pipe-C-eDP-1
[404.672957] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[404.682368] Starting dynamic subtest: pipe-D-eDP-1
[404.711854] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[404.716674] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[406.700362] [075/130] (672s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[406.756024] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[406.759024] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[406.865969] [076/130] (672s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[406.968348] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[406.973540] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[407.056955] [077/130] (672s left) api_intel_allocator (reloc-allocator)
[407.112991] Starting subtest: reloc-allocator
[407.115715] Starting dynamic subtest: basic
[407.118021] Dynamic subtest basic: SUCCESS (0.004s)
[407.128359] Starting dynamic subtest: parallel-one
[407.131005] Dynamic subtest parallel-one: SUCCESS (0.008s)
[407.141479] Starting dynamic subtest: print
[407.144141] Dynamic subtest print: SUCCESS (0.000s)
[407.153525] Starting dynamic subtest: reuse
[407.156337] Dynamic subtest reuse: SUCCESS (0.000s)
[407.165719] Starting dynamic subtest: fork-reopen-allocator
[407.168527] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[407.171064] Subtest reloc-allocator: SUCCESS (0.027s)
[407.254096] [078/130] (672s left) gem_exec_balancer (bonded-dual)
[407.317400] Starting subtest: bonded-dual
[407.322528] Subtest bonded-dual: SKIP (0.000s)
[407.587775] [079/130] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[407.700723] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[413.292226] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.594s)
[413.410787] [080/130] (666s left) kms_plane (plane-position-covered)
[413.521695] Starting subtest: plane-position-covered
[414.025643] Starting dynamic subtest: pipe-A-plane-1
[415.270456] Dynamic subtest pipe-A-plane-1: SUCCESS (1.244s)
[415.280689] Starting dynamic subtest: pipe-A-plane-2
[416.500647] Dynamic subtest pipe-A-plane-2: SUCCESS (1.230s)
[416.511096] Starting dynamic subtest: pipe-A-plane-3
[417.728124] Dynamic subtest pipe-A-plane-3: SUCCESS (1.226s)
[417.737981] Starting dynamic subtest: pipe-A-plane-4
[418.958713] Dynamic subtest pipe-A-plane-4: SUCCESS (1.229s)
[418.968602] Starting dynamic subtest: pipe-A-plane-5
[418.998647] Dynamic subtest pipe-A-plane-5: SUCCESS (0.039s)
[420.106800] Starting dynamic subtest: pipe-B-plane-1
[421.327265] Dynamic subtest pipe-B-plane-1: SUCCESS (1.227s)
[421.337011] Starting dynamic subtest: pipe-B-plane-2
[422.570834] Dynamic subtest pipe-B-plane-2: SUCCESS (1.243s)
[422.581373] Starting dynamic subtest: pipe-B-plane-3
[423.870537] Dynamic subtest pipe-B-plane-3: SUCCESS (1.300s)
[423.880964] Starting dynamic subtest: pipe-B-plane-4
[425.120649] Dynamic subtest pipe-B-plane-4: SUCCESS (1.249s)
[425.131542] Starting dynamic subtest: pipe-B-plane-5
[425.157739] Dynamic subtest pipe-B-plane-5: SUCCESS (0.036s)
[425.160490] Subtest plane-position-covered: SUCCESS (11.631s)
[425.896007] [081/130] (653s left) gem_wait (invalid-flags)
[425.967420] Starting subtest: invalid-flags
[425.969868] Subtest invalid-flags: SUCCESS (0.000s)
[426.192264] [082/130] (653s left) kms_psr (psr-primary-render)
[426.290728] Starting subtest: psr-primary-render
[426.293285] Starting dynamic subtest: eDP-1
[428.015028] Dynamic subtest eDP-1: SUCCESS (1.724s)
[428.017478] Subtest psr-primary-render: SUCCESS (1.725s)
[428.855169] [083/130] (650s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[428.955390] Starting subtest: 4-tiled-16bpp-rotate-270
[428.974934] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[429.094379] [084/130] (650s left) gen7_exec_parse (basic-offset)
[429.154980] Subtest basic-offset: SKIP (0.000s)
[429.205489] [085/130] (650s left) kms_addfb_basic (bad-pitch-128)
[429.273484] Starting subtest: bad-pitch-128
[429.275682] Subtest bad-pitch-128: SUCCESS (0.000s)
[429.398040] [086/130] (650s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[429.505557] Starting subtest: fbcpsr-shrfb-scaledprimary
[435.205619] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.701s)
[435.358934] [087/130] (644s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[435.470287] Starting subtest: fbc-rgb565-draw-blt
[438.687281] Subtest fbc-rgb565-draw-blt: SUCCESS (3.221s)
[438.830817] [088/130] (641s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[438.930250] Starting subtest: fbc-pr-sprite-mmap-gtt
[438.935199] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[438.997447] [089/130] (641s left) gem_tiled_partial_pwrite_pread (writes)
[439.068131] Subtest writes: SKIP (0.000s)
[439.147434] [090/130] (640s left) perf_pmu (interrupts)
[439.198027] Starting subtest: interrupts
[440.276207] Subtest interrupts: SUCCESS (1.084s)
[440.389893] [091/130] (639s left) gem_softpin (allocator-nopin-reserve)
[440.454107] Starting subtest: allocator-nopin-reserve
[440.535308] Subtest allocator-nopin-reserve: SUCCESS (0.082s)
[440.663759] [092/130] (639s left) kms_pm_backlight (fade)
[440.768847] Starting subtest: fade
[440.830989] Starting dynamic subtest: eDP-1
[443.491529] Dynamic subtest eDP-1: SUCCESS (2.656s)
[443.494365] Subtest fade: SUCCESS (2.721s)
[444.276133] [093/130] (635s left) kms_cursor_crc (cursor-alpha-transparent)
[444.374242] Starting subtest: cursor-alpha-transparent
[444.376628] Starting dynamic subtest: pipe-A-eDP-1
[445.013167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[445.023146] Starting dynamic subtest: pipe-D-eDP-1
[446.259289] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[446.261689] Subtest cursor-alpha-transparent: SUCCESS (1.885s)
[447.123151] [094/130] (633s left) gem_render_copy (x-tiled)
[447.182191] Starting subtest: x-tiled
[447.184847] Starting dynamic subtest: smem
[447.226096] Dynamic subtest smem: SUCCESS (0.043s)
[447.229042] Subtest x-tiled: SUCCESS (0.044s)
[447.454135] [095/130] (632s left) kms_display_modes (extended-mode-basic)
[447.547926] Starting subtest: extended-mode-basic
[447.552720] Subtest extended-mode-basic: SKIP (0.000s)
[447.592333] [096/130] (632s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[447.696756] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[447.702148] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[447.798989] [097/130] (632s left) gem_mmap_offset (bad-object)
[447.858599] Starting subtest: bad-object
[447.861636] Subtest bad-object: SUCCESS (0.001s)
[447.966403] [098/130] (632s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[448.024841] Starting subtest: invalid-smem-bo-on-discrete
[448.030263] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[448.160800] [099/130] (632s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[448.255485] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[448.258259] Starting dynamic subtest: pipe-A-eDP-1
[448.283200] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.293470] Starting dynamic subtest: pipe-B-eDP-1
[448.317708] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[448.326647] Starting dynamic subtest: pipe-C-eDP-1
[448.351696] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[448.360471] Starting dynamic subtest: pipe-D-eDP-1
[448.383275] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[448.388333] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[450.395631] [100/130] (630s left) gem_userptr_blits (map-fixed-invalidate-busy)
[450.466925] Starting subtest: map-fixed-invalidate-busy
[450.471917] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[450.611114] [101/130] (629s left) kms_psr (psr2-primary-mmap-cpu)
[450.699634] Starting subtest: psr2-primary-mmap-cpu
[450.705731] Starting dynamic subtest: eDP-1
[452.489607] Dynamic subtest eDP-1: SUCCESS (1.785s)
[452.492462] Subtest psr2-primary-mmap-cpu: SUCCESS (1.786s)
[453.352431] [102/130] (627s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[453.451273] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[453.456419] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[453.545040] [103/130] (626s left) sysfs_timeslice_duration (idempotent)
[453.601201] Starting subtest: idempotent
[453.603723] Starting dynamic subtest: vecs0
[453.606506] Dynamic subtest vecs0: SUCCESS (0.000s)
[453.617555] Starting dynamic subtest: ccs0
[453.620492] Dynamic subtest ccs0: SUCCESS (0.000s)
[453.630640] Starting dynamic subtest: vcs0
[453.633601] Dynamic subtest vcs0: SUCCESS (0.000s)
[453.644703] Starting dynamic subtest: bcs0
[453.647543] Dynamic subtest bcs0: SUCCESS (0.000s)
[453.657220] Starting dynamic subtest: rcs0
[453.659473] Dynamic subtest rcs0: SUCCESS (0.000s)
[453.669224] Starting dynamic subtest: vcs1
[453.671683] Dynamic subtest vcs1: SUCCESS (0.000s)
[453.674313] Subtest idempotent: SUCCESS (0.005s)
[453.709518] [104/130] (626s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[458.693874] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[458.696703] Starting dynamic subtest: pipe-A-eDP-1
[459.495699] Dynamic subtest pipe-A-eDP-1: SKIP (0.799s)
[459.507989] Starting dynamic subtest: pipe-B-eDP-1
[460.621189] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[460.626735] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.926s)
[461.791430] [105/130] (618s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[461.897231] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[466.515312] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.620s)
[466.673705] [106/130] (613s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[466.783616] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[466.786359] Starting dynamic subtest: pipe-A
[468.558741] Dynamic subtest pipe-A: SUCCESS (1.778s)
[468.570632] Starting dynamic subtest: pipe-B
[471.377041] Dynamic subtest pipe-B: SUCCESS (2.817s)
[471.387053] Starting dynamic subtest: pipe-C
[472.573550] Dynamic subtest pipe-C: SUCCESS (1.195s)
[472.583967] Starting dynamic subtest: pipe-D
[473.825517] Dynamic subtest pipe-D: SUCCESS (1.252s)
[473.828516] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (7.044s)
[474.960377] [107/130] (605s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt)
[475.074568] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt
[475.080043] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[475.183020] [108/130] (605s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[475.233705] Starting subtest: multi-wait-all-for-submit-available-signaled
[475.236720] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[475.337057] [109/130] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[475.437470] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[475.442346] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[475.547243] [110/130] (605s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[475.652700] Starting subtest: stress-xrgb8888-ytiled
[475.658305] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[475.741332] [111/130] (605s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[475.847759] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[475.853170] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[475.945904] [112/130] (604s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[476.034940] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[476.037276] Starting dynamic subtest: pipe-A-default-mode
[476.323729] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[476.329397] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.284s)
[477.184061] [113/130] (603s left) gem_ctx_persistence (engines-mixed-process)
[477.256505] Starting subtest: engines-mixed-process
[477.259630] Starting dynamic subtest: rcs0
[479.399882] Dynamic subtest rcs0: SUCCESS (2.143s)
[479.411714] Starting dynamic subtest: bcs0
[481.455014] Dynamic subtest bcs0: SUCCESS (2.053s)
[481.467023] Starting dynamic subtest: vcs0
[483.426040] Dynamic subtest vcs0: SUCCESS (1.969s)
[483.438282] Starting dynamic subtest: vcs1
[485.406008] Dynamic subtest vcs1: SUCCESS (1.978s)
[485.417026] Starting dynamic subtest: vecs0
[487.415935] Dynamic subtest vecs0: SUCCESS (2.008s)
[487.426449] Starting dynamic subtest: ccs0
[489.437749] Dynamic subtest ccs0: SUCCESS (2.020s)
[489.440792] Subtest engines-mixed-process: SUCCESS (12.180s)
[489.515271] [114/130] (591s left) gem_eio (suspend)
[489.756488] Starting subtest: suspend
[501.630579] Subtest suspend: SUCCESS (11.875s)
[501.777835] [115/130] (579s left) drm_fdinfo (memory-info-resident)
[501.823279] Starting subtest: memory-info-resident
[501.826053] Starting dynamic subtest: smem0
[504.816722] Dynamic subtest smem0: SUCCESS (2.994s)
[504.819725] Subtest memory-info-resident: SUCCESS (2.994s)
[504.888196] [116/130] (576s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[504.994632] Starting subtest: plane-use-after-nonblocking-unbind
[504.997595] Starting dynamic subtest: pipe-A-eDP-1
[505.065312] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.072s)
[505.371241] Starting dynamic subtest: pipe-B-eDP-1
[506.155632] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.799s)
[506.429505] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.437s)
[507.299593] [117/130] (573s left) kms_feature_discovery (display)
[507.390292] Starting subtest: display
[507.392709] Subtest display: SUCCESS (0.000s)
[507.462870] [118/130] (573s left) gem_lmem_swapping (verify-random-ccs)
[507.504719] Subtest verify-random-ccs: SKIP (0.000s)
[507.545404] [119/130] (573s left) kms_psr (fbc-psr-primary-blt)
[507.635499] Starting subtest: fbc-psr-primary-blt
[507.637616] Starting dynamic subtest: eDP-1
[507.642300] Dynamic subtest eDP-1: SKIP (0.000s)
[507.647283] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[507.702550] [120/130] (573s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[507.813797] Starting subtest: psr-1p-primscrn-spr-indfb-move
[513.104022] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (5.294s)
[513.247498] [121/130] (567s left) syncobj_timeline (wait-all-interrupted)
[513.312751] Starting subtest: wait-all-interrupted
[513.413740] Subtest wait-all-interrupted: SUCCESS (0.103s)
[513.486156] [122/130] (567s left) kms_cursor_crc (cursor-sliding-128x42)
[513.697482] Starting subtest: cursor-sliding-128x42
[513.736729] Subtest cursor-sliding-128x42: SKIP (0.034s)
[513.950077] [123/130] (567s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[514.018220] Starting subtest: wait-all-for-submit-delayed-submit
[514.118550] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[514.195098] [124/130] (567s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[514.305313] Starting subtest: y-tiled-16bpp-rotate-90
[514.309454] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[514.412070] [125/130] (566s left) gem_ctx_engines (none)
[514.482919] Starting subtest: none
[514.485397] Subtest none: SUCCESS (0.001s)
[514.667059] [126/130] (566s left) kms_psr2_su (page_flip-p010)
[514.731619] Subtest page_flip-P010: SKIP (0.000s)
[514.781596] [127/130] (566s left) api_intel_bb (offset-control)
[514.837686] Starting subtest: offset-control
[514.845566] Subtest offset-control: SUCCESS (0.009s)
[514.972054] [128/130] (566s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[520.020820] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[520.026378] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[520.858689] [129/130] (560s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[520.963460] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[522.219265] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.256s)
[522.360766] [130/130] (559s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[522.467030] Starting subtest: bad-pixel-format-yf-tiled-ccs
[522.469351] Starting dynamic subtest: pipe-A-eDP-1
[522.490559] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[522.500481] Starting dynamic subtest: pipe-B-eDP-1
[522.522992] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[522.532706] Starting dynamic subtest: pipe-C-eDP-1
[522.556548] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[522.566409] Starting dynamic subtest: pipe-D-eDP-1
[522.589997] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[522.594580] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[524.616756] Closing watchdogs
results: parsing output: 0/ for test: kms_getfb
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_query
results: parsing output: 6/ for test: kms_legacy_colorkey
results: parsing output: 7/ for test: vgem_basic
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: gem_ctx_persistence
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_pxp
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_atomic_transition
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_invalid_mode
results: parsing output: 22/ for test: i915_pm_rps
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: gem_create
results: parsing output: 27/ for test: kms_pm_rpm
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: gem_exec_gttfill
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_chamelium_edid
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: i915_pm_rc6_residency
results: parsing output: 40/ for test: kms_pipe_b_c_ivb
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: drm_fdinfo
results: parsing output: 44/ for test: kms_vrr
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: gem_ctx_create
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_chamelium_hpd
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: template
results: parsing output: 60/ for test: syncobj_eventfd
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr_stress_test
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: intel_hwmon
results: parsing output: 72/ for test: gem_exec_fence
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: api_intel_allocator
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: gem_wait
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gen7_exec_parse
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: gem_softpin
results: parsing output: 91/ for test: kms_pm_backlight
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: kms_display_modes
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: sysfs_timeslice_duration
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_pipe_stress
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: drm_fdinfo
results: parsing output: 115/ for test: kms_atomic_transition
results: parsing output: 116/ for test: kms_feature_discovery
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_ctx_engines
results: parsing output: 125/ for test: kms_psr2_su
results: parsing output: 126/ for test: api_intel_bb
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_ccs
Done.