[58.157368] Initializing watchdogs
[58.157416]   /dev/watchdog0
[58.171160] [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]
[58.175246] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.177453] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.181051] [001/133] (960s left) kms_dp_link_training (uhbr-sst)
[58.285314] Starting subtest: uhbr-sst
[58.293811] Subtest uhbr-sst: SKIP (0.000s)
[58.366735] [002/133] (960s left) syncobj_wait (invalid-signal-one-illegal-handle)
[58.427338] Starting subtest: invalid-signal-one-illegal-handle
[58.429318] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[58.519560] [003/133] (960s left) kms_psr (psr2-suspend)
[58.614549] Starting subtest: psr2-suspend
[58.616739] Starting dynamic subtest: eDP-1
[76.194173] Dynamic subtest eDP-1: SUCCESS (3.034s)
[76.198526] Subtest psr2-suspend: SUCCESS (3.034s)
[76.988023] [004/133] (941s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[77.082394] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[77.086599] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[77.161938] [005/133] (941s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[77.249679] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[77.251942] Starting dynamic subtest: pipe-A-eDP-1
[77.274687] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[77.285384] Starting dynamic subtest: pipe-B-eDP-1
[77.305878] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[77.313397] Starting dynamic subtest: pipe-C-eDP-1
[77.334562] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[77.342005] Starting dynamic subtest: pipe-D-eDP-1
[77.363611] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[77.367591] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[79.494747] [006/133] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[79.599162] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[102.275729] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.839s)
[102.419390] [007/133] (916s left) gem_exec_schedule (submit-late-slice)
[102.501860] Starting subtest: submit-late-slice
[102.503481] Starting dynamic subtest: rcs0
[102.534611] Dynamic subtest rcs0: SUCCESS (0.034s)
[102.544980] Starting dynamic subtest: bcs0
[102.562817] Dynamic subtest bcs0: SUCCESS (0.028s)
[102.570611] Starting dynamic subtest: vcs0
[102.602790] Dynamic subtest vcs0: SUCCESS (0.039s)
[102.611326] Starting dynamic subtest: vcs1
[102.635177] Dynamic subtest vcs1: SUCCESS (0.032s)
[102.644753] Starting dynamic subtest: vecs0
[102.665092] Dynamic subtest vecs0: SUCCESS (0.029s)
[102.672778] Starting dynamic subtest: ccs0
[102.701991] Dynamic subtest ccs0: SUCCESS (0.035s)
[102.704009] Subtest submit-late-slice: SUCCESS (0.203s)
[103.967475] [008/133] (914s left) gem_userptr_blits (map-fixed-invalidate)
[104.035750] Starting subtest: map-fixed-invalidate
[104.040351] Subtest map-fixed-invalidate: SKIP (0.000s)
[104.163159] [009/133] (914s left) gem_mmap (bad-object)
[104.211709] Subtest bad-object: SKIP (0.000s)
[104.286522] [010/133] (914s left) gem_tiled_blits (interruptible)
[104.343477] Subtest interruptible: SKIP (0.000s)
[104.401220] [011/133] (914s left) gem_wait (write-busy)
[104.468706] Starting subtest: write-busy
[104.471118] Starting dynamic subtest: all-engines
[105.079023] Dynamic subtest all-engines: SUCCESS (0.611s)
[105.093674] Starting dynamic subtest: rcs0
[105.629273] Dynamic subtest rcs0: SUCCESS (0.550s)
[105.644601] Starting dynamic subtest: bcs0
[106.177314] Dynamic subtest bcs0: SUCCESS (0.548s)
[106.191504] Starting dynamic subtest: vcs0
[107.908645] Dynamic subtest vcs0: SUCCESS (1.726s)
[107.926900] Starting dynamic subtest: vcs1
[109.893058] Dynamic subtest vcs1: SUCCESS (1.980s)
[109.908199] Starting dynamic subtest: vecs0
[111.876998] Dynamic subtest vecs0: SUCCESS (1.980s)
[111.892114] Starting dynamic subtest: ccs0
[112.427485] Dynamic subtest ccs0: SUCCESS (0.549s)
[112.430457] Subtest write-busy: SUCCESS (7.953s)
[112.622368] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[112.625477] [012/133] (906s left) gen3_render_linear_blits
[112.749352] [013/133] (906s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[112.855816] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[119.744074] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.885s)
[119.884962] [014/133] (899s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[119.979844] Starting subtest: basic-max-pipe-crc-check
[119.984394] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[120.030841] [015/133] (899s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[120.124576] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[120.126906] Starting dynamic subtest: pipe-A-default-mode
[122.851908] Dynamic subtest pipe-A-default-mode: SUCCESS (2.726s)
[122.853978] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.727s)
[123.714023] [016/133] (895s left) perf (non-system-wide-paranoid)
[123.846098] Starting subtest: non-system-wide-paranoid
[123.872216] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[123.920968] [017/133] (895s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[124.029222] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[124.033596] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[124.107295] [018/133] (895s left) syncobj_timeline (signal-point-0)
[124.160837] Starting subtest: signal-point-0
[124.163112] Subtest signal-point-0: SUCCESS (0.000s)
[124.249056] [019/133] (895s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[124.344166] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[131.600616] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.259s)
[131.727300] [020/133] (887s left) gem_ppgtt (shrink-vs-evict-pinned)
[131.788116] Starting subtest: shrink-vs-evict-pinned
[139.900744] Subtest shrink-vs-evict-pinned: SUCCESS (8.109s)
[140.007220] [021/133] (879s left) i915_pm_rc6_residency (rc6-idle)
[140.076639] Starting subtest: rc6-idle
[140.115234] Starting dynamic subtest: gt0-rcs0
[164.395025] Dynamic subtest gt0-rcs0: SUCCESS (24.284s)
[164.404119] Starting dynamic subtest: gt0-bcs0
[188.781219] Dynamic subtest gt0-bcs0: SUCCESS (24.381s)
[188.790374] Starting dynamic subtest: gt0-ccs0
[213.071093] Dynamic subtest gt0-ccs0: SUCCESS (24.286s)
[213.080920] Starting dynamic subtest: gt1-vcs0
[219.244711] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[219.256632] Starting dynamic subtest: gt1-vecs0
[225.417453] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[225.420746] Subtest rc6-idle: SUCCESS (85.345s)
[225.512787] [022/133] (794s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[225.612035] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[225.614350] Starting dynamic subtest: pipe-A-eDP-1
[225.636092] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[225.646992] Starting dynamic subtest: pipe-B-eDP-1
[225.667530] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[225.675992] Starting dynamic subtest: pipe-C-eDP-1
[225.696681] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[225.705061] Starting dynamic subtest: pipe-D-eDP-1
[225.727305] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[225.731584] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[227.883394] [023/133] (791s left) gem_exec_balancer (parallel-contexts)
[228.344508] Starting subtest: parallel-contexts
[231.115038] Subtest parallel-contexts: SUCCESS (2.772s)
[231.954688] [024/133] (787s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[232.056546] Starting subtest: pipe-fbc-rte
[232.062842] Starting dynamic subtest: pipe-B-eDP-1
[237.554793] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.502s)
[237.562069] Subtest pipe-fbc-rte: SUCCESS (5.504s)
[239.807471] [025/133] (779s left) prime_self_import (export-vs-gem_close-race)
[239.838885] Starting subtest: export-vs-gem_close-race
[244.917283] Subtest export-vs-gem_close-race: SUCCESS (5.077s)
[244.995141] [026/133] (774s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[245.121285] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[245.123481] Starting dynamic subtest: pipe-A-eDP-1
[245.145305] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[245.156513] Starting dynamic subtest: pipe-B-eDP-1
[245.177449] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[245.186927] Starting dynamic subtest: pipe-C-eDP-1
[245.208971] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[245.218579] Starting dynamic subtest: pipe-D-eDP-1
[245.240676] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[245.244761] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[247.356198] [027/133] (772s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[247.474710] Starting subtest: yf-tiled-64bpp-rotate-0
[247.478976] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[247.568275] [028/133] (772s left) kms_flip (2x-plain-flip-ts-check)
[247.680760] Starting subtest: 2x-plain-flip-ts-check
[247.690811] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[247.772369] [029/133] (772s left) i915_suspend (fence-restore-untiled)
[247.830981] Starting subtest: fence-restore-untiled
[247.834976] Subtest fence-restore-untiled: SKIP (0.000s)
[247.926972] [030/133] (771s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[248.018751] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[249.063985] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.045s)
[249.200702] [031/133] (770s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[249.287956] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[255.817696] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.534s)
[255.964026] [032/133] (763s left) kms_sequence (queue-busy)
[256.064569] Starting subtest: queue-busy
[256.066902] Starting dynamic subtest: pipe-A-eDP-1
[258.003468] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[258.013835] Starting dynamic subtest: pipe-B-eDP-1
[260.588772] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.582s)
[260.598193] Starting dynamic subtest: pipe-C-eDP-1
[263.221464] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.632s)
[263.231383] Starting dynamic subtest: pipe-D-eDP-1
[265.843023] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.623s)
[265.845298] Subtest queue-busy: SUCCESS (9.782s)
[266.648762] [033/133] (753s left) gem_exec_schedule (preempt-queue)
[266.714544] Subtest preempt-queue: SKIP (0.000s)
[267.007237] [034/133] (753s left) kms_cursor_crc (cursor-random-64x64)
[267.173478] Starting subtest: cursor-random-64x64
[267.175787] Starting dynamic subtest: pipe-A-eDP-1
[270.502176] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.328s)
[270.530543] Starting dynamic subtest: pipe-D-eDP-1
[274.548578] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.025s)
[274.550893] Subtest cursor-random-64x64: SUCCESS (7.378s)
[275.396183] [035/133] (744s left) gem_ctx_persistence (engines-mixed-process)
[275.452778] Starting subtest: engines-mixed-process
[275.455104] Starting dynamic subtest: rcs0
[276.865982] Dynamic subtest rcs0: SUCCESS (1.412s)
[276.876792] Starting dynamic subtest: bcs0
[278.859482] Dynamic subtest bcs0: SUCCESS (1.995s)
[278.870471] Starting dynamic subtest: vcs0
[280.852191] Dynamic subtest vcs0: SUCCESS (1.992s)
[280.862968] Starting dynamic subtest: vcs1
[282.909247] Dynamic subtest vcs1: SUCCESS (2.055s)
[282.920725] Starting dynamic subtest: vecs0
[284.887526] Dynamic subtest vecs0: SUCCESS (1.976s)
[284.897627] Starting dynamic subtest: ccs0
[286.864332] Dynamic subtest ccs0: SUCCESS (1.975s)
[286.866712] Subtest engines-mixed-process: SUCCESS (11.414s)
[286.957997] [036/133] (733s left) sysfs_heartbeat_interval (idempotent)
[287.018050] Starting subtest: idempotent
[287.020438] Starting dynamic subtest: vecs0
[287.022813] Dynamic subtest vecs0: SUCCESS (0.001s)
[287.033743] Starting dynamic subtest: ccs0
[287.035575] Dynamic subtest ccs0: SUCCESS (0.002s)
[287.044179] Starting dynamic subtest: vcs0
[287.046074] Dynamic subtest vcs0: SUCCESS (0.000s)
[287.054624] Starting dynamic subtest: bcs0
[287.056463] Dynamic subtest bcs0: SUCCESS (0.002s)
[287.065053] Starting dynamic subtest: rcs0
[287.066965] Dynamic subtest rcs0: SUCCESS (0.002s)
[287.076062] Starting dynamic subtest: vcs1
[287.078224] Dynamic subtest vcs1: SUCCESS (0.000s)
[287.080426] Subtest idempotent: SUCCESS (0.013s)
[287.159138] [037/133] (733s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[287.259965] Starting subtest: fbc-rgb565-draw-pwrite
[291.882284] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.626s)
[293.010780] [038/133] (727s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[293.059510] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[293.160477] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[293.241465] [039/133] (727s left) gem_ctx_persistence (legacy-engines-persistence)
[293.291426] Starting subtest: legacy-engines-persistence
[293.293671] Starting dynamic subtest: render
[294.078096] Dynamic subtest render: SUCCESS (0.786s)
[294.092646] Starting dynamic subtest: bsd1
[294.832372] Dynamic subtest bsd1: SUCCESS (0.751s)
[294.844402] Starting dynamic subtest: bsd2
[295.613281] Dynamic subtest bsd2: SUCCESS (0.779s)
[295.627957] Starting dynamic subtest: blt
[296.361625] Dynamic subtest blt: SUCCESS (0.745s)
[296.373600] Starting dynamic subtest: vebox
[297.161292] Dynamic subtest vebox: SUCCESS (0.797s)
[297.163775] Subtest legacy-engines-persistence: SUCCESS (3.872s)
[297.253668] [040/133] (723s left) gem_softpin (allocator-basic-reserve)
[297.317330] Starting subtest: allocator-basic-reserve
[297.384319] Subtest allocator-basic-reserve: SUCCESS (0.069s)
[297.492741] [041/133] (722s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[297.586270] Starting subtest: plane-upscale-20x20-with-modifiers
[297.588469] Starting dynamic subtest: pipe-A
[297.921592] Dynamic subtest pipe-A: SUCCESS (0.338s)
[297.932319] Starting dynamic subtest: pipe-B
[299.287269] Dynamic subtest pipe-B: SUCCESS (1.365s)
[299.297088] Starting dynamic subtest: pipe-C
[300.716103] Dynamic subtest pipe-C: SUCCESS (1.427s)
[300.725513] Starting dynamic subtest: pipe-D
[302.147549] Dynamic subtest pipe-D: SUCCESS (1.429s)
[302.149790] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.564s)
[303.325897] [042/133] (717s left) kms_psr (psr-sprite-plane-move)
[303.416432] Starting subtest: psr-sprite-plane-move
[303.418712] Starting dynamic subtest: eDP-1
[305.158103] Dynamic subtest eDP-1: SUCCESS (1.738s)
[305.159995] Subtest psr-sprite-plane-move: SUCCESS (1.739s)
[305.981323] [043/133] (714s left) api_intel_bb (crc32)
[306.041819] Starting subtest: crc32
[306.043744] Starting dynamic subtest: rcs0-smem0
[306.333594] Dynamic subtest rcs0-smem0: SUCCESS (0.292s)
[306.347292] Starting dynamic subtest: bcs0-smem0
[306.673106] Dynamic subtest bcs0-smem0: SUCCESS (0.337s)
[306.685196] Starting dynamic subtest: vcs0-smem0
[307.036691] Dynamic subtest vcs0-smem0: SUCCESS (0.360s)
[307.048430] Starting dynamic subtest: vcs1-smem0
[307.411863] Dynamic subtest vcs1-smem0: SUCCESS (0.372s)
[307.427245] Starting dynamic subtest: vecs0-smem0
[307.749963] Dynamic subtest vecs0-smem0: SUCCESS (0.335s)
[307.761643] Starting dynamic subtest: ccs0-smem0
[308.082316] Dynamic subtest ccs0-smem0: SUCCESS (0.329s)
[308.085487] Subtest crc32: SUCCESS (2.043s)
[308.195222] [044/133] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[308.280903] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[308.285085] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[308.394750] [045/133] (712s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[308.499794] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[308.503784] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[308.613577] [046/133] (711s left) perf (invalid-oa-exponent)
[308.696367] Starting subtest: invalid-oa-exponent
[308.711321] Subtest invalid-oa-exponent: SUCCESS (0.015s)
[308.764335] [047/133] (711s left) kms_content_protection (atomic-hdcp14)
[308.898622] Starting subtest: atomic-hdcp14
[308.903021] Subtest atomic-hdcp14: SKIP (0.000s)
[309.030009] [048/133] (711s left) prime_busy (after)
[309.094688] Starting subtest: after
[309.099152] Starting dynamic subtest: rcs0
[309.131159] Dynamic subtest rcs0: SUCCESS (0.034s)
[309.141239] Starting dynamic subtest: bcs0
[309.187645] Dynamic subtest bcs0: SUCCESS (0.056s)
[309.197636] Starting dynamic subtest: vcs0
[309.228497] Dynamic subtest vcs0: SUCCESS (0.040s)
[309.240278] Starting dynamic subtest: vcs1
[309.269581] Dynamic subtest vcs1: SUCCESS (0.040s)
[309.280625] Starting dynamic subtest: vecs0
[309.310494] Dynamic subtest vecs0: SUCCESS (0.040s)
[309.319447] Starting dynamic subtest: ccs0
[309.351698] Dynamic subtest ccs0: SUCCESS (0.040s)
[309.459340] Subtest after: SUCCESS (0.363s)
[309.533534] [049/133] (711s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[309.624152] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[309.628460] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[310.713509] [050/133] (710s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[310.808749] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[314.508528] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.703s)
[315.697272] [051/133] (705s left) gem_exec_params (invalid-bsd2-flag-on-render)
[315.768789] Starting subtest: invalid-bsd2-flag-on-render
[315.771042] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[315.860827] [052/133] (704s left) kms_fence_pin_leak
[316.033536] [053/133] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[316.128745] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[316.132719] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[316.236535] [054/133] (704s left) prime_mmap (test_dup)
[316.291919] Starting subtest: test_dup
[316.294056] Starting dynamic subtest: test_dup-smem
[316.321081] Dynamic subtest test_dup-smem: SUCCESS (0.031s)
[316.323555] Subtest test_dup: SUCCESS (0.032s)
[316.399655] [055/133] (704s left) syncobj_basic (bad-pad-handle-to-fd)
[316.456302] Starting subtest: bad-pad-handle-to-fd
[316.458477] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[316.562736] [056/133] (704s left) gem_exec_balancer (hog)
[316.623455] Starting subtest: hog
[316.627058] Subtest hog: SKIP (0.000s)
[316.929037] [057/133] (704s left) kms_flip (flip-vs-fences)
[317.025581] Starting subtest: flip-vs-fences
[317.029462] Subtest flip-vs-fences: SKIP (0.000s)
[317.144755] [058/133] (703s left) kms_pm_rpm (cursor-dpms)
[319.084000] Starting subtest: cursor-dpms
[319.088825] Subtest cursor-dpms: SKIP (0.000s)
[319.459042] [059/133] (701s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[319.553192] Starting subtest: primary-x-tiled-reflect-x-180
[326.507882] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.954s)
[327.701688] [060/133] (693s left) gen9_exec_parse (bb-oversize)
[327.757952] Subtest bb-oversize: SKIP (0.000s)
[327.844540] [061/133] (693s left) perf_pmu (busy-double-start)
[327.880226] Starting subtest: busy-double-start
[327.882055] Starting dynamic subtest: rcs0
[331.511862] Dynamic subtest rcs0: FAIL (3.575s)
[331.522989] Starting dynamic subtest: bcs0
[335.022018] Dynamic subtest bcs0: SUCCESS (3.566s)
[335.032027] Starting dynamic subtest: vcs0
[339.395084] Dynamic subtest vcs0: SUCCESS (4.371s)
[339.405500] Starting dynamic subtest: vcs1
[343.428373] Dynamic subtest vcs1: SUCCESS (4.031s)
[343.439454] Starting dynamic subtest: vecs0
[347.412456] Dynamic subtest vecs0: SUCCESS (3.981s)
[347.427221] Starting dynamic subtest: ccs0
[351.050060] Dynamic subtest ccs0: FAIL (3.568s)
[351.052241] Subtest busy-double-start: FAIL (23.104s)
[351.093089] [062/133] (670s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[351.194638] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[351.198867] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[351.284928] [063/133] (670s left) kms_psr (fbc-psr-primary-blt)
[351.384515] Starting subtest: fbc-psr-primary-blt
[351.386727] Starting dynamic subtest: eDP-1
[351.391015] Dynamic subtest eDP-1: SKIP (0.000s)
[351.395198] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[351.457917] [064/133] (669s left) gem_mmap_wc (coherency)
[351.523968] Subtest coherency: SKIP (0.000s)
[351.591467] [065/133] (669s left) kms_invalid_mode (overflow-vrefresh)
[351.669503] Starting subtest: overflow-vrefresh
[351.671577] Starting dynamic subtest: pipe-A-eDP-1
[351.952247] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[351.965727] Starting dynamic subtest: pipe-B-eDP-1
[351.967885] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[351.980017] Starting dynamic subtest: pipe-C-eDP-1
[351.981875] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[351.991541] Starting dynamic subtest: pipe-D-eDP-1
[351.993893] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[351.996225] Subtest overflow-vrefresh: SUCCESS (0.295s)
[352.837472] [066/133] (668s left) i915_drm_fdinfo (busy-check-all)
[352.879333] Starting subtest: busy-check-all
[352.881212] Starting dynamic subtest: rcs0
[352.885794] Dynamic subtest rcs0: SKIP (0.004s)
[352.899676] Starting dynamic subtest: bcs0
[352.903826] Dynamic subtest bcs0: SKIP (0.000s)
[352.913109] Starting dynamic subtest: vcs0
[352.917431] Dynamic subtest vcs0: SKIP (0.001s)
[352.926465] Starting dynamic subtest: vcs1
[352.930531] Dynamic subtest vcs1: SKIP (0.000s)
[352.939467] Starting dynamic subtest: vecs0
[352.943537] Dynamic subtest vecs0: SKIP (0.000s)
[352.952741] Starting dynamic subtest: ccs0
[352.956909] Dynamic subtest ccs0: SKIP (0.000s)
[352.961001] Subtest busy-check-all: SKIP (0.013s)
[352.998036] [067/133] (668s left) dumb_buffer (map-valid)
[353.074112] Starting subtest: map-valid
[353.076150] Subtest map-valid: SUCCESS (0.000s)
[353.174083] [068/133] (668s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[353.271178] Starting subtest: plane-lut1d-ctm3x4-lut1d
[353.406657] Starting dynamic subtest: pipe-A-plane-0
[353.551703] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[353.562720] Starting dynamic subtest: pipe-A-plane-1
[353.696731] Dynamic subtest pipe-A-plane-1: SUCCESS (0.143s)
[353.706672] Starting dynamic subtest: pipe-A-plane-2
[353.841345] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s)
[355.021549] Starting dynamic subtest: pipe-B-plane-0
[355.156022] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[355.166294] Starting dynamic subtest: pipe-B-plane-1
[355.294507] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[355.303891] Starting dynamic subtest: pipe-B-plane-2
[355.422828] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[356.647435] Starting dynamic subtest: pipe-C-plane-0
[356.794061] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[356.804475] Starting dynamic subtest: pipe-C-plane-1
[356.927166] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[356.937288] Starting dynamic subtest: pipe-C-plane-2
[357.060848] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[358.273230] Starting dynamic subtest: pipe-D-plane-0
[358.420510] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[358.430803] Starting dynamic subtest: pipe-D-plane-1
[358.564698] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[358.574922] Starting dynamic subtest: pipe-D-plane-2
[358.698133] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[358.985223] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.713s)
[359.842182] [069/133] (661s left) syncobj_eventfd (timeline-wait)
[359.896108] Starting subtest: timeline-wait
[359.904644] Subtest timeline-wait: SUCCESS (0.011s)
[359.981509] [070/133] (661s left) gem_exec_schedule (u-submit-golden-slice)
[360.053528] Starting subtest: u-submit-golden-slice
[360.055894] Starting dynamic subtest: rcs0
[360.080314] Dynamic subtest rcs0: SUCCESS (0.035s)
[360.092024] Starting dynamic subtest: bcs0
[360.123023] Dynamic subtest bcs0: SUCCESS (0.042s)
[360.138110] Starting dynamic subtest: vcs0
[360.161970] Dynamic subtest vcs0: SUCCESS (0.038s)
[360.172702] Starting dynamic subtest: vcs1
[360.201937] Dynamic subtest vcs1: SUCCESS (0.039s)
[360.211986] Starting dynamic subtest: vecs0
[360.234628] Dynamic subtest vecs0: SUCCESS (0.032s)
[360.245450] Starting dynamic subtest: ccs0
[360.275871] Dynamic subtest ccs0: SUCCESS (0.040s)
[360.278069] Subtest u-submit-golden-slice: SUCCESS (0.232s)
[361.950136] [071/133] (659s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[362.055637] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[366.019634] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.967s)
[367.144685] [072/133] (654s left) kms_chamelium_audio (hdmi-audio)
[367.528765] Subtest hdmi-audio: SKIP (0.000s)
[368.342007] [073/133] (653s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[368.444920] Starting subtest: basic-modeset-with-all-modifiers-formats
[368.815348] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[369.557689] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.742s)
[369.568217] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[369.579249] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[369.589124] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[369.601537] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[369.611575] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[369.757113] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[369.768816] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[369.779461] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[369.791613] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[369.801882] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[369.814438] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[369.823850] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[369.837111] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[369.845969] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[369.855651] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[369.868388] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[369.878583] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[369.890568] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[369.902304] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[369.912671] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[369.922330] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[369.934786] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[369.944682] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[370.090614] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[370.104124] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[370.112703] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[370.122568] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[370.134941] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[370.149811] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[370.157274] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[370.167278] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[370.179372] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[370.189283] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[370.201553] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[370.213992] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[370.223790] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.020s)
[370.233753] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[370.246015] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[370.258127] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[370.268401] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[370.281489] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[370.423884] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[370.433739] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[370.446070] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[370.456094] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[370.468327] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[370.478337] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[370.490465] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[370.502561] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[370.512653] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[370.521941] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[370.534944] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[370.544069] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[370.557162] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[370.566209] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[370.579402] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[370.588388] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[370.601549] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[370.993753] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.550s)
[371.840152] [074/133] (649s left) kms_prop_blob (blob-prop-validate)
[371.902475] Starting subtest: blob-prop-validate
[371.904378] Subtest blob-prop-validate: SUCCESS (0.000s)
[371.992311] [075/133] (649s left) gem_ctx_exec (basic)
[372.047393] Starting subtest: basic
[372.052014] Subtest basic: SUCCESS (0.005s)
[372.165722] [076/133] (649s left) kms_vrr (flip-dpms)
[372.259646] Starting subtest: flip-dpms
[372.265603] Subtest flip-dpms: SKIP (0.000s)
[372.341489] [077/133] (649s left) kms_cursor_crc (cursor-offscreen-32x10)
[372.502268] Starting subtest: cursor-offscreen-32x10
[372.546156] Subtest cursor-offscreen-32x10: SKIP (0.038s)
[372.836446] [078/133] (649s left) gem_media_vme
[372.967321] [079/133] (649s left) kms_busy (extended-pageflip-hang-oldfb)
[373.059161] Starting subtest: extended-pageflip-hang-oldfb
[373.060984] Starting dynamic subtest: pipe-A
[373.464202] Dynamic subtest pipe-A: SUCCESS (0.404s)
[373.478216] Starting dynamic subtest: pipe-D
[374.588863] Dynamic subtest pipe-D: SUCCESS (1.121s)
[374.591003] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.529s)
[375.417478] [080/133] (646s left) syncobj_timeline (invalid-signal-zero-handles)
[375.478067] Starting subtest: invalid-signal-zero-handles
[375.480387] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[375.577214] [081/133] (646s left) gem_workarounds (basic-read)
[375.635397] Starting subtest: basic-read
[375.651091] Subtest basic-read: SUCCESS (0.015s)
[375.766606] [082/133] (646s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[375.894668] Starting subtest: cursorB-vs-flipA-atomic
[375.898982] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[376.054731] [083/133] (646s left) gem_partial_pwrite_pread (writes-after-reads-display)
[376.120632] Subtest writes-after-reads-display: SKIP (0.000s)
[376.184683] [084/133] (646s left) gem_pipe_control_store_loop (fresh-buffer)
[376.242474] Starting subtest: fresh-buffer
[378.395459] Subtest fresh-buffer: SUCCESS (2.152s)
[378.523511] [085/133] (643s left) i915_hangman (error-state-basic)
[378.577750] Starting subtest: error-state-basic
[378.746647] Subtest error-state-basic: SUCCESS (0.168s)
[378.828919] [086/133] (643s left) api_intel_bb (object-reloc-keep-cache)
[378.875418] Starting subtest: object-reloc-keep-cache
[378.880198] Subtest object-reloc-keep-cache: SKIP (0.003s)
[379.044752] [087/133] (643s left) device_reset (cold-reset-bound)
[379.118729] Starting subtest: cold-reset-bound
[379.123395] Subtest cold-reset-bound: SKIP (0.000s)
[379.192849] [088/133] (643s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[379.299990] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[386.668788] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.371s)
[386.806341] [089/133] (635s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[386.863164] Starting subtest: multi-wait-for-submit-available-signaled
[386.865087] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[386.956995] [090/133] (635s left) gem_exec_create (basic)
[387.013045] Starting subtest: basic
[387.015377] Starting dynamic subtest: smem
[389.101097] Dynamic subtest smem: SUCCESS (2.087s)
[389.103772] Subtest basic: SUCCESS (2.088s)
[389.288382] [091/133] (633s left) gem_eio (in-flight-immediate)
[389.527611] Starting subtest: in-flight-immediate
[397.892178] Subtest in-flight-immediate: SUCCESS (8.365s)
[398.027972] [092/133] (624s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[400.063182] Starting subtest: modeset-lpsp-stress-no-wait
[409.879363] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.820s)
[409.960428] [093/133] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[410.055168] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[410.059671] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[410.151957] [094/133] (612s left) gem_exec_fence (parallel)
[410.331464] Starting subtest: parallel
[410.333998] Starting dynamic subtest: rcs0
[412.476677] Dynamic subtest rcs0: SUCCESS (2.149s)
[412.488007] Starting dynamic subtest: bcs0
[414.629498] Dynamic subtest bcs0: SUCCESS (2.152s)
[414.641896] Starting dynamic subtest: vcs0
[416.780908] Dynamic subtest vcs0: SUCCESS (2.151s)
[416.791742] Starting dynamic subtest: vcs1
[418.930452] Dynamic subtest vcs1: SUCCESS (2.149s)
[418.941924] Starting dynamic subtest: vecs0
[421.079576] Dynamic subtest vecs0: SUCCESS (2.148s)
[421.089849] Starting dynamic subtest: ccs0
[423.237307] Dynamic subtest ccs0: SUCCESS (2.157s)
[423.239899] Subtest parallel: SUCCESS (12.911s)
[423.975480] [095/133] (598s left) kms_debugfs (display-on-read-all)
[424.077399] Starting subtest: display-on-read-all
[424.242537] Subtest display-on-read-all: SUCCESS (0.165s)
[424.366861] [096/133] (598s left) gem_exec_params (rs-invalid)
[424.421201] Starting subtest: rs-invalid
[424.423377] Subtest rs-invalid: SUCCESS (0.003s)
[424.529075] [097/133] (598s left) gem_workarounds (suspend-resume-fd)
[424.598325] Starting subtest: suspend-resume-fd
[440.817314] Subtest suspend-resume-fd: SUCCESS (1.184s)
[440.963616] [098/133] (581s left) gem_userptr_blits (dmabuf-unsync)
[441.046495] Subtest dmabuf-unsync: SKIP (0.000s)
[441.212782] [099/133] (581s left) gem_mmap_gtt (big-copy-xy)
[441.276066] Subtest big-copy-XY: SKIP (0.000s)
[441.329946] [100/133] (581s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[441.388376] Starting subtest: y-tiled-to-vebox-x-tiled
[441.392777] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[441.569781] [101/133] (581s left) gem_ctx_shared (exec-shared-gtt)
[441.624316] Starting subtest: exec-shared-gtt
[441.626613] Starting dynamic subtest: rcs0
[441.632911] Dynamic subtest rcs0: SUCCESS (0.008s)
[441.643619] Starting dynamic subtest: bcs0
[441.645411] Dynamic subtest bcs0: SUCCESS (0.005s)
[441.654829] Starting dynamic subtest: vcs0
[441.656822] Dynamic subtest vcs0: SUCCESS (0.006s)
[441.665931] Starting dynamic subtest: vcs1
[441.668057] Dynamic subtest vcs1: SUCCESS (0.007s)
[441.677105] Starting dynamic subtest: vecs0
[441.679170] Dynamic subtest vecs0: SUCCESS (0.006s)
[441.688347] Starting dynamic subtest: ccs0
[441.690485] Dynamic subtest ccs0: SUCCESS (0.006s)
[441.692555] Subtest exec-shared-gtt: SUCCESS (0.043s)
[441.850487] [102/133] (581s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[441.944571] Starting subtest: fbc-pr-cursor-mmap-cpu
[441.948843] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[442.028278] [103/133] (581s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[442.404360] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[443.226339] [104/133] (579s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[443.322203] Starting subtest: fbc-rgb101010-draw-pwrite
[448.589987] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.369s)
[449.753848] [105/133] (573s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[449.851397] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[456.491842] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.692s)
[456.604805] [106/133] (566s left) syncobj_wait (reset-during-wait-for-submit)
[456.670338] Starting subtest: reset-during-wait-for-submit
[456.773653] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[456.864316] [107/133] (566s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[456.947904] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[456.951977] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[457.032359] [108/133] (566s left) gem_mmap_gtt (flink-race)
[457.100169] Subtest flink-race: SKIP (0.000s)
[457.160490] [109/133] (566s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[457.249285] Starting subtest: psr-rgb101010-draw-render
[464.549562] Subtest psr-rgb101010-draw-render: SUCCESS (7.325s)
[464.664601] [110/133] (558s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[464.791720] Starting subtest: 4-tiled-8bpp-rotate-270
[464.827018] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.030s)
[464.937119] [111/133] (558s left) kms_psr (fbc-psr2-primary-page-flip)
[465.028418] Starting subtest: fbc-psr2-primary-page-flip
[465.030528] Starting dynamic subtest: eDP-1
[465.034409] Dynamic subtest eDP-1: SKIP (0.000s)
[465.038326] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[465.116982] [112/133] (558s left) kms_chamelium_hpd (dp-hpd-storm)
[465.504109] Subtest dp-hpd-storm: SKIP (0.000s)
[466.314709] [113/133] (557s left) kms_psr (pr-cursor-mmap-gtt)
[466.410073] Starting subtest: pr-cursor-mmap-gtt
[466.414103] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[466.483179] [114/133] (557s left) perf_pmu (rc6-all-gts)
[466.522252] Starting subtest: rc6-all-gts
[472.888399] Subtest rc6-all-gts: SUCCESS (6.373s)
[473.779041] [115/133] (549s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[473.880637] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[474.682629] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.803s)
[474.862556] [116/133] (548s left) gem_tiled_fence_blits (basic)
[474.920508] Subtest basic: SKIP (0.000s)
[474.987125] [117/133] (548s left) gem_exec_params (invalid-ring2)
[475.049769] Starting subtest: invalid-ring2
[475.052369] Subtest invalid-ring2: SUCCESS (0.000s)
[475.145799] [118/133] (548s left) kms_async_flips (test-cursor)
[475.233652] Starting subtest: test-cursor
[475.604892] Starting dynamic subtest: pipe-A-eDP-1
[476.410112] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[476.820217] Starting dynamic subtest: pipe-B-eDP-1
[477.543659] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.733s)
[477.936201] Starting dynamic subtest: pipe-C-eDP-1
[478.684596] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.757s)
[479.050698] Starting dynamic subtest: pipe-D-eDP-1
[479.823946] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.782s)
[479.826324] Subtest test-cursor: SUCCESS (4.590s)
[480.986857] [119/133] (542s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[481.125696] Starting subtest: short-flip-before-cursor-atomic-transitions
[482.111274] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.983s)
[482.915444] [120/133] (540s left) gem_create (create-massive)
[482.975034] Starting subtest: create-massive
[482.977516] Subtest create-massive: SUCCESS (0.000s)
[483.160831] [121/133] (540s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[483.270695] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[483.275164] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[483.370385] [122/133] (540s left) gem_eio (in-flight-internal-immediate)
[483.604123] Starting subtest: in-flight-internal-immediate
[485.003109] Subtest in-flight-internal-immediate: SUCCESS (1.398s)
[485.145946] [123/133] (538s left) gem_exec_suspend (basic)
[485.200574] Starting subtest: basic
[485.202901] Starting dynamic subtest: smem
[486.913064] Dynamic subtest smem: SUCCESS (1.710s)
[486.916046] Subtest basic: SUCCESS (1.712s)
[487.101242] [124/133] (536s left) kms_lease (lease-revoke)
[487.198963] Starting subtest: lease-revoke
[487.201301] Starting dynamic subtest: pipe-A-eDP-1
[487.233110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.033s)
[487.244174] Starting dynamic subtest: pipe-B-eDP-1
[487.259667] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[487.271823] Starting dynamic subtest: pipe-C-eDP-1
[487.286985] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[487.300834] Starting dynamic subtest: pipe-D-eDP-1
[487.318955] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[487.321198] Subtest lease-revoke: SUCCESS (0.121s)
[487.433721] [125/133] (536s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[487.529325] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[487.531632] Starting dynamic subtest: pipe-A
[487.881019] Dynamic subtest pipe-A: SUCCESS (0.353s)
[487.894141] Starting dynamic subtest: pipe-B
[489.312351] Dynamic subtest pipe-B: SUCCESS (1.430s)
[489.323299] Starting dynamic subtest: pipe-C
[490.775517] Dynamic subtest pipe-C: SUCCESS (1.459s)
[490.786444] Starting dynamic subtest: pipe-D
[492.175475] Dynamic subtest pipe-D: SUCCESS (1.402s)
[492.177626] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.649s)
[493.353540] [126/133] (530s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[493.442434] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[493.446520] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[493.542365] [127/133] (530s left) gem_render_copy (linear-to-vebox-yf-tiled)
[493.613185] Starting subtest: linear-to-vebox-yf-tiled
[493.617382] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[493.801273] [128/133] (530s left) kms_big_fb (linear-32bpp-rotate-180)
[493.907072] Starting subtest: linear-32bpp-rotate-180
[495.476035] Subtest linear-32bpp-rotate-180: SUCCESS (1.568s)
[495.621892] [129/133] (528s left) gem_set_tiling_vs_pwrite
[495.737828] [130/133] (528s left) kms_cursor_edge_walk (64x64-top-edge)
[495.827511] Starting subtest: 64x64-top-edge
[495.829451] Starting dynamic subtest: pipe-A-eDP-1
[499.303479] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.476s)
[499.314523] Starting dynamic subtest: pipe-D-eDP-1
[502.415430] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s)
[502.417795] Subtest 64x64-top-edge: SUCCESS (6.589s)
[503.218957] [131/133] (521s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[503.314770] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[503.319008] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[503.415480] [132/133] (520s left) gem_lmem_swapping (parallel-random)
[503.457377] Subtest parallel-random: SKIP (0.000s)
[503.499654] [133/133] (520s left) kms_force_connector_basic (prune-stale-modes)
[503.574930] Starting subtest: prune-stale-modes
[504.014464] Subtest prune-stale-modes: SUCCESS (0.442s)
[504.149127] Closing watchdogs
results: parsing output: 0/ for test: kms_dp_link_training
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: gem_mmap
results: parsing output: 9/ for test: gem_tiled_blits
results: parsing output: 10/ for test: gem_wait
results: parsing output: 11/ for test: gen3_render_linear_blits
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_multipipe_modeset
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ppgtt
results: parsing output: 20/ for test: i915_pm_rc6_residency
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: prime_self_import
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: i915_suspend
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_sequence
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: gem_ctx_persistence
results: parsing output: 35/ for test: sysfs_heartbeat_interval
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: api_intel_bb
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: perf
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: prime_busy
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_fence_pin_leak
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: prime_mmap
results: parsing output: 54/ for test: syncobj_basic
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: kms_invalid_mode
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: dumb_buffer
results: parsing output: 67/ for test: kms_color_pipeline
results: parsing output: 68/ for test: syncobj_eventfd
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_chamelium_audio
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: kms_prop_blob
results: parsing output: 74/ for test: gem_ctx_exec
results: parsing output: 75/ for test: kms_vrr
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: gem_media_vme
results: parsing output: 78/ for test: kms_busy
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_workarounds
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_partial_pwrite_pread
results: parsing output: 83/ for test: gem_pipe_control_store_loop
results: parsing output: 84/ for test: i915_hangman
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: device_reset
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_exec_create
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_debugfs
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: gem_workarounds
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: gem_ctx_shared
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_chamelium_edid
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_chamelium_hpd
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_tiled_fence_blits
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_async_flips
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: gem_create
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_eio
results: parsing output: 122/ for test: gem_exec_suspend
results: parsing output: 123/ for test: kms_lease
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 129/ for test: kms_cursor_edge_walk
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_lmem_swapping
results: parsing output: 132/ for test: kms_force_connector_basic
Done.