[61.853938] Initializing watchdogs
[61.853985]   /dev/watchdog0
[61.867755] [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]
[61.872178] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.875304] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.880206] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[62.007671] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[68.953818] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.950s)
[69.064951] [002/133] (953s left) kms_big_fb (4-tiled-addfb-size-overflow)
[69.157599] Starting subtest: 4-tiled-addfb-size-overflow
[69.159868] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[69.249868] [003/133] (953s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[69.364144] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[70.353501] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.990s)
[70.497503] [004/133] (951s left) gem_userptr_blits (process-exit-busy)
[70.577266] Starting subtest: process-exit-busy
[70.589825] Subtest process-exit-busy: SUCCESS (0.016s)
[70.702176] [005/133] (951s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[70.786599] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[70.790698] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[71.922022] [006/133] (950s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[71.976805] Starting subtest: invalid-multi-wait-all-unsubmitted
[71.979180] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[72.067643] [007/133] (950s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[72.117686] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[72.221080] [008/133] (950s left) gem_ctx_param (set-priority-not-supported)
[72.290827] Starting subtest: set-priority-not-supported
[72.296034] Subtest set-priority-not-supported: SKIP (0.000s)
[72.369480] [009/133] (950s left) kms_cursor_crc (cursor-onscreen-512x170)
[72.655700] Starting subtest: cursor-onscreen-512x170
[72.659855] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[72.790349] [010/133] (950s left) kms_psr (psr2-primary-mmap-cpu)
[72.880581] Starting subtest: psr2-primary-mmap-cpu
[72.882683] Starting dynamic subtest: eDP-1
[74.582911] Dynamic subtest eDP-1: SUCCESS (1.704s)
[74.585295] Subtest psr2-primary-mmap-cpu: SUCCESS (1.705s)
[75.448825] [011/133] (947s left) gem_softpin (evict-snoop-interruptible)
[75.524619] Starting subtest: evict-snoop-interruptible
[75.528929] Subtest evict-snoop-interruptible: SKIP (0.000s)
[75.641763] [012/133] (947s left) kms_fbcon_fbt (fbc-suspend)
[75.699839] Starting subtest: fbc-suspend
[125.578847] Subtest fbc-suspend: SUCCESS (19.245s)
[126.901684] [013/133] (896s left) i915_query (hwconfig_table)
[126.955850] Starting subtest: hwconfig_table
[127.258824] Subtest hwconfig_table: SUCCESS (0.001s)
[127.294598] [014/133] (895s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[127.397696] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[127.402300] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[127.478633] [015/133] (895s left) kms_psr (fbc-pr-dpms)
[127.572521] Starting subtest: fbc-pr-dpms
[127.576619] Subtest fbc-pr-dpms: SKIP (0.000s)
[127.645712] [016/133] (895s left) kms_addfb_basic (basic-y-tiled-legacy)
[127.700134] Starting subtest: basic-y-tiled-legacy
[127.704511] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[127.820704] [017/133] (895s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[127.916168] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[127.918057] Starting dynamic subtest: pipe-A
[127.936979] Dynamic subtest pipe-A: SKIP (0.019s)
[127.945271] Starting dynamic subtest: pipe-B
[127.973647] Dynamic subtest pipe-B: SKIP (0.036s)
[127.982189] Starting dynamic subtest: pipe-C
[128.007841] Dynamic subtest pipe-C: SKIP (0.034s)
[128.015290] Starting dynamic subtest: pipe-D
[128.043100] Dynamic subtest pipe-D: SKIP (0.034s)
[128.046243] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.125s)
[128.156301] [018/133] (894s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[128.265153] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[128.268968] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[128.372945] [019/133] (894s left) gem_eio (in-flight-1us)
[128.574133] Starting subtest: in-flight-1us
[136.967827] Subtest in-flight-1us: SUCCESS (8.393s)
[137.122201] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[137.125237] [020/133] (886s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[137.223633] Starting subtest: disable-crc-after-crtc
[137.226048] Starting dynamic subtest: pipe-A-eDP-1
[138.864712] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.639s)
[138.874024] Starting dynamic subtest: pipe-B-eDP-1
[141.141085] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.276s)
[141.153516] Starting dynamic subtest: pipe-C-eDP-1
[143.412332] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.268s)
[143.422567] Starting dynamic subtest: pipe-D-eDP-1
[145.684065] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.272s)
[145.686217] Subtest disable-crc-after-crtc: SUCCESS (8.460s)
[146.526392] [021/133] (876s left) kms_plane_multiple (tiling-y)
[146.619867] Starting subtest: tiling-y
[146.624272] Subtest tiling-y: SKIP (0.000s)
[146.692207] [022/133] (876s left) gem_exec_fence (nb-await)
[146.876885] Starting subtest: nb-await
[146.879343] Starting dynamic subtest: rcs0
[146.945754] Dynamic subtest rcs0: SUCCESS (0.068s)
[146.957283] Starting dynamic subtest: bcs0
[147.015767] Dynamic subtest bcs0: SUCCESS (0.069s)
[147.026627] Starting dynamic subtest: vcs0
[147.074676] Dynamic subtest vcs0: SUCCESS (0.057s)
[147.086022] Starting dynamic subtest: vcs1
[147.133679] Dynamic subtest vcs1: SUCCESS (0.058s)
[147.144673] Starting dynamic subtest: vecs0
[147.193147] Dynamic subtest vecs0: SUCCESS (0.058s)
[147.204151] Starting dynamic subtest: ccs0
[147.251496] Dynamic subtest ccs0: SUCCESS (0.057s)
[147.254009] Subtest nb-await: SUCCESS (0.375s)
[148.608689] [023/133] (874s left) kms_psr (pr-sprite-render)
[148.705683] Starting subtest: pr-sprite-render
[148.709693] Subtest pr-sprite-render: SKIP (0.000s)
[148.776153] [024/133] (874s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[148.886000] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[148.890034] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[148.998661] [025/133] (874s left) syncobj_wait (multi-wait-all-submitted)
[149.062554] Starting subtest: multi-wait-all-submitted
[149.168822] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[149.244544] [026/133] (874s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[149.334894] Starting subtest: plane-primary-overlay-mutable-zpos
[152.771433] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.434s)
[153.949439] [027/133] (869s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[154.047030] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[154.051227] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[154.115427] [028/133] (869s left) gem_exec_schedule (u-submit-late-slice)
[154.191658] Starting subtest: u-submit-late-slice
[154.193789] Starting dynamic subtest: rcs0
[154.224622] Dynamic subtest rcs0: SUCCESS (0.042s)
[154.236145] Starting dynamic subtest: bcs0
[154.265638] Dynamic subtest bcs0: SUCCESS (0.040s)
[154.275416] Starting dynamic subtest: vcs0
[154.296856] Dynamic subtest vcs0: SUCCESS (0.031s)
[154.305449] Starting dynamic subtest: vcs1
[154.331555] Dynamic subtest vcs1: SUCCESS (0.034s)
[154.340019] Starting dynamic subtest: vecs0
[154.376458] Dynamic subtest vecs0: SUCCESS (0.044s)
[154.386835] Starting dynamic subtest: ccs0
[154.409146] Dynamic subtest ccs0: SUCCESS (0.032s)
[154.411517] Subtest u-submit-late-slice: SUCCESS (0.228s)
[155.599094] [029/133] (867s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[155.692651] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[155.696830] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[155.802410] [030/133] (867s left) kms_flip (2x-dpms-vs-vblank-race)
[155.896152] Starting subtest: 2x-dpms-vs-vblank-race
[155.904251] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[155.987056] [031/133] (867s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[156.087610] Starting subtest: extended-modeset-hang-newfb-with-reset
[156.090092] Starting dynamic subtest: pipe-A
[171.970177] Dynamic subtest pipe-A: SUCCESS (15.878s)
[171.980875] Starting dynamic subtest: pipe-D
[187.553433] Dynamic subtest pipe-D: SUCCESS (15.580s)
[187.555445] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.463s)
[188.359938] [032/133] (835s left) i915_drm_fdinfo (context-close-stress)
[188.406617] Starting subtest: context-close-stress
[199.204214] Subtest context-close-stress: SUCCESS (10.745s)
[199.247602] [033/133] (824s left) gem_exec_balancer (semaphore)
[199.527601] Starting subtest: semaphore
[201.524411] Subtest semaphore: SUCCESS (1.995s)
[201.819010] [034/133] (821s left) gem_exec_schedule (in-order)
[201.892238] Starting subtest: in-order
[201.894501] Starting dynamic subtest: rcs0
[202.048656] Dynamic subtest rcs0: SUCCESS (0.163s)
[202.060749] Starting dynamic subtest: vcs0
[202.165586] Dynamic subtest vcs0: SUCCESS (0.117s)
[202.177108] Starting dynamic subtest: vcs1
[202.273361] Dynamic subtest vcs1: SUCCESS (0.107s)
[202.289459] Starting dynamic subtest: vecs0
[202.378988] Dynamic subtest vecs0: SUCCESS (0.105s)
[202.390248] Starting dynamic subtest: ccs0
[202.521212] Dynamic subtest ccs0: SUCCESS (0.141s)
[202.524105] Subtest in-order: SUCCESS (0.635s)
[203.607300] [035/133] (820s left) gem_ctx_persistence (saturated-hostile)
[203.666139] Starting subtest: saturated-hostile
[203.668424] Starting dynamic subtest: rcs0
[204.489012] Dynamic subtest rcs0: SUCCESS (0.822s)
[204.501689] Starting dynamic subtest: bcs0
[205.284171] Dynamic subtest bcs0: SUCCESS (0.793s)
[205.295961] Starting dynamic subtest: vcs0
[206.072349] Dynamic subtest vcs0: SUCCESS (0.787s)
[206.083911] Starting dynamic subtest: vcs1
[206.870274] Dynamic subtest vcs1: SUCCESS (0.796s)
[206.881659] Starting dynamic subtest: vecs0
[207.662177] Dynamic subtest vecs0: SUCCESS (0.790s)
[207.673837] Starting dynamic subtest: ccs0
[208.516252] Dynamic subtest ccs0: SUCCESS (0.853s)
[208.519089] Subtest saturated-hostile: SUCCESS (4.850s)
[208.600457] [036/133] (815s left) gem_userptr_blits (userfault)
[208.671841] Starting subtest: userfault
[208.674643] Subtest userfault: SUCCESS (0.009s)
[208.817100] [037/133] (815s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[208.915069] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[208.917192] Starting dynamic subtest: pipe-A-default-mode
[210.116845] Dynamic subtest pipe-A-default-mode: SKIP (1.198s)
[210.121037] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.199s)
[210.251239] [038/133] (813s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[210.343988] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[210.346264] Starting dynamic subtest: pipe-A-eDP-1
[210.369457] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.378833] Starting dynamic subtest: pipe-B-eDP-1
[210.400850] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.409273] Starting dynamic subtest: pipe-C-eDP-1
[210.431145] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.439876] Starting dynamic subtest: pipe-D-eDP-1
[210.462022] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.466058] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[212.570508] [039/133] (811s left) kms_plane (pixel-format-yf-tiled-modifier)
[212.662843] Starting subtest: pixel-format-yf-tiled-modifier
[212.667162] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[212.759088] [040/133] (811s left) gem_mmap_gtt (fault-concurrent-x)
[212.816536] Subtest fault-concurrent-X: SKIP (0.000s)
[212.878868] [041/133] (811s left) testdisplay
[213.199538] [042/133] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[213.300654] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[213.305227] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[213.411545] [043/133] (810s left) i915_module_load (reload)
[213.447245] Starting subtest: reload
[218.179605] Subtest reload: SUCCESS (4.734s)
[218.219465] [044/133] (805s left) kms_prop_blob (basic)
[219.486753] Starting subtest: basic
[219.489521] Subtest basic: SUCCESS (0.000s)
[219.598410] [045/133] (804s left) kms_hdr (bpc-switch)
[219.693524] Starting subtest: bpc-switch
[220.785026] Starting dynamic subtest: pipe-A-eDP-1
[224.291133] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.507s)
[224.293469] Subtest bpc-switch: SUCCESS (4.601s)
[224.394961] [046/133] (799s left) sysfs_timeslice_duration (invalid)
[224.462306] Starting subtest: invalid
[224.464575] Starting dynamic subtest: vecs0
[224.466955] Dynamic subtest vecs0: SUCCESS (0.000s)
[224.476855] Starting dynamic subtest: ccs0
[224.478848] Dynamic subtest ccs0: SUCCESS (0.000s)
[224.486791] Starting dynamic subtest: vcs0
[224.489040] Dynamic subtest vcs0: SUCCESS (0.000s)
[224.497019] Starting dynamic subtest: bcs0
[224.498919] Dynamic subtest bcs0: SUCCESS (0.000s)
[224.506397] Starting dynamic subtest: rcs0
[224.508310] Dynamic subtest rcs0: SUCCESS (0.000s)
[224.517109] Starting dynamic subtest: vcs1
[224.519049] Dynamic subtest vcs1: SUCCESS (0.000s)
[224.520943] Subtest invalid: SUCCESS (0.004s)
[224.557671] [047/133] (799s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[224.646394] Starting subtest: crc-primary-suspend-y-tiled-ccs
[224.648670] Starting dynamic subtest: pipe-A-eDP-1
[224.658741] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.667413] Starting dynamic subtest: pipe-B-eDP-1
[224.676411] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.689245] Starting dynamic subtest: pipe-C-eDP-1
[224.697342] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.704594] Starting dynamic subtest: pipe-D-eDP-1
[224.712603] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.716515] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[226.930625] [048/133] (797s left) gem_unref_active_buffers
[227.152383] [049/133] (797s left) perf (oa-exponents)
[227.267262] Starting subtest: oa-exponents
[227.269250] Starting dynamic subtest: 0-rcs0
[229.053855] Dynamic subtest 0-rcs0: SUCCESS (1.787s)
[229.063184] Starting dynamic subtest: 1-vcs0
[230.883433] Dynamic subtest 1-vcs0: SUCCESS (1.829s)
[230.885725] Subtest oa-exponents: SUCCESS (3.618s)
[230.931649] [050/133] (793s left) syncobj_timeline (etime-multi-wait-submitted)
[230.988317] Starting subtest: etime-multi-wait-submitted
[231.096439] Subtest etime-multi-wait-submitted: SUCCESS (0.108s)
[231.168932] [051/133] (793s left) perf (short-reads)
[231.262855] Starting subtest: short-reads
[231.276010] Subtest short-reads: SUCCESS (0.014s)
[231.319071] [052/133] (793s left) gem_partial_pwrite_pread (reads-snoop)
[231.382176] Subtest reads-snoop: SKIP (0.000s)
[231.470799] [053/133] (793s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[231.576597] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[231.580985] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[231.671153] [054/133] (792s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[231.770503] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[231.774601] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[231.857434] [055/133] (792s left) gem_ctx_param (invalid-ctx-get)
[231.926847] Starting subtest: invalid-ctx-get
[231.929030] Subtest invalid-ctx-get: SUCCESS (0.000s)
[231.999310] [056/133] (792s left) kms_lease (lease-unleased-crtc)
[232.093544] Starting subtest: lease-unleased-crtc
[232.095833] Starting dynamic subtest: pipe-A-eDP-1
[232.387857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[232.399421] Starting dynamic subtest: pipe-B-eDP-1
[233.181703] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.794s)
[233.192154] Starting dynamic subtest: pipe-C-eDP-1
[233.194358] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[233.201744] Starting dynamic subtest: pipe-D-eDP-1
[233.203651] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[233.205576] Subtest lease-unleased-crtc: SUCCESS (1.099s)
[233.569031] [057/133] (791s left) syncobj_wait (multi-wait-submitted-signaled)
[233.619767] Starting subtest: multi-wait-submitted-signaled
[233.621972] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[233.721637] [058/133] (791s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[233.808656] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[233.810867] Starting dynamic subtest: pipe-A-eDP-1
[234.664839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.849s)
[234.675411] Starting dynamic subtest: pipe-B-eDP-1
[236.205553] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.540s)
[236.214493] Starting dynamic subtest: pipe-C-eDP-1
[237.677503] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.470s)
[237.687121] Starting dynamic subtest: pipe-D-eDP-1
[239.211415] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[239.213306] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.396s)
[240.390692] [059/133] (784s left) gem_exec_schedule (semaphore-codependency)
[240.455416] Starting subtest: semaphore-codependency
[240.460252] Subtest semaphore-codependency: SUCCESS (0.013s)
[240.817175] [060/133] (784s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[240.915851] Starting subtest: fbcpsr-shrfb-scaledprimary
[246.669667] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.757s)
[246.807850] [061/133] (778s left) kms_cursor_legacy (torture-bo)
[246.922956] Starting subtest: torture-bo
[246.924799] Starting dynamic subtest: pipe-A
[252.963920] Dynamic subtest pipe-A: SUCCESS (6.037s)
[252.975240] Starting dynamic subtest: pipe-B
[258.989250] Dynamic subtest pipe-B: SUCCESS (6.026s)
[259.005036] Starting dynamic subtest: pipe-C
[265.639320] Dynamic subtest pipe-C: SUCCESS (6.648s)
[265.649839] Starting dynamic subtest: pipe-D
[272.000621] Dynamic subtest pipe-D: SUCCESS (6.360s)
[272.009977] Starting dynamic subtest: all-pipes
[278.695411] Dynamic subtest all-pipes: SUCCESS (6.693s)
[278.697867] Subtest torture-bo: SUCCESS (31.773s)
[278.854924] [062/133] (746s left) gem_exec_balancer (bonded-semaphore)
[278.911442] Starting subtest: bonded-semaphore
[278.916004] Subtest bonded-semaphore: SKIP (0.000s)
[279.221407] [063/133] (745s left) gem_madvise (dontneed-before-pwrite)
[279.259085] Starting subtest: dontneed-before-pwrite
[279.277844] Subtest dontneed-before-pwrite: SKIP (0.019s)
[279.377320] [064/133] (745s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[279.474600] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[279.478809] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[279.585043] [065/133] (745s left) gem_ctx_bad_destroy (invalid-pad)
[279.644663] Starting subtest: invalid-pad
[279.647044] Subtest invalid-pad: SUCCESS (0.000s)
[279.717975] [066/133] (745s left) kms_concurrent (multi-plane-atomic-lowres)
[279.811842] Starting subtest: multi-plane-atomic-lowres
[279.814156] Starting dynamic subtest: pipe-A-eDP-1
[280.337329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.523s)
[280.346584] Starting dynamic subtest: pipe-B-eDP-1
[281.568873] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s)
[281.578419] Starting dynamic subtest: pipe-C-eDP-1
[282.772956] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s)
[282.782412] Starting dynamic subtest: pipe-D-eDP-1
[284.028708] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.255s)
[284.031485] Subtest multi-plane-atomic-lowres: SUCCESS (4.217s)
[284.859216] [067/133] (740s left) kms_properties (get_properties-sanity-atomic)
[284.961731] Starting subtest: get_properties-sanity-atomic
[284.964134] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[285.047564] [068/133] (740s left) gem_ccs (block-multicopy-inplace)
[285.099554] Starting subtest: block-multicopy-inplace
[285.103895] Subtest block-multicopy-inplace: SKIP (0.000s)
[285.200514] [069/133] (740s left) kms_vblank (ts-continuation-idle-hang)
[285.284524] Starting subtest: ts-continuation-idle-hang
[285.286791] Starting dynamic subtest: pipe-A-eDP-1
[311.296026] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.010s)
[311.309766] Starting dynamic subtest: pipe-D-eDP-1
[326.261305] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.960s)
[326.263223] Subtest ts-continuation-idle-hang: SUCCESS (40.975s)
[327.106169] [070/133] (698s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[327.498214] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[328.311086] [071/133] (697s left) gen9_exec_parse (bb-oversize)
[328.372834] Subtest bb-oversize: SKIP (0.000s)
[328.449023] [072/133] (696s left) kms_plane_scaling (invalid-num-scalers)
[328.541918] Starting subtest: invalid-num-scalers
[328.544121] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[328.561244] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[328.570218] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[328.592112] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[328.600651] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[328.624347] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[328.632706] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[328.656405] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[328.658678] Subtest invalid-num-scalers: SUCCESS (0.115s)
[328.770770] [073/133] (696s left) prime_vgem (fence-read-hang)
[328.860699] Subtest fence-read-hang: SKIP (0.000s)
[328.959957] [074/133] (696s left) kms_psr (fbc-psr-primary-blt)
[329.058738] Starting subtest: fbc-psr-primary-blt
[329.061087] Starting dynamic subtest: eDP-1
[329.065314] Dynamic subtest eDP-1: SKIP (0.000s)
[329.069530] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[329.132232] [075/133] (696s left) gem_spin_batch (resubmit-new)
[329.187078] Starting subtest: resubmit-new
[329.189238] Starting dynamic subtest: rcs0
[329.195837] Dynamic subtest rcs0: SUCCESS (0.009s)
[329.206538] Starting dynamic subtest: bcs0
[329.208592] Dynamic subtest bcs0: SUCCESS (0.004s)
[329.216989] Starting dynamic subtest: vcs0
[329.219252] Dynamic subtest vcs0: SUCCESS (0.007s)
[329.227654] Starting dynamic subtest: vcs1
[329.229501] Dynamic subtest vcs1: SUCCESS (0.005s)
[329.237065] Starting dynamic subtest: vecs0
[329.238596] Dynamic subtest vecs0: SUCCESS (0.004s)
[329.245859] Starting dynamic subtest: ccs0
[329.247726] Dynamic subtest ccs0: SUCCESS (0.004s)
[329.249291] Subtest resubmit-new: SUCCESS (0.039s)
[330.607098] [076/133] (694s left) gem_userptr_blits (process-exit)
[330.684977] Starting subtest: process-exit
[330.693154] Subtest process-exit: SUCCESS (0.010s)
[330.827251] [077/133] (694s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[330.920880] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[330.924841] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[331.010287] [078/133] (694s left) syncobj_timeline (invalid-wait-illegal-handle)
[331.075936] Starting subtest: invalid-wait-illegal-handle
[331.077753] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[331.165986] [079/133] (694s left) syncobj_wait (wait-all-interrupted)
[331.230072] Starting subtest: wait-all-interrupted
[331.331622] Subtest wait-all-interrupted: SUCCESS (0.102s)
[331.409066] [080/133] (694s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[331.504745] Starting subtest: yf-tiled-32bpp-rotate-180
[331.508962] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[331.591897] [081/133] (694s left) gem_ctx_persistence (engines-hostile)
[331.640020] Starting subtest: engines-hostile
[331.642272] Starting dynamic subtest: rcs0
[331.759602] Dynamic subtest rcs0: SUCCESS (0.119s)
[331.770683] Starting dynamic subtest: bcs0
[331.853740] Dynamic subtest bcs0: SUCCESS (0.092s)
[331.868910] Starting dynamic subtest: vcs0
[331.966682] Dynamic subtest vcs0: SUCCESS (0.109s)
[331.980556] Starting dynamic subtest: vcs1
[332.086826] Dynamic subtest vcs1: SUCCESS (0.118s)
[332.097244] Starting dynamic subtest: vecs0
[332.195397] Dynamic subtest vecs0: SUCCESS (0.106s)
[332.206817] Starting dynamic subtest: ccs0
[332.295724] Dynamic subtest ccs0: SUCCESS (0.098s)
[332.298522] Subtest engines-hostile: SUCCESS (0.656s)
[332.375743] [082/133] (693s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[332.480838] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[332.482751] Starting dynamic subtest: A-eDP1
[336.056742] Dynamic subtest A-eDP1: SUCCESS (3.573s)
[336.066888] Starting dynamic subtest: B-eDP1
[339.260413] Dynamic subtest B-eDP1: SUCCESS (3.202s)
[339.269172] Starting dynamic subtest: C-eDP1
[342.476888] Dynamic subtest C-eDP1: SUCCESS (3.215s)
[342.485990] Starting dynamic subtest: D-eDP1
[345.605857] Dynamic subtest D-eDP1: SUCCESS (3.128s)
[345.608208] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.126s)
[346.405611] [083/133] (679s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[346.478581] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[346.481041] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[346.592168] [084/133] (679s left) gem_exec_schedule (fairslice)
[346.661857] Starting subtest: fairslice
[346.664048] Starting dynamic subtest: rcs0
[348.726491] Dynamic subtest rcs0: SUCCESS (2.019s)
[348.736173] Starting dynamic subtest: bcs0
[350.694865] Dynamic subtest bcs0: SUCCESS (2.018s)
[350.704003] Starting dynamic subtest: vcs0
[352.763757] Dynamic subtest vcs0: SUCCESS (2.018s)
[352.773568] Starting dynamic subtest: vcs1
[354.730703] Dynamic subtest vcs1: SUCCESS (2.015s)
[354.740268] Starting dynamic subtest: vecs0
[356.798279] Dynamic subtest vecs0: SUCCESS (2.016s)
[356.807836] Starting dynamic subtest: ccs0
[358.764887] Dynamic subtest ccs0: SUCCESS (2.018s)
[358.766738] Subtest fairslice: SUCCESS (12.109s)
[359.078714] [085/133] (666s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[359.185035] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[359.189269] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[359.279613] [086/133] (666s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[359.381530] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[359.387818] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[359.495817] [087/133] (666s left) kms_flip (2x-flip-vs-fences)
[359.574171] Starting subtest: 2x-flip-vs-fences
[359.578452] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[359.684530] [088/133] (666s left) gem_create (create-massive)
[359.745080] Starting subtest: create-massive
[359.747448] Subtest create-massive: SUCCESS (0.000s)
[359.928913] [089/133] (666s left) kms_rotation_crc (multiplane-rotation)
[360.033131] Starting subtest: multiplane-rotation
[377.391218] Subtest multiplane-rotation: SUCCESS (17.360s)
[377.544458] [090/133] (648s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[377.663580] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[387.056819] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.391s)
[387.935315] [091/133] (638s left) perf_pmu (busy-hang)
[387.976692] Starting subtest: busy-hang
[387.979006] Starting dynamic subtest: rcs0
[389.230159] Dynamic subtest rcs0: SUCCESS (1.254s)
[389.244819] Starting dynamic subtest: bcs0
[390.455712] Dynamic subtest bcs0: SUCCESS (1.221s)
[390.468977] Starting dynamic subtest: vcs0
[393.028856] Dynamic subtest vcs0: SUCCESS (2.574s)
[393.040179] Starting dynamic subtest: vcs1
[395.076163] Dynamic subtest vcs1: SUCCESS (2.042s)
[395.086858] Starting dynamic subtest: vecs0
[397.061271] Dynamic subtest vecs0: SUCCESS (1.983s)
[397.071536] Starting dynamic subtest: ccs0
[398.294145] Dynamic subtest ccs0: SUCCESS (1.234s)
[398.296681] Subtest busy-hang: SUCCESS (10.319s)
[398.408672] [092/133] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[398.504271] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[405.993148] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.491s)
[406.127590] [093/133] (620s left) prime_mmap_kms (buffer-sharing)
[406.216426] Starting subtest: buffer-sharing
[406.660846] Subtest buffer-sharing: SUCCESS (0.446s)
[407.474558] [094/133] (618s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[407.567822] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[414.851092] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.284s)
[414.979754] [095/133] (611s left) kms_properties (connector-properties-legacy)
[415.070578] Starting subtest: connector-properties-legacy
[415.072766] Starting dynamic subtest: pipe-A-eDP-1
[423.070549] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.000s)
[423.081554] Starting dynamic subtest: pipe-None-DP-1
[423.085818] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[423.094645] Starting dynamic subtest: pipe-None-HDMI-A-1
[423.098839] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[423.108171] Starting dynamic subtest: pipe-None-DP-2
[423.112528] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[423.121662] Starting dynamic subtest: pipe-None-HDMI-A-2
[423.125986] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[423.137214] Starting dynamic subtest: pipe-None-DP-3
[423.141829] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[423.150709] Starting dynamic subtest: pipe-None-DP-4
[423.155512] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[423.157850] Subtest connector-properties-legacy: SUCCESS (8.012s)
[423.936444] [096/133] (602s left) syncobj_timeline (reset-multiple-signaled)
[423.992240] Starting subtest: reset-multiple-signaled
[423.994436] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[424.102048] [097/133] (602s left) api_intel_bb (delta-check)
[424.163399] Starting subtest: delta-check
[424.166805] Subtest delta-check: SUCCESS (0.006s)
[424.289973] [098/133] (602s left) kms_draw_crc (draw-method-mmap-wc)
[424.390015] Starting subtest: draw-method-mmap-wc
[424.391875] Starting dynamic subtest: xrgb8888-untiled
[424.642701] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[424.652622] Starting dynamic subtest: rgb565-untiled
[424.856987] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[424.867845] Starting dynamic subtest: xrgb2101010-untiled
[425.075649] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.219s)
[425.084698] Starting dynamic subtest: xbgr16161616f-untiled
[425.297817] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[425.306759] Starting dynamic subtest: xrgb8888-xtiled
[425.464591] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.166s)
[425.475892] Starting dynamic subtest: rgb565-xtiled
[425.586816] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[425.598072] Starting dynamic subtest: xrgb2101010-xtiled
[425.720157] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[425.735113] Starting dynamic subtest: xbgr16161616f-xtiled
[425.853744] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[425.864616] Starting dynamic subtest: xrgb8888-4tiled
[425.998103] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.142s)
[426.010841] Starting dynamic subtest: rgb565-4tiled
[426.142594] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s)
[426.153812] Starting dynamic subtest: xrgb2101010-4tiled
[426.276401] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[426.291640] Starting dynamic subtest: xbgr16161616f-4tiled
[426.465549] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.187s)
[426.467426] Subtest draw-method-mmap-wc: SUCCESS (2.079s)
[426.607276] [099/133] (599s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[426.702111] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[431.174555] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.474s)
[432.359434] [100/133] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[432.465833] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[439.732838] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.271s)
[439.857211] [101/133] (586s left) gem_exec_async (forked-writes)
[439.930667] Starting subtest: forked-writes
[439.932941] Starting dynamic subtest: rcs0
[439.957442] Dynamic subtest rcs0: SUCCESS (0.026s)
[439.967438] Starting dynamic subtest: bcs0
[439.979584] Dynamic subtest bcs0: SUCCESS (0.021s)
[439.989530] Starting dynamic subtest: vcs0
[440.003372] Dynamic subtest vcs0: SUCCESS (0.023s)
[440.013031] Starting dynamic subtest: vcs1
[440.026469] Dynamic subtest vcs1: SUCCESS (0.022s)
[440.039709] Starting dynamic subtest: vecs0
[440.047878] Dynamic subtest vecs0: SUCCESS (0.021s)
[440.057902] Starting dynamic subtest: ccs0
[440.072080] Dynamic subtest ccs0: SUCCESS (0.024s)
[440.074219] Subtest forked-writes: SUCCESS (0.142s)
[440.295209] [102/133] (586s left) kms_chamelium_frames (hdmi-frame-dump)
[440.679258] Subtest hdmi-frame-dump: SKIP (0.000s)
[441.472463] [103/133] (585s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[441.562453] Starting subtest: primary-yf-tiled-reflect-x-0
[441.644261] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.081s)
[441.746096] [104/133] (584s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[441.841991] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[441.852820] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[441.951899] [105/133] (584s left) kms_chamelium_audio (hdmi-audio-edid)
[442.330882] Subtest hdmi-audio-edid: SKIP (0.000s)
[443.105581] [106/133] (583s left) gem_exec_reloc (basic-write-wc-noreloc)
[443.174649] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[443.255561] [107/133] (583s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[443.309162] Starting subtest: wait-all-for-submit-delayed-submit
[443.411888] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[443.489441] [108/133] (583s left) kms_cursor_crc (cursor-sliding-256x256)
[443.739942] Starting subtest: cursor-sliding-256x256
[443.745098] Starting dynamic subtest: pipe-A-eDP-1
[446.954838] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.210s)
[446.985359] Starting dynamic subtest: pipe-D-eDP-1
[450.830710] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.854s)
[450.833066] Subtest cursor-sliding-256x256: SUCCESS (7.091s)
[451.691608] [109/133] (575s left) gem_ppgtt (shrink-vs-evict-pinned)
[451.750437] Starting subtest: shrink-vs-evict-pinned
[457.541899] Subtest shrink-vs-evict-pinned: SUCCESS (5.738s)
[457.580312] [110/133] (569s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[457.676922] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[464.490455] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.816s)
[464.641439] [111/133] (562s left) gem_userptr_blits (dmabuf-sync)
[464.707424] Starting subtest: dmabuf-sync
[464.711532] Subtest dmabuf-sync: SKIP (0.002s)
[464.849511] [112/133] (562s left) kms_psr (fbc-pr-primary-mmap-gtt)
[464.945900] Starting subtest: fbc-pr-primary-mmap-gtt
[464.950360] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[465.020782] [113/133] (562s left) gem_mmap_offset (clear-via-pagefault)
[465.071406] Starting subtest: clear-via-pagefault
[465.073512] Starting dynamic subtest: smem0
[498.249186] Dynamic subtest smem0: SUCCESS (33.172s)
[498.251559] Subtest clear-via-pagefault: SUCCESS (33.174s)
[498.350322] [114/133] (528s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[498.427329] Starting subtest: yf-tiled-to-vebox-y-tiled
[498.431925] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[498.611466] [115/133] (528s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[498.715417] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[502.282837] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.571s)
[503.425700] [116/133] (523s left) kms_joiner (invalid-modeset-force-big-joiner)
[503.521352] Starting subtest: invalid-modeset-force-big-joiner
[503.525586] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[503.589128] [117/133] (523s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[503.689170] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[503.693386] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[503.804138] [118/133] (523s left) perf_pmu (busy-accuracy-50)
[503.845529] Starting subtest: busy-accuracy-50
[503.847871] Starting dynamic subtest: rcs0
[505.381120] Dynamic subtest rcs0: SUCCESS (1.533s)
[505.392660] Starting dynamic subtest: bcs0
[506.923220] Dynamic subtest bcs0: SUCCESS (1.540s)
[506.932679] Starting dynamic subtest: vcs0
[508.465945] Dynamic subtest vcs0: SUCCESS (1.540s)
[508.475379] Starting dynamic subtest: vcs1
[510.008650] Dynamic subtest vcs1: SUCCESS (1.540s)
[510.020966] Starting dynamic subtest: vecs0
[511.547352] Dynamic subtest vecs0: SUCCESS (1.537s)
[511.559376] Starting dynamic subtest: ccs0
[513.095260] Dynamic subtest ccs0: SUCCESS (1.545s)
[513.097666] Subtest busy-accuracy-50: SUCCESS (9.250s)
[513.211286] [119/133] (514s left) gem_lmem_swapping (heavy-random)
[513.260357] Subtest heavy-random: SKIP (0.000s)
[513.300135] [120/133] (514s left) i915_pm_rc6_residency (rc6-accuracy)
[513.346502] Starting subtest: rc6-accuracy
[513.348744] Starting dynamic subtest: gt0
[516.572715] Dynamic subtest gt0: SUCCESS (3.169s)
[516.586864] Starting dynamic subtest: gt1
[519.742389] Dynamic subtest gt1: SUCCESS (3.168s)
[519.745110] Subtest rc6-accuracy: SUCCESS (6.342s)
[519.787532] [121/133] (507s left) core_sysfs (read-all-entries)
[519.843220] Starting subtest: read-all-entries
[519.849647] Subtest read-all-entries: SUCCESS (0.009s)
[519.952154] [122/133] (507s left) kms_flip (2x-nonexisting-fb)
[520.060904] Starting subtest: 2x-nonexisting-fb
[520.071138] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[520.165597] [123/133] (507s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[520.228829] Starting subtest: etime-multi-wait-all-available-unsubmitted
[520.336878] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[520.428190] [124/133] (507s left) kms_pm_backlight (basic-brightness)
[520.518347] Starting subtest: basic-brightness
[520.565072] Starting dynamic subtest: eDP-1
[520.876697] Dynamic subtest eDP-1: SUCCESS (0.308s)
[520.879187] Subtest basic-brightness: SUCCESS (0.358s)
[521.749988] [125/133] (505s left) syncobj_wait (multi-wait-for-submit-signaled)
[521.813587] Starting subtest: multi-wait-for-submit-signaled
[521.815562] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[521.927417] [126/133] (505s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[521.985999] Starting subtest: x-tiled-to-vebox-yf-tiled
[521.990220] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[522.184722] [127/133] (505s left) prime_vgem (sync)
[522.250822] Starting subtest: sync
[522.253126] Starting dynamic subtest: rcs0
[522.318057] Dynamic subtest rcs0: SUCCESS (0.067s)
[522.328168] Starting dynamic subtest: bcs0
[522.382295] Dynamic subtest bcs0: SUCCESS (0.063s)
[522.392087] Starting dynamic subtest: vcs0
[522.429598] Dynamic subtest vcs0: SUCCESS (0.046s)
[522.438967] Starting dynamic subtest: vcs1
[522.473954] Dynamic subtest vcs1: SUCCESS (0.043s)
[522.483327] Starting dynamic subtest: vecs0
[522.520838] Dynamic subtest vecs0: SUCCESS (0.046s)
[522.530310] Starting dynamic subtest: ccs0
[522.567662] Dynamic subtest ccs0: SUCCESS (0.046s)
[522.569988] Subtest sync: SUCCESS (0.318s)
[522.704610] [128/133] (505s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[522.898630] Starting subtest: cursor-rapid-movement-64x64
[522.903893] Starting dynamic subtest: pipe-A-eDP-1
[523.438451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.534s)
[523.469799] Starting dynamic subtest: pipe-D-eDP-1
[524.645715] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.185s)
[524.648102] Subtest cursor-rapid-movement-64x64: SUCCESS (1.746s)
[525.494462] [129/133] (502s left) kms_vblank (query-busy)
[525.596044] Starting subtest: query-busy
[525.598175] Starting dynamic subtest: pipe-A-eDP-1
[527.482581] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[527.502691] Starting dynamic subtest: pipe-D-eDP-1
[530.037672] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[530.040038] Subtest query-busy: SUCCESS (4.443s)
[530.841640] [130/133] (497s left) gem_exec_await (wide-all)
[531.065589] Starting subtest: wide-all
[554.528191] Subtest wide-all: SUCCESS (23.459s)
[554.725882] [131/133] (473s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[554.890670] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[554.892868] Starting dynamic subtest: pipe-A-default-mode
[556.017976] Dynamic subtest pipe-A-default-mode: SKIP (1.124s)
[556.021923] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.126s)
[556.169743] [132/133] (471s left) kms_color (ctm-0-75)
[556.276075] Starting subtest: ctm-0-75
[556.278279] Starting dynamic subtest: pipe-A-eDP-1
[561.036761] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.762s)
[561.047651] Starting dynamic subtest: pipe-B-eDP-1
[566.762963] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.723s)
[566.773436] Starting dynamic subtest: pipe-C-eDP-1
[572.047356] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.285s)
[572.062700] Starting dynamic subtest: pipe-D-eDP-1
[577.376329] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.329s)
[577.378721] Subtest ctm-0-75: SUCCESS (21.101s)
[578.200187] [133/133] (449s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[578.309572] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[578.313752] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[578.395872] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: gem_ctx_param
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_fbcon_fbt
results: parsing output: 12/ for test: i915_query
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: kms_pipe_crc_basic
results: parsing output: 20/ for test: kms_plane_multiple
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_atomic
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_busy
results: parsing output: 31/ for test: i915_drm_fdinfo
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: gem_ctx_persistence
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: testdisplay
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: i915_module_load
results: parsing output: 43/ for test: kms_prop_blob
results: parsing output: 44/ for test: kms_hdr
results: parsing output: 45/ for test: sysfs_timeslice_duration
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_unref_active_buffers
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_ctx_param
results: parsing output: 55/ for test: kms_lease
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: gem_madvise
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_ctx_bad_destroy
results: parsing output: 65/ for test: kms_concurrent
results: parsing output: 66/ for test: kms_properties
results: parsing output: 67/ for test: gem_ccs
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: gen9_exec_parse
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: prime_vgem
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_spin_batch
results: parsing output: 75/ for test: gem_userptr_blits
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: gem_create
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: prime_mmap_kms
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_properties
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: kms_draw_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_async
results: parsing output: 101/ for test: kms_chamelium_frames
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_chamelium_audio
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_ppgtt
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_userptr_blits
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_mmap_offset
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_joiner
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: gem_lmem_swapping
results: parsing output: 119/ for test: i915_pm_rc6_residency
results: parsing output: 120/ for test: core_sysfs
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_pm_backlight
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: gem_render_copy
results: parsing output: 126/ for test: prime_vgem
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_exec_await
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: kms_color
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.