[68.558693] Initializing watchdogs
[68.558863]   /dev/watchdog0
[68.583758] [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)
[68.591569] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.595406] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.598168] [001/131] (960s left) vgem_slow (nohang)
[68.695797] Starting subtest: nohang
[78.951476] Subtest nohang: SUCCESS (10.256s)
[79.050421] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[79.053236] [002/131] (950s left) gem_userptr_blits (unsync-overlap)
[79.111497] Subtest unsync-overlap: SKIP (0.000s)
[79.275824] [003/131] (949s left) gem_exec_schedule (u-fairslice-all)
[79.339976] Subtest u-fairslice-all: SKIP (0.000s)
[79.567725] [004/131] (949s left) gem_lmem_swapping (parallel-random)
[79.625156] Subtest parallel-random: SKIP (0.000s)
[79.678432] [005/131] (949s left) kms_sequence (queue-idle)
[79.977760] Starting subtest: queue-idle
[79.978425] Starting dynamic subtest: pipe-A-HDMI-A-1
[82.354846] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.377s)
[82.364232] Starting dynamic subtest: pipe-B-HDMI-A-1
[84.596726] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.241s)
[84.597285] Subtest queue-idle: SUCCESS (4.620s)
[85.114135] [006/131] (944s left) gem_exec_schedule (lateslice)
[85.188294] Subtest lateslice: SKIP (0.000s)
[85.409597] [007/131] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[85.707160] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[85.708091] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[86.111787] [008/131] (943s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[86.432934] Starting subtest: syncobj-timeline-invalid-wait
[86.435522] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[86.718232] [009/131] (942s left) gem_exec_params (no-vebox)
[86.776883] Starting subtest: no-vebox
[86.777579] Subtest no-vebox: SUCCESS (0.000s)
[86.922887] [010/131] (942s left) gem_exec_balancer (parallel-contexts)
[86.976565] Subtest parallel-contexts: SKIP (0.000s)
[87.116802] [011/131] (942s left) kms_pm_rpm (legacy-planes-dpms)
[98.650429] Subtest legacy-planes-dpms: SKIP (0.000s)
[98.850135] [012/131] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[99.155211] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[99.156452] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[99.566976] [013/131] (930s left) kms_cursor_edge_walk (64x64-left-edge)
[99.855827] Starting subtest: 64x64-left-edge
[99.857484] Starting dynamic subtest: pipe-A-HDMI-A-1
[103.277260] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.420s)
[103.287077] Starting dynamic subtest: pipe-B-HDMI-A-1
[106.607724] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.329s)
[106.608263] Subtest 64x64-left-edge: SUCCESS (6.752s)
[107.128303] [014/131] (922s left) gem_mmap_offset (open-flood)
[107.187318] Starting subtest: open-flood
[128.694125] Subtest open-flood: SUCCESS (21.508s)
[128.831782] [015/131] (900s left) gem_spin_batch (spin-each)
[128.901726] Starting subtest: spin-each
[132.237064] Subtest spin-each: SUCCESS (3.336s)
[132.488218] [016/131] (897s left) gem_ctx_persistence (saturated-hostile)
[132.545306] Subtest saturated-hostile: SKIP (0.000s)
[132.598636] [017/131] (897s left) gem_ctx_shared (q-independent)
[132.654905] Subtest Q-independent: SKIP (0.000s)
[132.770342] [018/131] (897s left) kms_psr (fbc-psr-primary-render)
[133.064920] Subtest fbc-psr-primary-render: SKIP (0.000s)
[133.264655] [019/131] (896s left) perf_pmu (rc6-all-gts)
[133.328103] Starting subtest: rc6-all-gts
[133.329317] Subtest rc6-all-gts: SKIP (0.000s)
[133.453322] [020/131] (896s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[133.508087] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.000s)
[133.564548] [021/131] (896s left) gem_pxp (create-regular-context-1)
[136.134333] Starting subtest: create-regular-context-1
[136.136254] Subtest create-regular-context-1: SKIP (0.000s)
[136.271900] [022/131] (893s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[136.339835] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[136.341409] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[136.567831] [023/131] (893s left) syncobj_timeline (host-signal-points)
[136.624251] Starting subtest: host-signal-points
[136.635948] Subtest host-signal-points: SUCCESS (0.012s)
[136.767892] [024/131] (893s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[136.819704] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[136.873987] [025/131] (893s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[137.166683] Starting subtest: stress-xrgb8888-xtiled
[144.300854] Subtest stress-xrgb8888-xtiled: SUCCESS (7.134s)
[144.704103] [026/131] (885s left) kms_async_flips (test-time-stamp)
[145.007886] Starting subtest: test-time-stamp
[145.147895] Starting dynamic subtest: pipe-A-HDMI-A-1
[145.331061] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.182s)
[145.472884] Starting dynamic subtest: pipe-B-HDMI-A-1
[145.596678] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.131s)
[145.597707] Subtest test-time-stamp: SUCCESS (0.590s)
[146.254494] [027/131] (884s left) prime_self_import (basic-with_two_bos)
[146.311415] Starting subtest: basic-with_two_bos
[146.314585] Subtest basic-with_two_bos: SUCCESS (0.003s)
[146.453645] [028/131] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[146.753702] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[146.754847] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[147.170278] [029/131] (883s left) gem_mmap_gtt (close-race)
[147.227304] Starting subtest: close-race
[167.332391] Subtest close-race: SUCCESS (20.103s)
[167.480550] [030/131] (863s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[167.777399] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[169.727796] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.951s)
[170.193630] [031/131] (860s left) gen9_exec_parse (valid-registers)
[170.251560] Subtest valid-registers: SKIP (0.000s)
[170.318100] [032/131] (860s left) kms_color (legacy-gamma-reset)
[170.607656] Starting subtest: legacy-gamma-reset
[170.608622] Starting dynamic subtest: pipe-A-HDMI-A-1
[170.744653] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.138s)
[170.754944] Starting dynamic subtest: pipe-B-HDMI-A-1
[170.755678] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[170.756235] Subtest legacy-gamma-reset: SUCCESS (0.145s)
[171.265438] [033/131] (859s left) gem_partial_pwrite_pread (reads-snoop)
[171.327813] Starting subtest: reads-snoop
[172.416903] Subtest reads-snoop: SUCCESS (1.090s)
[172.580292] [034/131] (858s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[172.875368] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[172.876310] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[173.287285] [035/131] (857s left) gem_exec_reloc (basic-gtt-noreloc)
[173.345284] Starting subtest: basic-gtt-noreloc
[173.348773] Subtest basic-gtt-noreloc: SUCCESS (0.004s)
[173.992169] [036/131] (856s left) syncobj_timeline (invalid-transfer-illegal-handle)
[174.047949] Starting subtest: invalid-transfer-illegal-handle
[174.048628] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[174.176156] [037/131] (856s left) gem_ctx_param (invalid-get-engines)
[174.228539] Starting subtest: invalid-get-engines
[174.229104] Subtest invalid-get-engines: SUCCESS (0.000s)
[174.357112] [038/131] (856s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[174.648738] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[174.649877] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[175.056241] [039/131] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[175.353257] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[175.354326] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[175.755746] [040/131] (855s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[176.051419] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[176.052509] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[176.456268] [041/131] (854s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[176.509922] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[176.566558] [042/131] (854s left) kms_plane_cursor (primary)
[176.856707] Starting subtest: primary
[176.858320] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[179.283955] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.426s)
[179.329457] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[181.761964] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.444s)
[181.806189] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[184.223703] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.427s)
[184.350944] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[186.847869] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.506s)
[186.893161] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[189.309388] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.427s)
[189.353687] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[191.771059] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.427s)
[191.888322] Subtest primary: SUCCESS (15.031s)
[192.401166] [043/131] (838s left) kms_flip (dpms-off-confusion-interruptible)
[192.701734] Starting subtest: dpms-off-confusion-interruptible
[192.703678] Starting dynamic subtest: A-VGA1
[200.418948] Dynamic subtest A-VGA1: SUCCESS (7.715s)
[200.430566] Starting dynamic subtest: B-VGA1
[208.099645] Dynamic subtest B-VGA1: SUCCESS (7.677s)
[208.111963] Starting dynamic subtest: A-HDMI-A1
[215.821824] Dynamic subtest A-HDMI-A1: SUCCESS (7.719s)
[215.833334] Starting dynamic subtest: B-HDMI-A1
[223.574208] Dynamic subtest B-HDMI-A1: SUCCESS (7.749s)
[223.577292] Subtest dpms-off-confusion-interruptible: SUCCESS (30.874s)
[224.159755] [044/131] (807s left) kms_cursor_edge_walk (256x256-top-bottom)
[224.453576] Starting subtest: 256x256-top-bottom
[224.454751] Starting dynamic subtest: pipe-A-HDMI-A-1
[227.881585] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.427s)
[227.893631] Starting dynamic subtest: pipe-B-HDMI-A-1
[231.210754] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.327s)
[231.212583] Subtest 256x256-top-bottom: SUCCESS (6.759s)
[231.723793] [045/131] (799s left) kms_psr (pr-sprite-plane-onoff)
[232.017747] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[232.218563] [046/131] (799s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[232.510400] Starting subtest: short-flip-before-cursor-toggle
[233.489939] Subtest short-flip-before-cursor-toggle: SUCCESS (0.979s)
[234.004418] [047/131] (797s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[234.306862] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[234.309244] Starting dynamic subtest: A-VGA1
[242.353249] Dynamic subtest A-VGA1: SUCCESS (8.043s)
[242.364995] Starting dynamic subtest: B-VGA1
[250.345578] Dynamic subtest B-VGA1: SUCCESS (7.989s)
[250.358579] Starting dynamic subtest: A-HDMI-A1
[258.502142] Dynamic subtest A-HDMI-A1: SUCCESS (8.153s)
[258.516640] Starting dynamic subtest: B-HDMI-A1
[266.685568] Dynamic subtest B-HDMI-A1: SUCCESS (8.180s)
[266.688860] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.380s)
[267.285772] [048/131] (764s left) gem_exec_params (secure-non-master)
[267.343013] Starting subtest: secure-non-master
[267.344140] Subtest secure-non-master: SKIP (0.000s)
[267.486594] [049/131] (763s left) kms_flip (2x-flip-vs-dpms)
[267.774709] Starting subtest: 2x-flip-vs-dpms
[267.775809] Starting dynamic subtest: AB-VGA1-HDMI-A1
[270.143631] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.367s)
[270.145653] Subtest 2x-flip-vs-dpms: SUCCESS (2.370s)
[270.694225] [050/131] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[270.993346] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[270.994521] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[271.403603] [051/131] (760s left) drm_read (fault-buffer)
[271.740795] Starting subtest: fault-buffer
[271.741395] Subtest fault-buffer: SUCCESS (0.001s)
[272.188879] [052/131] (759s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[272.249942] Starting subtest: basic-batch-kernel-default-cmd
[272.251292] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[272.484342] [053/131] (759s left) kms_cursor_crc (cursor-offscreen-128x128)
[272.778877] Starting subtest: cursor-offscreen-128x128
[272.780519] Starting dynamic subtest: pipe-A-HDMI-A-1
[275.163655] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.383s)
[275.204474] Starting dynamic subtest: pipe-B-HDMI-A-1
[277.586496] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.392s)
[277.588202] Subtest cursor-offscreen-128x128: SUCCESS (4.810s)
[278.142184] [054/131] (753s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[278.444919] Starting subtest: x-tiled-8bpp-rotate-90
[278.462190] Subtest x-tiled-8bpp-rotate-90: SKIP (0.016s)
[278.893819] [055/131] (752s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[278.951733] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[279.054635] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[279.177374] [056/131] (752s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[279.478555] Starting subtest: 4-tiled-32bpp-rotate-90
[279.479787] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[279.888465] [057/131] (751s left) core_setmaster (master-drop-set-shared-fd)
[280.043562] Starting subtest: master-drop-set-shared-fd
[280.074748] Subtest master-drop-set-shared-fd: SUCCESS (0.032s)
[280.121376] [058/131] (751s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[280.418405] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[280.420717] Starting dynamic subtest: AB-VGA1-HDMI-A1
[282.007518] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.586s)
[282.008053] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (1.590s)
[282.546539] [059/131] (749s left) syncobj_wait (single-wait-all-submitted)
[282.607159] Starting subtest: single-wait-all-submitted
[282.710446] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[282.842293] [060/131] (749s left) kms_big_fb (linear-64bpp-rotate-270)
[283.145475] Starting subtest: linear-64bpp-rotate-270
[283.157525] Subtest linear-64bpp-rotate-270: SKIP (0.011s)
[283.586266] [061/131] (748s left) gem_exec_params (invalid-fence-in-submit)
[283.647474] Starting subtest: invalid-fence-in-submit
[283.649443] Subtest invalid-fence-in-submit: SUCCESS (0.001s)
[283.820176] [062/131] (748s left) syncobj_wait (single-wait-for-submit-submitted)
[283.877147] Starting subtest: single-wait-for-submit-submitted
[283.982443] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s)
[284.105472] [063/131] (748s left) prime_vgem (fence-write-hang)
[284.178409] Subtest fence-write-hang: SKIP (0.000s)
[284.320440] [064/131] (747s left) syncobj_timeline (single-wait-signaled)
[284.375717] Starting subtest: single-wait-signaled
[284.376421] Subtest single-wait-signaled: SUCCESS (0.000s)
[284.501183] [065/131] (747s left) kms_chamelium_edid (vga-edid-read)
[284.870780] Subtest vga-edid-read: SKIP (0.000s)
[285.175030] [066/131] (747s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[285.469800] Starting subtest: 2x-long-flip-vs-cursor-atomic
[285.470898] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[285.879370] [067/131] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[286.169073] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[288.094341] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.925s)
[288.538040] [068/131] (743s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[288.835063] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[290.722268] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.888s)
[291.185783] [069/131] (741s left) prime_vgem (basic-read)
[291.242705] Starting subtest: basic-read
[291.261276] Subtest basic-read: SUCCESS (0.019s)
[291.418592] [070/131] (741s left) gem_userptr_blits (vma-merge)
[291.500877] Starting subtest: vma-merge
[291.583797] Subtest vma-merge: SUCCESS (0.084s)
[291.732801] [071/131] (740s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[292.041828] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[292.042938] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[292.449489] [072/131] (740s left) kms_vrr (negative-basic)
[292.743727] Starting subtest: negative-basic
[292.746851] Subtest negative-basic: SKIP (0.000s)
[293.159599] [073/131] (739s left) gem_exec_reloc (basic-cpu-read-active)
[293.218542] Starting subtest: basic-cpu-read-active
[293.326270] Subtest basic-cpu-read-active: SUCCESS (0.109s)
[293.970431] [074/131] (738s left) kms_chamelium_hpd (hdmi-hpd)
[294.332434] Subtest hdmi-hpd: SKIP (0.000s)
[294.644799] [075/131] (738s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[294.946795] Starting subtest: yf-tiled-16bpp-rotate-0
[294.947770] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[295.351564] [076/131] (737s left) syncobj_timeline (reset-signaled)
[295.405300] Starting subtest: reset-signaled
[295.405846] Subtest reset-signaled: SUCCESS (0.000s)
[295.532642] [077/131] (737s left) kms_psr (fbc-psr2-basic)
[295.823337] Subtest fbc-psr2-basic: SKIP (0.000s)
[296.025660] [078/131] (736s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[296.317792] Starting subtest: primary-yf-tiled-reflect-x-0
[296.318906] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.002s)
[296.734399] [079/131] (736s left) kms_prop_blob (basic)
[296.787831] Starting subtest: basic
[296.788387] Subtest basic: SUCCESS (0.000s)
[296.917118] [080/131] (736s left) vgem_basic (debugfs)
[296.986101] Starting subtest: debugfs
[296.986753] Subtest debugfs: SUCCESS (0.001s)
[297.099359] [081/131] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[297.397833] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[297.398853] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[297.819188] [082/131] (735s left) gem_userptr_blits (unsync-unmap-cycles)
[297.877861] Subtest unsync-unmap-cycles: SKIP (0.000s)
[298.044377] [083/131] (735s left) perf_pmu (busy-double-start)
[298.101956] Starting subtest: busy-double-start
[298.103710] Starting dynamic subtest: rcs0
[301.630352] Dynamic subtest rcs0: SUCCESS (3.527s)
[301.644354] Starting dynamic subtest: bcs0
[305.156563] Dynamic subtest bcs0: SUCCESS (3.523s)
[305.170767] Starting dynamic subtest: vcs0
[309.182299] Dynamic subtest vcs0: SUCCESS (4.023s)
[309.185072] Subtest busy-double-start: SUCCESS (11.081s)
[309.309504] [084/131] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[309.608736] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[309.609884] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[310.027356] [085/131] (723s left) kms_chamelium_color (ctm-negative)
[310.319243] Subtest ctm-negative: SKIP (0.000s)
[310.514766] [086/131] (722s left) kms_async_flips (async-flip-dpms)
[310.802977] Starting subtest: async-flip-dpms
[310.923241] Starting dynamic subtest: pipe-A-HDMI-A-1
[323.105942] Dynamic subtest pipe-A-HDMI-A-1: SKIP (12.182s)
[323.250301] Starting dynamic subtest: pipe-B-HDMI-A-1
[335.382986] Dynamic subtest pipe-B-HDMI-A-1: SKIP (12.141s)
[335.384736] Subtest async-flip-dpms: SKIP (24.582s)
[336.036343] [087/131] (697s left) gem_busy (semaphore)
[336.217203] Subtest semaphore: SKIP (0.000s)
[336.484383] [088/131] (696s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[336.775750] Starting subtest: flip-vs-dpms-off-vs-modeset
[336.776546] Starting dynamic subtest: A-VGA1
[337.552640] Dynamic subtest A-VGA1: SUCCESS (0.775s)
[337.564774] Starting dynamic subtest: B-VGA1
[338.240880] Dynamic subtest B-VGA1: SUCCESS (0.687s)
[338.252752] Starting dynamic subtest: A-HDMI-A1
[339.058560] Dynamic subtest A-HDMI-A1: SUCCESS (0.816s)
[339.071577] Starting dynamic subtest: B-HDMI-A1
[339.832298] Dynamic subtest B-HDMI-A1: SUCCESS (0.773s)
[339.834366] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.058s)
[340.392867] [089/131] (693s left) prime_mmap (test_reprime)
[340.452324] Starting subtest: test_reprime
[340.453049] Starting dynamic subtest: test_reprime-smem
[340.455287] Dynamic subtest test_reprime-smem: SUCCESS (0.003s)
[340.455849] Subtest test_reprime: SUCCESS (0.004s)
[340.614367] [090/131] (692s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[340.913612] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[341.124748] [091/131] (692s left) gem_exec_whisper (basic-fds)
[341.196932] Starting subtest: basic-fds
[343.950702] Subtest basic-fds: SUCCESS (2.754s)
[344.185766] [092/131] (689s left) gem_ctx_param (set-priority-range)
[344.241910] Subtest set-priority-range: SKIP (0.000s)
[344.354784] [093/131] (689s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[344.408412] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.000s)
[344.468710] [094/131] (689s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[344.522438] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[344.585292] [095/131] (689s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[344.882303] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[344.883526] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[345.284406] [096/131] (688s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[345.338863] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[345.402468] [097/131] (688s left) i915_selftest (mock)
[346.304918] Starting subtest: mock
[346.305718] Starting dynamic subtest: sanitycheck
[347.479512] Dynamic subtest sanitycheck: SUCCESS (1.174s)
[347.491853] Starting dynamic subtest: shmem
[348.635531] Dynamic subtest shmem: SUCCESS (1.154s)
[348.647831] Starting dynamic subtest: fence
[357.118629] Dynamic subtest fence: SUCCESS (8.481s)
[357.130685] Starting dynamic subtest: scatterlist
[359.262372] Dynamic subtest scatterlist: SUCCESS (2.142s)
[359.274453] Starting dynamic subtest: syncmap
[362.399601] Dynamic subtest syncmap: SUCCESS (3.135s)
[362.412194] Starting dynamic subtest: uncore
[363.565443] Dynamic subtest uncore: SUCCESS (1.164s)
[363.578021] Starting dynamic subtest: ring
[364.689369] Dynamic subtest ring: SUCCESS (1.122s)
[364.701509] Starting dynamic subtest: engine
[365.838582] Dynamic subtest engine: SUCCESS (1.147s)
[365.851146] Starting dynamic subtest: timelines
[372.111750] Dynamic subtest timelines: SUCCESS (6.271s)
[372.123922] Starting dynamic subtest: requests
[375.458609] Dynamic subtest requests: SUCCESS (3.345s)
[375.470920] Starting dynamic subtest: objects
[376.751746] Dynamic subtest objects: SUCCESS (1.291s)
[376.764848] Starting dynamic subtest: phys
[378.045657] Dynamic subtest phys: SUCCESS (1.292s)
[378.057820] Starting dynamic subtest: dmabuf
[379.315692] Dynamic subtest dmabuf: SUCCESS (1.268s)
[379.329373] Starting dynamic subtest: vma
[391.107632] Dynamic subtest vma: SUCCESS (11.790s)
[391.121345] Starting dynamic subtest: evict
[393.699618] Dynamic subtest evict: SUCCESS (2.590s)
[393.711937] Starting dynamic subtest: gtt
[398.074560] Dynamic subtest gtt: SUCCESS (4.373s)
[398.086350] Starting dynamic subtest: hugepages
[399.622616] Dynamic subtest hugepages: SUCCESS (1.546s)
[399.639542] Starting dynamic subtest: memory_region
[404.829474] Dynamic subtest memory_region: SUCCESS (5.204s)
[404.831580] Subtest mock: SUCCESS (58.526s)
[404.868066] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[404.869700] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[404.872270] [098/131] (629s left) gem_ctx_exec (basic-close-race)
[406.777815] Starting subtest: basic-close-race
[412.432863] Subtest basic-close-race: SUCCESS (5.655s)
[412.542427] [FACT gem_ctx_exec (basic-close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[412.544129] [FACT gem_ctx_exec (basic-close-race)] new: kernel.kmod_is_loaded.i915: true
[412.548095] [099/131] (621s left) prime_busy (after)
[412.610183] Starting subtest: after
[412.617740] Starting dynamic subtest: rcs0
[412.642755] Dynamic subtest rcs0: SUCCESS (0.025s)
[412.658445] Starting dynamic subtest: bcs0
[412.661543] Dynamic subtest bcs0: SUCCESS (0.017s)
[412.676858] Starting dynamic subtest: vcs0
[412.682102] Dynamic subtest vcs0: SUCCESS (0.019s)
[412.789240] Subtest after: SUCCESS (0.178s)
[412.912378] [100/131] (621s left) syncobj_wait (reset-signaled)
[412.966412] Starting subtest: reset-signaled
[412.966999] Subtest reset-signaled: SUCCESS (0.000s)
[413.098858] [101/131] (620s left) kms_dsc (dsc-basic)
[413.395835] Subtest dsc-basic: SKIP (0.000s)
[413.587913] [102/131] (620s left) vgem_basic (bad-flag)
[413.644563] Starting subtest: bad-flag
[413.645116] Subtest bad-flag: SUCCESS (0.000s)
[413.757969] [103/131] (620s left) kms_psr (psr2-sprite-mmap-gtt)
[414.055586] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[414.250556] [104/131] (619s left) gem_exec_balancer (noheartbeat)
[414.309890] Subtest noheartbeat: SKIP (0.000s)
[414.440706] [105/131] (619s left) gem_tiled_wb
[422.975633] [106/131] (611s left) gem_exec_reloc (basic-softpin)
[423.039077] Starting subtest: basic-softpin
[423.040715] Subtest basic-softpin: SUCCESS (0.002s)
[423.697686] [107/131] (610s left) gem_pxp (hw-rejects-pxp-buffer)
[426.273977] Starting subtest: hw-rejects-pxp-buffer
[426.274664] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[426.415748] [108/131] (608s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[426.708419] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[426.914145] [109/131] (607s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[427.209781] Starting subtest: 2x-cursor-vs-flip-legacy
[427.212705] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[427.630816] [110/131] (606s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[427.920867] Starting subtest: multiplane-rotation-cropping-bottom
[427.921861] Subtest multiplane-rotation-cropping-bottom: SKIP (0.000s)
[428.329305] [111/131] (606s left) gem_userptr_blits (sync-overlap)
[428.400622] Starting subtest: sync-overlap
[428.401357] Subtest sync-overlap: SUCCESS (0.000s)
[428.559756] [112/131] (606s left) kms_feature_discovery (psr2)
[428.847867] Starting subtest: psr2
[428.849214] Subtest psr2: SKIP (0.000s)
[429.261475] [113/131] (605s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[429.558607] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[429.559758] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[429.959441] [114/131] (604s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[430.255978] Starting subtest: y-tiled-32bpp-rotate-0
[430.257235] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[430.659585] [115/131] (604s left) gem_mmap_gtt (basic-small-bo)
[430.714593] Starting subtest: basic-small-bo
[431.490271] Subtest basic-small-bo: SUCCESS (0.776s)
[431.670153] [116/131] (603s left) api_intel_bb (simple-bb)
[431.806443] Starting subtest: simple-bb
[431.809726] Subtest simple-bb: SUCCESS (0.003s)
[431.980506] [117/131] (602s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[432.280772] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[432.281534] Starting dynamic subtest: pipe-A
[432.283417] Dynamic subtest pipe-A: SKIP (0.001s)
[432.294794] Starting dynamic subtest: pipe-B
[432.296303] Dynamic subtest pipe-B: SKIP (0.001s)
[432.297244] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.006s)
[432.686896] [118/131] (602s left) kms_lease (lease-unleased-connector)
[432.977911] Starting subtest: lease-unleased-connector
[432.978688] Starting dynamic subtest: pipe-A-HDMI-A-1
[433.037745] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.058s)
[433.051014] Starting dynamic subtest: pipe-B-HDMI-A-1
[433.100874] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.059s)
[433.101636] Subtest lease-unleased-connector: SUCCESS (0.124s)
[433.519111] [119/131] (601s left) gen9_exec_parse (bb-secure)
[433.576293] Subtest bb-secure: SKIP (0.000s)
[433.629253] [120/131] (601s left) vgem_basic (mmap)
[433.688249] Starting subtest: mmap
[433.699447] Subtest mmap: SUCCESS (0.012s)
[433.819416] [121/131] (601s left) gem_eio (in-flight-contexts-10ms)
[433.888220] Starting subtest: in-flight-contexts-10ms
[437.301033] Subtest in-flight-contexts-10ms: SUCCESS (3.414s)
[437.963384] [122/131] (597s left) i915_pm_rpm (debugfs-forcewake-user)
[449.514336] Subtest debugfs-forcewake-user: SKIP (0.000s)
[449.716322] [123/131] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[450.010504] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[450.011541] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[450.418570] [124/131] (584s left) kms_psr (fbc-pr-no-drrs)
[450.710610] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[450.913220] [125/131] (584s left) kms_invalid_mode (bad-htotal)
[451.208477] Starting subtest: bad-htotal
[451.209165] Starting dynamic subtest: pipe-A-HDMI-A-1
[451.284484] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.076s)
[451.301477] Starting dynamic subtest: pipe-B-HDMI-A-1
[451.302056] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[451.302600] Subtest bad-htotal: SUCCESS (0.081s)
[451.662301] [126/131] (583s left) kms_cursor_crc (cursor-random-128x42)
[451.961723] Starting subtest: cursor-random-128x42
[452.044406] Subtest cursor-random-128x42: SKIP (0.081s)
[452.463849] [127/131] (582s left) gem_linear_blits (interruptible)
[452.610128] Starting subtest: interruptible
[454.573968] Subtest interruptible: SUCCESS (1.964s)
[454.746112] [128/131] (580s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[455.132228] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[455.134138] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[455.542861] [129/131] (579s left) i915_hangman (engine-engine-error)
[455.609629] Subtest engine-engine-error: SKIP (0.000s)
[455.682611] [130/131] (579s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[455.982456] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[455.983512] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[456.400069] [131/131] (579s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[456.692920] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[456.693719] Starting dynamic subtest: pipe-A
[456.695505] Dynamic subtest pipe-A: SKIP (0.001s)
[456.708104] Starting dynamic subtest: pipe-B
[456.709917] Dynamic subtest pipe-B: SKIP (0.001s)
[456.710849] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.005s)
[457.103296] Closing watchdogs
results: parsing output: 0/ for test: vgem_slow
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: kms_sequence
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_edge_walk
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: gem_ctx_shared
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_pipe_stress
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: prime_self_import
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_plane_cursor
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_cursor_edge_walk
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: drm_read
results: parsing output: 51/ for test: gem_exec_flush
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: core_setmaster
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: prime_vgem
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_chamelium_edid
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: prime_vgem
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_vrr
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: kms_prop_blob
results: parsing output: 79/ for test: vgem_basic
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_chamelium_color
results: parsing output: 85/ for test: kms_async_flips
results: parsing output: 86/ for test: gem_busy
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: prime_mmap
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: gem_ctx_param
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: i915_selftest
results: parsing output: 97/ for test: gem_ctx_exec
results: parsing output: 98/ for test: prime_busy
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_dsc
results: parsing output: 101/ for test: vgem_basic
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: gem_tiled_wb
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: gem_userptr_blits
results: parsing output: 111/ for test: kms_feature_discovery
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: vgem_basic
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_invalid_mode
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: gem_linear_blits
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: i915_hangman
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_plane_scaling
Done.