[71.393078] Initializing watchdogs
[71.393207]   /dev/watchdog0
[71.415538] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[71.423236] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.426810] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.429799] [001/133] (960s left) core_auth (getclient-master-drop)
[71.493932] Starting subtest: getclient-master-drop
[71.497370] Subtest getclient-master-drop: SUCCESS (0.004s)
[71.622288] [002/133] (960s left) gem_workarounds (reset)
[71.691348] Starting subtest: reset
[71.699640] Subtest reset: SUCCESS (0.008s)
[71.835817] [003/133] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[72.330885] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[72.331988] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[72.935529] [004/133] (959s left) i915_hangman (hangcheck-unterminated)
[72.996023] Starting subtest: hangcheck-unterminated
[72.997217] Subtest hangcheck-unterminated: SKIP (0.000s)
[73.061669] [005/133] (959s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[73.555900] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[73.841131] [006/133] (958s left) gem_exec_whisper (basic-normal-all)
[73.908239] Starting subtest: basic-normal-all
[74.921919] Subtest basic-normal-all: SUCCESS (1.014s)
[75.147422] [007/133] (957s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[75.633713] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[75.943113] [008/133] (956s left) dmabuf (all-tests)
[75.995842] Starting subtest: all-tests
[75.996455] Starting dynamic subtest: sanitycheck
[76.093716] Dynamic subtest sanitycheck: SUCCESS (0.098s)
[76.108142] Starting dynamic subtest: dma_fence
[76.352906] Dynamic subtest dma_fence: SUCCESS (0.258s)
[76.366017] Starting dynamic subtest: dma_fence_chain
[87.175890] Dynamic subtest dma_fence_chain: SUCCESS (10.822s)
[87.189946] Starting dynamic subtest: dma_fence_unwrap
[87.265711] Dynamic subtest dma_fence_unwrap: SUCCESS (0.089s)
[87.278443] Starting dynamic subtest: dma_resv
[87.362735] Dynamic subtest dma_resv: SUCCESS (0.096s)
[87.363925] Subtest all-tests: SUCCESS (11.368s)
[87.473303] [009/133] (944s left) gem_render_copy_redux (interruptible)
[87.533070] Starting subtest: interruptible
[88.060840] Subtest interruptible: SUCCESS (0.527s)
[88.220476] [010/133] (944s left) gem_exec_schedule (pi-shared-iova)
[88.288955] Subtest pi-shared-iova: SKIP (0.000s)
[88.526501] [011/133] (943s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[89.020710] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[89.022942] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[89.617318] [012/133] (942s left) gem_render_copy (y-tiled)
[89.687081] Starting subtest: y-tiled
[89.687788] Starting dynamic subtest: smem
[89.759887] Dynamic subtest smem: SUCCESS (0.072s)
[89.760635] Subtest y-tiled: SUCCESS (0.073s)
[89.990960] [013/133] (942s left) kms_busy (basic)
[90.487232] Starting subtest: basic
[90.487859] Starting dynamic subtest: flip
[91.062338] Dynamic subtest flip: SUCCESS (0.574s)
[91.073577] Starting dynamic subtest: modeset
[91.809828] Dynamic subtest modeset: SUCCESS (0.747s)
[91.810446] Subtest basic: SUCCESS (1.324s)
[92.523644] [014/133] (939s left) kms_psr (psr2-cursor-blt)
[93.021894] Subtest psr2-cursor-blt: SKIP (0.000s)
[93.313195] [015/133] (939s left) kms_flip (2x-plain-flip-fb-recreate)
[93.811652] Starting subtest: 2x-plain-flip-fb-recreate
[93.813347] Starting dynamic subtest: AB-VGA1-HDMI-A1
[124.450984] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.640s)
[124.452219] Subtest 2x-plain-flip-fb-recreate: SUCCESS (30.644s)
[125.268611] [016/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[125.763930] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[125.764967] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[126.365301] [017/133] (906s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[126.861253] Starting subtest: fbcpsr-stridechange
[126.862282] Subtest fbcpsr-stridechange: SKIP (0.000s)
[127.459542] [018/133] (905s left) gem_mmap_gtt (close-race)
[127.516777] Starting subtest: close-race
[147.624062] Subtest close-race: SUCCESS (20.108s)
[147.765711] [019/133] (884s left) perf_pmu (semaphore-wait)
[147.819866] Starting subtest: semaphore-wait
[147.820596] Starting dynamic subtest: rcs0
[147.821827] Dynamic subtest rcs0: SKIP (0.001s)
[147.835260] Starting dynamic subtest: bcs0
[147.837276] Dynamic subtest bcs0: SKIP (0.000s)
[147.851764] Starting dynamic subtest: vcs0
[147.853912] Dynamic subtest vcs0: SKIP (0.000s)
[147.855883] Subtest semaphore-wait: SKIP (0.003s)
[147.967249] [020/133] (884s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[148.463267] Starting subtest: primary-4-tiled-reflect-x-0
[148.465019] Subtest primary-4-tiled-reflect-x-0: SKIP (0.002s)
[149.066063] [021/133] (883s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[149.567245] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[150.102456] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.534s)
[150.780517] [022/133] (882s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[151.285662] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[151.288535] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[151.901704] [023/133] (880s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[152.394916] Starting subtest: plane-upscale-20x20-with-pixel-format
[152.395709] Starting dynamic subtest: pipe-A
[152.397447] Dynamic subtest pipe-A: SKIP (0.001s)
[152.407814] Starting dynamic subtest: pipe-B
[152.409508] Dynamic subtest pipe-B: SKIP (0.001s)
[152.410483] Subtest plane-upscale-20x20-with-pixel-format: SKIP (0.003s)
[152.990263] [024/133] (879s left) kms_color (ctm-negative)
[153.484859] Starting subtest: ctm-negative
[153.485812] Starting dynamic subtest: pipe-A-HDMI-A-1
[153.961034] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.476s)
[153.979097] Starting dynamic subtest: pipe-B-HDMI-A-1
[154.474628] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.513s)
[154.475154] Subtest ctm-negative: SUCCESS (0.990s)
[155.222939] [025/133] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[155.722697] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[155.723654] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[156.316989] [026/133] (876s left) kms_addfb_basic (too-wide)
[156.807842] Starting subtest: too-wide
[156.808500] Subtest too-wide: SUCCESS (0.000s)
[157.397207] [027/133] (875s left) syncobj_basic (bad-flags-fd-to-handle)
[157.448388] Starting subtest: bad-flags-fd-to-handle
[157.448849] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[157.564469] [028/133] (875s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[157.618140] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[157.673681] [029/133] (875s left) kms_big_fb (linear-16bpp-rotate-270)
[158.182133] Starting subtest: linear-16bpp-rotate-270
[158.187021] Subtest linear-16bpp-rotate-270: SKIP (0.005s)
[158.813194] [030/133] (874s left) kms_pm_rpm (legacy-planes-dpms)
[170.606381] Subtest legacy-planes-dpms: SKIP (0.000s)
[170.898754] [031/133] (862s left) syncobj_timeline (multi-wait-all-available-signaled)
[170.957573] Starting subtest: multi-wait-all-available-signaled
[170.958201] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[171.089998] [032/133] (862s left) gem_pxp (create-regular-buffer)
[173.660284] Starting subtest: create-regular-buffer
[173.661599] Subtest create-regular-buffer: SKIP (0.000s)
[173.780985] [033/133] (859s left) gem_userptr_blits (sync-overlap)
[173.852158] Starting subtest: sync-overlap
[173.853570] Subtest sync-overlap: SUCCESS (0.000s)
[174.000056] [034/133] (859s left) kms_cursor_crc (cursor-offscreen-256x85)
[174.502011] Starting subtest: cursor-offscreen-256x85
[174.560771] Subtest cursor-offscreen-256x85: SKIP (0.058s)
[175.166854] [035/133] (858s left) kms_vblank (wait-forked-hang)
[175.656794] Starting subtest: wait-forked-hang
[175.657282] Starting dynamic subtest: pipe-A-HDMI-A-1
[181.954599] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.296s)
[181.969074] Starting dynamic subtest: pipe-B-HDMI-A-1
[187.961245] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.006s)
[187.962932] Subtest wait-forked-hang: SUCCESS (12.307s)
[188.685458] [036/133] (844s left) gem_exec_reloc (basic-wc-active)
[188.741736] Starting subtest: basic-wc-active
[188.851746] Subtest basic-wc-active: SUCCESS (0.110s)
[189.892583] [037/133] (843s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[189.949931] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[190.013282] [038/133] (843s left) kms_flip (2x-dpms-vs-vblank-race)
[190.503264] Starting subtest: 2x-dpms-vs-vblank-race
[190.504818] Starting dynamic subtest: AB-VGA1-HDMI-A1
[201.136579] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.632s)
[201.138788] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.636s)
[201.854791] [039/133] (831s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[202.342716] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[202.406714] [040/133] (831s left) kms_atomic (plane-cursor-legacy)
[202.880640] Starting subtest: plane-cursor-legacy
[202.881350] Starting dynamic subtest: pipe-A-VGA-1
[203.103600] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.221s)
[203.104055] Subtest plane-cursor-legacy: SUCCESS (0.224s)
[203.373735] [041/133] (830s left) gem_partial_pwrite_pread (write-uncached)
[203.434247] Starting subtest: write-uncached
[207.290025] Subtest write-uncached: SUCCESS (3.856s)
[207.448873] [042/133] (826s left) gem_create (create-ext-cpu-access-sanity-check)
[207.628240] Starting subtest: create-ext-cpu-access-sanity-check
[207.631531] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[208.037806] [043/133] (825s left) gem_mmap_gtt (zero-extend)
[208.090100] Starting subtest: zero-extend
[208.090624] Subtest zero-extend: SUCCESS (0.000s)
[208.220936] [044/133] (825s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[208.277951] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[208.332742] [045/133] (825s left) api_intel_allocator (fork-simple-stress)
[208.386658] Starting subtest: fork-simple-stress
[213.815564] Subtest fork-simple-stress: SUCCESS (5.429s)
[213.943410] [046/133] (820s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[214.444256] Starting subtest: y-tiled-64bpp-rotate-180
[214.445421] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[215.030276] [047/133] (818s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[215.096229] Starting subtest: yf-tiled-to-vebox-y-tiled
[215.097435] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[215.323907] [048/133] (818s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[215.811638] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[215.812792] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[216.401919] [049/133] (817s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[218.971322] Starting subtest: protected-encrypted-src-copy-not-readible
[218.972410] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[219.085557] [050/133] (815s left) i915_pm_rps (basic-api)
[219.147898] Starting subtest: basic-api
[219.150564] Subtest basic-api: SUCCESS (0.004s)
[219.266467] [051/133] (814s left) gem_busy (busy)
[219.332737] Starting subtest: busy
[219.333540] Starting dynamic subtest: all-engines
[219.361060] Dynamic subtest all-engines: SUCCESS (0.027s)
[219.374852] Starting dynamic subtest: rcs0
[219.379337] Dynamic subtest rcs0: SUCCESS (0.017s)
[219.394909] Starting dynamic subtest: bcs0
[219.395697] Dynamic subtest bcs0: SUCCESS (0.013s)
[219.406790] Starting dynamic subtest: vcs0
[219.408863] Dynamic subtest vcs0: SUCCESS (0.012s)
[219.409536] Subtest busy: SUCCESS (0.077s)
[219.798292] [052/133] (814s left) kms_dp_link_training (non-uhbr-sst)
[220.282927] Starting subtest: non-uhbr-sst
[220.285139] Subtest non-uhbr-sst: SKIP (0.000s)
[220.644662] [053/133] (813s left) gem_unfence_active_buffers
[220.877596] [054/133] (813s left) kms_dsc (dsc-with-formats)
[221.365904] Subtest dsc-with-formats: SKIP (0.000s)
[221.655169] [055/133] (812s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[222.144426] Starting subtest: plane-downscale-factor-0-75-with-rotation
[222.145218] Starting dynamic subtest: pipe-A
[222.146896] Dynamic subtest pipe-A: SKIP (0.001s)
[222.159166] Starting dynamic subtest: pipe-B
[222.160746] Dynamic subtest pipe-B: SKIP (0.001s)
[222.162507] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (0.005s)
[222.726166] [056/133] (811s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[223.211626] Starting subtest: cursor-vs-flip-toggle
[257.293713] Subtest cursor-vs-flip-toggle: SUCCESS (34.082s)
[257.999999] [057/133] (776s left) kms_psr (fbc-psr-cursor-blt)
[258.480381] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[258.774987] [058/133] (775s left) gem_ctx_exec (basic)
[258.830233] Starting subtest: basic
[258.831807] Subtest basic: SUCCESS (0.002s)
[258.995830] [059/133] (775s left) gem_sync (basic-store-all)
[259.060843] Starting subtest: basic-store-all
[261.302034] Subtest basic-store-all: SUCCESS (2.241s)
[261.524769] [060/133] (773s left) kms_flip (2x-blocking-wf_vblank)
[262.006522] Starting subtest: 2x-blocking-wf_vblank
[262.008086] Starting dynamic subtest: AB-VGA1-HDMI-A1
[292.717328] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.709s)
[292.719852] Subtest 2x-blocking-wf_vblank: SUCCESS (30.713s)
[293.515712] [061/133] (741s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[293.568665] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[293.631206] [062/133] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[294.115565] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[294.116526] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[294.713397] [063/133] (740s left) gem_ctx_persistence (idempotent)
[294.773919] Subtest idempotent: SKIP (0.000s)
[294.831288] [064/133] (739s left) gem_flink_basic (basic)
[294.887453] Starting subtest: basic
[294.888497] Subtest basic: SUCCESS (0.000s)
[295.030638] [065/133] (739s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[295.514773] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[295.515892] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[296.117619] [066/133] (738s left) kms_cursor_crc (cursor-random-512x512)
[296.608880] Starting subtest: cursor-random-512x512
[296.610865] Subtest cursor-random-512x512: SKIP (0.001s)
[297.209803] [067/133] (737s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[297.764873] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[298.169316] [068/133] (736s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[298.656320] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[298.657259] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[299.256345] [069/133] (735s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[299.748736] Starting subtest: psr-rgb565-draw-render
[299.749792] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[300.345835] [070/133] (734s left) perf (unprivileged-single-ctx-counters)
[300.459495] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[300.507894] [071/133] (734s left) kms_cursor_edge_walk (128x128-top-edge)
[300.993070] Starting subtest: 128x128-top-edge
[300.994405] Starting dynamic subtest: pipe-A-HDMI-A-1
[304.413020] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.418s)
[304.425901] Starting dynamic subtest: pipe-B-HDMI-A-1
[307.744329] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.329s)
[307.744920] Subtest 128x128-top-edge: SUCCESS (6.752s)
[308.450924] [072/133] (726s left) i915_drm_fdinfo (memory-info-resident)
[308.510776] Subtest memory-info-resident: SKIP (0.000s)
[308.560686] [073/133] (726s left) kms_pm_rpm (dpms-lpsp)
[320.341879] Subtest dpms-lpsp: SKIP (0.000s)
[320.640567] [074/133] (714s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[321.127820] Starting subtest: cursorA-vs-flipA-legacy
[332.026260] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.898s)
[332.718841] [075/133] (702s left) gen9_exec_parse (allowed-single)
[332.777319] Subtest allowed-single: SKIP (0.000s)
[332.829624] [076/133] (702s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[332.884108] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.000s)
[332.945677] [077/133] (702s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[333.441214] Starting subtest: 4-tiled-32bpp-rotate-180
[333.443722] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[334.038392] [078/133] (701s left) kms_lease (simple-lease)
[334.522608] Starting subtest: simple-lease
[334.523632] Starting dynamic subtest: pipe-A-HDMI-A-1
[334.803121] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.278s)
[334.815211] Starting dynamic subtest: pipe-B-HDMI-A-1
[335.118044] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.312s)
[335.120478] Subtest simple-lease: SUCCESS (0.597s)
[335.810119] [079/133] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[336.297231] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[336.298332] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[336.907367] [080/133] (698s left) gem_userptr_blits (create-destroy-sync)
[336.977175] Starting subtest: create-destroy-sync
[342.004968] Subtest create-destroy-sync: SUCCESS (5.028s)
[342.163220] [081/133] (693s left) gem_exec_whisper (basic-queues-priority)
[342.230442] Starting subtest: basic-queues-priority
[342.231851] Subtest basic-queues-priority: SKIP (0.001s)
[342.461279] [082/133] (693s left) gem_exec_fence (expired-history)
[342.692922] Starting subtest: expired-history
[342.751301] Subtest expired-history: SUCCESS (0.058s)
[343.102238] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[343.105236] [083/133] (692s left) gem_exec_gttfill (all-engines)
[343.169120] Starting subtest: all-engines
[367.492132] Subtest all-engines: SUCCESS (24.323s)
[367.735020] [084/133] (667s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[368.288383] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[368.290446] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[368.901832] [085/133] (666s left) syncobj_timeline (reset-during-wait-for-submit)
[368.963683] Starting subtest: reset-during-wait-for-submit
[369.066198] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[369.203755] [086/133] (666s left) kms_vblank (query-forked)
[369.689756] Starting subtest: query-forked
[369.690271] Starting dynamic subtest: pipe-A-HDMI-A-1
[371.974310] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.283s)
[371.987370] Starting dynamic subtest: pipe-B-HDMI-A-1
[374.286189] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.310s)
[374.286690] Subtest query-forked: SUCCESS (4.597s)
[375.001183] [087/133] (660s left) i915_selftest (mock)
[375.916449] Starting subtest: mock
[375.916937] Starting dynamic subtest: sanitycheck
[377.121605] Dynamic subtest sanitycheck: SUCCESS (1.204s)
[377.134139] Starting dynamic subtest: shmem
[378.257541] Dynamic subtest shmem: SUCCESS (1.134s)
[378.274528] Starting dynamic subtest: fence
[386.111525] Dynamic subtest fence: SUCCESS (7.851s)
[386.123693] Starting dynamic subtest: scatterlist
[388.222562] Dynamic subtest scatterlist: SUCCESS (2.109s)
[388.235218] Starting dynamic subtest: syncmap
[391.396728] Dynamic subtest syncmap: SUCCESS (3.172s)
[391.409783] Starting dynamic subtest: uncore
[392.507688] Dynamic subtest uncore: SUCCESS (1.109s)
[392.519929] Starting dynamic subtest: ring
[393.655708] Dynamic subtest ring: SUCCESS (1.146s)
[393.667925] Starting dynamic subtest: engine
[394.805626] Dynamic subtest engine: SUCCESS (1.148s)
[394.818676] Starting dynamic subtest: timelines
[401.043576] Dynamic subtest timelines: SUCCESS (6.236s)
[401.055706] Starting dynamic subtest: requests
[404.461581] Dynamic subtest requests: SUCCESS (3.416s)
[404.473855] Starting dynamic subtest: objects
[405.725589] Dynamic subtest objects: SUCCESS (1.262s)
[405.742310] Starting dynamic subtest: phys
[407.025647] Dynamic subtest phys: SUCCESS (1.297s)
[407.037947] Starting dynamic subtest: dmabuf
[408.275632] Dynamic subtest dmabuf: SUCCESS (1.248s)
[408.287959] Starting dynamic subtest: vma
[419.873609] Dynamic subtest vma: SUCCESS (11.596s)
[419.885906] Starting dynamic subtest: evict
[422.428485] Dynamic subtest evict: SUCCESS (2.553s)
[422.441845] Starting dynamic subtest: gtt
[426.725617] Dynamic subtest gtt: SUCCESS (4.295s)
[426.738469] Starting dynamic subtest: hugepages
[428.258516] Dynamic subtest hugepages: SUCCESS (1.531s)
[428.270955] Starting dynamic subtest: memory_region
[433.148535] Dynamic subtest memory_region: SUCCESS (4.888s)
[433.151218] Subtest mock: SUCCESS (57.234s)
[433.193214] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[433.194521] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[433.196898] [088/133] (602s left) perf_pmu (busy-check-all)
[435.301115] Starting subtest: busy-check-all
[435.301772] Starting dynamic subtest: rcs0
[435.831265] Dynamic subtest rcs0: SUCCESS (0.531s)
[435.844761] Starting dynamic subtest: bcs0
[436.360254] Dynamic subtest bcs0: SUCCESS (0.526s)
[436.373929] Starting dynamic subtest: vcs0
[437.386267] Dynamic subtest vcs0: SUCCESS (1.023s)
[437.389422] Subtest busy-check-all: SUCCESS (2.089s)
[437.445965] [FACT perf_pmu (busy-check-all)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[437.447598] [FACT perf_pmu (busy-check-all)] new: kernel.kmod_is_loaded.i915: true
[437.451108] [089/133] (598s left) gem_exec_params (no-blt)
[437.509493] Starting subtest: no-blt
[437.510113] Subtest no-blt: SUCCESS (0.000s)
[437.652796] [090/133] (598s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[438.145470] Starting subtest: basic-max-pipe-crc-check
[438.147632] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[438.440951] [091/133] (597s left) perf (gen8-unprivileged-single-ctx-counters)
[438.627160] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[438.677550] [092/133] (597s left) kms_rotation_crc (cursor-rotation-180)
[439.159594] Starting subtest: cursor-rotation-180
[439.958275] Subtest cursor-rotation-180: SUCCESS (0.799s)
[440.761586] [093/133] (595s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[441.253012] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[441.254306] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[441.867039] [094/133] (594s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[442.354206] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[442.355376] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[442.973674] [095/133] (593s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[443.033505] Starting subtest: framebuffer-vs-set-tiling
[443.034095] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[444.068700] [096/133] (592s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[444.382698] Starting subtest: syncobj-timeline-multiple-ext-nodes
[444.385226] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.002s)
[444.652136] [097/133] (591s left) kms_flip (2x-nonexisting-fb-interruptible)
[445.146594] Starting subtest: 2x-nonexisting-fb-interruptible
[445.148675] Starting dynamic subtest: AB-VGA1-HDMI-A1
[445.522226] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (0.372s)
[445.524093] Subtest 2x-nonexisting-fb-interruptible: SUCCESS (0.377s)
[446.339341] [098/133] (590s left) kms_psr (psr2-sprite-plane-move)
[446.823847] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[447.115303] [099/133] (589s left) kms_psr (fbc-psr2-cursor-plane-move)
[447.602774] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[447.895850] [100/133] (588s left) kms_rotation_crc (bad-pixel-format)
[448.382180] Starting subtest: bad-pixel-format
[448.383346] Subtest bad-pixel-format: SKIP (0.001s)
[448.989829] [101/133] (587s left) kms_invalid_mode (bad-vsync-end)
[449.477887] Starting subtest: bad-vsync-end
[449.480226] Starting dynamic subtest: pipe-A-HDMI-A-1
[449.550798] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.072s)
[449.564558] Starting dynamic subtest: pipe-B-HDMI-A-1
[449.565189] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[449.565824] Subtest bad-vsync-end: SUCCESS (0.076s)
[450.029454] [102/133] (586s left) gem_exec_schedule (preempt-user)
[450.101441] Subtest preempt-user: SKIP (0.000s)
[450.329496] [103/133] (586s left) syncobj_wait (wait-zero-handles)
[450.385160] Starting subtest: wait-zero-handles
[450.385809] Subtest wait-zero-handles: SUCCESS (0.000s)
[450.515763] [104/133] (586s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[451.001870] Starting subtest: basic-flip-before-cursor-varying-size
[451.974695] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.973s)
[452.696739] [105/133] (584s left) gem_softpin (softpin)
[452.754879] Starting subtest: softpin
[484.968166] Subtest softpin: SUCCESS (32.213s)
[485.128199] [106/133] (551s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[485.612482] Starting subtest: 2x-cursor-vs-flip-legacy
[485.613792] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[486.203994] [107/133] (550s left) kms_getfb (getfb-reject-nv12)
[486.692558] Starting subtest: getfb-reject-nv12
[486.693861] Subtest getfb-reject-nv12: SKIP (0.000s)
[487.305278] [108/133] (549s left) gem_ctx_persistence (engines-persistence)
[487.361994] Subtest engines-persistence: SKIP (0.000s)
[487.414556] [109/133] (549s left) gem_tiled_blits (basic)
[487.621866] Starting subtest: basic
[487.645781] Subtest basic: SUCCESS (0.024s)
[487.831303] [110/133] (549s left) kms_chamelium_color (ctm-green-to-red)
[488.412402] Subtest ctm-green-to-red: SKIP (0.000s)
[488.713956] [111/133] (548s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[488.771358] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[488.830836] [112/133] (548s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[488.894676] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[488.998587] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[489.134369] [113/133] (548s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[489.189291] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[489.294557] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[489.417616] [114/133] (547s left) gem_ctx_shared (disjoint-timelines)
[489.472618] Subtest disjoint-timelines: SKIP (0.000s)
[489.600727] [115/133] (547s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[489.656798] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[489.711674] [116/133] (547s left) kms_properties (get_properties-sanity-atomic)
[490.197737] Starting subtest: get_properties-sanity-atomic
[490.198465] Subtest get_properties-sanity-atomic: SUCCESS (0.001s)
[490.797498] [117/133] (546s left) kms_addfb_basic (basic-x-tiled-legacy)
[490.851875] Starting subtest: basic-x-tiled-legacy
[490.852453] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[491.882036] [118/133] (545s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[492.376598] Starting subtest: yf-tiled-64bpp-rotate-180
[492.377826] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.001s)
[492.982801] [119/133] (544s left) kms_content_protection (lic-type-0-hdcp14)
[493.501580] Starting subtest: lic-type-0-hdcp14
[493.502892] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[494.109634] [120/133] (543s left) perf_pmu (all-busy-check-all)
[494.167413] Starting subtest: all-busy-check-all
[494.687460] Subtest all-busy-check-all: SUCCESS (0.520s)
[494.821308] [121/133] (542s left) syncobj_timeline (single-wait-all-available-submitted)
[494.876463] Starting subtest: single-wait-all-available-submitted
[494.877083] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[495.021827] [122/133] (542s left) prime_vgem (basic-write)
[495.099381] Starting subtest: basic-write
[495.117656] Subtest basic-write: SUCCESS (0.020s)
[495.255519] [123/133] (542s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[495.748705] Starting subtest: x-tiled-16bpp-rotate-90
[495.757911] Subtest x-tiled-16bpp-rotate-90: SKIP (0.007s)
[496.368714] [124/133] (541s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[496.855419] Starting subtest: 2x-cursor-vs-flip-atomic
[496.856922] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[497.467278] [125/133] (540s left) gem_tiled_pread_basic (basic)
[497.522155] Starting subtest: basic
[497.744557] Subtest basic: SUCCESS (0.222s)
[497.867637] [126/133] (539s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[498.358678] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[498.359663] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[498.967479] [127/133] (538s left) gem_spin_batch (resubmit-all)
[499.029784] Starting subtest: resubmit-all
[499.030396] Starting dynamic subtest: rcs0
[499.032534] Dynamic subtest rcs0: SUCCESS (0.002s)
[499.046597] Starting dynamic subtest: bcs0
[499.047383] Dynamic subtest bcs0: SUCCESS (0.001s)
[499.060540] Starting dynamic subtest: vcs0
[499.061321] Dynamic subtest vcs0: SUCCESS (0.001s)
[499.061957] Subtest resubmit-all: SUCCESS (0.009s)
[499.295670] [128/133] (538s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[499.784012] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[499.785214] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[500.394912] [129/133] (537s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[500.881844] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[502.791856] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.910s)
[503.441233] [130/133] (534s left) gem_mmap_wc (write-read)
[503.500446] Starting subtest: write-read
[503.515996] Subtest write-read: SUCCESS (0.016s)
[503.656388] [131/133] (534s left) perf_pmu (busy-start)
[503.710888] Starting subtest: busy-start
[503.711568] Starting dynamic subtest: rcs0
[506.227448] Dynamic subtest rcs0: SUCCESS (2.515s)
[506.242538] Starting dynamic subtest: bcs0
[508.751439] Dynamic subtest bcs0: SUCCESS (2.520s)
[508.772214] Starting dynamic subtest: vcs0
[511.777413] Dynamic subtest vcs0: SUCCESS (3.022s)
[511.780855] Subtest busy-start: SUCCESS (8.067s)
[511.906396] [132/133] (526s left) gem_exec_balancer (bonded-false-hang)
[511.968266] Subtest bonded-false-hang: SKIP (0.000s)
[512.087477] [133/133] (526s left) kms_chamelium_frames (hdmi-crc-multiple)
[512.659167] Subtest hdmi-crc-multiple: SKIP (0.000s)
[513.080951] Closing watchdogs
results: parsing output: 0/ for test: core_auth
results: parsing output: 1/ for test: gem_workarounds
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: i915_hangman
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: dmabuf
results: parsing output: 8/ for test: gem_render_copy_redux
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_busy
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: syncobj_basic
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_pm_rpm
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_atomic
results: parsing output: 40/ for test: gem_partial_pwrite_pread
results: parsing output: 41/ for test: gem_create
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: i915_pm_rps
results: parsing output: 50/ for test: gem_busy
results: parsing output: 51/ for test: kms_dp_link_training
results: parsing output: 52/ for test: gem_unfence_active_buffers
results: parsing output: 53/ for test: kms_dsc
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_ctx_exec
results: parsing output: 58/ for test: gem_sync
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: gem_flink_basic
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: perf
results: parsing output: 70/ for test: kms_cursor_edge_walk
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gen9_exec_parse
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: gem_exec_gttfill
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: i915_selftest
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: kms_multipipe_modeset
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: kms_invalid_mode
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: gem_softpin
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: gem_tiled_blits
results: parsing output: 109/ for test: kms_chamelium_color
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_ctx_shared
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: kms_properties
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_content_protection
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gem_tiled_pread_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_spin_batch
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_chamelium_frames
Done.