[66.911362] Initializing watchdogs
[66.911479]   /dev/watchdog0
[66.932226] [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)
[66.940119] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[66.943783] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.947955] [001/131] (960s left) vgem_slow (nohang)
[67.054860] Starting subtest: nohang
[77.412533] Subtest nohang: SUCCESS (10.371s)
[77.514968] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[77.518549] [002/131] (949s left) gem_userptr_blits (unsync-overlap)
[77.589053] Subtest unsync-overlap: SKIP (0.000s)
[77.746279] [003/131] (949s left) gem_exec_schedule (u-fairslice-all)
[77.816277] Subtest u-fairslice-all: SKIP (0.000s)
[78.052454] [004/131] (949s left) gem_lmem_swapping (parallel-random)
[78.112043] Subtest parallel-random: SKIP (0.000s)
[78.160816] [005/131] (949s left) kms_sequence (queue-idle)
[78.462984] Starting subtest: queue-idle
[78.464709] Starting dynamic subtest: pipe-A-HDMI-A-1
[80.851846] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.388s)
[80.861419] Starting dynamic subtest: pipe-B-HDMI-A-1
[83.092593] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.240s)
[83.094329] Subtest queue-idle: SUCCESS (4.630s)
[83.614035] [006/131] (944s left) gem_exec_schedule (lateslice)
[83.708110] Subtest lateslice: SKIP (0.000s)
[83.946198] [007/131] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[84.245725] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[84.249101] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[84.650855] [008/131] (943s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[84.977959] Starting subtest: syncobj-timeline-invalid-wait
[84.980113] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s)
[85.244820] [009/131] (942s left) gem_exec_params (no-vebox)
[85.303607] Starting subtest: no-vebox
[85.305506] Subtest no-vebox: SUCCESS (0.000s)
[85.448687] [010/131] (942s left) gem_exec_balancer (parallel-contexts)
[85.506962] Subtest parallel-contexts: SKIP (0.000s)
[85.644570] [011/131] (942s left) kms_pm_rpm (legacy-planes-dpms)
[97.179725] Subtest legacy-planes-dpms: SKIP (0.000s)
[97.380249] [012/131] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[97.686628] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[97.689733] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[98.078203] [013/131] (930s left) kms_cursor_edge_walk (64x64-left-edge)
[98.375915] Starting subtest: 64x64-left-edge
[98.377682] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.788047] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.412s)
[101.798220] Starting dynamic subtest: pipe-B-HDMI-A-1
[105.134858] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.345s)
[105.136568] Subtest 64x64-left-edge: SUCCESS (6.760s)
[105.642214] [014/131] (922s left) gem_mmap_offset (open-flood)
[105.705569] Starting subtest: open-flood
[127.214094] Subtest open-flood: SUCCESS (21.510s)
[127.372335] [015/131] (900s left) gem_spin_batch (spin-each)
[127.446812] Starting subtest: spin-each
[130.782144] Subtest spin-each: SUCCESS (3.336s)
[131.023604] [016/131] (897s left) gem_ctx_persistence (saturated-hostile)
[131.088418] Subtest saturated-hostile: SKIP (0.000s)
[131.153190] [017/131] (897s left) gem_ctx_shared (q-independent)
[131.215848] Subtest Q-independent: SKIP (0.000s)
[131.345651] [018/131] (897s left) kms_psr (fbc-psr-primary-render)
[131.643733] Subtest fbc-psr-primary-render: SKIP (0.000s)
[131.850172] [019/131] (896s left) perf_pmu (rc6-all-gts)
[131.934187] Starting subtest: rc6-all-gts
[131.938222] Subtest rc6-all-gts: SKIP (0.000s)
[132.076400] [020/131] (896s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[132.137119] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.000s)
[132.201806] [021/131] (896s left) gem_pxp (create-regular-context-1)
[134.776123] Starting subtest: create-regular-context-1
[134.780171] Subtest create-regular-context-1: SKIP (0.000s)
[134.902082] [022/131] (893s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[134.968875] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[134.973130] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[135.202922] [023/131] (893s left) syncobj_timeline (host-signal-points)
[135.260428] Starting subtest: host-signal-points
[135.272288] Subtest host-signal-points: SUCCESS (0.012s)
[135.401868] [024/131] (893s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[135.461503] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[135.529880] [025/131] (893s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[135.834945] Starting subtest: stress-xrgb8888-xtiled
[143.242700] Subtest stress-xrgb8888-xtiled: SUCCESS (7.408s)
[143.624487] [026/131] (885s left) kms_async_flips (test-time-stamp)
[143.920957] Starting subtest: test-time-stamp
[144.061962] Starting dynamic subtest: pipe-A-HDMI-A-1
[144.255386] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.191s)
[144.397973] Starting dynamic subtest: pipe-B-HDMI-A-1
[144.521251] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.131s)
[144.523475] Subtest test-time-stamp: SUCCESS (0.601s)
[145.166766] [027/131] (883s left) prime_self_import (basic-with_two_bos)
[145.223827] Starting subtest: basic-with_two_bos
[145.227197] Subtest basic-with_two_bos: SUCCESS (0.004s)
[145.367223] [028/131] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[145.678404] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[145.681694] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[146.088942] [029/131] (882s left) gem_mmap_gtt (close-race)
[146.147795] Starting subtest: close-race
[166.254333] Subtest close-race: SUCCESS (20.105s)
[166.397137] [030/131] (862s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[166.695205] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[168.650300] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.957s)
[169.098868] [031/131] (860s left) gen9_exec_parse (valid-registers)
[169.161760] Subtest valid-registers: SKIP (0.000s)
[169.230193] [032/131] (859s left) kms_color (legacy-gamma-reset)
[169.529839] Starting subtest: legacy-gamma-reset
[169.531967] Starting dynamic subtest: pipe-A-HDMI-A-1
[169.666269] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.138s)
[169.678063] Starting dynamic subtest: pipe-B-HDMI-A-1
[169.681083] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[169.694525] Subtest legacy-gamma-reset: SUCCESS (0.145s)
[170.197991] [033/131] (859s left) gem_partial_pwrite_pread (reads-snoop)
[170.264766] Starting subtest: reads-snoop
[171.419414] Subtest reads-snoop: SUCCESS (1.153s)
[171.592559] [034/131] (857s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[171.902883] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[171.906142] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[172.321941] [035/131] (857s left) gem_exec_reloc (basic-gtt-noreloc)
[172.387177] Starting subtest: basic-gtt-noreloc
[172.388906] Subtest basic-gtt-noreloc: SUCCESS (0.003s)
[173.034593] [036/131] (856s left) syncobj_timeline (invalid-transfer-illegal-handle)
[173.096868] Starting subtest: invalid-transfer-illegal-handle
[173.098761] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[173.241495] [037/131] (856s left) gem_ctx_param (invalid-get-engines)
[173.302146] Starting subtest: invalid-get-engines
[173.304213] Subtest invalid-get-engines: SUCCESS (0.000s)
[173.429568] [038/131] (856s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[173.731123] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[173.734413] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[174.149621] [039/131] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[174.458829] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[174.462063] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[174.873252] [040/131] (854s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[175.185207] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[175.202535] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[175.596518] [041/131] (854s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[175.659194] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[175.723369] [042/131] (854s left) kms_plane_cursor (primary)
[176.019090] Starting subtest: primary
[176.022365] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[178.438715] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.419s)
[178.482958] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[180.917087] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.444s)
[180.961997] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[183.395125] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.444s)
[183.523019] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[186.053788] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.540s)
[186.098253] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[188.515476] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.427s)
[188.558125] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[190.977080] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.427s)
[191.091032] Subtest primary: SUCCESS (15.075s)
[191.606791] [043/131] (838s left) kms_flip (dpms-off-confusion-interruptible)
[191.918269] Starting subtest: dpms-off-confusion-interruptible
[191.919911] Starting dynamic subtest: A-VGA1
[199.642559] Dynamic subtest A-VGA1: SUCCESS (7.725s)
[199.655918] Starting dynamic subtest: B-VGA1
[207.337766] Dynamic subtest B-VGA1: SUCCESS (7.692s)
[207.351448] Starting dynamic subtest: A-HDMI-A1
[215.045249] Dynamic subtest A-HDMI-A1: SUCCESS (7.704s)
[215.058569] Starting dynamic subtest: B-HDMI-A1
[222.795903] Dynamic subtest B-HDMI-A1: SUCCESS (7.748s)
[222.797954] Subtest dpms-off-confusion-interruptible: SUCCESS (30.882s)
[223.409436] [044/131] (806s left) kms_cursor_edge_walk (256x256-top-bottom)
[223.707880] Starting subtest: 256x256-top-bottom
[223.709656] Starting dynamic subtest: pipe-A-HDMI-A-1
[227.126882] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.419s)
[227.142838] Starting dynamic subtest: pipe-B-HDMI-A-1
[230.469903] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.338s)
[230.471750] Subtest 256x256-top-bottom: SUCCESS (6.763s)
[230.978830] [045/131] (798s left) kms_psr (pr-sprite-plane-onoff)
[231.272690] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[231.473967] [046/131] (798s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[231.770920] Starting subtest: short-flip-before-cursor-toggle
[232.755080] Subtest short-flip-before-cursor-toggle: SUCCESS (0.986s)
[233.291420] [047/131] (796s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[233.596713] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[233.598381] Starting dynamic subtest: A-VGA1
[241.623097] Dynamic subtest A-VGA1: SUCCESS (8.024s)
[241.639700] Starting dynamic subtest: B-VGA1
[249.613439] Dynamic subtest B-VGA1: SUCCESS (7.986s)
[249.626855] Starting dynamic subtest: A-HDMI-A1
[257.787220] Dynamic subtest A-HDMI-A1: SUCCESS (8.171s)
[257.800619] Starting dynamic subtest: B-HDMI-A1
[265.988184] Dynamic subtest B-HDMI-A1: SUCCESS (8.198s)
[265.990114] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.393s)
[266.586488] [048/131] (763s left) gem_exec_params (secure-non-master)
[266.648384] Starting subtest: secure-non-master
[266.652045] Subtest secure-non-master: SKIP (0.000s)
[266.793968] [049/131] (763s left) kms_flip (2x-flip-vs-dpms)
[267.087755] Starting subtest: 2x-flip-vs-dpms
[267.089415] Starting dynamic subtest: AB-VGA1-HDMI-A1
[269.472189] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.383s)
[269.473948] Subtest 2x-flip-vs-dpms: SUCCESS (2.386s)
[270.045887] [050/131] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[270.351199] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[270.354462] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[270.762738] [051/131] (759s left) drm_read (fault-buffer)
[271.111930] Starting subtest: fault-buffer
[271.114200] Subtest fault-buffer: SUCCESS (0.001s)
[271.558192] [052/131] (758s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[271.626867] Starting subtest: basic-batch-kernel-default-cmd
[271.630920] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[271.862605] [053/131] (758s left) kms_cursor_crc (cursor-offscreen-128x128)
[272.159532] Starting subtest: cursor-offscreen-128x128
[272.164234] Starting dynamic subtest: pipe-A-HDMI-A-1
[274.550123] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.389s)
[274.605051] Starting dynamic subtest: pipe-B-HDMI-A-1
[276.985779] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.391s)
[276.987546] Subtest cursor-offscreen-128x128: SUCCESS (4.827s)
[277.496725] [054/131] (752s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[277.801857] Starting subtest: x-tiled-8bpp-rotate-90
[277.808788] Subtest x-tiled-8bpp-rotate-90: SKIP (0.005s)
[278.249964] [055/131] (752s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[278.309109] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[278.419641] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[278.561111] [056/131] (751s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[278.862336] Starting subtest: 4-tiled-32bpp-rotate-90
[278.865698] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[279.272945] [057/131] (751s left) core_setmaster (master-drop-set-shared-fd)
[279.423112] Starting subtest: master-drop-set-shared-fd
[279.453322] Subtest master-drop-set-shared-fd: SUCCESS (0.031s)
[279.502243] [058/131] (751s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[279.798725] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[279.800390] Starting dynamic subtest: AB-VGA1-HDMI-A1
[281.391450] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.593s)
[281.393135] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (1.596s)
[281.922177] [059/131] (748s left) syncobj_wait (single-wait-all-submitted)
[281.987528] Starting subtest: single-wait-all-submitted
[282.091636] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[282.226907] [060/131] (748s left) kms_big_fb (linear-64bpp-rotate-270)
[282.537528] Starting subtest: linear-64bpp-rotate-270
[282.556886] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[282.995917] [061/131] (747s left) gem_exec_params (invalid-fence-in-submit)
[283.057698] Starting subtest: invalid-fence-in-submit
[283.059332] Subtest invalid-fence-in-submit: SUCCESS (0.001s)
[283.205909] [062/131] (747s left) syncobj_wait (single-wait-for-submit-submitted)
[283.268042] Starting subtest: single-wait-for-submit-submitted
[283.371809] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[283.510082] [063/131] (747s left) prime_vgem (fence-write-hang)
[283.578741] Subtest fence-write-hang: SKIP (0.000s)
[283.721516] [064/131] (747s left) syncobj_timeline (single-wait-signaled)
[283.781108] Starting subtest: single-wait-signaled
[283.782803] Subtest single-wait-signaled: SUCCESS (0.000s)
[283.903546] [065/131] (747s left) kms_chamelium_edid (vga-edid-read)
[284.272363] Subtest vga-edid-read: SKIP (0.000s)
[284.578726] [066/131] (746s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[284.876640] Starting subtest: 2x-long-flip-vs-cursor-atomic
[284.879867] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[285.285257] [067/131] (745s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[285.592181] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[287.509118] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.919s)
[287.955797] [068/131] (743s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[288.257836] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[290.203367] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.947s)
[290.652144] [069/131] (740s left) prime_vgem (basic-read)
[290.722866] Starting subtest: basic-read
[290.740364] Subtest basic-read: SUCCESS (0.017s)
[290.908120] [070/131] (740s left) gem_userptr_blits (vma-merge)
[290.990063] Starting subtest: vma-merge
[291.076155] Subtest vma-merge: SUCCESS (0.085s)
[291.253794] [071/131] (740s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[291.558392] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[291.563101] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[291.984962] [072/131] (739s left) kms_vrr (negative-basic)
[292.280615] Starting subtest: negative-basic
[292.285743] Subtest negative-basic: SKIP (0.000s)
[292.687734] [073/131] (738s left) gem_exec_reloc (basic-cpu-read-active)
[292.749491] Starting subtest: basic-cpu-read-active
[292.859541] Subtest basic-cpu-read-active: SUCCESS (0.110s)
[293.500306] [074/131] (738s left) kms_chamelium_hpd (hdmi-hpd)
[293.862746] Subtest hdmi-hpd: SKIP (0.000s)
[294.172367] [075/131] (737s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[294.477388] Starting subtest: yf-tiled-16bpp-rotate-0
[294.480793] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[294.891812] [076/131] (736s left) syncobj_timeline (reset-signaled)
[294.954121] Starting subtest: reset-signaled
[294.955986] Subtest reset-signaled: SUCCESS (0.000s)
[295.092381] [077/131] (736s left) kms_psr (fbc-psr2-basic)
[295.386974] Subtest fbc-psr2-basic: SKIP (0.000s)
[295.589750] [078/131] (736s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[295.886715] Starting subtest: primary-yf-tiled-reflect-x-0
[295.891562] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.001s)
[296.305641] [079/131] (735s left) kms_prop_blob (basic)
[296.364762] Starting subtest: basic
[296.366418] Subtest basic: SUCCESS (0.000s)
[296.489390] [080/131] (735s left) vgem_basic (debugfs)
[296.553800] Starting subtest: debugfs
[296.555645] Subtest debugfs: SUCCESS (0.001s)
[296.669375] [081/131] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[296.968045] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[296.971523] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[297.371126] [082/131] (734s left) gem_userptr_blits (unsync-unmap-cycles)
[297.436942] Subtest unsync-unmap-cycles: SKIP (0.000s)
[297.603700] [083/131] (734s left) perf_pmu (busy-double-start)
[297.669702] Starting subtest: busy-double-start
[297.671516] Starting dynamic subtest: rcs0
[301.212416] Dynamic subtest rcs0: SUCCESS (3.542s)
[301.228128] Starting dynamic subtest: bcs0
[304.728972] Dynamic subtest bcs0: SUCCESS (3.513s)
[304.746947] Starting dynamic subtest: vcs0
[308.748336] Dynamic subtest vcs0: SUCCESS (4.017s)
[308.750568] Subtest busy-double-start: SUCCESS (11.081s)
[308.881698] [084/131] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[309.340886] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[309.390618] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[309.698921] [085/131] (722s left) kms_chamelium_color (ctm-negative)
[310.069646] Subtest ctm-negative: SKIP (0.000s)
[310.391490] [086/131] (722s left) kms_async_flips (async-flip-dpms)
[310.687573] Starting subtest: async-flip-dpms
[310.825205] Starting dynamic subtest: pipe-A-HDMI-A-1
[323.023872] Dynamic subtest pipe-A-HDMI-A-1: SKIP (12.196s)
[323.188891] Starting dynamic subtest: pipe-B-HDMI-A-1
[335.327631] Dynamic subtest pipe-B-HDMI-A-1: SKIP (12.148s)
[335.331886] Subtest async-flip-dpms: SKIP (24.642s)
[336.012069] [087/131] (696s left) gem_busy (semaphore)
[336.206971] Subtest semaphore: SKIP (0.000s)
[336.469767] [088/131] (696s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[336.767914] Starting subtest: flip-vs-dpms-off-vs-modeset
[336.769735] Starting dynamic subtest: A-VGA1
[337.554955] Dynamic subtest A-VGA1: SUCCESS (0.784s)
[337.566570] Starting dynamic subtest: B-VGA1
[338.250984] Dynamic subtest B-VGA1: SUCCESS (0.694s)
[338.262858] Starting dynamic subtest: A-HDMI-A1
[339.061170] Dynamic subtest A-HDMI-A1: SUCCESS (0.808s)
[339.072786] Starting dynamic subtest: B-HDMI-A1
[339.854646] Dynamic subtest B-HDMI-A1: SUCCESS (0.791s)
[339.856376] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.088s)
[340.401749] [089/131] (692s left) prime_mmap (test_reprime)
[340.465977] Starting subtest: test_reprime
[340.467766] Starting dynamic subtest: test_reprime-smem
[340.469324] Dynamic subtest test_reprime-smem: SUCCESS (0.003s)
[340.470934] Subtest test_reprime: SUCCESS (0.004s)
[340.617894] [090/131] (692s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[340.927130] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[341.116384] [091/131] (691s left) gem_exec_whisper (basic-fds)
[341.183588] Starting subtest: basic-fds
[343.944611] Subtest basic-fds: SUCCESS (2.758s)
[344.190825] [092/131] (688s left) gem_ctx_param (set-priority-range)
[344.249053] Subtest set-priority-range: SKIP (0.000s)
[344.387878] [093/131] (688s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[344.449711] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.000s)
[344.514776] [094/131] (688s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[344.573724] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[344.626468] [095/131] (688s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[344.927850] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[344.931133] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[345.342019] [096/131] (687s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[345.401899] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[345.464111] [097/131] (687s left) i915_selftest (mock)
[346.370147] Starting subtest: mock
[346.372218] Starting dynamic subtest: sanitycheck
[347.520779] Dynamic subtest sanitycheck: SUCCESS (1.150s)
[347.533335] Starting dynamic subtest: shmem
[348.670763] Dynamic subtest shmem: SUCCESS (1.148s)
[348.682479] Starting dynamic subtest: fence
[357.069848] Dynamic subtest fence: SUCCESS (8.397s)
[357.083763] Starting dynamic subtest: scatterlist
[359.226759] Dynamic subtest scatterlist: SUCCESS (2.155s)
[359.239787] Starting dynamic subtest: syncmap
[362.416799] Dynamic subtest syncmap: SUCCESS (3.188s)
[362.429270] Starting dynamic subtest: uncore
[363.539813] Dynamic subtest uncore: SUCCESS (1.121s)
[363.552385] Starting dynamic subtest: ring
[364.726937] Dynamic subtest ring: SUCCESS (1.185s)
[364.739141] Starting dynamic subtest: engine
[365.866824] Dynamic subtest engine: SUCCESS (1.138s)
[365.878960] Starting dynamic subtest: timelines
[372.140721] Dynamic subtest timelines: SUCCESS (6.272s)
[372.154601] Starting dynamic subtest: requests
[375.463910] Dynamic subtest requests: SUCCESS (3.321s)
[375.475993] Starting dynamic subtest: objects
[376.756195] Dynamic subtest objects: SUCCESS (1.290s)
[376.771144] Starting dynamic subtest: phys
[378.032848] Dynamic subtest phys: SUCCESS (1.274s)
[378.044816] Starting dynamic subtest: dmabuf
[379.252836] Dynamic subtest dmabuf: SUCCESS (1.218s)
[379.264924] Starting dynamic subtest: vma
[390.961980] Dynamic subtest vma: SUCCESS (11.707s)
[390.974100] Starting dynamic subtest: evict
[393.583857] Dynamic subtest evict: SUCCESS (2.620s)
[393.596192] Starting dynamic subtest: gtt
[397.945840] Dynamic subtest gtt: SUCCESS (4.360s)
[397.958410] Starting dynamic subtest: hugepages
[399.491869] Dynamic subtest hugepages: SUCCESS (1.544s)
[399.504202] Starting dynamic subtest: memory_region
[404.691750] Dynamic subtest memory_region: SUCCESS (5.198s)
[404.693480] Subtest mock: SUCCESS (58.324s)
[404.727708] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[404.729071] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[404.732695] [098/131] (628s left) gem_ctx_exec (basic-close-race)
[406.628811] Starting subtest: basic-close-race
[412.190392] Subtest basic-close-race: SUCCESS (5.559s)
[412.278345] [FACT gem_ctx_exec (basic-close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[412.280009] [FACT gem_ctx_exec (basic-close-race)] new: kernel.kmod_is_loaded.i915: true
[412.285258] [099/131] (620s left) prime_busy (after)
[412.349799] Starting subtest: after
[412.357055] Starting dynamic subtest: rcs0
[412.373232] Dynamic subtest rcs0: SUCCESS (0.016s)
[412.392267] Starting dynamic subtest: bcs0
[412.397230] Dynamic subtest bcs0: SUCCESS (0.022s)
[412.415296] Starting dynamic subtest: vcs0
[412.417153] Dynamic subtest vcs0: SUCCESS (0.018s)
[412.526451] Subtest after: SUCCESS (0.174s)
[412.663238] [100/131] (620s left) syncobj_wait (reset-signaled)
[412.724127] Starting subtest: reset-signaled
[412.725862] Subtest reset-signaled: SUCCESS (0.000s)
[412.870893] [101/131] (620s left) kms_dsc (dsc-basic)
[413.168017] Subtest dsc-basic: SKIP (0.000s)
[413.384074] [102/131] (619s left) vgem_basic (bad-flag)
[413.446994] Starting subtest: bad-flag
[413.449099] Subtest bad-flag: SUCCESS (0.000s)
[413.562634] [103/131] (619s left) kms_psr (psr2-sprite-mmap-gtt)
[413.859207] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[414.058721] [104/131] (619s left) gem_exec_balancer (noheartbeat)
[414.117855] Subtest noheartbeat: SKIP (0.000s)
[414.252818] [105/131] (619s left) gem_tiled_wb
[424.341140] [106/131] (609s left) gem_exec_reloc (basic-softpin)
[424.399850] Starting subtest: basic-softpin
[424.401654] Subtest basic-softpin: SUCCESS (0.002s)
[425.062464] [107/131] (608s left) gem_pxp (hw-rejects-pxp-buffer)
[427.636520] Starting subtest: hw-rejects-pxp-buffer
[427.638375] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[427.782227] [108/131] (605s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[428.085050] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[428.277739] [109/131] (605s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[428.580790] Starting subtest: 2x-cursor-vs-flip-legacy
[428.584108] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[429.000983] [110/131] (604s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[429.323945] Starting subtest: multiplane-rotation-cropping-bottom
[429.327410] Subtest multiplane-rotation-cropping-bottom: SKIP (0.000s)
[429.730972] [111/131] (604s left) gem_userptr_blits (sync-overlap)
[429.803969] Starting subtest: sync-overlap
[429.805848] Subtest sync-overlap: SUCCESS (0.000s)
[429.960857] [112/131] (603s left) kms_feature_discovery (psr2)
[430.256788] Starting subtest: psr2
[430.260244] Subtest psr2: SKIP (0.000s)
[430.663123] [113/131] (603s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[430.967995] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[430.971409] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[431.378855] [114/131] (602s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[431.682177] Starting subtest: y-tiled-32bpp-rotate-0
[431.685516] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[432.092527] [115/131] (602s left) gem_mmap_gtt (basic-small-bo)
[432.151499] Starting subtest: basic-small-bo
[432.842525] Subtest basic-small-bo: SUCCESS (0.690s)
[433.022546] [116/131] (601s left) api_intel_bb (simple-bb)
[433.160714] Starting subtest: simple-bb
[433.162462] Subtest simple-bb: SUCCESS (0.003s)
[433.345390] [117/131] (600s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[433.648796] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[433.651052] Starting dynamic subtest: pipe-A
[433.657663] Dynamic subtest pipe-A: SKIP (0.001s)
[433.674071] Starting dynamic subtest: pipe-B
[433.690651] Dynamic subtest pipe-B: SKIP (0.001s)
[433.693859] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.005s)
[434.105189] [118/131] (600s left) kms_lease (lease-unleased-connector)
[434.404741] Starting subtest: lease-unleased-connector
[434.417813] Starting dynamic subtest: pipe-A-HDMI-A-1
[434.463064] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.059s)
[434.480928] Starting dynamic subtest: pipe-B-HDMI-A-1
[434.524066] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.057s)
[434.525836] Subtest lease-unleased-connector: SUCCESS (0.122s)
[434.940744] [119/131] (599s left) gen9_exec_parse (bb-secure)
[435.004583] Subtest bb-secure: SKIP (0.000s)
[435.067198] [120/131] (599s left) vgem_basic (mmap)
[435.134990] Starting subtest: mmap
[435.146121] Subtest mmap: SUCCESS (0.012s)
[435.271431] [121/131] (599s left) gem_eio (in-flight-contexts-10ms)
[435.338950] Starting subtest: in-flight-contexts-10ms
[438.799158] Subtest in-flight-contexts-10ms: SUCCESS (3.461s)
[439.468469] [122/131] (595s left) i915_pm_rpm (debugfs-forcewake-user)
[451.041046] Subtest debugfs-forcewake-user: SKIP (0.000s)
[451.233465] [123/131] (583s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[451.540197] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[451.543361] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[451.951287] [124/131] (582s left) kms_psr (fbc-pr-no-drrs)
[452.254210] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[452.450289] [125/131] (582s left) kms_invalid_mode (bad-htotal)
[452.746859] Starting subtest: bad-htotal
[452.748624] Starting dynamic subtest: pipe-A-HDMI-A-1
[452.832510] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.083s)
[452.847915] Starting dynamic subtest: pipe-B-HDMI-A-1
[452.849703] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[452.851329] Subtest bad-htotal: SUCCESS (0.088s)
[453.219691] [126/131] (581s left) kms_cursor_crc (cursor-random-128x42)
[453.521757] Starting subtest: cursor-random-128x42
[453.592802] Subtest cursor-random-128x42: SKIP (0.067s)
[454.014347] [127/131] (580s left) gem_linear_blits (interruptible)
[454.166050] Starting subtest: interruptible
[456.125084] Subtest interruptible: SUCCESS (1.961s)
[456.258498] [128/131] (578s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[456.626913] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[456.630238] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[457.042172] [129/131] (577s left) i915_hangman (engine-engine-error)
[457.114158] Subtest engine-engine-error: SKIP (0.000s)
[457.190920] [130/131] (577s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[457.493261] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[457.496514] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[457.909545] [131/131] (577s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[458.208389] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[458.210175] Starting dynamic subtest: pipe-A
[458.215032] Dynamic subtest pipe-A: SKIP (0.001s)
[458.229682] Starting dynamic subtest: pipe-B
[458.234320] Dynamic subtest pipe-B: SKIP (0.001s)
[458.237447] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.005s)
[458.628384] 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.