[55.802845] Initializing watchdogs
[55.802976]   /dev/watchdog0
[55.819040] [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]
[55.823465] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.825935] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.829319] [001/130] (960s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[55.957175] Starting subtest: plane-upscale-20x20-with-rotation
[55.959547] Starting dynamic subtest: pipe-A
[56.192805] Dynamic subtest pipe-A: SUCCESS (0.236s)
[56.201631] Starting dynamic subtest: pipe-B
[57.513019] Dynamic subtest pipe-B: SUCCESS (1.320s)
[57.519853] Starting dynamic subtest: pipe-C
[58.850604] Dynamic subtest pipe-C: SUCCESS (1.337s)
[58.858853] Starting dynamic subtest: pipe-D
[60.185330] Dynamic subtest pipe-D: SUCCESS (1.334s)
[60.187654] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.228s)
[61.372838] [002/130] (954s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[61.483108] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[61.487603] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[61.579212] [003/130] (954s left) kms_big_fb (linear-8bpp-rotate-180)
[61.680614] Starting subtest: linear-8bpp-rotate-180
[62.937194] Subtest linear-8bpp-rotate-180: SUCCESS (1.257s)
[63.071129] [004/130] (953s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[63.173163] Starting subtest: blocking-absolute-wf_vblank-interruptible
[63.175234] Starting dynamic subtest: A-eDP1
[71.924364] Dynamic subtest A-eDP1: SUCCESS (8.749s)
[71.934309] Starting dynamic subtest: B-eDP1
[80.658314] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[80.666892] Starting dynamic subtest: C-eDP1
[89.376760] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[89.385803] Starting dynamic subtest: D-eDP1
[98.103086] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[98.105669] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.930s)
[99.333015] [005/130] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[99.430635] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[99.434771] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[99.542813] [006/130] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[99.644721] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[106.267057] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (6.626s)
[106.427362] [007/130] (910s left) gem_ctx_exec (basic-norecovery)
[106.483766] Starting subtest: basic-norecovery
[106.774552] Subtest basic-norecovery: SUCCESS (0.291s)
[106.913526] [008/130] (909s left) kms_psr (psr-primary-page-flip)
[107.002094] Starting subtest: psr-primary-page-flip
[107.004458] Starting dynamic subtest: eDP-1
[108.737095] Dynamic subtest eDP-1: SUCCESS (1.734s)
[108.739345] Subtest psr-primary-page-flip: SUCCESS (1.735s)
[109.619679] [009/130] (907s left) core_getstats
[109.788492] [010/130] (906s left) i915_hangman (detector)
[109.855475] Starting subtest: detector
[109.857721] Starting dynamic subtest: rcs0
[121.906503] Dynamic subtest rcs0: SUCCESS (12.050s)
[121.916613] Starting dynamic subtest: bcs0
[132.850798] Dynamic subtest bcs0: SUCCESS (10.944s)
[132.861893] Starting dynamic subtest: vcs0
[143.857820] Dynamic subtest vcs0: SUCCESS (11.006s)
[143.868040] Starting dynamic subtest: vcs1
[155.890586] Dynamic subtest vcs1: SUCCESS (12.031s)
[155.901081] Starting dynamic subtest: vecs0
[167.795055] Dynamic subtest vecs0: SUCCESS (11.903s)
[167.805913] Starting dynamic subtest: ccs0
[178.868616] Dynamic subtest ccs0: SUCCESS (11.072s)
[178.871312] Subtest detector: SUCCESS (69.010s)
[179.046911] [011/130] (837s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[179.150843] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[179.152674] Starting dynamic subtest: pipe-A-eDP-1
[181.212262] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.062s)
[181.224583] Starting dynamic subtest: pipe-B-eDP-1
[183.279477] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.066s)
[183.287458] Starting dynamic subtest: pipe-C-eDP-1
[185.353769] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.073s)
[185.362228] Starting dynamic subtest: pipe-D-eDP-1
[187.363014] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.009s)
[187.365335] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.214s)
[188.570543] [012/130] (828s left) gem_lmem_swapping (parallel-random-engines)
[188.618431] Subtest parallel-random-engines: SKIP (0.000s)
[188.658762] [013/130] (828s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[188.753591] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[188.758057] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[188.874286] [014/130] (827s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[188.970509] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[188.974690] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[189.083404] [015/130] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[189.187666] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[189.191634] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[189.295609] [016/130] (827s left) gem_ctx_persistence (legacy-engines-hostile)
[189.357393] Starting subtest: legacy-engines-hostile
[189.359833] Starting dynamic subtest: render
[189.521579] Dynamic subtest render: SUCCESS (0.164s)
[189.532274] Starting dynamic subtest: bsd1
[189.629887] Dynamic subtest bsd1: SUCCESS (0.106s)
[189.639266] Starting dynamic subtest: bsd2
[189.765669] Dynamic subtest bsd2: SUCCESS (0.134s)
[189.777485] Starting dynamic subtest: blt
[189.800153] Dynamic subtest blt: SUCCESS (0.033s)
[189.807667] Starting dynamic subtest: vebox
[189.954569] Dynamic subtest vebox: SUCCESS (0.153s)
[189.956866] Subtest legacy-engines-hostile: SUCCESS (0.598s)
[190.039996] [017/130] (826s left) prime_vgem (shrink)
[190.148322] Starting subtest: shrink
[190.160678] Subtest shrink: SUCCESS (0.012s)
[190.294459] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[190.297119] [018/130] (826s left) gem_exec_schedule (preempt-queue-chain)
[190.372616] Subtest preempt-queue-chain: SKIP (0.000s)
[190.672871] [019/130] (826s left) kms_flip (flip-vs-panning-vs-hang)
[190.766291] Starting subtest: flip-vs-panning-vs-hang
[190.768509] Starting dynamic subtest: A-eDP1
[230.399151] Dynamic subtest A-eDP1: SUCCESS (39.635s)
[230.408984] Starting dynamic subtest: D-eDP1
[270.398575] Dynamic subtest D-eDP1: SUCCESS (39.997s)
[270.400889] Subtest flip-vs-panning-vs-hang: SUCCESS (79.637s)
[271.653979] [020/130] (745s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[271.894969] Starting subtest: cursor-rapid-movement-256x256
[271.900062] Starting dynamic subtest: pipe-A-eDP-1
[272.439912] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[272.465677] Starting dynamic subtest: pipe-D-eDP-1
[273.627718] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.167s)
[273.630063] Subtest cursor-rapid-movement-256x256: SUCCESS (1.730s)
[274.509719] [021/130] (742s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[274.611069] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[274.615219] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[274.724942] [022/130] (742s left) gem_exec_balancer (sliced)
[274.790660] Starting subtest: sliced
[274.795341] Subtest sliced: SKIP (0.000s)
[275.112700] [023/130] (742s left) kms_psr (fbc-psr-suspend)
[275.209067] Starting subtest: fbc-psr-suspend
[275.211248] Starting dynamic subtest: eDP-1
[275.215613] Dynamic subtest eDP-1: SKIP (0.000s)
[275.220235] Subtest fbc-psr-suspend: SKIP (0.001s)
[275.307969] [024/130] (741s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[275.407680] Starting subtest: fbcpsr-stridechange
[281.585860] Subtest fbcpsr-stridechange: SUCCESS (6.180s)
[281.732256] [025/130] (735s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[281.833495] Starting subtest: 4-tiled-32bpp-rotate-180
[283.243339] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.411s)
[283.395924] [026/130] (733s left) gem_mmap_gtt (basic-read-write-distinct)
[283.456954] Subtest basic-read-write-distinct: SKIP (0.000s)
[283.521093] [027/130] (733s left) perf_pmu (busy-accuracy-2)
[283.555571] Starting subtest: busy-accuracy-2
[283.557474] Starting dynamic subtest: rcs0
[286.600415] Dynamic subtest rcs0: SUCCESS (3.041s)
[286.610994] Starting dynamic subtest: bcs0
[289.657734] Dynamic subtest bcs0: SUCCESS (3.055s)
[289.667856] Starting dynamic subtest: vcs0
[292.706417] Dynamic subtest vcs0: SUCCESS (3.047s)
[292.715302] Starting dynamic subtest: vcs1
[295.752286] Dynamic subtest vcs1: SUCCESS (3.044s)
[295.760787] Starting dynamic subtest: vecs0
[298.799038] Dynamic subtest vecs0: SUCCESS (3.045s)
[298.810062] Starting dynamic subtest: ccs0
[301.859171] Dynamic subtest ccs0: SUCCESS (3.058s)
[301.861234] Subtest busy-accuracy-2: SUCCESS (18.300s)
[301.984244] [028/130] (715s left) gem_create (create-ext-set-pat)
[302.146717] Starting subtest: create-ext-set-pat
[302.149568] Subtest create-ext-set-pat: SUCCESS (0.001s)
[302.283473] [029/130] (715s left) gem_exec_reloc (basic-wc-cpu-active)
[302.343941] Subtest basic-wc-cpu-active: SKIP (0.000s)
[302.442923] [030/130] (715s left) gem_ctx_persistence (userptr)
[302.507739] Starting subtest: userptr
[302.750695] Subtest userptr: SUCCESS (0.242s)
[302.844462] [031/130] (714s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[302.897833] Starting subtest: multi-wait-all-for-submit-unsubmitted
[302.998410] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[303.087188] [032/130] (714s left) gem_busy (close-race)
[303.143358] Starting subtest: close-race
[326.930564] Subtest close-race: SUCCESS (23.785s)
[327.318249] [033/130] (690s left) kms_addfb_basic (small-bo)
[327.454088] Starting subtest: small-bo
[327.455964] Subtest small-bo: SUCCESS (0.000s)
[327.604686] [034/130] (690s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[327.708128] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[332.169077] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.464s)
[333.364205] [035/130] (684s left) syncobj_timeline (invalid-transfer-non-existent-point)
[333.426806] Starting subtest: invalid-transfer-non-existent-point
[333.429244] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[333.551524] [036/130] (684s left) kms_lease (lease-revoke)
[333.651632] Starting subtest: lease-revoke
[333.653816] Starting dynamic subtest: pipe-A-eDP-1
[333.689423] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.038s)
[333.699095] Starting dynamic subtest: pipe-B-eDP-1
[333.715792] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[333.728524] Starting dynamic subtest: pipe-C-eDP-1
[333.745399] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[333.755111] Starting dynamic subtest: pipe-D-eDP-1
[333.771331] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.025s)
[333.773647] Subtest lease-revoke: SUCCESS (0.123s)
[333.928449] [037/130] (683s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[334.023259] Starting subtest: psr-rgb101010-draw-pwrite
[341.681646] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.661s)
[341.818542] [038/130] (675s left) gem_mmap_offset (partial-remap)
[341.883722] Starting subtest: partial-remap
[341.885647] Starting dynamic subtest: smem0
[341.894584] Dynamic subtest smem0: SUCCESS (0.003s)
[341.896857] Subtest partial-remap: SUCCESS (0.004s)
[342.015172] [039/130] (675s left) gem_exec_whisper (basic-fds-priority)
[342.077139] Starting subtest: basic-fds-priority
[366.963264] Subtest basic-fds-priority: SUCCESS (24.881s)
[367.160534] [040/130] (650s left) gem_softpin (allocator-nopin)
[367.224982] Starting subtest: allocator-nopin
[367.337551] Subtest allocator-nopin: SUCCESS (0.111s)
[367.477445] [041/130] (650s left) gem_exec_reloc (basic-concurrent16)
[367.540695] Subtest basic-concurrent16: SKIP (0.000s)
[367.617389] [042/130] (650s left) kms_vrr (negative-basic)
[367.705943] Starting subtest: negative-basic
[367.712224] Starting dynamic subtest: pipe-A-eDP-1
[373.128441] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.415s)
[373.416571] Subtest negative-basic: SUCCESS (5.711s)
[374.288088] [043/130] (643s left) syncobj_timeline (single-wait-all-signaled)
[374.343278] Starting subtest: single-wait-all-signaled
[374.345608] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[374.472495] [044/130] (643s left) kms_psr (fbc-psr2-primary-page-flip)
[374.563562] Starting subtest: fbc-psr2-primary-page-flip
[374.565744] Starting dynamic subtest: eDP-1
[374.570112] Dynamic subtest eDP-1: SKIP (0.000s)
[374.574610] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[374.649877] [045/130] (643s left) kms_feature_discovery (display-4x)
[374.743943] Starting subtest: display-4x
[374.748447] Subtest display-4x: SKIP (0.000s)
[374.816676] [046/130] (643s left) kms_pm_rpm (universal-planes)
[377.081355] Starting subtest: universal-planes
[377.084322] Starting dynamic subtest: plane-33
[385.375728] Dynamic subtest plane-33: SUCCESS (8.294s)
[385.390236] Starting dynamic subtest: plane-43
[393.776901] Dynamic subtest plane-43: SUCCESS (8.397s)
[393.788169] Starting dynamic subtest: plane-53
[402.184963] Dynamic subtest plane-53: SUCCESS (8.407s)
[402.194713] Starting dynamic subtest: plane-63
[410.574377] Dynamic subtest plane-63: SUCCESS (8.388s)
[410.586045] Starting dynamic subtest: plane-73
[418.993993] Dynamic subtest plane-73: SUCCESS (8.415s)
[419.005524] Starting dynamic subtest: plane-83
[427.504275] Dynamic subtest plane-83: SUCCESS (8.507s)
[427.507204] Subtest universal-planes: SUCCESS (50.423s)
[427.891839] [047/130] (590s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[427.981086] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[428.970663] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.989s)
[429.117225] [048/130] (589s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[429.184021] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[429.264790] [049/130] (588s left) kms_scaling_modes (scaling-mode-full-aspect)
[429.348482] Starting subtest: scaling-mode-full-aspect
[429.350206] Starting dynamic subtest: pipe-A-eDP-1
[429.443728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[429.455711] Starting dynamic subtest: pipe-B-eDP-1
[430.595329] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s)
[430.605810] Starting dynamic subtest: pipe-C-eDP-1
[431.715544] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[431.725330] Starting dynamic subtest: pipe-D-eDP-1
[432.853036] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[432.855439] Subtest scaling-mode-full-aspect: SUCCESS (3.506s)
[434.053132] [050/130] (584s left) kms_color (degamma)
[434.147165] Starting subtest: degamma
[434.149465] Starting dynamic subtest: pipe-A-eDP-1
[434.833908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[434.844682] Starting dynamic subtest: pipe-B-eDP-1
[436.277756] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.440s)
[436.287007] Starting dynamic subtest: pipe-C-eDP-1
[437.605564] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.330s)
[437.614675] Starting dynamic subtest: pipe-D-eDP-1
[438.911944] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s)
[438.914572] Subtest degamma: SUCCESS (4.765s)
[439.758067] [051/130] (578s left) kms_cursor_crc (cursor-offscreen-256x85)
[440.019912] Starting subtest: cursor-offscreen-256x85
[440.063367] Subtest cursor-offscreen-256x85: SKIP (0.038s)
[440.274040] [052/130] (578s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[440.397576] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[440.402170] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[440.563130] [053/130] (577s left) perf_pmu (busy-start)
[440.601516] Starting subtest: busy-start
[440.603435] Starting dynamic subtest: rcs0
[443.152312] Dynamic subtest rcs0: SUCCESS (2.551s)
[443.164774] Starting dynamic subtest: bcs0
[445.702696] Dynamic subtest bcs0: SUCCESS (2.548s)
[445.714736] Starting dynamic subtest: vcs0
[448.915378] Dynamic subtest vcs0: SUCCESS (3.209s)
[448.927910] Starting dynamic subtest: vcs1
[452.883292] Dynamic subtest vcs1: SUCCESS (3.966s)
[452.895418] Starting dynamic subtest: vecs0
[456.914793] Dynamic subtest vecs0: SUCCESS (4.030s)
[456.926663] Starting dynamic subtest: ccs0
[459.462965] Dynamic subtest ccs0: SUCCESS (2.547s)
[459.465433] Subtest busy-start: SUCCESS (18.862s)
[459.578408] [054/130] (558s left) gem_spin_batch (spin-each)
[459.636839] Starting subtest: spin-each
[463.003718] Subtest spin-each: SUCCESS (3.367s)
[464.973942] [055/130] (553s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[465.074548] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[465.078526] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[465.201924] [056/130] (553s left) kms_chamelium_frames (hdmi-crc-multiple)
[465.591486] Subtest hdmi-crc-multiple: SKIP (0.000s)
[466.372260] [057/130] (552s left) gen9_exec_parse (bb-start-out)
[466.436639] Subtest bb-start-out: SKIP (0.000s)
[466.512335] [058/130] (552s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[466.626543] Starting subtest: cursorB-vs-flipA-atomic-transitions
[466.631158] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[466.790556] [059/130] (551s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[466.883692] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[466.887830] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[466.988206] [060/130] (551s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[467.074754] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[467.077036] Starting dynamic subtest: pipe-A-eDP-1
[467.098989] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[467.108159] Starting dynamic subtest: pipe-B-eDP-1
[467.128914] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[467.137731] Starting dynamic subtest: pipe-C-eDP-1
[467.159064] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[467.168581] Starting dynamic subtest: pipe-D-eDP-1
[467.190756] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.195141] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[469.277581] [061/130] (549s left) kms_flip (absolute-wf_vblank)
[469.387400] Starting subtest: absolute-wf_vblank
[469.389570] Starting dynamic subtest: A-eDP1
[478.120597] Dynamic subtest A-eDP1: SUCCESS (8.734s)
[478.132696] Starting dynamic subtest: B-eDP1
[486.845269] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[486.857353] Starting dynamic subtest: C-eDP1
[495.561793] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[495.574683] Starting dynamic subtest: D-eDP1
[504.307045] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[504.309270] Subtest absolute-wf_vblank: SUCCESS (34.916s)
[505.528947] [062/130] (513s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[505.591722] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[505.696079] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[505.783901] [063/130] (513s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[505.843239] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[505.845591] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[505.983975] [064/130] (512s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[506.076617] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[506.089018] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[506.187874] [065/130] (512s left) kms_cursor_crc (cursor-onscreen-128x42)
[506.407015] Starting subtest: cursor-onscreen-128x42
[506.448445] Subtest cursor-onscreen-128x42: SKIP (0.040s)
[506.692630] [066/130] (512s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[506.787495] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[506.789329] Starting dynamic subtest: pipe-A-eDP-1
[506.837329] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[506.847716] Starting dynamic subtest: pipe-B-eDP-1
[506.895208] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[506.906078] Starting dynamic subtest: pipe-C-eDP-1
[506.956550] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[506.966480] Starting dynamic subtest: pipe-D-eDP-1
[507.013162] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[507.016841] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[509.024071] [067/130] (509s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[509.117806] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[509.120156] Starting dynamic subtest: pipe-A-eDP-1
[509.142739] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[509.154421] Starting dynamic subtest: pipe-B-eDP-1
[509.175691] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[509.184261] Starting dynamic subtest: pipe-C-eDP-1
[509.206566] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[509.215093] Starting dynamic subtest: pipe-D-eDP-1
[509.237759] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[509.242363] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[511.302622] [068/130] (507s left) kms_vblank (query-idle)
[511.391143] Starting subtest: query-idle
[511.393011] Starting dynamic subtest: pipe-A-eDP-1
[513.134177] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.744s)
[513.148951] Starting dynamic subtest: pipe-D-eDP-1
[515.618329] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.481s)
[515.620576] Subtest query-idle: SUCCESS (4.228s)
[516.464202] [069/130] (502s left) gem_exec_reloc (basic-cpu-read-active)
[516.528426] Subtest basic-cpu-read-active: SKIP (0.000s)
[516.616145] [070/130] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[516.708036] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[516.712479] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[516.833530] [071/130] (502s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[521.819058] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[521.821423] Starting dynamic subtest: pipe-A-eDP-1
[522.619560] Dynamic subtest pipe-A-eDP-1: SKIP (0.797s)
[522.630843] Starting dynamic subtest: pipe-B-eDP-1
[523.745050] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[523.749266] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.924s)
[524.957496] [072/130] (494s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[525.054214] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[531.301912] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.251s)
[532.467567] [073/130] (486s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[532.564223] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[532.568139] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[532.697098] [074/130] (486s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[532.796303] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[540.105183] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.310s)
[540.298515] [075/130] (479s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[540.401508] Starting subtest: fbc-modesetfrombusy
[544.209814] Subtest fbc-modesetfrombusy: SUCCESS (3.812s)
[545.378338] [076/130] (473s left) gem_tiled_blits (basic)
[545.439646] Subtest basic: SKIP (0.000s)
[545.519046] [077/130] (473s left) gem_eio (context-create)
[545.735542] Starting subtest: context-create
[546.053463] Subtest context-create: SUCCESS (0.317s)
[546.210380] [078/130] (473s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[546.269550] Starting subtest: x-tiled-to-vebox-y-tiled
[546.274230] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[546.475088] [079/130] (473s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[546.586608] Starting subtest: basic-busy-flip-before-cursor-varying-size
[546.590986] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[546.752358] [080/130] (472s left) kms_plane_alpha_blend (alpha-7efc)
[546.847847] Starting subtest: alpha-7efc
[547.131314] Starting dynamic subtest: pipe-A-eDP-1
[547.721539] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[547.745647] Starting dynamic subtest: pipe-D-eDP-1
[549.032614] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s)
[549.035070] Subtest alpha-7efc: SUCCESS (2.185s)
[549.838978] [081/130] (469s left) i915_selftest (perf)
[553.330314] Starting subtest: perf
[553.333072] Starting dynamic subtest: engine_cs
[557.725670] Dynamic subtest engine_cs: SUCCESS (4.394s)
[557.734753] Starting dynamic subtest: request
[565.073665] Dynamic subtest request: SUCCESS (7.346s)
[565.083027] Starting dynamic subtest: migrate
[569.467914] Dynamic subtest migrate: SUCCESS (4.392s)
[569.477726] Starting dynamic subtest: region
[575.674318] Dynamic subtest region: SUCCESS (6.204s)
[575.676815] Subtest perf: SUCCESS (22.342s)
[575.704093] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[575.704836] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[575.707330] [082/130] (443s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[577.295462] Starting subtest: short-flip-before-cursor-toggle
[578.250889] Subtest short-flip-before-cursor-toggle: SUCCESS (0.957s)
[579.147028] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[579.148186] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true
[579.151923] [083/130] (440s left) kms_pm_rpm (modeset-lpsp-stress)
[581.095788] Starting subtest: modeset-lpsp-stress
[596.944652] Subtest modeset-lpsp-stress: SUCCESS (15.851s)
[597.042375] [084/130] (422s left) gem_exec_flush (basic-wb-rw-before-default)
[597.112700] Starting subtest: basic-wb-rw-before-default
[602.564065] Subtest basic-wb-rw-before-default: SUCCESS (5.452s)
[602.777442] [085/130] (416s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[602.883992] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[603.663691] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[603.857919] [086/130] (415s left) i915_query (query-regions-unallocated)
[603.908819] Starting subtest: query-regions-unallocated
[603.910936] Subtest query-regions-unallocated: SUCCESS (0.000s)
[604.040345] [087/130] (415s left) gem_exec_flush (basic-batch-kernel-default-wb)
[604.112031] Starting subtest: basic-batch-kernel-default-wb
[611.057433] Subtest basic-batch-kernel-default-wb: SUCCESS (6.946s)
[611.260589] [088/130] (408s left) syncobj_wait (multi-wait-all-signaled)
[611.321777] Starting subtest: multi-wait-all-signaled
[611.324084] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[611.423962] [089/130] (408s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[611.520281] Starting subtest: fbc-dirtyfb-ioctl
[611.522600] Starting dynamic subtest: A-eDP-1
[614.181429] Dynamic subtest A-eDP-1: SUCCESS (2.658s)
[614.183635] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.660s)
[615.072817] [090/130] (404s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[620.057473] Starting subtest: psr2-overlay-plane-update-continuous-sf
[620.060033] Starting dynamic subtest: pipe-A-eDP-1
[621.824872] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.769s)
[621.834351] Starting dynamic subtest: pipe-B-eDP-1
[623.556052] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.729s)
[623.558323] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.502s)
[624.386057] [091/130] (395s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[624.483265] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[624.487511] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[624.609368] [092/130] (395s left) kms_fbcon_fbt (fbc-suspend)
[624.671566] Starting subtest: fbc-suspend
[673.143678] Subtest fbc-suspend: SUCCESS (18.806s)
[674.240411] [093/130] (345s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[674.353116] Starting subtest: y-tiled-8bpp-rotate-270
[674.357486] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[674.469577] [094/130] (345s left) gem_exec_schedule (u-submit-early-slice)
[674.545319] Starting subtest: u-submit-early-slice
[674.547384] Starting dynamic subtest: rcs0
[674.583128] Dynamic subtest rcs0: SUCCESS (0.046s)
[674.594591] Starting dynamic subtest: bcs0
[674.620877] Dynamic subtest bcs0: SUCCESS (0.037s)
[674.631577] Starting dynamic subtest: vcs0
[674.663931] Dynamic subtest vcs0: SUCCESS (0.042s)
[674.675023] Starting dynamic subtest: vcs1
[674.700778] Dynamic subtest vcs1: SUCCESS (0.036s)
[674.712345] Starting dynamic subtest: vecs0
[674.738207] Dynamic subtest vecs0: SUCCESS (0.037s)
[674.750170] Starting dynamic subtest: ccs0
[674.774603] Dynamic subtest ccs0: SUCCESS (0.036s)
[674.776903] Subtest u-submit-early-slice: SUCCESS (0.238s)
[676.722323] [095/130] (343s left) vgem_basic (debugfs)
[676.759001] Starting subtest: debugfs
[676.760905] Subtest debugfs: SUCCESS (0.001s)
[676.830235] [096/130] (343s left) gen7_exec_parse (batch-without-end)
[676.890673] Subtest batch-without-end: SKIP (0.000s)
[676.969457] [097/130] (343s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[677.070906] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[699.119996] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.043s)
[699.254027] [098/130] (320s left) dmabuf_sync_file (export-basic)
[699.295776] Starting subtest: export-basic
[699.297652] Subtest export-basic: SUCCESS (0.001s)
[699.377911] [099/130] (320s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[699.471733] Starting subtest: random-ccs-data-y-tiled-ccs
[699.473709] Starting dynamic subtest: pipe-A-eDP-1
[699.495103] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[699.506339] Starting dynamic subtest: pipe-B-eDP-1
[699.525980] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[699.535864] Starting dynamic subtest: pipe-C-eDP-1
[699.557354] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[699.569236] Starting dynamic subtest: pipe-D-eDP-1
[699.589577] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[699.593380] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[701.768421] [100/130] (318s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[701.888606] Starting subtest: cursorB-vs-flipB-atomic
[701.893049] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[702.068604] [101/130] (318s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[702.132731] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[702.202061] [102/130] (318s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[702.330225] Starting subtest: protected-encrypted-src-copy-not-readible
[702.443096] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.114s)
[702.608126] [103/130] (317s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[702.701471] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[702.703585] Starting dynamic subtest: pipe-A-default-mode
[703.810545] Dynamic subtest pipe-A-default-mode: SKIP (1.107s)
[703.815170] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.109s)
[704.009666] [104/130] (316s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[704.120014] Starting subtest: fbcpsr-tiling-y
[704.124475] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[704.261207] [105/130] (316s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[704.808438] Starting subtest: syncobj-timeline-invalid-flags
[704.810905] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[706.630055] [106/130] (313s left) gem_basic (create-close)
[706.691785] Starting subtest: create-close
[706.696041] Subtest create-close: SUCCESS (0.000s)
[706.826858] [107/130] (313s left) api_intel_allocator (reloc-allocator)
[706.883728] Starting subtest: reloc-allocator
[706.885690] Starting dynamic subtest: basic
[706.888075] Dynamic subtest basic: SUCCESS (0.005s)
[706.898436] Starting dynamic subtest: parallel-one
[706.900225] Dynamic subtest parallel-one: SUCCESS (0.008s)
[706.910041] Starting dynamic subtest: print
[706.912174] Dynamic subtest print: SUCCESS (0.000s)
[706.921136] Starting dynamic subtest: reuse
[706.922973] Dynamic subtest reuse: SUCCESS (0.000s)
[706.932067] Starting dynamic subtest: fork-reopen-allocator
[706.933960] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[706.935839] Subtest reloc-allocator: SUCCESS (0.028s)
[707.073673] [108/130] (313s left) kms_psr (pr-primary-blt)
[707.161250] Starting subtest: pr-primary-blt
[707.165359] Subtest pr-primary-blt: SKIP (0.000s)
[707.271350] [109/130] (313s left) gem_ctx_bad_destroy (double-destroy)
[707.332417] Starting subtest: double-destroy
[707.334772] Subtest double-destroy: SUCCESS (0.000s)
[707.421368] [110/130] (313s left) core_getclient
[707.602654] [111/130] (313s left) syncobj_wait (wait-all-delayed-signal)
[707.655186] Starting subtest: wait-all-delayed-signal
[707.758637] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[707.846176] [112/130] (312s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[707.935013] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[707.938996] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[708.059196] [113/130] (312s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[708.156801] Starting subtest: yf-tiled-16bpp-rotate-0
[708.161243] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[708.287103] [114/130] (312s left) kms_async_flips (test-time-stamp)
[708.390711] Starting subtest: test-time-stamp
[708.761012] Starting dynamic subtest: pipe-A-eDP-1
[709.590680] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.827s)
[709.967278] Starting dynamic subtest: pipe-B-eDP-1
[710.718638] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[711.085510] Starting dynamic subtest: pipe-C-eDP-1
[711.845684] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[712.207109] Starting dynamic subtest: pipe-D-eDP-1
[712.974944] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[712.977390] Subtest test-time-stamp: SUCCESS (4.585s)
[714.155705] [115/130] (306s left) kms_invalid_mode (bad-vsync-end)
[714.260071] Starting subtest: bad-vsync-end
[714.264733] Starting dynamic subtest: pipe-A-eDP-1
[714.538371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[714.548477] Starting dynamic subtest: pipe-B-eDP-1
[714.550404] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[714.559569] Starting dynamic subtest: pipe-C-eDP-1
[714.561778] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[714.572751] Starting dynamic subtest: pipe-D-eDP-1
[714.574940] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[714.577154] Subtest bad-vsync-end: SUCCESS (0.289s)
[715.373217] [116/130] (305s left) gem_exec_suspend (basic)
[715.429464] Starting subtest: basic
[715.431910] Starting dynamic subtest: smem
[717.553146] Dynamic subtest smem: SUCCESS (2.121s)
[717.556104] Subtest basic: SUCCESS (2.123s)
[717.765425] [117/130] (303s left) api_intel_bb (blit-noreloc-purge-cache)
[717.818532] Starting subtest: blit-noreloc-purge-cache
[717.827410] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[717.992014] [118/130] (303s left) kms_plane (pixel-format-source-clamping)
[718.099146] Starting subtest: pixel-format-source-clamping
[718.125299] Starting dynamic subtest: pipe-A-plane-0
[722.924954] Dynamic subtest pipe-A-plane-0: SUCCESS (4.800s)
[722.936714] Starting dynamic subtest: pipe-A-plane-3
[725.425005] Dynamic subtest pipe-A-plane-3: SUCCESS (2.499s)
[725.435396] Starting dynamic subtest: pipe-A-plane-5
[725.437475] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[726.544655] Starting dynamic subtest: pipe-B-plane-0
[731.357605] Dynamic subtest pipe-B-plane-0: SUCCESS (4.822s)
[731.368511] Starting dynamic subtest: pipe-B-plane-3
[733.635765] Dynamic subtest pipe-B-plane-3: SUCCESS (2.277s)
[733.645668] Starting dynamic subtest: pipe-B-plane-5
[733.647638] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[733.943270] Subtest pixel-format-source-clamping: SUCCESS (15.844s)
[734.842798] [119/130] (286s left) i915_query (query-topology-kernel-writes)
[734.904692] Starting subtest: query-topology-kernel-writes
[734.906675] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[735.012534] [120/130] (286s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[735.404361] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[736.235252] [121/130] (284s left) gem_exec_reloc (basic-cpu-active)
[736.297586] Subtest basic-cpu-active: SKIP (0.000s)
[736.374764] [122/130] (284s left) gem_exec_fence (concurrent)
[736.550129] Starting subtest: concurrent
[736.554575] Subtest concurrent: SKIP (0.000s)
[738.667632] [123/130] (282s left) perf (short-reads)
[738.810594] Starting subtest: short-reads
[738.823802] Subtest short-reads: SUCCESS (0.015s)
[738.865394] [124/130] (282s left) dumb_buffer (create-clear)
[738.924016] Starting subtest: create-clear
[773.634781] Subtest create-clear: SUCCESS (34.706s)
[773.745050] [125/130] (247s left) kms_psr2_su (page_flip-p010)
[773.804027] Subtest page_flip-P010: SKIP (0.000s)
[773.864016] [126/130] (247s left) i915_pm_rc6_residency (rc6-idle)
[773.922343] Starting subtest: rc6-idle
[773.954841] Starting dynamic subtest: gt0-rcs0
[798.214923] Dynamic subtest gt0-rcs0: SUCCESS (24.260s)
[798.226528] Starting dynamic subtest: gt0-bcs0
[822.475633] Dynamic subtest gt0-bcs0: SUCCESS (24.258s)
[822.487370] Starting dynamic subtest: gt0-ccs0
[846.685886] Dynamic subtest gt0-ccs0: SUCCESS (24.207s)
[846.697834] Starting dynamic subtest: gt1-vcs0
[852.860925] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[852.874278] Starting dynamic subtest: gt1-vecs0
[859.032411] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[859.035666] Subtest rc6-idle: SUCCESS (85.106s)
[859.127191] [127/130] (162s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[859.233421] Starting subtest: plane-scaler-unity-scaling-with-rotation
[859.235625] Starting dynamic subtest: pipe-A
[859.472473] Dynamic subtest pipe-A: SUCCESS (0.241s)
[859.483507] Starting dynamic subtest: pipe-B
[860.731658] Dynamic subtest pipe-B: SUCCESS (1.258s)
[860.741692] Starting dynamic subtest: pipe-C
[862.064169] Dynamic subtest pipe-C: SUCCESS (1.332s)
[862.075621] Starting dynamic subtest: pipe-D
[863.394979] Dynamic subtest pipe-D: SUCCESS (1.330s)
[863.397303] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.164s)
[864.588155] [128/130] (156s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[864.689767] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[864.693910] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[864.836239] [129/130] (156s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[864.957827] Starting subtest: cursor-vs-flip-legacy
[894.248127] Subtest cursor-vs-flip-legacy: SUCCESS (29.287s)
[895.132712] [130/130] (126s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[895.185480] Starting subtest: multi-wait-available-submitted-signaled
[895.187828] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[895.328640] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_ctx_exec
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: core_getstats
results: parsing output: 9/ for test: i915_hangman
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_busy
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_lease
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: gem_exec_whisper
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_vrr
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_feature_discovery
results: parsing output: 45/ for test: kms_pm_rpm
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_scaling_modes
results: parsing output: 49/ for test: kms_color
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: gem_spin_batch
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_tiled_blits
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_plane_alpha_blend
results: parsing output: 80/ for test: i915_selftest
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: gem_exec_flush
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: i915_query
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_dirtyfb
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_fbcon_fbt
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: vgem_basic
results: parsing output: 95/ for test: gen7_exec_parse
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: dmabuf_sync_file
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: gem_basic
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_ctx_bad_destroy
results: parsing output: 109/ for test: core_getclient
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: gem_exec_suspend
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_chamelium_edid
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: dumb_buffer
results: parsing output: 124/ for test: kms_psr2_su
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: syncobj_timeline
Done.