[57.628486] Initializing watchdogs
[57.628557]   /dev/watchdog0
[57.654480] [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.658829] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.661088] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.664287] [001/133] (960s left) gem_exec_schedule (reorder-wide)
[57.856349] Subtest reorder-wide: SKIP (0.000s)
[58.059078] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[58.152136] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[58.156115] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[58.258568] [003/133] (959s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-gtt)
[58.358795] Starting subtest: fbcpsr-argb161616f-draw-mmap-gtt
[58.363202] Subtest fbcpsr-argb161616f-draw-mmap-gtt: SKIP (0.000s)
[58.487586] [004/133] (959s left) gem_mmap_offset (isolation)
[58.546981] Starting subtest: isolation
[58.564829] Subtest isolation: SUCCESS (0.007s)
[58.690068] [005/133] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[58.792572] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[58.796879] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[58.931873] [006/133] (959s left) gen7_exec_parse (basic-rejected)
[58.998178] Subtest basic-rejected: SKIP (0.000s)
[59.078410] [007/133] (959s left) kms_cursor_edge_walk (128x128-right-edge)
[59.169128] Starting subtest: 128x128-right-edge
[59.171434] Starting dynamic subtest: pipe-A-eDP-1
[62.615363] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[62.624687] Starting dynamic subtest: pipe-D-eDP-1
[65.714744] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[65.717691] Subtest 128x128-right-edge: SUCCESS (6.582s)
[66.550915] [008/133] (951s left) api_intel_bb (reset-bb)
[66.603124] Starting subtest: reset-bb
[66.604981] Subtest reset-bb: SUCCESS (0.004s)
[66.745699] [009/133] (951s left) gem_exec_reloc (basic-gtt-read-active)
[66.831975] Subtest basic-gtt-read-active: SKIP (0.000s)
[66.918117] [010/133] (951s left) kms_psr (psr-no-drrs)
[67.418471] Starting subtest: psr-no-drrs
[67.421198] Starting dynamic subtest: eDP-1
[69.103678] Dynamic subtest eDP-1: SUCCESS (1.690s)
[69.106012] Subtest psr-no-drrs: SUCCESS (1.691s)
[69.998852] [011/133] (948s left) kms_chamelium_color (ctm-max)
[70.100357] Subtest ctm-max: SKIP (0.000s)
[70.145345] [012/133] (948s left) drm_mm (drm_mm)
[70.188125] Starting subtest: drm_mm
[70.199743] Starting dynamic subtest: drm_test_mm_init
[70.339288] Dynamic subtest drm_test_mm_init: SUCCESS (0.138s)
[70.348471] Starting dynamic subtest: drm_test_mm_debug
[70.473335] Dynamic subtest drm_test_mm_debug: SUCCESS (0.133s)
[70.482524] Starting dynamic subtest: drm_test_mm_align32
[70.612245] Dynamic subtest drm_test_mm_align32: SUCCESS (0.139s)
[70.621055] Starting dynamic subtest: drm_test_mm_align64
[70.755242] Dynamic subtest drm_test_mm_align64: SUCCESS (0.143s)
[70.763540] Starting dynamic subtest: drm_test_mm_lowest
[70.904167] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.148s)
[70.912973] Starting dynamic subtest: drm_test_mm_highest
[71.049060] Dynamic subtest drm_test_mm_highest: SUCCESS (0.145s)
[71.051261] Subtest drm_mm: SUCCESS (0.860s)
[71.267593] [013/133] (947s left) i915_query (query-topology-garbage-items)
[71.319731] Starting subtest: query-topology-garbage-items
[71.321626] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[71.455844] [014/133] (947s left) kms_hdr (bpc-switch)
[71.555156] Starting subtest: bpc-switch
[72.650779] Starting dynamic subtest: pipe-A-eDP-1
[76.138290] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.494s)
[76.140760] Subtest bpc-switch: SUCCESS (4.591s)
[76.296794] [015/133] (942s left) kms_frontbuffer_tracking (psr-argb161616f-draw-pwrite)
[76.395811] Starting subtest: psr-argb161616f-draw-pwrite
[76.400292] Subtest psr-argb161616f-draw-pwrite: SKIP (0.000s)
[76.524135] [016/133] (942s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[81.559948] Starting subtest: fbc-pr-cursor-plane-update-sf
[81.564813] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.003s)
[82.438026] [017/133] (936s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[82.542242] Starting subtest: plane-upscale-20x20-with-rotation
[82.544603] Starting dynamic subtest: pipe-A
[82.766590] Dynamic subtest pipe-A: SUCCESS (0.227s)
[82.775722] Starting dynamic subtest: pipe-B
[84.104052] Dynamic subtest pipe-B: SUCCESS (1.337s)
[84.113415] Starting dynamic subtest: pipe-C
[85.430581] Dynamic subtest pipe-C: SUCCESS (1.326s)
[85.439843] Starting dynamic subtest: pipe-D
[86.768684] Dynamic subtest pipe-D: SUCCESS (1.337s)
[86.771209] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.229s)
[87.972177] [018/133] (930s left) gem_ccs (ctrl-surf-copy-new-ctx)
[88.054468] Starting subtest: ctrl-surf-copy-new-ctx
[88.058816] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[88.193345] [019/133] (930s left) gem_exec_alignment (single)
[88.269822] Starting subtest: single
[88.274803] Subtest single: SUCCESS (0.004s)
[88.417495] [020/133] (930s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[88.502912] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[88.505369] Starting dynamic subtest: pipe-A-default-mode
[89.624229] Dynamic subtest pipe-A-default-mode: SKIP (1.118s)
[89.628184] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.119s)
[89.803512] [021/133] (929s left) kms_lease (simple-lease)
[89.898231] Starting subtest: simple-lease
[89.900738] Starting dynamic subtest: pipe-A-eDP-1
[90.397950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.499s)
[90.408604] Starting dynamic subtest: pipe-B-eDP-1
[91.846872] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s)
[91.856285] Starting dynamic subtest: pipe-C-eDP-1
[93.240783] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[93.249595] Starting dynamic subtest: pipe-D-eDP-1
[94.642133] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s)
[94.644573] Subtest simple-lease: SUCCESS (4.747s)
[95.460584] [022/133] (923s left) perf (polling-parameterized)
[95.609404] Starting subtest: polling-parameterized
[115.631119] Subtest polling-parameterized: SUCCESS (20.021s)
[115.676367] [023/133] (903s left) perf_pmu (module-unload)
[115.778978] Starting subtest: module-unload
[122.584057] Subtest module-unload: FAIL (6.694s)
[122.615942] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[122.618865] [024/133] (896s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[124.185851] Starting subtest: basic-batch-kernel-default-cmd
[124.191154] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[124.341339] [FACT gem_exec_flush (basic-batch-kernel-default-cmd)] new: kernel.kmod_is_loaded.i915: true
[124.344785] [025/133] (894s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[124.445108] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[124.449634] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[125.558792] [026/133] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[125.673691] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[125.678060] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[125.799226] [027/133] (893s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[125.914985] Starting subtest: fbc-rgb101010-draw-render
[130.544914] Subtest fbc-rgb101010-draw-render: SUCCESS (4.642s)
[131.668156] [028/133] (887s left) gem_exec_reloc (basic-gtt)
[131.732737] Subtest basic-gtt: SKIP (0.000s)
[131.819190] [029/133] (887s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[131.927746] Starting subtest: 4-tiled-32bpp-rotate-270
[131.946991] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[132.104942] [030/133] (887s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[132.206106] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[132.208358] Starting dynamic subtest: pipe-A
[133.377239] Dynamic subtest pipe-A: SUCCESS (1.174s)
[133.385760] Starting dynamic subtest: pipe-B
[135.659457] Dynamic subtest pipe-B: SUCCESS (2.282s)
[135.667740] Starting dynamic subtest: pipe-C
[136.838177] Dynamic subtest pipe-C: SUCCESS (1.177s)
[136.848960] Starting dynamic subtest: pipe-D
[138.079130] Dynamic subtest pipe-D: SUCCESS (1.240s)
[138.081412] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.876s)
[139.291932] [031/133] (880s left) gem_ctx_shared (disjoint-timelines)
[139.371929] Starting subtest: disjoint-timelines
[139.408691] Subtest disjoint-timelines: SUCCESS (0.037s)
[139.687344] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[139.692055] [032/133] (879s left) kms_flip (wf_vblank-ts-check-interruptible)
[139.779075] Starting subtest: wf_vblank-ts-check-interruptible
[139.785040] Starting dynamic subtest: A-eDP1
[148.724992] Dynamic subtest A-eDP1: SUCCESS (8.938s)
[148.735823] Starting dynamic subtest: B-eDP1
[157.659845] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[157.668683] Starting dynamic subtest: C-eDP1
[166.578332] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[166.587960] Starting dynamic subtest: D-eDP1
[175.514558] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[175.520118] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.737s)
[176.766558] [033/133] (842s left) kms_addfb_basic (bad-pitch-32)
[176.833449] Starting subtest: bad-pitch-32
[176.835728] Subtest bad-pitch-32: SUCCESS (0.000s)
[177.001599] [034/133] (842s left) gem_exec_fence (basic-busy)
[177.183247] Starting subtest: basic-busy
[177.185777] Starting dynamic subtest: rcs0
[177.294636] Dynamic subtest rcs0: SUCCESS (0.112s)
[177.305491] Starting dynamic subtest: bcs0
[177.362442] Dynamic subtest bcs0: SUCCESS (0.066s)
[177.372602] Starting dynamic subtest: vcs0
[177.427220] Dynamic subtest vcs0: SUCCESS (0.063s)
[177.437629] Starting dynamic subtest: vcs1
[177.490649] Dynamic subtest vcs1: SUCCESS (0.062s)
[177.501062] Starting dynamic subtest: vecs0
[177.548841] Dynamic subtest vecs0: SUCCESS (0.056s)
[177.559241] Starting dynamic subtest: ccs0
[177.611085] Dynamic subtest ccs0: SUCCESS (0.061s)
[177.613496] Subtest basic-busy: SUCCESS (0.429s)
[178.994457] [035/133] (840s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[179.101197] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[180.168298] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.068s)
[180.337737] [036/133] (839s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[180.432214] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[180.435892] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[180.561617] [037/133] (838s left) kms_pm_rpm (modeset-stress-extra-wait)
[182.078962] Starting subtest: modeset-stress-extra-wait
[236.397176] Subtest modeset-stress-extra-wait: SUCCESS (54.319s)
[236.511965] [038/133] (783s left) prime_vgem (basic-fence-mmap)
[236.595425] Starting subtest: basic-fence-mmap
[236.599802] Subtest basic-fence-mmap: SKIP (0.000s)
[236.734854] [039/133] (782s left) gem_userptr_blits (set-cache-level)
[236.810424] Starting subtest: set-cache-level
[236.814979] Subtest set-cache-level: SKIP (0.000s)
[236.985732] [040/133] (782s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[237.053610] Starting subtest: single-wait-for-submit-available-signaled
[237.056083] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[237.186553] [041/133] (782s left) gem_mmap_gtt (basic-small-copy-xy)
[237.255115] Subtest basic-small-copy-XY: SKIP (0.000s)
[237.327174] [042/133] (782s left) kms_flip (basic-flip-vs-wf_vblank)
[237.426870] Starting subtest: basic-flip-vs-wf_vblank
[237.428848] Starting dynamic subtest: A-eDP1
[239.399877] Dynamic subtest A-eDP1: SUCCESS (1.972s)
[239.410572] Starting dynamic subtest: B-eDP1
[241.329110] Dynamic subtest B-eDP1: SUCCESS (1.927s)
[241.339764] Starting dynamic subtest: C-eDP1
[243.251267] Dynamic subtest C-eDP1: SUCCESS (1.921s)
[243.267207] Starting dynamic subtest: D-eDP1
[245.168385] Dynamic subtest D-eDP1: SUCCESS (1.915s)
[245.170750] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.744s)
[246.423185] [043/133] (773s left) kms_getfb (getfb-handle-valid)
[246.530103] Starting subtest: getfb-handle-valid
[246.532372] Subtest getfb-handle-valid: SUCCESS (0.000s)
[246.698900] [044/133] (773s left) gen3_render_mixed_blits
[246.833231] [045/133] (773s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[247.232264] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[248.022438] [046/133] (771s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[248.120838] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[248.123141] Starting dynamic subtest: pipe-A-eDP-1
[248.401997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.249s)
[248.411624] Starting dynamic subtest: pipe-B-eDP-1
[249.720186] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.319s)
[249.731111] Starting dynamic subtest: pipe-C-eDP-1
[251.021103] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.293s)
[251.031680] Starting dynamic subtest: pipe-D-eDP-1
[252.267960] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[252.270289] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.117s)
[253.489925] [047/133] (766s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[253.561387] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[253.566115] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[253.770789] [048/133] (766s left) kms_cursor_crc (cursor-offscreen-32x32)
[253.921745] Starting subtest: cursor-offscreen-32x32
[253.970275] Subtest cursor-offscreen-32x32: SKIP (0.044s)
[254.299247] [049/133] (765s left) kms_psr (fbc-psr-basic)
[254.408346] Starting subtest: fbc-psr-basic
[254.410614] Starting dynamic subtest: eDP-1
[254.414683] Dynamic subtest eDP-1: SKIP (0.000s)
[254.418797] Subtest fbc-psr-basic: SKIP (0.001s)
[254.503989] [050/133] (765s left) kms_psr (fbc-psr2-cursor-blt)
[254.607154] Starting subtest: fbc-psr2-cursor-blt
[254.609445] Starting dynamic subtest: eDP-1
[254.613870] Dynamic subtest eDP-1: SKIP (0.000s)
[254.618364] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[254.709114] [051/133] (765s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[254.810655] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[254.812548] Starting dynamic subtest: pipe-A
[254.830061] Dynamic subtest pipe-A: SKIP (0.018s)
[254.838673] Starting dynamic subtest: pipe-B
[254.863064] Dynamic subtest pipe-B: SKIP (0.032s)
[254.870882] Starting dynamic subtest: pipe-C
[254.895559] Dynamic subtest pipe-C: SKIP (0.031s)
[254.903601] Starting dynamic subtest: pipe-D
[254.927745] Dynamic subtest pipe-D: SKIP (0.031s)
[254.930820] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.115s)
[255.074719] [052/133] (765s left) gem_exec_reloc (basic-write-gtt)
[255.145992] Subtest basic-write-gtt: SKIP (0.000s)
[255.225650] [053/133] (765s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[255.324125] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[255.327435] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[255.456785] [054/133] (764s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[260.456387] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[260.458755] Starting dynamic subtest: pipe-A-eDP-1
[261.236782] Dynamic subtest pipe-A-eDP-1: SKIP (0.778s)
[261.245996] Starting dynamic subtest: pipe-B-eDP-1
[262.377724] Dynamic subtest pipe-B-eDP-1: SKIP (1.136s)
[262.382492] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.919s)
[263.585297] [055/133] (756s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[263.673323] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[263.677914] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[264.804310] [056/133] (755s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[264.937238] Starting subtest: protected-encrypted-src-copy-not-readible
[265.048059] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s)
[265.218445] [057/133] (755s left) syncobj_timeline (host-signal-points)
[265.273830] Starting subtest: host-signal-points
[265.276235] Subtest host-signal-points: SUCCESS (0.004s)
[265.417302] [058/133] (755s left) kms_flip (2x-flip-vs-expired-vblank)
[265.512493] Starting subtest: 2x-flip-vs-expired-vblank
[265.528050] Subtest 2x-flip-vs-expired-vblank: SKIP (0.015s)
[265.631968] [059/133] (754s left) kms_pipe_stress (stress-xrgb8888-untiled)
[265.727851] Starting subtest: stress-xrgb8888-untiled
[271.577905] Subtest stress-xrgb8888-untiled: SUCCESS (5.853s)
[271.627261] [060/133] (748s left) kms_psr (psr2-primary-mmap-gtt)
[271.716410] Starting subtest: psr2-primary-mmap-gtt
[271.718153] Starting dynamic subtest: eDP-1
[273.176063] Dynamic subtest eDP-1: SKIP (1.457s)
[273.180812] Subtest psr2-primary-mmap-gtt: SKIP (1.459s)
[273.344804] [061/133] (747s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[273.403865] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[273.468119] [062/133] (747s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[273.529432] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[273.610445] [063/133] (747s left) gem_exec_reloc (basic-cpu-wc)
[273.671417] Subtest basic-cpu-wc: SKIP (0.000s)
[273.752773] [064/133] (746s left) gem_ctx_isolation (clean)
[273.818506] Starting subtest: clean
[273.820931] Starting dynamic subtest: rcs0
[273.874315] Dynamic subtest rcs0: SUCCESS (0.055s)
[273.888498] Starting dynamic subtest: bcs0
[273.968848] Dynamic subtest bcs0: SUCCESS (0.092s)
[273.980276] Starting dynamic subtest: vcs0
[274.059763] Dynamic subtest vcs0: SUCCESS (0.090s)
[274.069523] Starting dynamic subtest: vcs1
[275.977877] Dynamic subtest vcs1: SUCCESS (1.917s)
[275.987735] Starting dynamic subtest: vecs0
[277.919250] Dynamic subtest vecs0: SUCCESS (1.940s)
[277.929869] Starting dynamic subtest: ccs0
[279.949376] Dynamic subtest ccs0: SUCCESS (2.029s)
[279.951905] Subtest clean: SUCCESS (6.130s)
[280.235877] [065/133] (740s left) api_intel_allocator (simple-allocator)
[280.296454] Starting subtest: simple-allocator
[280.298428] Starting dynamic subtest: basic
[280.303487] Dynamic subtest basic: SUCCESS (0.007s)
[280.315299] Starting dynamic subtest: parallel-one
[280.493256] Dynamic subtest parallel-one: SUCCESS (0.190s)
[280.504568] Starting dynamic subtest: print
[280.506659] Dynamic subtest print: SUCCESS (0.000s)
[280.515223] Starting dynamic subtest: reuse
[280.517584] Dynamic subtest reuse: SUCCESS (0.000s)
[280.525907] Starting dynamic subtest: reserve
[280.528082] Dynamic subtest reserve: SUCCESS (0.000s)
[280.537180] Starting dynamic subtest: fork-reopen-allocator
[280.539327] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[280.541462] Subtest simple-allocator: SUCCESS (0.214s)
[280.678565] [066/133] (740s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[280.781542] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[281.847880] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.067s)
[282.026760] [067/133] (738s left) gem_exec_balancer (bonded-sync)
[282.092191] Starting subtest: bonded-sync
[282.095865] Subtest bonded-sync: SKIP (0.000s)
[282.420269] [068/133] (738s left) kms_content_protection (lic-type-0)
[282.574701] Starting subtest: lic-type-0
[282.579278] Subtest lic-type-0: SKIP (0.000s)
[282.738708] [069/133] (738s left) i915_drm_fdinfo (all-busy-idle-check-all)
[282.782153] Starting subtest: all-busy-idle-check-all
[282.786711] Subtest all-busy-idle-check-all: SKIP (0.004s)
[282.872330] [070/133] (738s left) kms_flip (2x-wf_vblank-ts-check)
[283.018841] Starting subtest: 2x-wf_vblank-ts-check
[283.028132] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[283.130349] [071/133] (737s left) kms_lease (lease-get)
[283.221411] Starting subtest: lease-get
[283.223650] Starting dynamic subtest: pipe-A-eDP-1
[283.225936] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[283.235093] Starting dynamic subtest: pipe-B-eDP-1
[283.236913] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[283.244839] Starting dynamic subtest: pipe-C-eDP-1
[283.246692] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[283.254905] Starting dynamic subtest: pipe-D-eDP-1
[283.256770] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[283.258634] Subtest lease-get: SUCCESS (0.009s)
[283.363646] [072/133] (737s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[283.469803] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[283.473417] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[283.597441] [073/133] (737s left) sw_sync (alloc_fence)
[283.633233] Starting subtest: alloc_fence
[283.634785] Subtest alloc_fence: SUCCESS (0.000s)
[283.704808] [074/133] (737s left) kms_force_connector_basic (force-edid)
[283.780654] Starting subtest: force-edid
[284.096061] Subtest force-edid: SUCCESS (0.316s)
[284.257275] [075/133] (736s left) kms_flip_scaled_crc (flip-32bpp-linear-to-32bpp-linear-reflect-x)
[284.350996] Starting subtest: flip-32bpp-linear-to-32bpp-linear-reflect-x
[284.352897] Starting dynamic subtest: pipe-A-default-mode
[285.472450] Dynamic subtest pipe-A-default-mode: SKIP (1.116s)
[285.476884] Subtest flip-32bpp-linear-to-32bpp-linear-reflect-x: SKIP (1.118s)
[285.667658] [076/133] (735s left) gem_ppgtt (blt-vs-render-ctx0)
[285.729550] Starting subtest: blt-vs-render-ctx0
[318.790582] Subtest blt-vs-render-ctx0: SUCCESS (33.054s)
[318.967199] [077/133] (702s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[319.105043] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[319.107331] Starting dynamic subtest: pipe-A-default-mode
[319.400791] Dynamic subtest pipe-A-default-mode: SKIP (0.295s)
[319.405538] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.296s)
[320.252464] [078/133] (701s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[320.323907] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[320.326382] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[320.458097] [079/133] (700s left) syncobj_timeline (wait-all-snapshot)
[320.522448] Starting subtest: wait-all-snapshot
[320.601780] Subtest wait-all-snapshot: SUCCESS (0.081s)
[320.702574] [080/133] (700s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[320.753347] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[320.859851] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[320.958209] [081/133] (700s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[321.067051] Starting subtest: fbc-psr-sprite-mmap-cpu
[321.068957] Starting dynamic subtest: eDP-1
[321.073074] Dynamic subtest eDP-1: SKIP (0.000s)
[321.077124] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[321.165305] [082/133] (700s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[321.264535] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[322.057677] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.794s)
[322.257397] [083/133] (699s left) kms_async_flips (invalid-async-flip-atomic)
[322.352271] Starting subtest: invalid-async-flip-atomic
[322.727076] Starting dynamic subtest: pipe-A-eDP-1
[323.529390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.804s)
[323.888929] Starting dynamic subtest: pipe-B-eDP-1
[324.730223] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.849s)
[325.084744] Starting dynamic subtest: pipe-C-eDP-1
[325.916329] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.840s)
[326.277086] Starting dynamic subtest: pipe-D-eDP-1
[327.110200] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.841s)
[327.112321] Subtest invalid-async-flip-atomic: SUCCESS (4.759s)
[328.356706] [084/133] (693s left) gem_exec_params (dr1-dirt)
[328.416836] Starting subtest: DR1-dirt
[328.418740] Subtest DR1-dirt: SUCCESS (0.000s)
[328.544822] [085/133] (693s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[328.659461] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[328.663602] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[328.799120] [086/133] (692s left) kms_cursor_legacy (forked-bo)
[328.918266] Starting subtest: forked-bo
[328.920384] Starting dynamic subtest: pipe-A
[334.374536] Dynamic subtest pipe-A: SUCCESS (5.454s)
[334.386166] Starting dynamic subtest: pipe-B
[339.840868] Dynamic subtest pipe-B: SUCCESS (5.463s)
[339.852308] Starting dynamic subtest: pipe-C
[345.306715] Dynamic subtest pipe-C: SUCCESS (5.464s)
[345.317703] Starting dynamic subtest: pipe-D
[350.797866] Dynamic subtest pipe-D: SUCCESS (5.489s)
[350.809455] Starting dynamic subtest: all-pipes
[356.295597] Dynamic subtest all-pipes: SUCCESS (5.494s)
[356.298071] Subtest forked-bo: SUCCESS (27.375s)
[356.466601] [087/133] (665s left) kms_vblank (wait-forked-hang)
[356.575261] Starting subtest: wait-forked-hang
[356.577572] Starting dynamic subtest: pipe-A-eDP-1
[382.688493] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.110s)
[382.703872] Starting dynamic subtest: pipe-D-eDP-1
[407.649852] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.961s)
[407.652357] Subtest wait-forked-hang: SUCCESS (51.076s)
[408.552704] [088/133] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[408.664476] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[408.668814] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[408.794394] [089/133] (612s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[408.853189] Subtest untiled-to-tiled: SKIP (0.000s)
[408.923530] [090/133] (612s left) kms_frontbuffer_tracking (fbc-argb161616f-draw-mmap-gtt)
[409.022403] Starting subtest: fbc-argb161616f-draw-mmap-gtt
[409.026750] Subtest fbc-argb161616f-draw-mmap-gtt: SKIP (0.000s)
[409.161853] [091/133] (612s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[409.271104] Starting subtest: psr-rgb101010-draw-render
[416.604306] Subtest psr-rgb101010-draw-render: SUCCESS (7.335s)
[416.763147] [092/133] (605s left) fbdev (info)
[416.796451] Starting subtest: info
[416.798791] Subtest info: SUCCESS (0.000s)
[416.883635] [093/133] (605s left) kms_flip (plain-flip-interruptible)
[416.986591] Starting subtest: plain-flip-interruptible
[416.989105] Starting dynamic subtest: A-eDP1
[418.603090] Dynamic subtest A-eDP1: SUCCESS (1.616s)
[418.622524] Starting dynamic subtest: B-eDP1
[420.301187] Dynamic subtest B-eDP1: SUCCESS (1.695s)
[420.312087] Starting dynamic subtest: C-eDP1
[421.991641] Dynamic subtest C-eDP1: SUCCESS (1.689s)
[422.002981] Starting dynamic subtest: D-eDP1
[423.596755] Dynamic subtest D-eDP1: SUCCESS (1.604s)
[423.602182] Subtest plain-flip-interruptible: SUCCESS (6.616s)
[424.842344] [094/133] (597s left) gem_tiled_wc
[424.992599] [095/133] (597s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[430.008632] Starting subtest: pr-primary-plane-update-sf-dmg-area
[430.013163] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[430.846307] [096/133] (591s left) kms_flip (2x-flip-vs-wf_vblank)
[430.948194] Starting subtest: 2x-flip-vs-wf_vblank
[430.957014] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[431.090362] [097/133] (591s left) kms_async_flips (async-flip-suspend-resume)
[431.183179] Starting subtest: async-flip-suspend-resume
[431.567314] Starting dynamic subtest: pipe-A-eDP-1
[449.802657] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.087s)
[450.183403] Starting dynamic subtest: pipe-B-eDP-1
[467.771670] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.937s)
[468.192962] Starting dynamic subtest: pipe-C-eDP-1
[485.799412] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.947s)
[486.165534] Starting dynamic subtest: pipe-D-eDP-1
[503.769899] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.927s)
[503.773584] Subtest async-flip-suspend-resume: SUCCESS (13.438s)
[504.956035] [098/133] (517s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[505.066396] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[505.070368] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[505.212852] [099/133] (516s left) gem_exec_whisper (basic-contexts-priority)
[505.288331] Starting subtest: basic-contexts-priority
[529.909233] Subtest basic-contexts-priority: SUCCESS (24.924s)
[530.115394] [100/133] (492s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[530.236941] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[530.241296] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[530.389176] [101/133] (491s left) gem_exec_schedule (noreorder)
[530.561248] Starting subtest: noreorder
[530.563131] Starting dynamic subtest: rcs0
[530.646228] Dynamic subtest rcs0: SUCCESS (0.087s)
[530.659937] Starting dynamic subtest: vcs0
[532.429456] Dynamic subtest vcs0: SUCCESS (1.783s)
[532.442522] Starting dynamic subtest: vcs1
[534.429134] Dynamic subtest vcs1: SUCCESS (2.000s)
[534.441001] Starting dynamic subtest: vecs0
[536.416223] Dynamic subtest vecs0: SUCCESS (1.984s)
[536.428314] Starting dynamic subtest: ccs0
[536.518110] Dynamic subtest ccs0: SUCCESS (0.100s)
[536.521037] Subtest noreorder: SUCCESS (5.966s)
[536.730498] [102/133] (485s left) kms_addfb_basic (tile-pitch-mismatch)
[536.783336] Starting subtest: tile-pitch-mismatch
[536.788136] Subtest tile-pitch-mismatch: SKIP (0.000s)
[536.962103] [103/133] (485s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[537.062045] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[537.066299] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[537.197220] [104/133] (485s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[537.305616] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[537.309661] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[537.435749] [105/133] (485s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[537.494578] Starting subtest: saturated-hostile-nopreempt
[537.496835] Starting dynamic subtest: rcs0
[537.611373] Dynamic subtest rcs0: SKIP (0.114s)
[537.624718] Starting dynamic subtest: bcs0
[537.640354] Dynamic subtest bcs0: SKIP (0.026s)
[537.651966] Starting dynamic subtest: vcs0
[537.659953] Dynamic subtest vcs0: SKIP (0.020s)
[537.670171] Starting dynamic subtest: vcs1
[537.685062] Dynamic subtest vcs1: SKIP (0.024s)
[537.695804] Starting dynamic subtest: vecs0
[537.699405] Dynamic subtest vecs0: SKIP (0.010s)
[537.709359] Starting dynamic subtest: ccs0
[537.713172] Dynamic subtest ccs0: SKIP (0.014s)
[537.716913] Subtest saturated-hostile-nopreempt: SKIP (0.216s)
[537.807248] [106/133] (484s left) kms_hdmi_inject (inject-4k)
[538.139681] Starting subtest: inject-4k
[538.454740] Subtest inject-4k: SUCCESS (0.315s)
[539.057450] [107/133] (483s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[539.156141] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[539.160515] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[539.291387] [108/133] (483s left) syncobj_basic (illegal-fd-to-handle)
[539.351237] Starting subtest: illegal-fd-to-handle
[539.353592] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[539.486912] [109/133] (483s left) gem_exec_reloc (basic-active)
[539.536689] Subtest basic-active: SKIP (0.000s)
[539.623142] [110/133] (483s left) kms_color (invalid-ctm-matrix-sizes)
[539.710395] Starting subtest: invalid-ctm-matrix-sizes
[539.712645] Starting dynamic subtest: pipe-A
[539.714932] Dynamic subtest pipe-A: SUCCESS (0.002s)
[539.725749] Starting dynamic subtest: pipe-B
[539.727662] Dynamic subtest pipe-B: SUCCESS (0.003s)
[539.738203] Starting dynamic subtest: pipe-C
[539.740464] Dynamic subtest pipe-C: SUCCESS (0.004s)
[539.750845] Starting dynamic subtest: pipe-D
[539.752805] Dynamic subtest pipe-D: SUCCESS (0.004s)
[539.754713] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[539.824452] [111/133] (482s left) gem_mmap_gtt (cpuset-big-copy-odd)
[539.889527] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[539.967699] [112/133] (482s left) kms_vblank (query-forked-hang)
[540.062086] Starting subtest: query-forked-hang
[540.063981] Starting dynamic subtest: pipe-A-eDP-1
[566.240900] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.171s)
[566.257454] Starting dynamic subtest: pipe-D-eDP-1
[581.208973] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.968s)
[581.210973] Subtest query-forked-hang: SUCCESS (41.144s)
[582.028147] [113/133] (440s left) gem_softpin (reverse)
[582.103023] Starting subtest: reverse
[582.109034] Subtest reverse: SUCCESS (0.005s)
[582.262722] [114/133] (440s left) i915_pm_rps (engine-order)
[582.331099] Starting subtest: engine-order
[587.265564] Subtest engine-order: SUCCESS (4.933s)
[587.417506] [115/133] (435s left) gem_mmap_gtt (basic-read-write)
[587.483438] Subtest basic-read-write: SKIP (0.000s)
[587.546239] [116/133] (435s left) gem_ppgtt (shrink-vs-evict-any)
[587.595035] Starting subtest: shrink-vs-evict-any
[595.353546] Subtest shrink-vs-evict-any: SUCCESS (7.759s)
[595.471637] [117/133] (427s left) gem_exec_fence (submit3)
[595.656722] Starting subtest: submit3
[595.661716] Subtest submit3: SKIP (0.000s)
[597.611563] [118/133] (425s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[597.772046] Starting subtest: cursor-rapid-movement-32x10
[597.822027] Subtest cursor-rapid-movement-32x10: SKIP (0.044s)
[598.118383] [119/133] (424s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[598.224462] Starting subtest: bad-rotation-90-y-tiled-ccs
[598.226664] Starting dynamic subtest: pipe-A-eDP-1
[598.249102] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[598.262153] Starting dynamic subtest: pipe-B-eDP-1
[598.283413] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[598.293908] Starting dynamic subtest: pipe-C-eDP-1
[598.314797] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[598.324904] Starting dynamic subtest: pipe-D-eDP-1
[598.346859] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[598.350923] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[600.508537] [120/133] (422s left) gem_exec_whisper (basic-queues-priority-all)
[600.573722] Starting subtest: basic-queues-priority-all
[620.804777] Subtest basic-queues-priority-all: SUCCESS (20.216s)
[621.014060] [121/133] (402s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[621.108820] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[621.112955] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[621.245017] [122/133] (401s left) syncobj_eventfd (timeline-wait-signaled)
[621.300783] Starting subtest: timeline-wait-signaled
[621.303139] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[621.440452] [123/133] (401s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[621.540284] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[628.983952] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.444s)
[629.134103] [124/133] (394s left) gem_exec_params (invalid-ring2)
[629.196712] Starting subtest: invalid-ring2
[629.199046] Subtest invalid-ring2: SUCCESS (0.000s)
[629.336914] [125/133] (393s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[629.442530] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[629.446548] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[629.565341] [126/133] (393s left) kms_feature_discovery (chamelium)
[629.672343] Starting subtest: chamelium
[629.676848] Subtest chamelium: SKIP (0.000s)
[629.769969] [127/133] (393s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[629.876787] Starting subtest: primary-y-tiled-reflect-x-90
[629.881236] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[629.970592] [128/133] (393s left) i915_pm_freq_api (freq-reset)
[630.038734] Starting subtest: freq-reset
[630.040610] Starting dynamic subtest: gt0
[630.233894] Dynamic subtest gt0: SUCCESS (0.193s)
[630.245512] Starting dynamic subtest: gt1
[630.410304] Dynamic subtest gt1: SUCCESS (0.172s)
[630.412992] Subtest freq-reset: SUCCESS (0.366s)
[630.509086] [129/133] (392s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[630.619009] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[630.623393] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[630.754308] [130/133] (392s left) kms_chamelium_edid (dp-edid-read)
[631.126396] Subtest dp-edid-read: SKIP (0.000s)
[631.984488] [131/133] (391s left) kms_universal_plane (cursor-fb-leak)
[632.076528] Starting subtest: cursor-fb-leak
[632.078415] Starting dynamic subtest: pipe-A-eDP-1
[632.407064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.332s)
[632.421741] Starting dynamic subtest: pipe-B-eDP-1
[633.748314] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.340s)
[633.760031] Starting dynamic subtest: pipe-C-eDP-1
[635.057395] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.307s)
[635.071252] Starting dynamic subtest: pipe-D-eDP-1
[636.357345] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s)
[636.359738] Subtest cursor-fb-leak: SUCCESS (4.283s)
[637.616751] [132/133] (386s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[637.723921] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[637.728021] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[637.850473] [133/133] (385s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[637.954476] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[637.958876] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[638.066681] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gen7_exec_parse
results: parsing output: 6/ for test: kms_cursor_edge_walk
results: parsing output: 7/ for test: api_intel_bb
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_chamelium_color
results: parsing output: 11/ for test: drm_mm
results: parsing output: 12/ for test: i915_query
results: parsing output: 13/ for test: kms_hdr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: gem_ccs
results: parsing output: 18/ for test: gem_exec_alignment
results: parsing output: 19/ for test: kms_flip_scaled_crc
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: gem_exec_flush
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: gem_ctx_shared
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: prime_vgem
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_getfb
results: parsing output: 43/ for test: gen3_render_mixed_blits
results: parsing output: 44/ for test: kms_chamelium_hpd
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_pipe_stress
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_fenced_exec_thrash
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_content_protection
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_force_connector_basic
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: gem_ppgtt
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_async_flips
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_set_tiling_vs_blt
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: fbdev
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: gem_tiled_wc
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_async_flips
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_hdmi_inject
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_basic
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_color
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: i915_pm_rps
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: gem_ppgtt
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_eventfd
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_params
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_feature_discovery
results: parsing output: 126/ for test: kms_rotation_crc
results: parsing output: 127/ for test: i915_pm_freq_api
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_chamelium_edid
results: parsing output: 130/ for test: kms_universal_plane
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.