[68.700688] Initializing watchdogs
[68.700859]   /dev/watchdog0
[68.725506] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[68.733275] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.736800] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.739863] [001/131] (960s left) vgem_slow (nohang)
[68.839757] Starting subtest: nohang
[78.951494] Subtest nohang: SUCCESS (10.121s)
[79.067382] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[79.069834] [002/131] (950s left) gem_userptr_blits (unsync-overlap)
[79.131588] Subtest unsync-overlap: SKIP (0.000s)
[79.305235] [003/131] (950s left) gem_exec_schedule (u-fairslice-all)
[79.374725] Subtest u-fairslice-all: SKIP (0.000s)
[79.601515] [004/131] (949s left) gem_lmem_swapping (parallel-random)
[79.654401] Subtest parallel-random: SKIP (0.000s)
[79.714411] [005/131] (949s left) kms_sequence (queue-idle)
[80.015441] Starting subtest: queue-idle
[80.016190] Starting dynamic subtest: pipe-A-HDMI-A-1
[82.408381] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.393s)
[82.417876] Starting dynamic subtest: pipe-B-HDMI-A-1
[84.660110] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.250s)
[84.660677] Subtest queue-idle: SUCCESS (4.646s)
[85.192669] [006/131] (944s left) gem_exec_schedule (lateslice)
[85.262643] Subtest lateslice: SKIP (0.000s)
[85.485053] [007/131] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[85.783911] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[85.785166] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[86.184719] [008/131] (943s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[86.500046] Starting subtest: syncobj-timeline-invalid-wait
[86.501771] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s)
[86.777629] [009/131] (942s left) gem_exec_params (no-vebox)
[86.830909] Starting subtest: no-vebox
[86.831509] Subtest no-vebox: SUCCESS (0.000s)
[86.965974] [010/131] (942s left) gem_exec_balancer (parallel-contexts)
[87.023959] Subtest parallel-contexts: SKIP (0.000s)
[87.148145] [011/131] (942s left) kms_pm_rpm (legacy-planes-dpms)
[98.676058] Subtest legacy-planes-dpms: SKIP (0.000s)
[98.866749] [012/131] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[99.163582] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[99.164762] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[99.582769] [013/131] (930s left) kms_cursor_edge_walk (64x64-left-edge)
[99.880968] Starting subtest: 64x64-left-edge
[99.882138] Starting dynamic subtest: pipe-A-HDMI-A-1
[103.303176] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.420s)
[103.314583] Starting dynamic subtest: pipe-B-HDMI-A-1
[106.659962] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.356s)
[106.660654] Subtest 64x64-left-edge: SUCCESS (6.780s)
[107.184951] [014/131] (922s left) gem_mmap_offset (open-flood)
[107.238491] Starting subtest: open-flood
[128.746373] Subtest open-flood: SUCCESS (21.508s)
[128.895395] [015/131] (901s left) gem_spin_batch (spin-each)
[128.966257] Starting subtest: spin-each
[132.302913] Subtest spin-each: SUCCESS (3.337s)
[132.569747] [016/131] (897s left) gem_ctx_persistence (saturated-hostile)
[132.625237] Subtest saturated-hostile: SKIP (0.000s)
[132.678757] [017/131] (897s left) gem_ctx_shared (q-independent)
[132.732931] Subtest Q-independent: SKIP (0.000s)
[132.852217] [018/131] (897s left) kms_psr (fbc-psr-primary-render)
[133.149769] Subtest fbc-psr-primary-render: SKIP (0.000s)
[133.344251] [019/131] (896s left) perf_pmu (rc6-all-gts)
[133.401422] Starting subtest: rc6-all-gts
[133.402704] Subtest rc6-all-gts: SKIP (0.000s)
[133.531687] [020/131] (896s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[133.581966] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.000s)
[133.641977] [021/131] (896s left) gem_pxp (create-regular-context-1)
[136.211528] Starting subtest: create-regular-context-1
[136.212971] Subtest create-regular-context-1: SKIP (0.000s)
[136.346636] [022/131] (893s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[136.406148] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[136.407915] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[136.645302] [023/131] (893s left) syncobj_timeline (host-signal-points)
[136.700326] Starting subtest: host-signal-points
[136.712128] Subtest host-signal-points: SUCCESS (0.012s)
[136.840968] [024/131] (893s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[136.894995] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[136.954777] [025/131] (893s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[137.249975] Starting subtest: stress-xrgb8888-xtiled
[144.694093] Subtest stress-xrgb8888-xtiled: SUCCESS (7.444s)
[145.087542] [026/131] (885s left) kms_async_flips (test-time-stamp)
[145.381612] Starting subtest: test-time-stamp
[145.526869] Starting dynamic subtest: pipe-A-HDMI-A-1
[145.704324] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.176s)
[145.868973] Starting dynamic subtest: pipe-B-HDMI-A-1
[145.987538] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.131s)
[145.988577] Subtest test-time-stamp: SUCCESS (0.607s)
[146.648876] [027/131] (883s left) prime_self_import (basic-with_two_bos)
[146.700944] Starting subtest: basic-with_two_bos
[146.705624] Subtest basic-with_two_bos: SUCCESS (0.005s)
[146.849121] [028/131] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[147.146223] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[147.147416] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[147.548116] [029/131] (883s left) gem_mmap_gtt (close-race)
[147.602887] Starting subtest: close-race
[167.709396] Subtest close-race: SUCCESS (20.106s)
[167.839594] [030/131] (862s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[168.137877] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[170.088056] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.950s)
[170.550389] [031/131] (860s left) gen9_exec_parse (valid-registers)
[170.610937] Subtest valid-registers: SKIP (0.000s)
[170.667163] [032/131] (860s left) kms_color (legacy-gamma-reset)
[170.958482] Starting subtest: legacy-gamma-reset
[170.959338] Starting dynamic subtest: pipe-A-HDMI-A-1
[171.104058] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.146s)
[171.117210] Starting dynamic subtest: pipe-B-HDMI-A-1
[171.117834] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.007s)
[171.118536] Subtest legacy-gamma-reset: SUCCESS (0.156s)
[171.631182] [033/131] (859s left) gem_partial_pwrite_pread (reads-snoop)
[171.691955] Starting subtest: reads-snoop
[172.774660] Subtest reads-snoop: SUCCESS (1.082s)
[172.929740] [034/131] (857s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[173.227592] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[173.228541] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[173.641185] [035/131] (857s left) gem_exec_reloc (basic-gtt-noreloc)
[173.698753] Starting subtest: basic-gtt-noreloc
[173.700969] Subtest basic-gtt-noreloc: SUCCESS (0.003s)
[174.354391] [036/131] (856s left) syncobj_timeline (invalid-transfer-illegal-handle)
[174.416747] Starting subtest: invalid-transfer-illegal-handle
[174.417340] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[174.540068] [037/131] (856s left) gem_ctx_param (invalid-get-engines)
[174.593725] Starting subtest: invalid-get-engines
[174.594210] Subtest invalid-get-engines: SUCCESS (0.000s)
[174.725454] [038/131] (856s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[175.026884] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[175.027889] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[175.435385] [039/131] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[175.730915] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[175.731943] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[176.135522] [040/131] (855s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[176.430341] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[176.431391] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[176.835384] [041/131] (854s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[176.888943] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[176.942828] [042/131] (854s left) kms_plane_cursor (primary)
[177.232806] Starting subtest: primary
[177.234033] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[179.647811] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.414s)
[179.693378] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[182.126201] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.444s)
[182.170222] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[184.604421] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.443s)
[184.731813] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[187.229207] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.506s)
[187.273099] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[189.690720] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.427s)
[189.734229] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[192.169052] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.444s)
[192.286495] Subtest primary: SUCCESS (15.054s)
[192.820356] [043/131] (838s left) kms_flip (dpms-off-confusion-interruptible)
[193.118786] Starting subtest: dpms-off-confusion-interruptible
[193.119513] Starting dynamic subtest: A-VGA1
[200.838066] Dynamic subtest A-VGA1: SUCCESS (7.718s)
[200.850069] Starting dynamic subtest: B-VGA1
[208.528420] Dynamic subtest B-VGA1: SUCCESS (7.687s)
[208.540367] Starting dynamic subtest: A-HDMI-A1
[216.270413] Dynamic subtest A-HDMI-A1: SUCCESS (7.739s)
[216.282472] Starting dynamic subtest: B-HDMI-A1
[224.024435] Dynamic subtest B-HDMI-A1: SUCCESS (7.750s)
[224.027812] Subtest dpms-off-confusion-interruptible: SUCCESS (30.908s)
[224.626818] [044/131] (806s left) kms_cursor_edge_walk (256x256-top-bottom)
[224.918509] Starting subtest: 256x256-top-bottom
[224.919129] Starting dynamic subtest: pipe-A-HDMI-A-1
[228.337677] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.417s)
[228.347553] Starting dynamic subtest: pipe-B-HDMI-A-1
[231.665836] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.327s)
[231.666545] Subtest 256x256-top-bottom: SUCCESS (6.749s)
[232.180520] [045/131] (799s left) kms_psr (pr-sprite-plane-onoff)
[232.473662] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[232.675139] [046/131] (798s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[232.970132] Starting subtest: short-flip-before-cursor-toggle
[233.945130] Subtest short-flip-before-cursor-toggle: SUCCESS (0.976s)
[234.457891] [047/131] (797s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[234.755711] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[234.757531] Starting dynamic subtest: A-VGA1
[242.781861] Dynamic subtest A-VGA1: SUCCESS (8.024s)
[242.793733] Starting dynamic subtest: B-VGA1
[250.772804] Dynamic subtest B-VGA1: SUCCESS (7.988s)
[250.785033] Starting dynamic subtest: A-HDMI-A1
[258.928180] Dynamic subtest A-HDMI-A1: SUCCESS (8.152s)
[258.941388] Starting dynamic subtest: B-HDMI-A1
[267.114922] Dynamic subtest B-HDMI-A1: SUCCESS (8.182s)
[267.118457] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.361s)
[267.702970] [048/131] (763s left) gem_exec_params (secure-non-master)
[267.760693] Starting subtest: secure-non-master
[267.761940] Subtest secure-non-master: SKIP (0.000s)
[267.899659] [049/131] (763s left) kms_flip (2x-flip-vs-dpms)
[268.192922] Starting subtest: 2x-flip-vs-dpms
[268.193879] Starting dynamic subtest: AB-VGA1-HDMI-A1
[270.549651] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.355s)
[270.550229] Subtest 2x-flip-vs-dpms: SUCCESS (2.358s)
[271.100385] [050/131] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[271.392722] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[271.393793] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[271.793125] [051/131] (759s left) drm_read (fault-buffer)
[272.133452] Starting subtest: fault-buffer
[272.134304] Subtest fault-buffer: SUCCESS (0.001s)
[272.577426] [052/131] (759s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[272.642101] Starting subtest: basic-batch-kernel-default-cmd
[272.643839] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[272.876370] [053/131] (758s left) kms_cursor_crc (cursor-offscreen-128x128)
[273.181686] Starting subtest: cursor-offscreen-128x128
[273.184219] Starting dynamic subtest: pipe-A-HDMI-A-1
[275.574689] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.389s)
[275.614527] Starting dynamic subtest: pipe-B-HDMI-A-1
[277.996147] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.392s)
[277.997929] Subtest cursor-offscreen-128x128: SUCCESS (4.816s)
[278.525400] [054/131] (753s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[278.831852] Starting subtest: x-tiled-8bpp-rotate-90
[278.843181] Subtest x-tiled-8bpp-rotate-90: SKIP (0.011s)
[279.272952] [055/131] (752s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[279.326947] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[279.430736] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[279.554336] [056/131] (752s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[279.852228] Starting subtest: 4-tiled-32bpp-rotate-90
[279.853571] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[280.252669] [057/131] (751s left) core_setmaster (master-drop-set-shared-fd)
[280.407663] Starting subtest: master-drop-set-shared-fd
[280.439211] Subtest master-drop-set-shared-fd: SUCCESS (0.032s)
[280.486962] [058/131] (751s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[280.782093] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[280.783098] Starting dynamic subtest: AB-VGA1-HDMI-A1
[282.399776] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.616s)
[282.400301] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (1.619s)
[282.925985] [059/131] (749s left) syncobj_wait (single-wait-all-submitted)
[282.982908] Starting subtest: single-wait-all-submitted
[283.086327] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[283.209408] [060/131] (748s left) kms_big_fb (linear-64bpp-rotate-270)
[283.516855] Starting subtest: linear-64bpp-rotate-270
[283.530591] Subtest linear-64bpp-rotate-270: SKIP (0.013s)
[283.962618] [061/131] (748s left) gem_exec_params (invalid-fence-in-submit)
[284.017361] Starting subtest: invalid-fence-in-submit
[284.019225] Subtest invalid-fence-in-submit: SUCCESS (0.001s)
[284.175229] [062/131] (748s left) syncobj_wait (single-wait-for-submit-submitted)
[284.235708] Starting subtest: single-wait-for-submit-submitted
[284.342290] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s)
[284.473769] [063/131] (747s left) prime_vgem (fence-write-hang)
[284.551554] Subtest fence-write-hang: SKIP (0.000s)
[284.696523] [064/131] (747s left) syncobj_timeline (single-wait-signaled)
[284.751479] Starting subtest: single-wait-signaled
[284.752015] Subtest single-wait-signaled: SUCCESS (0.000s)
[284.873612] [065/131] (747s left) kms_chamelium_edid (vga-edid-read)
[285.243183] Subtest vga-edid-read: SKIP (0.000s)
[285.562364] [066/131] (746s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[285.860773] Starting subtest: 2x-long-flip-vs-cursor-atomic
[285.861779] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[286.268541] [067/131] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[286.562328] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[288.532738] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.970s)
[288.978435] [068/131] (743s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[289.275125] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[291.210544] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.935s)
[291.655878] [069/131] (740s left) prime_vgem (basic-read)
[291.732675] Starting subtest: basic-read
[291.750358] Subtest basic-read: SUCCESS (0.017s)
[291.891558] [070/131] (740s left) gem_userptr_blits (vma-merge)
[291.973762] Starting subtest: vma-merge
[292.060484] Subtest vma-merge: SUCCESS (0.087s)
[292.223262] [071/131] (740s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[292.526723] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[292.528069] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[292.940341] [072/131] (739s left) kms_vrr (negative-basic)
[293.237489] Starting subtest: negative-basic
[293.239328] Subtest negative-basic: SKIP (0.000s)
[293.653008] [073/131] (739s left) gem_exec_reloc (basic-cpu-read-active)
[293.710876] Starting subtest: basic-cpu-read-active
[293.818855] Subtest basic-cpu-read-active: SUCCESS (0.109s)
[294.455451] [074/131] (738s left) kms_chamelium_hpd (hdmi-hpd)
[294.819901] Subtest hdmi-hpd: SKIP (0.000s)
[295.120367] [075/131] (737s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[295.423970] Starting subtest: yf-tiled-16bpp-rotate-0
[295.425257] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[295.826444] [076/131] (737s left) syncobj_timeline (reset-signaled)
[295.881890] Starting subtest: reset-signaled
[295.882567] Subtest reset-signaled: SUCCESS (0.000s)
[296.010437] [077/131] (736s left) kms_psr (fbc-psr2-basic)
[296.304480] Subtest fbc-psr2-basic: SKIP (0.000s)
[296.508851] [078/131] (736s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[296.802146] Starting subtest: primary-yf-tiled-reflect-x-0
[296.803302] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.001s)
[297.205520] [079/131] (735s left) kms_prop_blob (basic)
[297.261560] Starting subtest: basic
[297.262069] Subtest basic: SUCCESS (0.000s)
[297.389198] [080/131] (735s left) vgem_basic (debugfs)
[297.444317] Starting subtest: debugfs
[297.444904] Subtest debugfs: SUCCESS (0.001s)
[297.555463] [081/131] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[297.847690] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[297.848914] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[298.256635] [082/131] (734s left) gem_userptr_blits (unsync-unmap-cycles)
[298.319210] Subtest unsync-unmap-cycles: SKIP (0.000s)
[298.490671] [083/131] (734s left) perf_pmu (busy-double-start)
[298.542219] Starting subtest: busy-double-start
[298.542906] Starting dynamic subtest: rcs0
[302.087300] Dynamic subtest rcs0: SUCCESS (3.544s)
[302.100892] Starting dynamic subtest: bcs0
[305.614360] Dynamic subtest bcs0: SUCCESS (3.524s)
[305.628890] Starting dynamic subtest: vcs0
[309.633235] Dynamic subtest vcs0: SUCCESS (4.016s)
[309.636587] Subtest busy-double-start: SUCCESS (11.092s)
[309.766180] [084/131] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[310.064554] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[310.065681] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[310.464828] [085/131] (722s left) kms_chamelium_color (ctm-negative)
[310.760615] Subtest ctm-negative: SKIP (0.000s)
[310.956439] [086/131] (722s left) kms_async_flips (async-flip-dpms)
[311.243924] Starting subtest: async-flip-dpms
[311.383041] Starting dynamic subtest: pipe-A-HDMI-A-1
[323.566706] Dynamic subtest pipe-A-HDMI-A-1: SKIP (12.181s)
[323.728308] Starting dynamic subtest: pipe-B-HDMI-A-1
[335.863861] Dynamic subtest pipe-B-HDMI-A-1: SKIP (12.144s)
[335.865562] Subtest async-flip-dpms: SKIP (24.621s)
[336.522097] [087/131] (696s left) gem_busy (semaphore)
[336.710807] Subtest semaphore: SKIP (0.000s)
[336.989391] [088/131] (696s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[337.285738] Starting subtest: flip-vs-dpms-off-vs-modeset
[337.286302] Starting dynamic subtest: A-VGA1
[338.050861] Dynamic subtest A-VGA1: SUCCESS (0.765s)
[338.062911] Starting dynamic subtest: B-VGA1
[338.754543] Dynamic subtest B-VGA1: SUCCESS (0.701s)
[338.765161] Starting dynamic subtest: A-HDMI-A1
[339.523596] Dynamic subtest A-HDMI-A1: SUCCESS (0.768s)
[339.535698] Starting dynamic subtest: B-HDMI-A1
[340.294351] Dynamic subtest B-HDMI-A1: SUCCESS (0.768s)
[340.294977] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.011s)
[340.831978] [089/131] (692s left) prime_mmap (test_reprime)
[340.890953] Starting subtest: test_reprime
[340.891517] Starting dynamic subtest: test_reprime-smem
[340.893733] Dynamic subtest test_reprime-smem: SUCCESS (0.003s)
[340.895787] Subtest test_reprime: SUCCESS (0.005s)
[341.054427] [090/131] (692s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[341.355605] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[341.553679] [091/131] (692s left) gem_exec_whisper (basic-fds)
[341.617966] Starting subtest: basic-fds
[344.376141] Subtest basic-fds: SUCCESS (2.758s)
[344.620672] [092/131] (689s left) gem_ctx_param (set-priority-range)
[344.677934] Subtest set-priority-range: SKIP (0.000s)
[344.805883] [093/131] (688s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[344.858754] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.000s)
[344.911847] [094/131] (688s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[344.967691] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[345.030127] [095/131] (688s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[345.326299] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[345.327609] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[345.731544] [096/131] (688s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[345.788877] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[345.844735] [097/131] (688s left) i915_selftest (mock)
[346.690843] Starting subtest: mock
[346.691532] Starting dynamic subtest: sanitycheck
[347.921526] Dynamic subtest sanitycheck: SUCCESS (1.230s)
[347.934043] Starting dynamic subtest: shmem
[349.084627] Dynamic subtest shmem: SUCCESS (1.161s)
[349.097049] Starting dynamic subtest: fence
[357.009564] Dynamic subtest fence: SUCCESS (7.923s)
[357.023748] Starting dynamic subtest: scatterlist
[359.199521] Dynamic subtest scatterlist: SUCCESS (2.187s)
[359.215808] Starting dynamic subtest: syncmap
[362.406556] Dynamic subtest syncmap: SUCCESS (3.204s)
[362.423589] Starting dynamic subtest: uncore
[363.569708] Dynamic subtest uncore: SUCCESS (1.160s)
[363.581979] Starting dynamic subtest: ring
[364.743632] Dynamic subtest ring: SUCCESS (1.172s)
[364.756069] Starting dynamic subtest: engine
[365.916633] Dynamic subtest engine: SUCCESS (1.171s)
[365.929726] Starting dynamic subtest: timelines
[372.193641] Dynamic subtest timelines: SUCCESS (6.275s)
[372.206040] Starting dynamic subtest: requests
[375.538633] Dynamic subtest requests: SUCCESS (3.343s)
[375.550650] Starting dynamic subtest: objects
[376.763503] Dynamic subtest objects: SUCCESS (1.223s)
[376.775539] Starting dynamic subtest: phys
[378.072619] Dynamic subtest phys: SUCCESS (1.307s)
[378.085492] Starting dynamic subtest: dmabuf
[379.300636] Dynamic subtest dmabuf: SUCCESS (1.225s)
[379.313042] Starting dynamic subtest: vma
[391.101678] Dynamic subtest vma: SUCCESS (11.799s)
[391.114674] Starting dynamic subtest: evict
[393.666577] Dynamic subtest evict: SUCCESS (2.563s)
[393.683375] Starting dynamic subtest: gtt
[398.036732] Dynamic subtest gtt: SUCCESS (4.367s)
[398.048960] Starting dynamic subtest: hugepages
[399.587623] Dynamic subtest hugepages: SUCCESS (1.549s)
[399.600148] Starting dynamic subtest: memory_region
[404.750600] Dynamic subtest memory_region: SUCCESS (5.161s)
[404.752846] Subtest mock: SUCCESS (58.060s)
[404.788133] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[404.789401] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[404.791969] [098/131] (629s left) gem_ctx_exec (basic-close-race)
[406.666813] Starting subtest: basic-close-race
[412.214635] Subtest basic-close-race: SUCCESS (5.548s)
[412.299609] [FACT gem_ctx_exec (basic-close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[412.301245] [FACT gem_ctx_exec (basic-close-race)] new: kernel.kmod_is_loaded.i915: true
[412.304756] [099/131] (621s left) prime_busy (after)
[412.365348] Starting subtest: after
[412.372397] Starting dynamic subtest: rcs0
[412.390634] Dynamic subtest rcs0: SUCCESS (0.018s)
[412.410181] Starting dynamic subtest: bcs0
[412.411244] Dynamic subtest bcs0: SUCCESS (0.016s)
[412.428251] Starting dynamic subtest: vcs0
[412.430774] Dynamic subtest vcs0: SUCCESS (0.020s)
[412.537897] Subtest after: SUCCESS (0.172s)
[412.675176] [100/131] (621s left) syncobj_wait (reset-signaled)
[412.731656] Starting subtest: reset-signaled
[412.732284] Subtest reset-signaled: SUCCESS (0.000s)
[412.867305] [101/131] (621s left) kms_dsc (dsc-basic)
[413.157540] Subtest dsc-basic: SKIP (0.000s)
[413.357574] [102/131] (620s left) vgem_basic (bad-flag)
[413.417855] Starting subtest: bad-flag
[413.418554] Subtest bad-flag: SUCCESS (0.000s)
[413.532490] [103/131] (620s left) kms_psr (psr2-sprite-mmap-gtt)
[413.821826] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[414.024761] [104/131] (620s left) gem_exec_balancer (noheartbeat)
[414.081280] Subtest noheartbeat: SKIP (0.000s)
[414.212666] [105/131] (620s left) gem_tiled_wb
[423.126714] [106/131] (611s left) gem_exec_reloc (basic-softpin)
[423.187969] Starting subtest: basic-softpin
[423.189645] Subtest basic-softpin: SUCCESS (0.002s)
[423.841601] [107/131] (610s left) gem_pxp (hw-rejects-pxp-buffer)
[426.410968] Starting subtest: hw-rejects-pxp-buffer
[426.411526] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[426.555294] [108/131] (607s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[426.848816] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[427.048921] [109/131] (607s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[427.338373] Starting subtest: 2x-cursor-vs-flip-legacy
[427.340534] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[427.752388] [110/131] (606s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[428.044945] Starting subtest: multiplane-rotation-cropping-bottom
[428.045996] Subtest multiplane-rotation-cropping-bottom: SKIP (0.000s)
[428.453465] [111/131] (606s left) gem_userptr_blits (sync-overlap)
[428.520676] Starting subtest: sync-overlap
[428.521235] Subtest sync-overlap: SUCCESS (0.000s)
[428.682700] [112/131] (605s left) kms_feature_discovery (psr2)
[428.978463] Starting subtest: psr2
[428.979721] Subtest psr2: SKIP (0.000s)
[429.389272] [113/131] (605s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[429.686344] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[429.687581] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[430.096579] [114/131] (604s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[430.395493] Starting subtest: y-tiled-32bpp-rotate-0
[430.396748] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[430.812867] [115/131] (603s left) gem_mmap_gtt (basic-small-bo)
[430.870131] Starting subtest: basic-small-bo
[431.683675] Subtest basic-small-bo: SUCCESS (0.814s)
[431.840484] [116/131] (603s left) api_intel_bb (simple-bb)
[431.983586] Starting subtest: simple-bb
[431.985470] Subtest simple-bb: SUCCESS (0.002s)
[432.162408] [117/131] (602s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[432.471936] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[432.472644] Starting dynamic subtest: pipe-A
[432.474920] Dynamic subtest pipe-A: SKIP (0.001s)
[432.489880] Starting dynamic subtest: pipe-B
[432.504740] Dynamic subtest pipe-B: SKIP (0.001s)
[432.518196] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.006s)
[432.891521] [118/131] (602s left) kms_lease (lease-unleased-connector)
[433.186543] Starting subtest: lease-unleased-connector
[433.187413] Starting dynamic subtest: pipe-A-HDMI-A-1
[433.244554] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.058s)
[433.259743] Starting dynamic subtest: pipe-B-HDMI-A-1
[433.306030] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.058s)
[433.308887] Subtest lease-unleased-connector: SUCCESS (0.123s)
[433.708808] [119/131] (601s left) gen9_exec_parse (bb-secure)
[433.765085] Subtest bb-secure: SKIP (0.000s)
[433.817484] [120/131] (601s left) vgem_basic (mmap)
[433.876871] Starting subtest: mmap
[433.888085] Subtest mmap: SUCCESS (0.012s)
[434.019775] [121/131] (601s left) gem_eio (in-flight-contexts-10ms)
[434.086301] Starting subtest: in-flight-contexts-10ms
[437.482879] Subtest in-flight-contexts-10ms: SUCCESS (3.396s)
[438.137779] [122/131] (597s left) i915_pm_rpm (debugfs-forcewake-user)
[449.689198] Subtest debugfs-forcewake-user: SKIP (0.000s)
[449.889772] [123/131] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[450.189499] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[450.190672] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[450.589805] [124/131] (584s left) kms_psr (fbc-pr-no-drrs)
[450.880100] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[451.083451] [125/131] (584s left) kms_invalid_mode (bad-htotal)
[451.379180] Starting subtest: bad-htotal
[451.379830] Starting dynamic subtest: pipe-A-HDMI-A-1
[451.456803] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.077s)
[451.484411] Starting dynamic subtest: pipe-B-HDMI-A-1
[451.484983] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[451.485660] Subtest bad-htotal: SUCCESS (0.082s)
[451.835433] [126/131] (583s left) kms_cursor_crc (cursor-random-128x42)
[452.133650] Starting subtest: cursor-random-128x42
[452.195392] Subtest cursor-random-128x42: SKIP (0.061s)
[452.603949] [127/131] (582s left) gem_linear_blits (interruptible)
[452.747723] Starting subtest: interruptible
[454.730575] Subtest interruptible: SUCCESS (1.983s)
[454.863548] [128/131] (580s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[455.243835] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[455.245841] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[455.663735] [129/131] (579s left) i915_hangman (engine-engine-error)
[455.723927] Subtest engine-engine-error: SKIP (0.000s)
[455.812678] [130/131] (579s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[456.113991] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[456.115254] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[456.529200] [131/131] (579s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[456.819974] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[456.820628] Starting dynamic subtest: pipe-A
[456.822048] Dynamic subtest pipe-A: SKIP (0.001s)
[456.834583] Starting dynamic subtest: pipe-B
[456.836332] Dynamic subtest pipe-B: SKIP (0.001s)
[456.837438] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.005s)
[457.244604] 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.