[55.704446] Initializing watchdogs
[55.704699]   /dev/watchdog0
[55.720574] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[55.724514] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.726845] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.730180] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[55.838745] Starting subtest: fbcpsr-indfb-scaledprimary
[61.559148] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.723s)
[61.705548] [002/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[61.799356] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[68.611776] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.815s)
[68.741081] [003/133] (947s left) prime_mmap (test_correct)
[68.792662] Starting subtest: test_correct
[68.794846] Starting dynamic subtest: test_correct-smem
[68.822615] Dynamic subtest test_correct-smem: SUCCESS (0.031s)
[68.825096] Subtest test_correct: SUCCESS (0.031s)
[68.905292] [004/133] (947s left) gem_exec_reloc (basic-write-read)
[68.964433] Subtest basic-write-read: SKIP (0.000s)
[69.033298] [005/133] (947s left) gem_ctx_isolation (preservation)
[69.096418] Starting subtest: preservation
[69.098842] Starting dynamic subtest: rcs0
[69.231888] Dynamic subtest rcs0: SUCCESS (0.135s)
[69.239593] Starting dynamic subtest: bcs0
[69.373645] Dynamic subtest bcs0: SUCCESS (0.141s)
[69.383744] Starting dynamic subtest: vcs0
[69.514392] Dynamic subtest vcs0: SUCCESS (0.140s)
[69.524613] Starting dynamic subtest: vcs1
[71.351594] Dynamic subtest vcs1: SUCCESS (1.836s)
[71.362479] Starting dynamic subtest: vecs0
[73.468364] Dynamic subtest vecs0: SUCCESS (2.116s)
[73.478901] Starting dynamic subtest: ccs0
[75.332454] Dynamic subtest ccs0: SUCCESS (1.863s)
[75.335117] Subtest preservation: SUCCESS (6.234s)
[75.556911] [006/133] (940s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[75.654283] Starting subtest: x-tiled-16bpp-rotate-270
[75.672968] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[75.783192] [007/133] (940s left) gem_exec_fence (long-history)
[76.234492] Starting subtest: long-history
[83.042117] Subtest long-history: SUCCESS (6.807s)
[83.529947] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[83.533013] [008/133] (932s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[83.612567] Starting subtest: primary-yf-tiled-reflect-x-180
[83.674068] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[83.773984] [009/133] (932s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[83.836801] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[83.839144] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[83.926192] [010/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[84.009422] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[84.014041] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[84.071797] [011/133] (932s left) gem_exec_flush (basic-uc-set-default)
[84.137909] Starting subtest: basic-uc-set-default
[89.623673] Subtest basic-uc-set-default: SUCCESS (5.470s)
[89.802803] [012/133] (926s left) gem_ctx_bad_destroy (double-destroy)
[89.861646] Starting subtest: double-destroy
[89.864059] Subtest double-destroy: SUCCESS (0.000s)
[89.937234] [013/133] (926s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[90.016936] Starting subtest: y-tiled-32bpp-rotate-0
[90.020941] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[90.122241] [014/133] (926s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[90.227984] Starting subtest: 2x-flip-vs-cursor-legacy
[90.232393] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[90.370143] [015/133] (926s left) kms_cursor_crc (cursor-random-256x256)
[90.582461] Starting subtest: cursor-random-256x256
[90.584345] Starting dynamic subtest: pipe-A-eDP-1
[93.957272] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.373s)
[93.990152] Starting dynamic subtest: pipe-D-eDP-1
[97.961165] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.976s)
[97.963676] Subtest cursor-random-256x256: SUCCESS (7.379s)
[98.797107] [016/133] (918s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[99.167645] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[100.004753] [017/133] (916s left) gem_ctx_shared (q-independent)
[100.073394] Starting subtest: Q-independent
[100.075860] Starting dynamic subtest: rcs0
[100.138256] Dynamic subtest rcs0: SUCCESS (0.064s)
[100.149919] Starting dynamic subtest: vcs0
[100.178264] Dynamic subtest vcs0: SUCCESS (0.041s)
[100.189557] Starting dynamic subtest: vcs1
[100.215852] Dynamic subtest vcs1: SUCCESS (0.037s)
[100.226021] Starting dynamic subtest: vecs0
[100.256794] Dynamic subtest vecs0: SUCCESS (0.041s)
[100.266224] Starting dynamic subtest: ccs0
[100.301033] Dynamic subtest ccs0: SUCCESS (0.044s)
[100.303775] Subtest Q-independent: SUCCESS (0.228s)
[101.338810] [018/133] (915s left) gem_ctx_param (basic-default)
[101.388878] Starting subtest: basic-default
[101.391418] Subtest basic-default: SUCCESS (0.000s)
[101.463895] [019/133] (915s left) gem_exec_schedule (preempt-queue-contexts-chain)
[101.541319] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[101.842708] [020/133] (915s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[101.911755] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[101.914083] Starting dynamic subtest: pipe-A-eDP-1
[101.937221] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.947336] Starting dynamic subtest: pipe-B-eDP-1
[101.969744] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.978236] Starting dynamic subtest: pipe-C-eDP-1
[102.000211] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[102.009291] Starting dynamic subtest: pipe-D-eDP-1
[102.031342] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[102.035513] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[104.100700] [021/133] (912s left) kms_addfb_basic (tile-pitch-mismatch)
[104.161122] Starting subtest: tile-pitch-mismatch
[104.165500] Subtest tile-pitch-mismatch: SKIP (0.000s)
[104.279514] [022/133] (912s left) kms_cursor_crc (cursor-suspend)
[104.382938] Starting subtest: cursor-suspend
[104.385247] Starting dynamic subtest: pipe-A-eDP-1
[137.648025] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.049s)
[137.658377] Starting dynamic subtest: pipe-D-eDP-1
[171.657019] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.810s)
[171.659239] Subtest cursor-suspend: SUCCESS (7.860s)
[172.450350] [023/133] (844s left) core_getversion (basic)
[172.491026] Starting subtest: basic
[172.495135] Subtest basic: SUCCESS (0.000s)
[172.549958] [024/133] (844s left) gem_pread (bench)
[172.595615] Subtest bench: SKIP (0.000s)
[172.653605] [025/133] (844s left) gen9_exec_parse (bb-start-far)
[172.703237] Subtest bb-start-far: SKIP (0.000s)
[172.768101] [026/133] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[172.843944] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[172.847784] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[172.932684] [027/133] (844s left) gem_ctx_param (get-priority-new-ctx)
[172.989026] Starting subtest: get-priority-new-ctx
[172.991097] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[173.093660] [028/133] (844s left) kms_big_fb (linear-8bpp-rotate-90)
[173.175342] Starting subtest: linear-8bpp-rotate-90
[173.195504] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[173.310745] [029/133] (844s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[173.378465] Starting subtest: basic-modeset-with-all-modifiers-formats
[173.753919] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[174.486578] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.754s)
[174.496619] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[174.507132] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[174.515465] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[174.528794] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[174.536997] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[174.680386] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[174.688994] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[174.702011] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[174.710649] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[174.723743] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[174.734544] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[174.745479] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[174.753700] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[174.767767] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.023s)
[174.777158] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[174.788937] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.020s)
[174.797694] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[174.810499] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[174.818994] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[174.832229] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[174.843335] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[174.853848] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[174.865143] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[174.995127] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[175.005986] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[175.016657] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[175.024881] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[175.038471] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[175.048689] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[175.059710] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[175.068742] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[175.082089] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[175.092513] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[175.103473] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[175.111722] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[175.125093] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[175.133364] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[175.146799] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[175.155086] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[175.168486] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[175.176801] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[175.320802] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s)
[175.330737] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[175.342405] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[175.351127] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[175.363802] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[175.372588] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[175.385744] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[175.394505] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[175.407507] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[175.416167] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[175.428749] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[175.437337] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[175.450418] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[175.458619] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[175.472204] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[175.480165] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[175.493675] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[175.886581] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.575s)
[176.710252] [030/133] (840s left) gem_exec_balancer (persistence)
[176.973483] Starting subtest: persistence
[177.841106] Subtest persistence: SUCCESS (0.883s)
[177.964203] [031/133] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[178.056691] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[178.061001] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[178.155577] [032/133] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[178.229978] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[178.234292] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[178.324575] [033/133] (839s left) i915_pm_rpm (gem-pread)
[180.021660] Starting subtest: gem-pread
[182.217263] Subtest gem-pread: SUCCESS (2.221s)
[182.305696] [034/133] (835s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[184.008967] Starting subtest: dpms-mode-unset-lpsp
[188.038661] Subtest dpms-mode-unset-lpsp: SUCCESS (4.054s)
[188.408021] [035/133] (829s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[188.476918] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[188.481513] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[188.665167] [036/133] (828s left) gem_exec_whisper (basic-queues-priority)
[188.731615] Starting subtest: basic-queues-priority
[212.010477] Subtest basic-queues-priority: SUCCESS (23.297s)
[212.207282] [037/133] (805s left) kms_addfb_basic (addfb25-modifier-no-flag)
[212.299403] Starting subtest: addfb25-modifier-no-flag
[212.301378] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[212.409027] [038/133] (805s left) kms_flip (dpms-off-confusion-interruptible)
[212.486505] Starting subtest: dpms-off-confusion-interruptible
[212.488829] Starting dynamic subtest: A-eDP1
[221.214199] Dynamic subtest A-eDP1: SUCCESS (8.689s)
[221.225310] Starting dynamic subtest: B-eDP1
[229.845124] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[229.855948] Starting dynamic subtest: C-eDP1
[238.480873] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[238.491619] Starting dynamic subtest: D-eDP1
[247.114370] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[247.116786] Subtest dpms-off-confusion-interruptible: SUCCESS (34.584s)
[248.240112] [039/133] (769s left) kms_flip (flip-vs-panning-vs-hang)
[248.314303] Starting subtest: flip-vs-panning-vs-hang
[248.316653] Starting dynamic subtest: A-eDP1
[298.290546] Dynamic subtest A-eDP1: SUCCESS (49.976s)
[298.304241] Starting dynamic subtest: D-eDP1
[338.351524] Dynamic subtest D-eDP1: SUCCESS (40.063s)
[338.353988] Subtest flip-vs-panning-vs-hang: SUCCESS (90.042s)
[339.519857] [040/133] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[339.615845] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[346.119994] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.509s)
[346.230413] [041/133] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[346.310758] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[353.630868] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.326s)
[353.777518] [042/133] (664s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[353.860593] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[353.864619] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[353.928855] [043/133] (663s left) gem_userptr_blits (create-destroy-unsync)
[353.996667] Subtest create-destroy-unsync: SKIP (0.000s)
[354.103748] [044/133] (663s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[354.203038] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[354.207201] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[354.314740] [045/133] (663s left) kms_psr (fbc-pr-sprite-render)
[354.395080] Starting subtest: fbc-pr-sprite-render
[354.399471] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[354.472149] [046/133] (663s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[354.546344] Starting subtest: psr2-plane-move-sf-dmg-area
[354.548920] Starting dynamic subtest: pipe-A-eDP-1
[359.082426] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.543s)
[359.092118] Starting dynamic subtest: pipe-B-eDP-1
[364.392685] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.308s)
[364.395008] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.854s)
[365.264609] [047/133] (652s left) kms_psr (psr-primary-blt)
[365.342303] Starting subtest: psr-primary-blt
[365.344576] Starting dynamic subtest: eDP-1
[367.055296] Dynamic subtest eDP-1: SUCCESS (1.713s)
[367.057682] Subtest psr-primary-blt: SUCCESS (1.714s)
[367.924210] [048/133] (650s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[368.005240] Starting subtest: fbc-psr-sprite-mmap-cpu
[368.007381] Starting dynamic subtest: eDP-1
[368.011252] Dynamic subtest eDP-1: SKIP (0.000s)
[368.015226] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[368.078970] [049/133] (650s left) i915_drm_fdinfo (memory-info-idle)
[368.120260] Starting subtest: memory-info-idle
[368.122406] Starting dynamic subtest: smem0
[368.170113] Dynamic subtest smem0: SUCCESS (0.051s)
[368.173100] Subtest memory-info-idle: SUCCESS (0.051s)
[368.245889] [050/133] (649s left) kms_plane_scaling (invalid-parameters)
[368.318192] Starting subtest: invalid-parameters
[368.320465] Starting dynamic subtest: less-than-1-height-src
[368.331226] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[368.341658] Starting dynamic subtest: less-than-1-width-src
[368.344015] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[368.346288] Subtest invalid-parameters: SUCCESS (0.028s)
[368.451638] [051/133] (649s left) gem_exec_reloc (basic-gtt-active)
[368.509210] Subtest basic-gtt-active: SKIP (0.000s)
[368.580858] [052/133] (649s left) gem_mmap_gtt (close-race)
[368.642330] Subtest close-race: SKIP (0.000s)
[368.703263] [053/133] (649s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[368.774556] Starting subtest: compare-crc-sanitycheck-nv12
[368.776812] Starting dynamic subtest: pipe-A-eDP-1
[369.443113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.669s)
[369.453207] Starting dynamic subtest: pipe-B-eDP-1
[370.703220] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s)
[370.713130] Starting dynamic subtest: pipe-C-eDP-1
[371.961100] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.256s)
[371.972106] Starting dynamic subtest: pipe-D-eDP-1
[373.196406] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[373.198700] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.423s)
[374.057406] [054/133] (644s left) api_intel_allocator (fork-simple-once)
[374.120793] Starting subtest: fork-simple-once
[374.131286] Subtest fork-simple-once: SUCCESS (0.013s)
[374.247362] [055/133] (644s left) kms_vrr (max-min)
[374.314182] Starting subtest: max-min
[374.319975] Subtest max-min: SKIP (0.000s)
[374.390022] [056/133] (644s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[374.453555] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[374.457957] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[374.541999] [057/133] (643s left) gem_exec_params (sol-reset-invalid)
[374.593699] Starting subtest: sol-reset-invalid
[374.595894] Subtest sol-reset-invalid: SUCCESS (0.002s)
[375.878359] [058/133] (642s left) kms_lease (invalid-create-leases)
[375.949624] Starting subtest: invalid-create-leases
[375.954247] Subtest invalid-create-leases: SUCCESS (0.005s)
[376.064209] [059/133] (642s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[376.124331] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[376.227659] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[376.306077] [060/133] (642s left) kms_psr (pr-primary-page-flip)
[376.384101] Starting subtest: pr-primary-page-flip
[376.388627] Subtest pr-primary-page-flip: SKIP (0.000s)
[376.456010] [061/133] (642s left) gem_exec_params (readonly)
[376.511843] Starting subtest: readonly
[376.514009] Subtest readonly: SUCCESS (0.002s)
[376.618357] [062/133] (642s left) gem_mmap_gtt (basic-copy)
[376.680259] Subtest basic-copy: SKIP (0.000s)
[376.734071] [063/133] (641s left) kms_psr (psr2-sprite-mmap-cpu)
[376.802917] Starting subtest: psr2-sprite-mmap-cpu
[376.805207] Starting dynamic subtest: eDP-1
[378.539959] Dynamic subtest eDP-1: SUCCESS (1.738s)
[378.542279] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.739s)
[379.420924] [064/133] (639s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[379.510556] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[386.542343] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.036s)
[386.665611] [065/133] (632s left) drm_read (empty-nonblock)
[386.793197] Starting subtest: empty-nonblock
[386.795376] Subtest empty-nonblock: SUCCESS (0.000s)
[386.919868] [066/133] (631s left) perf_pmu (busy-no-semaphores)
[386.957890] Starting subtest: busy-no-semaphores
[386.960202] Starting dynamic subtest: rcs0
[387.522905] Dynamic subtest rcs0: SUCCESS (0.564s)
[387.534051] Starting dynamic subtest: bcs0
[388.069101] Dynamic subtest bcs0: SUCCESS (0.544s)
[388.083711] Starting dynamic subtest: vcs0
[388.617395] Dynamic subtest vcs0: SUCCESS (0.545s)
[388.632596] Starting dynamic subtest: vcs1
[390.364175] Dynamic subtest vcs1: SUCCESS (1.725s)
[390.374576] Starting dynamic subtest: vecs0
[392.329684] Dynamic subtest vecs0: SUCCESS (1.983s)
[392.346075] Starting dynamic subtest: ccs0
[394.314475] Dynamic subtest ccs0: SUCCESS (1.983s)
[394.317489] Subtest busy-no-semaphores: SUCCESS (7.360s)
[394.431578] [067/133] (624s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[394.519593] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[394.521885] Starting dynamic subtest: pipe-A-eDP-1
[394.530895] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[394.541362] Starting dynamic subtest: pipe-B-eDP-1
[394.550262] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[394.559422] Starting dynamic subtest: pipe-C-eDP-1
[394.568201] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[394.577296] Starting dynamic subtest: pipe-D-eDP-1
[394.585741] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[394.590011] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[396.715059] [068/133] (622s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[396.796604] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[396.798914] Starting dynamic subtest: pipe-A-eDP-1
[396.821961] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[396.833508] Starting dynamic subtest: pipe-B-eDP-1
[396.855338] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[396.865705] Starting dynamic subtest: pipe-C-eDP-1
[396.888111] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[396.899630] Starting dynamic subtest: pipe-D-eDP-1
[396.922262] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[396.926402] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[398.999869] [069/133] (619s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[399.084305] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[399.086518] Starting dynamic subtest: pipe-A
[399.324630] Dynamic subtest pipe-A: SUCCESS (0.241s)
[399.335124] Starting dynamic subtest: pipe-B
[400.587814] Dynamic subtest pipe-B: SUCCESS (1.261s)
[400.598355] Starting dynamic subtest: pipe-C
[401.920510] Dynamic subtest pipe-C: SUCCESS (1.331s)
[401.930868] Starting dynamic subtest: pipe-D
[403.313734] Dynamic subtest pipe-D: SUCCESS (1.392s)
[403.315869] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.230s)
[404.451873] [070/133] (614s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[404.554700] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[404.558730] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[404.665258] [071/133] (614s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[404.780145] Starting subtest: protected-encrypted-src-copy-not-readible
[404.907486] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.129s)
[405.024759] [072/133] (614s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[405.097912] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[408.926065] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.830s)
[410.062098] [073/133] (609s left) fbdev (read)
[410.098925] Starting subtest: read
[410.842237] Subtest read: SUCCESS (0.741s)
[410.906295] [074/133] (608s left) gem_exec_parallel (basic)
[410.960686] Starting subtest: basic
[410.963032] Starting dynamic subtest: rcs0
[412.413338] Dynamic subtest rcs0: SUCCESS (1.451s)
[412.426259] Starting dynamic subtest: bcs0
[413.893187] Dynamic subtest bcs0: SUCCESS (1.478s)
[413.904708] Starting dynamic subtest: vcs0
[415.814773] Dynamic subtest vcs0: SUCCESS (1.918s)
[415.827980] Starting dynamic subtest: vcs1
[417.799182] Dynamic subtest vcs1: SUCCESS (1.981s)
[417.812629] Starting dynamic subtest: vecs0
[419.846736] Dynamic subtest vecs0: SUCCESS (2.044s)
[419.860320] Starting dynamic subtest: ccs0
[421.300320] Dynamic subtest ccs0: SUCCESS (1.453s)
[421.302898] Subtest basic: SUCCESS (10.338s)
[421.487769] [075/133] (597s left) kms_dsc (dsc-with-formats)
[421.565931] Starting subtest: dsc-with-formats
[421.604039] Subtest dsc-with-formats: SKIP (0.001s)
[421.640669] [076/133] (597s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[421.705005] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[421.709605] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[421.782833] [077/133] (597s left) kms_cursor_crc (cursor-onscreen-512x512)
[422.021596] Starting subtest: cursor-onscreen-512x512
[422.025890] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[422.195315] [078/133] (597s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[422.270294] Starting subtest: plane-lut1d-pre-ctm3x4
[422.394063] Starting dynamic subtest: pipe-A-plane-0
[422.538019] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[422.548977] Starting dynamic subtest: pipe-A-plane-1
[422.717605] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[422.729684] Starting dynamic subtest: pipe-A-plane-2
[422.871289] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[424.050809] Starting dynamic subtest: pipe-B-plane-0
[424.218765] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[424.230297] Starting dynamic subtest: pipe-B-plane-1
[424.353279] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[424.370152] Starting dynamic subtest: pipe-B-plane-2
[424.485744] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[425.671303] Starting dynamic subtest: pipe-C-plane-0
[425.806848] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[425.817057] Starting dynamic subtest: pipe-C-plane-1
[425.951927] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[425.965946] Starting dynamic subtest: pipe-C-plane-2
[426.107819] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[427.302850] Starting dynamic subtest: pipe-D-plane-0
[427.434915] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[427.445576] Starting dynamic subtest: pipe-D-plane-1
[427.579671] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[427.590201] Starting dynamic subtest: pipe-D-plane-2
[427.713074] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[428.010882] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.741s)
[428.872546] [079/133] (590s left) kms_invalid_mode (overflow-vrefresh)
[428.949894] Starting subtest: overflow-vrefresh
[428.952079] Starting dynamic subtest: pipe-A-eDP-1
[429.238010] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[429.248402] Starting dynamic subtest: pipe-B-eDP-1
[429.250412] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[429.259952] Starting dynamic subtest: pipe-C-eDP-1
[429.262298] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[429.271328] Starting dynamic subtest: pipe-D-eDP-1
[429.273293] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[429.275268] Subtest overflow-vrefresh: SUCCESS (0.294s)
[430.116616] [080/133] (589s left) kms_async_flips (invalid-async-flip-atomic)
[430.197283] Starting subtest: invalid-async-flip-atomic
[430.580572] Starting dynamic subtest: pipe-A-eDP-1
[431.355937] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.777s)
[431.720205] Starting dynamic subtest: pipe-B-eDP-1
[432.498742] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.787s)
[432.858322] Starting dynamic subtest: pipe-C-eDP-1
[433.614047] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s)
[433.965695] Starting dynamic subtest: pipe-D-eDP-1
[434.742569] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.784s)
[434.744939] Subtest invalid-async-flip-atomic: SUCCESS (4.546s)
[435.902186] [081/133] (583s left) kms_content_protection (dp-mst-type-0)
[436.024949] Starting subtest: dp-mst-type-0
[436.029505] Subtest dp-mst-type-0: SKIP (0.000s)
[436.149348] [082/133] (583s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[436.225818] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[436.230027] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[436.339645] [083/133] (583s left) kms_getfb (getfb2-into-addfb2)
[436.411002] Starting subtest: getfb2-into-addfb2
[436.413352] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[436.521758] [084/133] (583s left) i915_module_load (resize-bar)
[436.563262] Starting subtest: resize-bar
[436.569932] Subtest resize-bar: SKIP (0.006s)
[436.616341] [085/133] (583s left) kms_flip (plain-flip-fb-recreate-interruptible)
[436.695966] Starting subtest: plain-flip-fb-recreate-interruptible
[436.698294] Starting dynamic subtest: A-eDP1
[445.495304] Dynamic subtest A-eDP1: SUCCESS (8.798s)
[445.508500] Starting dynamic subtest: B-eDP1
[454.316899] Dynamic subtest B-eDP1: SUCCESS (8.818s)
[454.335425] Starting dynamic subtest: C-eDP1
[463.137890] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[463.150865] Starting dynamic subtest: D-eDP1
[471.967676] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[471.970004] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.274s)
[473.175378] [086/133] (546s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[473.254619] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[473.890409] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[474.041532] [087/133] (545s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[474.095142] Starting subtest: single-wait-for-submit-available-signaled
[474.097264] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[474.211321] [088/133] (545s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[474.283037] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[474.285181] Starting dynamic subtest: pipe-A-default-mode
[475.404919] Dynamic subtest pipe-A-default-mode: SKIP (1.119s)
[475.409115] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.121s)
[475.550759] [089/133] (544s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[475.652986] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[475.657495] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[475.810934] [090/133] (544s left) gem_exec_schedule (preempt-queue)
[475.890209] Subtest preempt-queue: SKIP (0.000s)
[476.176908] [091/133] (543s left) kms_cdclk (mode-transition-all-outputs)
[476.259911] Starting subtest: mode-transition-all-outputs
[476.548740] Subtest mode-transition-all-outputs: SKIP (0.287s)
[477.409412] [092/133] (542s left) gem_workarounds (reset-fd)
[477.504139] Starting subtest: reset-fd
[477.687185] Subtest reset-fd: SUCCESS (0.186s)
[477.803552] [093/133] (542s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[477.877048] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[477.881011] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[477.978082] [094/133] (542s left) gem_close_race (multigpu-basic-threads)
[478.039337] Starting subtest: multigpu-basic-threads
[478.043572] Subtest multigpu-basic-threads: SKIP (0.000s)
[478.273712] [095/133] (541s left) gem_exec_params (no-bsd)
[478.339910] Starting subtest: no-bsd
[478.342305] Subtest no-bsd: SUCCESS (0.003s)
[479.890034] [096/133] (540s left) kms_plane_multiple (2x-tiling-yf)
[479.960522] Starting subtest: 2x-tiling-yf
[479.965226] Subtest 2x-tiling-yf: SKIP (0.000s)
[480.035783] [097/133] (540s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[480.093481] Starting subtest: invalid-bsd2-flag-on-blt
[480.095592] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[480.191123] [098/133] (539s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[480.270296] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[485.217573] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.952s)
[486.410372] [099/133] (533s left) kms_pm_rpm (pm-tiling)
[488.012367] Starting subtest: pm-tiling
[488.017389] Subtest pm-tiling: SKIP (0.000s)
[488.630521] [100/133] (531s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[488.682719] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[488.786490] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[488.863976] [101/133] (531s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[488.925841] Starting subtest: invalid-multi-wait-unsubmitted
[488.927805] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[489.018411] [102/133] (531s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[489.090975] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[489.095042] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[489.170166] [103/133] (531s left) kms_chamelium_frames (hdmi-crc-single)
[489.540260] Subtest hdmi-crc-single: SKIP (0.000s)
[490.350370] [104/133] (530s left) syncobj_wait (multi-wait-submitted-signaled)
[490.404516] Starting subtest: multi-wait-submitted-signaled
[490.406831] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[490.496980] [105/133] (529s left) gem_userptr_blits (coherency-sync)
[490.551501] Starting subtest: coherency-sync
[490.945150] Subtest coherency-sync: SKIP (0.356s)
[491.048735] [106/133] (529s left) kms_vblank (ts-continuation-idle-hang)
[491.164234] Starting subtest: ts-continuation-idle-hang
[491.166416] Starting dynamic subtest: pipe-A-eDP-1
[517.664072] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.498s)
[517.690496] Starting dynamic subtest: pipe-D-eDP-1
[542.590720] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.927s)
[542.592886] Subtest ts-continuation-idle-hang: SUCCESS (51.430s)
[543.413618] [107/133] (477s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[543.492205] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[543.496494] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[543.605835] [108/133] (477s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[543.718723] Starting subtest: 2x-cursor-vs-flip-legacy
[543.722985] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[543.865290] [109/133] (476s left) gem_exec_balancer (parallel-balancer)
[544.127056] Starting subtest: parallel-balancer
[545.020963] Subtest parallel-balancer: SUCCESS (0.894s)
[545.128430] [110/133] (475s left) perf (stress-open-close)
[545.268949] Starting subtest: stress-open-close
[545.271139] Starting dynamic subtest: 0-rcs0
[547.432183] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[547.445474] Starting dynamic subtest: 1-vecs0
[549.594323] Dynamic subtest 1-vecs0: SUCCESS (2.162s)
[549.596285] Subtest stress-open-close: SUCCESS (4.329s)
[549.634345] [111/133] (471s left) gem_ctx_shared (create-shared-gtt)
[549.696220] Starting subtest: create-shared-gtt
[551.903483] Subtest create-shared-gtt: SUCCESS (2.152s)
[552.148246] [112/133] (468s left) kms_addfb_basic (small-bo)
[552.229485] Starting subtest: small-bo
[552.231690] Subtest small-bo: SUCCESS (0.000s)
[552.335389] [113/133] (468s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[552.409315] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[552.411529] Starting dynamic subtest: pipe-A-eDP-1
[552.431849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[552.445213] Starting dynamic subtest: pipe-B-eDP-1
[552.464596] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[552.475813] Starting dynamic subtest: pipe-C-eDP-1
[552.494989] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[552.505362] Starting dynamic subtest: pipe-D-eDP-1
[552.524494] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[552.526357] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[554.613056] [114/133] (466s left) syncobj_timeline (wait-delayed-signal)
[554.672998] Starting subtest: wait-delayed-signal
[554.773425] Subtest wait-delayed-signal: SUCCESS (0.102s)
[554.857810] [115/133] (466s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[554.934580] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[554.938970] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[555.033678] [116/133] (465s left) gem_mmap_gtt (hang-user)
[555.089591] Subtest hang-user: SKIP (0.000s)
[555.154938] [117/133] (465s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[555.207031] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[555.314531] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[555.394183] [118/133] (465s left) gem_tiled_wc
[555.530869] [119/133] (465s left) i915_pm_rps (thresholds-park)
[555.581215] Starting subtest: thresholds-park
[555.585720] Subtest thresholds-park: SKIP (0.000s)
[555.657417] [120/133] (465s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[555.731652] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[555.735540] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[555.826069] [121/133] (465s left) kms_busy (extended-pageflip-hang-newfb)
[555.908263] Starting subtest: extended-pageflip-hang-newfb
[555.910508] Starting dynamic subtest: pipe-A
[582.617630] Dynamic subtest pipe-A: SUCCESS (26.711s)
[582.629019] Starting dynamic subtest: pipe-D
[606.633601] Dynamic subtest pipe-D: SUCCESS (24.017s)
[606.635830] Subtest extended-pageflip-hang-newfb: SUCCESS (50.734s)
[607.436861] [122/133] (413s left) gem_spin_batch (engines)
[607.498776] Starting subtest: engines
[607.501092] Starting dynamic subtest: rcs0
[610.736789] Dynamic subtest rcs0: SUCCESS (3.234s)
[610.749739] Starting dynamic subtest: bcs0
[614.023746] Dynamic subtest bcs0: SUCCESS (3.233s)
[614.036517] Starting dynamic subtest: vcs0
[617.257635] Dynamic subtest vcs0: SUCCESS (3.232s)
[617.273715] Starting dynamic subtest: vcs1
[620.492640] Dynamic subtest vcs1: SUCCESS (3.233s)
[620.505105] Starting dynamic subtest: vecs0
[623.729321] Dynamic subtest vecs0: SUCCESS (3.233s)
[623.743231] Starting dynamic subtest: ccs0
[626.964462] Dynamic subtest ccs0: SUCCESS (3.233s)
[626.966878] Subtest engines: SUCCESS (19.415s)
[627.131032] [123/133] (394s left) kms_sequence (get-busy)
[627.204511] Starting subtest: get-busy
[627.206369] Starting dynamic subtest: pipe-A-eDP-1
[629.161128] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.956s)
[629.172569] Starting dynamic subtest: pipe-B-eDP-1
[631.734254] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.573s)
[631.748944] Starting dynamic subtest: pipe-C-eDP-1
[634.345044] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s)
[634.357230] Starting dynamic subtest: pipe-D-eDP-1
[636.963190] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.617s)
[636.965160] Subtest get-busy: SUCCESS (9.760s)
[637.757033] [124/133] (383s left) gem_exec_reloc (basic-cpu-read)
[637.828887] Subtest basic-cpu-read: SKIP (0.000s)
[637.907275] [125/133] (383s left) gem_exec_whisper (basic-forked-all)
[637.960858] Starting subtest: basic-forked-all
[651.728126] Subtest basic-forked-all: SUCCESS (13.769s)
[651.912872] [126/133] (369s left) kms_flip (basic-flip-vs-wf_vblank)
[651.983669] Starting subtest: basic-flip-vs-wf_vblank
[651.985884] Starting dynamic subtest: A-eDP1
[653.895859] Dynamic subtest A-eDP1: SUCCESS (1.913s)
[653.909413] Starting dynamic subtest: B-eDP1
[655.835365] Dynamic subtest B-eDP1: SUCCESS (1.937s)
[655.846310] Starting dynamic subtest: C-eDP1
[657.753929] Dynamic subtest C-eDP1: SUCCESS (1.915s)
[657.767971] Starting dynamic subtest: D-eDP1
[659.691082] Dynamic subtest D-eDP1: SUCCESS (1.936s)
[659.696157] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.710s)
[660.927968] [127/133] (360s left) core_auth (getclient-simple)
[660.971527] Starting subtest: getclient-simple
[660.993121] Subtest getclient-simple: SUCCESS (0.020s)
[661.100382] [128/133] (360s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[661.178594] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[661.182941] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[661.285247] [129/133] (360s left) perf (low-oa-exponent-permissions)
[661.372989] Starting subtest: low-oa-exponent-permissions
[661.405061] Subtest low-oa-exponent-permissions: SUCCESS (0.033s)
[661.447998] [130/133] (360s left) gem_vm_create (execbuf)
[661.517461] Starting subtest: execbuf
[661.520958] Subtest execbuf: SUCCESS (0.006s)
[661.661994] [131/133] (359s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[661.739160] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[662.705854] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.966s)
[662.832417] [132/133] (358s left) gem_mmap_gtt (basic-small-bo)
[662.884258] Subtest basic-small-bo: SKIP (0.000s)
[662.949834] [133/133] (358s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[663.024403] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[663.027928] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[663.110353] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: prime_mmap
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: gem_ctx_isolation
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_rotation_crc
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: gem_exec_flush
results: parsing output: 11/ for test: gem_ctx_bad_destroy
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: gem_ctx_shared
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: core_getversion
results: parsing output: 23/ for test: gem_pread
results: parsing output: 24/ for test: gen9_exec_parse
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rpm
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: gem_render_copy
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_flip
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: i915_drm_fdinfo
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: kms_pipe_crc_basic
results: parsing output: 53/ for test: api_intel_allocator
results: parsing output: 54/ for test: kms_vrr
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: drm_read
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_pxp
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: fbdev
results: parsing output: 73/ for test: gem_exec_parallel
results: parsing output: 74/ for test: kms_dsc
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_color_pipeline
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: kms_async_flips
results: parsing output: 80/ for test: kms_content_protection
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_getfb
results: parsing output: 83/ for test: i915_module_load
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_cdclk
results: parsing output: 91/ for test: gem_workarounds
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_close_race
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_plane_multiple
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_chamelium_frames
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: gem_ctx_shared
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_tiled_wc
results: parsing output: 118/ for test: i915_pm_rps
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_busy
results: parsing output: 121/ for test: gem_spin_batch
results: parsing output: 122/ for test: kms_sequence
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: core_auth
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_vm_create
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.