[60.007542] Initializing watchdogs
[60.007586]   /dev/watchdog0
[60.021586] [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]
[60.026546] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.029085] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.032294] [001/133] (960s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[60.158118] Starting subtest: yf-tiled-64bpp-rotate-90
[60.162772] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.002s)
[60.260746] [002/133] (960s left) i915_pm_rps (waitboost)
[60.317790] Starting subtest: waitboost
[66.655649] Subtest waitboost: SUCCESS (6.313s)
[66.727342] [003/133] (953s left) gem_exec_parallel (userptr)
[66.790145] Starting subtest: userptr
[66.792597] Starting dynamic subtest: rcs0
[68.602815] Dynamic subtest rcs0: SUCCESS (1.808s)
[68.613095] Starting dynamic subtest: bcs0
[70.132019] Dynamic subtest bcs0: SUCCESS (1.527s)
[70.142712] Starting dynamic subtest: vcs0
[71.891798] Dynamic subtest vcs0: SUCCESS (1.754s)
[71.899969] Starting dynamic subtest: vcs1
[73.876467] Dynamic subtest vcs1: SUCCESS (1.981s)
[73.886895] Starting dynamic subtest: vecs0
[75.924292] Dynamic subtest vecs0: SUCCESS (2.046s)
[75.933455] Starting dynamic subtest: ccs0
[77.385684] Dynamic subtest ccs0: SUCCESS (1.461s)
[77.388227] Subtest userptr: SUCCESS (10.583s)
[77.574459] [004/133] (943s left) gem_workarounds (suspend-resume-context)
[77.659515] Starting subtest: suspend-resume-context
[93.957807] Subtest suspend-resume-context: SUCCESS (1.292s)
[94.086332] [005/133] (926s left) i915_drm_fdinfo (virtual-busy)
[94.143253] Starting subtest: virtual-busy
[94.147734] Subtest virtual-busy: SKIP (0.000s)
[94.211660] [006/133] (926s left) gem_lmem_swapping (verify-random-ccs)
[94.249512] Subtest verify-random-ccs: SKIP (0.000s)
[94.289123] [007/133] (926s left) syncobj_timeline (invalid-transfer-bad-pad)
[94.338167] Starting subtest: invalid-transfer-bad-pad
[94.340356] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[94.419788] [008/133] (926s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[94.517532] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[94.522169] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[95.686923] [009/133] (925s left) kms_pm_rpm (cursor)
[100.509404] Starting subtest: cursor
[100.514674] Subtest cursor: SKIP (0.000s)
[101.265081] [010/133] (919s left) gem_exec_reloc (basic-write-cpu-active)
[101.330013] Subtest basic-write-cpu-active: SKIP (0.000s)
[101.397100] [011/133] (919s left) gem_render_linear_blits (basic)
[101.464814] Starting subtest: basic
[101.486128] Subtest basic: SUCCESS (0.022s)
[101.580104] [012/133] (919s left) gem_softpin (allocator-nopin-reserve)
[101.641160] Starting subtest: allocator-nopin-reserve
[101.716930] Subtest allocator-nopin-reserve: SUCCESS (0.074s)
[101.861551] [013/133] (919s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[101.963727] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[101.967905] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[102.043960] [014/133] (918s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[102.134403] Starting subtest: psr-modesetfrombusy
[108.349785] Subtest psr-modesetfrombusy: SUCCESS (6.171s)
[108.490289] [015/133] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[108.585492] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[108.589145] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[108.682753] [016/133] (912s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[108.736662] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[108.848270] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.110s)
[108.922983] [017/133] (912s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[108.976547] Starting subtest: multi-wait-all-for-submit-submitted
[109.078025] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[109.151359] [018/133] (912s left) syncobj_timeline (host-signal-ordered)
[109.195348] Starting subtest: host-signal-ordered
[109.197793] Subtest host-signal-ordered: SUCCESS (0.000s)
[109.286957] [019/133] (911s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[109.390865] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[109.395265] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[109.475111] [020/133] (911s left) api_intel_allocator (fork-simple-stress-signal)
[109.531481] Starting subtest: fork-simple-stress-signal
[115.000490] Subtest fork-simple-stress-signal: SUCCESS (5.402s)
[115.102515] [021/133] (906s left) gem_exec_balancer (bonded-sync)
[115.185659] Starting subtest: bonded-sync
[115.190438] Subtest bonded-sync: SKIP (0.000s)
[115.531864] [022/133] (905s left) kms_psr (psr2-suspend)
[115.634906] Starting subtest: psr2-suspend
[115.637384] Starting dynamic subtest: eDP-1
[133.354328] Dynamic subtest eDP-1: SUCCESS (7.362s)
[133.356715] Subtest psr2-suspend: SUCCESS (7.363s)
[134.145843] [023/133] (887s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[134.240836] Starting subtest: y-tiled-64bpp-rotate-90
[134.245336] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[134.329512] [024/133] (887s left) gem_userptr_blits (readonly-pwrite-unsync)
[134.392706] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[134.504829] [025/133] (886s left) gem_exec_schedule (u-independent)
[134.571283] Starting subtest: u-independent
[134.573470] Starting dynamic subtest: rcs0
[136.286320] Dynamic subtest rcs0: SUCCESS (1.722s)
[136.297795] Starting dynamic subtest: vcs0
[138.274867] Dynamic subtest vcs0: SUCCESS (1.986s)
[138.286153] Starting dynamic subtest: vcs1
[140.270874] Dynamic subtest vcs1: SUCCESS (1.993s)
[140.279681] Starting dynamic subtest: vecs0
[142.248302] Dynamic subtest vecs0: SUCCESS (1.974s)
[142.256856] Starting dynamic subtest: ccs0
[144.221690] Dynamic subtest ccs0: SUCCESS (1.972s)
[144.224495] Subtest u-independent: SUCCESS (9.651s)
[144.518438] [026/133] (876s left) kms_big_fb (x-tiled-addfb-size-overflow)
[144.630489] Starting subtest: x-tiled-addfb-size-overflow
[144.632898] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[144.735040] [027/133] (876s left) kms_cursor_edge_walk (128x128-top-edge)
[144.819147] Starting subtest: 128x128-top-edge
[144.821623] Starting dynamic subtest: pipe-A-eDP-1
[148.324650] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.502s)
[148.341696] Starting dynamic subtest: pipe-D-eDP-1
[151.439410] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[151.441887] Subtest 128x128-top-edge: SUCCESS (6.615s)
[152.267603] [028/133] (869s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[152.370215] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[152.372572] Starting dynamic subtest: pipe-A-eDP-1
[152.396135] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[152.414306] Starting dynamic subtest: pipe-B-eDP-1
[152.436510] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[152.445797] Starting dynamic subtest: pipe-C-eDP-1
[152.468072] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[152.477825] Starting dynamic subtest: pipe-D-eDP-1
[152.499523] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[152.503491] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[154.659359] [029/133] (867s left) kms_addfb_basic (invalid-get-prop-any)
[154.720847] Starting subtest: invalid-get-prop-any
[154.722914] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[154.849167] [030/133] (866s left) gem_pipe_control_store_loop (fresh-buffer)
[154.914487] Starting subtest: fresh-buffer
[157.068143] Subtest fresh-buffer: SUCCESS (2.151s)
[157.201506] [031/133] (864s left) perf (gen12-mi-rpc)
[157.328193] Starting subtest: gen12-mi-rpc
[157.330185] Starting dynamic subtest: rcs0
[157.346671] Dynamic subtest rcs0: SUCCESS (0.017s)
[157.349045] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[157.384482] [032/133] (864s left) gem_mmap_wc (bad-size)
[157.461413] Subtest bad-size: SKIP (0.000s)
[157.533034] [033/133] (864s left) gem_exec_reloc (basic-range-active)
[157.596545] Subtest basic-range-active: SKIP (0.000s)
[157.673164] [034/133] (864s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[157.728854] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[157.733429] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[157.924275] [035/133] (864s left) gen7_exec_parse (bitmasks)
[157.979777] Subtest bitmasks: SKIP (0.000s)
[158.043062] [036/133] (863s left) prime_busy (after-wait)
[158.099388] Starting subtest: after-wait
[158.104420] Starting dynamic subtest: rcs0
[158.142979] Dynamic subtest rcs0: SUCCESS (0.039s)
[158.152386] Starting dynamic subtest: bcs0
[158.198708] Dynamic subtest bcs0: SUCCESS (0.055s)
[158.209503] Starting dynamic subtest: vcs0
[158.240371] Dynamic subtest vcs0: SUCCESS (0.042s)
[158.249621] Starting dynamic subtest: vcs1
[158.282020] Dynamic subtest vcs1: SUCCESS (0.041s)
[158.289989] Starting dynamic subtest: vecs0
[158.324597] Dynamic subtest vecs0: SUCCESS (0.042s)
[158.333923] Starting dynamic subtest: ccs0
[158.367383] Dynamic subtest ccs0: SUCCESS (0.042s)
[158.475370] Subtest after-wait: SUCCESS (0.374s)
[158.549723] [037/133] (863s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[158.647388] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[159.249559] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.603s)
[159.422247] [038/133] (862s left) kms_big_fb (linear-8bpp-rotate-0)
[159.537819] Starting subtest: linear-8bpp-rotate-0
[160.728720] Subtest linear-8bpp-rotate-0: SUCCESS (1.192s)
[160.848925] [039/133] (861s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[160.944244] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[160.947665] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[161.020847] [040/133] (861s left) gem_ctx_persistence (engines-hang)
[161.081734] Starting subtest: engines-hang
[161.083836] Starting dynamic subtest: rcs0
[161.150384] Dynamic subtest rcs0: SUCCESS (0.068s)
[161.163637] Starting dynamic subtest: bcs0
[161.222290] Dynamic subtest bcs0: SUCCESS (0.071s)
[161.232620] Starting dynamic subtest: vcs0
[161.343367] Dynamic subtest vcs0: SUCCESS (0.120s)
[161.355186] Starting dynamic subtest: vcs1
[161.435382] Dynamic subtest vcs1: SUCCESS (0.091s)
[161.449798] Starting dynamic subtest: vecs0
[161.534339] Dynamic subtest vecs0: SUCCESS (0.098s)
[161.545792] Starting dynamic subtest: ccs0
[161.644277] Dynamic subtest ccs0: SUCCESS (0.109s)
[161.646575] Subtest engines-hang: SUCCESS (0.563s)
[161.718996] [041/133] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[161.815318] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[169.279073] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.342s)
[169.404708] [042/133] (852s left) gen7_exec_parse (basic-allocation)
[169.458339] Subtest basic-allocation: SKIP (0.000s)
[169.519225] [043/133] (852s left) kms_cursor_crc (cursor-offscreen-64x64)
[169.708245] Starting subtest: cursor-offscreen-64x64
[169.713056] Starting dynamic subtest: pipe-A-eDP-1
[171.685734] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.952s)
[171.715555] Starting dynamic subtest: pipe-D-eDP-1
[174.333822] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.602s)
[174.336211] Subtest cursor-offscreen-64x64: SUCCESS (4.578s)
[175.197492] [044/133] (847s left) syncobj_wait (wait-for-submit-snapshot)
[175.249571] Starting subtest: wait-for-submit-snapshot
[175.330608] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[175.404442] [045/133] (846s left) gem_unref_active_buffers
[175.625060] [046/133] (846s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[175.734148] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[183.169922] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.408s)
[183.294068] [047/133] (839s left) kms_cursor_crc (cursor-random-128x42)
[183.547502] Starting subtest: cursor-random-128x42
[183.595391] Subtest cursor-random-128x42: SKIP (0.043s)
[183.832454] [048/133] (838s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[184.416602] Starting subtest: syncobj-timeline-invalid-flags
[184.419207] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[186.348266] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[186.354172] [049/133] (836s left) drm_read (short-buffer-nonblock)
[186.503299] Starting subtest: short-buffer-nonblock
[186.505688] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[186.629623] [050/133] (835s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[186.729432] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[190.734589] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.003s)
[191.873583] [051/133] (830s left) gem_exec_params (no-blt)
[191.938775] Starting subtest: no-blt
[191.941252] Subtest no-blt: SUCCESS (0.002s)
[192.070795] [052/133] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[192.174351] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[192.178829] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[192.268520] [053/133] (830s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[192.366014] Starting subtest: psr-2p-primscrn-spr-indfb-move
[192.370320] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[192.459834] [054/133] (830s left) kms_pm_rpm (pm-tiling)
[194.388790] Starting subtest: pm-tiling
[194.394116] Subtest pm-tiling: SKIP (0.000s)
[194.763262] [055/133] (827s left) sysfs_heartbeat_interval (mixed)
[194.822140] Starting subtest: mixed
[194.824558] Starting dynamic subtest: vecs0
[200.079197] Dynamic subtest vecs0: SUCCESS (5.255s)
[200.091484] Starting dynamic subtest: ccs0
[205.273787] Dynamic subtest ccs0: SUCCESS (5.192s)
[205.285434] Starting dynamic subtest: vcs0
[210.514371] Dynamic subtest vcs0: SUCCESS (5.237s)
[210.525926] Starting dynamic subtest: bcs0
[215.701111] Dynamic subtest bcs0: SUCCESS (5.184s)
[215.710697] Starting dynamic subtest: rcs0
[220.864517] Dynamic subtest rcs0: SUCCESS (5.161s)
[220.875844] Starting dynamic subtest: vcs1
[226.085007] Dynamic subtest vcs1: SUCCESS (5.218s)
[226.087706] Subtest mixed: SUCCESS (31.256s)
[226.177261] [056/133] (796s left) gem_create (create-clear)
[226.232825] Starting subtest: create-clear
[226.235242] Starting dynamic subtest: smem0
[259.152511] Dynamic subtest smem0: SUCCESS (32.905s)
[259.154841] Subtest create-clear: SUCCESS (32.906s)
[259.340888] [057/133] (763s left) i915_hangman (detector)
[259.407384] Starting subtest: detector
[259.409819] Starting dynamic subtest: rcs0
[271.164769] Dynamic subtest rcs0: SUCCESS (11.760s)
[271.181094] Starting dynamic subtest: bcs0
[283.195962] Dynamic subtest bcs0: SUCCESS (12.031s)
[283.211446] Starting dynamic subtest: vcs0
[294.203799] Dynamic subtest vcs0: SUCCESS (11.006s)
[294.215169] Starting dynamic subtest: vcs1
[306.174204] Dynamic subtest vcs1: SUCCESS (11.967s)
[306.184965] Starting dynamic subtest: vecs0
[317.180051] Dynamic subtest vecs0: SUCCESS (11.002s)
[317.191671] Starting dynamic subtest: ccs0
[329.211723] Dynamic subtest ccs0: SUCCESS (12.027s)
[329.214548] Subtest detector: SUCCESS (69.805s)
[329.307123] [058/133] (693s left) kms_addfb_basic (basic)
[329.387043] Starting subtest: basic
[329.389017] Subtest basic: SUCCESS (0.000s)
[329.519766] [059/133] (693s left) kms_addfb_basic (bad-pitch-1024)
[329.569799] Starting subtest: bad-pitch-1024
[329.572086] Subtest bad-pitch-1024: SUCCESS (0.000s)
[329.722727] [060/133] (693s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[330.104893] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[330.877442] [061/133] (692s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[330.994968] Starting subtest: basic-flip-after-cursor-atomic
[331.909070] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.914s)
[332.732243] [062/133] (690s left) i915_pm_rpm (gem-execbuf-stress)
[334.350116] Starting subtest: gem-execbuf-stress
[334.352522] Starting dynamic subtest: smem0
[347.280245] Dynamic subtest smem0: SUCCESS (12.925s)
[347.294045] Starting dynamic subtest: extra-wait-smem0
[409.036250] Dynamic subtest extra-wait-smem0: SUCCESS (61.745s)
[409.038978] Subtest gem-execbuf-stress: SUCCESS (74.675s)
[409.416904] [063/133] (613s left) kms_draw_crc (draw-method-pwrite)
[409.520736] Starting subtest: draw-method-pwrite
[409.523039] Starting dynamic subtest: xrgb8888-untiled
[410.063733] Dynamic subtest xrgb8888-untiled: SUCCESS (0.544s)
[410.073473] Starting dynamic subtest: rgb565-untiled
[410.496936] Dynamic subtest rgb565-untiled: SUCCESS (0.433s)
[410.506804] Starting dynamic subtest: xrgb2101010-untiled
[411.030178] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.531s)
[411.040181] Starting dynamic subtest: xbgr16161616f-untiled
[411.797049] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.765s)
[411.807055] Starting dynamic subtest: xrgb8888-xtiled
[413.518618] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.720s)
[413.528723] Starting dynamic subtest: rgb565-xtiled
[414.574522] Dynamic subtest rgb565-xtiled: SUCCESS (1.055s)
[414.584643] Starting dynamic subtest: xrgb2101010-xtiled
[416.296372] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.722s)
[416.305952] Starting dynamic subtest: xbgr16161616f-xtiled
[419.506853] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.210s)
[419.516392] Starting dynamic subtest: xrgb8888-4tiled
[420.562131] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.055s)
[420.571356] Starting dynamic subtest: rgb565-4tiled
[421.095242] Dynamic subtest rgb565-4tiled: SUCCESS (0.532s)
[421.106467] Starting dynamic subtest: xrgb2101010-4tiled
[422.142436] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.044s)
[422.152318] Starting dynamic subtest: xbgr16161616f-4tiled
[425.039707] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.900s)
[425.042028] Subtest draw-method-pwrite: SUCCESS (15.523s)
[425.149529] [064/133] (597s left) kms_joiner (invalid-modeset-force-big-joiner)
[425.247394] Starting subtest: invalid-modeset-force-big-joiner
[425.251817] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[425.325282] [065/133] (597s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[425.418050] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[425.420271] Starting dynamic subtest: pipe-A-default-mode
[428.154922] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s)
[428.157409] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.739s)
[428.992579] [066/133] (594s left) gem_partial_pwrite_pread (reads-display)
[429.056696] Subtest reads-display: SKIP (0.000s)
[429.126696] [067/133] (594s left) perf_pmu (interrupts-sync)
[429.168967] Starting subtest: interrupts-sync
[430.254451] Subtest interrupts-sync: SUCCESS (1.085s)
[430.376450] [068/133] (592s left) kms_debugfs (display-on-read-all)
[430.470888] Starting subtest: display-on-read-all
[430.624895] Subtest display-on-read-all: SUCCESS (0.155s)
[430.749843] [069/133] (592s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[430.842109] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[437.259041] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.420s)
[437.352041] [070/133] (586s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[437.445803] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[437.450145] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[437.543385] [071/133] (585s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[437.663834] Starting subtest: short-flip-before-cursor-toggle
[438.579793] Subtest short-flip-before-cursor-toggle: SUCCESS (0.913s)
[439.427961] [072/133] (584s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[439.541024] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[439.544957] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[439.658852] [073/133] (583s left) kms_chamelium_edid (dp-edid-read)
[440.050795] Subtest dp-edid-read: SKIP (0.000s)
[440.833781] [074/133] (582s left) syncobj_wait (single-wait-all-submitted)
[440.892651] Starting subtest: single-wait-all-submitted
[440.995785] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[441.084719] [075/133] (582s left) gem_exec_fence (expired-history)
[441.521468] Starting subtest: expired-history
[448.923696] Subtest expired-history: SUCCESS (7.403s)
[449.493978] [076/133] (574s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[449.604261] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[449.608804] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[449.699593] [077/133] (574s left) gem_exec_schedule (implicit-read-write)
[449.769801] Starting subtest: implicit-read-write
[449.772106] Starting dynamic subtest: rcs0
[449.874795] Dynamic subtest rcs0: SUCCESS (0.113s)
[449.887792] Starting dynamic subtest: vcs0
[449.956871] Dynamic subtest vcs0: SUCCESS (0.081s)
[449.968187] Starting dynamic subtest: vcs1
[450.035957] Dynamic subtest vcs1: SUCCESS (0.077s)
[450.048205] Starting dynamic subtest: vecs0
[450.117944] Dynamic subtest vecs0: SUCCESS (0.081s)
[450.130572] Starting dynamic subtest: ccs0
[450.215258] Dynamic subtest ccs0: SUCCESS (0.096s)
[450.217655] Subtest implicit-read-write: SUCCESS (0.455s)
[451.409666] [078/133] (572s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[451.506462] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[451.510431] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[451.613417] [079/133] (572s left) kms_psr (pr-cursor-plane-onoff)
[451.712047] Starting subtest: pr-cursor-plane-onoff
[451.716094] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[451.795404] [080/133] (572s left) kms_psr (fbc-psr-cursor-render)
[451.887910] Starting subtest: fbc-psr-cursor-render
[451.890121] Starting dynamic subtest: eDP-1
[451.894202] Dynamic subtest eDP-1: SKIP (0.000s)
[451.898393] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[451.975798] [081/133] (571s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[452.075373] Starting subtest: fbcpsr-shrfb-scaledprimary
[457.823811] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.750s)
[457.963670] [082/133] (565s left) kms_flip (2x-busy-flip)
[458.056882] Starting subtest: 2x-busy-flip
[458.065162] Subtest 2x-busy-flip: SKIP (0.010s)
[458.158985] [083/133] (565s left) gem_ctx_persistence (legacy-engines-persistence)
[458.211509] Starting subtest: legacy-engines-persistence
[458.213836] Starting dynamic subtest: render
[458.974689] Dynamic subtest render: SUCCESS (0.762s)
[458.989549] Starting dynamic subtest: bsd1
[459.741676] Dynamic subtest bsd1: SUCCESS (0.764s)
[459.757147] Starting dynamic subtest: bsd2
[460.509831] Dynamic subtest bsd2: SUCCESS (0.765s)
[460.525482] Starting dynamic subtest: blt
[461.278600] Dynamic subtest blt: SUCCESS (0.766s)
[461.293192] Starting dynamic subtest: vebox
[462.043714] Dynamic subtest vebox: SUCCESS (0.762s)
[462.046372] Subtest legacy-engines-persistence: SUCCESS (3.833s)
[462.168477] [084/133] (561s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[462.234220] Starting subtest: mixed-tiled-to-y-tiled-ccs
[462.238317] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[462.438183] [085/133] (561s left) gem_exec_params (invalid-ring)
[462.503547] Starting subtest: invalid-ring
[462.505996] Subtest invalid-ring: SUCCESS (0.000s)
[462.607064] [086/133] (561s left) gem_close (basic)
[462.670503] Starting subtest: basic
[462.672371] Subtest basic: SUCCESS (0.000s)
[462.770269] [087/133] (561s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[462.865056] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[462.869378] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[462.968377] [088/133] (561s left) kms_lease (lease-get)
[463.070184] Starting subtest: lease-get
[463.072783] Starting dynamic subtest: pipe-A-eDP-1
[463.075506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[463.088714] Starting dynamic subtest: pipe-B-eDP-1
[463.090927] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[463.100859] Starting dynamic subtest: pipe-C-eDP-1
[463.103182] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[463.113674] Starting dynamic subtest: pipe-D-eDP-1
[463.115920] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[463.118088] Subtest lease-get: SUCCESS (0.009s)
[463.208114] [089/133] (561s left) gem_mmap_offset (partial-mmap)
[463.261617] Starting subtest: partial-mmap
[463.263565] Starting dynamic subtest: smem0
[463.265915] Dynamic subtest smem0: SUCCESS (0.004s)
[463.268093] Subtest partial-mmap: SUCCESS (0.004s)
[463.394858] [090/133] (560s left) gem_tiled_partial_pwrite_pread (reads)
[463.454052] Subtest reads: SKIP (0.000s)
[463.525014] [091/133] (560s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[463.620608] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[463.624156] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[463.736836] [092/133] (560s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[463.832713] Starting subtest: fbc-psr2-cursor-plane-update-sf
[463.834642] Starting dynamic subtest: pipe-A-eDP-1
[463.906204] Dynamic subtest pipe-A-eDP-1: SKIP (0.076s)
[463.917243] Starting dynamic subtest: pipe-B-eDP-1
[465.047216] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[465.052010] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.216s)
[466.227648] [093/133] (558s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[466.323878] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[466.327876] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[466.418301] [094/133] (558s left) gem_exec_reloc (basic-cpu-wc)
[466.474000] Subtest basic-cpu-wc: SKIP (0.000s)
[466.543720] [095/133] (558s left) kms_content_protection (lic-type-1)
[466.675626] Starting subtest: lic-type-1
[466.680359] Subtest lic-type-1: SKIP (0.000s)
[466.818620] [096/133] (557s left) kms_atomic (plane-invalid-params-fence)
[466.904011] Starting subtest: plane-invalid-params-fence
[466.906252] Starting dynamic subtest: pipe-A-eDP-1
[467.271265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.366s)
[467.273160] Subtest plane-invalid-params-fence: SUCCESS (0.367s)
[468.078506] [097/133] (556s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[468.167991] Starting subtest: bad-rotation-90-yf-tiled-ccs
[468.170149] Starting dynamic subtest: pipe-A-eDP-1
[468.191912] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[468.202353] Starting dynamic subtest: pipe-B-eDP-1
[468.223408] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[468.232966] Starting dynamic subtest: pipe-C-eDP-1
[468.253584] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[468.262959] Starting dynamic subtest: pipe-D-eDP-1
[468.283920] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[468.287867] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[470.438941] [098/133] (554s left) gem_lmem_swapping (massive-random)
[470.485832] Subtest massive-random: SKIP (0.000s)
[470.534209] [099/133] (554s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[470.620987] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[471.002660] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[473.817702] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.814s)
[473.831010] Starting dynamic subtest: pipe-A-eDP-1-4
[476.044716] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.171s)
[476.057813] Starting dynamic subtest: pipe-A-eDP-1-4
[478.002803] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[478.015390] Starting dynamic subtest: pipe-A-eDP-1-x
[480.193372] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[480.580408] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[483.350569] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.777s)
[483.360554] Starting dynamic subtest: pipe-B-eDP-1-4
[485.536425] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[485.546684] Starting dynamic subtest: pipe-B-eDP-1-4
[487.545800] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[487.558728] Starting dynamic subtest: pipe-B-eDP-1-x
[489.800458] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[490.112440] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[492.871903] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.766s)
[492.886509] Starting dynamic subtest: pipe-C-eDP-1-4
[495.067611] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.194s)
[495.080217] Starting dynamic subtest: pipe-C-eDP-1-4
[497.076400] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[497.086177] Starting dynamic subtest: pipe-C-eDP-1-x
[499.267573] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[499.636754] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[502.401295] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.771s)
[502.414341] Starting dynamic subtest: pipe-D-eDP-1-4
[504.566752] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[504.594498] Starting dynamic subtest: pipe-D-eDP-1-4
[506.575670] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[506.586443] Starting dynamic subtest: pipe-D-eDP-1-x
[508.753584] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[508.756535] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.130s)
[509.911822] [100/133] (514s left) kms_color (ctm-negative)
[510.002433] Starting subtest: ctm-negative
[510.004714] Starting dynamic subtest: pipe-A-eDP-1
[510.712870] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[510.723309] Starting dynamic subtest: pipe-B-eDP-1
[512.123271] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.412s)
[512.134078] Starting dynamic subtest: pipe-C-eDP-1
[513.508833] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[513.519635] Starting dynamic subtest: pipe-D-eDP-1
[514.869384] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.357s)
[514.871535] Subtest ctm-negative: SUCCESS (4.866s)
[515.752224] [101/133] (509s left) gem_fence_thrash (bo-write-verify-y)
[515.792426] Starting subtest: bo-write-verify-y
[515.809577] Subtest bo-write-verify-y: SKIP (0.016s)
[515.871769] [102/133] (508s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[515.956803] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[515.960886] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[516.028021] [103/133] (508s left) kms_psr (fbc-pr-primary-mmap-gtt)
[516.135092] Starting subtest: fbc-pr-primary-mmap-gtt
[516.139490] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[516.221168] [104/133] (508s left) core_getversion (basic)
[516.261493] Starting subtest: basic
[516.265492] Subtest basic: SUCCESS (0.000s)
[516.317420] [105/133] (508s left) kms_atomic_transition (plane-all-transition-fencing)
[516.406915] Starting subtest: plane-all-transition-fencing
[516.409259] Starting dynamic subtest: pipe-A-eDP-1
[518.900330] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[519.212843] Starting dynamic subtest: pipe-B-eDP-1
[522.481994] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.279s)
[522.789510] Subtest plane-all-transition-fencing: SUCCESS (6.382s)
[523.613076] [106/133] (501s left) gem_eio (in-flight-immediate)
[523.846955] Starting subtest: in-flight-immediate
[531.897379] Subtest in-flight-immediate: SUCCESS (8.047s)
[532.020209] [107/133] (493s left) kms_pm_backlight (bad-brightness)
[532.110098] Starting subtest: bad-brightness
[532.169099] Starting dynamic subtest: eDP-1
[532.474580] Dynamic subtest eDP-1: SUCCESS (0.305s)
[532.476960] Subtest bad-brightness: SUCCESS (0.367s)
[533.356993] [108/133] (491s left) kms_psr (psr-primary-page-flip)
[533.441709] Starting subtest: psr-primary-page-flip
[533.443927] Starting dynamic subtest: eDP-1
[535.148174] Dynamic subtest eDP-1: SUCCESS (1.706s)
[535.150426] Subtest psr-primary-page-flip: SUCCESS (1.707s)
[536.009533] [109/133] (489s left) gem_exec_store (pages)
[536.075136] Starting subtest: pages
[536.077184] Starting dynamic subtest: rcs0
[536.151984] Dynamic subtest rcs0: SUCCESS (0.079s)
[536.164750] Starting dynamic subtest: bcs0
[536.219025] Dynamic subtest bcs0: SUCCESS (0.066s)
[536.233400] Starting dynamic subtest: vcs0
[536.286492] Dynamic subtest vcs0: SUCCESS (0.067s)
[536.298182] Starting dynamic subtest: vcs1
[536.351323] Dynamic subtest vcs1: SUCCESS (0.064s)
[536.364556] Starting dynamic subtest: vecs0
[536.414985] Dynamic subtest vecs0: SUCCESS (0.062s)
[536.427485] Starting dynamic subtest: ccs0
[536.485366] Dynamic subtest ccs0: SUCCESS (0.069s)
[536.487856] Subtest pages: SUCCESS (0.414s)
[536.671137] [110/133] (488s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[536.771237] Starting subtest: extended-pageflip-modeset-hang-oldfb
[536.773426] Starting dynamic subtest: pipe-A
[544.659394] Dynamic subtest pipe-A: SUCCESS (7.888s)
[544.671350] Starting dynamic subtest: pipe-D
[553.306033] Dynamic subtest pipe-D: SUCCESS (8.642s)
[553.308433] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.534s)
[554.176162] [111/133] (471s left) perf_pmu (busy-start)
[554.230738] Starting subtest: busy-start
[554.232912] Starting dynamic subtest: rcs0
[556.781859] Dynamic subtest rcs0: SUCCESS (2.552s)
[556.794162] Starting dynamic subtest: bcs0
[559.354387] Dynamic subtest bcs0: SUCCESS (2.548s)
[559.366381] Starting dynamic subtest: vcs0
[563.293360] Dynamic subtest vcs0: SUCCESS (3.956s)
[563.305940] Starting dynamic subtest: vcs1
[567.261277] Dynamic subtest vcs1: SUCCESS (3.964s)
[567.274855] Starting dynamic subtest: vecs0
[571.292839] Dynamic subtest vecs0: SUCCESS (4.028s)
[571.306089] Starting dynamic subtest: ccs0
[573.864043] Dynamic subtest ccs0: SUCCESS (2.548s)
[573.866303] Subtest busy-start: SUCCESS (19.611s)
[573.968312] [112/133] (451s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[574.067016] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[574.068915] Starting dynamic subtest: pipe-A-eDP-1
[574.089123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[574.104122] Starting dynamic subtest: pipe-B-eDP-1
[574.123980] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[574.134435] Starting dynamic subtest: pipe-C-eDP-1
[574.154284] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[574.164505] Starting dynamic subtest: pipe-D-eDP-1
[574.184840] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[574.186693] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[576.332092] [113/133] (448s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[576.387840] Starting subtest: single-wait-all-for-submit-signaled
[576.390076] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[576.479993] [114/133] (448s left) gem_exec_schedule (smoketest-all)
[576.560723] Starting subtest: smoketest-all
[608.940002] Subtest smoketest-all: SUCCESS (32.329s)
[610.253676] [115/133] (415s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[610.351070] Starting subtest: primary-yf-tiled-reflect-x-180
[610.412901] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[610.518446] [116/133] (414s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[610.612965] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[610.615346] Starting dynamic subtest: pipe-A-eDP-1
[616.431697] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.819s)
[616.441863] Starting dynamic subtest: pipe-B-eDP-1
[623.080064] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.647s)
[623.082435] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.469s)
[623.960858] [117/133] (401s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[624.066893] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[630.652960] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.587s)
[630.790273] [118/133] (394s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[630.876844] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[630.879265] Starting dynamic subtest: pipe-A
[630.896664] Dynamic subtest pipe-A: SKIP (0.015s)
[630.917875] Starting dynamic subtest: pipe-B
[630.927346] Dynamic subtest pipe-B: SKIP (0.028s)
[630.945519] Starting dynamic subtest: pipe-C
[630.954600] Dynamic subtest pipe-C: SKIP (0.028s)
[630.964890] Starting dynamic subtest: pipe-D
[630.983250] Dynamic subtest pipe-D: SKIP (0.028s)
[630.987058] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.103s)
[631.092411] [119/133] (394s left) kms_universal_plane (cursor-fb-leak)
[631.187004] Starting subtest: cursor-fb-leak
[631.189234] Starting dynamic subtest: pipe-A-eDP-1
[631.529523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.344s)
[631.542457] Starting dynamic subtest: pipe-B-eDP-1
[632.907174] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s)
[632.922618] Starting dynamic subtest: pipe-C-eDP-1
[634.222636] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.312s)
[634.234959] Starting dynamic subtest: pipe-D-eDP-1
[635.562328] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[635.564946] Subtest cursor-fb-leak: SUCCESS (4.377s)
[636.723008] [120/133] (388s left) gem_exec_async (concurrent-writes)
[636.780483] Starting subtest: concurrent-writes
[636.782602] Starting dynamic subtest: rcs0
[636.794728] Dynamic subtest rcs0: SUCCESS (0.016s)
[636.811555] Starting dynamic subtest: bcs0
[636.813496] Dynamic subtest bcs0: SUCCESS (0.006s)
[636.823533] Starting dynamic subtest: vcs0
[636.825673] Dynamic subtest vcs0: SUCCESS (0.004s)
[636.838338] Starting dynamic subtest: vcs1
[636.840372] Dynamic subtest vcs1: SUCCESS (0.006s)
[636.851668] Starting dynamic subtest: vecs0
[636.853521] Dynamic subtest vecs0: SUCCESS (0.005s)
[636.863189] Starting dynamic subtest: ccs0
[636.865116] Dynamic subtest ccs0: SUCCESS (0.005s)
[636.867007] Subtest concurrent-writes: SUCCESS (0.048s)
[637.070250] [121/133] (388s left) syncobj_timeline (reset-signaled)
[637.122088] Starting subtest: reset-signaled
[637.124391] Subtest reset-signaled: SUCCESS (0.000s)
[637.221510] [122/133] (388s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[637.336373] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[637.341104] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[637.482385] [123/133] (388s left) kms_getfb (getfb-handle-protection)
[637.572550] Starting subtest: getfb-handle-protection
[637.593644] Subtest getfb-handle-protection: SUCCESS (0.024s)
[637.761271] [124/133] (388s left) kms_addfb_basic (bad-pitch-32)
[637.815085] Starting subtest: bad-pitch-32
[637.817048] Subtest bad-pitch-32: SUCCESS (0.000s)
[637.957211] [125/133] (387s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[638.059586] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[639.184392] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.123s)
[639.296629] [126/133] (386s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[639.389226] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[639.391209] Starting dynamic subtest: pipe-A-eDP-1
[639.408573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[639.421126] Starting dynamic subtest: pipe-B-eDP-1
[639.436877] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[639.446246] Starting dynamic subtest: pipe-C-eDP-1
[639.461791] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[639.470993] Starting dynamic subtest: pipe-D-eDP-1
[639.486824] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[639.488341] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[641.612726] [127/133] (384s left) kms_vblank (query-forked-hang)
[641.717726] Starting subtest: query-forked-hang
[641.719564] Starting dynamic subtest: pipe-A-eDP-1
[668.059000] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.354s)
[668.074210] Starting dynamic subtest: pipe-D-eDP-1
[683.027390] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.973s)
[683.029828] Subtest query-forked-hang: SUCCESS (41.332s)
[683.847375] [128/133] (342s left) kms_flip (flip-vs-absolute-wf_vblank)
[683.944779] Starting subtest: flip-vs-absolute-wf_vblank
[683.947066] Starting dynamic subtest: A-eDP1
[692.876695] Dynamic subtest A-eDP1: SUCCESS (8.934s)
[692.888505] Starting dynamic subtest: B-eDP1
[701.803083] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[701.816603] Starting dynamic subtest: C-eDP1
[710.769618] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[710.779684] Starting dynamic subtest: D-eDP1
[719.701750] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[719.703848] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.723s)
[720.983956] [129/133] (305s left) kms_pipe_crc_basic (hang-read-crc)
[721.076157] Starting subtest: hang-read-crc
[721.078180] Starting dynamic subtest: pipe-A-eDP-1
[723.153979] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.079s)
[723.164492] Starting dynamic subtest: pipe-B-eDP-1
[725.828137] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.672s)
[725.838625] Starting dynamic subtest: pipe-C-eDP-1
[728.452960] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.622s)
[728.464121] Starting dynamic subtest: pipe-D-eDP-1
[731.108487] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.656s)
[731.110834] Subtest hang-read-crc: SUCCESS (10.035s)
[731.961827] [130/133] (294s left) core_debugfs (read-all-entries)
[732.014390] Starting subtest: read-all-entries
[732.096033] Subtest read-all-entries: SUCCESS (0.082s)
[732.163513] [131/133] (293s left) gem_ccs (block-multicopy-compressed)
[732.228393] Starting subtest: block-multicopy-compressed
[732.232467] Subtest block-multicopy-compressed: SKIP (0.000s)
[732.344936] [132/133] (293s left) kms_plane_multiple (tiling-4)
[732.439903] Starting subtest: tiling-4
[732.442081] Starting dynamic subtest: pipe-A-eDP-1
[736.092970] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.654s)
[736.104931] Starting dynamic subtest: pipe-B-eDP-1
[740.441732] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.348s)
[740.452413] Starting dynamic subtest: pipe-C-eDP-1
[744.752948] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.310s)
[744.765181] Starting dynamic subtest: pipe-D-eDP-1
[749.104556] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.347s)
[749.106793] Subtest tiling-4: SUCCESS (16.664s)
[749.902688] [133/133] (276s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[750.010492] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[753.585172] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.582s)
[754.796764] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: i915_pm_rps
results: parsing output: 2/ for test: gem_exec_parallel
results: parsing output: 3/ for test: gem_workarounds
results: parsing output: 4/ for test: i915_drm_fdinfo
results: parsing output: 5/ for test: gem_lmem_swapping
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: gem_render_linear_blits
results: parsing output: 11/ for test: gem_softpin
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: api_intel_allocator
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_cursor_edge_walk
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: gem_pipe_control_store_loop
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_mmap_wc
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: gen7_exec_parse
results: parsing output: 35/ for test: prime_busy
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gen7_exec_parse
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_unref_active_buffers
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: drm_read
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_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: sysfs_heartbeat_interval
results: parsing output: 55/ for test: gem_create
results: parsing output: 56/ for test: i915_hangman
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_chamelium_hpd
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: kms_draw_crc
results: parsing output: 63/ for test: kms_joiner
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: gem_partial_pwrite_pread
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_debugfs
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_chamelium_edid
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: gem_close
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_atomic
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: gem_lmem_swapping
results: parsing output: 98/ for test: kms_async_flips
results: parsing output: 99/ for test: kms_color
results: parsing output: 100/ for test: gem_fence_thrash
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: core_getversion
results: parsing output: 104/ for test: kms_atomic_transition
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_pm_backlight
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_exec_store
results: parsing output: 109/ for test: kms_busy
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: kms_rotation_crc
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_universal_plane
results: parsing output: 119/ for test: gem_exec_async
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_getfb
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_pipe_crc_basic
results: parsing output: 129/ for test: core_debugfs
results: parsing output: 130/ for test: gem_ccs
results: parsing output: 131/ for test: kms_plane_multiple
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.