[56.395220] Initializing watchdogs
[56.395260]   /dev/watchdog0
[56.409436] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[56.413638] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.415533] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.418791] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[56.567682] Starting subtest: dp-mst-lic-type-0-hdcp14
[56.572206] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[56.703548] [002/133] (960s left) core_getversion (all-cards)
[56.739962] Starting subtest: all-cards
[56.744402] Subtest all-cards: SUCCESS (0.008s)
[56.776867] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms)
[56.854571] Starting subtest: legacy-dpms
[56.856903] Starting dynamic subtest: pipe-A-eDP-1
[64.319734] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.499s)
[64.322067] Subtest legacy-dpms: SUCCESS (7.500s)
[65.132627] [004/133] (951s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[65.212544] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[65.225960] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[65.293306] [005/133] (951s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[65.368595] Starting subtest: plane-primary-toggle-with-vblank-wait
[65.370911] Starting dynamic subtest: pipe-A-eDP-1
[65.541455] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[65.855958] Starting dynamic subtest: pipe-B-eDP-1
[66.714334] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.869s)
[67.015362] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.651s)
[67.949050] [006/133] (949s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[68.053616] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[68.057844] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[68.180193] [007/133] (948s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[68.269450] Starting subtest: fbc-psr2-primary-mmap-cpu
[68.271435] Starting dynamic subtest: eDP-1
[68.275592] Dynamic subtest eDP-1: SKIP (0.000s)
[68.279763] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[68.351317] [008/133] (948s left) perf (invalid-oa-exponent)
[68.474413] Starting subtest: invalid-oa-exponent
[68.489387] Subtest invalid-oa-exponent: SUCCESS (0.015s)
[68.534163] [009/133] (948s left) gem_eio (create-ext)
[68.678179] Starting subtest: create-ext
[68.849030] Subtest create-ext: SUCCESS (0.170s)
[68.989405] [010/133] (948s left) kms_color (invalid-degamma-lut-sizes)
[69.070405] Starting subtest: invalid-degamma-lut-sizes
[69.072481] Starting dynamic subtest: pipe-A
[69.356875] Dynamic subtest pipe-A: SUCCESS (0.286s)
[69.365996] Starting dynamic subtest: pipe-B
[69.368603] Dynamic subtest pipe-B: SUCCESS (0.000s)
[69.376035] Starting dynamic subtest: pipe-C
[69.378565] Dynamic subtest pipe-C: SUCCESS (0.000s)
[69.385928] Starting dynamic subtest: pipe-D
[69.388416] Dynamic subtest pipe-D: SUCCESS (0.000s)
[69.390859] Subtest invalid-degamma-lut-sizes: SUCCESS (0.288s)
[70.161676] [011/133] (947s left) gem_softpin (allocator-basic)
[70.228948] Starting subtest: allocator-basic
[70.295874] Subtest allocator-basic: SUCCESS (0.067s)
[70.449790] [012/133] (946s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[70.537183] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[70.539494] Starting dynamic subtest: pipe-A-eDP-1
[76.433566] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.906s)
[76.442775] Starting dynamic subtest: pipe-B-eDP-1
[83.089588] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.655s)
[83.092061] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.563s)
[83.965881] [013/133] (933s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[84.052520] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[84.057092] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[84.165043] [014/133] (933s left) kms_psr (pr-primary-render)
[84.246108] Starting subtest: pr-primary-render
[84.250605] Subtest pr-primary-render: SKIP (0.000s)
[84.358887] [015/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[84.432181] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[84.436487] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[84.557844] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[84.633838] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[84.637841] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[84.760859] [017/133] (932s left) gem_ccs (ctrl-surf-copy)
[84.833523] Starting subtest: ctrl-surf-copy
[84.838576] Subtest ctrl-surf-copy: SKIP (0.000s)
[84.964305] [018/133] (932s left) perf (invalid-oa-metric-set-id)
[85.071486] Starting subtest: invalid-oa-metric-set-id
[85.081339] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[85.121660] [019/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[85.201256] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[85.205068] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[85.324847] [020/133] (932s left) gem_pxp (create-regular-buffer)
[85.452599] Starting subtest: create-regular-buffer
[85.455070] Subtest create-regular-buffer: SUCCESS (0.000s)
[85.563596] [021/133] (932s left) gem_eio (in-flight-contexts-10ms)
[85.758111] Starting subtest: in-flight-contexts-10ms
[99.879194] Subtest in-flight-contexts-10ms: SUCCESS (14.117s)
[100.069215] [022/133] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[100.166146] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[106.887332] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.724s)
[107.064012] [023/133] (910s left) gem_exec_schedule (u-fairslice-all)
[107.145050] Starting subtest: u-fairslice-all
[109.201219] Subtest u-fairslice-all: SUCCESS (2.063s)
[109.513239] [024/133] (908s left) core_getstats (basic)
[109.569081] Starting subtest: basic
[109.571397] Subtest basic: SUCCESS (0.000s)
[109.675771] [025/133] (908s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[109.753789] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[109.756108] Starting dynamic subtest: pipe-A-eDP-1
[110.622853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.862s)
[110.631603] Starting dynamic subtest: pipe-B-eDP-1
[112.162264] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.536s)
[112.170888] Starting dynamic subtest: pipe-C-eDP-1
[113.637596] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.474s)
[113.647016] Starting dynamic subtest: pipe-D-eDP-1
[115.174552] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.537s)
[115.176369] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.413s)
[116.332201] [026/133] (901s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[116.401972] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[116.404411] Starting dynamic subtest: pipe-A-eDP-1
[116.427962] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[116.438672] Starting dynamic subtest: pipe-B-eDP-1
[116.459700] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[116.467645] Starting dynamic subtest: pipe-C-eDP-1
[116.488311] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[116.495968] Starting dynamic subtest: pipe-D-eDP-1
[116.518711] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[116.523231] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[118.616953] [027/133] (899s left) sw_sync (alloc_fence)
[118.657971] Starting subtest: alloc_fence
[118.660310] Subtest alloc_fence: SUCCESS (0.000s)
[118.719189] [028/133] (899s left) i915_pm_rps (basic-api)
[118.786559] Starting subtest: basic-api
[118.791302] Subtest basic-api: SKIP (0.001s)
[118.914231] [029/133] (899s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[119.013996] Starting subtest: cursorB-vs-flipA-toggle
[119.018570] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[119.169844] [030/133] (898s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[119.353026] Starting subtest: cursor-rapid-movement-128x42
[119.396198] Subtest cursor-rapid-movement-128x42: SKIP (0.038s)
[119.628852] [031/133] (898s left) kms_dp_link_training (non-uhbr-sst)
[119.713068] Starting subtest: non-uhbr-sst
[119.719859] Subtest non-uhbr-sst: SKIP (0.000s)
[119.810367] [032/133] (898s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[119.894831] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[119.898197] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[120.018435] [033/133] (898s left) gem_exec_parallel (engines)
[120.076613] Starting subtest: engines
[120.078593] Starting dynamic subtest: basic
[121.819305] Dynamic subtest basic: SUCCESS (1.740s)
[121.829612] Starting dynamic subtest: contexts
[126.275021] Dynamic subtest contexts: SUCCESS (4.454s)
[126.286044] Starting dynamic subtest: fds
[130.219523] Dynamic subtest fds: SUCCESS (3.943s)
[130.229883] Starting dynamic subtest: userptr
[131.866067] Dynamic subtest userptr: SUCCESS (1.645s)
[131.868995] Subtest engines: SUCCESS (11.787s)
[132.080684] [034/133] (886s left) gem_eio (in-flight-immediate)
[132.341947] Starting subtest: in-flight-immediate
[140.982172] Subtest in-flight-immediate: SUCCESS (8.641s)
[141.169634] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[141.173213] [035/133] (877s left) prime_mmap (test_forked)
[141.245381] Starting subtest: test_forked
[141.247624] Starting dynamic subtest: test_forked-smem
[141.311080] Dynamic subtest test_forked-smem: SUCCESS (0.064s)
[141.314231] Subtest test_forked: SUCCESS (0.065s)
[141.427210] [036/133] (876s left) kms_dsc (dsc-with-formats)
[141.506256] Starting subtest: dsc-with-formats
[141.546432] Subtest dsc-with-formats: SKIP (0.001s)
[141.583102] [037/133] (876s left) prime_busy (hang)
[141.642778] Starting subtest: hang
[141.645136] Starting dynamic subtest: rcs0
[167.352973] Dynamic subtest rcs0: SUCCESS (25.706s)
[167.366182] Starting dynamic subtest: bcs0
[174.507957] Dynamic subtest bcs0: SUCCESS (7.154s)
[174.515835] Starting dynamic subtest: vcs0
[181.480597] Dynamic subtest vcs0: SUCCESS (6.975s)
[181.488632] Starting dynamic subtest: vcs1
[188.532513] Dynamic subtest vcs1: SUCCESS (7.047s)
[188.540387] Starting dynamic subtest: vecs0
[195.495677] Dynamic subtest vecs0: SUCCESS (6.966s)
[195.503823] Starting dynamic subtest: ccs0
[209.398820] Dynamic subtest ccs0: SUCCESS (13.900s)
[209.401150] Subtest hang: SUCCESS (67.752s)
[209.538373] [038/133] (808s left) kms_vblank (wait-idle)
[209.627183] Starting subtest: wait-idle
[209.629323] Starting dynamic subtest: pipe-A-eDP-1
[211.382273] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.756s)
[211.395837] Starting dynamic subtest: pipe-D-eDP-1
[213.850987] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.466s)
[213.853398] Subtest wait-idle: SUCCESS (4.225s)
[214.688662] [039/133] (803s left) kms_pm_rpm (package-g7)
[216.197660] Starting subtest: package-g7
[216.202647] Subtest package-g7: SKIP (0.000s)
[216.911231] [040/133] (801s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[217.016483] Starting subtest: flip-vs-cursor-varying-size
[225.376192] Subtest flip-vs-cursor-varying-size: SUCCESS (8.358s)
[226.229996] [041/133] (792s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[226.321660] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[233.627229] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.309s)
[233.785587] [042/133] (784s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[233.851501] Starting subtest: single-wait-all-for-submit-signaled
[233.853935] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[233.962806] [043/133] (784s left) perf (gen12-group-exclusive-stream-ctx-handle)
[234.047032] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[234.071267] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[234.115137] [044/133] (784s left) gem_wait (busy)
[235.844070] Starting subtest: busy
[235.846590] Starting dynamic subtest: all-engines
[237.849421] Dynamic subtest all-engines: SUCCESS (2.003s)
[237.861071] Starting dynamic subtest: rcs0
[238.391827] Dynamic subtest rcs0: SUCCESS (0.542s)
[238.402601] Starting dynamic subtest: bcs0
[238.933258] Dynamic subtest bcs0: SUCCESS (0.540s)
[238.943529] Starting dynamic subtest: vcs0
[240.857372] Dynamic subtest vcs0: SUCCESS (1.922s)
[240.868694] Starting dynamic subtest: vcs1
[242.842100] Dynamic subtest vcs1: SUCCESS (1.983s)
[242.853806] Starting dynamic subtest: vecs0
[244.825456] Dynamic subtest vecs0: SUCCESS (1.981s)
[244.836748] Starting dynamic subtest: ccs0
[245.366448] Dynamic subtest ccs0: SUCCESS (0.540s)
[245.368900] Subtest busy: SUCCESS (9.523s)
[245.575929] [045/133] (773s left) gen9_exec_parse (bb-secure)
[245.634407] Subtest bb-secure: SKIP (0.000s)
[245.709868] [046/133] (772s left) kms_cursor_edge_walk (128x128-right-edge)
[245.803284] Starting subtest: 128x128-right-edge
[245.806067] Starting dynamic subtest: pipe-A-eDP-1
[249.299067] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[249.308364] Starting dynamic subtest: pipe-D-eDP-1
[252.426195] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[252.428588] Subtest 128x128-right-edge: SUCCESS (6.622s)
[253.252866] [047/133] (765s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[253.336394] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[253.340724] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.461883] [048/133] (765s left) prime_mmap (test_forked_cpu_write)
[253.515090] Starting subtest: test_forked_cpu_write
[253.517320] Starting dynamic subtest: test_forked_cpu_write-smem
[253.519137] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.006s)
[253.521409] Subtest test_forked_cpu_write: SUCCESS (0.006s)
[253.643184] [049/133] (765s left) kms_addfb_basic (small-bo)
[253.719169] Starting subtest: small-bo
[253.721457] Subtest small-bo: SUCCESS (0.000s)
[253.846220] [050/133] (764s left) kms_chamelium_audio (dp-audio)
[254.203445] Subtest dp-audio: SKIP (0.000s)
[255.045760] [051/133] (763s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[255.418819] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[256.185398] [052/133] (762s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[256.270740] Starting subtest: psr-shrfb-scaledprimary
[262.051922] Subtest psr-shrfb-scaledprimary: SUCCESS (5.782s)
[262.218636] [053/133] (756s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[262.297464] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[262.301999] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[262.419883] [054/133] (756s left) perf (i915-ref-count)
[262.488067] Starting subtest: i915-ref-count
[262.517964] Subtest i915-ref-count: SUCCESS (0.026s)
[262.578775] [055/133] (756s left) kms_joiner (invalid-modeset-force-big-joiner)
[262.654564] Starting subtest: invalid-modeset-force-big-joiner
[262.658782] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[262.768773] [056/133] (756s left) kms_cursor_crc (cursor-alpha-opaque)
[262.845228] Starting subtest: cursor-alpha-opaque
[262.847475] Starting dynamic subtest: pipe-A-eDP-1
[263.487386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s)
[263.501709] Starting dynamic subtest: pipe-D-eDP-1
[264.804674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s)
[264.806663] Subtest cursor-alpha-opaque: SUCCESS (1.959s)
[265.617391] [057/133] (753s left) kms_legacy_colorkey (basic)
[265.701997] Starting subtest: basic
[265.703959] Starting dynamic subtest: pipe-A
[265.745957] Dynamic subtest pipe-A: SUCCESS (0.045s)
[265.756684] Starting dynamic subtest: pipe-B
[265.759194] Dynamic subtest pipe-B: SUCCESS (0.001s)
[265.766984] Starting dynamic subtest: pipe-C
[265.769592] Dynamic subtest pipe-C: SUCCESS (0.000s)
[265.777226] Starting dynamic subtest: pipe-D
[265.779140] Dynamic subtest pipe-D: SUCCESS (0.000s)
[265.781038] Subtest basic: SUCCESS (0.051s)
[265.836419] [058/133] (753s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[265.918348] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[265.922782] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[266.024555] [059/133] (753s left) kms_addfb_basic (bad-pitch-32)
[266.088753] Starting subtest: bad-pitch-32
[266.091180] Subtest bad-pitch-32: SUCCESS (0.000s)
[266.228776] [060/133] (753s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[266.294629] Starting subtest: x-tiled-to-vebox-y-tiled
[266.299107] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[266.489705] [061/133] (752s left) gem_exec_reloc (basic-range)
[266.546531] Subtest basic-range: SKIP (0.000s)
[266.611646] [062/133] (752s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[266.699119] Starting subtest: yf-tiled-64bpp-rotate-0
[266.703652] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[266.823479] [063/133] (752s left) syncobj_wait (wait-all-for-submit-snapshot)
[266.887474] Starting subtest: wait-all-for-submit-snapshot
[266.969814] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[267.049773] [064/133] (752s left) kms_async_flips (invalid-async-flip)
[267.134473] Starting subtest: invalid-async-flip
[267.508854] Starting dynamic subtest: pipe-A-eDP-1
[268.334049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s)
[268.692469] Starting dynamic subtest: pipe-B-eDP-1
[269.479092] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.794s)
[269.835277] Starting dynamic subtest: pipe-C-eDP-1
[270.591655] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[270.946080] Starting dynamic subtest: pipe-D-eDP-1
[271.719056] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[271.721315] Subtest invalid-async-flip: SUCCESS (4.585s)
[272.883485] [065/133] (746s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[272.967332] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[272.969652] Starting dynamic subtest: A-eDP1
[276.503687] Dynamic subtest A-eDP1: SUCCESS (3.534s)
[276.514829] Starting dynamic subtest: B-eDP1
[279.705447] Dynamic subtest B-eDP1: SUCCESS (3.200s)
[279.714396] Starting dynamic subtest: C-eDP1
[282.808458] Dynamic subtest C-eDP1: SUCCESS (3.100s)
[282.817617] Starting dynamic subtest: D-eDP1
[285.999756] Dynamic subtest D-eDP1: SUCCESS (3.189s)
[286.001697] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.031s)
[286.821772] [066/133] (732s left) kms_frontbuffer_tracking (fbc-suspend)
[286.915916] Starting subtest: fbc-suspend
[325.407279] Subtest fbc-suspend: SUCCESS (7.858s)
[326.603028] [067/133] (692s left) syncobj_timeline (invalid-transfer-bad-pad)
[326.660380] Starting subtest: invalid-transfer-bad-pad
[326.662741] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[326.768181] [068/133] (692s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[326.846454] Starting subtest: 4-tiled-64bpp-rotate-90
[326.869433] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[327.016044] [069/133] (692s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[327.074563] Starting subtest: saturated-hostile-nopreempt
[327.076856] Starting dynamic subtest: rcs0
[327.166353] Dynamic subtest rcs0: SKIP (0.091s)
[327.178721] Starting dynamic subtest: bcs0
[327.190658] Dynamic subtest bcs0: SKIP (0.022s)
[327.200526] Starting dynamic subtest: vcs0
[327.213243] Dynamic subtest vcs0: SKIP (0.021s)
[327.221556] Starting dynamic subtest: vcs1
[327.237464] Dynamic subtest vcs1: SKIP (0.023s)
[327.245639] Starting dynamic subtest: vecs0
[327.262269] Dynamic subtest vecs0: SKIP (0.024s)
[327.270531] Starting dynamic subtest: ccs0
[327.283952] Dynamic subtest ccs0: SKIP (0.020s)
[327.288564] Subtest saturated-hostile-nopreempt: SKIP (0.211s)
[327.368372] [070/133] (692s left) gem_exec_big (single)
[327.432560] Starting subtest: single
[328.557697] Subtest single: SUCCESS (1.144s)
[328.746401] [071/133] (690s left) gem_exec_fence (submit67)
[328.966629] Starting subtest: submit67
[328.970916] Subtest submit67: SKIP (0.000s)
[330.731239] [072/133] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[330.822364] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[330.826335] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[330.923916] [073/133] (688s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[331.010044] Starting subtest: fbc-rgb101010-draw-mmap-wc
[335.563214] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.592s)
[336.676506] [074/133] (683s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[336.773308] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[336.777381] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[336.879308] [075/133] (682s left) i915_drm_fdinfo (busy-idle)
[336.922539] Starting subtest: busy-idle
[336.924657] Starting dynamic subtest: rcs0
[336.964824] Dynamic subtest rcs0: SKIP (0.041s)
[336.976592] Starting dynamic subtest: bcs0
[336.980596] Dynamic subtest bcs0: SKIP (0.001s)
[336.990431] Starting dynamic subtest: vcs0
[336.994594] Dynamic subtest vcs0: SKIP (0.000s)
[337.003914] Starting dynamic subtest: vcs1
[337.008148] Dynamic subtest vcs1: SKIP (0.000s)
[337.019502] Starting dynamic subtest: vecs0
[337.023495] Dynamic subtest vecs0: SKIP (0.000s)
[337.032131] Starting dynamic subtest: ccs0
[337.036027] Dynamic subtest ccs0: SKIP (0.000s)
[337.039873] Subtest busy-idle: SKIP (0.048s)
[337.075491] [076/133] (682s left) kms_psr (psr2-primary-page-flip)
[337.161034] Starting subtest: psr2-primary-page-flip
[337.163203] Starting dynamic subtest: eDP-1
[338.935238] Dynamic subtest eDP-1: SUCCESS (1.782s)
[338.937387] Subtest psr2-primary-page-flip: SUCCESS (1.783s)
[339.814859] [077/133] (680s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[339.922547] Starting subtest: cursorA-vs-flipB-atomic
[339.927038] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[340.077090] [078/133] (679s left) kms_prop_blob (blob-prop-lifetime)
[340.141813] Starting subtest: blob-prop-lifetime
[340.144160] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[340.267925] [079/133] (679s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[340.343761] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[340.346085] Starting dynamic subtest: pipe-A
[340.465160] Dynamic subtest pipe-A: SKIP (0.117s)
[340.475946] Starting dynamic subtest: pipe-B
[341.646956] Dynamic subtest pipe-B: SKIP (1.184s)
[341.657548] Starting dynamic subtest: pipe-C
[342.771960] Dynamic subtest pipe-C: SUCCESS (1.133s)
[342.782061] Starting dynamic subtest: pipe-D
[343.918865] Dynamic subtest pipe-D: SUCCESS (1.149s)
[343.921206] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.587s)
[345.114184] [080/133] (674s left) kms_pipe_crc_basic (hang-read-crc)
[345.195873] Starting subtest: hang-read-crc
[345.198229] Starting dynamic subtest: pipe-A-eDP-1
[347.279957] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.087s)
[347.289633] Starting dynamic subtest: pipe-B-eDP-1
[349.961757] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.682s)
[349.972350] Starting dynamic subtest: pipe-C-eDP-1
[352.591140] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.631s)
[352.600716] Starting dynamic subtest: pipe-D-eDP-1
[355.267685] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.673s)
[355.269841] Subtest hang-read-crc: SUCCESS (10.081s)
[356.092856] [081/133] (663s left) kms_selftest (drm_format)
[356.147559] Starting subtest: drm_format
[356.158154] Starting dynamic subtest: drm_test_format_block_width_invalid
[356.261952] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.103s)
[356.270799] Starting dynamic subtest: drm_test_format_block_width_one_plane
[356.390051] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.125s)
[356.401232] Starting dynamic subtest: drm_test_format_block_width_two_plane
[356.512012] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.121s)
[356.522673] Starting dynamic subtest: drm_test_format_block_width_three_plane
[356.643874] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.132s)
[356.654574] Starting dynamic subtest: drm_test_format_block_width_tiled
[356.781920] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.137s)
[356.792624] Starting dynamic subtest: drm_test_format_block_height_invalid
[356.901937] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.119s)
[356.912798] Starting dynamic subtest: drm_test_format_block_height_one_plane
[357.017525] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.115s)
[357.027997] Starting dynamic subtest: drm_test_format_block_height_two_plane
[357.141861] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.122s)
[357.152845] Starting dynamic subtest: drm_test_format_block_height_three_plane
[357.276925] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.134s)
[357.287617] Starting dynamic subtest: drm_test_format_block_height_tiled
[357.390166] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.114s)
[357.400833] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[357.531312] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.139s)
[357.540378] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[357.694432] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.160s)
[357.704819] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[357.790039] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.097s)
[357.798810] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[357.919232] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.127s)
[357.928324] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[358.072042] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.150s)
[358.081876] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[358.212121] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.138s)
[358.223047] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[358.369424] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.157s)
[358.379474] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[358.496278] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.127s)
[358.498202] Subtest drm_format: SUCCESS (2.344s)
[358.691786] [082/133] (661s left) gem_close_race (multigpu-basic-process)
[358.766578] Starting subtest: multigpu-basic-process
[358.771148] Subtest multigpu-basic-process: SKIP (0.000s)
[359.026439] [083/133] (661s left) gem_set_tiling_vs_gtt
[359.144499] [084/133] (661s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[359.228354] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[359.230534] Starting dynamic subtest: pipe-A
[359.247805] Dynamic subtest pipe-A: SKIP (0.016s)
[359.258354] Starting dynamic subtest: pipe-B
[359.278616] Dynamic subtest pipe-B: SKIP (0.028s)
[359.288458] Starting dynamic subtest: pipe-C
[359.306646] Dynamic subtest pipe-C: SKIP (0.028s)
[359.316255] Starting dynamic subtest: pipe-D
[359.334034] Dynamic subtest pipe-D: SKIP (0.028s)
[359.338530] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.103s)
[359.474135] [085/133] (660s left) kms_addfb_basic (basic-y-tiled-legacy)
[359.530857] Starting subtest: basic-y-tiled-legacy
[359.535467] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[359.686271] [086/133] (660s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[359.767894] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[360.792523] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.024s)
[360.954343] [087/133] (659s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[361.020474] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[361.024274] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[361.218787] [088/133] (659s left) gem_caching (writes)
[361.285728] Subtest writes: SKIP (0.000s)
[361.370943] [089/133] (659s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[361.430367] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[361.539131] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[361.628942] [090/133] (658s left) kms_flip (wf_vblank-ts-check)
[361.716206] Starting subtest: wf_vblank-ts-check
[361.718123] Starting dynamic subtest: A-eDP1
[370.644548] Dynamic subtest A-eDP1: SUCCESS (8.926s)
[370.655878] Starting dynamic subtest: B-eDP1
[379.564028] Dynamic subtest B-eDP1: SUCCESS (8.917s)
[379.573849] Starting dynamic subtest: C-eDP1
[388.479832] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[388.489419] Starting dynamic subtest: D-eDP1
[397.415820] Dynamic subtest D-eDP1: SUCCESS (8.938s)
[397.420930] Subtest wf_vblank-ts-check: SUCCESS (35.704s)
[398.658752] [091/133] (621s left) gem_lmem_evict (dontneed-evict-race)
[398.718936] Subtest dontneed-evict-race: SKIP (0.000s)
[398.770348] [092/133] (621s left) gem_mmap_gtt (medium-copy-odd)
[398.834105] Subtest medium-copy-odd: SKIP (0.000s)
[398.897171] [093/133] (621s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[398.979264] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[398.992044] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[399.061997] [094/133] (621s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[399.133998] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[399.136177] Starting dynamic subtest: pipe-A-eDP-1
[399.191912] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[399.207522] Starting dynamic subtest: pipe-B-eDP-1
[399.264689] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[399.276723] Starting dynamic subtest: pipe-C-eDP-1
[399.337513] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[399.348568] Starting dynamic subtest: pipe-D-eDP-1
[399.404443] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[399.408602] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[401.332262] [095/133] (619s left) gem_exec_suspend (basic-s0)
[401.422291] Starting subtest: basic-S0
[401.424212] Starting dynamic subtest: smem
[421.926232] Dynamic subtest smem: SUCCESS (6.212s)
[421.928805] Subtest basic-S0: SUCCESS (6.214s)
[422.120001] [096/133] (598s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[422.206679] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[423.141881] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.957s)
[423.294103] [097/133] (597s left) gem_mmap_offset (bad-extensions)
[423.357831] Starting subtest: bad-extensions
[423.360085] Subtest bad-extensions: SUCCESS (0.000s)
[423.484057] [098/133] (597s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[423.591989] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[423.595555] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[423.746728] [099/133] (597s left) gem_mmap_gtt (cpuset-big-copy-odd)
[423.814054] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[423.883740] [100/133] (596s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[423.964862] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[423.968364] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[424.082562] [101/133] (596s left) kms_psr (fbc-psr2-sprite-render)
[424.152986] Starting subtest: fbc-psr2-sprite-render
[424.154946] Starting dynamic subtest: eDP-1
[424.158392] Dynamic subtest eDP-1: SKIP (0.000s)
[424.161862] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[424.241089] [102/133] (596s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[424.317648] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[424.320786] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[424.431774] [103/133] (596s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[424.499490] Starting subtest: crc-primary-basic-y-tiled-ccs
[424.501479] Starting dynamic subtest: pipe-A-eDP-1
[424.520192] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[424.531147] Starting dynamic subtest: pipe-B-eDP-1
[424.548573] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[424.557973] Starting dynamic subtest: pipe-C-eDP-1
[424.575630] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[424.584845] Starting dynamic subtest: pipe-D-eDP-1
[424.603386] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[424.606831] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[426.667585] [104/133] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[426.749285] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[426.753785] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[426.851188] [105/133] (594s left) api_intel_bb (add-remove-objects)
[426.909976] Starting subtest: add-remove-objects
[426.915653] Subtest add-remove-objects: SUCCESS (0.008s)
[427.067368] [106/133] (594s left) sysfs_heartbeat_interval (nopreempt)
[427.143669] Starting subtest: nopreempt
[427.145599] Starting dynamic subtest: vecs0
[436.905716] Dynamic subtest vecs0: SUCCESS (9.834s)
[436.919347] Starting dynamic subtest: ccs0
[440.939979] Dynamic subtest ccs0: SUCCESS (4.046s)
[440.952171] Starting dynamic subtest: vcs0
[450.940283] Dynamic subtest vcs0: SUCCESS (10.015s)
[450.953338] Starting dynamic subtest: bcs0
[454.998773] Dynamic subtest bcs0: SUCCESS (4.057s)
[455.010137] Starting dynamic subtest: rcs0
[459.050963] Dynamic subtest rcs0: SUCCESS (4.047s)
[459.063698] Starting dynamic subtest: vcs1
[468.920500] Dynamic subtest vcs1: SUCCESS (9.862s)
[468.923304] Subtest nopreempt: SUCCESS (41.873s)
[469.015380] [107/133] (552s left) kms_getfb (getfb2-into-addfb2)
[469.095895] Starting subtest: getfb2-into-addfb2
[469.098259] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[469.225289] [108/133] (551s left) gem_close (basic)
[469.297842] Starting subtest: basic
[469.300200] Subtest basic: SUCCESS (0.000s)
[469.435770] [109/133] (551s left) gem_exec_schedule (preemptive-hang)
[469.617791] Starting subtest: preemptive-hang
[469.620302] Starting dynamic subtest: rcs0
[479.121984] Dynamic subtest rcs0: SUCCESS (9.502s)
[479.132471] Starting dynamic subtest: bcs0
[488.081742] Dynamic subtest bcs0: SUCCESS (8.959s)
[488.103977] Starting dynamic subtest: vcs0
[497.049330] Dynamic subtest vcs0: SUCCESS (8.970s)
[497.059592] Starting dynamic subtest: vcs1
[506.061217] Dynamic subtest vcs1: SUCCESS (9.011s)
[506.070815] Starting dynamic subtest: vecs0
[515.068655] Dynamic subtest vecs0: SUCCESS (9.011s)
[515.080837] Starting dynamic subtest: ccs0
[524.051767] Dynamic subtest ccs0: SUCCESS (8.979s)
[524.054273] Subtest preemptive-hang: SUCCESS (54.439s)
[524.332000] [110/133] (496s left) i915_drm_fdinfo (virtual-busy-idle)
[524.396749] Starting subtest: virtual-busy-idle
[524.401417] Subtest virtual-busy-idle: SKIP (0.000s)
[524.482799] [111/133] (496s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[524.572815] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[528.553441] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.983s)
[529.758329] [112/133] (491s left) gem_linear_blits (interruptible)
[529.967823] Starting subtest: interruptible
[534.142360] Subtest interruptible: SUCCESS (4.173s)
[534.372144] [113/133] (487s left) gem_ctx_persistence (engines-mixed)
[534.484739] Starting subtest: engines-mixed
[534.487501] Starting dynamic subtest: rcs0
[534.624418] Dynamic subtest rcs0: SUCCESS (0.138s)
[534.637910] Starting dynamic subtest: bcs0
[534.725034] Dynamic subtest bcs0: SUCCESS (0.099s)
[534.737819] Starting dynamic subtest: vcs0
[534.812028] Dynamic subtest vcs0: SUCCESS (0.085s)
[534.824823] Starting dynamic subtest: vcs1
[534.908170] Dynamic subtest vcs1: SUCCESS (0.094s)
[534.920456] Starting dynamic subtest: vecs0
[534.973777] Dynamic subtest vecs0: SUCCESS (0.063s)
[534.984398] Starting dynamic subtest: ccs0
[535.059140] Dynamic subtest ccs0: SUCCESS (0.083s)
[535.061962] Subtest engines-mixed: SUCCESS (0.575s)
[535.152279] [114/133] (486s left) perf_pmu (init-wait)
[535.190502] Starting subtest: init-wait
[535.192417] Starting dynamic subtest: rcs0
[535.194205] Dynamic subtest rcs0: SUCCESS (0.002s)
[535.203373] Starting dynamic subtest: bcs0
[535.205087] Dynamic subtest bcs0: SUCCESS (0.000s)
[535.213755] Starting dynamic subtest: vcs0
[535.215479] Dynamic subtest vcs0: SUCCESS (0.001s)
[535.224113] Starting dynamic subtest: vcs1
[535.225856] Dynamic subtest vcs1: SUCCESS (0.001s)
[535.234365] Starting dynamic subtest: vecs0
[535.236043] Dynamic subtest vecs0: SUCCESS (0.000s)
[535.244596] Starting dynamic subtest: ccs0
[535.246096] Dynamic subtest ccs0: SUCCESS (0.000s)
[535.247627] Subtest init-wait: SUCCESS (0.008s)
[535.322340] [115/133] (486s left) gem_exec_reloc (basic-gtt-cpu-active)
[535.390122] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[535.480294] [116/133] (486s left) kms_pm_lpsp (screens-disabled)
[536.588177] Starting subtest: screens-disabled
[536.592233] Subtest screens-disabled: SKIP (0.000s)
[536.672722] [117/133] (484s left) kms_flip (flip-vs-expired-vblank-interruptible)
[536.758670] Starting subtest: flip-vs-expired-vblank-interruptible
[536.760976] Starting dynamic subtest: A-eDP1
[545.434856] Dynamic subtest A-eDP1: SUCCESS (8.674s)
[545.445982] Starting dynamic subtest: B-eDP1
[554.061958] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[554.074032] Starting dynamic subtest: C-eDP1
[562.690155] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[562.701559] Starting dynamic subtest: D-eDP1
[571.330589] Dynamic subtest D-eDP1: SUCCESS (8.640s)
[571.335640] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.579s)
[572.516232] [118/133] (449s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[572.602624] Starting subtest: psr-1p-primscrn-cur-indfb-move
[579.921331] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.322s)
[580.092350] [119/133] (441s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[580.195008] Starting subtest: plane-all-modeset-transition-internal-panels
[580.197228] Starting dynamic subtest: pipe-A-eDP-1
[581.556768] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.361s)
[581.839728] Starting dynamic subtest: pipe-B-eDP-1
[582.884372] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[583.148200] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.954s)
[583.999381] [120/133] (437s left) gem_userptr_blits (stress-mm)
[584.070286] Starting subtest: stress-mm
[589.436575] Subtest stress-mm: SUCCESS (5.369s)
[589.600448] [121/133] (432s left) syncobj_eventfd (invalid-bad-flags)
[589.658748] Starting subtest: invalid-bad-flags
[589.661013] Subtest invalid-bad-flags: SUCCESS (0.000s)
[589.800138] [122/133] (431s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[589.865885] Starting subtest: framebuffer-vs-set-tiling
[589.870305] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[589.997140] [123/133] (431s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[590.078186] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[590.082480] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[590.186515] [124/133] (431s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[590.252295] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[590.254518] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[590.374210] [125/133] (431s left) kms_flip (2x-modeset-vs-vblank-race)
[590.445972] Starting subtest: 2x-modeset-vs-vblank-race
[590.451827] Subtest 2x-modeset-vs-vblank-race: SKIP (0.008s)
[590.540053] [126/133] (431s left) i915_query (query-regions-garbage-items)
[590.598952] Starting subtest: query-regions-garbage-items
[590.600953] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[590.731163] [127/133] (431s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[590.802035] Starting subtest: flip-primary-invalidate-overlay
[602.464129] Subtest flip-primary-invalidate-overlay: SUCCESS (11.665s)
[602.648698] [128/133] (419s left) gem_exec_balancer (full-late)
[602.716854] Starting subtest: full-late
[607.730619] Subtest full-late: SUCCESS (5.014s)
[608.071487] [129/133] (413s left) gem_exec_reloc (basic-write-wc)
[608.137301] Subtest basic-write-wc: SKIP (0.000s)
[608.208731] [130/133] (413s left) kms_force_connector_basic (force-load-detect)
[608.275852] Subtest force-load-detect: SKIP (0.000s)
[608.347851] [131/133] (413s left) kms_chamelium_hpd (hdmi-hpd-fast)
[608.709234] Subtest hdmi-hpd-fast: SKIP (0.000s)
[609.485311] [132/133] (412s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[609.578903] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[609.581092] Starting dynamic subtest: pipe-A-default-mode
[612.346453] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[612.348442] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.768s)
[613.204190] [133/133] (408s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[613.300134] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[613.304441] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[613.417499] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: core_getversion
results: parsing output: 2/ for test: kms_atomic_interruptible
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_color
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_ccs
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: core_getstats
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: i915_pm_rps
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_dp_link_training
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_parallel
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: prime_busy
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_wait
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_chamelium_audio
results: parsing output: 50/ for test: kms_chamelium_edid
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_legacy_colorkey
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: gem_exec_big
results: parsing output: 70/ for test: gem_exec_fence
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: i915_drm_fdinfo
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_pipe_crc_basic
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: gem_close_race
results: parsing output: 82/ for test: gem_set_tiling_vs_gtt
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_caching
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_lmem_evict
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_suspend
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: sysfs_heartbeat_interval
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_close
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_linear_blits
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_pm_lpsp
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: kms_psr_stress_test
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_force_connector_basic
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.