[58.309336] Initializing watchdogs
[58.309384]   /dev/watchdog0
[58.326409] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.330688] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.332889] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.335957] [001/156] (960s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-plflip-blt)
[58.467636] Starting subtest: psrhdr-2p-primscrn-shrfb-plflip-blt
[58.472065] Subtest psrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[58.581739] [002/156] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[58.669411] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[58.671602] Starting dynamic subtest: pipe-A
[59.793587] Dynamic subtest pipe-A: SUCCESS (1.131s)
[59.801277] Starting dynamic subtest: pipe-B
[62.213085] Dynamic subtest pipe-B: SUCCESS (2.427s)
[62.221901] Starting dynamic subtest: pipe-C
[63.405967] Dynamic subtest pipe-C: SUCCESS (1.195s)
[63.414933] Starting dynamic subtest: pipe-D
[64.633230] Dynamic subtest pipe-D: SUCCESS (1.229s)
[64.635613] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.984s)
[65.820006] [003/156] (953s left) i915_pm_freq_api (freq-reset-multiple)
[65.889319] Starting subtest: freq-reset-multiple
[65.891311] Starting dynamic subtest: gt0
[73.540557] Dynamic subtest gt0: SUCCESS (7.658s)
[73.548253] Starting dynamic subtest: gt1
[80.422047] Dynamic subtest gt1: SUCCESS (6.883s)
[80.424866] Subtest freq-reset-multiple: SUCCESS (14.542s)
[80.510319] [004/156] (938s left) kms_chamelium_color (ctm-negative)
[80.612739] Subtest ctm-negative: SKIP (0.000s)
[80.656498] [005/156] (938s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[80.754106] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[80.758071] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[80.818236] [006/156] (938s left) device_reset (unbind-cold-reset-rebind)
[80.872546] Starting subtest: unbind-cold-reset-rebind
[80.876547] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[80.939962] [007/156] (938s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[81.048614] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[81.052708] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[81.165574] [008/156] (937s left) gem_userptr_blits (dmabuf-unsync)
[81.229518] Subtest dmabuf-unsync: SKIP (0.000s)
[81.334552] [009/156] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[81.431472] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[81.435166] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[81.514195] [010/156] (937s left) prime_vgem (fence-read-hang)
[81.614133] Subtest fence-read-hang: SKIP (0.000s)
[81.694435] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[81.697420] [011/156] (937s left) syncobj_timeline (invalid-wait-illegal-handle)
[81.757505] Starting subtest: invalid-wait-illegal-handle
[81.759583] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[81.846707] [012/156] (937s left) kms_cursor_crc (cursor-size-hints)
[81.981815] Starting subtest: cursor-size-hints
[81.984222] Starting dynamic subtest: pipe-A-eDP-1
[82.618421] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[82.628708] Starting dynamic subtest: pipe-D-eDP-1
[83.878950] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.259s)
[83.881443] Subtest cursor-size-hints: SUCCESS (1.896s)
[84.690994] [013/156] (934s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[84.788265] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[88.827672] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.047s)
[89.998851] [014/156] (929s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[90.375249] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[91.195936] [015/156] (928s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[91.304941] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[91.309305] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[91.409386] [016/156] (928s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[91.529353] Starting subtest: cursorA-vs-flipA-varying-size
[102.665747] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.136s)
[103.551341] [017/156] (915s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[103.645880] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[103.648118] Starting dynamic subtest: pipe-A-eDP-1
[103.670386] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.683607] Starting dynamic subtest: pipe-B-eDP-1
[103.705032] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.713578] Starting dynamic subtest: pipe-C-eDP-1
[103.735275] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.744022] Starting dynamic subtest: pipe-D-eDP-1
[103.765770] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.770169] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[105.901566] [018/156] (913s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[106.000932] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[106.005080] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[106.071903] [019/156] (913s left) gem_pxp (display-protected-crc)
[106.198532] Starting subtest: display-protected-crc
[107.865222] Subtest display-protected-crc: SUCCESS (1.669s)
[107.982294] [020/156] (911s left) gem_ctx_shared (disjoint-timelines)
[108.037600] Starting subtest: disjoint-timelines
[108.059036] Subtest disjoint-timelines: SUCCESS (0.021s)
[108.287147] [021/156] (911s left) kms_async_flips (test-cursor-atomic)
[108.374166] Starting subtest: test-cursor-atomic
[108.746923] Starting dynamic subtest: pipe-A-eDP-1
[109.598380] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s)
[109.978412] Starting dynamic subtest: pipe-B-eDP-1
[110.739717] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.768s)
[111.129439] Starting dynamic subtest: pipe-C-eDP-1
[111.880647] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[112.242419] Starting dynamic subtest: pipe-D-eDP-1
[113.002782] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[113.005117] Subtest test-cursor-atomic: SUCCESS (4.631s)
[114.181543] [022/156] (905s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[114.281015] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[114.285451] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[114.381010] [023/156] (905s left) kms_psr (fbc-psr2-sprite-plane-move)
[114.469034] Starting subtest: fbc-psr2-sprite-plane-move
[114.471324] Starting dynamic subtest: eDP-1
[114.475379] Dynamic subtest eDP-1: SKIP (0.000s)
[114.479468] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[114.546136] [024/156] (905s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[114.648062] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[118.261256] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.620s)
[119.473218] [025/156] (900s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[119.565231] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[119.569233] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[119.667152] [026/156] (900s left) kms_psr (pr-cursor-plane-move)
[119.749757] Starting subtest: pr-cursor-plane-move
[119.754153] Subtest pr-cursor-plane-move: SKIP (0.000s)
[119.836876] [027/156] (900s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[119.877535] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[119.922986] [028/156] (900s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[120.020567] Starting subtest: psr-rgb565-draw-pwrite
[127.207619] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.194s)
[127.322788] [029/156] (892s left) perf (global-sseu-config-invalid)
[127.441456] Starting subtest: global-sseu-config-invalid
[127.445103] Subtest global-sseu-config-invalid: SKIP (0.000s)
[127.487958] [030/156] (892s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[128.010973] Starting subtest: syncobj-stationary-timeline-chain-engines
[128.119835] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.109s)
[129.414721] [031/156] (890s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[129.521389] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[129.525783] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[129.607988] [032/156] (890s left) i915_pm_rpm (gem-evict-pwrite)
[131.548068] Starting subtest: gem-evict-pwrite
[131.552914] Subtest gem-evict-pwrite: SKIP (0.000s)
[131.947008] [033/156] (888s left) gem_madvise (dontneed-before-pwrite)
[131.987283] Starting subtest: dontneed-before-pwrite
[132.005440] Subtest dontneed-before-pwrite: SKIP (0.015s)
[132.060445] [034/156] (888s left) kms_chamelium_hpd (hdmi-hpd-storm)
[132.437614] Subtest hdmi-hpd-storm: SKIP (0.000s)
[133.243295] [035/156] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[133.354764] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[133.358598] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[133.438685] [036/156] (886s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[133.548602] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[133.552833] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[133.647778] [037/156] (886s left) gem_mmap_gtt (hang-user)
[133.714198] Subtest hang-user: SKIP (0.000s)
[133.772970] [038/156] (886s left) gem_exec_schedule (submit-golden-slice)
[133.843576] Starting subtest: submit-golden-slice
[133.845731] Starting dynamic subtest: rcs0
[133.874559] Dynamic subtest rcs0: SUCCESS (0.036s)
[133.883780] Starting dynamic subtest: bcs0
[133.903790] Dynamic subtest bcs0: SUCCESS (0.029s)
[133.912399] Starting dynamic subtest: vcs0
[133.938896] Dynamic subtest vcs0: SUCCESS (0.034s)
[133.947595] Starting dynamic subtest: vcs1
[133.977407] Dynamic subtest vcs1: SUCCESS (0.038s)
[133.986297] Starting dynamic subtest: vecs0
[134.009935] Dynamic subtest vecs0: SUCCESS (0.032s)
[134.018424] Starting dynamic subtest: ccs0
[134.042095] Dynamic subtest ccs0: SUCCESS (0.031s)
[134.044420] Subtest submit-golden-slice: SUCCESS (0.205s)
[135.412995] [039/156] (885s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[135.468090] Starting subtest: legacy-engines-hostile-preempt
[135.470433] Starting dynamic subtest: render
[135.536615] Dynamic subtest render: SUCCESS (0.068s)
[135.547310] Starting dynamic subtest: bsd1
[137.291567] Dynamic subtest bsd1: SUCCESS (1.751s)
[137.302663] Starting dynamic subtest: bsd2
[139.275970] Dynamic subtest bsd2: SUCCESS (1.982s)
[139.286914] Starting dynamic subtest: blt
[139.322350] Dynamic subtest blt: SUCCESS (0.046s)
[139.332641] Starting dynamic subtest: vebox
[141.345484] Dynamic subtest vebox: SUCCESS (2.020s)
[141.348448] Subtest legacy-engines-hostile-preempt: SUCCESS (5.877s)
[141.437877] [040/156] (879s left) kms_frontbuffer_tracking (psrhdr-1p-rte)
[141.546958] Starting subtest: psrhdr-1p-rte
[141.551087] Subtest psrhdr-1p-rte: SKIP (0.000s)
[141.642043] [041/156] (878s left) kms_psr2_su (frontbuffer-xrgb8888)
[141.707955] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[141.774077] [042/156] (878s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[141.869499] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[141.873573] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[141.969136] [043/156] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[142.060642] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[149.479271] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.424s)
[149.613790] [044/156] (871s left) gem_eio (in-flight-contexts-10ms)
[149.855654] Starting subtest: in-flight-contexts-10ms
[163.379517] Subtest in-flight-contexts-10ms: SUCCESS (13.521s)
[163.516352] [045/156] (857s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[163.622796] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[163.626865] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[163.719499] [046/156] (856s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[163.822817] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[163.827208] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[163.921449] [047/156] (856s left) kms_content_protection (suspend-resume)
[164.047352] Starting subtest: suspend-resume
[164.051768] Subtest suspend-resume: SKIP (0.000s)
[164.163749] [048/156] (856s left) kms_psr (psr2-primary-page-flip)
[164.253967] Starting subtest: psr2-primary-page-flip
[164.256754] Starting dynamic subtest: eDP-1
[166.002421] Dynamic subtest eDP-1: SUCCESS (1.748s)
[166.004659] Subtest psr2-primary-page-flip: SUCCESS (1.749s)
[166.877635] [049/156] (853s left) gem_exec_capture (pi)
[166.926891] Starting subtest: pi
[166.929118] Starting dynamic subtest: rcs0
[171.369948] Dynamic subtest rcs0: SUCCESS (4.442s)
[171.384416] Starting dynamic subtest: bcs0
[175.492842] Dynamic subtest bcs0: SUCCESS (4.121s)
[175.503177] Starting dynamic subtest: vcs0
[179.626263] Dynamic subtest vcs0: SUCCESS (4.132s)
[179.638773] Starting dynamic subtest: vcs1
[183.688199] Dynamic subtest vcs1: SUCCESS (4.061s)
[183.699530] Starting dynamic subtest: vecs0
[187.776985] Dynamic subtest vecs0: SUCCESS (4.088s)
[187.791166] Starting dynamic subtest: ccs0
[191.888682] Dynamic subtest ccs0: SUCCESS (4.109s)
[191.891130] Subtest pi: SUCCESS (24.960s)
[191.969523] [050/156] (828s left) core_auth (many-magics)
[192.073398] Starting subtest: many-magics
[193.061144] Subtest many-magics: SUCCESS (0.989s)
[193.189808] [051/156] (827s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[193.256289] Starting subtest: mixed-tiled-to-y-tiled-ccs
[193.259956] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[193.439990] [052/156] (827s left) gem_exec_schedule (preempt-hang)
[193.633018] Starting subtest: preempt-hang
[193.635981] Starting dynamic subtest: rcs0
[193.885289] Dynamic subtest rcs0: SUCCESS (0.250s)
[193.896848] Starting dynamic subtest: bcs0
[194.118880] Dynamic subtest bcs0: SUCCESS (0.235s)
[194.130894] Starting dynamic subtest: vcs0
[194.344192] Dynamic subtest vcs0: SUCCESS (0.222s)
[194.353999] Starting dynamic subtest: vcs1
[194.568652] Dynamic subtest vcs1: SUCCESS (0.223s)
[194.578111] Starting dynamic subtest: vecs0
[194.789087] Dynamic subtest vecs0: SUCCESS (0.220s)
[194.800096] Starting dynamic subtest: ccs0
[195.031086] Dynamic subtest ccs0: SUCCESS (0.241s)
[195.032992] Subtest preempt-hang: SUCCESS (1.397s)
[195.449774] [053/156] (825s left) gen9_exec_parse (batch-invalid-length)
[195.497240] Subtest batch-invalid-length: SKIP (0.000s)
[195.566425] [054/156] (825s left) kms_vrr (flipline)
[195.663932] Starting subtest: flipline
[195.670594] Subtest flipline: SKIP (0.000s)
[195.750243] [055/156] (825s left) gem_exec_reloc (basic-write-cpu-noreloc)
[195.801979] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[195.868612] [056/156] (825s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[195.968572] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[197.083968] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.117s)
[197.193023] [057/156] (823s left) kms_addfb_basic (bad-pitch-128)
[197.250932] Starting subtest: bad-pitch-128
[197.252911] Subtest bad-pitch-128: SUCCESS (0.000s)
[197.382956] [058/156] (823s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[197.488125] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[197.491889] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[197.589984] [059/156] (823s left) gem_workarounds (suspend-resume)
[197.675824] Starting subtest: suspend-resume
[214.329870] Subtest suspend-resume: SUCCESS (1.710s)
[220.492625] [060/156] (806s left) kms_psr (fbc-psr-dpms)
[220.595618] Starting subtest: fbc-psr-dpms
[220.597893] Starting dynamic subtest: eDP-1
[220.601852] Dynamic subtest eDP-1: SKIP (0.000s)
[220.605855] Subtest fbc-psr-dpms: SKIP (0.001s)
[220.669395] [061/156] (806s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[220.767537] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[220.780922] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.012s)
[220.857335] [062/156] (806s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[220.970759] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[220.973013] Starting dynamic subtest: pipe-A-eDP-1
[220.996354] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[221.009093] Starting dynamic subtest: pipe-B-eDP-1
[221.030426] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[221.040160] Starting dynamic subtest: pipe-C-eDP-1
[221.061407] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[221.070972] Starting dynamic subtest: pipe-D-eDP-1
[221.092332] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[221.096687] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[223.228051] [063/156] (804s left) perf_pmu (semaphore-busy)
[223.274319] Starting subtest: semaphore-busy
[223.276137] Starting dynamic subtest: rcs0
[224.919524] Dynamic subtest rcs0: SUCCESS (1.653s)
[224.933135] Starting dynamic subtest: bcs0
[225.547096] Dynamic subtest bcs0: FAIL (0.580s)
[225.558675] Starting dynamic subtest: vcs0
[226.113511] Dynamic subtest vcs0: FAIL (0.554s)
[226.125039] Starting dynamic subtest: vcs1
[227.843130] Dynamic subtest vcs1: FAIL (1.736s)
[227.855149] Starting dynamic subtest: vecs0
[229.830765] Dynamic subtest vecs0: FAIL (1.990s)
[229.842939] Starting dynamic subtest: ccs0
[231.883952] Dynamic subtest ccs0: FAIL (2.056s)
[231.886300] Subtest semaphore-busy: FAIL (8.578s)
[231.931852] [064/156] (795s left) gem_ctx_param (invalid-get-engines)
[231.987293] Starting subtest: invalid-get-engines
[231.989457] Subtest invalid-get-engines: SUCCESS (0.001s)
[232.088001] [065/156] (795s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[232.188840] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[232.192830] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[232.295797] [066/156] (795s left) gem_exec_parallel (basic)
[232.349880] Starting subtest: basic
[232.352241] Starting dynamic subtest: rcs0
[233.983921] Dynamic subtest rcs0: SUCCESS (1.637s)
[233.996807] Starting dynamic subtest: bcs0
[235.486066] Dynamic subtest bcs0: SUCCESS (1.504s)
[235.497194] Starting dynamic subtest: vcs0
[237.248898] Dynamic subtest vcs0: SUCCESS (1.763s)
[237.260605] Starting dynamic subtest: vcs1
[239.297017] Dynamic subtest vcs1: SUCCESS (2.049s)
[239.310638] Starting dynamic subtest: vecs0
[241.280299] Dynamic subtest vecs0: SUCCESS (1.984s)
[241.293240] Starting dynamic subtest: ccs0
[242.779732] Dynamic subtest ccs0: SUCCESS (1.500s)
[242.782208] Subtest basic: SUCCESS (10.447s)
[242.971463] [067/156] (784s left) kms_pm_rpm (fences-dpms)
[244.512399] Starting subtest: fences-dpms
[244.517391] Subtest fences-dpms: SKIP (0.000s)
[245.239198] [068/156] (782s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[245.344375] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[249.680351] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.342s)
[250.826795] [069/156] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[250.926025] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[257.762757] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.842s)
[257.893311] [070/156] (769s left) i915_pm_rps (thresholds-idle)
[257.958169] Starting subtest: thresholds-idle
[257.962809] Subtest thresholds-idle: SKIP (0.001s)
[258.067678] [071/156] (769s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[258.132895] Starting subtest: multi-wait-available-submitted-signaled
[258.135468] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[258.240430] [072/156] (769s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[258.338406] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[258.340769] Starting dynamic subtest: pipe-A
[258.364805] Dynamic subtest pipe-A: SKIP (0.022s)
[258.376582] Starting dynamic subtest: pipe-B
[258.409013] Dynamic subtest pipe-B: SKIP (0.042s)
[258.420775] Starting dynamic subtest: pipe-C
[258.443886] Dynamic subtest pipe-C: SKIP (0.037s)
[258.455325] Starting dynamic subtest: pipe-D
[258.482536] Dynamic subtest pipe-D: SKIP (0.037s)
[258.486796] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.142s)
[258.581017] [073/156] (769s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[258.647598] Subtest writes-after-reads: SKIP (0.000s)
[258.717092] [074/156] (769s left) syncobj_timeline (single-wait-all-signaled)
[258.764172] Starting subtest: single-wait-all-signaled
[258.766195] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[258.859586] [075/156] (769s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[258.911186] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[258.914927] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[259.108008] [076/156] (768s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[259.208448] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[259.212608] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[259.295429] [077/156] (768s left) api_intel_bb (intel-bb-blit-none)
[259.344792] Starting subtest: intel-bb-blit-none
[263.498683] Subtest intel-bb-blit-none: SUCCESS (4.154s)
[263.638331] [078/156] (764s left) gem_exec_params (no-vebox)
[263.690858] Starting subtest: no-vebox
[263.696358] Subtest no-vebox: SUCCESS (0.003s)
[265.334592] [079/156] (762s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[265.431604] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-wc
[265.436073] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[265.541486] [080/156] (762s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[265.624907] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[265.627140] Starting dynamic subtest: pipe-A-eDP-1
[266.148029] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.495s)
[266.161116] Starting dynamic subtest: pipe-B-eDP-1
[267.632530] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.482s)
[267.645999] Starting dynamic subtest: pipe-C-eDP-1
[269.104962] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.473s)
[269.118636] Starting dynamic subtest: pipe-D-eDP-1
[270.537529] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.433s)
[270.539601] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.888s)
[271.681725] [081/156] (756s left) gem_vm_create (invalid-destroy)
[271.734374] Starting subtest: invalid-destroy
[271.736547] Subtest invalid-destroy: SUCCESS (0.002s)
[271.834281] [082/156] (756s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[271.954151] Starting subtest: basic-busy-flip-before-cursor-legacy
[271.959971] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[272.113731] [083/156] (756s left) kms_draw_crc (draw-method-blt)
[272.197023] Starting subtest: draw-method-blt
[272.199242] Starting dynamic subtest: xrgb8888-untiled
[272.461096] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[272.472848] Starting dynamic subtest: rgb565-untiled
[272.682842] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[272.693811] Starting dynamic subtest: xrgb2101010-untiled
[272.905209] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[272.916177] Starting dynamic subtest: xbgr16161616f-untiled
[273.127522] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[273.140030] Starting dynamic subtest: xrgb8888-xtiled
[273.249637] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[273.263193] Starting dynamic subtest: rgb565-xtiled
[273.371665] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[273.385215] Starting dynamic subtest: xrgb2101010-xtiled
[273.482836] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.109s)
[273.496499] Starting dynamic subtest: xbgr16161616f-xtiled
[273.595610] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.109s)
[273.606291] Starting dynamic subtest: xrgb8888-4tiled
[273.716215] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[273.727122] Starting dynamic subtest: rgb565-4tiled
[273.838293] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[273.849244] Starting dynamic subtest: xrgb2101010-4tiled
[273.950109] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[273.960908] Starting dynamic subtest: xbgr16161616f-4tiled
[274.060676] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[274.062543] Subtest draw-method-blt: SUCCESS (1.868s)
[274.178937] [084/156] (754s left) gem_mmap_gtt (fault-concurrent-y)
[274.234616] Subtest fault-concurrent-Y: SKIP (0.000s)
[274.299734] [085/156] (754s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[274.399355] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[274.401298] Starting dynamic subtest: pipe-A-default-mode
[277.161144] Dynamic subtest pipe-A-default-mode: SUCCESS (2.759s)
[277.163103] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.760s)
[277.988949] [086/156] (750s left) i915_drm_fdinfo (idle)
[278.033892] Starting subtest: idle
[278.036153] Starting dynamic subtest: rcs0
[278.585634] Dynamic subtest rcs0: SUCCESS (0.552s)
[278.597701] Starting dynamic subtest: bcs0
[279.093575] Dynamic subtest bcs0: SUCCESS (0.504s)
[279.106410] Starting dynamic subtest: vcs0
[279.600826] Dynamic subtest vcs0: SUCCESS (0.504s)
[279.614679] Starting dynamic subtest: vcs1
[280.107546] Dynamic subtest vcs1: SUCCESS (0.503s)
[280.120839] Starting dynamic subtest: vecs0
[280.616336] Dynamic subtest vecs0: SUCCESS (0.503s)
[280.629141] Starting dynamic subtest: ccs0
[281.119288] Dynamic subtest ccs0: SUCCESS (0.503s)
[281.122005] Subtest idle: SUCCESS (3.088s)
[281.208087] [087/156] (747s left) gem_userptr_blits (sync-unmap-after-close)
[281.281834] Starting subtest: sync-unmap-after-close
[281.298118] Subtest sync-unmap-after-close: SUCCESS (0.016s)
[281.429209] [088/156] (747s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[281.544456] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[281.548552] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[281.637413] [089/156] (746s left) syncobj_wait (invalid-signal-zero-handles)
[281.692276] Starting subtest: invalid-signal-zero-handles
[281.694528] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[281.805923] [090/156] (746s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move)
[281.904089] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move
[281.908389] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[282.028616] [091/156] (746s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[282.132393] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[282.135765] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[282.228785] [092/156] (746s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[282.275678] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[282.381686] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[282.462469] [093/156] (746s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[282.555695] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[282.559750] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[282.656051] [094/156] (746s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt)
[282.750320] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt
[282.754361] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[282.851552] [095/156] (746s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[282.915958] Starting subtest: map-fixed-invalidate-overlap
[282.920417] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[283.037720] [096/156] (745s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[283.133808] Starting subtest: yf-tiled-8bpp-rotate-270
[283.138229] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[283.233884] [097/156] (745s left) kms_lease (master-vs-lease)
[283.333834] Starting subtest: master-vs-lease
[283.336161] Subtest master-vs-lease: SUCCESS (0.002s)
[283.446180] [098/156] (745s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[283.541488] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[283.544851] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[283.641086] [099/156] (745s left) kms_invalid_mode (overflow-vrefresh)
[283.730736] Starting subtest: overflow-vrefresh
[283.732502] Starting dynamic subtest: pipe-A-eDP-1
[284.016010] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[284.027101] Starting dynamic subtest: pipe-B-eDP-1
[284.028914] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[284.039405] Starting dynamic subtest: pipe-C-eDP-1
[284.041538] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[284.054983] Starting dynamic subtest: pipe-D-eDP-1
[284.057259] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[284.059461] Subtest overflow-vrefresh: SUCCESS (0.291s)
[284.826413] [100/156] (744s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[284.930950] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[284.934851] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[285.044566] [101/156] (744s left) kms_busy (extended-modeset-hang-oldfb)
[285.136726] Starting subtest: extended-modeset-hang-oldfb
[285.138996] Starting dynamic subtest: pipe-A
[296.898276] Dynamic subtest pipe-A: SUCCESS (11.764s)
[296.909489] Starting dynamic subtest: pipe-D
[309.147758] Dynamic subtest pipe-D: SUCCESS (12.251s)
[309.150428] Subtest extended-modeset-hang-oldfb: SUCCESS (24.021s)
[310.042074] [102/156] (719s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[310.142722] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[310.169272] Starting dynamic subtest: pipe-A-plane-0
[310.435716] Dynamic subtest pipe-A-plane-0: SUCCESS (0.266s)
[310.446905] Starting dynamic subtest: pipe-A-plane-3
[310.646987] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s)
[311.738364] Starting dynamic subtest: pipe-B-plane-0
[312.006177] Dynamic subtest pipe-B-plane-0: SUCCESS (0.278s)
[312.019477] Starting dynamic subtest: pipe-B-plane-3
[312.218289] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[312.526523] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.384s)
[313.412308] [103/156] (715s left) prime_busy (hang-wait)
[313.475185] Starting subtest: hang-wait
[313.477113] Starting dynamic subtest: rcs0
[339.742742] Dynamic subtest rcs0: SUCCESS (26.260s)
[339.753422] Starting dynamic subtest: bcs0
[346.962713] Dynamic subtest bcs0: SUCCESS (7.216s)
[346.973540] Starting dynamic subtest: vcs0
[353.874347] Dynamic subtest vcs0: SUCCESS (6.911s)
[353.887387] Starting dynamic subtest: vcs1
[360.914969] Dynamic subtest vcs1: SUCCESS (7.039s)
[360.925565] Starting dynamic subtest: vecs0
[367.954440] Dynamic subtest vecs0: SUCCESS (7.038s)
[367.966292] Starting dynamic subtest: ccs0
[381.793320] Dynamic subtest ccs0: SUCCESS (13.839s)
[381.795743] Subtest hang-wait: SUCCESS (68.317s)
[381.922706] [104/156] (647s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[382.028382] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[382.032485] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[382.119964] [105/156] (647s left) kms_color (degamma)
[382.205600] Starting subtest: degamma
[382.207421] Starting dynamic subtest: pipe-A-eDP-1
[382.926832] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[382.937808] Starting dynamic subtest: pipe-B-eDP-1
[384.333871] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[384.346032] Starting dynamic subtest: pipe-C-eDP-1
[385.712774] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[385.723893] Starting dynamic subtest: pipe-D-eDP-1
[387.130337] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.417s)
[387.132543] Subtest degamma: SUCCESS (4.926s)
[387.937604] [106/156] (641s left) sysfs_preempt_timeout (idempotent)
[387.993434] Starting subtest: idempotent
[387.995930] Starting dynamic subtest: vecs0
[387.998334] Dynamic subtest vecs0: SUCCESS (0.000s)
[388.011221] Starting dynamic subtest: ccs0
[388.013137] Dynamic subtest ccs0: SUCCESS (0.000s)
[388.024048] Starting dynamic subtest: vcs0
[388.025978] Dynamic subtest vcs0: SUCCESS (0.000s)
[388.036671] Starting dynamic subtest: bcs0
[388.038688] Dynamic subtest bcs0: SUCCESS (0.000s)
[388.049403] Starting dynamic subtest: rcs0
[388.051745] Dynamic subtest rcs0: SUCCESS (0.000s)
[388.062715] Starting dynamic subtest: vcs1
[388.064713] Dynamic subtest vcs1: SUCCESS (0.000s)
[388.066612] Subtest idempotent: SUCCESS (0.007s)
[388.106716] [107/156] (641s left) gem_softpin (evict-active-interruptible)
[388.158792] Starting subtest: evict-active-interruptible
[388.164925] Subtest evict-active-interruptible: SUCCESS (0.006s)
[388.302507] [108/156] (641s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[388.393431] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[388.397955] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[388.483836] [109/156] (640s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[388.584830] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[388.589275] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[388.675333] [110/156] (640s left) kms_plane_multiple (tiling-4)
[388.776232] Starting subtest: tiling-4
[388.778302] Starting dynamic subtest: pipe-A-eDP-1
[392.683316] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.907s)
[392.694912] Starting dynamic subtest: pipe-B-eDP-1
[397.241787] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.560s)
[397.255228] Starting dynamic subtest: pipe-C-eDP-1
[401.759342] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.516s)
[401.770906] Starting dynamic subtest: pipe-D-eDP-1
[406.392835] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.632s)
[406.395187] Subtest tiling-4: SUCCESS (17.620s)
[407.202500] [111/156] (622s left) kms_cursor_edge_walk (128x128-left-edge)
[407.306320] Starting subtest: 128x128-left-edge
[407.308725] Starting dynamic subtest: pipe-A-eDP-1
[410.764510] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s)
[410.775889] Starting dynamic subtest: pipe-D-eDP-1
[413.969361] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.204s)
[413.971695] Subtest 128x128-left-edge: SUCCESS (6.666s)
[414.789365] [112/156] (614s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[414.887637] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[414.889994] Starting dynamic subtest: pipe-A-eDP-1
[414.910096] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[414.924106] Starting dynamic subtest: pipe-B-eDP-1
[414.942825] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[414.953634] Starting dynamic subtest: pipe-C-eDP-1
[414.972983] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[414.983768] Starting dynamic subtest: pipe-D-eDP-1
[415.004090] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[415.006295] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[417.163784] [113/156] (612s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[417.257362] Starting subtest: fbcpsrhdr-tiling-4
[417.261327] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[417.341303] [114/156] (612s left) gem_ctx_param (non-root-set)
[417.391133] Starting subtest: non-root-set
[417.411014] Subtest non-root-set: SUCCESS (0.019s)
[417.519089] [115/156] (612s left) gem_ctx_param (get-priority-new-ctx)
[417.560715] Starting subtest: get-priority-new-ctx
[417.562959] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[417.669780] [116/156] (612s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[417.728598] Starting subtest: etime-single-wait-for-submit-submitted
[417.837599] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[417.931125] [117/156] (611s left) gem_eio (in-flight-1us)
[418.144709] Starting subtest: in-flight-1us
[426.939232] Subtest in-flight-1us: SUCCESS (8.798s)
[427.062221] [118/156] (602s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[427.169132] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[428.202620] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.034s)
[428.342159] [119/156] (601s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[428.438115] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[428.441552] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[428.521502] [120/156] (601s left) gem_workarounds (reset-fd)
[428.589298] Starting subtest: reset-fd
[428.764122] Subtest reset-fd: SUCCESS (0.175s)
[428.912192] [121/156] (601s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[429.011106] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[429.014450] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[429.117650] [122/156] (600s left) kms_frontbuffer_tracking (fbchdr-suspend)
[429.222398] Starting subtest: fbchdr-suspend
[429.225661] Subtest fbchdr-suspend: SKIP (0.000s)
[429.323511] [123/156] (600s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[429.427756] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[429.431364] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[429.553787] [124/156] (600s left) gem_exec_balancer (bonded-sync)
[429.611206] Starting subtest: bonded-sync
[429.615031] Subtest bonded-sync: SKIP (0.000s)
[429.925141] [125/156] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[430.032262] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[430.036497] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[430.113897] [126/156] (600s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[430.204208] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[430.208386] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[430.308419] [127/156] (599s left) gem_exec_params (invalid-fence-in-submit)
[430.359175] Starting subtest: invalid-fence-in-submit
[430.364436] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[430.477071] [128/156] (599s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[430.571057] Starting subtest: addfb25-y-tiled-legacy
[430.572930] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[430.663215] [129/156] (599s left) kms_flip (absolute-wf_vblank)
[430.759982] Starting subtest: absolute-wf_vblank
[430.762328] Starting dynamic subtest: A-eDP1
[439.510629] Dynamic subtest A-eDP1: SUCCESS (8.755s)
[439.522697] Starting dynamic subtest: B-eDP1
[448.242288] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[448.254872] Starting dynamic subtest: C-eDP1
[456.972171] Dynamic subtest C-eDP1: SUCCESS (8.726s)
[456.986092] Starting dynamic subtest: D-eDP1
[465.702792] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[465.707990] Subtest absolute-wf_vblank: SUCCESS (34.943s)
[466.915374] [130/156] (563s left) gem_softpin (allocator-nopin-reserve)
[466.976729] Starting subtest: allocator-nopin-reserve
[467.082575] Subtest allocator-nopin-reserve: SUCCESS (0.103s)
[467.221915] [131/156] (563s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[467.320167] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[474.611693] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.294s)
[474.733133] [132/156] (555s left) gem_exec_flush (basic-wb-rw-before-default)
[474.806345] Starting subtest: basic-wb-rw-before-default
[480.272404] Subtest basic-wb-rw-before-default: SUCCESS (5.466s)
[480.462306] [133/156] (550s left) kms_hdr (bpc-switch-suspend)
[480.557575] Starting subtest: bpc-switch-suspend
[480.559916] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[501.479306] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (6.130s)
[501.494706] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[522.468583] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (6.141s)
[522.471045] Subtest bpc-switch-suspend: SUCCESS (12.275s)
[528.585673] [134/156] (508s left) kms_cursor_crc (cursor-offscreen-max-size)
[528.910282] Starting subtest: cursor-offscreen-max-size
[528.916702] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[529.046716] [135/156] (507s left) syncobj_basic (bad-pad-fd-to-handle)
[529.108857] Starting subtest: bad-pad-fd-to-handle
[529.110745] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[529.223489] [136/156] (507s left) kms_prime (d3hot)
[529.301887] Subtest D3hot: SKIP (0.000s)
[529.407291] [137/156] (507s left) gem_exec_whisper (basic-queues)
[529.467931] Starting subtest: basic-queues
[536.868361] Subtest basic-queues: SUCCESS (7.439s)
[537.058530] [138/156] (499s left) gem_busy (busy)
[537.125504] Starting subtest: busy
[537.127865] Starting dynamic subtest: all-engines
[537.198372] Dynamic subtest all-engines: SUCCESS (0.071s)
[537.213855] Starting dynamic subtest: rcs0
[538.896324] Dynamic subtest rcs0: SUCCESS (1.702s)
[538.910032] Starting dynamic subtest: bcs0
[538.947593] Dynamic subtest bcs0: SUCCESS (0.050s)
[538.959247] Starting dynamic subtest: vcs0
[538.987272] Dynamic subtest vcs0: SUCCESS (0.039s)
[538.998421] Starting dynamic subtest: vcs1
[540.939279] Dynamic subtest vcs1: SUCCESS (1.953s)
[540.952648] Starting dynamic subtest: vecs0
[542.922939] Dynamic subtest vecs0: SUCCESS (1.986s)
[542.937171] Starting dynamic subtest: ccs0
[544.907937] Dynamic subtest ccs0: SUCCESS (1.987s)
[544.910531] Subtest busy: SUCCESS (7.798s)
[545.280025] [139/156] (491s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[545.379061] Starting subtest: x-tiled-32bpp-rotate-180
[546.845105] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.469s)
[546.970038] [140/156] (489s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-render)
[547.067693] Starting subtest: psrhdr-rgb101010-draw-render
[547.071119] Subtest psrhdr-rgb101010-draw-render: SKIP (0.000s)
[547.176141] [141/156] (489s left) gem_ctx_exec (basic-invalid-context)
[547.227126] Starting subtest: basic-invalid-context
[547.229423] Subtest basic-invalid-context: SUCCESS (0.004s)
[547.366983] [142/156] (489s left) gem_exec_reloc (basic-range-active)
[547.425557] Subtest basic-range-active: SKIP (0.000s)
[547.502000] [143/156] (489s left) kms_properties (connector-properties-legacy)
[547.594999] Starting subtest: connector-properties-legacy
[547.596916] Starting dynamic subtest: pipe-A-eDP-1
[555.762792] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.174s)
[555.774779] Starting dynamic subtest: pipe-None-DP-1
[555.779275] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[555.790460] Starting dynamic subtest: pipe-None-HDMI-A-1
[555.794517] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[555.805130] Starting dynamic subtest: pipe-None-DP-2
[555.809202] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[555.820186] Starting dynamic subtest: pipe-None-HDMI-A-2
[555.825027] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[555.836248] Starting dynamic subtest: pipe-None-DP-3
[555.840833] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[555.851520] Starting dynamic subtest: pipe-None-DP-4
[555.855929] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[555.858161] Subtest connector-properties-legacy: SUCCESS (8.185s)
[556.633042] [144/156] (480s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[556.728987] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[557.519035] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s)
[557.709971] [145/156] (479s left) kms_vblank (query-forked-busy-hang)
[557.812906] Starting subtest: query-forked-busy-hang
[557.815231] Starting dynamic subtest: pipe-A-eDP-1
[584.647265] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.830s)
[584.663036] Starting dynamic subtest: pipe-D-eDP-1
[609.671593] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.028s)
[609.673766] Subtest query-forked-busy-hang: SUCCESS (51.863s)
[610.485545] [146/156] (426s left) kms_rotation_crc (primary-rotation-90)
[610.584086] Starting subtest: primary-rotation-90
[610.588233] Subtest primary-rotation-90: SKIP (0.001s)
[610.661606] [147/156] (426s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[610.759741] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[610.763650] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[610.878799] [148/156] (426s left) gem_softpin (noreloc-interruptible)
[610.940570] Starting subtest: noreloc-interruptible
[616.361160] Subtest noreloc-interruptible: SUCCESS (5.421s)
[616.479169] [149/156] (420s left) gem_pipe_control_store_loop (reused-buffer)
[616.541112] Starting subtest: reused-buffer
[618.695029] Subtest reused-buffer: SUCCESS (2.155s)
[618.829549] [150/156] (418s left) api_intel_allocator (alloc-simple)
[618.881033] Starting subtest: alloc-simple
[618.886788] Subtest alloc-simple: SUCCESS (0.006s)
[619.004688] [151/156] (418s left) kms_pipe_stress (stress-xrgb8888-untiled)
[619.103613] Starting subtest: stress-xrgb8888-untiled
[624.949527] Subtest stress-xrgb8888-untiled: SUCCESS (5.849s)
[625.003302] [152/156] (412s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[625.096381] Starting subtest: primary-4-tiled-reflect-x-180
[632.186749] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.087s)
[633.476346] [153/156] (403s left) kms_addfb_basic (bad-pitch-63)
[633.530344] Starting subtest: bad-pitch-63
[633.532544] Subtest bad-pitch-63: SUCCESS (0.000s)
[633.675696] [154/156] (403s left) gem_shrink (reclaim)
[633.736466] Starting subtest: reclaim
[636.152686] Subtest reclaim: SUCCESS (2.411s)
[636.309751] [155/156] (401s left) kms_debugfs (display-off-read-all)
[636.405643] Starting subtest: display-off-read-all
[636.708379] Subtest display-off-read-all: SUCCESS (0.302s)
[637.580202] [156/156] (399s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[637.676370] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[637.680654] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[637.771684] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: i915_pm_freq_api
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: device_reset
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_frames
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: gem_ctx_shared
results: parsing output: 20/ for test: kms_async_flips
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_lmem_swapping
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: i915_pm_rpm
results: parsing output: 32/ for test: gem_madvise
results: parsing output: 33/ for test: kms_chamelium_hpd
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_psr2_su
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_exec_capture
results: parsing output: 49/ for test: core_auth
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: gen9_exec_parse
results: parsing output: 53/ for test: kms_vrr
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_workarounds
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_parallel
results: parsing output: 66/ for test: kms_pm_rpm
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: i915_pm_rps
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_vm_create
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_draw_crc
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: i915_drm_fdinfo
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_lease
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_invalid_mode
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_busy
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: prime_busy
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_color
results: parsing output: 105/ for test: sysfs_preempt_timeout
results: parsing output: 106/ for test: gem_softpin
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_plane_multiple
results: parsing output: 110/ for test: kms_cursor_edge_walk
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: gem_workarounds
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_exec_flush
results: parsing output: 132/ for test: kms_hdr
results: parsing output: 133/ for test: kms_cursor_crc
results: parsing output: 134/ for test: syncobj_basic
results: parsing output: 135/ for test: kms_prime
results: parsing output: 136/ for test: gem_exec_whisper
results: parsing output: 137/ for test: gem_busy
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_ctx_exec
results: parsing output: 141/ for test: gem_exec_reloc
results: parsing output: 142/ for test: kms_properties
results: parsing output: 143/ for test: kms_big_fb
results: parsing output: 144/ for test: kms_vblank
results: parsing output: 145/ for test: kms_rotation_crc
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_softpin
results: parsing output: 148/ for test: gem_pipe_control_store_loop
results: parsing output: 149/ for test: api_intel_allocator
results: parsing output: 150/ for test: kms_pipe_stress
results: parsing output: 151/ for test: kms_rotation_crc
results: parsing output: 152/ for test: kms_addfb_basic
results: parsing output: 153/ for test: gem_shrink
results: parsing output: 154/ for test: kms_debugfs
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.