[57.175702] Initializing watchdogs
[57.175792]   /dev/watchdog0
[57.189378] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.193469] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.195581] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.198767] [001/130] (960s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[57.300701] Starting subtest: plane-upscale-20x20-with-rotation
[57.302944] Starting dynamic subtest: pipe-A
[57.534447] Dynamic subtest pipe-A: SUCCESS (0.236s)
[57.542744] Starting dynamic subtest: pipe-B
[58.807514] Dynamic subtest pipe-B: SUCCESS (1.280s)
[58.815918] Starting dynamic subtest: pipe-C
[60.132521] Dynamic subtest pipe-C: SUCCESS (1.331s)
[60.140793] Starting dynamic subtest: pipe-D
[61.468389] Dynamic subtest pipe-D: SUCCESS (1.341s)
[61.470805] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.189s)
[62.647563] [002/130] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[62.756188] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[62.760836] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[62.876168] [003/130] (954s left) kms_big_fb (linear-8bpp-rotate-180)
[62.983098] Starting subtest: linear-8bpp-rotate-180
[64.080417] Subtest linear-8bpp-rotate-180: SUCCESS (1.101s)
[64.253949] [004/130] (953s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[64.349290] Starting subtest: blocking-absolute-wf_vblank-interruptible
[64.351581] Starting dynamic subtest: A-eDP1
[73.114784] Dynamic subtest A-eDP1: SUCCESS (8.742s)
[73.123397] Starting dynamic subtest: B-eDP1
[81.843477] Dynamic subtest B-eDP1: SUCCESS (8.735s)
[81.855300] Starting dynamic subtest: C-eDP1
[90.567859] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[90.575822] Starting dynamic subtest: D-eDP1
[99.300393] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[99.302465] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.927s)
[100.485787] [005/130] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[100.582598] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[100.587173] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[100.707882] [006/130] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[100.808646] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[107.430845] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (6.625s)
[107.609362] [007/130] (910s left) gem_ctx_exec (basic-norecovery)
[107.675796] Starting subtest: basic-norecovery
[107.962422] Subtest basic-norecovery: SUCCESS (0.285s)
[108.097286] [008/130] (909s left) kms_psr (psr-primary-page-flip)
[108.183240] Starting subtest: psr-primary-page-flip
[108.185606] Starting dynamic subtest: eDP-1
[109.890696] Dynamic subtest eDP-1: SUCCESS (1.707s)
[109.893022] Subtest psr-primary-page-flip: SUCCESS (1.707s)
[110.758550] [009/130] (907s left) core_getstats
[110.924949] [010/130] (907s left) i915_hangman (detector)
[110.992349] Starting subtest: detector
[110.994602] Starting dynamic subtest: rcs0
[122.865253] Dynamic subtest rcs0: SUCCESS (11.872s)
[122.875288] Starting dynamic subtest: bcs0
[134.899639] Dynamic subtest bcs0: SUCCESS (12.034s)
[134.909487] Starting dynamic subtest: vcs0
[146.801098] Dynamic subtest vcs0: SUCCESS (11.900s)
[146.811857] Starting dynamic subtest: vcs1
[156.850195] Dynamic subtest vcs1: SUCCESS (10.048s)
[156.863863] Starting dynamic subtest: vecs0
[168.817085] Dynamic subtest vecs0: SUCCESS (11.966s)
[168.827873] Starting dynamic subtest: ccs0
[179.888585] Dynamic subtest ccs0: SUCCESS (11.070s)
[179.890985] Subtest detector: SUCCESS (68.894s)
[180.037162] [011/130] (838s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[180.123526] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[180.125879] Starting dynamic subtest: pipe-A-eDP-1
[182.102165] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.978s)
[182.109716] Starting dynamic subtest: pipe-B-eDP-1
[184.228523] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.124s)
[184.236055] Starting dynamic subtest: pipe-C-eDP-1
[186.272168] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.042s)
[186.280314] Starting dynamic subtest: pipe-D-eDP-1
[188.310248] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.038s)
[188.312653] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.185s)
[189.496586] [012/130] (828s left) gem_lmem_swapping (parallel-random-engines)
[189.539271] Subtest parallel-random-engines: SKIP (0.000s)
[189.580155] [013/130] (828s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[189.670277] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[189.674612] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[189.780864] [014/130] (828s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[189.880045] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[189.884319] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[189.993041] [015/130] (828s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[190.096937] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[190.100886] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[190.215278] [016/130] (828s left) gem_ctx_persistence (legacy-engines-hostile)
[190.275079] Starting subtest: legacy-engines-hostile
[190.277319] Starting dynamic subtest: render
[190.430957] Dynamic subtest render: SUCCESS (0.155s)
[190.444226] Starting dynamic subtest: bsd1
[190.544647] Dynamic subtest bsd1: SUCCESS (0.112s)
[190.555017] Starting dynamic subtest: bsd2
[190.660392] Dynamic subtest bsd2: SUCCESS (0.114s)
[190.670054] Starting dynamic subtest: blt
[190.777377] Dynamic subtest blt: SUCCESS (0.115s)
[190.787310] Starting dynamic subtest: vebox
[190.880611] Dynamic subtest vebox: SUCCESS (0.101s)
[190.882896] Subtest legacy-engines-hostile: SUCCESS (0.606s)
[190.967253] [017/130] (827s left) prime_vgem (shrink)
[191.082108] Starting subtest: shrink
[191.096148] Subtest shrink: SUCCESS (0.012s)
[191.214273] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[191.217501] [018/130] (827s left) gem_exec_schedule (preempt-queue-chain)
[191.288960] Subtest preempt-queue-chain: SKIP (0.000s)
[191.590584] [019/130] (826s left) kms_flip (flip-vs-panning-vs-hang)
[191.681365] Starting subtest: flip-vs-panning-vs-hang
[191.683727] Starting dynamic subtest: A-eDP1
[242.433347] Dynamic subtest A-eDP1: SUCCESS (50.752s)
[242.440788] Starting dynamic subtest: D-eDP1
[282.364427] Dynamic subtest D-eDP1: SUCCESS (39.930s)
[282.366935] Subtest flip-vs-panning-vs-hang: SUCCESS (90.685s)
[283.562450] [020/130] (734s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[283.802228] Starting subtest: cursor-rapid-movement-256x256
[283.806899] Starting dynamic subtest: pipe-A-eDP-1
[284.336916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.528s)
[284.360111] Starting dynamic subtest: pipe-D-eDP-1
[285.558394] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s)
[285.560662] Subtest cursor-rapid-movement-256x256: SUCCESS (1.756s)
[286.431721] [021/130] (732s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[286.528387] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[286.532779] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[286.671805] [022/130] (731s left) gem_exec_balancer (sliced)
[286.735912] Starting subtest: sliced
[286.740372] Subtest sliced: SKIP (0.000s)
[287.053507] [023/130] (731s left) kms_psr (fbc-psr-suspend)
[287.144141] Starting subtest: fbc-psr-suspend
[287.146415] Starting dynamic subtest: eDP-1
[287.150639] Dynamic subtest eDP-1: SKIP (0.000s)
[287.154897] Subtest fbc-psr-suspend: SKIP (0.001s)
[287.240346] [024/130] (731s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[287.344213] Starting subtest: fbcpsr-stridechange
[293.450546] Subtest fbcpsr-stridechange: SUCCESS (6.108s)
[293.595847] [025/130] (725s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[293.695771] Starting subtest: 4-tiled-32bpp-rotate-180
[294.993801] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.300s)
[295.149974] [026/130] (723s left) gem_mmap_gtt (basic-read-write-distinct)
[295.208415] Subtest basic-read-write-distinct: SKIP (0.000s)
[295.263711] [027/130] (723s left) perf_pmu (busy-accuracy-2)
[295.298897] Starting subtest: busy-accuracy-2
[295.301224] Starting dynamic subtest: rcs0
[298.344195] Dynamic subtest rcs0: SUCCESS (3.043s)
[298.351875] Starting dynamic subtest: bcs0
[301.402025] Dynamic subtest bcs0: SUCCESS (3.056s)
[301.418683] Starting dynamic subtest: vcs0
[304.493852] Dynamic subtest vcs0: SUCCESS (3.039s)
[304.503267] Starting dynamic subtest: vcs1
[307.485221] Dynamic subtest vcs1: SUCCESS (3.042s)
[307.493256] Starting dynamic subtest: vecs0
[310.533083] Dynamic subtest vecs0: SUCCESS (3.046s)
[310.542250] Starting dynamic subtest: ccs0
[313.590162] Dynamic subtest ccs0: SUCCESS (3.056s)
[313.592054] Subtest busy-accuracy-2: SUCCESS (18.290s)
[313.741045] [028/130] (704s left) gem_create (create-ext-set-pat)
[313.908595] Starting subtest: create-ext-set-pat
[313.911063] Subtest create-ext-set-pat: SUCCESS (0.001s)
[314.037261] [029/130] (704s left) gem_exec_reloc (basic-wc-cpu-active)
[314.103497] Subtest basic-wc-cpu-active: SKIP (0.000s)
[314.189798] [030/130] (704s left) gem_ctx_persistence (userptr)
[314.247144] Starting subtest: userptr
[314.482912] Subtest userptr: SUCCESS (0.235s)
[314.572389] [031/130] (704s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[314.627359] Starting subtest: multi-wait-all-for-submit-unsubmitted
[314.735192] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[314.823638] [032/130] (704s left) gem_busy (close-race)
[314.891856] Starting subtest: close-race
[338.925046] Subtest close-race: SUCCESS (24.033s)
[339.333341] [033/130] (679s left) kms_addfb_basic (small-bo)
[339.479324] Starting subtest: small-bo
[339.481622] Subtest small-bo: SUCCESS (0.000s)
[339.602632] [034/130] (679s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[339.701666] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[344.103500] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.407s)
[345.304121] [035/130] (673s left) syncobj_timeline (invalid-transfer-non-existent-point)
[345.368867] Starting subtest: invalid-transfer-non-existent-point
[345.371077] Subtest invalid-transfer-non-existent-point: SUCCESS (0.001s)
[345.489160] [036/130] (673s left) kms_lease (lease-revoke)
[345.596381] Starting subtest: lease-revoke
[345.598876] Starting dynamic subtest: pipe-A-eDP-1
[345.633784] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.036s)
[345.645893] Starting dynamic subtest: pipe-B-eDP-1
[345.664220] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[345.673132] Starting dynamic subtest: pipe-C-eDP-1
[345.690219] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[345.699507] Starting dynamic subtest: pipe-D-eDP-1
[345.721096] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[345.723071] Subtest lease-revoke: SUCCESS (0.123s)
[345.867051] [037/130] (673s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[345.971545] Starting subtest: psr-rgb101010-draw-pwrite
[353.507390] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.538s)
[353.643474] [038/130] (665s left) gem_mmap_offset (partial-remap)
[353.706648] Starting subtest: partial-remap
[353.708977] Starting dynamic subtest: smem0
[353.717750] Dynamic subtest smem0: SUCCESS (0.004s)
[353.719982] Subtest partial-remap: SUCCESS (0.004s)
[353.846030] [039/130] (665s left) gem_exec_whisper (basic-fds-priority)
[353.902130] Starting subtest: basic-fds-priority
[377.436816] Subtest basic-fds-priority: SUCCESS (23.532s)
[377.629462] [040/130] (641s left) gem_softpin (allocator-nopin)
[377.693694] Starting subtest: allocator-nopin
[377.787721] Subtest allocator-nopin: SUCCESS (0.093s)
[377.929788] [041/130] (641s left) gem_exec_reloc (basic-concurrent16)
[378.003740] Subtest basic-concurrent16: SKIP (0.000s)
[378.081288] [042/130] (641s left) kms_vrr (negative-basic)
[378.189034] Starting subtest: negative-basic
[378.195675] Starting dynamic subtest: pipe-A-eDP-1
[383.664218] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s)
[383.917924] Subtest negative-basic: SUCCESS (5.728s)
[384.789438] [043/130] (634s left) syncobj_timeline (single-wait-all-signaled)
[384.848043] Starting subtest: single-wait-all-signaled
[384.850392] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[384.972053] [044/130] (634s left) kms_psr (fbc-psr2-primary-page-flip)
[385.065381] Starting subtest: fbc-psr2-primary-page-flip
[385.067680] Starting dynamic subtest: eDP-1
[385.071788] Dynamic subtest eDP-1: SKIP (0.000s)
[385.075956] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[385.151513] [045/130] (634s left) kms_feature_discovery (display-4x)
[385.242747] Starting subtest: display-4x
[385.247093] Subtest display-4x: SKIP (0.000s)
[385.328884] [046/130] (634s left) kms_pm_rpm (universal-planes)
[387.077628] Starting subtest: universal-planes
[387.080905] Starting dynamic subtest: plane-33
[395.382554] Dynamic subtest plane-33: SUCCESS (8.303s)
[395.395196] Starting dynamic subtest: plane-43
[403.663956] Dynamic subtest plane-43: SUCCESS (8.280s)
[403.673669] Starting dynamic subtest: plane-53
[412.042062] Dynamic subtest plane-53: SUCCESS (8.376s)
[412.051889] Starting dynamic subtest: plane-63
[420.335895] Dynamic subtest plane-63: SUCCESS (8.292s)
[420.346558] Starting dynamic subtest: plane-73
[428.712385] Dynamic subtest plane-73: SUCCESS (8.374s)
[428.724745] Starting dynamic subtest: plane-83
[437.013474] Dynamic subtest plane-83: SUCCESS (8.300s)
[437.015995] Subtest universal-planes: SUCCESS (49.937s)
[437.412906] [047/130] (582s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[437.516506] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[438.595302] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.081s)
[438.728168] [048/130] (580s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[438.786906] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[438.858862] [049/130] (580s left) kms_scaling_modes (scaling-mode-full-aspect)
[438.956163] Starting subtest: scaling-mode-full-aspect
[438.958244] Starting dynamic subtest: pipe-A-eDP-1
[439.050122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[439.061063] Starting dynamic subtest: pipe-B-eDP-1
[440.219549] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[440.228476] Starting dynamic subtest: pipe-C-eDP-1
[441.341176] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[441.350558] Starting dynamic subtest: pipe-D-eDP-1
[442.472592] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[442.475029] Subtest scaling-mode-full-aspect: SUCCESS (3.518s)
[443.641067] [050/130] (575s left) kms_color (degamma)
[443.731185] Starting subtest: degamma
[443.733492] Starting dynamic subtest: pipe-A-eDP-1
[444.418565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s)
[444.427674] Starting dynamic subtest: pipe-B-eDP-1
[445.816411] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[445.826852] Starting dynamic subtest: pipe-C-eDP-1
[447.204389] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[447.213529] Starting dynamic subtest: pipe-D-eDP-1
[448.509647] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.305s)
[448.512066] Subtest degamma: SUCCESS (4.778s)
[449.362789] [051/130] (570s left) kms_cursor_crc (cursor-offscreen-256x85)
[449.626917] Starting subtest: cursor-offscreen-256x85
[449.671622] Subtest cursor-offscreen-256x85: SKIP (0.040s)
[449.861489] [052/130] (569s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[449.974399] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[449.981863] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[450.133085] [053/130] (569s left) perf_pmu (busy-start)
[450.168984] Starting subtest: busy-start
[450.171396] Starting dynamic subtest: rcs0
[452.720091] Dynamic subtest rcs0: SUCCESS (2.551s)
[452.730248] Starting dynamic subtest: bcs0
[455.292590] Dynamic subtest bcs0: SUCCESS (2.548s)
[455.303489] Starting dynamic subtest: vcs0
[458.898358] Dynamic subtest vcs0: SUCCESS (3.624s)
[458.910561] Starting dynamic subtest: vcs1
[462.930428] Dynamic subtest vcs1: SUCCESS (4.030s)
[462.942040] Starting dynamic subtest: vecs0
[466.898084] Dynamic subtest vecs0: SUCCESS (3.966s)
[466.909270] Starting dynamic subtest: ccs0
[469.468602] Dynamic subtest ccs0: SUCCESS (2.549s)
[469.470655] Subtest busy-start: SUCCESS (19.279s)
[469.579072] [054/130] (550s left) gem_spin_batch (spin-each)
[469.652113] Starting subtest: spin-each
[472.980120] Subtest spin-each: SUCCESS (3.266s)
[474.921155] [055/130] (544s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[475.028684] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[475.032737] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[475.152410] [056/130] (544s left) kms_chamelium_frames (hdmi-crc-multiple)
[475.549058] Subtest hdmi-crc-multiple: SKIP (0.000s)
[476.364802] [057/130] (543s left) gen9_exec_parse (bb-start-out)
[476.427703] Subtest bb-start-out: SKIP (0.000s)
[476.491156] [058/130] (543s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[476.610452] Starting subtest: cursorB-vs-flipA-atomic-transitions
[476.614815] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.003s)
[476.765578] [059/130] (543s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[476.849141] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[476.853218] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[476.962306] [060/130] (542s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[477.047121] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[477.049417] Starting dynamic subtest: pipe-A-eDP-1
[477.072980] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[477.082309] Starting dynamic subtest: pipe-B-eDP-1
[477.103109] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[477.112037] Starting dynamic subtest: pipe-C-eDP-1
[477.132707] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[477.141530] Starting dynamic subtest: pipe-D-eDP-1
[477.164099] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[477.168561] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[479.262353] [061/130] (540s left) kms_flip (absolute-wf_vblank)
[479.352941] Starting subtest: absolute-wf_vblank
[479.355164] Starting dynamic subtest: A-eDP1
[488.144593] Dynamic subtest A-eDP1: SUCCESS (8.755s)
[488.153501] Starting dynamic subtest: B-eDP1
[496.866915] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[496.877936] Starting dynamic subtest: C-eDP1
[505.602239] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[505.613046] Starting dynamic subtest: D-eDP1
[514.338573] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[514.340659] Subtest absolute-wf_vblank: SUCCESS (34.944s)
[515.535549] [062/130] (504s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[515.595645] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[515.703370] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[515.812255] [063/130] (504s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[515.869187] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[515.871434] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[515.977241] [064/130] (504s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[516.060874] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[516.072054] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[516.212743] [065/130] (503s left) kms_cursor_crc (cursor-onscreen-128x42)
[516.435591] Starting subtest: cursor-onscreen-128x42
[516.484060] Subtest cursor-onscreen-128x42: SKIP (0.042s)
[516.728307] [066/130] (503s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[516.820204] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[516.821991] Starting dynamic subtest: pipe-A-eDP-1
[516.868910] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[516.877706] Starting dynamic subtest: pipe-B-eDP-1
[516.923650] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[516.932605] Starting dynamic subtest: pipe-C-eDP-1
[516.981727] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[516.990919] Starting dynamic subtest: pipe-D-eDP-1
[517.036921] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[517.040696] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[519.094489] [067/130] (501s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[519.191850] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[519.203563] Starting dynamic subtest: pipe-A-eDP-1
[519.226976] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[519.238856] Starting dynamic subtest: pipe-B-eDP-1
[519.260353] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[519.269426] Starting dynamic subtest: pipe-C-eDP-1
[519.290972] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[519.301843] Starting dynamic subtest: pipe-D-eDP-1
[519.324582] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[519.328823] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[521.367347] [068/130] (498s left) kms_vblank (query-idle)
[521.461090] Starting subtest: query-idle
[521.463222] Starting dynamic subtest: pipe-A-eDP-1
[523.205128] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.741s)
[523.219392] Starting dynamic subtest: pipe-D-eDP-1
[525.678748] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.473s)
[525.681172] Subtest query-idle: SUCCESS (4.218s)
[526.511995] [069/130] (493s left) gem_exec_reloc (basic-cpu-read-active)
[526.579863] Subtest basic-cpu-read-active: SKIP (0.000s)
[526.658888] [070/130] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[526.756516] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[526.760862] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[526.875853] [071/130] (493s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[531.862225] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[531.864639] Starting dynamic subtest: pipe-A-eDP-1
[532.663786] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s)
[532.674298] Starting dynamic subtest: pipe-B-eDP-1
[533.796216] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[533.801102] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.935s)
[534.990965] [072/130] (485s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[535.091491] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[541.296476] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.208s)
[542.496110] [073/130] (478s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[542.596287] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[542.600574] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[542.731656] [074/130] (477s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[542.835239] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[550.151705] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.319s)
[550.341997] [075/130] (470s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[550.439149] Starting subtest: fbc-modesetfrombusy
[554.276102] Subtest fbc-modesetfrombusy: SUCCESS (3.841s)
[555.470656] [076/130] (465s left) gem_tiled_blits (basic)
[555.542572] Subtest basic: SKIP (0.000s)
[555.625440] [077/130] (465s left) gem_eio (context-create)
[555.839978] Starting subtest: context-create
[556.143387] Subtest context-create: SUCCESS (0.302s)
[556.304694] [078/130] (464s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[556.362613] Starting subtest: x-tiled-to-vebox-y-tiled
[556.367213] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[556.564135] [079/130] (464s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[556.673047] Starting subtest: basic-busy-flip-before-cursor-varying-size
[556.677665] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[556.834950] [080/130] (463s left) kms_plane_alpha_blend (alpha-7efc)
[556.939343] Starting subtest: alpha-7efc
[557.221905] Starting dynamic subtest: pipe-A-eDP-1
[557.806692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[557.832661] Starting dynamic subtest: pipe-D-eDP-1
[559.128978] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.303s)
[559.131183] Subtest alpha-7efc: SUCCESS (2.189s)
[560.026395] [081/130] (460s left) i915_selftest (perf)
[563.561367] Starting subtest: perf
[563.564046] Starting dynamic subtest: engine_cs
[566.389311] Dynamic subtest engine_cs: SUCCESS (2.827s)
[566.398235] Starting dynamic subtest: request
[573.717025] Dynamic subtest request: SUCCESS (7.326s)
[573.726231] Starting dynamic subtest: migrate
[578.098179] Dynamic subtest migrate: SUCCESS (4.379s)
[578.113098] Starting dynamic subtest: region
[584.018371] Dynamic subtest region: SUCCESS (5.918s)
[584.021086] Subtest perf: SUCCESS (20.457s)
[584.048344] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[584.049137] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[584.052423] [082/130] (436s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[585.570454] Starting subtest: short-flip-before-cursor-toggle
[586.508525] Subtest short-flip-before-cursor-toggle: SUCCESS (0.939s)
[587.404793] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[587.405927] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true
[587.409630] [083/130] (433s left) kms_pm_rpm (modeset-lpsp-stress)
[589.028224] Starting subtest: modeset-lpsp-stress
[604.508763] Subtest modeset-lpsp-stress: SUCCESS (15.481s)
[604.608613] [084/130] (416s left) gem_exec_flush (basic-wb-rw-before-default)
[604.677416] Starting subtest: basic-wb-rw-before-default
[610.169840] Subtest basic-wb-rw-before-default: SUCCESS (5.451s)
[610.332201] [085/130] (410s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[610.432702] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[611.189784] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.759s)
[611.389630] [086/130] (409s left) i915_query (query-regions-unallocated)
[611.455722] Starting subtest: query-regions-unallocated
[611.458101] Subtest query-regions-unallocated: SUCCESS (0.000s)
[611.590408] [087/130] (409s left) gem_exec_flush (basic-batch-kernel-default-wb)
[611.652772] Starting subtest: basic-batch-kernel-default-wb
[619.153999] Subtest basic-batch-kernel-default-wb: SUCCESS (7.503s)
[619.353238] [088/130] (401s left) syncobj_wait (multi-wait-all-signaled)
[619.410557] Starting subtest: multi-wait-all-signaled
[619.413026] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[619.549237] [089/130] (401s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[619.643787] Starting subtest: fbc-dirtyfb-ioctl
[619.645995] Starting dynamic subtest: A-eDP-1
[622.251740] Dynamic subtest A-eDP-1: SUCCESS (2.608s)
[622.254118] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.610s)
[623.136848] [090/130] (398s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[628.112541] Starting subtest: psr2-overlay-plane-update-continuous-sf
[628.115061] Starting dynamic subtest: pipe-A-eDP-1
[629.865501] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[629.874669] Starting dynamic subtest: pipe-B-eDP-1
[631.606794] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.737s)
[631.609138] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.492s)
[632.442328] [091/130] (388s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[632.528676] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[632.532955] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[632.640358] [092/130] (388s left) kms_fbcon_fbt (fbc-suspend)
[632.696859] Starting subtest: fbc-suspend
[681.480243] Subtest fbc-suspend: SUCCESS (19.199s)
[682.620167] [093/130] (338s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[682.718126] Starting subtest: y-tiled-8bpp-rotate-270
[682.722346] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[682.829228] [094/130] (338s left) gem_exec_schedule (u-submit-early-slice)
[682.905306] Starting subtest: u-submit-early-slice
[682.907530] Starting dynamic subtest: rcs0
[682.942293] Dynamic subtest rcs0: SUCCESS (0.044s)
[682.954902] Starting dynamic subtest: bcs0
[682.975978] Dynamic subtest bcs0: SUCCESS (0.034s)
[682.985189] Starting dynamic subtest: vcs0
[683.016740] Dynamic subtest vcs0: SUCCESS (0.040s)
[683.029175] Starting dynamic subtest: vcs1
[683.050241] Dynamic subtest vcs1: SUCCESS (0.033s)
[683.059777] Starting dynamic subtest: vecs0
[683.083053] Dynamic subtest vecs0: SUCCESS (0.033s)
[683.092427] Starting dynamic subtest: ccs0
[683.121110] Dynamic subtest ccs0: SUCCESS (0.038s)
[683.123409] Subtest u-submit-early-slice: SUCCESS (0.225s)
[684.785809] [095/130] (336s left) vgem_basic (debugfs)
[684.832047] Starting subtest: debugfs
[684.834173] Subtest debugfs: SUCCESS (0.000s)
[684.901705] [096/130] (336s left) gen7_exec_parse (batch-without-end)
[684.963330] Subtest batch-without-end: SKIP (0.000s)
[685.029395] [097/130] (336s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[685.120311] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[706.979843] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (21.902s)
[707.147077] [098/130] (314s left) dmabuf_sync_file (export-basic)
[707.199755] Starting subtest: export-basic
[707.201908] Subtest export-basic: SUCCESS (0.001s)
[707.282023] [099/130] (314s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[707.375176] Starting subtest: random-ccs-data-y-tiled-ccs
[707.377158] Starting dynamic subtest: pipe-A-eDP-1
[707.398514] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[707.409319] Starting dynamic subtest: pipe-B-eDP-1
[707.428733] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[707.437499] Starting dynamic subtest: pipe-C-eDP-1
[707.457234] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[707.466537] Starting dynamic subtest: pipe-D-eDP-1
[707.488272] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[707.491818] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[709.619391] [100/130] (311s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[709.736513] Starting subtest: cursorB-vs-flipB-atomic
[709.740985] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[709.901066] [101/130] (311s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[709.953041] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[710.022083] [102/130] (311s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[710.140700] Starting subtest: protected-encrypted-src-copy-not-readible
[710.284598] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.146s)
[710.451100] [103/130] (311s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[710.557032] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[710.559232] Starting dynamic subtest: pipe-A-default-mode
[711.671319] Dynamic subtest pipe-A-default-mode: SKIP (1.110s)
[711.675856] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.111s)
[711.845463] [104/130] (309s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[711.946415] Starting subtest: fbcpsr-tiling-y
[711.950825] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[712.053857] [105/130] (309s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[712.587460] Starting subtest: syncobj-timeline-invalid-flags
[712.590196] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[713.741879] [106/130] (308s left) gem_basic (create-close)
[713.802340] Starting subtest: create-close
[713.806630] Subtest create-close: SUCCESS (0.000s)
[713.920120] [107/130] (307s left) api_intel_allocator (reloc-allocator)
[713.970343] Starting subtest: reloc-allocator
[713.972487] Starting dynamic subtest: basic
[713.975168] Dynamic subtest basic: SUCCESS (0.005s)
[713.987618] Starting dynamic subtest: parallel-one
[713.989909] Dynamic subtest parallel-one: SUCCESS (0.008s)
[713.998970] Starting dynamic subtest: print
[714.000826] Dynamic subtest print: SUCCESS (0.000s)
[714.009304] Starting dynamic subtest: reuse
[714.011185] Dynamic subtest reuse: SUCCESS (0.000s)
[714.019703] Starting dynamic subtest: fork-reopen-allocator
[714.021503] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[714.023300] Subtest reloc-allocator: SUCCESS (0.028s)
[714.141831] [108/130] (307s left) kms_psr (pr-primary-blt)
[714.227957] Starting subtest: pr-primary-blt
[714.232447] Subtest pr-primary-blt: SKIP (0.000s)
[714.327940] [109/130] (307s left) gem_ctx_bad_destroy (double-destroy)
[714.385894] Starting subtest: double-destroy
[714.388197] Subtest double-destroy: SUCCESS (0.000s)
[714.472459] [110/130] (307s left) core_getclient
[714.643078] [111/130] (307s left) syncobj_wait (wait-all-delayed-signal)
[714.689822] Starting subtest: wait-all-delayed-signal
[714.793970] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[714.877646] [112/130] (307s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[714.977376] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[714.981779] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[715.103045] [113/130] (307s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[715.211605] Starting subtest: yf-tiled-16bpp-rotate-0
[715.215720] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[715.345322] [114/130] (306s left) kms_async_flips (test-time-stamp)
[715.429059] Starting subtest: test-time-stamp
[715.798814] Starting dynamic subtest: pipe-A-eDP-1
[716.650514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.849s)
[717.016753] Starting dynamic subtest: pipe-B-eDP-1
[717.782989] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.773s)
[718.144745] Starting dynamic subtest: pipe-C-eDP-1
[718.916442] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[719.283858] Starting dynamic subtest: pipe-D-eDP-1
[720.050083] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[720.052582] Subtest test-time-stamp: SUCCESS (4.620s)
[721.225545] [115/130] (300s left) kms_invalid_mode (bad-vsync-end)
[721.326184] Starting subtest: bad-vsync-end
[721.328471] Starting dynamic subtest: pipe-A-eDP-1
[721.609412] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[721.619891] Starting dynamic subtest: pipe-B-eDP-1
[721.621880] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[721.631391] Starting dynamic subtest: pipe-C-eDP-1
[721.633793] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[721.642866] Starting dynamic subtest: pipe-D-eDP-1
[721.644850] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[721.646815] Subtest bad-vsync-end: SUCCESS (0.288s)
[722.454225] [116/130] (299s left) gem_exec_suspend (basic)
[722.515390] Starting subtest: basic
[722.517756] Starting dynamic subtest: smem
[724.641436] Dynamic subtest smem: SUCCESS (2.123s)
[724.644399] Subtest basic: SUCCESS (2.125s)
[724.849034] [117/130] (297s left) api_intel_bb (blit-noreloc-purge-cache)
[724.906745] Starting subtest: blit-noreloc-purge-cache
[724.919012] Subtest blit-noreloc-purge-cache: SUCCESS (0.013s)
[725.032772] [118/130] (297s left) kms_plane (pixel-format-source-clamping)
[725.135965] Starting subtest: pixel-format-source-clamping
[725.165876] Starting dynamic subtest: pipe-A-plane-0
[729.976556] Dynamic subtest pipe-A-plane-0: SUCCESS (4.811s)
[729.985871] Starting dynamic subtest: pipe-A-plane-3
[732.265409] Dynamic subtest pipe-A-plane-3: SUCCESS (2.288s)
[732.275139] Starting dynamic subtest: pipe-A-plane-5
[732.276760] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[733.332596] Starting dynamic subtest: pipe-B-plane-0
[738.066211] Dynamic subtest pipe-B-plane-0: SUCCESS (4.744s)
[738.076932] Starting dynamic subtest: pipe-B-plane-3
[740.387791] Dynamic subtest pipe-B-plane-3: SUCCESS (2.322s)
[740.397856] Starting dynamic subtest: pipe-B-plane-5
[740.399786] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[740.694210] Subtest pixel-format-source-clamping: SUCCESS (15.559s)
[741.508454] [119/130] (280s left) i915_query (query-topology-kernel-writes)
[741.562061] Starting subtest: query-topology-kernel-writes
[741.564358] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[741.682664] [120/130] (280s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[742.073961] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[742.911119] [121/130] (279s left) gem_exec_reloc (basic-cpu-active)
[742.980721] Subtest basic-cpu-active: SKIP (0.000s)
[743.062898] [122/130] (279s left) gem_exec_fence (concurrent)
[743.238462] Starting subtest: concurrent
[743.243135] Subtest concurrent: SKIP (0.000s)
[744.712884] [123/130] (277s left) perf (short-reads)
[744.845030] Starting subtest: short-reads
[744.861448] Subtest short-reads: SUCCESS (0.017s)
[744.908500] [124/130] (277s left) dumb_buffer (create-clear)
[744.967120] Starting subtest: create-clear
[779.209482] Subtest create-clear: SUCCESS (34.194s)
[779.276313] [125/130] (243s left) kms_psr2_su (page_flip-p010)
[779.339652] Subtest page_flip-P010: SKIP (0.000s)
[779.403747] [126/130] (243s left) i915_pm_rc6_residency (rc6-idle)
[779.454774] Starting subtest: rc6-idle
[779.495766] Starting dynamic subtest: gt0-rcs0
[803.760250] Dynamic subtest gt0-rcs0: SUCCESS (24.262s)
[803.771640] Starting dynamic subtest: gt0-bcs0
[828.106816] Dynamic subtest gt0-bcs0: SUCCESS (24.347s)
[828.116114] Starting dynamic subtest: gt0-ccs0
[852.370323] Dynamic subtest gt0-ccs0: SUCCESS (24.266s)
[852.380820] Starting dynamic subtest: gt1-vcs0
[858.596113] Dynamic subtest gt1-vcs0: SUCCESS (6.172s)
[858.609314] Starting dynamic subtest: gt1-vecs0
[864.766921] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[864.769664] Subtest rc6-idle: SUCCESS (85.264s)
[864.815082] [127/130] (157s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[864.909948] Starting subtest: plane-scaler-unity-scaling-with-rotation
[864.912105] Starting dynamic subtest: pipe-A
[865.138156] Dynamic subtest pipe-A: SUCCESS (0.230s)
[865.148345] Starting dynamic subtest: pipe-B
[866.391009] Dynamic subtest pipe-B: SUCCESS (1.253s)
[866.403000] Starting dynamic subtest: pipe-C
[867.720306] Dynamic subtest pipe-C: SUCCESS (1.329s)
[867.730849] Starting dynamic subtest: pipe-D
[869.057363] Dynamic subtest pipe-D: SUCCESS (1.337s)
[869.059515] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.151s)
[870.240073] [128/130] (152s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[870.339415] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[870.343904] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[870.478709] [129/130] (152s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[870.595921] Starting subtest: cursor-vs-flip-legacy
[899.785520] Subtest cursor-vs-flip-legacy: SUCCESS (29.195s)
[900.675366] [130/130] (122s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[900.740256] Starting subtest: multi-wait-available-submitted-signaled
[900.742675] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[900.859874] 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.