[74.868188] Initializing watchdogs
[74.868341]   /dev/watchdog0
[74.894105] [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)
[74.901871] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[74.905767] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[74.909843] [001/133] (960s left) core_auth (getclient-master-drop)
[74.993326] Starting subtest: getclient-master-drop
[74.996292] Subtest getclient-master-drop: SUCCESS (0.003s)
[75.109511] [002/133] (960s left) gem_workarounds (reset)
[75.177874] Starting subtest: reset
[75.188645] Subtest reset: SUCCESS (0.011s)
[75.297869] [003/133] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[75.796429] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[75.797830] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[76.402885] [004/133] (959s left) i915_hangman (hangcheck-unterminated)
[76.466842] Starting subtest: hangcheck-unterminated
[76.468452] Subtest hangcheck-unterminated: SKIP (0.000s)
[76.541448] [005/133] (959s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[77.031123] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[77.335273] [006/133] (958s left) gem_exec_whisper (basic-normal-all)
[77.404667] Starting subtest: basic-normal-all
[78.393916] Subtest basic-normal-all: SUCCESS (0.987s)
[78.633311] [007/133] (957s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[79.125377] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[79.406275] [008/133] (956s left) dmabuf (all-tests)
[79.463124] Starting subtest: all-tests
[79.463873] Starting dynamic subtest: sanitycheck
[79.546335] Dynamic subtest sanitycheck: SUCCESS (0.085s)
[79.563122] Starting dynamic subtest: dma_fence
[79.775594] Dynamic subtest dma_fence: SUCCESS (0.228s)
[79.787798] Starting dynamic subtest: dma_fence_chain
[90.664368] Dynamic subtest dma_fence_chain: SUCCESS (10.881s)
[90.676417] Starting dynamic subtest: dma_fence_unwrap
[90.750821] Dynamic subtest dma_fence_unwrap: SUCCESS (0.088s)
[90.767211] Starting dynamic subtest: dma_resv
[90.830788] Dynamic subtest dma_resv: SUCCESS (0.079s)
[90.832080] Subtest all-tests: SUCCESS (11.366s)
[90.927362] [009/133] (944s left) gem_render_copy_redux (interruptible)
[90.993468] Starting subtest: interruptible
[91.565435] Subtest interruptible: SUCCESS (0.570s)
[91.730158] [010/133] (944s left) gem_exec_schedule (pi-shared-iova)
[91.798794] Subtest pi-shared-iova: SKIP (0.000s)
[92.027771] [011/133] (943s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[92.524247] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[92.525981] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[93.126533] [012/133] (942s left) gem_render_copy (y-tiled)
[93.189288] Starting subtest: y-tiled
[93.190126] Starting dynamic subtest: smem
[93.265740] Dynamic subtest smem: SUCCESS (0.075s)
[93.266685] Subtest y-tiled: SUCCESS (0.076s)
[93.492708] [013/133] (942s left) kms_busy (basic)
[93.999085] Starting subtest: basic
[93.999933] Starting dynamic subtest: flip
[94.617714] Dynamic subtest flip: SUCCESS (0.618s)
[94.627856] Starting dynamic subtest: modeset
[95.388166] Dynamic subtest modeset: SUCCESS (0.770s)
[95.388953] Subtest basic: SUCCESS (1.390s)
[96.117850] [014/133] (939s left) kms_psr (psr2-cursor-blt)
[96.625313] Subtest psr2-cursor-blt: SKIP (0.000s)
[96.943072] [015/133] (939s left) kms_flip (2x-plain-flip-fb-recreate)
[97.441806] Starting subtest: 2x-plain-flip-fb-recreate
[97.442817] Starting dynamic subtest: AB-VGA1-HDMI-A1
[128.083381] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.636s)
[128.085813] Subtest 2x-plain-flip-fb-recreate: SUCCESS (30.640s)
[128.877272] [016/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[129.379914] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[129.382769] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[129.972135] [017/133] (906s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[130.473427] Starting subtest: fbcpsr-stridechange
[130.476230] Subtest fbcpsr-stridechange: SKIP (0.000s)
[131.070083] [018/133] (905s left) gem_mmap_gtt (close-race)
[131.126986] Starting subtest: close-race
[151.253295] Subtest close-race: SUCCESS (20.125s)
[151.383797] [019/133] (884s left) perf_pmu (semaphore-wait)
[151.448851] Starting subtest: semaphore-wait
[151.449667] Starting dynamic subtest: rcs0
[151.451147] Dynamic subtest rcs0: SKIP (0.001s)
[151.463454] Starting dynamic subtest: bcs0
[151.465998] Dynamic subtest bcs0: SKIP (0.000s)
[151.481215] Starting dynamic subtest: vcs0
[151.483362] Dynamic subtest vcs0: SKIP (0.000s)
[151.485293] Subtest semaphore-wait: SKIP (0.003s)
[151.602850] [020/133] (884s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[152.092030] Starting subtest: primary-4-tiled-reflect-x-0
[152.095235] Subtest primary-4-tiled-reflect-x-0: SKIP (0.001s)
[152.714042] [021/133] (883s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[153.218194] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[153.768037] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.549s)
[154.461957] [022/133] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[154.969473] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[154.971008] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[155.576294] [023/133] (880s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[156.070295] Starting subtest: plane-upscale-20x20-with-pixel-format
[156.071254] Starting dynamic subtest: pipe-A
[156.073298] Dynamic subtest pipe-A: SKIP (0.001s)
[156.085314] Starting dynamic subtest: pipe-B
[156.087295] Dynamic subtest pipe-B: SKIP (0.001s)
[156.088503] Subtest plane-upscale-20x20-with-pixel-format: SKIP (0.003s)
[156.673860] [024/133] (879s left) kms_color (ctm-negative)
[157.170632] Starting subtest: ctm-negative
[157.171482] Starting dynamic subtest: pipe-A-HDMI-A-1
[157.643731] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.474s)
[157.654239] Starting dynamic subtest: pipe-B-HDMI-A-1
[158.140300] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.496s)
[158.140982] Subtest ctm-negative: SUCCESS (0.971s)
[158.817438] [025/133] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[159.320694] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[159.321985] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[159.915184] [026/133] (876s left) kms_addfb_basic (too-wide)
[160.411475] Starting subtest: too-wide
[160.412257] Subtest too-wide: SUCCESS (0.000s)
[160.996365] [027/133] (875s left) syncobj_basic (bad-flags-fd-to-handle)
[161.054774] Starting subtest: bad-flags-fd-to-handle
[161.055510] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[161.178907] [028/133] (875s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[161.232706] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[161.290449] [029/133] (875s left) kms_big_fb (linear-16bpp-rotate-270)
[161.794406] Starting subtest: linear-16bpp-rotate-270
[161.801842] Subtest linear-16bpp-rotate-270: SKIP (0.006s)
[162.427623] [030/133] (874s left) kms_pm_rpm (legacy-planes-dpms)
[174.227681] Subtest legacy-planes-dpms: SKIP (0.000s)
[174.529386] [031/133] (862s left) syncobj_timeline (multi-wait-all-available-signaled)
[174.589051] Starting subtest: multi-wait-all-available-signaled
[174.590825] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[174.723424] [032/133] (862s left) gem_pxp (create-regular-buffer)
[177.289956] Starting subtest: create-regular-buffer
[177.291599] Subtest create-regular-buffer: SKIP (0.000s)
[177.417214] [033/133] (859s left) gem_userptr_blits (sync-overlap)
[177.486993] Starting subtest: sync-overlap
[177.487850] Subtest sync-overlap: SUCCESS (0.000s)
[177.651616] [034/133] (859s left) kms_cursor_crc (cursor-offscreen-256x85)
[178.156700] Starting subtest: cursor-offscreen-256x85
[178.216705] Subtest cursor-offscreen-256x85: SKIP (0.058s)
[178.811906] [035/133] (858s left) kms_vblank (wait-forked-hang)
[179.305617] Starting subtest: wait-forked-hang
[179.306682] Starting dynamic subtest: pipe-A-HDMI-A-1
[185.917556] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.610s)
[185.928098] Starting dynamic subtest: pipe-B-HDMI-A-1
[191.935926] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.018s)
[191.938665] Subtest wait-forked-hang: SUCCESS (12.633s)
[192.648339] [036/133] (844s left) gem_exec_reloc (basic-wc-active)
[192.713526] Starting subtest: basic-wc-active
[192.823676] Subtest basic-wc-active: SUCCESS (0.109s)
[193.865382] [037/133] (843s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[193.924589] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[193.978921] [038/133] (843s left) kms_flip (2x-dpms-vs-vblank-race)
[194.468928] Starting subtest: 2x-dpms-vs-vblank-race
[194.470893] Starting dynamic subtest: AB-VGA1-HDMI-A1
[205.121731] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.648s)
[205.124838] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.652s)
[205.824511] [039/133] (831s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[206.331061] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[206.390561] [040/133] (830s left) kms_atomic (plane-cursor-legacy)
[206.865332] Starting subtest: plane-cursor-legacy
[206.866256] Starting dynamic subtest: pipe-A-VGA-1
[207.070934] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.204s)
[207.071777] Subtest plane-cursor-legacy: SUCCESS (0.207s)
[207.363427] [041/133] (829s left) gem_partial_pwrite_pread (write-uncached)
[207.422394] Starting subtest: write-uncached
[211.272747] Subtest write-uncached: SUCCESS (3.850s)
[211.423045] [042/133] (825s left) gem_create (create-ext-cpu-access-sanity-check)
[211.608731] Starting subtest: create-ext-cpu-access-sanity-check
[211.611010] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[211.993784] [043/133] (825s left) gem_mmap_gtt (zero-extend)
[212.048438] Starting subtest: zero-extend
[212.049074] Subtest zero-extend: SUCCESS (0.000s)
[212.192779] [044/133] (825s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[212.246228] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[212.303398] [045/133] (825s left) api_intel_allocator (fork-simple-stress)
[212.361247] Starting subtest: fork-simple-stress
[217.791821] Subtest fork-simple-stress: SUCCESS (5.428s)
[217.913582] [046/133] (819s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[218.404403] Starting subtest: y-tiled-64bpp-rotate-180
[218.406015] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[218.996071] [047/133] (818s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[219.067526] Starting subtest: yf-tiled-to-vebox-y-tiled
[219.069735] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[219.302175] [048/133] (818s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[219.794461] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[219.796047] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[220.374470] [049/133] (817s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[222.944126] Starting subtest: protected-encrypted-src-copy-not-readible
[222.945583] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[223.073696] [050/133] (814s left) i915_pm_rps (basic-api)
[223.138684] Starting subtest: basic-api
[223.141941] Subtest basic-api: SUCCESS (0.003s)
[223.271621] [051/133] (814s left) gem_busy (busy)
[223.336905] Starting subtest: busy
[223.337699] Starting dynamic subtest: all-engines
[223.363529] Dynamic subtest all-engines: SUCCESS (0.026s)
[223.379061] Starting dynamic subtest: rcs0
[223.381505] Dynamic subtest rcs0: SUCCESS (0.016s)
[223.396689] Starting dynamic subtest: bcs0
[223.399749] Dynamic subtest bcs0: SUCCESS (0.016s)
[223.415841] Starting dynamic subtest: vcs0
[223.416806] Dynamic subtest vcs0: SUCCESS (0.013s)
[223.417692] Subtest busy: SUCCESS (0.078s)
[223.770556] [052/133] (814s left) kms_dp_link_training (non-uhbr-sst)
[224.259891] Starting subtest: non-uhbr-sst
[224.262857] Subtest non-uhbr-sst: SKIP (0.000s)
[224.851419] [053/133] (812s left) gem_unfence_active_buffers
[225.088511] [054/133] (812s left) kms_dsc (dsc-with-formats)
[225.574802] Subtest dsc-with-formats: SKIP (0.000s)
[225.875668] [055/133] (812s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[226.365979] Starting subtest: plane-downscale-factor-0-75-with-rotation
[226.366821] Starting dynamic subtest: pipe-A
[226.368959] Dynamic subtest pipe-A: SKIP (0.001s)
[226.380499] Starting dynamic subtest: pipe-B
[226.382682] Dynamic subtest pipe-B: SKIP (0.001s)
[226.384176] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (0.005s)
[226.963701] [056/133] (810s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[227.453715] Starting subtest: cursor-vs-flip-toggle
[261.581382] Subtest cursor-vs-flip-toggle: SUCCESS (34.126s)
[262.289617] [057/133] (775s left) kms_psr (fbc-psr-cursor-blt)
[262.789446] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[263.084626] [058/133] (774s left) gem_ctx_exec (basic)
[263.147441] Starting subtest: basic
[263.148174] Subtest basic: SUCCESS (0.001s)
[263.285503] [059/133] (774s left) gem_sync (basic-store-all)
[263.352091] Starting subtest: basic-store-all
[265.630621] Subtest basic-store-all: SUCCESS (2.278s)
[265.869398] [060/133] (772s left) kms_flip (2x-blocking-wf_vblank)
[266.351019] Starting subtest: 2x-blocking-wf_vblank
[266.353171] Starting dynamic subtest: AB-VGA1-HDMI-A1
[297.074412] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.722s)
[297.078708] Subtest 2x-blocking-wf_vblank: SUCCESS (30.728s)
[297.899508] [061/133] (740s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[297.958568] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[298.019164] [062/133] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[298.513445] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[298.514866] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[299.108598] [063/133] (739s left) gem_ctx_persistence (idempotent)
[299.169076] Subtest idempotent: SKIP (0.000s)
[299.216483] [064/133] (739s left) gem_flink_basic (basic)
[299.274781] Starting subtest: basic
[299.275587] Subtest basic: SUCCESS (0.000s)
[299.377121] [065/133] (739s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[299.884838] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[299.886970] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[300.488740] [066/133] (737s left) kms_cursor_crc (cursor-random-512x512)
[300.990524] Starting subtest: cursor-random-512x512
[300.993885] Subtest cursor-random-512x512: SKIP (0.001s)
[301.585785] [067/133] (736s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[302.139526] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[302.543180] [068/133] (735s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[303.035879] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[303.037279] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[303.628254] [069/133] (734s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[304.124586] Starting subtest: psr-rgb565-draw-render
[304.125846] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[304.726869] [070/133] (733s left) perf (unprivileged-single-ctx-counters)
[304.851752] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[304.901823] [071/133] (733s left) kms_cursor_edge_walk (128x128-top-edge)
[305.391065] Starting subtest: 128x128-top-edge
[305.393457] Starting dynamic subtest: pipe-A-HDMI-A-1
[308.819806] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.427s)
[308.832611] Starting dynamic subtest: pipe-B-HDMI-A-1
[312.152149] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.330s)
[312.152958] Subtest 128x128-top-edge: SUCCESS (6.762s)
[312.839981] [072/133] (725s left) i915_drm_fdinfo (memory-info-resident)
[312.912750] Subtest memory-info-resident: SKIP (0.000s)
[312.968924] [073/133] (725s left) kms_pm_rpm (dpms-lpsp)
[324.750018] Subtest dpms-lpsp: SKIP (0.000s)
[325.048900] [074/133] (713s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[325.546572] Starting subtest: cursorA-vs-flipA-legacy
[336.465024] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.918s)
[337.199603] [075/133] (701s left) gen9_exec_parse (allowed-single)
[337.267834] Subtest allowed-single: SKIP (0.000s)
[337.363820] [076/133] (701s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[337.419865] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.000s)
[337.482824] [077/133] (701s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[337.978872] Starting subtest: 4-tiled-32bpp-rotate-180
[337.981526] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[338.580169] [078/133] (700s left) kms_lease (simple-lease)
[339.067875] Starting subtest: simple-lease
[339.070372] Starting dynamic subtest: pipe-A-HDMI-A-1
[339.367831] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.296s)
[339.380582] Starting dynamic subtest: pipe-B-HDMI-A-1
[339.683936] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.313s)
[339.684798] Subtest simple-lease: SUCCESS (0.616s)
[340.392184] [079/133] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[340.885856] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[340.886967] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[341.488737] [080/133] (697s left) gem_userptr_blits (create-destroy-sync)
[341.566633] Starting subtest: create-destroy-sync
[346.602119] Subtest create-destroy-sync: SUCCESS (5.037s)
[346.731589] [081/133] (692s left) gem_exec_whisper (basic-queues-priority)
[346.798454] Starting subtest: basic-queues-priority
[346.802230] Subtest basic-queues-priority: SKIP (0.001s)
[347.028279] [082/133] (692s left) gem_exec_fence (expired-history)
[347.257510] Starting subtest: expired-history
[347.346279] Subtest expired-history: SUCCESS (0.089s)
[347.697471] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[347.701402] [083/133] (691s left) gem_exec_gttfill (all-engines)
[347.768094] Starting subtest: all-engines
[372.019804] Subtest all-engines: SUCCESS (24.251s)
[372.248444] [084/133] (667s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[372.818217] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[372.819649] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[373.429430] [085/133] (665s left) syncobj_timeline (reset-during-wait-for-submit)
[373.504045] Starting subtest: reset-during-wait-for-submit
[373.607215] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[373.733736] [086/133] (665s left) kms_vblank (query-forked)
[374.221887] Starting subtest: query-forked
[374.222840] Starting dynamic subtest: pipe-A-HDMI-A-1
[376.507016] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.284s)
[376.520826] Starting dynamic subtest: pipe-B-HDMI-A-1
[378.816574] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.306s)
[378.817411] Subtest query-forked: SUCCESS (4.595s)
[379.538882] [087/133] (659s left) i915_selftest (mock)
[380.473613] Starting subtest: mock
[380.474387] Starting dynamic subtest: sanitycheck
[381.757140] Dynamic subtest sanitycheck: SUCCESS (1.282s)
[381.769807] Starting dynamic subtest: shmem
[382.889177] Dynamic subtest shmem: SUCCESS (1.130s)
[382.901790] Starting dynamic subtest: fence
[391.044246] Dynamic subtest fence: SUCCESS (8.153s)
[391.057278] Starting dynamic subtest: scatterlist
[393.187175] Dynamic subtest scatterlist: SUCCESS (2.141s)
[393.200608] Starting dynamic subtest: syncmap
[396.312106] Dynamic subtest syncmap: SUCCESS (3.123s)
[396.324867] Starting dynamic subtest: uncore
[397.426051] Dynamic subtest uncore: SUCCESS (1.112s)
[397.443617] Starting dynamic subtest: ring
[398.549248] Dynamic subtest ring: SUCCESS (1.121s)
[398.562137] Starting dynamic subtest: engine
[399.702172] Dynamic subtest engine: SUCCESS (1.151s)
[399.715290] Starting dynamic subtest: timelines
[405.946303] Dynamic subtest timelines: SUCCESS (6.242s)
[405.958874] Starting dynamic subtest: requests
[409.227161] Dynamic subtest requests: SUCCESS (3.279s)
[409.244756] Starting dynamic subtest: objects
[410.466723] Dynamic subtest objects: SUCCESS (1.237s)
[410.481683] Starting dynamic subtest: phys
[411.766056] Dynamic subtest phys: SUCCESS (1.298s)
[411.778730] Starting dynamic subtest: dmabuf
[413.022159] Dynamic subtest dmabuf: SUCCESS (1.254s)
[413.035120] Starting dynamic subtest: vma
[424.638152] Dynamic subtest vma: SUCCESS (11.614s)
[424.651079] Starting dynamic subtest: evict
[427.193357] Dynamic subtest evict: SUCCESS (2.553s)
[427.206410] Starting dynamic subtest: gtt
[431.554278] Dynamic subtest gtt: SUCCESS (4.359s)
[431.567165] Starting dynamic subtest: hugepages
[433.098295] Dynamic subtest hugepages: SUCCESS (1.542s)
[433.111928] Starting dynamic subtest: memory_region
[438.029243] Dynamic subtest memory_region: SUCCESS (4.929s)
[438.030195] Subtest mock: SUCCESS (57.555s)
[438.067774] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[438.069062] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[438.071605] [088/133] (601s left) perf_pmu (busy-check-all)
[440.193252] Starting subtest: busy-check-all
[440.194716] Starting dynamic subtest: rcs0
[440.718346] Dynamic subtest rcs0: SUCCESS (0.524s)
[440.732117] Starting dynamic subtest: bcs0
[441.247460] Dynamic subtest bcs0: SUCCESS (0.526s)
[441.261457] Starting dynamic subtest: vcs0
[442.274349] Dynamic subtest vcs0: SUCCESS (1.024s)
[442.277414] Subtest busy-check-all: SUCCESS (2.082s)
[442.339041] [FACT perf_pmu (busy-check-all)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[442.340641] [FACT perf_pmu (busy-check-all)] new: kernel.kmod_is_loaded.i915: true
[442.345324] [089/133] (597s left) gem_exec_params (no-blt)
[442.407967] Starting subtest: no-blt
[442.408817] Subtest no-blt: SUCCESS (0.000s)
[442.561876] [090/133] (597s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[443.048509] Starting subtest: basic-max-pipe-crc-check
[443.050090] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[443.355789] [091/133] (596s left) perf (gen8-unprivileged-single-ctx-counters)
[443.570596] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[443.640361] [092/133] (596s left) kms_rotation_crc (cursor-rotation-180)
[444.133463] Starting subtest: cursor-rotation-180
[444.934922] Subtest cursor-rotation-180: SUCCESS (0.802s)
[445.737998] [093/133] (594s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[446.235046] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[446.236525] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[446.822341] [094/133] (593s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[447.311489] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[447.312915] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[447.920728] [095/133] (591s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[447.981883] Starting subtest: framebuffer-vs-set-tiling
[447.982693] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[449.016431] [096/133] (590s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[449.334582] Starting subtest: syncobj-timeline-multiple-ext-nodes
[449.337122] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.002s)
[449.598843] [097/133] (590s left) kms_flip (2x-nonexisting-fb-interruptible)
[450.096616] Starting subtest: 2x-nonexisting-fb-interruptible
[450.098847] Starting dynamic subtest: AB-VGA1-HDMI-A1
[450.464299] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (0.365s)
[450.467346] Subtest 2x-nonexisting-fb-interruptible: SUCCESS (0.370s)
[451.248417] [098/133] (588s left) kms_psr (psr2-sprite-plane-move)
[451.734875] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[452.041774] [099/133] (588s left) kms_psr (fbc-psr2-cursor-plane-move)
[452.535409] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[452.839673] [100/133] (587s left) kms_rotation_crc (bad-pixel-format)
[453.320391] Starting subtest: bad-pixel-format
[453.321950] Subtest bad-pixel-format: SKIP (0.001s)
[453.955170] [101/133] (586s left) kms_invalid_mode (bad-vsync-end)
[454.466318] Starting subtest: bad-vsync-end
[454.467731] Starting dynamic subtest: pipe-A-HDMI-A-1
[454.527422] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.080s)
[454.539055] Starting dynamic subtest: pipe-B-HDMI-A-1
[454.553394] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[454.554273] Subtest bad-vsync-end: SUCCESS (0.085s)
[454.992462] [102/133] (585s left) gem_exec_schedule (preempt-user)
[455.064679] Subtest preempt-user: SKIP (0.000s)
[455.291163] [103/133] (585s left) syncobj_wait (wait-zero-handles)
[455.349534] Starting subtest: wait-zero-handles
[455.350271] Subtest wait-zero-handles: SUCCESS (0.000s)
[455.455556] [104/133] (584s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[455.943346] Starting subtest: basic-flip-before-cursor-varying-size
[456.922906] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.980s)
[457.624621] [105/133] (582s left) gem_softpin (softpin)
[457.683149] Starting subtest: softpin
[489.916518] Subtest softpin: SUCCESS (32.232s)
[490.077925] [106/133] (550s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[490.568505] Starting subtest: 2x-cursor-vs-flip-legacy
[490.569950] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[491.172887] [107/133] (549s left) kms_getfb (getfb-reject-nv12)
[491.661336] Starting subtest: getfb-reject-nv12
[491.662825] Subtest getfb-reject-nv12: SKIP (0.000s)
[492.258623] [108/133] (548s left) gem_ctx_persistence (engines-persistence)
[492.325712] Subtest engines-persistence: SKIP (0.000s)
[492.383800] [109/133] (548s left) gem_tiled_blits (basic)
[492.594240] Starting subtest: basic
[492.616669] Subtest basic: SUCCESS (0.023s)
[492.803417] [110/133] (547s left) kms_chamelium_color (ctm-green-to-red)
[493.419856] Subtest ctm-green-to-red: SKIP (0.000s)
[493.714030] [111/133] (547s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[493.775691] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[493.832865] [112/133] (546s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[493.903041] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[494.010297] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[494.140801] [113/133] (546s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[494.197338] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[494.306108] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[494.435375] [114/133] (546s left) gem_ctx_shared (disjoint-timelines)
[494.496159] Subtest disjoint-timelines: SKIP (0.000s)
[494.601463] [115/133] (546s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[494.661885] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[494.730506] [116/133] (546s left) kms_properties (get_properties-sanity-atomic)
[495.222281] Starting subtest: get_properties-sanity-atomic
[495.223100] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[495.833998] [117/133] (545s left) kms_addfb_basic (basic-x-tiled-legacy)
[495.895984] Starting subtest: basic-x-tiled-legacy
[495.896767] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[496.929786] [118/133] (544s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[497.428520] Starting subtest: yf-tiled-64bpp-rotate-180
[497.429864] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.001s)
[498.029163] [119/133] (543s left) kms_content_protection (lic-type-0-hdcp14)
[498.559191] Starting subtest: lic-type-0-hdcp14
[498.560687] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[499.176723] [120/133] (542s left) perf_pmu (all-busy-check-all)
[499.238392] Starting subtest: all-busy-check-all
[499.766555] Subtest all-busy-check-all: SUCCESS (0.528s)
[499.892759] [121/133] (541s left) syncobj_timeline (single-wait-all-available-submitted)
[499.950774] Starting subtest: single-wait-all-available-submitted
[499.951505] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[500.055663] [122/133] (541s left) prime_vgem (basic-write)
[500.129993] Starting subtest: basic-write
[500.148741] Subtest basic-write: SUCCESS (0.018s)
[500.257975] [123/133] (541s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[500.751644] Starting subtest: x-tiled-16bpp-rotate-90
[500.773818] Subtest x-tiled-16bpp-rotate-90: SKIP (0.021s)
[501.388895] [124/133] (539s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[501.879399] Starting subtest: 2x-cursor-vs-flip-atomic
[501.880831] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[502.486171] [125/133] (538s left) gem_tiled_pread_basic (basic)
[502.548162] Starting subtest: basic
[502.728101] Subtest basic: SUCCESS (0.179s)
[502.868506] [126/133] (538s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[503.362448] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[503.363712] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[503.968955] [127/133] (537s left) gem_spin_batch (resubmit-all)
[504.035029] Starting subtest: resubmit-all
[504.035899] Starting dynamic subtest: rcs0
[504.036767] Dynamic subtest rcs0: SUCCESS (0.002s)
[504.051769] Starting dynamic subtest: bcs0
[504.052627] Dynamic subtest bcs0: SUCCESS (0.001s)
[504.063535] Starting dynamic subtest: vcs0
[504.064303] Dynamic subtest vcs0: SUCCESS (0.001s)
[504.064957] Subtest resubmit-all: SUCCESS (0.009s)
[504.285800] [128/133] (537s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[504.776454] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[504.778986] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[505.380861] [129/133] (536s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[505.875617] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[507.808757] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.934s)
[508.457668] [130/133] (533s left) gem_mmap_wc (write-read)
[508.519467] Starting subtest: write-read
[508.533453] Subtest write-read: SUCCESS (0.015s)
[508.691600] [131/133] (533s left) perf_pmu (busy-start)
[508.750603] Starting subtest: busy-start
[508.751536] Starting dynamic subtest: rcs0
[511.276193] Dynamic subtest rcs0: SUCCESS (2.522s)
[511.293747] Starting dynamic subtest: bcs0
[513.790323] Dynamic subtest bcs0: SUCCESS (2.511s)
[513.809549] Starting dynamic subtest: vcs0
[516.806467] Dynamic subtest vcs0: SUCCESS (3.013s)
[516.807526] Subtest busy-start: SUCCESS (8.054s)
[516.942792] [132/133] (524s left) gem_exec_balancer (bonded-false-hang)
[517.000529] Subtest bonded-false-hang: SKIP (0.000s)
[517.125672] [133/133] (524s left) kms_chamelium_frames (hdmi-crc-multiple)
[517.693789] Subtest hdmi-crc-multiple: SKIP (0.000s)
[518.092952] 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.