[60.650032] Initializing watchdogs
[60.650116]   /dev/watchdog0
[60.664568] [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]
[60.668673] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.671014] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.674378] [001/132] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[60.807764] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[64.492321] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.687s)
[65.703943] [002/132] (955s left) kms_pm_rpm (modeset-lpsp-stress)
[67.246362] Starting subtest: modeset-lpsp-stress
[83.650198] Subtest modeset-lpsp-stress: SUCCESS (16.402s)
[83.762408] [003/132] (937s left) kms_plane_scaling (2x-scaler-multi-pipe)
[83.861464] Starting subtest: 2x-scaler-multi-pipe
[83.865844] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[83.990096] [004/132] (937s left) kms_cursor_crc (cursor-sliding-256x256)
[84.219147] Starting subtest: cursor-sliding-256x256
[84.221490] Starting dynamic subtest: pipe-A-eDP-1
[87.436493] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.215s)
[87.465205] Starting dynamic subtest: pipe-D-eDP-1
[91.305321] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.843s)
[91.307641] Subtest cursor-sliding-256x256: SUCCESS (7.086s)
[92.207582] [005/132] (929s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[92.324899] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[92.329169] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[92.460675] [006/132] (928s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[92.553139] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[92.555451] Starting dynamic subtest: pipe-A-eDP-1
[92.696972] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.134s)
[92.706999] Starting dynamic subtest: pipe-B-eDP-1
[92.726614] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[92.733746] Starting dynamic subtest: pipe-C-eDP-1
[92.753056] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[92.759732] Starting dynamic subtest: pipe-D-eDP-1
[92.778669] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[92.780502] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.142s)
[94.965202] [007/132] (926s left) kms_plane_multiple (tiling-4)
[95.072785] Starting subtest: tiling-4
[95.074644] Starting dynamic subtest: pipe-A-eDP-1
[98.780531] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.708s)
[98.789265] Starting dynamic subtest: pipe-B-eDP-1
[103.209992] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.429s)
[103.218950] Starting dynamic subtest: pipe-C-eDP-1
[107.524970] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.313s)
[107.533474] Starting dynamic subtest: pipe-D-eDP-1
[111.884564] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.358s)
[111.886470] Subtest tiling-4: SUCCESS (16.813s)
[112.711760] [008/132] (908s left) gem_wait (write-busy)
[112.779295] Starting subtest: write-busy
[112.781696] Starting dynamic subtest: all-engines
[113.451429] Dynamic subtest all-engines: SUCCESS (0.671s)
[113.466826] Starting dynamic subtest: rcs0
[114.000260] Dynamic subtest rcs0: SUCCESS (0.548s)
[114.014287] Starting dynamic subtest: bcs0
[114.546552] Dynamic subtest bcs0: SUCCESS (0.546s)
[114.560098] Starting dynamic subtest: vcs0
[115.925534] Dynamic subtest vcs0: SUCCESS (1.376s)
[115.939718] Starting dynamic subtest: vcs1
[117.909218] Dynamic subtest vcs1: SUCCESS (1.982s)
[117.923051] Starting dynamic subtest: vecs0
[119.892995] Dynamic subtest vecs0: SUCCESS (1.982s)
[119.906557] Starting dynamic subtest: ccs0
[120.442048] Dynamic subtest ccs0: SUCCESS (0.549s)
[120.446518] Subtest write-busy: SUCCESS (7.663s)
[120.657321] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[120.660387] [009/132] (900s left) perf_pmu (init-busy)
[120.708995] Starting subtest: init-busy
[120.711341] Starting dynamic subtest: rcs0
[120.713585] Dynamic subtest rcs0: SUCCESS (0.001s)
[120.721977] Starting dynamic subtest: bcs0
[120.724208] Dynamic subtest bcs0: SUCCESS (0.001s)
[120.730742] Starting dynamic subtest: vcs0
[120.732970] Dynamic subtest vcs0: SUCCESS (0.001s)
[120.739506] Starting dynamic subtest: vcs1
[120.741715] Dynamic subtest vcs1: SUCCESS (0.001s)
[120.748349] Starting dynamic subtest: vecs0
[120.750568] Dynamic subtest vecs0: SUCCESS (0.001s)
[120.757090] Starting dynamic subtest: ccs0
[120.759240] Dynamic subtest ccs0: SUCCESS (0.000s)
[120.761396] Subtest init-busy: SUCCESS (0.007s)
[120.867514] [010/132] (900s left) syncobj_timeline (signal-point-0)
[120.925138] Starting subtest: signal-point-0
[120.927556] Subtest signal-point-0: SUCCESS (0.000s)
[121.070177] [011/132] (900s left) perf (invalid-remove-userspace-config)
[121.217728] Starting subtest: invalid-remove-userspace-config
[121.227328] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[121.272379] [012/132] (900s left) kms_vrr (flip-basic-fastset)
[121.373883] Starting subtest: flip-basic-fastset
[121.380233] Subtest flip-basic-fastset: SKIP (0.000s)
[121.466884] [013/132] (900s left) kms_psr (psr-sprite-blt)
[121.568059] Starting subtest: psr-sprite-blt
[121.570267] Starting dynamic subtest: eDP-1
[123.312852] Dynamic subtest eDP-1: SUCCESS (1.745s)
[123.315147] Subtest psr-sprite-blt: SUCCESS (1.746s)
[124.178370] [014/132] (897s left) gem_exec_schedule (pi-common)
[124.376820] Starting subtest: pi-common
[124.378757] Starting dynamic subtest: rcs0
[124.400573] Dynamic subtest rcs0: SUCCESS (0.025s)
[124.412135] Starting dynamic subtest: bcs0
[124.427398] Dynamic subtest bcs0: SUCCESS (0.026s)
[124.438680] Starting dynamic subtest: vcs0
[124.452642] Dynamic subtest vcs0: SUCCESS (0.025s)
[124.463548] Starting dynamic subtest: vcs1
[124.479153] Dynamic subtest vcs1: SUCCESS (0.026s)
[124.490368] Starting dynamic subtest: vecs0
[124.505819] Dynamic subtest vecs0: SUCCESS (0.026s)
[124.516377] Starting dynamic subtest: ccs0
[124.532214] Dynamic subtest ccs0: SUCCESS (0.026s)
[124.534331] Subtest pi-common: SUCCESS (0.158s)
[124.809229] [015/132] (896s left) kms_prop_blob (blob-prop-validate)
[124.873336] Starting subtest: blob-prop-validate
[124.875816] Subtest blob-prop-validate: SUCCESS (0.000s)
[125.003643] [016/132] (896s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[125.103663] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[129.553361] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.453s)
[130.776816] [017/132] (891s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[130.903663] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[131.880655] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.974s)
[132.692072] [018/132] (889s left) perf_pmu (interrupts)
[132.730823] Starting subtest: interrupts
[133.779028] Subtest interrupts: SUCCESS (1.047s)
[133.923977] [019/132] (887s left) kms_psr (psr2-primary-mmap-cpu)
[134.026472] Starting subtest: psr2-primary-mmap-cpu
[134.028837] Starting dynamic subtest: eDP-1
[135.750531] Dynamic subtest eDP-1: SUCCESS (1.722s)
[135.752683] Subtest psr2-primary-mmap-cpu: SUCCESS (1.723s)
[136.654410] [020/132] (885s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[136.717076] Starting subtest: wait-all-for-submit-delayed-submit
[136.820086] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[136.924083] [021/132] (885s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[141.879524] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[141.882087] Starting dynamic subtest: pipe-A-eDP-1
[142.680069] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s)
[142.688096] Starting dynamic subtest: pipe-B-eDP-1
[143.815369] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[143.820099] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.935s)
[145.023118] [022/132] (876s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[145.128107] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[145.130385] Starting dynamic subtest: pipe-A-eDP-1
[145.187717] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[145.195129] Starting dynamic subtest: pipe-B-eDP-1
[145.252035] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[145.261317] Starting dynamic subtest: pipe-C-eDP-1
[145.319223] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[145.327794] Starting dynamic subtest: pipe-D-eDP-1
[145.384166] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[145.388654] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[147.389645] [023/132] (874s left) gem_exec_balancer (nop)
[147.455450] Starting subtest: nop
[194.131080] Subtest nop: SUCCESS (46.675s)
[194.448299] [024/132] (827s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[194.544473] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[194.555960] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[194.676122] [025/132] (827s left) core_sysfs (read-all-entries)
[194.732175] Starting subtest: read-all-entries
[194.739623] Subtest read-all-entries: SUCCESS (0.010s)
[194.874125] [026/132] (827s left) i915_drm_fdinfo (virtual-busy-hang-all)
[194.931806] Starting subtest: virtual-busy-hang-all
[194.936260] Subtest virtual-busy-hang-all: SKIP (0.000s)
[195.025339] [027/132] (827s left) gem_pxp (fail-invalid-protected-context)
[195.150749] Starting subtest: fail-invalid-protected-context
[195.153144] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[195.292716] [028/132] (826s left) kms_color (invalid-degamma-lut-sizes)
[195.385918] Starting subtest: invalid-degamma-lut-sizes
[195.387804] Starting dynamic subtest: pipe-A
[195.692169] Dynamic subtest pipe-A: SUCCESS (0.306s)
[195.700681] Starting dynamic subtest: pipe-B
[195.702815] Dynamic subtest pipe-B: SUCCESS (0.001s)
[195.709921] Starting dynamic subtest: pipe-C
[195.712096] Dynamic subtest pipe-C: SUCCESS (0.001s)
[195.719171] Starting dynamic subtest: pipe-D
[195.721293] Dynamic subtest pipe-D: SUCCESS (0.001s)
[195.723512] Subtest invalid-degamma-lut-sizes: SUCCESS (0.310s)
[196.515653] [029/132] (825s left) gem_create (create-ext-cpu-access-big)
[196.695319] Starting subtest: create-ext-cpu-access-big
[196.700630] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[196.793617] [030/132] (825s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[196.902260] Starting subtest: fbc-rgb101010-draw-pwrite
[202.256166] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.355s)
[203.417049] [031/132] (818s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[203.533298] Starting subtest: x-tiled-8bpp-rotate-270
[203.554083] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[203.711196] [032/132] (818s left) gem_softpin (safe-alignment)
[203.790770] Starting subtest: safe-alignment
[203.812306] Subtest safe-alignment: SUCCESS (0.022s)
[204.941929] [033/132] (817s left) gem_exec_schedule (semaphore-codependency)
[205.029570] Starting subtest: semaphore-codependency
[205.031897] Subtest semaphore-codependency: SUCCESS (0.013s)
[205.415191] [034/132] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[205.511304] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[205.515609] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[205.644596] [035/132] (816s left) kms_sequence (queue-idle)
[205.724907] Starting subtest: queue-idle
[205.727248] Starting dynamic subtest: pipe-A-eDP-1
[207.528048] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.801s)
[207.536781] Starting dynamic subtest: pipe-B-eDP-1
[209.962802] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.436s)
[209.972349] Starting dynamic subtest: pipe-C-eDP-1
[212.391431] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.428s)
[212.399804] Starting dynamic subtest: pipe-D-eDP-1
[214.816871] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.421s)
[214.819168] Subtest queue-idle: SUCCESS (9.091s)
[215.639437] [036/132] (806s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[215.729770] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[215.732079] Starting dynamic subtest: pipe-A-default-mode
[216.020880] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[216.025374] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.291s)
[216.871947] [037/132] (805s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[216.975081] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[216.979698] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[217.110283] [038/132] (805s left) kms_flip (flip-vs-expired-vblank-interruptible)
[217.210263] Starting subtest: flip-vs-expired-vblank-interruptible
[217.212714] Starting dynamic subtest: A-eDP1
[225.848060] Dynamic subtest A-eDP1: SUCCESS (8.636s)
[225.858168] Starting dynamic subtest: B-eDP1
[234.479986] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[234.490226] Starting dynamic subtest: C-eDP1
[243.091923] Dynamic subtest C-eDP1: SUCCESS (8.610s)
[243.099792] Starting dynamic subtest: D-eDP1
[251.722063] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[251.724527] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.513s)
[252.922440] [039/132] (769s left) gem_ctx_persistence (smoketest)
[252.992329] Starting subtest: smoketest
[293.811772] Subtest smoketest: SUCCESS (40.815s)
[293.913084] [040/132] (728s left) kms_cursor_crc (cursor-onscreen-256x85)
[294.154689] Starting subtest: cursor-onscreen-256x85
[294.198281] Subtest cursor-onscreen-256x85: SKIP (0.040s)
[294.400449] [041/132] (728s left) gem_flink_basic (double-flink)
[294.453155] Starting subtest: double-flink
[294.455303] Subtest double-flink: SUCCESS (0.000s)
[294.589405] [042/132] (728s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[294.690216] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[301.419649] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.730s)
[301.565201] [043/132] (721s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[301.660935] Starting subtest: extended-modeset-hang-oldfb-with-reset
[301.663289] Starting dynamic subtest: pipe-A
[313.300176] Dynamic subtest pipe-A: SUCCESS (11.638s)
[313.309963] Starting dynamic subtest: pipe-D
[325.580232] Dynamic subtest pipe-D: SUCCESS (12.276s)
[325.582599] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.919s)
[326.393579] [044/132] (696s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[326.500772] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[326.502681] Starting dynamic subtest: pipe-A-eDP-1
[328.564033] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.065s)
[328.571767] Starting dynamic subtest: pipe-B-eDP-1
[330.874253] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.307s)
[330.882094] Starting dynamic subtest: pipe-C-eDP-1
[332.903295] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.027s)
[332.916875] Starting dynamic subtest: pipe-D-eDP-1
[335.069998] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.167s)
[335.072030] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.571s)
[336.312390] [045/132] (686s left) i915_selftest (live)
[339.768595] Starting subtest: live
[339.771497] Starting dynamic subtest: sanitycheck
[344.172267] Dynamic subtest sanitycheck: SUCCESS (4.403s)
[344.181182] Starting dynamic subtest: uncore
[346.978384] Dynamic subtest uncore: SUCCESS (2.804s)
[346.987291] Starting dynamic subtest: workarounds
[365.141657] Dynamic subtest workarounds: FAIL (17.592s)
[365.149039] Starting dynamic subtest: gt_engines
[369.323250] Dynamic subtest gt_engines: SUCCESS (4.749s)
[369.331590] Starting dynamic subtest: gt_timelines
[386.808715] Dynamic subtest gt_timelines: SUCCESS (17.482s)
[386.816801] Starting dynamic subtest: gt_contexts
[391.298099] Dynamic subtest gt_contexts: SUCCESS (4.487s)
[391.307684] Starting dynamic subtest: gt_lrc
[397.649085] Dynamic subtest gt_lrc: SUCCESS (6.349s)
[397.658764] Starting dynamic subtest: gt_mocs
[400.764557] Dynamic subtest gt_mocs: SUCCESS (3.110s)
[400.773078] Starting dynamic subtest: gt_pm
[405.657066] Dynamic subtest gt_pm: SUCCESS (4.894s)
[405.671351] Starting dynamic subtest: gt_heartbeat
[410.082023] Dynamic subtest gt_heartbeat: SUCCESS (4.422s)
[410.091297] Starting dynamic subtest: gt_tlb
[419.549118] Dynamic subtest gt_tlb: SUCCESS (9.465s)
[419.557668] Starting dynamic subtest: requests
[433.087681] Dynamic subtest requests: SUCCESS (13.536s)
[433.097030] Starting dynamic subtest: migrate
[441.187755] Dynamic subtest migrate: SUCCESS (8.098s)
[441.197106] Starting dynamic subtest: active
[445.594496] Dynamic subtest active: SUCCESS (4.404s)
[445.603537] Starting dynamic subtest: objects
[450.375701] Dynamic subtest objects: SUCCESS (4.779s)
[450.384829] Starting dynamic subtest: mman
[455.278232] Dynamic subtest mman: SUCCESS (4.901s)
[455.292346] Starting dynamic subtest: dmabuf
[459.737978] Dynamic subtest dmabuf: SUCCESS (4.458s)
[459.749747] Starting dynamic subtest: vma
[464.176242] Dynamic subtest vma: SUCCESS (4.436s)
[464.184110] Starting dynamic subtest: coherency
[469.736289] Dynamic subtest coherency: SUCCESS (5.558s)
[469.745574] Starting dynamic subtest: gtt
[479.751732] Dynamic subtest gtt: SUCCESS (10.014s)
[479.759112] Starting dynamic subtest: gem
[487.723338] Dynamic subtest gem: SUCCESS (7.969s)
[487.732635] Starting dynamic subtest: evict
[493.298434] Dynamic subtest evict: SUCCESS (5.573s)
[493.306743] Starting dynamic subtest: hugepages
[504.428038] Dynamic subtest hugepages: SUCCESS (11.127s)
[504.437098] Starting dynamic subtest: gem_contexts
[531.200834] Dynamic subtest gem_contexts: SUCCESS (26.770s)
[531.210249] Starting dynamic subtest: client
[535.677445] Dynamic subtest client: SUCCESS (4.474s)
[535.686122] Starting dynamic subtest: gem_migrate
[538.528813] Dynamic subtest gem_migrate: SUCCESS (2.850s)
[538.536992] Starting dynamic subtest: reset
[541.458087] Dynamic subtest reset: SUCCESS (2.927s)
[541.466190] Starting dynamic subtest: memory_region
[545.981585] Dynamic subtest memory_region: SUCCESS (4.521s)
[545.991441] Starting dynamic subtest: hangcheck
[558.860744] Dynamic subtest hangcheck: SUCCESS (12.877s)
[558.870248] Starting dynamic subtest: execlists
[561.672955] Dynamic subtest execlists: SUCCESS (2.810s)
[561.681743] Starting dynamic subtest: ring_submission
[564.425084] Dynamic subtest ring_submission: SUCCESS (2.751s)
[564.433982] Starting dynamic subtest: perf
[568.893976] Dynamic subtest perf: SUCCESS (4.467s)
[568.903380] Starting dynamic subtest: slpc
[581.185745] Dynamic subtest slpc: SUCCESS (12.289s)
[581.194834] Starting dynamic subtest: guc
[585.133381] Dynamic subtest guc: SUCCESS (3.945s)
[585.142815] Starting dynamic subtest: guc_multi_lrc
[589.591729] Dynamic subtest guc_multi_lrc: SUCCESS (4.456s)
[589.600554] Starting dynamic subtest: guc_hang
[594.645346] Dynamic subtest guc_hang: SUCCESS (5.051s)
[594.653585] Starting dynamic subtest: late_gt_pm
[599.039344] Dynamic subtest late_gt_pm: SUCCESS (4.391s)
[599.042199] Subtest live: FAIL (259.263s)
[599.069282] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[599.069947] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[599.073116] [046/132] (423s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[600.652878] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[600.657172] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[600.745083] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[600.746310] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[600.750076] [047/132] (422s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[600.857121] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[600.861394] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[601.001079] [048/132] (422s left) perf (polling)
[601.130254] Starting subtest: polling
[601.132451] Starting dynamic subtest: 0-rcs0
[611.144047] Dynamic subtest 0-rcs0: SUCCESS (10.011s)
[611.151585] Starting dynamic subtest: 1-vcs1
[621.163275] Dynamic subtest 1-vcs1: SUCCESS (10.018s)
[621.166063] Subtest polling: SUCCESS (20.032s)
[621.212321] [049/132] (401s left) kms_flip (plain-flip-fb-recreate)
[621.306399] Starting subtest: plain-flip-fb-recreate
[621.308349] Starting dynamic subtest: A-eDP1
[630.134851] Dynamic subtest A-eDP1: SUCCESS (8.831s)
[630.143943] Starting dynamic subtest: B-eDP1
[638.971568] Dynamic subtest B-eDP1: SUCCESS (8.836s)
[638.981064] Starting dynamic subtest: C-eDP1
[647.791760] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[647.800561] Starting dynamic subtest: D-eDP1
[656.625540] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[656.630598] Subtest plain-flip-fb-recreate: SUCCESS (35.326s)
[657.836859] [050/132] (365s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[657.958345] Starting subtest: cursor-vs-flip-atomic-transitions
[687.794582] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.834s)
[688.672344] [051/132] (334s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[688.782526] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[692.885607] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.106s)
[694.096294] [052/132] (329s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[694.348582] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[694.353321] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[694.559871] [053/132] (328s left) gem_flink_basic (flink-lifetime)
[694.648127] Starting subtest: flink-lifetime
[694.650452] Subtest flink-lifetime: SUCCESS (0.002s)
[694.853549] [054/132] (328s left) gem_exec_reloc (basic-cpu-read-noreloc)
[694.935652] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[695.022319] [055/132] (328s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[695.094661] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[695.096854] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[695.201329] [056/132] (328s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[695.257911] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[695.262466] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[695.464967] [057/132] (327s left) kms_mmap_write_crc (main)
[695.563796] Starting subtest: main
[695.566093] Starting dynamic subtest: pipe-A-eDP-1
[699.008674] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.443s)
[699.010819] Subtest main: SUCCESS (3.445s)
[699.885127] [058/132] (323s left) gem_exec_whisper (basic-queues-all)
[699.963382] Starting subtest: basic-queues-all
[711.862221] Subtest basic-queues-all: SUCCESS (11.896s)
[712.075389] [059/132] (311s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[712.185643] Starting subtest: fbc-pr-sprite-mmap-cpu
[712.190234] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[712.283470] [060/132] (311s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[712.408257] Starting subtest: flip-vs-cursor-atomic
[719.400108] Subtest flip-vs-cursor-atomic: SUCCESS (6.992s)
[720.221454] [061/132] (303s left) api_intel_bb (simple-bb)
[720.304607] Starting subtest: simple-bb
[720.312425] Subtest simple-bb: SUCCESS (0.009s)
[720.479244] [062/132] (303s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[720.542480] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[720.596981] [063/132] (303s left) kms_invalid_mode (bad-vsync-end)
[720.695183] Starting subtest: bad-vsync-end
[720.697400] Starting dynamic subtest: pipe-A-eDP-1
[720.979396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[720.991680] Starting dynamic subtest: pipe-B-eDP-1
[720.993535] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[721.001161] Starting dynamic subtest: pipe-C-eDP-1
[721.003296] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[721.010475] Starting dynamic subtest: pipe-D-eDP-1
[721.012942] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[721.015360] Subtest bad-vsync-end: SUCCESS (0.292s)
[721.852357] [064/132] (301s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[721.909105] Starting subtest: framebuffer-vs-set-tiling
[721.913671] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[722.060856] [065/132] (301s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[722.164656] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[722.169755] Starting dynamic subtest: pipe-A-default-mode
[723.306455] Dynamic subtest pipe-A-default-mode: SKIP (1.135s)
[723.310827] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.138s)
[723.462800] [066/132] (300s left) gem_lmem_swapping (verify-ccs)
[723.514854] Subtest verify-ccs: SKIP (0.000s)
[723.565622] [067/132] (300s left) vgem_basic (bad-flag)
[723.618367] Starting subtest: bad-flag
[723.620564] Subtest bad-flag: SUCCESS (0.000s)
[723.698374] [068/132] (300s left) kms_big_fb (linear-32bpp-rotate-180)
[723.798211] Starting subtest: linear-32bpp-rotate-180
[725.341045] Subtest linear-32bpp-rotate-180: SUCCESS (1.544s)
[725.514499] [069/132] (298s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[725.579389] Subtest writes-after-reads: SKIP (0.000s)
[725.650046] [070/132] (298s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[725.753068] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[725.756501] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[725.892942] [071/132] (298s left) gem_ctx_bad_destroy (double-destroy)
[725.954487] Starting subtest: double-destroy
[725.956543] Subtest double-destroy: SUCCESS (0.000s)
[726.053307] [072/132] (297s left) kms_chamelium_color (ctm-blue-to-red)
[726.154809] Subtest ctm-blue-to-red: SKIP (0.000s)
[726.201923] [073/132] (297s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[726.291604] Starting subtest: fbc-psr-cursor-mmap-cpu
[726.293518] Starting dynamic subtest: eDP-1
[726.296925] Dynamic subtest eDP-1: SKIP (0.000s)
[726.300349] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[726.387426] [074/132] (297s left) i915_drm_fdinfo (isolation)
[726.428260] Starting subtest: isolation
[726.430203] Starting dynamic subtest: rcs0
[726.465522] Dynamic subtest rcs0: SKIP (0.035s)
[726.474464] Starting dynamic subtest: bcs0
[726.477938] Dynamic subtest bcs0: SKIP (0.001s)
[726.485824] Starting dynamic subtest: vcs0
[726.489284] Dynamic subtest vcs0: SKIP (0.000s)
[726.496546] Starting dynamic subtest: vcs1
[726.499770] Dynamic subtest vcs1: SKIP (0.000s)
[726.506597] Starting dynamic subtest: vecs0
[726.509797] Dynamic subtest vecs0: SKIP (0.000s)
[726.516742] Starting dynamic subtest: ccs0
[726.519958] Dynamic subtest ccs0: SKIP (0.000s)
[726.523195] Subtest isolation: SKIP (0.041s)
[726.562434] [075/132] (297s left) gem_ctx_sseu (invalid-args)
[726.623764] Subtest invalid-args: SKIP (0.000s)
[726.698205] [076/132] (297s left) gen9_exec_parse (allowed-all)
[726.759537] Subtest allowed-all: SKIP (0.000s)
[726.850623] [077/132] (297s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[731.844391] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[731.846540] Starting dynamic subtest: pipe-A-eDP-1
[738.683774] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.837s)
[738.699603] Starting dynamic subtest: pipe-B-eDP-1
[745.546366] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.863s)
[745.548605] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.704s)
[746.438784] [078/132] (277s left) kms_chamelium_frames (dp-crc-multiple)
[746.846643] Subtest dp-crc-multiple: SKIP (0.000s)
[747.641229] [079/132] (276s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[747.744264] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[747.746619] Starting dynamic subtest: pipe-A
[747.770535] Dynamic subtest pipe-A: SKIP (0.021s)
[747.783818] Starting dynamic subtest: pipe-B
[747.817275] Dynamic subtest pipe-B: SKIP (0.046s)
[747.830734] Starting dynamic subtest: pipe-C
[747.847208] Dynamic subtest pipe-C: SKIP (0.029s)
[747.855888] Starting dynamic subtest: pipe-D
[747.877509] Dynamic subtest pipe-D: SKIP (0.028s)
[747.881857] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.130s)
[747.998460] [080/132] (276s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[748.110925] Starting subtest: y-tiled-8bpp-rotate-270
[748.115537] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[748.230532] [081/132] (276s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[748.327094] Starting subtest: psr-rgb565-draw-blt
[755.421209] Subtest psr-rgb565-draw-blt: SUCCESS (7.097s)
[755.573314] [082/132] (268s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[755.691803] Starting subtest: cursorB-vs-flipA-atomic-transitions
[755.697280] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[755.862015] [083/132] (268s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[755.959950] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[762.781666] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.824s)
[762.989603] [084/132] (261s left) kms_big_fb (4-tiled-addfb)
[763.098073] Starting subtest: 4-tiled-addfb
[763.100247] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[763.224321] [085/132] (261s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[763.625014] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[764.408014] [086/132] (260s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[764.517829] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[764.522336] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[764.654358] [087/132] (260s left) gem_mmap_gtt (big-bo-tiledy)
[764.711452] Subtest big-bo-tiledY: SKIP (0.000s)
[764.780556] [088/132] (259s left) gem_ctx_persistence (engines-hang)
[764.836059] Starting subtest: engines-hang
[764.838294] Starting dynamic subtest: rcs0
[764.926482] Dynamic subtest rcs0: SUCCESS (0.089s)
[764.941273] Starting dynamic subtest: bcs0
[765.042629] Dynamic subtest bcs0: SUCCESS (0.115s)
[765.053834] Starting dynamic subtest: vcs0
[765.121497] Dynamic subtest vcs0: SUCCESS (0.077s)
[765.130988] Starting dynamic subtest: vcs1
[765.227634] Dynamic subtest vcs1: SUCCESS (0.104s)
[765.238609] Starting dynamic subtest: vecs0
[765.356731] Dynamic subtest vecs0: SUCCESS (0.127s)
[765.367603] Starting dynamic subtest: ccs0
[765.433435] Dynamic subtest ccs0: SUCCESS (0.075s)
[765.435595] Subtest engines-hang: SUCCESS (0.599s)
[765.588189] [089/132] (259s left) prime_self_import (export-vs-gem_close-race)
[765.630193] Starting subtest: export-vs-gem_close-race
[770.723388] Subtest export-vs-gem_close-race: SUCCESS (5.094s)
[770.849422] [090/132] (253s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[770.984808] Starting subtest: 4-tiled-16bpp-rotate-0
[772.243076] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.258s)
[772.434364] [091/132] (252s left) drm_read (short-buffer-block)
[772.597067] Starting subtest: short-buffer-block
[772.599165] Subtest short-buffer-block: SUCCESS (0.000s)
[772.770852] [092/132] (252s left) sriov_basic (bind-unbind-vf)
[772.841541] Starting subtest: bind-unbind-vf
[772.843679] Starting dynamic subtest: vf-1
[772.906545] Dynamic subtest vf-1: FAIL (0.006s)
[772.916536] Starting dynamic subtest: vf-2
[772.976369] Dynamic subtest vf-2: FAIL (0.004s)
[772.986297] Starting dynamic subtest: vf-3
[773.046463] Dynamic subtest vf-3: FAIL (0.004s)
[773.055494] Starting dynamic subtest: vf-4
[773.114501] Dynamic subtest vf-4: FAIL (0.004s)
[773.123751] Starting dynamic subtest: vf-5
[773.182729] Dynamic subtest vf-5: FAIL (0.004s)
[773.191729] Starting dynamic subtest: vf-6
[773.251933] Dynamic subtest vf-6: FAIL (0.004s)
[773.260768] Starting dynamic subtest: vf-7
[773.322918] Dynamic subtest vf-7: FAIL (0.004s)
[773.332868] Starting dynamic subtest: vf-random
[773.392959] Dynamic subtest vf-random: FAIL (0.004s)
[773.402331] Starting dynamic subtest: vf-last
[773.462761] Dynamic subtest vf-last: FAIL (0.428s)
[773.464516] Subtest bind-unbind-vf: FAIL (0.470s)
[773.499902] [093/132] (251s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[773.555534] Starting subtest: multi-wait-all-available-submitted-signaled
[773.557584] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[773.700153] [094/132] (251s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[773.813975] Starting subtest: cursor-tearing-framebuffer-change
[773.815835] Starting dynamic subtest: pipe-A-eDP-1
[774.380153] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[774.389410] Starting dynamic subtest: pipe-D-eDP-1
[775.663607] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.283s)
[775.665925] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.849s)
[776.519802] [095/132] (248s left) gem_mmap_wc (write-wc-read-gtt)
[776.586052] Subtest write-wc-read-gtt: SKIP (0.000s)
[776.646285] [096/132] (248s left) kms_flip (bo-too-big-interruptible)
[776.745064] Starting subtest: bo-too-big-interruptible
[776.747367] Starting dynamic subtest: A-eDP1
[778.057084] Dynamic subtest A-eDP1: SUCCESS (1.312s)
[778.072135] Starting dynamic subtest: B-eDP1
[779.301858] Dynamic subtest B-eDP1: SUCCESS (1.243s)
[779.316874] Starting dynamic subtest: C-eDP1
[780.546704] Dynamic subtest C-eDP1: SUCCESS (1.242s)
[780.555769] Starting dynamic subtest: D-eDP1
[781.784806] Dynamic subtest D-eDP1: SUCCESS (1.237s)
[781.787463] Subtest bo-too-big-interruptible: SUCCESS (5.043s)
[783.013134] [097/132] (242s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[783.117511] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[787.536687] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.422s)
[788.720954] [098/132] (236s left) gem_mmap_gtt (ptrace)
[788.770769] Subtest ptrace: SKIP (0.000s)
[788.830240] [099/132] (236s left) gem_exec_gttfill (engines)
[788.905033] Starting subtest: engines
[788.907438] Starting dynamic subtest: rcs0
[811.891035] Dynamic subtest rcs0: SUCCESS (22.983s)
[811.903139] Starting dynamic subtest: bcs0
[835.163065] Dynamic subtest bcs0: SUCCESS (23.270s)
[835.174796] Starting dynamic subtest: vcs0
[858.412238] Dynamic subtest vcs0: SUCCESS (23.245s)
[858.423743] Starting dynamic subtest: vcs1
[881.707986] Dynamic subtest vcs1: SUCCESS (23.294s)
[881.718254] Starting dynamic subtest: vecs0
[904.985861] Dynamic subtest vecs0: SUCCESS (23.275s)
[904.997589] Starting dynamic subtest: ccs0
[928.278506] Dynamic subtest ccs0: SUCCESS (23.289s)
[928.280955] Subtest engines: SUCCESS (139.370s)
[928.492487] [100/132] ( 96s left) gem_ppgtt (blt-vs-render-ctx0)
[928.572565] Starting subtest: blt-vs-render-ctx0
[961.476962] Subtest blt-vs-render-ctx0: SUCCESS (32.901s)
[961.653422] [101/132] ( 63s left) dumb_buffer (map-valid)
[961.750699] Starting subtest: map-valid
[961.753147] Subtest map-valid: SUCCESS (0.000s)
[961.887772] [102/132] ( 63s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[961.994552] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[961.998518] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[962.136657] [103/132] ( 63s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[962.230603] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[962.235202] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[962.348114] [104/132] ( 63s left) prime_busy (after)
[962.398967] Starting subtest: after
[962.404458] Starting dynamic subtest: rcs0
[962.451522] Dynamic subtest rcs0: SUCCESS (0.050s)
[962.459864] Starting dynamic subtest: bcs0
[962.512473] Dynamic subtest bcs0: SUCCESS (0.060s)
[962.520880] Starting dynamic subtest: vcs0
[962.551316] Dynamic subtest vcs0: SUCCESS (0.038s)
[962.559113] Starting dynamic subtest: vcs1
[962.592701] Dynamic subtest vcs1: SUCCESS (0.040s)
[962.600732] Starting dynamic subtest: vecs0
[962.632267] Dynamic subtest vecs0: SUCCESS (0.039s)
[962.642435] Starting dynamic subtest: ccs0
[962.672497] Dynamic subtest ccs0: SUCCESS (0.039s)
[962.781583] Subtest after: SUCCESS (0.381s)
[962.902846] [105/132] ( 62s left) gem_exec_store (cachelines)
[962.972304] Starting subtest: cachelines
[962.974251] Starting dynamic subtest: rcs0
[963.051590] Dynamic subtest rcs0: SUCCESS (0.082s)
[963.066141] Starting dynamic subtest: bcs0
[963.116272] Dynamic subtest bcs0: SUCCESS (0.062s)
[963.127518] Starting dynamic subtest: vcs0
[963.181150] Dynamic subtest vcs0: SUCCESS (0.063s)
[963.189763] Starting dynamic subtest: vcs1
[963.251410] Dynamic subtest vcs1: SUCCESS (0.067s)
[963.259685] Starting dynamic subtest: vecs0
[963.302858] Dynamic subtest vecs0: SUCCESS (0.052s)
[963.311336] Starting dynamic subtest: ccs0
[963.366576] Dynamic subtest ccs0: SUCCESS (0.062s)
[963.368915] Subtest cachelines: SUCCESS (0.398s)
[963.574500] [106/132] ( 61s left) gem_exec_reloc (basic-wc)
[963.630709] Subtest basic-wc: SKIP (0.000s)
[963.694410] [107/132] ( 61s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[963.750676] Starting subtest: multi-wait-for-submit-submitted-signaled
[963.752877] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[963.888237] [108/132] ( 61s left) kms_hdr (bpc-switch-suspend)
[963.983076] Starting subtest: bpc-switch-suspend
[965.030772] Starting dynamic subtest: pipe-A-eDP-1
[984.145123] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.314s)
[984.147811] Subtest bpc-switch-suspend: SUCCESS (9.365s)
[984.319007] [109/132] ( 41s left) kms_pm_dc (dc5-dpms)
[985.435339] Starting subtest: dc5-dpms
[987.483724] Subtest dc5-dpms: SUCCESS (2.045s)
[987.583453] [110/132] ( 38s left) api_intel_allocator (execbuf-with-allocator)
[987.649649] Starting subtest: execbuf-with-allocator
[987.653965] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[987.811158] [111/132] ( 37s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[987.913744] Starting subtest: fbcpsr-stridechange
[994.066183] Subtest fbcpsr-stridechange: SUCCESS (6.149s)
[994.269506] [112/132] ( 31s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[994.369710] Starting subtest: yf-tiled-32bpp-rotate-90
[994.374845] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[994.492944] [113/132] ( 31s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[994.587161] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[994.591952] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[994.724416] [114/132] ( 31s left) gem_exec_balancer (parallel-keep-submit-fence)
[994.975822] Starting subtest: parallel-keep-submit-fence
[996.254802] Subtest parallel-keep-submit-fence: SUCCESS (1.281s)
[996.402644] [115/132] ( 29s left) kms_cursor_crc (cursor-size-change)
[996.511736] Starting subtest: cursor-size-change
[996.514499] Starting dynamic subtest: pipe-A-eDP-1
[997.297808] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s)
[997.308370] Starting dynamic subtest: pipe-D-eDP-1
[998.726369] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.428s)
[998.728834] Subtest cursor-size-change: SUCCESS (2.216s)
[999.563520] [116/132] ( 26s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[999.624809] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[999.627727] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[999.748262] [117/132] ( 26s left) gem_exec_reloc (basic-write-gtt-active)
[999.798831] Subtest basic-write-gtt-active: SKIP (0.000s)
[999.876824] [118/132] ( 26s left) syncobj_basic (test-valid-cycle)
[999.943934] Starting subtest: test-valid-cycle
[999.946662] Subtest test-valid-cycle: SUCCESS (0.000s)
[1000.087449] [119/132] ( 25s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[1000.185578] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[1000.197810] Starting dynamic subtest: pipe-A-eDP-1
[1000.207627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[1000.219546] Starting dynamic subtest: pipe-B-eDP-1
[1000.228328] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[1000.237352] Starting dynamic subtest: pipe-C-eDP-1
[1000.246325] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[1000.254944] Starting dynamic subtest: pipe-D-eDP-1
[1000.263647] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[1000.268071] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[1002.427358] [120/132] ( 23s left) gem_unfence_active_buffers
[1002.605144] [121/132] ( 23s left) kms_universal_plane (disable-primary-vs-flip)
[1002.710573] Starting subtest: disable-primary-vs-flip
[1002.712950] Starting dynamic subtest: pipe-A-eDP-1
[1004.282590] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.573s)
[1004.295766] Starting dynamic subtest: pipe-B-eDP-1
[1006.460469] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.174s)
[1006.470761] Starting dynamic subtest: pipe-C-eDP-1
[1008.630626] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.166s)
[1008.640150] Starting dynamic subtest: pipe-D-eDP-1
[1010.801710] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s)
[1010.804686] Subtest disable-primary-vs-flip: SUCCESS (8.091s)
[1011.629105] [122/132] ( 14s left) kms_addfb_basic (invalid-set-prop)
[1011.691414] Starting subtest: invalid-set-prop
[1011.693919] Subtest invalid-set-prop: SUCCESS (0.000s)
[1011.855405] [123/132] ( 14s left) kms_psr (pr-primary-mmap-gtt)
[1011.954635] Starting subtest: pr-primary-mmap-gtt
[1011.959840] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[1012.054238] [124/132] ( 14s left) kms_cursor_legacy (torture-move)
[1012.184515] Starting subtest: torture-move
[1012.186896] Starting dynamic subtest: pipe-A
[1017.984823] Dynamic subtest pipe-A: SUCCESS (5.796s)
[1017.997555] Starting dynamic subtest: pipe-B
[1024.100279] Dynamic subtest pipe-B: SUCCESS (6.111s)
[1024.112409] Starting dynamic subtest: pipe-C
[1031.166331] Dynamic subtest pipe-C: SUCCESS (7.063s)
[1031.179047] Starting dynamic subtest: pipe-D
[1037.993926] Dynamic subtest pipe-D: SUCCESS (6.822s)
[1038.006451] Starting dynamic subtest: all-pipes
[1044.831736] Dynamic subtest all-pipes: SUCCESS (6.833s)
[1044.834895] Subtest torture-move: SUCCESS (32.636s)
[1044.992641] Overall timeout time exceeded, stopping.
[1045.011415] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_plane_multiple
results: parsing output: 7/ for test: gem_wait
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_vrr
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_prop_blob
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: core_sysfs
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: gem_pxp
results: parsing output: 27/ for test: kms_color
results: parsing output: 28/ for test: gem_create
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_softpin
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_sequence
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: gem_flink_basic
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_busy
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: i915_selftest
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_flink_basic
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: kms_mmap_write_crc
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: api_intel_bb
results: parsing output: 61/ for test: kms_pipe_b_c_ivb
results: parsing output: 62/ for test: kms_invalid_mode
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_ctx_bad_destroy
results: parsing output: 71/ for test: kms_chamelium_color
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: i915_drm_fdinfo
results: parsing output: 74/ for test: gem_ctx_sseu
results: parsing output: 75/ for test: gen9_exec_parse
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_chamelium_frames
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_chamelium_hpd
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: prime_self_import
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: drm_read
results: parsing output: 91/ for test: sriov_basic
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_mmap_wc
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: gem_exec_gttfill
results: parsing output: 99/ for test: gem_ppgtt
results: parsing output: 100/ for test: dumb_buffer
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: prime_busy
results: parsing output: 104/ for test: gem_exec_store
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_hdr
results: parsing output: 108/ for test: kms_pm_dc
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: syncobj_basic
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_unfence_active_buffers
results: parsing output: 120/ for test: kms_universal_plane
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: i915_pm_rpm
results: no output, setting notrun
results: parsing output: 125/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 126/ for test: gem_userptr_blits
results: no output, setting notrun
results: parsing output: 127/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 128/ for test: gem_userptr_blits
results: no output, setting notrun
results: parsing output: 129/ for test: kms_content_protection
results: no output, setting notrun
results: parsing output: 130/ for test: kms_plane_alpha_blend
results: no output, setting notrun
results: parsing output: 131/ for test: kms_addfb_basic
results: no output, setting notrun
Done.