[58.828456] Initializing watchdogs
[58.828503]   /dev/watchdog0
[58.843888] [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.848404] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.850830] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.852917] [001/132] (960s left) kms_atomic_transition (plane-all-transition-nonblocking)
[58.955845] Starting subtest: plane-all-transition-nonblocking
[58.956675] Starting dynamic subtest: pipe-A-eDP-1
[61.480803] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.543s)
[61.796058] Starting dynamic subtest: pipe-B-eDP-1
[65.032565] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.259s)
[65.329796] Subtest plane-all-transition-nonblocking: SUCCESS (6.411s)
[66.147504] [002/132] (953s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[66.230242] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[66.231953] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[67.398256] [003/132] (952s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[67.517043] Starting subtest: 2x-long-flip-vs-cursor-atomic
[67.521067] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[67.652652] [004/132] (951s left) sysfs_heartbeat_interval (nopreempt)
[67.712896] Starting subtest: nopreempt
[67.713744] Starting dynamic subtest: vecs0
[76.322575] Dynamic subtest vecs0: SUCCESS (8.614s)
[76.330315] Starting dynamic subtest: ccs0
[80.218807] Dynamic subtest ccs0: SUCCESS (3.905s)
[80.228525] Starting dynamic subtest: vcs0
[89.310684] Dynamic subtest vcs0: SUCCESS (9.083s)
[89.320481] Starting dynamic subtest: bcs0
[93.186831] Dynamic subtest bcs0: SUCCESS (3.883s)
[93.196686] Starting dynamic subtest: rcs0
[97.081170] Dynamic subtest rcs0: SUCCESS (3.894s)
[97.089767] Starting dynamic subtest: vcs1
[106.335509] Dynamic subtest vcs1: SUCCESS (9.244s)
[106.336486] Subtest nopreempt: SUCCESS (38.630s)
[106.411838] [005/132] (913s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[106.535682] Starting subtest: flip-vs-cursor-atomic-transitions
[114.520543] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.984s)
[115.388424] [006/132] (904s left) syncobj_wait (multi-wait-for-submit-signaled)
[115.437053] Starting subtest: multi-wait-for-submit-signaled
[115.437911] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[115.539934] [007/132] (903s left) gem_mmap_gtt (basic-read-write-distinct)
[115.592235] Subtest basic-read-write-distinct: SKIP (0.000s)
[115.645744] [008/132] (903s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[115.746391] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[115.748275] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[115.838237] [009/132] (903s left) perf (global-sseu-config-invalid)
[115.962997] Starting subtest: global-sseu-config-invalid
[115.964774] Subtest global-sseu-config-invalid: SKIP (0.000s)
[116.002648] [010/132] (903s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[116.086853] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[116.087671] Starting dynamic subtest: pipe-A-default-mode
[119.104722] Dynamic subtest pipe-A-default-mode: SUCCESS (3.016s)
[119.105802] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (3.017s)
[119.933156] [011/132] (899s left) kms_pm_rpm (modeset-non-lpsp-stress)
[121.457664] Starting subtest: modeset-non-lpsp-stress
[122.616485] Subtest modeset-non-lpsp-stress: SKIP (1.158s)
[122.991899] [012/132] (896s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[123.085051] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[130.042350] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.957s)
[130.175809] [013/132] (889s left) prime_mmap_coherency (read)
[130.236863] Starting subtest: read
[135.656318] Subtest read: SUCCESS (5.373s)
[135.709731] [014/132] (884s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[135.816976] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[135.818772] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[135.906299] [015/132] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[135.991805] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[135.993619] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[136.074881] [016/132] (883s left) kms_frontbuffer_tracking (psr-slowdraw)
[136.160964] Starting subtest: psr-slowdraw
[161.385231] Subtest psr-slowdraw: SUCCESS (25.224s)
[161.489836] [017/132] (858s left) gem_bad_reloc (negative-reloc-bltcopy)
[161.546934] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[161.623072] [018/132] (858s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[161.717551] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[161.719368] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[161.814141] [019/132] (858s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[161.899510] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[161.901555] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[161.998409] [020/132] (857s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[162.084639] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[162.085509] Starting dynamic subtest: pipe-A-eDP-1
[162.095291] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[162.103560] Starting dynamic subtest: pipe-B-eDP-1
[162.114199] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[162.122213] Starting dynamic subtest: pipe-C-eDP-1
[162.131879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[162.138574] Starting dynamic subtest: pipe-D-eDP-1
[162.148404] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[162.150060] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[164.323344] [021/132] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[164.419918] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[164.421711] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[164.534325] [022/132] (855s left) kms_chamelium_color (ctm-limited-range)
[164.616425] Subtest ctm-limited-range: SKIP (0.000s)
[164.653853] [023/132] (855s left) kms_flip (flip-vs-absolute-wf_vblank)
[164.739325] Starting subtest: flip-vs-absolute-wf_vblank
[164.741868] Starting dynamic subtest: A-eDP1
[173.676466] Dynamic subtest A-eDP1: SUCCESS (8.935s)
[173.686597] Starting dynamic subtest: B-eDP1
[182.600527] Dynamic subtest B-eDP1: SUCCESS (8.920s)
[182.608024] Starting dynamic subtest: C-eDP1
[191.556562] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[191.564427] Starting dynamic subtest: D-eDP1
[200.458344] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[200.461582] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.721s)
[201.691258] [024/132] (818s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[201.783598] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[201.785359] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[201.868387] [025/132] (818s left) i915_pm_rpm (reg-read-ioctl)
[203.502527] Starting subtest: reg-read-ioctl
[205.904789] Subtest reg-read-ioctl: SUCCESS (2.404s)
[206.285785] [026/132] (813s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[206.379667] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[207.392710] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.013s)
[207.517842] [027/132] (812s left) kms_async_flips (test-time-stamp-atomic)
[207.600849] Starting subtest: test-time-stamp-atomic
[207.975123] Starting dynamic subtest: pipe-A-eDP-1
[208.783966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.807s)
[209.166146] Starting dynamic subtest: pipe-B-eDP-1
[209.916259] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.755s)
[210.311213] Starting dynamic subtest: pipe-C-eDP-1
[211.061620] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.758s)
[211.427502] Starting dynamic subtest: pipe-D-eDP-1
[212.193196] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[212.194255] Subtest test-time-stamp-atomic: SUCCESS (4.593s)
[213.338758] [028/132] (806s left) kms_atomic_interruptible (legacy-pageflip)
[213.418234] Starting subtest: legacy-pageflip
[213.420345] Starting dynamic subtest: pipe-A-eDP-1
[220.865441] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.444s)
[220.866555] Subtest legacy-pageflip: SUCCESS (7.446s)
[221.702236] [029/132] (798s left) kms_chamelium_hpd (common-hpd-after-suspend)
[222.080078] Subtest common-hpd-after-suspend: SKIP (0.000s)
[222.903717] [030/132] (797s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[222.992366] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[222.994072] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[223.111427] [031/132] (797s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[223.199864] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[223.201792] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[223.264407] [032/132] (797s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[223.381192] Starting subtest: basic-flip-before-cursor-atomic
[224.305228] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.923s)
[225.167984] [033/132] (795s left) i915_drm_fdinfo (memory-info-active)
[225.207789] Starting subtest: memory-info-active
[225.208680] Starting dynamic subtest: smem0
[227.911267] Dynamic subtest smem0: SUCCESS (2.706s)
[227.912894] Subtest memory-info-active: SUCCESS (2.708s)
[227.979722] [034/132] (792s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[228.078582] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[228.080268] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[228.181256] [035/132] (792s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[228.275695] Starting subtest: x-tiled-8bpp-rotate-0
[229.522918] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.247s)
[229.652501] [036/132] (790s left) gem_exec_whisper (basic-contexts-forked)
[229.707156] Starting subtest: basic-contexts-forked
[252.992929] Subtest basic-contexts-forked: SUCCESS (23.276s)
[253.164082] [037/132] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[253.259844] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[253.261519] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[253.346863] [038/132] (767s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[253.432127] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[253.462394] Starting dynamic subtest: pipe-A-plane-0
[253.762042] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[253.770221] Starting dynamic subtest: pipe-A-plane-3
[254.006583] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[255.069100] Starting dynamic subtest: pipe-B-plane-0
[255.361814] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[255.372428] Starting dynamic subtest: pipe-B-plane-3
[255.617205] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[255.946891] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.514s)
[256.754404] [039/132] (763s left) sw_sync (sync_busy_fork)
[256.785993] Starting subtest: sync_busy_fork
[257.807576] Subtest sync_busy_fork: SUCCESS (1.011s)
[257.854182] [040/132] (762s left) dmabuf_sync_file (import-multiple-read-write)
[257.969815] Starting subtest: import-multiple-read-write
[257.972869] Subtest import-multiple-read-write: SUCCESS (0.004s)
[258.022211] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[258.024149] [041/132] (762s left) kms_content_protection (dp-mst-type-1)
[258.162714] Starting subtest: dp-mst-type-1
[258.165172] Subtest dp-mst-type-1: SKIP (0.000s)
[258.281963] [042/132] (762s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[258.380023] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[258.381874] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[258.487195] [043/132] (762s left) gem_exec_balancer (smoke)
[258.538263] Starting subtest: smoke
[281.226067] Subtest smoke: SUCCESS (22.639s)
[282.434568] [044/132] (738s left) prime_busy (hang-wait)
[282.486222] Starting subtest: hang-wait
[282.488493] Starting dynamic subtest: rcs0
[308.858030] Dynamic subtest rcs0: SUCCESS (26.366s)
[308.868315] Starting dynamic subtest: bcs0
[316.015525] Dynamic subtest bcs0: SUCCESS (7.157s)
[316.023737] Starting dynamic subtest: vcs0
[322.922166] Dynamic subtest vcs0: SUCCESS (6.905s)
[322.931720] Starting dynamic subtest: vcs1
[329.896887] Dynamic subtest vcs1: SUCCESS (6.972s)
[329.904964] Starting dynamic subtest: vecs0
[336.997897] Dynamic subtest vecs0: SUCCESS (7.099s)
[337.009034] Starting dynamic subtest: ccs0
[350.773065] Dynamic subtest ccs0: SUCCESS (13.772s)
[350.774354] Subtest hang-wait: SUCCESS (68.284s)
[350.894529] [045/132] (669s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[351.007281] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[351.008887] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[351.098697] [046/132] (669s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[351.186609] Starting subtest: fbc-rgb101010-draw-blt
[355.776968] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.590s)
[356.938668] [047/132] (663s left) gem_close_race (basic-process)
[357.004612] Starting subtest: basic-process
[357.047842] Subtest basic-process: SUCCESS (0.043s)
[357.224182] [048/132] (663s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[357.311080] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[357.311927] Starting dynamic subtest: pipe-A-default-mode
[360.103134] Dynamic subtest pipe-A-default-mode: SUCCESS (2.792s)
[360.103985] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.793s)
[360.926078] [049/132] (659s left) gem_softpin (allocator-evict)
[360.986625] Starting subtest: allocator-evict
[360.987745] Starting dynamic subtest: rcs0
[384.615662] Dynamic subtest rcs0: SUCCESS (23.627s)
[384.625451] Starting dynamic subtest: bcs0
[408.384851] Dynamic subtest bcs0: SUCCESS (23.767s)
[408.395998] Starting dynamic subtest: vcs0
[432.526982] Dynamic subtest vcs0: SUCCESS (24.140s)
[432.537397] Starting dynamic subtest: vcs1
[456.488506] Dynamic subtest vcs1: SUCCESS (23.960s)
[456.499105] Starting dynamic subtest: vecs0
[480.578243] Dynamic subtest vecs0: SUCCESS (24.088s)
[480.588095] Starting dynamic subtest: ccs0
[504.872897] Dynamic subtest ccs0: SUCCESS (24.293s)
[504.873799] Subtest allocator-evict: SUCCESS (143.882s)
[504.963114] [050/132] (515s left) kms_pm_dc (dc6-dpms)
[506.113748] Starting subtest: dc6-dpms
[508.206915] Subtest dc6-dpms: SUCCESS (2.083s)
[508.284254] [051/132] (512s left) kms_plane_scaling (planes-downscale-factor-0-5)
[508.374982] Starting subtest: planes-downscale-factor-0-5
[508.375813] Starting dynamic subtest: pipe-A
[508.397554] Dynamic subtest pipe-A: SKIP (0.020s)
[508.406037] Starting dynamic subtest: pipe-B
[508.430367] Dynamic subtest pipe-B: SKIP (0.033s)
[508.438926] Starting dynamic subtest: pipe-C
[508.465749] Dynamic subtest pipe-C: SKIP (0.034s)
[508.474247] Starting dynamic subtest: pipe-D
[508.500380] Dynamic subtest pipe-D: SKIP (0.034s)
[508.502098] Subtest planes-downscale-factor-0-5: SKIP (0.124s)
[508.599399] [052/132] (512s left) gem_ctx_param (invalid-size-get)
[508.646589] Starting subtest: invalid-size-get
[508.647588] Subtest invalid-size-get: SUCCESS (0.001s)
[508.758371] [053/132] (512s left) gem_ctx_persistence (engines-hang)
[508.812860] Starting subtest: engines-hang
[508.813968] Starting dynamic subtest: rcs0
[508.958040] Dynamic subtest rcs0: SUCCESS (0.144s)
[508.971591] Starting dynamic subtest: bcs0
[509.052765] Dynamic subtest bcs0: SUCCESS (0.093s)
[509.065175] Starting dynamic subtest: vcs0
[509.152798] Dynamic subtest vcs0: SUCCESS (0.097s)
[509.165774] Starting dynamic subtest: vcs1
[509.259844] Dynamic subtest vcs1: SUCCESS (0.105s)
[509.272887] Starting dynamic subtest: vecs0
[509.369702] Dynamic subtest vecs0: SUCCESS (0.108s)
[509.383432] Starting dynamic subtest: ccs0
[509.477751] Dynamic subtest ccs0: SUCCESS (0.106s)
[509.479739] Subtest engines-hang: SUCCESS (0.666s)
[509.553076] [054/132] (511s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[509.608046] Starting subtest: single-wait-all-for-submit-available-signaled
[509.609212] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[509.695573] [055/132] (511s left) kms_psr (fbc-pr-primary-page-flip)
[509.789513] Starting subtest: fbc-pr-primary-page-flip
[509.791585] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[509.875030] [056/132] (511s left) gem_exec_balancer (bonded-pair)
[509.936772] Starting subtest: bonded-pair
[509.938929] Subtest bonded-pair: SKIP (0.000s)
[510.255171] [057/132] (510s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[510.354668] Starting subtest: y-tiled-8bpp-rotate-90
[510.356661] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[510.435176] [058/132] (510s left) gem_ctx_persistence (heartbeat-close)
[510.485300] Starting subtest: heartbeat-close
[510.486977] Subtest heartbeat-close: SKIP (0.000s)
[510.582638] [059/132] (510s left) gem_exec_whisper (basic-sync-all)
[510.647539] Starting subtest: basic-sync-all
[518.043341] Subtest basic-sync-all: SUCCESS (7.394s)
[518.226498] [060/132] (503s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[518.272040] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[518.375064] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[518.450047] [061/132] (502s left) kms_selftest (drm_cmdline_parser)
[518.484429] Starting subtest: drm_cmdline_parser
[518.541965] Starting dynamic subtest: drm_test_cmdline_force_d_only
[518.647815] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.106s)
[518.658907] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[518.735708] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.086s)
[518.746047] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[518.830510] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.094s)
[518.840355] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[518.921618] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.090s)
[518.931722] Starting dynamic subtest: drm_test_cmdline_force_e_only
[519.017618] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.095s)
[519.027831] Starting dynamic subtest: drm_test_cmdline_res
[519.115462] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.097s)
[519.123871] Starting dynamic subtest: drm_test_cmdline_res_vesa
[519.199580] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.085s)
[519.210849] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[519.287086] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.085s)
[519.297353] Starting dynamic subtest: drm_test_cmdline_res_rblank
[519.392127] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.104s)
[519.401603] Starting dynamic subtest: drm_test_cmdline_res_bpp
[519.500404] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.107s)
[519.510206] Starting dynamic subtest: drm_test_cmdline_res_refresh
[519.595970] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.093s)
[519.605923] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[519.695824] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.098s)
[519.704573] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[519.788784] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.092s)
[519.799067] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[519.872611] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.083s)
[519.881346] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[519.956549] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.082s)
[519.964847] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[520.043452] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.085s)
[520.053430] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[520.130239] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.083s)
[520.139874] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[520.236429] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.105s)
[520.246301] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[520.328788] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.092s)
[520.337838] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[520.414573] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.085s)
[520.424239] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[520.507978] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.093s)
[520.516539] Starting dynamic subtest: drm_test_cmdline_name
[520.598830] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.090s)
[520.608156] Starting dynamic subtest: drm_test_cmdline_name_bpp
[520.696127] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.096s)
[520.704528] Starting dynamic subtest: drm_test_cmdline_name_option
[520.785231] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.088s)
[520.795562] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[520.862522] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.077s)
[520.872536] Starting dynamic subtest: drm_test_cmdline_rotate_0
[520.948118] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.083s)
[521.039871] Starting dynamic subtest: drm_test_cmdline_rotate_90
[521.192383] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.107s)
[521.231164] Starting dynamic subtest: drm_test_cmdline_rotate_180
[521.245323] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.087s)
[521.331904] Starting dynamic subtest: drm_test_cmdline_rotate_270
[521.348948] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.087s)
[521.406688] Starting dynamic subtest: drm_test_cmdline_hmirror
[521.421865] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.081s)
[521.432046] Starting dynamic subtest: drm_test_cmdline_vmirror
[521.432945] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.092s)
[521.441355] Starting dynamic subtest: drm_test_cmdline_margin_options
[521.506184] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.100s)
[521.516670] Starting dynamic subtest: drm_test_cmdline_multiple_options
[521.604629] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.096s)
[521.614478] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[521.694903] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.090s)
[521.705651] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[521.780688] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.084s)
[521.791104] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[521.864720] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.083s)
[521.874256] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[521.951556] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.086s)
[521.961334] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[522.068534] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.116s)
[522.079550] Starting dynamic subtest: drm_test_cmdline_invalid
[522.170168] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.100s)
[522.179451] Starting dynamic subtest: drm_test_cmdline_tv_options
[522.264587] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.093s)
[522.265558] Subtest drm_cmdline_parser: SUCCESS (3.780s)
[522.413156] [062/132] (498s left) gem_exec_schedule (implicit-write-read)
[522.471045] Starting subtest: implicit-write-read
[522.472038] Starting dynamic subtest: rcs0
[522.661848] Dynamic subtest rcs0: SUCCESS (0.190s)
[522.673931] Starting dynamic subtest: vcs0
[522.800645] Dynamic subtest vcs0: SUCCESS (0.138s)
[522.810520] Starting dynamic subtest: vcs1
[522.906775] Dynamic subtest vcs1: SUCCESS (0.104s)
[522.917817] Starting dynamic subtest: vecs0
[523.009998] Dynamic subtest vecs0: SUCCESS (0.103s)
[523.021857] Starting dynamic subtest: ccs0
[523.141889] Dynamic subtest ccs0: SUCCESS (0.130s)
[523.143150] Subtest implicit-write-read: SUCCESS (0.672s)
[524.423970] [063/132] (496s left) gem_ringfill (engines-basic)
[530.340769] Starting subtest: engines-basic
[530.342141] Starting dynamic subtest: rcs0
[530.385540] Dynamic subtest rcs0: SUCCESS (0.051s)
[530.398748] Starting dynamic subtest: bcs0
[530.431257] Dynamic subtest bcs0: SUCCESS (0.044s)
[530.442047] Starting dynamic subtest: vcs0
[530.474589] Dynamic subtest vcs0: SUCCESS (0.041s)
[530.485182] Starting dynamic subtest: vcs1
[530.517662] Dynamic subtest vcs1: SUCCESS (0.041s)
[530.529415] Starting dynamic subtest: vecs0
[530.561683] Dynamic subtest vecs0: SUCCESS (0.042s)
[530.572505] Starting dynamic subtest: ccs0
[530.607373] Dynamic subtest ccs0: SUCCESS (0.044s)
[530.610127] Subtest engines-basic: SUCCESS (0.275s)
[530.682066] [064/132] (490s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[530.781059] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[530.782892] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[530.882208] [065/132] (490s left) kms_psr (fbc-pr-cursor-plane-onoff)
[530.972522] Starting subtest: fbc-pr-cursor-plane-onoff
[530.974488] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[531.055881] [066/132] (490s left) kms_getfb (getfb-handle-valid)
[531.140105] Starting subtest: getfb-handle-valid
[531.141299] Subtest getfb-handle-valid: SUCCESS (0.000s)
[531.238943] [067/132] (490s left) kms_plane (plane-position-covered)
[531.317513] Starting subtest: plane-position-covered
[531.851643] Starting dynamic subtest: pipe-A-plane-1
[533.161200] Dynamic subtest pipe-A-plane-1: SUCCESS (1.310s)
[533.170520] Starting dynamic subtest: pipe-A-plane-2
[534.500069] Dynamic subtest pipe-A-plane-2: SUCCESS (1.338s)
[534.508798] Starting dynamic subtest: pipe-A-plane-3
[535.808368] Dynamic subtest pipe-A-plane-3: SUCCESS (1.307s)
[535.817334] Starting dynamic subtest: pipe-A-plane-4
[537.114524] Dynamic subtest pipe-A-plane-4: SUCCESS (1.306s)
[537.126121] Starting dynamic subtest: pipe-A-plane-5
[537.140966] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[538.360348] Starting dynamic subtest: pipe-B-plane-1
[539.699694] Dynamic subtest pipe-B-plane-1: SUCCESS (1.347s)
[539.708723] Starting dynamic subtest: pipe-B-plane-2
[541.009285] Dynamic subtest pipe-B-plane-2: SUCCESS (1.308s)
[541.018737] Starting dynamic subtest: pipe-B-plane-3
[542.347208] Dynamic subtest pipe-B-plane-3: SUCCESS (1.337s)
[542.357493] Starting dynamic subtest: pipe-B-plane-4
[543.681549] Dynamic subtest pipe-B-plane-4: SUCCESS (1.333s)
[543.693226] Starting dynamic subtest: pipe-B-plane-5
[543.710889] Dynamic subtest pipe-B-plane-5: SUCCESS (0.029s)
[543.711989] Subtest plane-position-covered: SUCCESS (12.393s)
[544.555335] [068/132] (476s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[544.661985] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[544.663903] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[544.744493] [069/132] (476s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[544.832463] Starting subtest: compare-crc-sanitycheck-nv12
[544.833422] Starting dynamic subtest: pipe-A-eDP-1
[545.559689] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.727s)
[545.572244] Starting dynamic subtest: pipe-B-eDP-1
[546.873637] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.312s)
[546.883938] Starting dynamic subtest: pipe-C-eDP-1
[548.159272] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.283s)
[548.168107] Starting dynamic subtest: pipe-D-eDP-1
[549.369166] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.210s)
[549.370166] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.538s)
[550.189025] [070/132] (471s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[550.287600] Starting subtest: invalidate-primary-flip-overlay
[561.074313] Subtest invalidate-primary-flip-overlay: SUCCESS (10.786s)
[561.182182] [071/132] (460s left) intel_hwmon (hwmon-read)
[561.239043] Subtest hwmon-read: SKIP (0.000s)
[561.300291] [072/132] (460s left) gem_ctx_shared (q-smoketest-all)
[561.349358] Starting subtest: Q-smoketest-all
[593.722686] Subtest Q-smoketest-all: SUCCESS (32.343s)
[595.378465] [073/132] (426s left) core_auth (getclient-simple)
[595.409226] Starting subtest: getclient-simple
[595.439487] Subtest getclient-simple: SUCCESS (0.030s)
[595.544692] [074/132] (426s left) kms_lease (cursor-implicit-plane)
[595.642337] Starting subtest: cursor-implicit-plane
[595.643324] Starting dynamic subtest: pipe-A-eDP-1
[596.104965] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s)
[596.116024] Starting dynamic subtest: pipe-B-eDP-1
[597.203570] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.095s)
[597.213399] Starting dynamic subtest: pipe-C-eDP-1
[598.305041] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.101s)
[598.315388] Starting dynamic subtest: pipe-D-eDP-1
[599.434680] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[599.435616] Subtest cursor-implicit-plane: SUCCESS (3.793s)
[600.292119] [075/132] (421s left) i915_hangman (engine-error-state-capture)
[600.353261] Starting subtest: engine-error-state-capture
[600.354221] Starting dynamic subtest: rcs0
[604.290978] Dynamic subtest rcs0: SUCCESS (3.927s)
[604.303396] Starting dynamic subtest: bcs0
[610.307240] Dynamic subtest bcs0: SUCCESS (6.013s)
[610.318426] Starting dynamic subtest: vcs0
[616.258302] Dynamic subtest vcs0: SUCCESS (5.948s)
[616.269652] Starting dynamic subtest: vcs1
[621.314058] Dynamic subtest vcs1: SUCCESS (5.053s)
[621.323058] Starting dynamic subtest: vecs0
[627.266895] Dynamic subtest vecs0: SUCCESS (5.950s)
[627.280873] Starting dynamic subtest: ccs0
[633.282380] Dynamic subtest ccs0: SUCCESS (6.011s)
[633.283836] Subtest engine-error-state-capture: SUCCESS (32.919s)
[633.352433] [076/132] (388s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[633.407511] Starting subtest: invalid-bsd2-flag-on-vebox
[633.408326] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[633.515839] [077/132] (388s left) gem_flink_basic (basic)
[633.566609] Starting subtest: basic
[633.567509] Subtest basic: SUCCESS (0.000s)
[633.681687] [078/132] (388s left) gem_create (create-size-update)
[633.736827] Starting subtest: create-size-update
[633.737842] Subtest create-size-update: SUCCESS (0.000s)
[633.946830] [079/132] (388s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[634.046348] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[640.587250] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.541s)
[641.942188] [080/132] (380s left) syncobj_timeline (invalid-query-one-illegal-handle)
[641.988897] Starting subtest: invalid-query-one-illegal-handle
[641.989979] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[642.091791] [081/132] (379s left) gem_exec_params (invalid-bsd-ring)
[642.144552] Starting subtest: invalid-bsd-ring
[642.145678] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[642.240784] [082/132] (379s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[642.328574] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[642.329481] Starting dynamic subtest: pipe-A-eDP-1
[642.337040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[642.346767] Starting dynamic subtest: pipe-B-eDP-1
[642.354406] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[642.364465] Starting dynamic subtest: pipe-C-eDP-1
[642.371502] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[642.380139] Starting dynamic subtest: pipe-D-eDP-1
[642.387363] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[642.388241] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[644.508193] [083/132] (377s left) perf_pmu (rc6-all-gts)
[644.549122] Starting subtest: rc6-all-gts
[650.962793] Subtest rc6-all-gts: SUCCESS (6.368s)
[651.270900] [084/132] (370s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[651.362823] Starting subtest: 4-tiled-32bpp-rotate-270
[651.382371] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[651.491652] [085/132] (370s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[651.533414] Starting subtest: multi-wait-for-submit-available-signaled
[651.534340] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[651.632895] [086/132] (370s left) gem_lmem_swapping (random)
[651.669864] Subtest random: SKIP (0.000s)
[651.714157] [087/132] (370s left) kms_psr (pr-cursor-mmap-cpu)
[651.806573] Starting subtest: pr-cursor-mmap-cpu
[651.808410] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[651.874218] [088/132] (370s left) gem_userptr_blits (nohangcheck)
[651.937205] Starting subtest: nohangcheck
[652.178854] Subtest nohangcheck: SUCCESS (0.239s)
[652.290371] [089/132] (370s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[652.385182] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[652.386075] Starting dynamic subtest: pipe-A-eDP-1
[652.464321] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[652.476765] Starting dynamic subtest: pipe-B-eDP-1
[653.579810] Dynamic subtest pipe-B-eDP-1: SKIP (1.114s)
[653.581773] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.195s)
[654.789401] [090/132] (367s left) kms_cursor_crc (cursor-random-512x512)
[655.045333] Starting subtest: cursor-random-512x512
[655.047238] Subtest cursor-random-512x512: SKIP (0.001s)
[655.195782] [091/132] (367s left) gem_ctx_param (invalid-ctx-set)
[655.247619] Starting subtest: invalid-ctx-set
[655.248736] Subtest invalid-ctx-set: SUCCESS (0.001s)
[655.354979] [092/132] (367s left) gem_exec_fence (submit3)
[655.545044] Starting subtest: submit3
[655.547144] Subtest submit3: SKIP (0.000s)
[657.376797] [093/132] (365s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[657.426853] Starting subtest: etime-multi-wait-for-submit-submitted
[657.535312] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[657.607931] [094/132] (364s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[657.653226] Starting subtest: yf-tiled-ccs-to-x-tiled
[657.654976] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[657.835830] [095/132] (364s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[657.927430] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[665.117110] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.190s)
[665.214528] [096/132] (357s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[665.331162] Starting subtest: cursorA-vs-flipA-varying-size
[676.496079] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.158s)
[677.287890] [097/132] (345s left) gem_readwrite (read-write)
[677.341808] Subtest read-write: SKIP (0.000s)
[677.407412] [098/132] (345s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[677.490681] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[684.921704] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.432s)
[685.065605] [099/132] (337s left) gem_ccs (block-copy-compressed)
[685.118387] Starting subtest: block-copy-compressed
[685.120274] Subtest block-copy-compressed: SKIP (0.000s)
[685.214515] [100/132] (337s left) gem_workarounds (suspend-resume-context)
[685.279531] Starting subtest: suspend-resume-context
[702.304751] Subtest suspend-resume-context: SUCCESS (1.732s)
[708.447596] [101/132] (320s left) gem_pxp (create-protected-buffer)
[708.564742] Starting subtest: create-protected-buffer
[708.565786] Subtest create-protected-buffer: SUCCESS (0.000s)
[708.667840] [102/132] (320s left) kms_chamelium_frames (hdmi-aspect-ratio)
[709.051945] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[709.855604] [103/132] (318s left) kms_big_fb (linear-64bpp-rotate-270)
[709.948192] Starting subtest: linear-64bpp-rotate-270
[709.975572] Subtest linear-64bpp-rotate-270: SKIP (0.027s)
[710.086103] [104/132] (318s left) gem_userptr_blits (unsync-unmap)
[710.148473] Subtest unsync-unmap: SKIP (0.000s)
[710.307954] [105/132] (318s left) kms_cursor_edge_walk (64x64-top-bottom)
[710.496358] Starting subtest: 64x64-top-bottom
[710.497604] Starting dynamic subtest: pipe-A-eDP-1
[713.905593] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[713.917354] Starting dynamic subtest: pipe-D-eDP-1
[717.008788] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[717.009663] Subtest 64x64-top-bottom: SUCCESS (6.584s)
[717.805765] [106/132] (311s left) kms_psr (psr2-cursor-plane-onoff)
[717.890134] Starting subtest: psr2-cursor-plane-onoff
[717.891144] Starting dynamic subtest: eDP-1
[719.562855] Dynamic subtest eDP-1: SUCCESS (1.682s)
[719.563794] Subtest psr2-cursor-plane-onoff: SUCCESS (1.683s)
[720.435408] [107/132] (308s left) gem_exec_params (batch-first)
[720.496660] Starting subtest: batch-first
[720.507347] Subtest batch-first: SUCCESS (0.011s)
[720.628030] [108/132] (308s left) kms_joiner (basic-big-joiner)
[720.733165] Starting subtest: basic-big-joiner
[720.734930] Subtest basic-big-joiner: SKIP (0.000s)
[720.793636] [109/132] (308s left) gem_ctx_create (basic)
[720.848593] Starting subtest: basic
[720.849612] Subtest basic: SUCCESS (0.000s)
[721.043731] [110/132] (308s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[721.128630] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[721.130148] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[721.232921] [111/132] (307s left) gem_exec_parallel (engines)
[721.301655] Starting subtest: engines
[721.302614] Starting dynamic subtest: basic
[724.640737] Dynamic subtest basic: SUCCESS (3.342s)
[724.652342] Starting dynamic subtest: contexts
[728.955598] Dynamic subtest contexts: SUCCESS (4.322s)
[728.965551] Starting dynamic subtest: fds
[732.754678] Dynamic subtest fds: SUCCESS (3.803s)
[732.766679] Starting dynamic subtest: userptr
[734.624438] Dynamic subtest userptr: SUCCESS (1.870s)
[734.625899] Subtest engines: SUCCESS (13.345s)
[734.810946] [112/132] (294s left) kms_flip (2x-busy-flip)
[734.896726] Starting subtest: 2x-busy-flip
[734.907797] Subtest 2x-busy-flip: SKIP (0.011s)
[734.996263] [113/132] (294s left) kms_addfb_basic (too-wide)
[735.076150] Starting subtest: too-wide
[735.076968] Subtest too-wide: SUCCESS (0.000s)
[735.172190] [114/132] (294s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[735.269131] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[742.343441] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.072s)
[742.466888] [115/132] (286s left) gen9_exec_parse (bb-start-out)
[742.528555] Subtest bb-start-out: SKIP (0.000s)
[742.594635] [116/132] (286s left) kms_flip (2x-flip-vs-wf_vblank)
[742.678050] Starting subtest: 2x-flip-vs-wf_vblank
[742.689413] Subtest 2x-flip-vs-wf_vblank: SKIP (0.012s)
[742.768463] [117/132] (286s left) gem_mmap_offset (mmap-unmap)
[742.816685] Starting subtest: mmap-unmap
[742.817677] Starting dynamic subtest: smem0
[769.218953] Dynamic subtest smem0: SUCCESS (26.360s)
[769.219970] Subtest mmap-unmap: SUCCESS (26.361s)
[769.280600] [118/132] (260s left) kms_cursor_crc (cursor-onscreen-32x32)
[769.433781] Starting subtest: cursor-onscreen-32x32
[769.483702] Subtest cursor-onscreen-32x32: SKIP (0.048s)
[769.747357] [119/132] (259s left) gem_mmap_gtt (basic-write-read-distinct)
[769.799466] Subtest basic-write-read-distinct: SKIP (0.000s)
[769.860295] [120/132] (259s left) kms_vblank (query-forked-hang)
[769.953306] Starting subtest: query-forked-hang
[769.954214] Starting dynamic subtest: pipe-A-eDP-1
[796.430628] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.485s)
[796.444675] Starting dynamic subtest: pipe-D-eDP-1
[811.416387] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.983s)
[811.417454] Subtest query-forked-hang: SUCCESS (41.472s)
[812.265984] [121/132] (217s left) core_auth (many-magics)
[812.311199] Starting subtest: many-magics
[813.288012] Subtest many-magics: SUCCESS (0.977s)
[813.432950] [122/132] (216s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[813.525114] Starting subtest: addfb25-y-tiled-legacy
[813.526419] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[813.606040] [123/132] (215s left) perf (i915-ref-count)
[813.670189] Starting subtest: i915-ref-count
[813.728588] Subtest i915-ref-count: SUCCESS (0.059s)
[813.782842] [124/132] (215s left) kms_draw_crc (draw-method-mmap-gtt)
[813.873814] Starting subtest: draw-method-mmap-gtt
[813.876280] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[813.975571] [125/132] (215s left) api_intel_allocator (standalone)
[814.020264] Starting subtest: standalone
[814.042404] Subtest standalone: SUCCESS (0.023s)
[814.163084] [126/132] (215s left) kms_dp_link_training (uhbr-mst)
[814.250221] Starting subtest: uhbr-mst
[814.253339] Subtest uhbr-mst: SKIP (0.000s)
[814.326837] [127/132] (215s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[814.408206] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[814.410058] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[814.491627] [128/132] (215s left) kms_psr (fbc-psr-cursor-blt)
[814.571187] Starting subtest: fbc-psr-cursor-blt
[814.572062] Starting dynamic subtest: eDP-1
[814.573694] Dynamic subtest eDP-1: SKIP (0.000s)
[814.575292] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[814.642062] [129/132] (215s left) gem_exec_schedule (thriceslice)
[814.714929] Starting subtest: thriceslice
[814.715873] Starting dynamic subtest: rcs0
[814.739867] Dynamic subtest rcs0: SUCCESS (0.032s)
[814.752276] Starting dynamic subtest: bcs0
[814.771141] Dynamic subtest bcs0: SUCCESS (0.030s)
[814.781944] Starting dynamic subtest: vcs0
[814.801070] Dynamic subtest vcs0: SUCCESS (0.028s)
[814.810652] Starting dynamic subtest: vcs1
[814.851357] Dynamic subtest vcs1: SUCCESS (0.049s)
[814.864358] Starting dynamic subtest: vecs0
[814.883361] Dynamic subtest vecs0: SUCCESS (0.030s)
[814.894193] Starting dynamic subtest: ccs0
[814.915247] Dynamic subtest ccs0: SUCCESS (0.030s)
[814.916207] Subtest thriceslice: SUCCESS (0.209s)
[815.214904] [130/132] (214s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[815.297168] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[815.298106] Starting dynamic subtest: pipe-A-eDP-1
[815.315096] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[815.327878] Starting dynamic subtest: pipe-B-eDP-1
[815.336942] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[815.346956] Starting dynamic subtest: pipe-C-eDP-1
[815.355070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[815.365265] Starting dynamic subtest: pipe-D-eDP-1
[815.373694] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[815.375336] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[817.462466] [131/132] (212s left) kms_color_pipeline (plane-lut1d-lut1d)
[817.559506] Starting subtest: plane-lut1d-lut1d
[817.706901] Starting dynamic subtest: pipe-A-plane-0
[817.906841] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[817.918873] Starting dynamic subtest: pipe-A-plane-1
[818.084317] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[818.095029] Starting dynamic subtest: pipe-A-plane-2
[818.274324] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[819.471559] Starting dynamic subtest: pipe-B-plane-0
[819.626291] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[819.639386] Starting dynamic subtest: pipe-B-plane-1
[819.826036] Dynamic subtest pipe-B-plane-1: SUCCESS (0.199s)
[819.839554] Starting dynamic subtest: pipe-B-plane-2
[820.015101] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[821.182246] Starting dynamic subtest: pipe-C-plane-0
[821.338137] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[821.351219] Starting dynamic subtest: pipe-C-plane-1
[821.505500] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[821.520368] Starting dynamic subtest: pipe-C-plane-2
[821.660336] Dynamic subtest pipe-C-plane-2: SUCCESS (0.154s)
[822.832908] Starting dynamic subtest: pipe-D-plane-0
[822.989524] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[823.000049] Starting dynamic subtest: pipe-D-plane-1
[823.145248] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[823.158110] Starting dynamic subtest: pipe-D-plane-2
[823.311813] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[823.597158] Subtest plane-lut1d-lut1d: SUCCESS (6.037s)
[824.476727] [132/132] (205s left) kms_flip (flip-vs-expired-vblank-interruptible)
[824.563539] Starting subtest: flip-vs-expired-vblank-interruptible
[824.565757] Starting dynamic subtest: A-eDP1
[833.230157] Dynamic subtest A-eDP1: SUCCESS (8.638s)
[833.241094] Starting dynamic subtest: B-eDP1
[841.859699] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[841.869633] Starting dynamic subtest: C-eDP1
[850.493593] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[850.503929] Starting dynamic subtest: D-eDP1
[859.123894] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[859.124816] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.530s)
[860.244078] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic_transition
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: sysfs_heartbeat_interval
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: prime_mmap_coherency
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_bad_reloc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_chamelium_color
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_pm_rpm
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_async_flips
results: parsing output: 27/ for test: kms_atomic_interruptible
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: sw_sync
results: parsing output: 39/ for test: dmabuf_sync_file
results: parsing output: 40/ for test: kms_content_protection
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: prime_busy
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_close_race
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: kms_pm_dc
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_selftest
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: gem_ringfill
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_getfb
results: parsing output: 66/ for test: kms_plane
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_pipe_crc_basic
results: parsing output: 69/ for test: kms_psr_stress_test
results: parsing output: 70/ for test: intel_hwmon
results: parsing output: 71/ for test: gem_ctx_shared
results: parsing output: 72/ for test: core_auth
results: parsing output: 73/ for test: kms_lease
results: parsing output: 74/ for test: i915_hangman
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: gem_flink_basic
results: parsing output: 77/ for test: gem_create
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: gem_ctx_param
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: gem_readwrite
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_ccs
results: parsing output: 99/ for test: gem_workarounds
results: parsing output: 100/ for test: gem_pxp
results: parsing output: 101/ for test: kms_chamelium_frames
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: kms_cursor_edge_walk
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_exec_params
results: parsing output: 107/ for test: kms_joiner
results: parsing output: 108/ for test: gem_ctx_create
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_parallel
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_mmap_offset
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: core_auth
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: kms_draw_crc
results: parsing output: 124/ for test: api_intel_allocator
results: parsing output: 125/ for test: kms_dp_link_training
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_color_pipeline
results: parsing output: 131/ for test: kms_flip
Done.