[59.961722] Initializing watchdogs
[59.961770]   /dev/watchdog0
[59.975639] [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.980045] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.982740] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.985941] [001/133] (960s left) kms_flip_event_leak (basic)
[60.096858] Starting subtest: basic
[60.098777] Starting dynamic subtest: pipe-A-eDP-1
[60.552973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[60.561356] Starting dynamic subtest: pipe-B-eDP-1
[61.703407] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s)
[61.711368] Starting dynamic subtest: pipe-C-eDP-1
[62.821985] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[62.830122] Starting dynamic subtest: pipe-D-eDP-1
[63.950770] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[63.953265] Subtest basic: SUCCESS (3.841s)
[64.813215] [002/133] (955s left) kms_cursor_crc (cursor-random-256x85)
[65.064160] Starting subtest: cursor-random-256x85
[65.112298] Subtest cursor-random-256x85: SKIP (0.042s)
[65.274661] [003/133] (955s left) gem_create (create-massive)
[65.343837] Starting subtest: create-massive
[65.345843] Subtest create-massive: SUCCESS (0.000s)
[65.558762] [004/133] (955s left) kms_addfb_basic (invalid-set-prop-any)
[65.626954] Starting subtest: invalid-set-prop-any
[65.629041] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[65.754567] [005/133] (954s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[66.146107] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[66.935509] [006/133] (953s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[67.165995] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[67.170879] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[67.397692] [007/133] (953s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[67.567393] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[67.569863] Starting dynamic subtest: pipe-A-eDP-1
[68.060745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s)
[68.068573] Starting dynamic subtest: pipe-B-eDP-1
[69.477587] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.414s)
[69.486279] Starting dynamic subtest: pipe-C-eDP-1
[70.835228] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.354s)
[70.843344] Starting dynamic subtest: pipe-D-eDP-1
[72.174579] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[72.176880] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.573s)
[73.366924] [008/133] (947s left) gem_exec_schedule (u-submit-golden-slice)
[73.443142] Starting subtest: u-submit-golden-slice
[73.445364] Starting dynamic subtest: rcs0
[73.471059] Dynamic subtest rcs0: SUCCESS (0.035s)
[73.482100] Starting dynamic subtest: bcs0
[73.499808] Dynamic subtest bcs0: SUCCESS (0.028s)
[73.508066] Starting dynamic subtest: vcs0
[73.537301] Dynamic subtest vcs0: SUCCESS (0.037s)
[73.544509] Starting dynamic subtest: vcs1
[73.567971] Dynamic subtest vcs1: SUCCESS (0.030s)
[73.576242] Starting dynamic subtest: vecs0
[73.597930] Dynamic subtest vecs0: SUCCESS (0.030s)
[73.606340] Starting dynamic subtest: ccs0
[73.630360] Dynamic subtest ccs0: SUCCESS (0.032s)
[73.632647] Subtest u-submit-golden-slice: SUCCESS (0.194s)
[74.982538] [009/133] (945s left) kms_fbcon_fbt (fbc)
[75.030681] Starting subtest: fbc
[81.405740] Subtest fbc: SUCCESS (6.370s)
[82.478693] [010/133] (938s left) gem_ccs (block-copy-uncompressed)
[82.552884] Starting subtest: block-copy-uncompressed
[82.555371] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[82.574081] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[82.583796] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[82.590106] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[82.597237] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[82.606497] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[82.613572] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[82.623662] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[82.626031] Subtest block-copy-uncompressed: SUCCESS (0.071s)
[82.746998] [011/133] (938s left) kms_hdr (bpc-switch-suspend)
[82.852817] Starting subtest: bpc-switch-suspend
[83.884509] Starting dynamic subtest: pipe-A-eDP-1
[103.411596] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.582s)
[103.414122] Subtest bpc-switch-suspend: SUCCESS (5.616s)
[103.526131] [012/133] (917s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[103.632947] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[103.635464] Starting dynamic subtest: pipe-A-eDP-1
[103.661763] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.670668] Starting dynamic subtest: pipe-B-eDP-1
[103.695692] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.703809] Starting dynamic subtest: pipe-C-eDP-1
[103.728773] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.737281] Starting dynamic subtest: pipe-D-eDP-1
[103.762379] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.766653] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[105.889603] [013/133] (915s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[106.004547] Starting subtest: basic-flip-after-cursor-atomic
[106.938234] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.917s)
[107.742015] [014/133] (913s left) kms_chamelium_edid (dp-edid-resolution-list)
[108.127962] Subtest dp-edid-resolution-list: SKIP (0.000s)
[108.969239] [015/133] (912s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[109.070281] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[109.072701] Starting dynamic subtest: pipe-A
[109.438524] Dynamic subtest pipe-A: SUCCESS (0.366s)
[109.448413] Starting dynamic subtest: pipe-B
[110.927435] Dynamic subtest pipe-B: SUCCESS (1.472s)
[110.937035] Starting dynamic subtest: pipe-C
[112.346695] Dynamic subtest pipe-C: SUCCESS (1.405s)
[112.356247] Starting dynamic subtest: pipe-D
[113.788185] Dynamic subtest pipe-D: SUCCESS (1.430s)
[113.790480] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.676s)
[114.950057] [016/133] (906s left) kms_plane_multiple (tiling-x)
[115.048973] Starting subtest: tiling-x
[115.052245] Starting dynamic subtest: pipe-A-eDP-1
[118.903712] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.835s)
[118.913279] Starting dynamic subtest: pipe-B-eDP-1
[123.263111] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.345s)
[123.272668] Starting dynamic subtest: pipe-C-eDP-1
[127.600353] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.328s)
[127.609738] Starting dynamic subtest: pipe-D-eDP-1
[131.916209] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.310s)
[131.918417] Subtest tiling-x: SUCCESS (16.824s)
[132.723358] [017/133] (888s left) kms_atomic_interruptible (universal-setplane-primary)
[132.819049] Starting subtest: universal-setplane-primary
[132.821318] Starting dynamic subtest: pipe-A-eDP-1
[140.243429] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.419s)
[140.245448] Subtest universal-setplane-primary: SUCCESS (7.420s)
[141.081475] [018/133] (880s left) gem_exec_params (no-blt)
[141.146273] Starting subtest: no-blt
[141.148620] Subtest no-blt: SUCCESS (0.002s)
[141.271867] [019/133] (879s left) gem_exec_reloc (basic-gtt-cpu)
[141.337945] Subtest basic-gtt-cpu: SKIP (0.000s)
[141.403705] [020/133] (879s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[141.498541] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[141.503023] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[142.614577] [021/133] (878s left) gem_exec_fence (invalid-timeline-fence-array)
[143.175202] Starting subtest: invalid-timeline-fence-array
[143.180726] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[144.882677] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[144.885882] [022/133] (876s left) kms_cursor_crc (cursor-onscreen-64x64)
[145.075267] Starting subtest: cursor-onscreen-64x64
[145.077366] Starting dynamic subtest: pipe-A-eDP-1
[147.187159] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s)
[147.212351] Starting dynamic subtest: pipe-D-eDP-1
[150.002281] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.794s)
[150.004479] Subtest cursor-onscreen-64x64: SUCCESS (4.926s)
[150.789489] [023/133] (870s left) gem_ctx_persistence (process)
[150.848496] Starting subtest: process
[150.999950] Subtest process: SUCCESS (0.151s)
[151.076638] [024/133] (870s left) kms_addfb_basic (too-wide)
[151.170304] Starting subtest: too-wide
[151.172161] Subtest too-wide: SUCCESS (0.000s)
[151.294799] [025/133] (870s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[151.392901] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[151.396786] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[151.470094] [026/133] (870s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[151.570297] Starting subtest: plane-upscale-20x20-with-pixel-format
[151.572499] Starting dynamic subtest: pipe-A
[152.629110] Dynamic subtest pipe-A: SUCCESS (1.061s)
[152.637898] Starting dynamic subtest: pipe-B
[154.702826] Dynamic subtest pipe-B: SUCCESS (2.072s)
[154.711624] Starting dynamic subtest: pipe-C
[155.901288] Dynamic subtest pipe-C: SUCCESS (1.197s)
[155.912338] Starting dynamic subtest: pipe-D
[157.053287] Dynamic subtest pipe-D: SUCCESS (1.150s)
[157.055534] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.484s)
[158.237959] [027/133] (863s left) kms_pm_rpm (drm-resources-equal)
[159.976504] Starting subtest: drm-resources-equal
[165.135702] Subtest drm-resources-equal: SUCCESS (5.157s)
[165.221672] [028/133] (856s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[165.339850] Starting subtest: x-tiled-16bpp-rotate-0
[166.563366] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.223s)
[166.697247] [029/133] (854s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[166.756462] Starting subtest: invalid-single-wait-unsubmitted
[166.758845] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[166.873156] [030/133] (854s left) gem_readwrite (read-bad-handle)
[166.920362] Subtest read-bad-handle: SKIP (0.000s)
[166.979958] [031/133] (854s left) kms_big_fb (linear-32bpp-rotate-270)
[167.078753] Starting subtest: linear-32bpp-rotate-270
[167.104573] Subtest linear-32bpp-rotate-270: SKIP (0.024s)
[167.215593] [032/133] (854s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[167.306797] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[167.310048] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[167.391054] [033/133] (854s left) kms_content_protection (srm)
[167.520694] Starting subtest: srm
[167.527364] Subtest srm: SKIP (0.002s)
[167.639283] [034/133] (854s left) gem_userptr_blits (coherency-unsync)
[167.694905] Subtest coherency-unsync: SKIP (0.000s)
[167.812342] [035/133] (854s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[167.904225] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[167.907613] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[167.974542] [036/133] (853s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[168.062057] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[168.071228] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[168.154827] [037/133] (853s left) core_setmaster_vs_auth
[168.325878] [038/133] (853s left) vgem_basic (bad-fence)
[168.366370] Starting subtest: bad-fence
[168.368296] Subtest bad-fence: SUCCESS (0.000s)
[168.439509] [039/133] (853s left) syncobj_wait (wait-for-submit-complex)
[168.490475] Starting subtest: wait-for-submit-complex
[168.551404] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[168.638961] [040/133] (853s left) kms_pm_rpm (i2c)
[170.167576] Starting subtest: i2c
[175.850828] Subtest i2c: SUCCESS (5.678s)
[175.940922] [041/133] (846s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[176.048172] Starting subtest: 2x-long-flip-vs-cursor-atomic
[176.052661] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[176.190754] [042/133] (845s left) api_intel_bb (render)
[176.247679] Starting subtest: render
[176.249613] Starting dynamic subtest: render-none-512
[176.378239] Dynamic subtest render-none-512: SUCCESS (0.130s)
[176.387594] Starting dynamic subtest: render-none-1024
[176.748881] Dynamic subtest render-none-1024: SUCCESS (0.369s)
[176.758291] Starting dynamic subtest: render-x-512
[176.833816] Dynamic subtest render-x-512: SUCCESS (0.085s)
[176.844039] Starting dynamic subtest: render-x-1024
[177.170355] Dynamic subtest render-x-1024: SUCCESS (0.335s)
[177.181570] Starting dynamic subtest: render-y-512
[177.257600] Dynamic subtest render-y-512: SUCCESS (0.085s)
[177.268227] Starting dynamic subtest: render-y-1024
[177.587795] Dynamic subtest render-y-1024: SUCCESS (0.330s)
[177.590605] Subtest render: SUCCESS (1.341s)
[177.703092] [043/133] (844s left) kms_flip (nonexisting-fb-interruptible)
[177.816302] Starting subtest: nonexisting-fb-interruptible
[177.818605] Starting dynamic subtest: A-eDP1
[179.021678] Dynamic subtest A-eDP1: SUCCESS (1.204s)
[179.033920] Starting dynamic subtest: B-eDP1
[180.151311] Dynamic subtest B-eDP1: SUCCESS (1.126s)
[180.162901] Starting dynamic subtest: C-eDP1
[181.287628] Dynamic subtest C-eDP1: SUCCESS (1.132s)
[181.299054] Starting dynamic subtest: D-eDP1
[182.425399] Dynamic subtest D-eDP1: SUCCESS (1.135s)
[182.430353] Subtest nonexisting-fb-interruptible: SUCCESS (4.613s)
[183.599973] [044/133] (838s left) kms_psr (pr-cursor-plane-move)
[183.692151] Starting subtest: pr-cursor-plane-move
[183.696435] Subtest pr-cursor-plane-move: SKIP (0.000s)
[183.768824] [045/133] (838s left) i915_hangman (engine-engine-error)
[183.836229] Starting subtest: engine-engine-error
[183.838151] Starting dynamic subtest: rcs0
[185.794752] Dynamic subtest rcs0: SUCCESS (1.957s)
[185.806061] Starting dynamic subtest: bcs0
[187.776297] Dynamic subtest bcs0: SUCCESS (1.977s)
[187.787594] Starting dynamic subtest: vcs0
[189.761878] Dynamic subtest vcs0: SUCCESS (1.982s)
[189.773701] Starting dynamic subtest: vcs1
[191.807465] Dynamic subtest vcs1: SUCCESS (2.042s)
[191.819336] Starting dynamic subtest: vecs0
[193.792544] Dynamic subtest vecs0: SUCCESS (1.981s)
[193.804101] Starting dynamic subtest: ccs0
[195.776788] Dynamic subtest ccs0: SUCCESS (1.981s)
[195.779638] Subtest engine-engine-error: SUCCESS (11.936s)
[195.903468] [046/133] (826s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[196.029246] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[205.049882] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.020s)
[205.845942] [047/133] (816s left) gem_exec_schedule (deep)
[206.045343] Starting subtest: deep
[206.047855] Starting dynamic subtest: rcs0
[211.095431] Dynamic subtest rcs0: SKIP (5.046s)
[211.108020] Starting dynamic subtest: vcs0
[221.291587] Dynamic subtest vcs0: SUCCESS (10.201s)
[221.305360] Starting dynamic subtest: vcs1
[233.120017] Dynamic subtest vcs1: SUCCESS (11.827s)
[233.133282] Starting dynamic subtest: vecs0
[245.018247] Dynamic subtest vecs0: SUCCESS (11.895s)
[245.031965] Starting dynamic subtest: ccs0
[257.001360] Dynamic subtest ccs0: SUCCESS (11.978s)
[257.003889] Subtest deep: SUCCESS (50.952s)
[258.992794] [048/133] (763s left) gem_linear_blits (normal)
[259.429604] Starting subtest: normal
[264.086654] Subtest normal: SUCCESS (4.653s)
[264.309762] [049/133] (758s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[264.471838] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[271.175534] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.704s)
[271.309999] [050/133] (751s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[271.387086] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[271.493797] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[271.572779] [051/133] (750s left) gem_mmap_offset (partial-remap)
[271.641027] Starting subtest: partial-remap
[271.642928] Starting dynamic subtest: smem0
[271.651321] Dynamic subtest smem0: SUCCESS (0.004s)
[271.653219] Subtest partial-remap: SUCCESS (0.005s)
[271.742814] [052/133] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[271.843073] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[271.847511] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[271.961328] [053/133] (750s left) i915_drm_fdinfo (idle)
[272.006332] Starting subtest: idle
[272.008728] Starting dynamic subtest: rcs0
[272.585608] Dynamic subtest rcs0: SUCCESS (0.579s)
[272.597774] Starting dynamic subtest: bcs0
[273.096535] Dynamic subtest bcs0: SUCCESS (0.503s)
[273.107812] Starting dynamic subtest: vcs0
[273.599447] Dynamic subtest vcs0: SUCCESS (0.504s)
[273.611114] Starting dynamic subtest: vcs1
[274.105590] Dynamic subtest vcs1: SUCCESS (0.503s)
[274.115530] Starting dynamic subtest: vecs0
[274.611312] Dynamic subtest vecs0: SUCCESS (0.503s)
[274.620994] Starting dynamic subtest: ccs0
[275.117122] Dynamic subtest ccs0: SUCCESS (0.503s)
[275.119873] Subtest idle: SUCCESS (3.110s)
[275.191977] [054/133] (747s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[275.298403] Starting subtest: fbc-pr-cursor-plane-update-sf
[275.302964] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[275.370624] [055/133] (747s left) kms_psr (fbc-pr-cursor-render)
[275.462281] Starting subtest: fbc-pr-cursor-render
[275.466612] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[275.551360] [056/133] (747s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[275.649657] Starting subtest: fbcpsr-tiling-linear
[282.288973] Subtest fbcpsr-tiling-linear: SUCCESS (6.641s)
[282.423268] [057/133] (740s left) gem_ctx_isolation (preservation-s3)
[282.492840] Starting subtest: preservation-S3
[282.495050] Starting dynamic subtest: rcs0
[298.301251] Dynamic subtest rcs0: SUCCESS (1.301s)
[298.314372] Starting dynamic subtest: bcs0
[314.307101] Dynamic subtest bcs0: SUCCESS (1.281s)
[314.319740] Starting dynamic subtest: vcs0
[330.296185] Dynamic subtest vcs0: SUCCESS (2.743s)
[330.307544] Starting dynamic subtest: vcs1
[348.328772] Dynamic subtest vcs1: SUCCESS (4.913s)
[348.341839] Starting dynamic subtest: vecs0
[366.333127] Dynamic subtest vecs0: SUCCESS (4.904s)
[366.345624] Starting dynamic subtest: ccs0
[384.319519] Dynamic subtest ccs0: SUCCESS (3.206s)
[384.324590] Subtest preservation-S3: SUCCESS (18.354s)
[384.557309] [058/133] (638s left) gem_exec_schedule (semaphore-power)
[384.773627] Subtest semaphore-power: SKIP (0.000s)
[384.961629] [059/133] (637s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[385.069258] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[385.074417] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[385.173644] [060/133] (637s left) i915_pm_rps (reset)
[385.236052] Starting subtest: reset
[393.706572] Subtest reset: SUCCESS (8.339s)
[393.820936] [061/133] (629s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[393.932588] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[394.662519] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.726s)
[394.823125] [062/133] (628s left) gem_softpin (evict-active-interruptible)
[394.881624] Starting subtest: evict-active-interruptible
[394.884857] Subtest evict-active-interruptible: SUCCESS (0.007s)
[395.032766] [063/133] (628s left) kms_debugfs (display-on-read-all)
[395.120086] Starting subtest: display-on-read-all
[395.289412] Subtest display-on-read-all: SUCCESS (0.167s)
[395.415349] [064/133] (627s left) kms_psr (fbc-psr2-no-drrs)
[395.512351] Starting subtest: fbc-psr2-no-drrs
[395.515023] Starting dynamic subtest: eDP-1
[395.520324] Dynamic subtest eDP-1: SKIP (0.000s)
[395.525490] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[395.587946] [065/133] (627s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[395.683966] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[395.685963] Starting dynamic subtest: pipe-A-eDP-1
[395.705598] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[395.715372] Starting dynamic subtest: pipe-B-eDP-1
[395.736564] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[395.745378] Starting dynamic subtest: pipe-C-eDP-1
[395.765254] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[395.774339] Starting dynamic subtest: pipe-D-eDP-1
[395.796389] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[395.800873] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[397.988360] [066/133] (625s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[398.044443] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[398.150288] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[398.240363] [067/133] (624s left) gem_exec_balancer (parallel-ordering)
[398.507515] Starting subtest: parallel-ordering
[399.462930] Subtest parallel-ordering: SUCCESS (0.954s)
[399.590649] [068/133] (623s left) kms_async_flips (crc)
[399.682176] Starting subtest: crc
[400.054638] Starting dynamic subtest: pipe-A-eDP-1
[403.017434] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.951s)
[403.407157] Starting dynamic subtest: pipe-B-eDP-1
[406.280374] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.877s)
[406.669573] Starting dynamic subtest: pipe-C-eDP-1
[409.595292] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.932s)
[409.976188] Starting dynamic subtest: pipe-D-eDP-1
[412.809919] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.840s)
[412.812373] Subtest crc: SUCCESS (13.101s)
[413.992694] [069/133] (609s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[414.062468] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[414.164470] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[414.267926] [070/133] (609s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[414.353822] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[414.359235] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[414.425905] [071/133] (608s left) gem_exec_fence (basic-busy-all)
[414.503340] Starting subtest: basic-busy-all
[414.595868] Subtest basic-busy-all: SUCCESS (0.094s)
[416.059295] [072/133] (607s left) gem_spin_batch (resubmit-new-all)
[416.122667] Starting subtest: resubmit-new-all
[416.124948] Starting dynamic subtest: rcs0
[416.135379] Dynamic subtest rcs0: SUCCESS (0.016s)
[416.147356] Starting dynamic subtest: bcs0
[416.149605] Dynamic subtest bcs0: SUCCESS (0.009s)
[416.159355] Starting dynamic subtest: vcs0
[416.162022] Dynamic subtest vcs0: SUCCESS (0.009s)
[416.171940] Starting dynamic subtest: vcs1
[416.174198] Dynamic subtest vcs1: SUCCESS (0.010s)
[416.184486] Starting dynamic subtest: vecs0
[416.187715] Dynamic subtest vecs0: SUCCESS (0.009s)
[416.196971] Starting dynamic subtest: ccs0
[416.199399] Dynamic subtest ccs0: SUCCESS (0.010s)
[416.201677] Subtest resubmit-new-all: SUCCESS (0.068s)
[418.005165] [073/133] (605s left) perf_pmu (busy-accuracy-50)
[418.049742] Starting subtest: busy-accuracy-50
[418.052576] Starting dynamic subtest: rcs0
[419.598161] Dynamic subtest rcs0: SUCCESS (1.548s)
[419.610525] Starting dynamic subtest: bcs0
[421.146050] Dynamic subtest bcs0: SUCCESS (1.546s)
[421.157727] Starting dynamic subtest: vcs0
[422.689439] Dynamic subtest vcs0: SUCCESS (1.542s)
[422.700321] Starting dynamic subtest: vcs1
[424.234368] Dynamic subtest vcs1: SUCCESS (1.542s)
[424.246775] Starting dynamic subtest: vecs0
[425.778450] Dynamic subtest vecs0: SUCCESS (1.541s)
[425.790164] Starting dynamic subtest: ccs0
[427.330348] Dynamic subtest ccs0: SUCCESS (1.550s)
[427.333430] Subtest busy-accuracy-50: SUCCESS (9.283s)
[427.445880] [074/133] (596s left) syncobj_timeline (wait-all-for-submit-snapshot)
[427.491258] Starting subtest: wait-all-for-submit-snapshot
[427.573177] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[427.653095] [075/133] (595s left) kms_lease (lease-unleased-connector)
[427.744105] Starting subtest: lease-unleased-connector
[427.746493] Starting dynamic subtest: pipe-A-eDP-1
[427.751874] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[427.763393] Starting dynamic subtest: pipe-B-eDP-1
[427.766222] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[427.777621] Starting dynamic subtest: pipe-C-eDP-1
[427.780454] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[427.790977] Starting dynamic subtest: pipe-D-eDP-1
[427.793475] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[427.796212] Subtest lease-unleased-connector: SUCCESS (0.032s)
[427.863753] [076/133] (595s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[427.922842] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[427.925398] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[428.025024] [077/133] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[428.112442] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[428.117476] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[428.191238] [078/133] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[428.277369] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[428.282458] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[428.377938] [079/133] (595s left) gem_userptr_blits (dmabuf-unsync)
[428.458082] Subtest dmabuf-unsync: SKIP (0.000s)
[428.578170] [080/133] (595s left) kms_addfb_basic (small-bo)
[428.674683] Starting subtest: small-bo
[428.677340] Subtest small-bo: SUCCESS (0.000s)
[428.784367] [081/133] (595s left) kms_dsc (dsc-with-output-formats)
[428.875303] Starting subtest: dsc-with-output-formats
[428.898200] Subtest dsc-with-output-formats: SKIP (0.000s)
[428.948706] [082/133] (594s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[429.054273] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[429.058585] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[429.125166] [083/133] (594s left) gem_userptr_blits (unsync-unmap-after-close)
[429.177231] Subtest unsync-unmap-after-close: SKIP (0.000s)
[429.291653] [084/133] (594s left) gem_madvise (dontneed-before-mmap)
[429.321529] Starting subtest: dontneed-before-mmap
[429.341149] Subtest dontneed-before-mmap: SUCCESS (0.019s)
[429.441903] [085/133] (594s left) kms_atomic_transition (modeset-transition-nonblocking)
[429.521816] Starting subtest: modeset-transition-nonblocking
[429.524024] Starting dynamic subtest: 1x-outputs
[440.600438] Dynamic subtest 1x-outputs: SUCCESS (11.076s)
[440.603481] Subtest modeset-transition-nonblocking: SUCCESS (11.078s)
[441.466050] [086/133] (582s left) kms_flip (2x-plain-flip)
[441.563314] Starting subtest: 2x-plain-flip
[441.573689] Subtest 2x-plain-flip: SKIP (0.010s)
[441.659930] [087/133] (582s left) gen7_exec_parse (basic-allowed)
[441.722403] Subtest basic-allowed: SKIP (0.000s)
[441.801787] [088/133] (582s left) gen9_exec_parse (bb-chained)
[441.864726] Subtest bb-chained: SKIP (0.000s)
[441.940003] [089/133] (582s left) kms_cursor_edge_walk (128x128-top-edge)
[442.039618] Starting subtest: 128x128-top-edge
[442.041899] Starting dynamic subtest: pipe-A-eDP-1
[445.545472] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.504s)
[445.556184] Starting dynamic subtest: pipe-D-eDP-1
[448.681510] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[448.684394] Subtest 128x128-top-edge: SUCCESS (6.639s)
[449.478594] [090/133] (574s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[449.584655] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[450.308922] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.726s)
[450.474853] [091/133] (573s left) gem_exec_reloc (basic-cpu-read-active)
[450.537780] Subtest basic-cpu-read-active: SKIP (0.000s)
[450.616050] [092/133] (573s left) kms_plane_alpha_blend (constant-alpha-mid)
[450.710473] Starting subtest: constant-alpha-mid
[451.006574] Starting dynamic subtest: pipe-A-eDP-1
[451.774601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.766s)
[451.786367] Starting dynamic subtest: pipe-D-eDP-1
[453.254707] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.477s)
[453.257618] Subtest constant-alpha-mid: SUCCESS (2.543s)
[454.062576] [093/133] (570s left) gem_pxp (protected-raw-src-copy-not-readible)
[454.177443] Starting subtest: protected-raw-src-copy-not-readible
[454.236075] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[454.352499] [094/133] (570s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[454.459249] Starting subtest: psr-rgb101010-draw-mmap-cpu
[461.377762] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.919s)
[461.480270] [095/133] (562s left) gem_partial_pwrite_pread (write)
[461.547319] Subtest write: SKIP (0.000s)
[461.612678] [096/133] (562s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[461.715695] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[461.718464] Starting dynamic subtest: pipe-A-eDP-1
[472.411270] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.701s)
[472.422193] Starting dynamic subtest: pipe-B-eDP-1
[483.815585] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.403s)
[483.818436] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.106s)
[484.655493] [097/133] (539s left) kms_busy (basic-hang)
[484.763842] Starting subtest: basic-hang
[484.766228] Starting dynamic subtest: flip-pipe-A
[485.384467] Dynamic subtest flip-pipe-A: SUCCESS (0.621s)
[485.398409] Starting dynamic subtest: modeset-pipe-A
[488.775519] Dynamic subtest modeset-pipe-A: SUCCESS (3.389s)
[488.787578] Starting dynamic subtest: flip-pipe-D
[489.969459] Dynamic subtest flip-pipe-D: SUCCESS (1.192s)
[489.982315] Starting dynamic subtest: modeset-pipe-D
[493.392561] Dynamic subtest modeset-pipe-D: SUCCESS (3.421s)
[493.395361] Subtest basic-hang: SUCCESS (8.630s)
[494.197724] [098/133] (530s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[494.295816] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[494.307493] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[494.389930] [099/133] (530s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[494.496731] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[494.502186] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[494.587620] [100/133] (530s left) api_intel_allocator (two-level-inception-interruptible)
[494.654456] Starting subtest: two-level-inception-interruptible
[500.057442] Subtest two-level-inception-interruptible: SUCCESS (5.405s)
[500.182503] [101/133] (524s left) dumb_buffer (create-valid-dumb)
[500.246178] Starting subtest: create-valid-dumb
[500.249118] Subtest create-valid-dumb: SUCCESS (0.000s)
[500.365998] [102/133] (524s left) gem_exec_async (forked-writes)
[500.440593] Starting subtest: forked-writes
[500.443409] Starting dynamic subtest: rcs0
[500.477865] Dynamic subtest rcs0: SUCCESS (0.040s)
[500.492890] Starting dynamic subtest: bcs0
[500.508497] Dynamic subtest bcs0: SUCCESS (0.029s)
[500.521404] Starting dynamic subtest: vcs0
[500.535629] Dynamic subtest vcs0: SUCCESS (0.026s)
[500.548877] Starting dynamic subtest: vcs1
[500.561877] Dynamic subtest vcs1: SUCCESS (0.025s)
[500.575975] Starting dynamic subtest: vecs0
[500.586988] Dynamic subtest vecs0: SUCCESS (0.025s)
[500.598631] Starting dynamic subtest: ccs0
[500.613575] Dynamic subtest ccs0: SUCCESS (0.026s)
[500.616441] Subtest forked-writes: SUCCESS (0.176s)
[500.875395] [103/133] (523s left) i915_suspend (fence-restore-untiled)
[500.936139] Starting subtest: fence-restore-untiled
[500.941277] Subtest fence-restore-untiled: SKIP (0.000s)
[501.048690] [104/133] (523s left) kms_color (degamma)
[501.142361] Starting subtest: degamma
[501.144604] Starting dynamic subtest: pipe-A-eDP-1
[501.881594] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[501.894608] Starting dynamic subtest: pipe-B-eDP-1
[503.341608] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.460s)
[503.352848] Starting dynamic subtest: pipe-C-eDP-1
[504.705407] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.363s)
[504.716485] Starting dynamic subtest: pipe-D-eDP-1
[506.040139] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[506.042908] Subtest degamma: SUCCESS (4.900s)
[506.843139] [105/133] (518s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[506.966422] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[518.143581] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.177s)
[518.977637] [106/133] (505s left) gem_exec_schedule (preemptive-hang)
[519.161572] Starting subtest: preemptive-hang
[519.164186] Starting dynamic subtest: rcs0
[528.073881] Dynamic subtest rcs0: SUCCESS (8.912s)
[528.086157] Starting dynamic subtest: bcs0
[537.095838] Dynamic subtest bcs0: SUCCESS (9.018s)
[537.108198] Starting dynamic subtest: vcs0
[546.055335] Dynamic subtest vcs0: SUCCESS (8.956s)
[546.065582] Starting dynamic subtest: vcs1
[555.079890] Dynamic subtest vcs1: SUCCESS (9.019s)
[555.092182] Starting dynamic subtest: vecs0
[564.098291] Dynamic subtest vecs0: SUCCESS (9.016s)
[564.110181] Starting dynamic subtest: ccs0
[573.070487] Dynamic subtest ccs0: SUCCESS (8.968s)
[573.073161] Subtest preemptive-hang: SUCCESS (53.901s)
[573.317800] [107/133] (451s left) kms_psr (psr2-sprite-render)
[573.408388] Starting subtest: psr2-sprite-render
[573.411192] Starting dynamic subtest: eDP-1
[575.069568] Dynamic subtest eDP-1: SUCCESS (1.661s)
[575.072404] Subtest psr2-sprite-render: SUCCESS (1.662s)
[575.946120] [108/133] (449s left) gem_mmap_wc (write-read-distinct)
[576.004587] Subtest write-read-distinct: SKIP (0.000s)
[576.070371] [109/133] (449s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[576.168860] Starting subtest: bad-pixel-format-y-tiled-ccs
[576.171260] Starting dynamic subtest: pipe-A-eDP-1
[576.195071] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[576.205758] Starting dynamic subtest: pipe-B-eDP-1
[576.232230] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[576.242617] Starting dynamic subtest: pipe-C-eDP-1
[576.269304] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[576.279411] Starting dynamic subtest: pipe-D-eDP-1
[576.305223] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[576.309790] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[578.418652] [110/133] (446s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[578.519445] Starting subtest: y-tiled-64bpp-rotate-0
[578.524848] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[578.612694] [111/133] (446s left) gem_ringfill (engines-basic)
[583.974503] Starting subtest: engines-basic
[583.977602] Starting dynamic subtest: rcs0
[584.031776] Dynamic subtest rcs0: SUCCESS (0.057s)
[584.045651] Starting dynamic subtest: bcs0
[584.076464] Dynamic subtest bcs0: SUCCESS (0.043s)
[584.087882] Starting dynamic subtest: vcs0
[584.120462] Dynamic subtest vcs0: SUCCESS (0.042s)
[584.132286] Starting dynamic subtest: vcs1
[584.167119] Dynamic subtest vcs1: SUCCESS (0.044s)
[584.185134] Starting dynamic subtest: vecs0
[584.213860] Dynamic subtest vecs0: SUCCESS (0.044s)
[584.225844] Starting dynamic subtest: ccs0
[584.262342] Dynamic subtest ccs0: SUCCESS (0.046s)
[584.265348] Subtest engines-basic: SUCCESS (0.290s)
[584.350619] [112/133] (440s left) gem_eio (in-flight-contexts-immediate)
[584.563918] Starting subtest: in-flight-contexts-immediate
[598.017081] Subtest in-flight-contexts-immediate: SUCCESS (13.447s)
[598.199128] [113/133] (427s left) kms_psr (fbc-psr-cursor-blt)
[598.314361] Starting subtest: fbc-psr-cursor-blt
[598.316590] Starting dynamic subtest: eDP-1
[598.321374] Dynamic subtest eDP-1: SKIP (0.000s)
[598.326314] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[598.408424] [114/133] (426s left) gem_lmem_swapping (parallel-random-verify)
[598.453228] Subtest parallel-random-verify: SKIP (0.000s)
[598.501710] [115/133] (426s left) gem_lmem_swapping (parallel-random)
[598.541920] Subtest parallel-random: SKIP (0.000s)
[598.586985] [116/133] (426s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[598.679290] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[598.688135] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[598.768919] [117/133] (426s left) gem_exec_balancer (bonded-semaphore)
[598.831627] Starting subtest: bonded-semaphore
[598.837098] Subtest bonded-semaphore: SKIP (0.000s)
[599.134677] [118/133] (426s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[599.236428] Starting subtest: psr-rgb565-draw-pwrite
[606.284235] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.049s)
[606.398497] [119/133] (419s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[606.501581] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[606.506719] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[606.601886] [120/133] (418s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[606.696874] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[606.701799] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[606.804078] [121/133] (418s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[606.903432] Starting subtest: psr-2p-pri-indfb-multidraw
[606.908379] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[607.025142] [122/133] (418s left) perf (invalid-create-userspace-config)
[607.171392] Starting subtest: invalid-create-userspace-config
[607.173729] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[607.225089] [123/133] (418s left) kms_invalid_mode (zero-vdisplay)
[607.314352] Starting subtest: zero-vdisplay
[607.316477] Starting dynamic subtest: pipe-A-eDP-1
[607.608000] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[607.619438] Starting dynamic subtest: pipe-B-eDP-1
[607.621360] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[607.631284] Starting dynamic subtest: pipe-C-eDP-1
[607.633614] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[607.643252] Starting dynamic subtest: pipe-D-eDP-1
[607.645599] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[607.648092] Subtest zero-vdisplay: SUCCESS (0.300s)
[608.462926] [124/133] (417s left) perf_pmu (idle-no-semaphores)
[608.507740] Starting subtest: idle-no-semaphores
[608.510361] Starting dynamic subtest: rcs0
[609.049463] Dynamic subtest rcs0: SUCCESS (0.542s)
[609.063717] Starting dynamic subtest: bcs0
[609.569773] Dynamic subtest bcs0: SUCCESS (0.517s)
[609.582811] Starting dynamic subtest: vcs0
[610.090961] Dynamic subtest vcs0: SUCCESS (0.518s)
[610.107127] Starting dynamic subtest: vcs1
[610.615080] Dynamic subtest vcs1: SUCCESS (0.521s)
[610.627723] Starting dynamic subtest: vecs0
[611.134287] Dynamic subtest vecs0: SUCCESS (0.517s)
[611.148347] Starting dynamic subtest: ccs0
[611.655799] Dynamic subtest ccs0: SUCCESS (0.518s)
[611.658495] Subtest idle-no-semaphores: SUCCESS (3.152s)
[611.748483] [125/133] (414s left) gem_eio (wait-1us)
[611.955796] Starting subtest: wait-1us
[612.264904] Subtest wait-1us: SUCCESS (0.310s)
[612.390192] [126/133] (413s left) prime_vgem (shrink)
[612.452060] Starting subtest: shrink
[612.502147] Subtest shrink: SUCCESS (0.052s)
[612.625352] [127/133] (413s left) kms_psr (psr-no-drrs)
[612.714339] Starting subtest: psr-no-drrs
[612.716425] Starting dynamic subtest: eDP-1
[614.338785] Dynamic subtest eDP-1: SUCCESS (1.622s)
[614.341368] Subtest psr-no-drrs: SUCCESS (1.623s)
[615.216612] [128/133] (410s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[615.324369] Starting subtest: fbc-rgb565-draw-pwrite
[619.856317] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.536s)
[621.018454] [129/133] (404s left) gem_pread (bench)
[621.078753] Subtest bench: SKIP (0.000s)
[621.142089] [130/133] (404s left) gem_mmap_wc (set-cache-level)
[621.196625] Subtest set-cache-level: SKIP (0.000s)
[621.271946] [131/133] (404s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[621.373474] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[628.711613] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.343s)
[628.852833] [132/133] (397s left) kms_vblank (query-forked-hang)
[628.942213] Starting subtest: query-forked-hang
[628.944413] Starting dynamic subtest: pipe-A-eDP-1
[655.709217] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.769s)
[655.725949] Starting dynamic subtest: pipe-D-eDP-1
[670.745259] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.033s)
[670.748147] Subtest query-forked-hang: SUCCESS (41.806s)
[671.583812] [133/133] (354s left) kms_sequence (get-idle)
[671.685423] Starting subtest: get-idle
[671.688366] Starting dynamic subtest: pipe-A-eDP-1
[673.492329] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.806s)
[673.504235] Starting dynamic subtest: pipe-B-eDP-1
[675.965490] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.473s)
[675.976959] Starting dynamic subtest: pipe-C-eDP-1
[678.470609] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.505s)
[678.483368] Starting dynamic subtest: pipe-D-eDP-1
[680.900053] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.428s)
[680.902609] Subtest get-idle: SUCCESS (9.217s)
[681.710630] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_event_leak
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: gem_create
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_chamelium_hpd
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_fbcon_fbt
results: parsing output: 9/ for test: gem_ccs
results: parsing output: 10/ for test: kms_hdr
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_chamelium_edid
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_plane_multiple
results: parsing output: 16/ for test: kms_atomic_interruptible
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: gem_ctx_persistence
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_readwrite
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_content_protection
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: core_setmaster_vs_auth
results: parsing output: 37/ for test: vgem_basic
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: api_intel_bb
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: i915_hangman
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: gem_linear_blits
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_mmap_offset
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: i915_drm_fdinfo
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_ctx_isolation
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_pm_rps
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: kms_debugfs
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_async_flips
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: gem_spin_batch
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: kms_dsc
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_madvise
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: gen7_exec_parse
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: kms_cursor_edge_walk
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: kms_plane_alpha_blend
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_partial_pwrite_pread
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: kms_busy
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: api_intel_allocator
results: parsing output: 100/ for test: dumb_buffer
results: parsing output: 101/ for test: gem_exec_async
results: parsing output: 102/ for test: i915_suspend
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: gem_mmap_wc
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_ringfill
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: gem_lmem_swapping
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_exec_balancer
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: kms_invalid_mode
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: gem_eio
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_pread
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: kms_sequence
Done.