[61.660219] Initializing watchdogs
[61.660334]   /dev/watchdog0
[61.681921] [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)
[61.689933] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.693801] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.696797] [001/131] (960s left) vgem_slow (nohang)
[61.803090] Starting subtest: nohang
[72.295158] Subtest nohang: SUCCESS (10.503s)
[72.396505] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[72.398939] [002/131] (949s left) gem_userptr_blits (unsync-overlap)
[72.457536] Subtest unsync-overlap: SKIP (0.000s)
[72.612469] [003/131] (949s left) gem_exec_schedule (u-fairslice-all)
[72.681224] Subtest u-fairslice-all: SKIP (0.000s)
[72.914836] [004/131] (949s left) gem_lmem_swapping (parallel-random)
[72.973599] Subtest parallel-random: SKIP (0.000s)
[73.024643] [005/131] (949s left) kms_sequence (queue-idle)
[73.321020] Starting subtest: queue-idle
[73.321861] Starting dynamic subtest: pipe-A-HDMI-A-1
[75.683318] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.363s)
[75.694563] Starting dynamic subtest: pipe-B-HDMI-A-1
[77.933667] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.250s)
[77.934504] Subtest queue-idle: SUCCESS (4.616s)
[78.453998] [006/131] (943s left) gem_exec_schedule (lateslice)
[78.520257] Subtest lateslice: SKIP (0.000s)
[78.750564] [007/131] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[79.044993] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[79.046163] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[79.449632] [008/131] (943s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[79.762453] Starting subtest: syncobj-timeline-invalid-wait
[79.764202] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s)
[80.046871] [009/131] (942s left) gem_exec_params (no-vebox)
[80.102360] Starting subtest: no-vebox
[80.102912] Subtest no-vebox: SUCCESS (0.000s)
[80.246615] [010/131] (942s left) gem_exec_balancer (parallel-contexts)
[80.305157] Subtest parallel-contexts: SKIP (0.000s)
[80.429738] [011/131] (942s left) kms_pm_rpm (legacy-planes-dpms)
[91.966977] Subtest legacy-planes-dpms: SKIP (0.000s)
[92.172960] [012/131] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[92.473899] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[92.475188] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[92.872855] [013/131] (929s left) kms_cursor_edge_walk (64x64-left-edge)
[93.164838] Starting subtest: 64x64-left-edge
[93.165685] Starting dynamic subtest: pipe-A-HDMI-A-1
[96.580571] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.415s)
[96.590465] Starting dynamic subtest: pipe-B-HDMI-A-1
[99.917622] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.335s)
[99.918096] Subtest 64x64-left-edge: SUCCESS (6.753s)
[100.432759] [014/131] (922s left) gem_mmap_offset (open-flood)
[100.488888] Starting subtest: open-flood
[122.000016] Subtest open-flood: SUCCESS (21.511s)
[122.142942] [015/131] (900s left) gem_spin_batch (spin-each)
[122.212699] Starting subtest: spin-each
[125.547757] Subtest spin-each: SUCCESS (3.335s)
[125.812984] [016/131] (897s left) gem_ctx_persistence (saturated-hostile)
[125.869414] Subtest saturated-hostile: SKIP (0.000s)
[125.924016] [017/131] (897s left) gem_ctx_shared (q-independent)
[125.981549] Subtest Q-independent: SKIP (0.000s)
[126.109877] [018/131] (896s left) kms_psr (fbc-psr-primary-render)
[126.405749] Subtest fbc-psr-primary-render: SKIP (0.000s)
[126.606093] [019/131] (896s left) perf_pmu (rc6-all-gts)
[126.663126] Starting subtest: rc6-all-gts
[126.664224] Subtest rc6-all-gts: SKIP (0.000s)
[126.792441] [020/131] (896s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[126.844760] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.000s)
[126.905131] [021/131] (896s left) gem_pxp (create-regular-context-1)
[129.473980] Starting subtest: create-regular-context-1
[129.475380] Subtest create-regular-context-1: SKIP (0.000s)
[129.604348] [022/131] (893s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[129.664918] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[129.666280] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[129.889140] [023/131] (893s left) syncobj_timeline (host-signal-points)
[129.951989] Starting subtest: host-signal-points
[129.963438] Subtest host-signal-points: SUCCESS (0.011s)
[130.094774] [024/131] (893s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[130.146778] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[130.198160] [025/131] (893s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[130.489171] Starting subtest: stress-xrgb8888-xtiled
[137.246926] Subtest stress-xrgb8888-xtiled: SUCCESS (6.758s)
[137.612857] [026/131] (885s left) kms_async_flips (test-time-stamp)
[137.907017] Starting subtest: test-time-stamp
[138.059195] Starting dynamic subtest: pipe-A-HDMI-A-1
[138.265254] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.204s)
[138.425507] Starting dynamic subtest: pipe-B-HDMI-A-1
[138.549090] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.132s)
[138.549995] Subtest test-time-stamp: SUCCESS (0.643s)
[139.210373] [027/131] (884s left) prime_self_import (basic-with_two_bos)
[139.264624] Starting subtest: basic-with_two_bos
[139.268103] Subtest basic-with_two_bos: SUCCESS (0.004s)
[139.409119] [028/131] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[139.706872] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[139.707904] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[140.109835] [029/131] (883s left) gem_mmap_gtt (close-race)
[140.162365] Starting subtest: close-race
[160.262965] Subtest close-race: SUCCESS (20.100s)
[160.401475] [030/131] (863s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[160.695941] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[162.648532] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.953s)
[163.112313] [031/131] (860s left) gen9_exec_parse (valid-registers)
[163.172964] Subtest valid-registers: SKIP (0.000s)
[163.240599] [032/131] (860s left) kms_color (legacy-gamma-reset)
[163.535794] Starting subtest: legacy-gamma-reset
[163.536525] Starting dynamic subtest: pipe-A-HDMI-A-1
[163.683723] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.147s)
[163.695684] Starting dynamic subtest: pipe-B-HDMI-A-1
[163.696349] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.005s)
[163.696997] Subtest legacy-gamma-reset: SUCCESS (0.155s)
[164.195225] [033/131] (859s left) gem_partial_pwrite_pread (reads-snoop)
[164.250243] Starting subtest: reads-snoop
[165.432777] Subtest reads-snoop: SUCCESS (1.182s)
[165.593204] [034/131] (858s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[165.891043] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[165.892101] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[166.305304] [035/131] (857s left) gem_exec_reloc (basic-gtt-noreloc)
[166.361792] Starting subtest: basic-gtt-noreloc
[166.364828] Subtest basic-gtt-noreloc: SUCCESS (0.003s)
[167.002366] [036/131] (856s left) syncobj_timeline (invalid-transfer-illegal-handle)
[167.059403] Starting subtest: invalid-transfer-illegal-handle
[167.059961] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[167.191260] [037/131] (856s left) gem_ctx_param (invalid-get-engines)
[167.246862] Starting subtest: invalid-get-engines
[167.247709] Subtest invalid-get-engines: SUCCESS (0.000s)
[167.370997] [038/131] (856s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[167.674158] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[167.675151] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[168.084250] [039/131] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[168.382427] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[168.383526] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[168.782725] [040/131] (855s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[169.074701] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[169.075613] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[169.492848] [041/131] (854s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[169.546771] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[169.611071] [042/131] (854s left) kms_plane_cursor (primary)
[169.901960] Starting subtest: primary
[169.903153] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[172.329807] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.426s)
[172.374704] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[174.808032] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.443s)
[174.852737] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[177.286568] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.444s)
[177.414292] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[179.925286] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.520s)
[179.969303] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[182.387277] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.427s)
[182.431179] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[184.865635] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.444s)
[184.982970] Subtest primary: SUCCESS (15.081s)
[185.509750] [043/131] (838s left) kms_flip (dpms-off-confusion-interruptible)
[185.806936] Starting subtest: dpms-off-confusion-interruptible
[185.808545] Starting dynamic subtest: A-VGA1
[193.532591] Dynamic subtest A-VGA1: SUCCESS (7.724s)
[193.545817] Starting dynamic subtest: B-VGA1
[201.220432] Dynamic subtest B-VGA1: SUCCESS (7.684s)
[201.232630] Starting dynamic subtest: A-HDMI-A1
[208.960421] Dynamic subtest A-HDMI-A1: SUCCESS (7.737s)
[208.972551] Starting dynamic subtest: B-HDMI-A1
[216.712758] Dynamic subtest B-HDMI-A1: SUCCESS (7.749s)
[216.715820] Subtest dpms-off-confusion-interruptible: SUCCESS (30.908s)
[217.297878] [044/131] (806s left) kms_cursor_edge_walk (256x256-top-bottom)
[217.590020] Starting subtest: 256x256-top-bottom
[217.591958] Starting dynamic subtest: pipe-A-HDMI-A-1
[221.006613] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.415s)
[221.017720] Starting dynamic subtest: pipe-B-HDMI-A-1
[224.335274] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.327s)
[224.336919] Subtest 256x256-top-bottom: SUCCESS (6.747s)
[224.850492] [045/131] (799s left) kms_psr (pr-sprite-plane-onoff)
[225.148598] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[225.347848] [046/131] (799s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[225.641539] Starting subtest: short-flip-before-cursor-toggle
[226.617468] Subtest short-flip-before-cursor-toggle: SUCCESS (0.976s)
[227.170330] [047/131] (797s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[227.470285] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[227.472660] Starting dynamic subtest: A-VGA1
[235.512834] Dynamic subtest A-VGA1: SUCCESS (8.040s)
[235.524559] Starting dynamic subtest: B-VGA1
[243.487827] Dynamic subtest B-VGA1: SUCCESS (7.972s)
[243.502596] Starting dynamic subtest: A-HDMI-A1
[251.660507] Dynamic subtest A-HDMI-A1: SUCCESS (8.169s)
[251.671957] Starting dynamic subtest: B-HDMI-A1
[259.862210] Dynamic subtest B-HDMI-A1: SUCCESS (8.199s)
[259.866623] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.394s)
[260.464775] [048/131] (764s left) gem_exec_params (secure-non-master)
[260.520923] Starting subtest: secure-non-master
[260.522268] Subtest secure-non-master: SKIP (0.000s)
[260.668045] [049/131] (763s left) kms_flip (2x-flip-vs-dpms)
[260.956842] Starting subtest: 2x-flip-vs-dpms
[260.958851] Starting dynamic subtest: AB-VGA1-HDMI-A1
[263.382841] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.423s)
[263.383382] Subtest 2x-flip-vs-dpms: SUCCESS (2.426s)
[263.951098] [050/131] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[264.258257] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[264.259387] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[264.668658] [051/131] (759s left) drm_read (fault-buffer)
[265.003762] Starting subtest: fault-buffer
[265.004389] Subtest fault-buffer: SUCCESS (0.001s)
[265.447519] [052/131] (759s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[265.516520] Starting subtest: basic-batch-kernel-default-cmd
[265.517703] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[265.747354] [053/131] (758s left) kms_cursor_crc (cursor-offscreen-128x128)
[266.045388] Starting subtest: cursor-offscreen-128x128
[266.048939] Starting dynamic subtest: pipe-A-HDMI-A-1
[268.443702] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.393s)
[268.486248] Starting dynamic subtest: pipe-B-HDMI-A-1
[270.875195] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.401s)
[270.876924] Subtest cursor-offscreen-128x128: SUCCESS (4.831s)
[271.400166] [054/131] (753s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[271.701105] Starting subtest: x-tiled-8bpp-rotate-90
[271.720315] Subtest x-tiled-8bpp-rotate-90: SKIP (0.018s)
[272.150681] [055/131] (752s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[272.205210] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[272.310508] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[272.433479] [056/131] (752s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[272.732973] Starting subtest: 4-tiled-32bpp-rotate-90
[272.734274] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[273.146877] [057/131] (751s left) core_setmaster (master-drop-set-shared-fd)
[273.302423] Starting subtest: master-drop-set-shared-fd
[273.332797] Subtest master-drop-set-shared-fd: SUCCESS (0.031s)
[273.384835] [058/131] (751s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[273.676673] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[273.677797] Starting dynamic subtest: AB-VGA1-HDMI-A1
[275.236721] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.558s)
[275.237334] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (1.561s)
[275.765548] [059/131] (749s left) syncobj_wait (single-wait-all-submitted)
[275.821592] Starting subtest: single-wait-all-submitted
[275.926699] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[276.049656] [060/131] (749s left) kms_big_fb (linear-64bpp-rotate-270)
[276.352781] Starting subtest: linear-64bpp-rotate-270
[276.368404] Subtest linear-64bpp-rotate-270: SKIP (0.016s)
[276.799125] [061/131] (748s left) gem_exec_params (invalid-fence-in-submit)
[276.855422] Starting subtest: invalid-fence-in-submit
[276.857481] Subtest invalid-fence-in-submit: SUCCESS (0.001s)
[277.029512] [062/131] (748s left) syncobj_wait (single-wait-for-submit-submitted)
[277.085796] Starting subtest: single-wait-for-submit-submitted
[277.190502] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[277.315120] [063/131] (747s left) prime_vgem (fence-write-hang)
[277.389129] Subtest fence-write-hang: SKIP (0.000s)
[277.532510] [064/131] (747s left) syncobj_timeline (single-wait-signaled)
[277.585972] Starting subtest: single-wait-signaled
[277.586710] Subtest single-wait-signaled: SUCCESS (0.000s)
[277.715093] [065/131] (747s left) kms_chamelium_edid (vga-edid-read)
[278.081317] Subtest vga-edid-read: SKIP (0.000s)
[278.384673] [066/131] (746s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[278.680737] Starting subtest: 2x-long-flip-vs-cursor-atomic
[278.682940] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[279.094020] [067/131] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[279.392723] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[281.337372] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.945s)
[281.782586] [068/131] (743s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[282.076274] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[284.048443] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.972s)
[284.496221] [069/131] (741s left) prime_vgem (basic-read)
[284.571595] Starting subtest: basic-read
[284.589642] Subtest basic-read: SUCCESS (0.018s)
[284.731489] [070/131] (740s left) gem_userptr_blits (vma-merge)
[284.811998] Starting subtest: vma-merge
[284.896910] Subtest vma-merge: SUCCESS (0.085s)
[285.046482] [071/131] (740s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[285.347291] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[285.348648] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[285.759520] [072/131] (739s left) kms_vrr (negative-basic)
[286.051906] Starting subtest: negative-basic
[286.053792] Subtest negative-basic: SKIP (0.000s)
[286.457684] [073/131] (739s left) gem_exec_reloc (basic-cpu-read-active)
[286.514164] Starting subtest: basic-cpu-read-active
[286.623832] Subtest basic-cpu-read-active: SUCCESS (0.109s)
[287.276861] [074/131] (738s left) kms_chamelium_hpd (hdmi-hpd)
[287.642695] Subtest hdmi-hpd: SKIP (0.000s)
[287.944164] [075/131] (737s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[288.243780] Starting subtest: yf-tiled-16bpp-rotate-0
[288.245140] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[288.660436] [076/131] (737s left) syncobj_timeline (reset-signaled)
[288.714422] Starting subtest: reset-signaled
[288.715015] Subtest reset-signaled: SUCCESS (0.000s)
[288.830439] [077/131] (737s left) kms_psr (fbc-psr2-basic)
[289.119144] Subtest fbc-psr2-basic: SKIP (0.000s)
[289.312961] [078/131] (736s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[289.609966] Starting subtest: primary-yf-tiled-reflect-x-0
[289.611183] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.001s)
[290.017907] [079/131] (735s left) kms_prop_blob (basic)
[290.072496] Starting subtest: basic
[290.072936] Subtest basic: SUCCESS (0.000s)
[290.196336] [080/131] (735s left) vgem_basic (debugfs)
[290.267966] Starting subtest: debugfs
[290.268634] Subtest debugfs: SUCCESS (0.001s)
[290.380728] [081/131] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[290.679972] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[290.681188] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[291.095363] [082/131] (735s left) gem_userptr_blits (unsync-unmap-cycles)
[291.154145] Subtest unsync-unmap-cycles: SKIP (0.000s)
[291.328510] [083/131] (734s left) perf_pmu (busy-double-start)
[291.385034] Starting subtest: busy-double-start
[291.385677] Starting dynamic subtest: rcs0
[294.933442] Dynamic subtest rcs0: SUCCESS (3.548s)
[294.947647] Starting dynamic subtest: bcs0
[298.453306] Dynamic subtest bcs0: SUCCESS (3.517s)
[298.467554] Starting dynamic subtest: vcs0
[302.471536] Dynamic subtest vcs0: SUCCESS (4.015s)
[302.474619] Subtest busy-double-start: SUCCESS (11.089s)
[302.607206] [084/131] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[302.900567] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[302.901836] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[303.306947] [085/131] (723s left) kms_chamelium_color (ctm-negative)
[303.604934] Subtest ctm-negative: SKIP (0.000s)
[303.803344] [086/131] (722s left) kms_async_flips (async-flip-dpms)
[304.100279] Starting subtest: async-flip-dpms
[304.241198] Starting dynamic subtest: pipe-A-HDMI-A-1
[316.432825] Dynamic subtest pipe-A-HDMI-A-1: SKIP (12.190s)
[316.594460] Starting dynamic subtest: pipe-B-HDMI-A-1
[328.731600] Dynamic subtest pipe-B-HDMI-A-1: SKIP (12.146s)
[328.733478] Subtest async-flip-dpms: SKIP (24.633s)
[329.393706] [087/131] (697s left) gem_busy (semaphore)
[329.579140] Subtest semaphore: SKIP (0.000s)
[329.842153] [088/131] (696s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[330.128929] Starting subtest: flip-vs-dpms-off-vs-modeset
[330.129633] Starting dynamic subtest: A-VGA1
[330.918387] Dynamic subtest A-VGA1: SUCCESS (0.789s)
[330.931202] Starting dynamic subtest: B-VGA1
[331.626311] Dynamic subtest B-VGA1: SUCCESS (0.705s)
[331.638224] Starting dynamic subtest: A-HDMI-A1
[332.406628] Dynamic subtest A-HDMI-A1: SUCCESS (0.778s)
[332.421857] Starting dynamic subtest: B-HDMI-A1
[333.202233] Dynamic subtest B-HDMI-A1: SUCCESS (0.794s)
[333.202762] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.075s)
[333.733688] [089/131] (692s left) prime_mmap (test_reprime)
[333.792519] Starting subtest: test_reprime
[333.793096] Starting dynamic subtest: test_reprime-smem
[333.795204] Dynamic subtest test_reprime-smem: SUCCESS (0.003s)
[333.796890] Subtest test_reprime: SUCCESS (0.004s)
[333.948455] [090/131] (692s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[334.241912] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[334.441613] [091/131] (692s left) gem_exec_whisper (basic-fds)
[334.508536] Starting subtest: basic-fds
[337.265018] Subtest basic-fds: SUCCESS (2.756s)
[337.511954] [092/131] (689s left) gem_ctx_param (set-priority-range)
[337.565958] Subtest set-priority-range: SKIP (0.000s)
[337.688905] [093/131] (689s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[337.741723] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.000s)
[337.803525] [094/131] (688s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[337.856673] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[337.918748] [095/131] (688s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[338.222664] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[338.223927] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[338.639428] [096/131] (688s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[338.691068] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[338.751542] [097/131] (688s left) i915_selftest (mock)
[339.636862] Starting subtest: mock
[339.637682] Starting dynamic subtest: sanitycheck
[340.813776] Dynamic subtest sanitycheck: SUCCESS (1.176s)
[340.826381] Starting dynamic subtest: shmem
[341.937513] Dynamic subtest shmem: SUCCESS (1.122s)
[341.949961] Starting dynamic subtest: fence
[350.023570] Dynamic subtest fence: SUCCESS (8.084s)
[350.035579] Starting dynamic subtest: scatterlist
[352.160580] Dynamic subtest scatterlist: SUCCESS (2.135s)
[352.173764] Starting dynamic subtest: syncmap
[355.395813] Dynamic subtest syncmap: SUCCESS (3.233s)
[355.414024] Starting dynamic subtest: uncore
[356.551547] Dynamic subtest uncore: SUCCESS (1.153s)
[356.563817] Starting dynamic subtest: ring
[357.706706] Dynamic subtest ring: SUCCESS (1.153s)
[357.719346] Starting dynamic subtest: engine
[358.880741] Dynamic subtest engine: SUCCESS (1.172s)
[358.897642] Starting dynamic subtest: timelines
[365.124779] Dynamic subtest timelines: SUCCESS (6.241s)
[365.137631] Starting dynamic subtest: requests
[368.435708] Dynamic subtest requests: SUCCESS (3.309s)
[368.448773] Starting dynamic subtest: objects
[369.725832] Dynamic subtest objects: SUCCESS (1.288s)
[369.738437] Starting dynamic subtest: phys
[371.040703] Dynamic subtest phys: SUCCESS (1.313s)
[371.053214] Starting dynamic subtest: dmabuf
[372.327736] Dynamic subtest dmabuf: SUCCESS (1.285s)
[372.340675] Starting dynamic subtest: vma
[384.004703] Dynamic subtest vma: SUCCESS (11.675s)
[384.017099] Starting dynamic subtest: evict
[386.614616] Dynamic subtest evict: SUCCESS (2.608s)
[386.626634] Starting dynamic subtest: gtt
[391.052625] Dynamic subtest gtt: SUCCESS (4.436s)
[391.065769] Starting dynamic subtest: hugepages
[392.588532] Dynamic subtest hugepages: SUCCESS (1.534s)
[392.601441] Starting dynamic subtest: memory_region
[397.721935] Dynamic subtest memory_region: SUCCESS (5.131s)
[397.724224] Subtest mock: SUCCESS (58.087s)
[397.760291] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[397.761573] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[397.763747] [098/131] (629s left) gem_ctx_exec (basic-close-race)
[399.666269] Starting subtest: basic-close-race
[405.230256] Subtest basic-close-race: SUCCESS (5.563s)
[405.324906] [FACT gem_ctx_exec (basic-close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[405.326543] [FACT gem_ctx_exec (basic-close-race)] new: kernel.kmod_is_loaded.i915: true
[405.330181] [099/131] (621s left) prime_busy (after)
[405.392901] Starting subtest: after
[405.399124] Starting dynamic subtest: rcs0
[405.420013] Dynamic subtest rcs0: SUCCESS (0.021s)
[405.434607] Starting dynamic subtest: bcs0
[405.437123] Dynamic subtest bcs0: SUCCESS (0.016s)
[405.455545] Starting dynamic subtest: vcs0
[405.459675] Dynamic subtest vcs0: SUCCESS (0.021s)
[405.567200] Subtest after: SUCCESS (0.175s)
[405.705177] [100/131] (621s left) syncobj_wait (reset-signaled)
[405.761669] Starting subtest: reset-signaled
[405.762190] Subtest reset-signaled: SUCCESS (0.001s)
[405.893139] [101/131] (621s left) kms_dsc (dsc-basic)
[406.197516] Subtest dsc-basic: SKIP (0.000s)
[406.387334] [102/131] (620s left) vgem_basic (bad-flag)
[406.447899] Starting subtest: bad-flag
[406.448515] Subtest bad-flag: SUCCESS (0.000s)
[406.562721] [103/131] (620s left) kms_psr (psr2-sprite-mmap-gtt)
[406.854185] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[407.055716] [104/131] (620s left) gem_exec_balancer (noheartbeat)
[407.116130] Subtest noheartbeat: SKIP (0.000s)
[407.243594] [105/131] (620s left) gem_tiled_wb
[415.991383] [106/131] (611s left) gem_exec_reloc (basic-softpin)
[416.052977] Starting subtest: basic-softpin
[416.054635] Subtest basic-softpin: SUCCESS (0.002s)
[416.708328] [107/131] (610s left) gem_pxp (hw-rejects-pxp-buffer)
[419.279220] Starting subtest: hw-rejects-pxp-buffer
[419.279818] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[419.417418] [108/131] (608s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[419.712975] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[419.914329] [109/131] (607s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[420.210750] Starting subtest: 2x-cursor-vs-flip-legacy
[420.211917] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[420.618788] [110/131] (606s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[420.914943] Starting subtest: multiplane-rotation-cropping-bottom
[420.916202] Subtest multiplane-rotation-cropping-bottom: SKIP (0.000s)
[421.333077] [111/131] (606s left) gem_userptr_blits (sync-overlap)
[421.406029] Starting subtest: sync-overlap
[421.406678] Subtest sync-overlap: SUCCESS (0.000s)
[421.564549] [112/131] (606s left) kms_feature_discovery (psr2)
[421.852560] Starting subtest: psr2
[421.853714] Subtest psr2: SKIP (0.000s)
[422.262819] [113/131] (605s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[422.554932] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[422.556238] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[422.962427] [114/131] (604s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[423.266887] Starting subtest: y-tiled-32bpp-rotate-0
[423.268222] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[423.676467] [115/131] (604s left) gem_mmap_gtt (basic-small-bo)
[423.730783] Starting subtest: basic-small-bo
[424.639775] Subtest basic-small-bo: SUCCESS (0.909s)
[424.811439] [116/131] (603s left) api_intel_bb (simple-bb)
[424.958714] Starting subtest: simple-bb
[424.961363] Subtest simple-bb: SUCCESS (0.003s)
[425.126871] [117/131] (602s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[425.431852] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[425.432544] Starting dynamic subtest: pipe-A
[425.434224] Dynamic subtest pipe-A: SKIP (0.001s)
[425.446360] Starting dynamic subtest: pipe-B
[425.448569] Dynamic subtest pipe-B: SKIP (0.001s)
[425.450349] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.005s)
[425.842140] [118/131] (602s left) kms_lease (lease-unleased-connector)
[426.140334] Starting subtest: lease-unleased-connector
[426.142218] Starting dynamic subtest: pipe-A-HDMI-A-1
[426.202269] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.059s)
[426.216283] Starting dynamic subtest: pipe-B-HDMI-A-1
[426.263249] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.057s)
[426.263843] Subtest lease-unleased-connector: SUCCESS (0.123s)
[426.670750] [119/131] (601s left) gen9_exec_parse (bb-secure)
[426.728609] Subtest bb-secure: SKIP (0.000s)
[426.784593] [120/131] (601s left) vgem_basic (mmap)
[426.839329] Starting subtest: mmap
[426.851378] Subtest mmap: SUCCESS (0.013s)
[426.969581] [121/131] (601s left) gem_eio (in-flight-contexts-10ms)
[427.036923] Starting subtest: in-flight-contexts-10ms
[430.454575] Subtest in-flight-contexts-10ms: SUCCESS (3.419s)
[431.118288] [122/131] (597s left) i915_pm_rpm (debugfs-forcewake-user)
[442.674919] Subtest debugfs-forcewake-user: SKIP (0.000s)
[442.882954] [123/131] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[443.177037] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[443.178211] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[443.590230] [124/131] (584s left) kms_psr (fbc-pr-no-drrs)
[443.877723] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[444.079514] [125/131] (584s left) kms_invalid_mode (bad-htotal)
[444.372559] Starting subtest: bad-htotal
[444.373202] Starting dynamic subtest: pipe-A-HDMI-A-1
[444.453387] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.080s)
[444.466893] Starting dynamic subtest: pipe-B-HDMI-A-1
[444.467611] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[444.468321] Subtest bad-htotal: SUCCESS (0.085s)
[444.993822] [126/131] (583s left) kms_cursor_crc (cursor-random-128x42)
[445.293699] Starting subtest: cursor-random-128x42
[445.383847] Subtest cursor-random-128x42: SKIP (0.088s)
[445.804266] [127/131] (582s left) gem_linear_blits (interruptible)
[445.956129] Starting subtest: interruptible
[447.928255] Subtest interruptible: SUCCESS (1.974s)
[448.086348] [128/131] (580s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[448.454176] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[448.456404] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[448.867713] [129/131] (579s left) i915_hangman (engine-engine-error)
[448.930905] Subtest engine-engine-error: SKIP (0.000s)
[449.012572] [130/131] (579s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[449.305842] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[449.306942] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[449.714541] [131/131] (578s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[450.006498] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[450.007126] Starting dynamic subtest: pipe-A
[450.008625] Dynamic subtest pipe-A: SKIP (0.001s)
[450.021248] Starting dynamic subtest: pipe-B
[450.022688] Dynamic subtest pipe-B: SKIP (0.001s)
[450.023798] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.005s)
[450.429083] 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.