[59.221153] Initializing watchdogs
[59.221202]   /dev/watchdog0
[59.236870] [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]
[59.241812] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.244124] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.246148] [001/133] (960s left) gem_softpin (evict-active-interruptible)
[59.306971] Starting subtest: evict-active-interruptible
[59.316984] Subtest evict-active-interruptible: SUCCESS (0.010s)
[59.396553] [002/133] (960s left) perf_pmu (busy-accuracy-2)
[59.430793] Starting subtest: busy-accuracy-2
[59.431816] Starting dynamic subtest: rcs0
[62.490840] Dynamic subtest rcs0: SUCCESS (3.054s)
[62.496651] Starting dynamic subtest: bcs0
[65.550037] Dynamic subtest bcs0: SUCCESS (3.058s)
[65.563237] Starting dynamic subtest: vcs0
[68.587861] Dynamic subtest vcs0: SUCCESS (3.042s)
[68.593762] Starting dynamic subtest: vcs1
[71.641373] Dynamic subtest vcs1: SUCCESS (3.047s)
[71.655442] Starting dynamic subtest: vecs0
[74.690346] Dynamic subtest vecs0: SUCCESS (3.049s)
[74.696603] Starting dynamic subtest: ccs0
[77.749400] Dynamic subtest ccs0: SUCCESS (3.058s)
[77.750510] Subtest busy-accuracy-2: SUCCESS (18.314s)
[77.874064] [003/133] (941s left) gem_sync (basic-all)
[77.934296] Starting subtest: basic-all
[82.848336] Subtest basic-all: SUCCESS (4.906s)
[83.020187] [004/133] (936s left) gem_exec_fence (invalid-timeline-fence-array)
[83.599882] Starting subtest: invalid-timeline-fence-array
[83.600724] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[84.956168] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[84.957780] [005/133] (934s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[85.003257] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[85.106623] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[85.192684] [006/133] (934s left) kms_hdr (bpc-switch-suspend)
[85.285905] Starting subtest: bpc-switch-suspend
[86.332398] Starting dynamic subtest: pipe-A-eDP-1
[106.396254] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.146s)
[106.397224] Subtest bpc-switch-suspend: SUCCESS (6.191s)
[114.529579] [007/133] (913s left) gem_eio (in-flight-1us)
[114.786179] Starting subtest: in-flight-1us
[123.916406] Subtest in-flight-1us: SUCCESS (9.135s)
[124.079937] [008/133] (903s left) gem_render_copy (linear-to-vebox-y-tiled)
[124.134975] Starting subtest: linear-to-vebox-y-tiled
[124.136812] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[124.324597] [009/133] (903s left) prime_vgem (basic-write)
[124.388614] Starting subtest: basic-write
[124.395121] Subtest basic-write: SKIP (0.006s)
[124.509208] [010/133] (903s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[124.594402] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[124.596147] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[124.684203] [011/133] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[124.774646] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[130.410775] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.637s)
[131.551369] [012/133] (896s left) gem_eio (reset-stress)
[131.802496] Starting subtest: reset-stress
[131.803465] Starting dynamic subtest: render
[136.987068] Dynamic subtest render: SUCCESS (5.183s)
[137.002145] Starting dynamic subtest: bsd1
[155.389853] Dynamic subtest bsd1: SUCCESS (18.404s)
[155.403089] Starting dynamic subtest: bsd2
[173.355147] Dynamic subtest bsd2: SUCCESS (17.967s)
[173.370487] Starting dynamic subtest: blt
[173.372276] Dynamic subtest blt: SKIP (0.000s)
[173.379439] Starting dynamic subtest: vebox
[191.339961] Dynamic subtest vebox: SUCCESS (17.985s)
[191.341304] Subtest reset-stress: SUCCESS (59.542s)
[192.835886] [013/133] (835s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[192.928255] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[192.929922] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[193.014218] [014/133] (835s left) kms_cursor_crc (cursor-size-hints)
[193.133444] Starting subtest: cursor-size-hints
[193.134391] Starting dynamic subtest: pipe-A-eDP-1
[193.741984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[193.756165] Starting dynamic subtest: pipe-D-eDP-1
[195.004853] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[195.005857] Subtest cursor-size-hints: SUCCESS (1.866s)
[195.808717] [015/133] (832s left) syncobj_timeline (wait-all-complex)
[195.857449] Starting subtest: wait-all-complex
[196.083714] Subtest wait-all-complex: SUCCESS (0.216s)
[196.159691] [016/133] (832s left) perf_pmu (busy-idle-no-semaphores)
[196.194178] Starting subtest: busy-idle-no-semaphores
[196.195463] Starting dynamic subtest: rcs0
[196.858673] Dynamic subtest rcs0: SUCCESS (0.654s)
[196.867518] Starting dynamic subtest: bcs0
[197.507931] Dynamic subtest bcs0: SUCCESS (0.648s)
[197.518317] Starting dynamic subtest: vcs0
[198.158089] Dynamic subtest vcs0: SUCCESS (0.649s)
[198.167503] Starting dynamic subtest: vcs1
[199.429780] Dynamic subtest vcs1: SUCCESS (1.278s)
[199.441253] Starting dynamic subtest: vecs0
[201.422006] Dynamic subtest vecs0: SUCCESS (1.984s)
[201.432537] Starting dynamic subtest: ccs0
[203.469410] Dynamic subtest ccs0: SUCCESS (2.047s)
[203.470573] Subtest busy-idle-no-semaphores: SUCCESS (7.267s)
[203.571389] [017/133] (824s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[203.660174] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[210.296964] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.637s)
[210.407985] [018/133] (817s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[210.501234] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[210.503070] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[210.592419] [019/133] (817s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[210.688047] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[210.689921] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[210.778644] [020/133] (817s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[210.864902] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[210.865756] Starting dynamic subtest: pipe-A-eDP-1
[227.471629] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.798s)
[227.480835] Starting dynamic subtest: pipe-B-eDP-1
[245.470146] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.827s)
[245.479276] Starting dynamic subtest: pipe-C-eDP-1
[263.432552] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.808s)
[263.441716] Starting dynamic subtest: pipe-D-eDP-1
[281.446010] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[281.446822] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.205s)
[288.691366] [021/133] (745s left) perf_pmu (semaphore-wait-idle)
[288.732820] Starting subtest: semaphore-wait-idle
[288.733687] Starting dynamic subtest: rcs0
[289.254456] Dynamic subtest rcs0: SUCCESS (0.512s)
[289.266485] Starting dynamic subtest: bcs0
[289.769493] Dynamic subtest bcs0: SUCCESS (0.513s)
[289.778599] Starting dynamic subtest: vcs0
[290.283594] Dynamic subtest vcs0: SUCCESS (0.512s)
[290.292414] Starting dynamic subtest: vcs1
[290.798167] Dynamic subtest vcs1: SUCCESS (0.512s)
[290.808268] Starting dynamic subtest: vecs0
[291.312230] Dynamic subtest vecs0: SUCCESS (0.512s)
[291.322417] Starting dynamic subtest: ccs0
[291.827227] Dynamic subtest ccs0: SUCCESS (0.513s)
[291.828447] Subtest semaphore-wait-idle: SUCCESS (3.085s)
[293.242844] [022/133] (741s left) kms_lease (lease-unleased-connector)
[293.331820] Starting subtest: lease-unleased-connector
[293.332837] Starting dynamic subtest: pipe-A-eDP-1
[293.340331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[293.352619] Starting dynamic subtest: pipe-B-eDP-1
[293.353371] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[293.361734] Starting dynamic subtest: pipe-C-eDP-1
[293.362586] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[293.371345] Starting dynamic subtest: pipe-D-eDP-1
[293.372152] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[293.372948] Subtest lease-unleased-connector: SUCCESS (0.037s)
[293.462546] [023/133] (741s left) gem_exec_parallel (basic)
[293.539309] Starting subtest: basic
[293.540329] Starting dynamic subtest: rcs0
[294.923166] Dynamic subtest rcs0: SUCCESS (1.383s)
[294.931515] Starting dynamic subtest: bcs0
[296.392647] Dynamic subtest bcs0: SUCCESS (1.468s)
[296.402913] Starting dynamic subtest: vcs0
[298.235928] Dynamic subtest vcs0: SUCCESS (1.832s)
[298.244722] Starting dynamic subtest: vcs1
[300.219875] Dynamic subtest vcs1: SUCCESS (1.982s)
[300.231061] Starting dynamic subtest: vecs0
[302.204736] Dynamic subtest vecs0: SUCCESS (1.983s)
[302.215443] Starting dynamic subtest: ccs0
[303.657890] Dynamic subtest ccs0: SUCCESS (1.460s)
[303.659023] Subtest basic: SUCCESS (10.116s)
[303.851058] [024/133] (730s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[303.984853] Starting subtest: cursorB-vs-flipA-atomic
[303.987708] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[304.125594] [025/133] (730s left) kms_properties (colorop-properties-legacy)
[304.208185] Starting subtest: colorop-properties-legacy
[304.209124] Starting dynamic subtest: pipe-A-eDP-1
[304.586156] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.378s)
[304.594976] Starting dynamic subtest: pipe-B-eDP-1
[305.679937] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.092s)
[305.692347] Starting dynamic subtest: pipe-C-eDP-1
[306.787299] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s)
[306.795677] Starting dynamic subtest: pipe-D-eDP-1
[307.825280] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s)
[307.826457] Subtest colorop-properties-legacy: SUCCESS (3.617s)
[308.611830] [026/133] (726s left) gen7_exec_parse (basic-offset)
[308.667461] Subtest basic-offset: SKIP (0.000s)
[308.722494] [027/133] (725s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[308.816765] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[308.817593] Starting dynamic subtest: pipe-A-eDP-1
[308.825474] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[308.833270] Starting dynamic subtest: pipe-B-eDP-1
[308.841238] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[308.849057] Starting dynamic subtest: pipe-C-eDP-1
[308.856900] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[308.864804] Starting dynamic subtest: pipe-D-eDP-1
[308.872640] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[308.874281] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[311.073514] [028/133] (723s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[311.167784] Starting subtest: fbc-rgb101010-draw-render
[315.797046] Subtest fbc-rgb101010-draw-render: SUCCESS (4.630s)
[316.981212] [029/133] (717s left) gem_exec_schedule (smoketest-all)
[317.035799] Starting subtest: smoketest-all
[349.370179] Subtest smoketest-all: SUCCESS (32.313s)
[350.304512] [030/133] (684s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[350.401706] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[350.402620] Starting dynamic subtest: pipe-A-eDP-1
[350.411608] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[350.421286] Starting dynamic subtest: pipe-B-eDP-1
[350.429564] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[350.437897] Starting dynamic subtest: pipe-C-eDP-1
[350.445808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[350.453384] Starting dynamic subtest: pipe-D-eDP-1
[350.461378] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[350.463125] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[352.641714] [031/133] (682s left) i915_fb_tiling (basic-x-tiling)
[352.705641] Subtest basic-x-tiling: SKIP (0.000s)
[352.770686] [032/133] (682s left) gem_userptr_blits (access-control)
[352.840642] Starting subtest: access-control
[352.842357] Subtest access-control: SKIP (0.000s)
[352.953067] [033/133] (681s left) gem_mmap_gtt (cpuset-basic-small-copy)
[353.001586] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[353.058474] [034/133] (681s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[353.152002] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[359.752368] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.602s)
[359.870490] [035/133] (675s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[359.955890] Starting subtest: psr-shrfb-scaledprimary
[365.773222] Subtest psr-shrfb-scaledprimary: SUCCESS (5.817s)
[365.897999] [036/133] (669s left) gem_exec_whisper (basic-forked)
[365.957197] Starting subtest: basic-forked
[372.991198] Subtest basic-forked: SUCCESS (7.034s)
[373.179258] [037/133] (661s left) kms_addfb_basic (unused-pitches)
[373.240016] Starting subtest: unused-pitches
[373.240959] Subtest unused-pitches: SUCCESS (0.000s)
[373.367317] [038/133] (661s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[373.473629] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[374.088179] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.615s)
[374.234550] [039/133] (660s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[374.323478] Starting subtest: psr2-cursor-plane-move-continuous-sf
[374.324356] Starting dynamic subtest: pipe-A-eDP-1
[384.675287] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.351s)
[384.683280] Starting dynamic subtest: pipe-B-eDP-1
[395.773729] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.095s)
[395.774737] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.449s)
[396.650132] [040/133] (638s left) kms_chamelium_color (gamma)
[396.749554] Subtest gamma: SKIP (0.000s)
[396.791535] [041/133] (638s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[396.843135] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[396.951299] [042/133] (638s left) api_intel_allocator (alloc-simple)
[396.995585] Starting subtest: alloc-simple
[396.997398] Subtest alloc-simple: SUCCESS (0.003s)
[397.108196] [043/133] (638s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[397.196041] Starting subtest: psr-1p-pri-indfb-multidraw
[420.523617] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.327s)
[420.625934] [044/133] (614s left) kms_selftest (drm_dp_mst_helper)
[420.670476] Starting subtest: drm_dp_mst_helper
[420.720731] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[420.818145] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.096s)
[420.829385] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[420.921926] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.105s)
[420.929808] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[421.015287] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.093s)
[421.016201] Subtest drm_dp_mst_helper: SUCCESS (0.345s)
[421.164456] [045/133] (614s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[421.259202] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[425.832709] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.573s)
[426.975208] [046/133] (608s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[427.069093] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[427.080663] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[427.165331] [047/133] (608s left) gem_exec_schedule (in-order)
[427.223582] Starting subtest: in-order
[427.224464] Starting dynamic subtest: rcs0
[427.338652] Dynamic subtest rcs0: SUCCESS (0.114s)
[427.353283] Starting dynamic subtest: vcs0
[427.423289] Dynamic subtest vcs0: SUCCESS (0.083s)
[427.442719] Starting dynamic subtest: vcs1
[427.502905] Dynamic subtest vcs1: SUCCESS (0.079s)
[427.514805] Starting dynamic subtest: vecs0
[427.581443] Dynamic subtest vecs0: SUCCESS (0.077s)
[427.594519] Starting dynamic subtest: ccs0
[427.664818] Dynamic subtest ccs0: SUCCESS (0.083s)
[427.666103] Subtest in-order: SUCCESS (0.441s)
[429.327996] [048/133] (606s left) gem_softpin (overlap)
[429.386545] Starting subtest: overlap
[430.382018] Subtest overlap: SUCCESS (0.986s)
[430.485896] [049/133] (604s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[430.587795] Starting subtest: y-tiled-16bpp-rotate-180
[430.589603] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[430.681165] [050/133] (604s left) perf_pmu (frequency)
[430.726574] Starting subtest: frequency
[430.727508] Starting dynamic subtest: gt0
[432.880308] Dynamic subtest gt0: SUCCESS (2.154s)
[432.890960] Starting dynamic subtest: idle-gt0
[433.394445] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[433.404340] Starting dynamic subtest: gt1
[438.210826] Dynamic subtest gt1: SUCCESS (4.811s)
[438.219476] Starting dynamic subtest: idle-gt1
[438.717175] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[438.718230] Subtest frequency: SUCCESS (7.995s)
[438.805225] [051/133] (596s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[438.895627] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[438.896618] Starting dynamic subtest: pipe-A-default-mode
[441.605091] Dynamic subtest pipe-A-default-mode: SUCCESS (2.708s)
[441.606598] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.710s)
[442.450149] [052/133] (593s left) gem_ctx_isolation (dirty-create)
[442.515989] Starting subtest: dirty-create
[442.516932] Starting dynamic subtest: rcs0
[442.698528] Dynamic subtest rcs0: SUCCESS (0.184s)
[442.709510] Starting dynamic subtest: bcs0
[442.898996] Dynamic subtest bcs0: SUCCESS (0.200s)
[442.910161] Starting dynamic subtest: vcs0
[443.107085] Dynamic subtest vcs0: SUCCESS (0.207s)
[443.117551] Starting dynamic subtest: vcs1
[444.320608] Dynamic subtest vcs1: SUCCESS (1.212s)
[444.336564] Starting dynamic subtest: vecs0
[446.382644] Dynamic subtest vecs0: SUCCESS (2.061s)
[446.393264] Starting dynamic subtest: ccs0
[448.389548] Dynamic subtest ccs0: SUCCESS (2.006s)
[448.390577] Subtest dirty-create: SUCCESS (5.876s)
[448.619046] [053/133] (587s left) kms_invalid_mode (overflow-vrefresh)
[448.711025] Starting subtest: overflow-vrefresh
[448.711807] Starting dynamic subtest: pipe-A-eDP-1
[449.006504] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[449.015791] Starting dynamic subtest: pipe-B-eDP-1
[449.016704] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[449.024299] Starting dynamic subtest: pipe-C-eDP-1
[449.025142] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[449.033818] Starting dynamic subtest: pipe-D-eDP-1
[449.034656] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[449.035562] Subtest overflow-vrefresh: SUCCESS (0.300s)
[449.800147] [054/133] (585s left) kms_vblank (wait-busy-hang)
[449.896979] Starting subtest: wait-busy-hang
[449.897820] Starting dynamic subtest: pipe-A-eDP-1
[476.022151] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.123s)
[476.032365] Starting dynamic subtest: pipe-D-eDP-1
[490.942278] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.919s)
[490.943148] Subtest wait-busy-hang: SUCCESS (41.047s)
[491.756638] [055/133] (543s left) gem_exec_schedule (submit-golden-slice)
[491.811225] Starting subtest: submit-golden-slice
[491.812245] Starting dynamic subtest: rcs0
[491.848374] Dynamic subtest rcs0: SUCCESS (0.037s)
[491.857463] Starting dynamic subtest: bcs0
[491.878841] Dynamic subtest bcs0: SUCCESS (0.030s)
[491.887432] Starting dynamic subtest: vcs0
[491.909495] Dynamic subtest vcs0: SUCCESS (0.029s)
[491.923659] Starting dynamic subtest: vcs1
[491.944462] Dynamic subtest vcs1: SUCCESS (0.035s)
[491.953630] Starting dynamic subtest: vecs0
[491.979586] Dynamic subtest vecs0: SUCCESS (0.034s)
[491.988733] Starting dynamic subtest: ccs0
[492.010663] Dynamic subtest ccs0: SUCCESS (0.030s)
[492.011697] Subtest submit-golden-slice: SUCCESS (0.200s)
[493.252150] [056/133] (542s left) gem_mmap_wc (bad-offset)
[493.307522] Subtest bad-offset: SKIP (0.000s)
[493.364183] [057/133] (542s left) sysfs_heartbeat_interval (idempotent)
[493.420029] Starting subtest: idempotent
[493.421166] Starting dynamic subtest: vecs0
[493.422100] Dynamic subtest vecs0: SUCCESS (0.001s)
[493.430365] Starting dynamic subtest: ccs0
[493.431240] Dynamic subtest ccs0: SUCCESS (0.001s)
[493.439228] Starting dynamic subtest: vcs0
[493.440131] Dynamic subtest vcs0: SUCCESS (0.000s)
[493.447823] Starting dynamic subtest: bcs0
[493.448724] Dynamic subtest bcs0: SUCCESS (0.001s)
[493.456497] Starting dynamic subtest: rcs0
[493.457481] Dynamic subtest rcs0: SUCCESS (0.000s)
[493.465105] Starting dynamic subtest: vcs1
[493.465964] Dynamic subtest vcs1: SUCCESS (0.000s)
[493.466807] Subtest idempotent: SUCCESS (0.008s)
[493.531564] [058/133] (542s left) gem_compute (compute-square)
[493.582785] Starting subtest: compute-square
[493.590658] Subtest compute-square: SUCCESS (0.008s)
[493.695979] [059/133] (542s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[493.780791] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[493.782854] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[493.900371] [060/133] (541s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[493.965714] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[493.966764] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[494.049138] [061/133] (541s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[494.133167] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[494.134028] Starting dynamic subtest: pipe-A-eDP-1
[494.153640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[494.163699] Starting dynamic subtest: pipe-B-eDP-1
[494.175169] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[494.184627] Starting dynamic subtest: pipe-C-eDP-1
[494.196540] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[494.205973] Starting dynamic subtest: pipe-D-eDP-1
[494.218493] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[494.219371] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[496.517670] [062/133] (539s left) kms_prime (basic-modeset-hybrid)
[496.605352] Subtest basic-modeset-hybrid: SKIP (0.000s)
[496.695183] [063/133] (539s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[496.750267] Starting subtest: y-tiled-ccs-to-x-tiled
[496.752356] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[496.941803] [064/133] (539s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[496.989191] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[496.990979] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[497.180182] [065/133] (538s left) kms_flip (basic-flip-vs-wf_vblank)
[497.264797] Starting subtest: basic-flip-vs-wf_vblank
[497.266698] Starting dynamic subtest: A-eDP1
[499.164219] Dynamic subtest A-eDP1: SUCCESS (1.898s)
[499.175456] Starting dynamic subtest: B-eDP1
[501.096947] Dynamic subtest B-eDP1: SUCCESS (1.930s)
[501.108843] Starting dynamic subtest: C-eDP1
[503.015293] Dynamic subtest C-eDP1: SUCCESS (1.915s)
[503.026705] Starting dynamic subtest: D-eDP1
[504.956367] Dynamic subtest D-eDP1: SUCCESS (1.939s)
[504.957499] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.693s)
[506.182568] [066/133] (529s left) vgem_basic (second-client)
[506.222995] Starting subtest: second-client
[506.244944] Subtest second-client: SUCCESS (0.022s)
[506.302802] [067/133] (529s left) gem_ctx_persistence (userptr)
[506.369634] Starting subtest: userptr
[506.542519] Subtest userptr: SUCCESS (0.174s)
[506.615648] [068/133] (529s left) syncobj_timeline (multi-wait-available-submitted)
[506.673000] Starting subtest: multi-wait-available-submitted
[506.673896] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[506.777315] [069/133] (529s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[506.867232] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[506.868088] Starting dynamic subtest: pipe-A
[506.931140] Dynamic subtest pipe-A: SUCCESS (0.065s)
[506.939813] Starting dynamic subtest: pipe-B
[508.110187] Dynamic subtest pipe-B: SUCCESS (1.178s)
[508.122293] Starting dynamic subtest: pipe-C
[509.232173] Dynamic subtest pipe-C: SUCCESS (1.120s)
[509.240612] Starting dynamic subtest: pipe-D
[510.354946] Dynamic subtest pipe-D: SUCCESS (1.122s)
[510.355786] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.489s)
[511.492172] [070/133] (524s left) kms_plane (pixel-format-linear-modifier)
[511.577002] Starting subtest: pixel-format-linear-modifier
[511.605877] Starting dynamic subtest: pipe-A-plane-0
[515.039301] Dynamic subtest pipe-A-plane-0: SUCCESS (3.433s)
[515.052152] Starting dynamic subtest: pipe-A-plane-3
[516.706307] Dynamic subtest pipe-A-plane-3: SUCCESS (1.665s)
[516.721617] Starting dynamic subtest: pipe-A-plane-5
[516.917145] Dynamic subtest pipe-A-plane-5: SUCCESS (0.208s)
[517.987672] Starting dynamic subtest: pipe-B-plane-0
[521.546549] Dynamic subtest pipe-B-plane-0: SUCCESS (3.566s)
[521.560454] Starting dynamic subtest: pipe-B-plane-3
[523.202500] Dynamic subtest pipe-B-plane-3: SUCCESS (1.655s)
[523.211660] Starting dynamic subtest: pipe-B-plane-5
[523.414081] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[523.722940] Subtest pixel-format-linear-modifier: SUCCESS (12.144s)
[524.567766] [071/133] (511s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[524.661117] Starting subtest: fbc-pr-cursor-mmap-cpu
[524.662654] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[524.743778] [072/133] (511s left) kms_flip (wf_vblank-ts-check)
[524.826441] Starting subtest: wf_vblank-ts-check
[524.827314] Starting dynamic subtest: A-eDP1
[533.826904] Dynamic subtest A-eDP1: SUCCESS (8.973s)
[533.837652] Starting dynamic subtest: B-eDP1
[542.750253] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[542.760587] Starting dynamic subtest: C-eDP1
[551.681944] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[551.690801] Starting dynamic subtest: D-eDP1
[560.581222] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[560.584902] Subtest wf_vblank-ts-check: SUCCESS (35.755s)
[561.807001] [073/133] (474s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[562.180186] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[563.019398] [074/133] (473s left) gem_fence_thrash (bo-write-verify-none)
[563.059344] Starting subtest: bo-write-verify-none
[563.070951] Subtest bo-write-verify-none: SKIP (0.012s)
[563.126449] [075/133] (473s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[563.220959] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[564.257069] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.035s)
[564.355483] [076/133] (472s left) kms_cursor_crc (cursor-offscreen-512x512)
[564.621430] Starting subtest: cursor-offscreen-512x512
[564.623341] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[564.781106] [077/133] (471s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[564.878973] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[564.881076] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[564.966036] [078/133] (471s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[565.067084] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[565.067968] Starting dynamic subtest: pipe-A
[565.417381] Dynamic subtest pipe-A: SUCCESS (0.351s)
[565.425882] Starting dynamic subtest: pipe-B
[566.847094] Dynamic subtest pipe-B: SUCCESS (1.429s)
[566.857819] Starting dynamic subtest: pipe-C
[568.275506] Dynamic subtest pipe-C: SUCCESS (1.428s)
[568.283823] Starting dynamic subtest: pipe-D
[569.720264] Dynamic subtest pipe-D: SUCCESS (1.444s)
[569.721261] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.654s)
[570.869164] [079/133] (465s left) i915_drm_fdinfo (memory-info-resident)
[570.905776] Starting subtest: memory-info-resident
[570.907015] Starting dynamic subtest: smem0
[573.751789] Dynamic subtest smem0: SUCCESS (2.845s)
[573.753398] Subtest memory-info-resident: SUCCESS (2.846s)
[573.824144] [080/133] (462s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[573.911957] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[573.913572] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[574.004928] [081/133] (462s left) kms_psr (psr-sprite-blt)
[574.102992] Starting subtest: psr-sprite-blt
[574.103869] Starting dynamic subtest: eDP-1
[575.892755] Dynamic subtest eDP-1: SUCCESS (1.789s)
[575.894268] Subtest psr-sprite-blt: SUCCESS (1.790s)
[576.732132] [082/133] (459s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[576.816109] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[577.197163] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[580.011284] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.803s)
[580.021913] Starting dynamic subtest: pipe-A-eDP-1-4
[582.187200] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[582.203734] Starting dynamic subtest: pipe-A-eDP-1-4
[584.194051] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.006s)
[584.208502] Starting dynamic subtest: pipe-A-eDP-1-x
[586.373017] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[586.737670] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[589.540128] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.803s)
[589.548184] Starting dynamic subtest: pipe-B-eDP-1-4
[591.727243] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[591.738619] Starting dynamic subtest: pipe-B-eDP-1-4
[593.737499] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[593.748711] Starting dynamic subtest: pipe-B-eDP-1-x
[595.927570] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[596.291698] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[599.078354] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.784s)
[599.090270] Starting dynamic subtest: pipe-C-eDP-1-4
[601.241505] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s)
[601.255227] Starting dynamic subtest: pipe-C-eDP-1-4
[603.252392] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[603.264080] Starting dynamic subtest: pipe-C-eDP-1-x
[605.430582] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.176s)
[605.788646] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[608.609895] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.823s)
[608.623150] Starting dynamic subtest: pipe-D-eDP-1-4
[610.785012] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[610.796209] Starting dynamic subtest: pipe-D-eDP-1-4
[612.795482] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[612.803996] Starting dynamic subtest: pipe-D-eDP-1-x
[614.974442] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[614.975961] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.148s)
[616.201725] [083/133] (420s left) gem_softpin (zero)
[616.262459] Starting subtest: zero
[616.266191] Subtest zero: SUCCESS (0.004s)
[616.376657] [084/133] (420s left) kms_plane_multiple (2x-tiling-y)
[616.471960] Starting subtest: 2x-tiling-y
[616.473733] Subtest 2x-tiling-y: SKIP (0.000s)
[616.547363] [085/133] (420s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[616.630327] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[616.631233] Starting dynamic subtest: pipe-A-eDP-1
[616.640931] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[616.654329] Starting dynamic subtest: pipe-B-eDP-1
[616.663929] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[616.678172] Starting dynamic subtest: pipe-C-eDP-1
[616.687840] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[616.696763] Starting dynamic subtest: pipe-D-eDP-1
[616.707216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[616.708958] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[618.964931] [086/133] (417s left) gem_mmap_gtt (basic-read-write)
[619.022062] Subtest basic-read-write: SKIP (0.000s)
[619.078822] [087/133] (417s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[619.120147] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[619.121328] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[619.192725] [088/133] (417s left) core_getstats (basic)
[619.250879] Starting subtest: basic
[619.251887] Subtest basic: SUCCESS (0.000s)
[619.340870] [089/133] (417s left) kms_cursor_edge_walk (64x64-left-edge)
[619.428433] Starting subtest: 64x64-left-edge
[619.430807] Starting dynamic subtest: pipe-A-eDP-1
[622.915709] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.486s)
[622.925113] Starting dynamic subtest: pipe-D-eDP-1
[626.043463] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[626.044355] Subtest 64x64-left-edge: SUCCESS (6.614s)
[626.884603] [090/133] (410s left) kms_display_modes (extended-mode-basic)
[626.973164] Starting subtest: extended-mode-basic
[626.974943] Subtest extended-mode-basic: SKIP (0.000s)
[627.015564] [091/133] (409s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[627.103018] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[627.104643] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[627.199826] [092/133] (409s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[627.297817] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[628.079058] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.781s)
[628.247300] [093/133] (408s left) gem_tiled_fence_blits (basic)
[628.303477] Subtest basic: SKIP (0.000s)
[628.375598] [094/133] (408s left) i915_pm_rps (min-max-config-loaded)
[628.435351] Starting subtest: min-max-config-loaded
[628.437198] Subtest min-max-config-loaded: SKIP (0.001s)
[628.527626] [095/133] (408s left) gem_unfence_active_buffers
[628.655286] [096/133] (408s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[628.794345] Starting subtest: dp-mst-type-1-suspend-resume
[628.796237] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[628.923663] [097/133] (408s left) kms_psr (pr-sprite-mmap-cpu)
[629.006999] Starting subtest: pr-sprite-mmap-cpu
[629.008711] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[629.090013] [098/133] (408s left) kms_psr (fbc-psr-dpms)
[629.177989] Starting subtest: fbc-psr-dpms
[629.178760] Starting dynamic subtest: eDP-1
[629.180394] Dynamic subtest eDP-1: SKIP (0.000s)
[629.181932] Subtest fbc-psr-dpms: SKIP (0.001s)
[629.278542] [099/133] (408s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[629.367061] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[629.368782] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[629.463799] [100/133] (407s left) gem_mmap_gtt (hang-user)
[629.520044] Subtest hang-user: SKIP (0.000s)
[629.570217] [101/133] (407s left) syncobj_basic (bad-pad-handle-to-fd)
[629.618815] Starting subtest: bad-pad-handle-to-fd
[629.619794] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[629.718522] [102/133] (407s left) syncobj_wait (invalid-wait-bad-flags)
[629.771117] Starting subtest: invalid-wait-bad-flags
[629.772047] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[629.884616] [103/133] (407s left) syncobj_basic (bad-pad-fd-to-handle)
[629.939853] Starting subtest: bad-pad-fd-to-handle
[629.940754] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[630.033139] [104/133] (407s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[630.130898] Starting subtest: stress-xrgb8888-ytiled
[630.132438] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[630.203863] [105/133] (407s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[630.324895] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[631.748655] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.416s)
[632.605582] [106/133] (404s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[632.697310] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[632.698979] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[632.787957] [107/133] (404s left) gem_exec_schedule (fairslice-all)
[632.859824] Starting subtest: fairslice-all
[634.913304] Subtest fairslice-all: SUCCESS (2.054s)
[636.299524] [108/133] (401s left) gem_exec_flush (basic-wb-pro-default)
[636.360465] Starting subtest: basic-wb-pro-default
[641.832239] Subtest basic-wb-pro-default: SUCCESS (5.473s)
[642.021773] [109/133] (395s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[642.116780] Starting subtest: yf-tiled-32bpp-rotate-90
[642.119322] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[642.197517] [110/133] (395s left) kms_atomic (plane-immutable-zpos)
[642.280313] Starting subtest: plane-immutable-zpos
[642.281293] Starting dynamic subtest: pipe-A-eDP-1
[642.918446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.637s)
[642.919565] Subtest plane-immutable-zpos: SUCCESS (0.639s)
[643.744870] [111/133] (393s left) gem_ctx_param (invalid-param-get)
[643.788329] Starting subtest: invalid-param-get
[643.789256] Subtest invalid-param-get: SUCCESS (0.001s)
[643.900765] [112/133] (393s left) kms_feature_discovery (display-3x)
[643.983218] Starting subtest: display-3x
[643.985080] Subtest display-3x: SKIP (0.000s)
[644.068309] [113/133] (393s left) gem_ctx_shared (q-out-order)
[644.124084] Starting subtest: Q-out-order
[644.125072] Starting dynamic subtest: rcs0
[644.234687] Dynamic subtest rcs0: SUCCESS (0.109s)
[644.246826] Starting dynamic subtest: vcs0
[644.324563] Dynamic subtest vcs0: SUCCESS (0.089s)
[644.341204] Starting dynamic subtest: vcs1
[644.407657] Dynamic subtest vcs1: SUCCESS (0.082s)
[644.426447] Starting dynamic subtest: vecs0
[644.485918] Dynamic subtest vecs0: SUCCESS (0.077s)
[644.503706] Starting dynamic subtest: ccs0
[644.568105] Dynamic subtest ccs0: SUCCESS (0.081s)
[644.569056] Subtest Q-out-order: SUCCESS (0.444s)
[646.285596] [114/133] (391s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[646.384664] Starting subtest: extended-modeset-hang-oldfb-with-reset
[646.385558] Starting dynamic subtest: pipe-A
[657.935308] Dynamic subtest pipe-A: SUCCESS (11.548s)
[657.944674] Starting dynamic subtest: pipe-D
[670.220289] Dynamic subtest pipe-D: SUCCESS (12.284s)
[670.221340] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.835s)
[671.031210] [115/133] (366s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[671.119232] Starting subtest: fbcpsr-rgb565-draw-blt
[678.250303] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.132s)
[678.368025] [116/133] (359s left) syncobj_wait (wait-for-submit-delayed-submit)
[678.424144] Starting subtest: wait-for-submit-delayed-submit
[678.527713] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[678.623296] [117/133] (359s left) dmabuf_sync_file (import-multiple-read-write)
[678.666604] Starting subtest: import-multiple-read-write
[678.670182] Subtest import-multiple-read-write: SUCCESS (0.003s)
[678.721373] [118/133] (359s left) kms_pipe_crc_basic (bad-source)
[678.824932] Starting subtest: bad-source
[678.825812] Subtest bad-source: SUCCESS (0.000s)
[678.940483] [119/133] (359s left) gem_ccs (ctrl-surf-copy)
[678.998298] Starting subtest: ctrl-surf-copy
[679.000180] Subtest ctrl-surf-copy: SKIP (0.000s)
[679.091620] [120/133] (359s left) kms_color (degamma)
[679.183188] Starting subtest: degamma
[679.184211] Starting dynamic subtest: pipe-A-eDP-1
[679.904300] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[679.912951] Starting dynamic subtest: pipe-B-eDP-1
[681.385229] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.479s)
[681.394035] Starting dynamic subtest: pipe-C-eDP-1
[682.734275] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s)
[682.743535] Starting dynamic subtest: pipe-D-eDP-1
[684.071181] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[684.071999] Subtest degamma: SUCCESS (4.888s)
[684.862154] [121/133] (353s left) gem_softpin (evict-snoop)
[684.919223] Starting subtest: evict-snoop
[684.921061] Subtest evict-snoop: SKIP (0.000s)
[685.017839] [122/133] (353s left) gem_exec_balancer (nohangcheck)
[685.290131] Starting subtest: nohangcheck
[686.287791] Subtest nohangcheck: SUCCESS (0.994s)
[686.411469] [123/133] (351s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[686.509229] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[693.921330] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.413s)
[694.040861] [124/133] (344s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[694.123403] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[694.125306] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[694.194690] [125/133] (344s left) gem_exec_whisper (basic-queues-all)
[694.256041] Starting subtest: basic-queues-all
[706.139057] Subtest basic-queues-all: SUCCESS (11.872s)
[706.316946] [126/133] (331s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[706.650142] Starting subtest: parallel-dmabuf-import-out-fence
[707.919779] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.269s)
[708.014827] [127/133] (330s left) kms_pm_rpm (cursor-dpms)
[709.530886] Starting subtest: cursor-dpms
[709.534026] Subtest cursor-dpms: SKIP (0.000s)
[710.235130] [128/133] (328s left) kms_psr (fbc-psr2-basic)
[710.331151] Starting subtest: fbc-psr2-basic
[710.332130] Starting dynamic subtest: eDP-1
[710.334093] Dynamic subtest eDP-1: SKIP (0.000s)
[710.335707] Subtest fbc-psr2-basic: SKIP (0.001s)
[710.401558] [129/133] (328s left) gem_userptr_blits (coherency-unsync)
[710.461122] Subtest coherency-unsync: SKIP (0.000s)
[710.595762] [130/133] (327s left) kms_psr (psr2-cursor-mmap-gtt)
[710.682304] Starting subtest: psr2-cursor-mmap-gtt
[710.683228] Starting dynamic subtest: eDP-1
[712.400812] Dynamic subtest eDP-1: SUCCESS (1.719s)
[712.401660] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.720s)
[713.201119] [131/133] (325s left) i915_selftest (live)
[717.826689] Starting subtest: live
[717.828103] Starting dynamic subtest: sanitycheck
[722.265043] Dynamic subtest sanitycheck: SUCCESS (4.439s)
[722.273110] Starting dynamic subtest: uncore
[726.616353] Dynamic subtest uncore: SUCCESS (4.348s)
[726.625663] Starting dynamic subtest: workarounds
[743.025933] Dynamic subtest workarounds: FAIL (16.205s)
[743.032586] Starting dynamic subtest: gt_engines
[745.874366] Dynamic subtest gt_engines: SUCCESS (3.051s)
[745.883474] Starting dynamic subtest: gt_timelines
[761.812176] Dynamic subtest gt_timelines: SUCCESS (15.936s)
[761.822955] Starting dynamic subtest: gt_contexts
[766.206339] Dynamic subtest gt_contexts: SUCCESS (4.393s)
[766.216017] Starting dynamic subtest: gt_lrc
[772.533642] Dynamic subtest gt_lrc: SUCCESS (6.326s)
[772.543364] Starting dynamic subtest: gt_mocs
[775.509131] Dynamic subtest gt_mocs: SUCCESS (2.973s)
[775.515235] Starting dynamic subtest: gt_pm
[780.286966] Dynamic subtest gt_pm: SUCCESS (4.775s)
[780.296297] Starting dynamic subtest: gt_heartbeat
[784.688483] Dynamic subtest gt_heartbeat: SUCCESS (4.399s)
[784.697485] Starting dynamic subtest: gt_tlb
[794.080017] Dynamic subtest gt_tlb: SUCCESS (9.390s)
[794.089316] Starting dynamic subtest: requests
[807.607674] Dynamic subtest requests: SUCCESS (13.525s)
[807.615832] Starting dynamic subtest: migrate
[815.400653] Dynamic subtest migrate: SUCCESS (7.793s)
[815.416598] Starting dynamic subtest: active
[818.139522] Dynamic subtest active: SUCCESS (2.737s)
[818.149226] Starting dynamic subtest: objects
[822.881304] Dynamic subtest objects: SUCCESS (4.740s)
[822.890281] Starting dynamic subtest: mman
[827.686816] Dynamic subtest mman: SUCCESS (4.803s)
[827.695986] Starting dynamic subtest: dmabuf
[832.073131] Dynamic subtest dmabuf: SUCCESS (4.384s)
[832.082560] Starting dynamic subtest: vma
[836.478562] Dynamic subtest vma: SUCCESS (4.404s)
[836.485587] Starting dynamic subtest: coherency
[841.562636] Dynamic subtest coherency: SUCCESS (5.081s)
[841.571523] Starting dynamic subtest: gtt
[853.460798] Dynamic subtest gtt: SUCCESS (11.895s)
[853.469549] Starting dynamic subtest: gem
[858.965801] Dynamic subtest gem: SUCCESS (5.505s)
[858.973277] Starting dynamic subtest: evict
[863.068523] Dynamic subtest evict: SUCCESS (4.099s)
[863.077786] Starting dynamic subtest: hugepages
[873.839729] Dynamic subtest hugepages: SUCCESS (10.771s)
[873.849159] Starting dynamic subtest: gem_contexts
[900.845055] Dynamic subtest gem_contexts: SUCCESS (27.003s)
[900.855944] Starting dynamic subtest: client
[905.273216] Dynamic subtest client: SUCCESS (4.427s)
[905.283109] Starting dynamic subtest: gem_migrate
[909.682312] Dynamic subtest gem_migrate: SUCCESS (4.405s)
[909.692307] Starting dynamic subtest: reset
[914.009521] Dynamic subtest reset: SUCCESS (4.325s)
[914.019090] Starting dynamic subtest: memory_region
[918.375452] Dynamic subtest memory_region: SUCCESS (4.364s)
[918.384514] Starting dynamic subtest: hangcheck
[931.357866] Dynamic subtest hangcheck: SUCCESS (12.982s)
[931.368173] Starting dynamic subtest: execlists
[934.103084] Dynamic subtest execlists: SUCCESS (2.743s)
[934.112566] Starting dynamic subtest: ring_submission
[938.499542] Dynamic subtest ring_submission: SUCCESS (4.394s)
[938.508885] Starting dynamic subtest: perf
[942.910864] Dynamic subtest perf: SUCCESS (4.410s)
[942.920006] Starting dynamic subtest: slpc
[955.038363] Dynamic subtest slpc: SUCCESS (12.125s)
[955.047335] Starting dynamic subtest: guc
[959.005381] Dynamic subtest guc: SUCCESS (3.965s)
[959.014347] Starting dynamic subtest: guc_multi_lrc
[963.348210] Dynamic subtest guc_multi_lrc: SUCCESS (4.343s)
[963.360182] Starting dynamic subtest: guc_hang
[968.374832] Dynamic subtest guc_hang: SUCCESS (5.024s)
[968.384142] Starting dynamic subtest: late_gt_pm
[972.794250] Dynamic subtest late_gt_pm: SUCCESS (4.418s)
[972.795593] Subtest live: FAIL (254.963s)
[972.817400] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[972.818125] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[972.819716] [132/133] ( 65s left) gem_userptr_blits (unsync-unmap)
[974.363157] Subtest unsync-unmap: SKIP (0.000s)
[974.453133] [FACT gem_userptr_blits (unsync-unmap)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[974.454455] [FACT gem_userptr_blits (unsync-unmap)] new: kernel.kmod_is_loaded.i915: true
[974.457211] [133/133] ( 64s left) gem_linear_blits (normal)
[975.082757] Starting subtest: normal
[978.872358] Subtest normal: SUCCESS (3.781s)
[979.001062] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: gem_sync
results: parsing output: 3/ for test: gem_exec_fence
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_hdr
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: prime_vgem
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: gem_exec_parallel
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: gen7_exec_parse
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: i915_fb_tiling
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_chamelium_color
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_selftest
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: gem_softpin
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: gem_ctx_isolation
results: parsing output: 52/ for test: kms_invalid_mode
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: sysfs_heartbeat_interval
results: parsing output: 57/ for test: gem_compute
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_prime
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: vgem_basic
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_chamelium_hpd
results: parsing output: 73/ for test: gem_fence_thrash
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: gem_softpin
results: parsing output: 83/ for test: kms_plane_multiple
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: core_getstats
results: parsing output: 88/ for test: kms_cursor_edge_walk
results: parsing output: 89/ for test: kms_display_modes
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_tiled_fence_blits
results: parsing output: 93/ for test: i915_pm_rps
results: parsing output: 94/ for test: gem_unfence_active_buffers
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: kms_pipe_stress
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_atomic
results: parsing output: 110/ for test: gem_ctx_param
results: parsing output: 111/ for test: kms_feature_discovery
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: kms_busy
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: dmabuf_sync_file
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: gem_ccs
results: parsing output: 119/ for test: kms_color
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_flip_scaled_crc
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: i915_selftest
results: parsing output: 131/ for test: gem_userptr_blits
results: parsing output: 132/ for test: gem_linear_blits
Done.