[56.329403] Initializing watchdogs
[56.329500]   /dev/watchdog0
[56.344924] [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]
[56.349630] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.351950] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.355645] [001/156] (960s left) api_intel_allocator (standalone)
[56.434634] Starting subtest: standalone
[56.452617] Subtest standalone: SUCCESS (0.021s)
[56.578892] [002/156] (960s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[56.690104] Starting subtest: y-tiled-16bpp-rotate-180
[56.694382] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[56.782146] [003/156] (960s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[56.876799] Starting subtest: fbc-pr-cursor-mmap-cpu
[56.880862] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[56.944126] [004/156] (960s left) gem_mmap (short-mmap)
[57.009484] Subtest short-mmap: SKIP (0.000s)
[57.061802] [005/156] (959s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[57.160451] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[57.164239] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[57.276518] [006/156] (959s left) kms_force_connector_basic (force-edid)
[57.353567] Starting subtest: force-edid
[57.668512] Subtest force-edid: SUCCESS (0.310s)
[57.807344] [007/156] (959s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[57.914841] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[57.918546] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[58.016619] [008/156] (959s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[58.113571] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[58.115496] Starting dynamic subtest: pipe-A-eDP-1
[58.134262] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.141960] Starting dynamic subtest: pipe-B-eDP-1
[58.159856] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.167090] Starting dynamic subtest: pipe-C-eDP-1
[58.184740] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.191084] Starting dynamic subtest: pipe-D-eDP-1
[58.209136] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.212620] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[60.383733] [009/156] (956s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[60.484105] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[60.587143] [010/156] (956s left) kms_pm_dc (dc5-dpms-negative)
[61.682828] Starting subtest: dc5-dpms-negative
[61.687425] Subtest dc5-dpms-negative: SKIP (0.000s)
[61.755532] [011/156] (955s left) gem_exec_reloc (basic-active)
[61.824101] Subtest basic-active: SKIP (0.000s)
[61.888596] [012/156] (955s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt)
[61.993933] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt
[61.998080] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[62.083635] [013/156] (955s left) gem_eio (in-flight-contexts-1us)
[62.231082] Starting subtest: in-flight-contexts-1us
[76.321974] Subtest in-flight-contexts-1us: SUCCESS (14.038s)
[76.453141] [014/156] (940s left) api_intel_bb (simple-bb-ctx)
[76.511927] Starting subtest: simple-bb-ctx
[76.519903] Subtest simple-bb-ctx: SUCCESS (0.010s)
[76.651219] [015/156] (940s left) gem_mmap_gtt (basic-small-bo-tiledy)
[76.706063] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[76.755935] [016/156] (940s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[76.857588] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[76.862170] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[76.950260] [017/156] (940s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[77.049204] Starting subtest: extended-pageflip-modeset-hang-oldfb
[77.051585] Starting dynamic subtest: pipe-A
[84.998979] Dynamic subtest pipe-A: SUCCESS (7.940s)
[85.009126] Starting dynamic subtest: pipe-D
[93.637396] Dynamic subtest pipe-D: SUCCESS (8.632s)
[93.639888] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.577s)
[94.465386] [018/156] (923s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[94.574834] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[94.579126] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[94.662865] [019/156] (922s left) kms_atomic (plane-cursor-legacy)
[94.757798] Starting subtest: plane-cursor-legacy
[94.760719] Starting dynamic subtest: pipe-A-eDP-1
[95.146651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[95.149077] Subtest plane-cursor-legacy: SUCCESS (0.388s)
[95.966128] [020/156] (921s left) kms_cursor_legacy (torture-move)
[96.092174] Starting subtest: torture-move
[96.094355] Starting dynamic subtest: pipe-A
[101.921928] Dynamic subtest pipe-A: SUCCESS (5.823s)
[101.934050] Starting dynamic subtest: pipe-B
[108.598756] Dynamic subtest pipe-B: SUCCESS (6.675s)
[108.614761] Starting dynamic subtest: pipe-C
[115.642150] Dynamic subtest pipe-C: SUCCESS (7.041s)
[115.653165] Starting dynamic subtest: pipe-D
[123.828559] Dynamic subtest pipe-D: SUCCESS (8.185s)
[123.843238] Starting dynamic subtest: all-pipes
[130.335808] Dynamic subtest all-pipes: SUCCESS (6.506s)
[130.338239] Subtest torture-move: SUCCESS (34.234s)
[130.500557] [021/156] (887s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-pgflip-blt)
[130.601257] Starting subtest: hdr-2p-primscrn-shrfb-pgflip-blt
[130.605705] Subtest hdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[130.710849] [022/156] (886s left) kms_flip (flip-vs-modeset-vs-hang)
[130.807756] Starting subtest: flip-vs-modeset-vs-hang
[130.810132] Starting dynamic subtest: A-eDP1
[181.786045] Dynamic subtest A-eDP1: SUCCESS (50.976s)
[181.798063] Starting dynamic subtest: D-eDP1
[231.772102] Dynamic subtest D-eDP1: SUCCESS (49.982s)
[231.774573] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.963s)
[232.162009] [023/156] (785s left) i915_pm_rc6_residency (rc6-idle)
[232.215101] Starting subtest: rc6-idle
[232.254888] Starting dynamic subtest: gt0-rcs0
[256.544406] Dynamic subtest gt0-rcs0: SUCCESS (24.287s)
[256.555498] Starting dynamic subtest: gt0-bcs0
[280.818414] Dynamic subtest gt0-bcs0: SUCCESS (24.272s)
[280.826968] Starting dynamic subtest: gt0-ccs0
[305.099300] Dynamic subtest gt0-ccs0: SUCCESS (24.279s)
[305.108452] Starting dynamic subtest: gt1-vcs0
[311.272567] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[311.283244] Starting dynamic subtest: gt1-vecs0
[317.444231] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[317.446977] Subtest rc6-idle: SUCCESS (85.228s)
[317.559317] [024/156] (700s left) kms_content_protection (legacy)
[317.699242] Starting subtest: legacy
[317.703540] Subtest legacy: SKIP (0.000s)
[317.838044] [025/156] (699s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[317.937485] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[318.817386] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.881s)
[318.976991] [026/156] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[319.083123] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[319.087358] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[319.178199] [027/156] (698s left) kms_dsc (dsc-with-output-formats-with-bpc)
[319.274398] Starting subtest: dsc-with-output-formats-with-bpc
[319.330661] Subtest dsc-with-output-formats-with-bpc: SKIP (0.003s)
[319.365664] [028/156] (698s left) gem_exec_reloc (basic-gtt-wc-active)
[319.432355] Subtest basic-gtt-wc-active: SKIP (0.000s)
[319.501642] [029/156] (698s left) syncobj_timeline (single-wait-available-submitted)
[319.547926] Starting subtest: single-wait-available-submitted
[319.549908] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[319.640117] [030/156] (698s left) sysfs_preempt_timeout (timeout)
[319.702055] Starting subtest: timeout
[319.704510] Starting dynamic subtest: vecs0
[329.277273] Dynamic subtest vecs0: SUCCESS (9.571s)
[329.287235] Starting dynamic subtest: ccs0
[330.544077] Dynamic subtest ccs0: SUCCESS (1.267s)
[330.553139] Starting dynamic subtest: vcs0
[340.283315] Dynamic subtest vcs0: SUCCESS (9.736s)
[340.293816] Starting dynamic subtest: bcs0
[341.504916] Dynamic subtest bcs0: SUCCESS (1.222s)
[341.516468] Starting dynamic subtest: rcs0
[342.755040] Dynamic subtest rcs0: SUCCESS (1.248s)
[342.768086] Starting dynamic subtest: vcs1
[352.315072] Dynamic subtest vcs1: SUCCESS (9.558s)
[352.317770] Subtest timeout: SUCCESS (32.611s)
[352.386775] [031/156] (665s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[352.505821] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[359.844766] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.345s)
[359.969897] [032/156] (658s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[360.353182] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[361.139053] [033/156] (657s left) gen3_render_tiledy_blits
[361.255868] [034/156] (656s left) kms_flip (modeset-vs-vblank-race)
[361.347696] Starting subtest: modeset-vs-vblank-race
[361.349801] Starting dynamic subtest: A-eDP1
[366.038745] Dynamic subtest A-eDP1: SUCCESS (4.692s)
[366.051402] Starting dynamic subtest: B-eDP1
[370.742749] Dynamic subtest B-eDP1: SUCCESS (4.703s)
[370.753544] Starting dynamic subtest: C-eDP1
[375.420760] Dynamic subtest C-eDP1: SUCCESS (4.676s)
[375.435599] Starting dynamic subtest: D-eDP1
[380.119676] Dynamic subtest D-eDP1: SUCCESS (4.696s)
[380.125063] Subtest modeset-vs-vblank-race: SUCCESS (18.779s)
[381.346212] [035/156] (636s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[381.444748] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[381.449145] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[381.543282] [036/156] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[381.643123] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[381.647337] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[381.734873] [037/156] (636s left) dmabuf_sync_file (import-multiple-read-write)
[381.833335] Starting subtest: import-multiple-read-write
[381.835600] Subtest import-multiple-read-write: SUCCESS (0.003s)
[381.891662] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[381.894854] [038/156] (636s left) gem_create (busy-create)
[381.950096] Starting subtest: busy-create
[381.953067] Starting dynamic subtest: smem0
[415.232397] Dynamic subtest smem0: SUCCESS (33.279s)
[415.234846] Subtest busy-create: SUCCESS (33.280s)
[415.432186] [039/156] (602s left) gem_gpgpu_fill (basic)
[415.492845] Starting subtest: basic
[415.495108] Starting dynamic subtest: smem
[415.504428] Dynamic subtest smem: SUCCESS (0.013s)
[415.506916] Subtest basic: SUCCESS (0.014s)
[415.646123] [040/156] (602s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[415.750800] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[415.754952] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[415.845936] [041/156] (602s left) gem_exec_schedule (thriceslice)
[415.914708] Starting subtest: thriceslice
[415.916644] Starting dynamic subtest: rcs0
[415.936814] Dynamic subtest rcs0: SUCCESS (0.032s)
[415.947557] Starting dynamic subtest: bcs0
[415.992226] Dynamic subtest bcs0: SUCCESS (0.053s)
[416.003761] Starting dynamic subtest: vcs0
[416.022429] Dynamic subtest vcs0: SUCCESS (0.029s)
[416.031841] Starting dynamic subtest: vcs1
[416.052252] Dynamic subtest vcs1: SUCCESS (0.029s)
[416.061028] Starting dynamic subtest: vecs0
[416.083494] Dynamic subtest vecs0: SUCCESS (0.031s)
[416.092328] Starting dynamic subtest: ccs0
[416.117882] Dynamic subtest ccs0: SUCCESS (0.033s)
[416.120217] Subtest thriceslice: SUCCESS (0.214s)
[417.320518] [042/156] (601s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[417.415754] Starting subtest: pr-overlay-plane-move-continuous-sf
[417.420160] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[417.491652] [043/156] (601s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[417.590448] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[417.592673] Starting dynamic subtest: pipe-A-default-mode
[418.777250] Dynamic subtest pipe-A-default-mode: SKIP (1.182s)
[418.781575] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.184s)
[418.921998] [044/156] (599s left) gem_tiled_fence_blits (normal)
[418.985079] Subtest normal: SKIP (0.000s)
[419.055157] [045/156] (599s left) gem_exec_reloc (basic-cpu-read-noreloc)
[419.104847] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[419.178976] [046/156] (599s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[419.274965] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[419.279074] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[419.387329] [047/156] (599s left) i915_query (query-topology-matches-eu-total)
[419.440885] Starting subtest: query-topology-matches-eu-total
[419.443090] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[419.534798] [048/156] (599s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[419.585436] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[419.695085] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[419.795634] [049/156] (599s left) kms_vblank (wait-forked-busy-hang)
[419.892546] Starting subtest: wait-forked-busy-hang
[419.894576] Starting dynamic subtest: pipe-A-eDP-1
[434.054655] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.162s)
[434.071423] Starting dynamic subtest: pipe-D-eDP-1
[449.080168] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.022s)
[449.082032] Subtest wait-forked-busy-hang: SUCCESS (29.188s)
[449.954527] [050/156] (568s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[450.061521] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[450.065687] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[450.168057] [051/156] (568s left) syncobj_wait (invalid-signal-bad-pad)
[450.227526] Starting subtest: invalid-signal-bad-pad
[450.229905] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[450.333627] [052/156] (568s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[450.437091] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[450.441265] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[450.519200] [053/156] (568s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[450.625331] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[457.085259] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.464s)
[457.224324] [054/156] (561s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt)
[457.322594] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt
[457.327131] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[457.441900] [055/156] (561s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[457.583223] Starting subtest: cursor-rapid-movement-32x32
[457.629472] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[457.916271] [056/156] (561s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt)
[458.023216] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt
[458.026581] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[458.122854] [057/156] (561s left) prime_busy (after)
[458.181107] Starting subtest: after
[458.185582] Starting dynamic subtest: rcs0
[458.217851] Dynamic subtest rcs0: SUCCESS (0.033s)
[458.228886] Starting dynamic subtest: bcs0
[458.257422] Dynamic subtest bcs0: SUCCESS (0.039s)
[458.266938] Starting dynamic subtest: vcs0
[458.299353] Dynamic subtest vcs0: SUCCESS (0.041s)
[458.308972] Starting dynamic subtest: vcs1
[458.340247] Dynamic subtest vcs1: SUCCESS (0.040s)
[458.349536] Starting dynamic subtest: vecs0
[458.381288] Dynamic subtest vecs0: SUCCESS (0.041s)
[458.390696] Starting dynamic subtest: ccs0
[458.421866] Dynamic subtest ccs0: SUCCESS (0.040s)
[458.529494] Subtest after: SUCCESS (0.346s)
[458.605836] [058/156] (560s left) gem_softpin (zero)
[458.659096] Starting subtest: zero
[458.666743] Subtest zero: SUCCESS (0.005s)
[458.785210] [059/156] (560s left) perf_pmu (idle)
[458.821297] Starting subtest: idle
[458.823254] Starting dynamic subtest: rcs0
[459.371914] Dynamic subtest rcs0: SUCCESS (0.550s)
[459.383230] Starting dynamic subtest: bcs0
[459.903204] Dynamic subtest bcs0: SUCCESS (0.525s)
[459.912446] Starting dynamic subtest: vcs0
[460.426964] Dynamic subtest vcs0: SUCCESS (0.525s)
[460.439711] Starting dynamic subtest: vcs1
[460.947655] Dynamic subtest vcs1: SUCCESS (0.518s)
[460.960993] Starting dynamic subtest: vecs0
[461.479703] Dynamic subtest vecs0: SUCCESS (0.526s)
[461.489540] Starting dynamic subtest: ccs0
[461.994313] Dynamic subtest ccs0: SUCCESS (0.516s)
[461.996897] Subtest idle: SUCCESS (3.174s)
[462.093766] [060/156] (557s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[462.201193] Starting subtest: fbc-rgb565-draw-mmap-cpu
[466.242059] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.046s)
[467.476727] [061/156] (551s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[467.568319] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[467.570706] Starting dynamic subtest: pipe-A-eDP-1
[467.630071] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[467.639293] Starting dynamic subtest: pipe-B-eDP-1
[467.696620] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[467.707204] Starting dynamic subtest: pipe-C-eDP-1
[467.765595] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[467.776564] Starting dynamic subtest: pipe-D-eDP-1
[467.833618] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[467.838165] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[469.852483] [062/156] (549s left) kms_plane_alpha_blend (alpha-7efc)
[469.947756] Starting subtest: alpha-7efc
[470.230366] Starting dynamic subtest: pipe-A-eDP-1
[470.828983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[470.858307] Starting dynamic subtest: pipe-D-eDP-1
[472.118804] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.270s)
[472.121065] Subtest alpha-7efc: SUCCESS (2.172s)
[472.944868] [063/156] (546s left) kms_joiner (invalid-modeset-big-joiner)
[473.048268] Starting subtest: invalid-modeset-big-joiner
[473.052628] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[473.115841] [064/156] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[473.213992] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[480.434039] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.227s)
[480.572790] [065/156] (538s left) kms_cursor_crc (cursor-offscreen-32x10)
[480.737496] Starting subtest: cursor-offscreen-32x10
[480.786139] Subtest cursor-offscreen-32x10: SKIP (0.044s)
[481.060900] [066/156] (538s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-blt)
[481.160937] Starting subtest: fbchdr-rgb101010-draw-blt
[481.165126] Subtest fbchdr-rgb101010-draw-blt: SKIP (0.000s)
[481.266864] [067/156] (538s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[481.368537] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[481.370506] Starting dynamic subtest: pipe-A-eDP-1
[481.389074] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[481.400063] Starting dynamic subtest: pipe-B-eDP-1
[481.417444] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[481.425741] Starting dynamic subtest: pipe-C-eDP-1
[481.442959] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[481.451274] Starting dynamic subtest: pipe-D-eDP-1
[481.469590] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[481.472960] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[483.639116] [068/156] (535s left) kms_chamelium_hpd (hdmi-hpd-storm)
[484.021885] Subtest hdmi-hpd-storm: SKIP (0.000s)
[484.823436] [069/156] (534s left) gem_sync (basic-each)
[484.897303] Starting subtest: basic-each
[487.285937] Subtest basic-each: SUCCESS (2.398s)
[487.469432] [070/156] (532s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt)
[487.577115] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt
[487.581254] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[487.688686] [071/156] (532s left) gem_exec_nop (basic-sequential)
[487.766113] Starting subtest: basic-sequential
[502.798913] Subtest basic-sequential: SUCCESS (15.040s)
[503.042123] [072/156] (516s left) gem_mmap_gtt (cpuset-medium-copy)
[503.107214] Subtest cpuset-medium-copy: SKIP (0.000s)
[503.172852] [073/156] (516s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[503.272444] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[503.276681] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[503.359863] [074/156] (516s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[503.448653] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[503.451079] Starting dynamic subtest: pipe-A
[503.557976] Dynamic subtest pipe-A: SKIP (0.106s)
[503.567933] Starting dynamic subtest: pipe-B
[504.777052] Dynamic subtest pipe-B: SKIP (1.217s)
[504.787277] Starting dynamic subtest: pipe-C
[505.985504] Dynamic subtest pipe-C: SUCCESS (1.215s)
[505.999374] Starting dynamic subtest: pipe-D
[507.174649] Dynamic subtest pipe-D: SUCCESS (1.188s)
[507.177133] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.729s)
[508.357219] [075/156] (511s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[508.446495] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[508.471747] Starting dynamic subtest: pipe-A-plane-0
[508.760726] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[508.771630] Starting dynamic subtest: pipe-A-plane-3
[508.993916] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[510.101662] Starting dynamic subtest: pipe-B-plane-0
[510.388337] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[510.399479] Starting dynamic subtest: pipe-B-plane-3
[510.632728] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[510.941070] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.495s)
[511.750524] [076/156] (508s left) kms_psr (pr-primary-blt)
[511.847109] Starting subtest: pr-primary-blt
[511.851687] Subtest pr-primary-blt: SKIP (0.000s)
[511.925141] [077/156] (508s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-blt)
[512.031160] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-blt
[512.035214] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[512.126649] [078/156] (507s left) kms_flip (flip-vs-rmfb-interruptible)
[512.223228] Starting subtest: flip-vs-rmfb-interruptible
[512.225511] Starting dynamic subtest: A-eDP1
[520.904124] Dynamic subtest A-eDP1: SUCCESS (8.680s)
[520.916956] Starting dynamic subtest: B-eDP1
[529.592057] Dynamic subtest B-eDP1: SUCCESS (8.684s)
[529.604967] Starting dynamic subtest: C-eDP1
[538.281057] Dynamic subtest C-eDP1: SUCCESS (8.686s)
[538.290549] Starting dynamic subtest: D-eDP1
[546.911543] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[546.916816] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.693s)
[548.137220] [079/156] (471s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[548.236409] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[548.240316] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[548.336346] [080/156] (471s left) gen9_exec_parse (batch-without-end)
[548.393608] Subtest batch-without-end: SKIP (0.000s)
[548.452638] [081/156] (471s left) kms_selftest (drm_dp_mst_helper)
[548.489619] Starting subtest: drm_dp_mst_helper
[548.542194] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[548.628580] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.087s)
[548.640425] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[548.722704] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.091s)
[548.732103] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[548.827849] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.104s)
[548.829708] Subtest drm_dp_mst_helper: SUCCESS (0.336s)
[548.970230] [082/156] (471s left) perf (invalid-oa-format-id)
[549.091524] Starting subtest: invalid-oa-format-id
[549.100193] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[549.144629] [083/156] (471s left) gem_exec_reloc (basic-wc-gtt-active)
[549.196327] Subtest basic-wc-gtt-active: SKIP (0.000s)
[549.265754] [084/156] (471s left) kms_color (deep-color)
[549.357084] Starting subtest: deep-color
[550.486589] Starting dynamic subtest: pipe-A-eDP-1-gamma
[551.206103] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.719s)
[551.217146] Starting dynamic subtest: pipe-A-eDP-1-degamma
[552.635603] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.430s)
[552.645658] Starting dynamic subtest: pipe-A-eDP-1-ctm
[554.052728] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.415s)
[554.885857] Starting dynamic subtest: pipe-B-eDP-1-gamma
[555.582942] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.707s)
[555.593516] Starting dynamic subtest: pipe-B-eDP-1-degamma
[557.052610] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.472s)
[557.063992] Starting dynamic subtest: pipe-B-eDP-1-ctm
[558.542485] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.487s)
[559.387200] Starting dynamic subtest: pipe-C-eDP-1-gamma
[560.070043] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.692s)
[560.080050] Starting dynamic subtest: pipe-C-eDP-1-degamma
[561.504689] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.431s)
[561.516567] Starting dynamic subtest: pipe-C-eDP-1-ctm
[562.896846] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.392s)
[563.687606] Starting dynamic subtest: pipe-D-eDP-1-gamma
[564.382813] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.704s)
[564.392490] Starting dynamic subtest: pipe-D-eDP-1-degamma
[565.811311] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.429s)
[565.824405] Starting dynamic subtest: pipe-D-eDP-1-ctm
[567.209294] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.396s)
[567.211646] Subtest deep-color: SUCCESS (17.850s)
[568.049246] [085/156] (452s left) kms_sequence (queue-busy)
[568.132262] Starting subtest: queue-busy
[568.134639] Starting dynamic subtest: pipe-A-eDP-1
[570.070085] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[570.080529] Starting dynamic subtest: pipe-B-eDP-1
[572.702654] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.632s)
[572.712544] Starting dynamic subtest: pipe-C-eDP-1
[575.285714] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.581s)
[575.295828] Starting dynamic subtest: pipe-D-eDP-1
[577.871202] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s)
[577.873626] Subtest queue-busy: SUCCESS (9.741s)
[578.743179] [086/156] (441s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[578.846741] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[583.045582] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.204s)
[584.244689] [087/156] (436s left) kms_prime (d3hot)
[584.328113] Subtest D3hot: SKIP (0.000s)
[584.422302] [088/156] (436s left) gem_ctx_persistence (engines-mixed)
[584.488768] Starting subtest: engines-mixed
[584.491098] Starting dynamic subtest: rcs0
[584.595333] Dynamic subtest rcs0: SUCCESS (0.105s)
[584.607079] Starting dynamic subtest: bcs0
[584.666927] Dynamic subtest bcs0: SUCCESS (0.069s)
[584.678924] Starting dynamic subtest: vcs0
[584.708617] Dynamic subtest vcs0: SUCCESS (0.040s)
[584.719079] Starting dynamic subtest: vcs1
[584.750429] Dynamic subtest vcs1: SUCCESS (0.040s)
[584.759776] Starting dynamic subtest: vecs0
[584.786553] Dynamic subtest vecs0: SUCCESS (0.035s)
[584.795952] Starting dynamic subtest: ccs0
[584.833632] Dynamic subtest ccs0: SUCCESS (0.045s)
[584.836082] Subtest engines-mixed: SUCCESS (0.346s)
[584.928307] [089/156] (435s left) kms_addfb_basic (invalid-get-prop-any)
[584.984647] Starting subtest: invalid-get-prop-any
[584.987388] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[585.106396] [090/156] (435s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[585.216448] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[586.182931] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.964s)
[587.032295] [091/156] (433s left) kms_psr (psr-basic)
[587.127958] Starting subtest: psr-basic
[587.130092] Starting dynamic subtest: eDP-1
[588.778822] Dynamic subtest eDP-1: SUCCESS (1.651s)
[588.781219] Subtest psr-basic: SUCCESS (1.652s)
[589.633040] [092/156] (430s left) gem_exec_schedule (noreorder-corked)
[589.817032] Starting subtest: noreorder-corked
[589.819225] Starting dynamic subtest: rcs0
[590.945839] Dynamic subtest rcs0: SUCCESS (1.131s)
[590.960623] Starting dynamic subtest: vcs0
[592.316729] Dynamic subtest vcs0: SUCCESS (1.367s)
[592.326539] Starting dynamic subtest: vcs1
[594.304419] Dynamic subtest vcs1: SUCCESS (1.985s)
[594.316319] Starting dynamic subtest: vecs0
[596.285072] Dynamic subtest vecs0: SUCCESS (1.979s)
[596.295743] Starting dynamic subtest: ccs0
[597.427798] Dynamic subtest ccs0: SUCCESS (1.141s)
[597.430327] Subtest noreorder-corked: SUCCESS (7.615s)
[597.617748] [093/156] (423s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[597.720771] Starting subtest: 2x-absolute-wf_vblank-interruptible
[597.731522] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[597.814861] [094/156] (422s left) gem_pxp (hw-rejects-pxp-buffer)
[597.935999] Starting subtest: hw-rejects-pxp-buffer
[597.940872] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[598.054280] [095/156] (422s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[598.108714] Starting subtest: basic-batch-kernel-default-cmd
[598.113147] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[598.293223] [096/156] (422s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[598.387891] Starting subtest: flip-vs-dpms-on-nop-interruptible
[598.390327] Starting dynamic subtest: A-eDP1
[600.294301] Dynamic subtest A-eDP1: SUCCESS (1.906s)
[600.303935] Starting dynamic subtest: B-eDP1
[602.205538] Dynamic subtest B-eDP1: SUCCESS (1.910s)
[602.215444] Starting dynamic subtest: C-eDP1
[604.088821] Dynamic subtest C-eDP1: SUCCESS (1.881s)
[604.101956] Starting dynamic subtest: D-eDP1
[605.884072] Dynamic subtest D-eDP1: SUCCESS (1.794s)
[605.886371] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.500s)
[607.125591] [097/156] (413s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[607.223428] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[607.225829] Starting dynamic subtest: pipe-A-eDP-1
[607.246031] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[607.255940] Starting dynamic subtest: pipe-B-eDP-1
[607.274766] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[607.283465] Starting dynamic subtest: pipe-C-eDP-1
[607.302586] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[607.311187] Starting dynamic subtest: pipe-D-eDP-1
[607.330594] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[607.332492] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[609.425291] [098/156] (411s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[609.530866] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[609.535271] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[609.628797] [099/156] (411s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[609.716895] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[609.721090] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[609.822453] [100/156] (411s left) gem_userptr_blits (stress-purge)
[609.893661] Starting subtest: stress-purge
[615.285113] Subtest stress-purge: SUCCESS (5.394s)
[615.414261] [101/156] (405s left) gem_caching (writes)
[615.511295] Subtest writes: SKIP (0.000s)
[615.592884] [102/156] (405s left) kms_plane_multiple (2x-tiling-none)
[615.690983] Starting subtest: 2x-tiling-none
[615.694637] Subtest 2x-tiling-none: SKIP (0.000s)
[615.766658] [103/156] (405s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[615.864228] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[623.312236] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.452s)
[623.450842] [104/156] (397s left) kms_psr (fbc-psr-cursor-blt)
[623.540125] Starting subtest: fbc-psr-cursor-blt
[623.542249] Starting dynamic subtest: eDP-1
[623.546113] Dynamic subtest eDP-1: SKIP (0.000s)
[623.549967] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[623.613391] [105/156] (397s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[623.710822] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[623.715307] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[623.820871] [106/156] (397s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-move)
[623.908905] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-move
[623.913331] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[624.014323] [107/156] (397s left) gem_exec_alignment (pi-isolated)
[624.075477] Starting subtest: pi-isolated
[672.609696] Subtest pi-isolated: SUCCESS (48.533s)
[673.542182] [108/156] (347s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[673.690584] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[673.694837] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[673.785549] [109/156] (347s left) perf (global-sseu-config-invalid)
[673.909957] Starting subtest: global-sseu-config-invalid
[673.914392] Subtest global-sseu-config-invalid: SKIP (0.000s)
[673.967613] [110/156] (347s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[674.062649] Starting subtest: x-tiled-16bpp-rotate-270
[674.081448] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[674.197409] [111/156] (347s left) kms_cursor_crc (cursor-sliding-32x10)
[674.360807] Starting subtest: cursor-sliding-32x10
[674.409331] Subtest cursor-sliding-32x10: SKIP (0.044s)
[674.664330] [112/156] (346s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[674.718037] Starting subtest: invalid-single-wait-unsubmitted
[674.719881] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[674.825863] [113/156] (346s left) kms_pm_dc (dc3co-vpb-simulation)
[675.921875] Starting subtest: dc3co-vpb-simulation
[684.558658] Subtest dc3co-vpb-simulation: SKIP (8.635s)
[684.703662] [114/156] (336s left) gem_exec_capture (userptr)
[684.774547] Starting subtest: userptr
[685.610067] Subtest userptr: SUCCESS (0.835s)
[685.766817] [115/156] (335s left) kms_getfb (getfb-reject-nv12)
[685.863300] Starting subtest: getfb-reject-nv12
[685.865539] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[685.960213] [116/156] (335s left) gem_render_copy (linear)
[686.024116] Starting subtest: linear
[686.026515] Starting dynamic subtest: smem
[686.064682] Dynamic subtest smem: SUCCESS (0.041s)
[686.067067] Subtest linear: SUCCESS (0.041s)
[686.323907] [117/156] (335s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[686.420748] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[686.425226] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[686.520230] [118/156] (335s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[686.575270] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[686.579517] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[686.776926] [119/156] (334s left) fbdev (eof)
[686.820901] Starting subtest: eof
[686.823252] Subtest eof: SUCCESS (0.000s)
[686.891745] [120/156] (334s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[686.992987] Starting subtest: fbc-rgb101010-draw-pwrite
[690.274811] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.288s)
[691.443433] [121/156] (330s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[691.500548] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[691.505214] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[691.685351] [122/156] (330s left) syncobj_wait (wait-any-interrupted)
[691.743371] Starting subtest: wait-any-interrupted
[691.845541] Subtest wait-any-interrupted: SUCCESS (0.103s)
[691.924187] [123/156] (330s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[692.025628] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[692.029753] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[692.136452] [124/156] (329s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[692.231748] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[692.236057] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[692.332550] [125/156] (329s left) gem_exec_balancer (bonded-semaphore)
[692.387292] Starting subtest: bonded-semaphore
[692.391818] Subtest bonded-semaphore: SKIP (0.000s)
[692.681966] [126/156] (329s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-pgflip-blt)
[692.777576] Starting subtest: hdr-2p-primscrn-indfb-pgflip-blt
[692.782150] Subtest hdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[692.871903] [127/156] (329s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[692.928254] Starting subtest: legacy-engines-hostile-preempt
[692.930418] Starting dynamic subtest: render
[693.007755] Dynamic subtest render: SUCCESS (0.081s)
[693.021047] Starting dynamic subtest: bsd1
[694.249427] Dynamic subtest bsd1: SUCCESS (1.237s)
[694.264247] Starting dynamic subtest: bsd2
[696.297296] Dynamic subtest bsd2: SUCCESS (2.045s)
[696.307874] Starting dynamic subtest: blt
[696.401948] Dynamic subtest blt: SUCCESS (0.104s)
[696.415377] Starting dynamic subtest: vebox
[698.281070] Dynamic subtest vebox: SUCCESS (1.875s)
[698.283851] Subtest legacy-engines-hostile-preempt: SUCCESS (5.355s)
[698.417709] [128/156] (323s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[698.521187] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[699.645838] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.124s)
[699.785031] [129/156] (322s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[699.885800] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[699.889181] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[699.969854] [130/156] (322s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[700.030772] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[700.094608] [131/156] (322s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[700.191121] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[700.194652] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[700.287980] [132/156] (322s left) gem_basic (create-fd-close)
[700.349095] Starting subtest: create-fd-close
[700.352817] Subtest create-fd-close: SUCCESS (0.000s)
[700.456920] [133/156] (321s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[700.553770] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[700.557039] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[700.662235] [134/156] (321s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[700.713407] Starting subtest: multi-wait-available-unsubmitted-submitted
[700.715506] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[700.808455] [135/156] (321s left) i915_drm_fdinfo (busy-idle-check-all)
[700.845075] Starting subtest: busy-idle-check-all
[700.846936] Starting dynamic subtest: rcs0
[700.850888] Dynamic subtest rcs0: SKIP (0.004s)
[700.866188] Starting dynamic subtest: bcs0
[700.869741] Dynamic subtest bcs0: SKIP (0.000s)
[700.878853] Starting dynamic subtest: vcs0
[700.882531] Dynamic subtest vcs0: SKIP (0.000s)
[700.891620] Starting dynamic subtest: vcs1
[700.895258] Dynamic subtest vcs1: SKIP (0.000s)
[700.904380] Starting dynamic subtest: vecs0
[700.907955] Dynamic subtest vecs0: SKIP (0.000s)
[700.917054] Starting dynamic subtest: ccs0
[700.920728] Dynamic subtest ccs0: SKIP (0.000s)
[700.924288] Subtest busy-idle-check-all: SKIP (0.009s)
[700.961249] [136/156] (321s left) gem_exec_fence (basic-wait-all)
[701.053504] Starting subtest: basic-wait-all
[701.161440] Subtest basic-wait-all: SUCCESS (0.109s)
[703.370452] [137/156] (319s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[703.423056] Starting subtest: single-wait-all-for-submit-unsubmitted
[703.526372] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[703.607049] [138/156] (318s left) kms_chamelium_color (ctm-0-50)
[703.714326] Subtest ctm-0-50: SKIP (0.000s)
[703.760110] [139/156] (318s left) kms_lease (lease-get)
[703.853798] Starting subtest: lease-get
[703.856096] Starting dynamic subtest: pipe-A-eDP-1
[703.858584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[703.872531] Starting dynamic subtest: pipe-B-eDP-1
[703.874395] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[703.884252] Starting dynamic subtest: pipe-C-eDP-1
[703.886092] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[703.895558] Starting dynamic subtest: pipe-D-eDP-1
[703.897496] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[703.899317] Subtest lease-get: SUCCESS (0.009s)
[703.965550] [140/156] (318s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[704.080262] Starting subtest: cursorB-vs-flipA-varying-size
[704.084701] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[704.223421] [141/156] (318s left) gem_userptr_blits (sync-overlap)
[704.287853] Starting subtest: sync-overlap
[704.290168] Subtest sync-overlap: SUCCESS (0.000s)
[704.432371] [142/156] (318s left) kms_psr (fbc-pr-sprite-plane-onoff)
[704.535249] Starting subtest: fbc-pr-sprite-plane-onoff
[704.539612] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[704.605288] [143/156] (318s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[704.696989] Starting subtest: yf-tiled-64bpp-rotate-270
[704.700458] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[704.780124] [144/156] (318s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[704.827874] Starting subtest: etime-single-wait-available-unsubmitted
[704.934804] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[705.015595] [145/156] (317s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[705.108147] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[705.112590] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[705.206832] [146/156] (317s left) i915_suspend (fence-restore-tiled2untiled)
[705.261641] Starting subtest: fence-restore-tiled2untiled
[705.266125] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[705.350268] [147/156] (317s left) gem_mmap_gtt (pf-nonblock)
[705.396118] Subtest pf-nonblock: SKIP (0.000s)
[705.454257] [148/156] (317s left) i915_module_load (reload)
[705.489383] Starting subtest: reload
[711.559727] Subtest reload: SUCCESS (6.071s)
[711.636700] [149/156] (311s left) perf (mi-rpc)
[711.768060] Starting subtest: mi-rpc
[711.771805] Subtest mi-rpc: SKIP (0.000s)
[711.843915] [150/156] (311s left) gem_exec_capture (capture)
[713.271558] Starting subtest: capture
[713.273716] Starting dynamic subtest: rcs0-smem
[714.074980] Dynamic subtest rcs0-smem: SUCCESS (0.801s)
[714.086198] Starting dynamic subtest: bcs0-smem
[714.874202] Dynamic subtest bcs0-smem: SUCCESS (0.801s)
[714.886048] Starting dynamic subtest: vcs0-smem
[715.671359] Dynamic subtest vcs0-smem: SUCCESS (0.796s)
[715.682932] Starting dynamic subtest: vcs1-smem
[716.549310] Dynamic subtest vcs1-smem: SUCCESS (0.878s)
[716.558421] Starting dynamic subtest: vecs0-smem
[717.442051] Dynamic subtest vecs0-smem: FAIL (0.828s)
[717.452881] Starting dynamic subtest: ccs0-smem
[718.699354] Dynamic subtest ccs0-smem: SUCCESS (1.317s)
[718.701798] Subtest capture: FAIL (5.426s)
[718.817626] [151/156] (304s left) gem_exec_fence (submit-chain)
[718.988051] Starting subtest: submit-chain
[719.017834] Subtest submit-chain: SUCCESS (0.033s)
[720.411865] [152/156] (302s left) sw_sync (alloc_merge_fence)
[720.450315] Starting subtest: alloc_merge_fence
[720.452632] Subtest alloc_merge_fence: SUCCESS (0.000s)
[720.507621] [153/156] (302s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[720.620614] Starting subtest: 4-tiled-32bpp-rotate-0
[722.064346] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.444s)
[722.195474] [154/156] (301s left) prime_self_import (basic-with_one_bo_two_files)
[722.233673] Starting subtest: basic-with_one_bo_two_files
[722.250073] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s)
[722.361945] [155/156] (300s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[722.462867] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[722.466424] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[722.566555] [156/156] (300s left) gem_exec_suspend (basic-s0)
[722.623475] Starting subtest: basic-S0
[722.625526] Starting dynamic subtest: smem
[742.699966] Dynamic subtest smem: SUCCESS (6.658s)
[742.703456] Subtest basic-S0: SUCCESS (6.660s)
[742.880146] Closing watchdogs
results: parsing output: 0/ for test: api_intel_allocator
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: gem_mmap
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_force_connector_basic
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: kms_pm_dc
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_eio
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_busy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_atomic
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: i915_pm_rc6_residency
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_dsc
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: sysfs_preempt_timeout
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: gen3_render_tiledy_blits
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: dmabuf_sync_file
results: parsing output: 37/ for test: gem_create
results: parsing output: 38/ for test: gem_gpgpu_fill
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: gem_tiled_fence_blits
results: parsing output: 44/ for test: gem_exec_reloc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_vblank
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: prime_busy
results: parsing output: 57/ for test: gem_softpin
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_plane_alpha_blend
results: parsing output: 62/ for test: kms_joiner
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_chamelium_hpd
results: parsing output: 68/ for test: gem_sync
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_nop
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: kms_color
results: parsing output: 84/ for test: kms_sequence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_prime
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: gem_pxp
results: parsing output: 94/ for test: gem_exec_flush
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: gem_caching
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_alignment
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_pm_dc
results: parsing output: 113/ for test: gem_exec_capture
results: parsing output: 114/ for test: kms_getfb
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: fbdev
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_pipe_b_c_ivb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_basic
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: syncobj_timeline
results: parsing output: 134/ for test: i915_drm_fdinfo
results: parsing output: 135/ for test: gem_exec_fence
results: parsing output: 136/ for test: syncobj_wait
results: parsing output: 137/ for test: kms_chamelium_color
results: parsing output: 138/ for test: kms_lease
results: parsing output: 139/ for test: kms_cursor_legacy
results: parsing output: 140/ for test: gem_userptr_blits
results: parsing output: 141/ for test: kms_psr
results: parsing output: 142/ for test: kms_big_fb
results: parsing output: 143/ for test: syncobj_timeline
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: i915_suspend
results: parsing output: 146/ for test: gem_mmap_gtt
results: parsing output: 147/ for test: i915_module_load
results: parsing output: 148/ for test: perf
results: parsing output: 149/ for test: gem_exec_capture
results: parsing output: 150/ for test: gem_exec_fence
results: parsing output: 151/ for test: sw_sync
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: prime_self_import
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: gem_exec_suspend
Done.