[69.674853] Initializing watchdogs
[69.675000]   /dev/watchdog0
[69.694823] [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)
[69.702558] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.706680] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.709730] [001/131] (960s left) vgem_slow (nohang)
[69.824993] Starting subtest: nohang
[79.975438] Subtest nohang: SUCCESS (10.146s)
[80.083503] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[80.085985] [002/131] (950s left) gem_userptr_blits (unsync-overlap)
[80.146341] Subtest unsync-overlap: SKIP (0.000s)
[80.302394] [003/131] (949s left) gem_exec_schedule (u-fairslice-all)
[80.366776] Subtest u-fairslice-all: SKIP (0.000s)
[80.600276] [004/131] (949s left) gem_lmem_swapping (parallel-random)
[80.653092] Subtest parallel-random: SKIP (0.000s)
[80.711739] [005/131] (949s left) kms_sequence (queue-idle)
[81.007116] Starting subtest: queue-idle
[81.007816] Starting dynamic subtest: pipe-A-HDMI-A-1
[83.389702] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.381s)
[83.398487] Starting dynamic subtest: pipe-B-HDMI-A-1
[85.632657] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.242s)
[85.633310] Subtest queue-idle: SUCCESS (4.626s)
[86.164543] [006/131] (944s left) gem_exec_schedule (lateslice)
[86.236417] Subtest lateslice: SKIP (0.000s)
[86.464669] [007/131] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[86.758145] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[86.759215] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[87.161562] [008/131] (943s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[87.478624] Starting subtest: syncobj-timeline-invalid-wait
[87.480757] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s)
[87.764710] [009/131] (942s left) gem_exec_params (no-vebox)
[87.819958] Starting subtest: no-vebox
[87.820954] Subtest no-vebox: SUCCESS (0.000s)
[87.977201] [010/131] (942s left) gem_exec_balancer (parallel-contexts)
[88.030755] Subtest parallel-contexts: SKIP (0.000s)
[88.162285] [011/131] (942s left) kms_pm_rpm (legacy-planes-dpms)
[99.697565] Subtest legacy-planes-dpms: SKIP (0.000s)
[99.898202] [012/131] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[100.191167] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[100.192245] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[100.602685] [013/131] (930s left) kms_cursor_edge_walk (64x64-left-edge)
[100.894179] Starting subtest: 64x64-left-edge
[100.894900] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.319690] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.425s)
[104.329462] Starting dynamic subtest: pipe-B-HDMI-A-1
[107.650298] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.329s)
[107.650983] Subtest 64x64-left-edge: SUCCESS (6.757s)
[108.170527] [014/131] (922s left) gem_mmap_offset (open-flood)
[108.224996] Starting subtest: open-flood
[129.737284] Subtest open-flood: SUCCESS (21.512s)
[129.880286] [015/131] (900s left) gem_spin_batch (spin-each)
[129.952719] Starting subtest: spin-each
[133.287798] Subtest spin-each: SUCCESS (3.335s)
[133.557262] [016/131] (897s left) gem_ctx_persistence (saturated-hostile)
[133.614753] Subtest saturated-hostile: SKIP (0.000s)
[133.679944] [017/131] (897s left) gem_ctx_shared (q-independent)
[133.733804] Subtest Q-independent: SKIP (0.000s)
[133.856371] [018/131] (897s left) kms_psr (fbc-psr-primary-render)
[134.143829] Subtest fbc-psr-primary-render: SKIP (0.000s)
[134.344074] [019/131] (896s left) perf_pmu (rc6-all-gts)
[134.400541] Starting subtest: rc6-all-gts
[134.401865] Subtest rc6-all-gts: SKIP (0.000s)
[134.535275] [020/131] (896s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[134.591463] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.000s)
[134.642773] [021/131] (896s left) gem_pxp (create-regular-context-1)
[137.211970] Starting subtest: create-regular-context-1
[137.213253] Subtest create-regular-context-1: SKIP (0.000s)
[137.331202] [022/131] (893s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[137.393261] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[137.394820] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[137.627073] [023/131] (893s left) syncobj_timeline (host-signal-points)
[137.681549] Starting subtest: host-signal-points
[137.692416] Subtest host-signal-points: SUCCESS (0.011s)
[137.809445] [024/131] (893s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[137.864817] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[137.923547] [025/131] (893s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[138.223041] Starting subtest: stress-xrgb8888-xtiled
[145.376659] Subtest stress-xrgb8888-xtiled: SUCCESS (7.153s)
[145.751609] [026/131] (885s left) kms_async_flips (test-time-stamp)
[146.051895] Starting subtest: test-time-stamp
[146.200830] Starting dynamic subtest: pipe-A-HDMI-A-1
[146.391288] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.189s)
[146.550248] Starting dynamic subtest: pipe-B-HDMI-A-1
[146.676230] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.133s)
[146.677202] Subtest test-time-stamp: SUCCESS (0.626s)
[147.338569] [027/131] (884s left) prime_self_import (basic-with_two_bos)
[147.390688] Starting subtest: basic-with_two_bos
[147.394205] Subtest basic-with_two_bos: SUCCESS (0.004s)
[147.537486] [028/131] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[147.840154] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[147.841178] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[148.252499] [029/131] (883s left) gem_mmap_gtt (close-race)
[148.306763] Starting subtest: close-race
[168.400735] Subtest close-race: SUCCESS (20.092s)
[168.549097] [030/131] (863s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[168.845376] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[170.793535] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.948s)
[171.256490] [031/131] (860s left) gen9_exec_parse (valid-registers)
[171.312140] Subtest valid-registers: SKIP (0.000s)
[171.370613] [032/131] (860s left) kms_color (legacy-gamma-reset)
[171.663775] Starting subtest: legacy-gamma-reset
[171.664557] Starting dynamic subtest: pipe-A-HDMI-A-1
[171.811930] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.148s)
[171.822559] Starting dynamic subtest: pipe-B-HDMI-A-1
[171.823109] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.005s)
[171.823623] Subtest legacy-gamma-reset: SUCCESS (0.156s)
[172.333170] [033/131] (859s left) gem_partial_pwrite_pread (reads-snoop)
[172.394643] Starting subtest: reads-snoop
[173.553537] Subtest reads-snoop: SUCCESS (1.160s)
[173.713077] [034/131] (858s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[174.013338] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[174.014374] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[174.433928] [035/131] (857s left) gem_exec_reloc (basic-gtt-noreloc)
[174.490366] Starting subtest: basic-gtt-noreloc
[174.493473] Subtest basic-gtt-noreloc: SUCCESS (0.003s)
[175.150228] [036/131] (856s left) syncobj_timeline (invalid-transfer-illegal-handle)
[175.206401] Starting subtest: invalid-transfer-illegal-handle
[175.207182] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[175.326790] [037/131] (856s left) gem_ctx_param (invalid-get-engines)
[175.384470] Starting subtest: invalid-get-engines
[175.385159] Subtest invalid-get-engines: SUCCESS (0.000s)
[175.508347] [038/131] (856s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[175.801734] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[175.802834] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[176.207440] [039/131] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[176.499486] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[176.500534] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[176.923827] [040/131] (855s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[177.222295] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[177.223724] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[177.643500] [041/131] (854s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[177.698660] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[177.765468] [042/131] (854s left) kms_plane_cursor (primary)
[178.054864] Starting subtest: primary
[178.056199] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[180.468443] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.412s)
[180.512896] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[182.946420] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.443s)
[182.992736] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[185.408299] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.427s)
[185.533978] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[188.032856] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.507s)
[188.078963] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[190.511202] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.443s)
[190.556303] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[192.989344] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.444s)
[193.106179] Subtest primary: SUCCESS (15.051s)
[193.609379] [043/131] (838s left) kms_flip (dpms-off-confusion-interruptible)
[193.906918] Starting subtest: dpms-off-confusion-interruptible
[193.908861] Starting dynamic subtest: A-VGA1
[201.627853] Dynamic subtest A-VGA1: SUCCESS (7.718s)
[201.639620] Starting dynamic subtest: B-VGA1
[209.330795] Dynamic subtest B-VGA1: SUCCESS (7.699s)
[209.342409] Starting dynamic subtest: A-HDMI-A1
[217.069942] Dynamic subtest A-HDMI-A1: SUCCESS (7.736s)
[217.082590] Starting dynamic subtest: B-HDMI-A1
[224.822194] Dynamic subtest B-HDMI-A1: SUCCESS (7.749s)
[224.826030] Subtest dpms-off-confusion-interruptible: SUCCESS (30.917s)
[225.423656] [044/131] (806s left) kms_cursor_edge_walk (256x256-top-bottom)
[225.719547] Starting subtest: 256x256-top-bottom
[225.720312] Starting dynamic subtest: pipe-A-HDMI-A-1
[229.158092] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.437s)
[229.168913] Starting dynamic subtest: pipe-B-HDMI-A-1
[232.486760] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.327s)
[232.487392] Subtest 256x256-top-bottom: SUCCESS (6.769s)
[233.001656] [045/131] (799s left) kms_psr (pr-sprite-plane-onoff)
[233.294203] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[233.491717] [046/131] (798s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[233.784019] Starting subtest: short-flip-before-cursor-toggle
[234.767776] Subtest short-flip-before-cursor-toggle: SUCCESS (0.982s)
[235.288565] [047/131] (797s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[235.591112] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[235.592932] Starting dynamic subtest: A-VGA1
[243.632967] Dynamic subtest A-VGA1: SUCCESS (8.040s)
[243.645514] Starting dynamic subtest: B-VGA1
[251.624731] Dynamic subtest B-VGA1: SUCCESS (7.988s)
[251.638289] Starting dynamic subtest: A-HDMI-A1
[259.801194] Dynamic subtest A-HDMI-A1: SUCCESS (8.174s)
[259.814095] Starting dynamic subtest: B-HDMI-A1
[267.989224] Dynamic subtest B-HDMI-A1: SUCCESS (8.184s)
[267.992262] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.400s)
[268.572890] [048/131] (763s left) gem_exec_params (secure-non-master)
[268.630085] Starting subtest: secure-non-master
[268.631359] Subtest secure-non-master: SKIP (0.000s)
[268.773404] [049/131] (763s left) kms_flip (2x-flip-vs-dpms)
[269.064910] Starting subtest: 2x-flip-vs-dpms
[269.066040] Starting dynamic subtest: AB-VGA1-HDMI-A1
[271.457707] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.391s)
[271.458216] Subtest 2x-flip-vs-dpms: SUCCESS (2.394s)
[272.007129] [050/131] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[272.307925] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[272.308929] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[272.704795] [051/131] (759s left) drm_read (fault-buffer)
[273.043617] Starting subtest: fault-buffer
[273.044290] Subtest fault-buffer: SUCCESS (0.001s)
[273.493354] [052/131] (759s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[273.560303] Starting subtest: basic-batch-kernel-default-cmd
[273.561745] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[273.786495] [053/131] (758s left) kms_cursor_crc (cursor-offscreen-128x128)
[274.080810] Starting subtest: cursor-offscreen-128x128
[274.083229] Starting dynamic subtest: pipe-A-HDMI-A-1
[276.468316] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.383s)
[276.505971] Starting dynamic subtest: pipe-B-HDMI-A-1
[278.905663] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.408s)
[278.906203] Subtest cursor-offscreen-128x128: SUCCESS (4.825s)
[279.424823] [054/131] (753s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[279.727951] Starting subtest: x-tiled-8bpp-rotate-90
[279.743761] Subtest x-tiled-8bpp-rotate-90: SKIP (0.015s)
[280.173593] [055/131] (752s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[280.230614] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[280.334451] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[280.457315] [056/131] (752s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[280.765042] Starting subtest: 4-tiled-32bpp-rotate-90
[280.766327] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[281.171135] [057/131] (751s left) core_setmaster (master-drop-set-shared-fd)
[281.324745] Starting subtest: master-drop-set-shared-fd
[281.356435] Subtest master-drop-set-shared-fd: SUCCESS (0.032s)
[281.403960] [058/131] (751s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[281.689751] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[281.691241] Starting dynamic subtest: AB-VGA1-HDMI-A1
[283.321561] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.630s)
[283.322080] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (1.633s)
[283.849472] [059/131] (749s left) syncobj_wait (single-wait-all-submitted)
[283.905838] Starting subtest: single-wait-all-submitted
[284.014493] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[284.153184] [060/131] (748s left) kms_big_fb (linear-64bpp-rotate-270)
[284.452084] Starting subtest: linear-64bpp-rotate-270
[284.468388] Subtest linear-64bpp-rotate-270: SKIP (0.015s)
[284.897748] [061/131] (748s left) gem_exec_params (invalid-fence-in-submit)
[284.956850] Starting subtest: invalid-fence-in-submit
[284.959186] Subtest invalid-fence-in-submit: SUCCESS (0.001s)
[285.128728] [062/131] (748s left) syncobj_wait (single-wait-for-submit-submitted)
[285.185388] Starting subtest: single-wait-for-submit-submitted
[285.286518] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s)
[285.415548] [063/131] (747s left) prime_vgem (fence-write-hang)
[285.489237] Subtest fence-write-hang: SKIP (0.000s)
[285.631822] [064/131] (747s left) syncobj_timeline (single-wait-signaled)
[285.687622] Starting subtest: single-wait-signaled
[285.688407] Subtest single-wait-signaled: SUCCESS (0.000s)
[285.813494] [065/131] (747s left) kms_chamelium_edid (vga-edid-read)
[286.182372] Subtest vga-edid-read: SKIP (0.000s)
[286.489410] [066/131] (746s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[286.784328] Starting subtest: 2x-long-flip-vs-cursor-atomic
[286.786708] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[287.196712] [067/131] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[287.492833] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[289.476162] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.984s)
[289.915384] [068/131] (743s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[290.216842] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[292.153938] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.937s)
[292.602516] [069/131] (740s left) prime_vgem (basic-read)
[292.676181] Starting subtest: basic-read
[292.694287] Subtest basic-read: SUCCESS (0.017s)
[292.832073] [070/131] (740s left) gem_userptr_blits (vma-merge)
[292.911920] Starting subtest: vma-merge
[292.993967] Subtest vma-merge: SUCCESS (0.082s)
[293.166370] [071/131] (740s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[293.470685] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[293.471833] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[293.880584] [072/131] (739s left) kms_vrr (negative-basic)
[294.171308] Starting subtest: negative-basic
[294.175536] Subtest negative-basic: SKIP (0.000s)
[294.579639] [073/131] (739s left) gem_exec_reloc (basic-cpu-read-active)
[294.639017] Starting subtest: basic-cpu-read-active
[294.748063] Subtest basic-cpu-read-active: SUCCESS (0.109s)
[295.394888] [074/131] (738s left) kms_chamelium_hpd (hdmi-hpd)
[295.764200] Subtest hdmi-hpd: SKIP (0.000s)
[296.067814] [075/131] (737s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[296.372889] Starting subtest: yf-tiled-16bpp-rotate-0
[296.373987] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[296.774480] [076/131] (737s left) syncobj_timeline (reset-signaled)
[296.829948] Starting subtest: reset-signaled
[296.830672] Subtest reset-signaled: SUCCESS (0.000s)
[296.956182] [077/131] (736s left) kms_psr (fbc-psr2-basic)
[297.249212] Subtest fbc-psr2-basic: SKIP (0.000s)
[297.448893] [078/131] (736s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[297.743454] Starting subtest: primary-yf-tiled-reflect-x-0
[297.744768] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.001s)
[298.152269] [079/131] (735s left) kms_prop_blob (basic)
[298.205335] Starting subtest: basic
[298.205840] Subtest basic: SUCCESS (0.000s)
[298.335277] [080/131] (735s left) vgem_basic (debugfs)
[298.389817] Starting subtest: debugfs
[298.390485] Subtest debugfs: SUCCESS (0.001s)
[298.501386] [081/131] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[298.800444] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[298.801544] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[299.203330] [082/131] (734s left) gem_userptr_blits (unsync-unmap-cycles)
[299.264804] Subtest unsync-unmap-cycles: SKIP (0.000s)
[299.433526] [083/131] (734s left) perf_pmu (busy-double-start)
[299.487815] Starting subtest: busy-double-start
[299.488579] Starting dynamic subtest: rcs0
[303.035384] Dynamic subtest rcs0: SUCCESS (3.548s)
[303.057252] Starting dynamic subtest: bcs0
[306.562287] Dynamic subtest bcs0: SUCCESS (3.524s)
[306.576076] Starting dynamic subtest: vcs0
[310.582534] Dynamic subtest vcs0: SUCCESS (4.017s)
[310.585713] Subtest busy-double-start: SUCCESS (11.097s)
[310.710848] [084/131] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[311.008490] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[311.009607] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[311.427695] [085/131] (722s left) kms_chamelium_color (ctm-negative)
[311.723562] Subtest ctm-negative: SKIP (0.000s)
[311.920875] [086/131] (722s left) kms_async_flips (async-flip-dpms)
[312.211891] Starting subtest: async-flip-dpms
[312.360112] Starting dynamic subtest: pipe-A-HDMI-A-1
[324.544563] Dynamic subtest pipe-A-HDMI-A-1: SKIP (12.183s)
[324.686811] Starting dynamic subtest: pipe-B-HDMI-A-1
[336.819903] Dynamic subtest pipe-B-HDMI-A-1: SKIP (12.141s)
[336.821523] Subtest async-flip-dpms: SKIP (24.610s)
[337.497780] [087/131] (696s left) gem_busy (semaphore)
[337.685361] Subtest semaphore: SKIP (0.000s)
[337.944662] [088/131] (696s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[338.240543] Starting subtest: flip-vs-dpms-off-vs-modeset
[338.241632] Starting dynamic subtest: A-VGA1
[339.023506] Dynamic subtest A-VGA1: SUCCESS (0.782s)
[339.035959] Starting dynamic subtest: B-VGA1
[339.714699] Dynamic subtest B-VGA1: SUCCESS (0.689s)
[339.726619] Starting dynamic subtest: A-HDMI-A1
[340.491974] Dynamic subtest A-HDMI-A1: SUCCESS (0.775s)
[340.502825] Starting dynamic subtest: B-HDMI-A1
[341.278800] Dynamic subtest B-HDMI-A1: SUCCESS (0.785s)
[341.279526] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.039s)
[341.811259] [089/131] (692s left) prime_mmap (test_reprime)
[341.870691] Starting subtest: test_reprime
[341.871327] Starting dynamic subtest: test_reprime-smem
[341.873820] Dynamic subtest test_reprime-smem: SUCCESS (0.003s)
[341.875743] Subtest test_reprime: SUCCESS (0.005s)
[342.008429] [090/131] (692s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[342.300129] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[342.500515] [091/131] (692s left) gem_exec_whisper (basic-fds)
[342.564510] Starting subtest: basic-fds
[345.377118] Subtest basic-fds: SUCCESS (2.811s)
[345.618397] [092/131] (689s left) gem_ctx_param (set-priority-range)
[345.670283] Subtest set-priority-range: SKIP (0.000s)
[345.803563] [093/131] (688s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[345.854902] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.000s)
[345.910566] [094/131] (688s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[345.962773] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[346.027868] [095/131] (688s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[346.326042] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[346.327304] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[346.731196] [096/131] (688s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[346.785740] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[346.844546] [097/131] (688s left) i915_selftest (mock)
[347.767912] Starting subtest: mock
[347.768708] Starting dynamic subtest: sanitycheck
[348.926584] Dynamic subtest sanitycheck: SUCCESS (1.158s)
[348.939063] Starting dynamic subtest: shmem
[350.063655] Dynamic subtest shmem: SUCCESS (1.135s)
[350.080329] Starting dynamic subtest: fence
[358.064651] Dynamic subtest fence: SUCCESS (7.998s)
[358.078929] Starting dynamic subtest: scatterlist
[360.258581] Dynamic subtest scatterlist: SUCCESS (2.191s)
[360.270753] Starting dynamic subtest: syncmap
[363.482808] Dynamic subtest syncmap: SUCCESS (3.222s)
[363.495034] Starting dynamic subtest: uncore
[364.640751] Dynamic subtest uncore: SUCCESS (1.156s)
[364.652885] Starting dynamic subtest: ring
[365.824535] Dynamic subtest ring: SUCCESS (1.182s)
[365.836755] Starting dynamic subtest: engine
[367.006681] Dynamic subtest engine: SUCCESS (1.180s)
[367.018961] Starting dynamic subtest: timelines
[373.248590] Dynamic subtest timelines: SUCCESS (6.240s)
[373.260541] Starting dynamic subtest: requests
[376.685596] Dynamic subtest requests: SUCCESS (3.435s)
[376.697848] Starting dynamic subtest: objects
[377.960704] Dynamic subtest objects: SUCCESS (1.273s)
[377.973328] Starting dynamic subtest: phys
[379.258561] Dynamic subtest phys: SUCCESS (1.296s)
[379.270626] Starting dynamic subtest: dmabuf
[380.545627] Dynamic subtest dmabuf: SUCCESS (1.285s)
[380.557788] Starting dynamic subtest: vma
[392.343748] Dynamic subtest vma: SUCCESS (11.796s)
[392.355599] Starting dynamic subtest: evict
[394.937699] Dynamic subtest evict: SUCCESS (2.592s)
[394.949999] Starting dynamic subtest: gtt
[399.302659] Dynamic subtest gtt: SUCCESS (4.363s)
[399.314907] Starting dynamic subtest: hugepages
[400.829702] Dynamic subtest hugepages: SUCCESS (1.525s)
[400.842272] Starting dynamic subtest: memory_region
[406.116621] Dynamic subtest memory_region: SUCCESS (5.285s)
[406.118777] Subtest mock: SUCCESS (58.350s)
[406.154853] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[406.156161] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[406.158528] [098/131] (628s left) gem_ctx_exec (basic-close-race)
[408.038480] Starting subtest: basic-close-race
[413.673581] Subtest basic-close-race: SUCCESS (5.635s)
[413.765537] [FACT gem_ctx_exec (basic-close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[413.767229] [FACT gem_ctx_exec (basic-close-race)] new: kernel.kmod_is_loaded.i915: true
[413.771121] [099/131] (621s left) prime_busy (after)
[413.833028] Starting subtest: after
[413.838926] Starting dynamic subtest: rcs0
[413.866736] Dynamic subtest rcs0: SUCCESS (0.028s)
[413.880249] Starting dynamic subtest: bcs0
[413.895664] Dynamic subtest bcs0: SUCCESS (0.027s)
[413.917691] Starting dynamic subtest: vcs0
[413.924572] Dynamic subtest vcs0: SUCCESS (0.027s)
[414.031981] Subtest after: SUCCESS (0.200s)
[414.153339] [100/131] (620s left) syncobj_wait (reset-signaled)
[414.207241] Starting subtest: reset-signaled
[414.207804] Subtest reset-signaled: SUCCESS (0.000s)
[414.336692] [101/131] (620s left) kms_dsc (dsc-basic)
[414.627235] Subtest dsc-basic: SKIP (0.000s)
[414.831137] [102/131] (620s left) vgem_basic (bad-flag)
[414.887937] Starting subtest: bad-flag
[414.888652] Subtest bad-flag: SUCCESS (0.000s)
[414.999746] [103/131] (620s left) kms_psr (psr2-sprite-mmap-gtt)
[415.286406] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[415.477779] [104/131] (619s left) gem_exec_balancer (noheartbeat)
[415.533258] Subtest noheartbeat: SKIP (0.000s)
[415.668313] [105/131] (619s left) gem_tiled_wb
[424.115642] [106/131] (611s left) gem_exec_reloc (basic-softpin)
[424.177600] Starting subtest: basic-softpin
[424.179011] Subtest basic-softpin: SUCCESS (0.002s)
[424.832838] [107/131] (610s left) gem_pxp (hw-rejects-pxp-buffer)
[427.401926] Starting subtest: hw-rejects-pxp-buffer
[427.402665] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[427.558431] [108/131] (607s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[427.856650] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[428.068267] [109/131] (607s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[428.362069] Starting subtest: 2x-cursor-vs-flip-legacy
[428.364271] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[428.771634] [110/131] (606s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[429.065922] Starting subtest: multiplane-rotation-cropping-bottom
[429.067086] Subtest multiplane-rotation-cropping-bottom: SKIP (0.000s)
[429.454291] [111/131] (606s left) gem_userptr_blits (sync-overlap)
[429.522088] Starting subtest: sync-overlap
[429.522795] Subtest sync-overlap: SUCCESS (0.000s)
[429.670282] [112/131] (605s left) kms_feature_discovery (psr2)
[429.959660] Starting subtest: psr2
[429.960886] Subtest psr2: SKIP (0.000s)
[430.387555] [113/131] (605s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[430.680858] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[430.682070] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[431.085677] [114/131] (604s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[431.387293] Starting subtest: y-tiled-32bpp-rotate-0
[431.388413] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[431.802049] [115/131] (604s left) gem_mmap_gtt (basic-small-bo)
[431.857520] Starting subtest: basic-small-bo
[432.655948] Subtest basic-small-bo: SUCCESS (0.798s)
[432.824887] [116/131] (603s left) api_intel_bb (simple-bb)
[432.967346] Starting subtest: simple-bb
[432.969123] Subtest simple-bb: SUCCESS (0.003s)
[433.117300] [117/131] (602s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[433.417226] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[433.417864] Starting dynamic subtest: pipe-A
[433.419670] Dynamic subtest pipe-A: SKIP (0.001s)
[433.431488] Starting dynamic subtest: pipe-B
[433.433490] Dynamic subtest pipe-B: SKIP (0.001s)
[433.434659] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.005s)
[433.832785] [118/131] (602s left) kms_lease (lease-unleased-connector)
[434.125666] Starting subtest: lease-unleased-connector
[434.126423] Starting dynamic subtest: pipe-A-HDMI-A-1
[434.185472] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.059s)
[434.202112] Starting dynamic subtest: pipe-B-HDMI-A-1
[434.247459] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.057s)
[434.248071] Subtest lease-unleased-connector: SUCCESS (0.122s)
[434.661796] [119/131] (601s left) gen9_exec_parse (bb-secure)
[434.726418] Subtest bb-secure: SKIP (0.000s)
[434.802184] [120/131] (601s left) vgem_basic (mmap)
[434.866016] Starting subtest: mmap
[434.876721] Subtest mmap: SUCCESS (0.012s)
[434.994859] [121/131] (601s left) gem_eio (in-flight-contexts-10ms)
[435.059100] Starting subtest: in-flight-contexts-10ms
[438.486259] Subtest in-flight-contexts-10ms: SUCCESS (3.427s)
[439.139939] [122/131] (597s left) i915_pm_rpm (debugfs-forcewake-user)
[450.692095] Subtest debugfs-forcewake-user: SKIP (0.000s)
[450.889562] [123/131] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[451.182275] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[451.183453] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[451.597085] [124/131] (584s left) kms_psr (fbc-pr-no-drrs)
[451.888174] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[452.088695] [125/131] (584s left) kms_invalid_mode (bad-htotal)
[452.386137] Starting subtest: bad-htotal
[452.386932] Starting dynamic subtest: pipe-A-HDMI-A-1
[452.462432] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.075s)
[452.475807] Starting dynamic subtest: pipe-B-HDMI-A-1
[452.476658] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[452.477650] Subtest bad-htotal: SUCCESS (0.080s)
[452.872826] [126/131] (583s left) kms_cursor_crc (cursor-random-128x42)
[453.174748] Starting subtest: cursor-random-128x42
[453.254743] Subtest cursor-random-128x42: SKIP (0.079s)
[453.671322] [127/131] (582s left) gem_linear_blits (interruptible)
[453.822439] Starting subtest: interruptible
[455.802799] Subtest interruptible: SUCCESS (1.980s)
[455.964646] [128/131] (580s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[456.332072] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[456.333865] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[456.749820] [129/131] (579s left) i915_hangman (engine-engine-error)
[456.817681] Subtest engine-engine-error: SKIP (0.000s)
[456.894279] [130/131] (579s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[457.190123] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[457.191240] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[457.599800] [131/131] (579s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[457.891796] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[457.892427] Starting dynamic subtest: pipe-A
[457.893974] Dynamic subtest pipe-A: SKIP (0.001s)
[457.906526] Starting dynamic subtest: pipe-B
[457.908157] Dynamic subtest pipe-B: SKIP (0.001s)
[457.909102] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.005s)
[458.313927] 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.