[76.161141] Initializing watchdogs
[76.161265]   /dev/watchdog0
[76.184458] [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)
[76.193727] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[76.197293] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[76.200716] [001/130] (960s left) gen9_exec_parse (allowed-single)
[76.851066] Subtest allowed-single: SKIP (0.000s)
[76.897863] [002/130] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[77.277046] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[77.278558] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[77.706325] [003/130] (959s left) debugfs_test (read_all_entries_display_off)
[78.093712] Starting subtest: read_all_entries_display_off
[78.186576] Subtest read_all_entries_display_off: SUCCESS (0.092s)
[78.732798] [004/130] (958s left) sriov_basic (enable-vfs-autoprobe-on)
[78.802356] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[78.854284] [005/130] (958s left) kms_content_protection (lic-type-0)
[79.253705] Starting subtest: lic-type-0
[79.477248] Subtest lic-type-0: SKIP (0.222s)
[80.087586] [006/130] (956s left) kms_vblank (wait-forked-busy)
[80.461053] Starting subtest: wait-forked-busy
[80.463374] Starting dynamic subtest: pipe-A-HDMI-A-1
[82.857773] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.393s)
[82.865536] Starting dynamic subtest: pipe-B-HDMI-A-1
[85.280613] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.420s)
[85.281806] Subtest wait-forked-busy: SUCCESS (4.817s)
[85.819224] [007/130] (951s left) syncobj_wait (multi-wait-all-signaled)
[85.884695] Starting subtest: multi-wait-all-signaled
[85.885603] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[85.972835] [008/130] (951s left) gem_userptr_blits (stress-purge)
[86.054899] Starting subtest: stress-purge
[91.428449] Subtest stress-purge: SUCCESS (5.371s)
[91.582316] [009/130] (945s left) gem_ctx_param (invalid-get-no-zeromap)
[91.751380] Starting subtest: invalid-get-no-zeromap
[91.752278] Subtest invalid-get-no-zeromap: SUCCESS (0.000s)
[91.845921] [010/130] (945s left) gem_ctx_persistence (idempotent)
[91.917424] Subtest idempotent: SKIP (0.000s)
[91.970287] [011/130] (945s left) gem_mmap_gtt (big-bo)
[92.029830] Starting subtest: big-bo
[92.317967] Subtest big-bo: SUCCESS (0.287s)
[92.473394] [012/130] (944s left) kms_vblank (query-forked-hang)
[92.961304] Starting subtest: query-forked-hang
[92.963791] Starting dynamic subtest: pipe-A-HDMI-A-1
[98.992846] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.028s)
[99.005090] Starting dynamic subtest: pipe-B-HDMI-A-1
[104.996626] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.000s)
[104.997391] Subtest query-forked-hang: SUCCESS (12.032s)
[105.574268] [013/130] (931s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[105.952728] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[105.954529] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[106.388085] [014/130] (930s left) kms_flip (flip-vs-modeset-vs-hang)
[106.773557] Starting subtest: flip-vs-modeset-vs-hang
[106.775388] Starting dynamic subtest: A-VGA1
[118.947908] Dynamic subtest A-VGA1: SUCCESS (12.171s)
[118.957451] Starting dynamic subtest: B-VGA1
[130.915265] Dynamic subtest B-VGA1: SUCCESS (11.965s)
[130.924345] Starting dynamic subtest: A-HDMI-A1
[142.946995] Dynamic subtest A-HDMI-A1: SUCCESS (12.030s)
[142.955982] Starting dynamic subtest: B-HDMI-A1
[154.915485] Dynamic subtest B-HDMI-A1: SUCCESS (11.970s)
[154.916308] Subtest flip-vs-modeset-vs-hang: SUCCESS (48.140s)
[155.485640] [015/130] (881s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[155.861284] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[155.862316] Starting dynamic subtest: pipe-A-HDMI-A-1
[155.972636] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.110s)
[156.045869] Starting dynamic subtest: pipe-B-HDMI-A-1
[156.200860] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.162s)
[156.263320] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.403s)
[156.804163] [016/130] (880s left) gem_partial_pwrite_pread (reads-uncached)
[156.878296] Starting subtest: reads-uncached
[157.921229] Subtest reads-uncached: SUCCESS (1.041s)
[158.036299] [017/130] (879s left) kms_atomic (plane-immutable-zpos)
[158.405758] Starting subtest: plane-immutable-zpos
[158.406727] Starting dynamic subtest: pipe-A-HDMI-A-1
[158.773397] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.367s)
[158.774122] Subtest plane-immutable-zpos: SUCCESS (0.370s)
[159.316079] [018/130] (878s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[159.700805] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[159.937018] [019/130] (877s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[160.311246] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[160.312790] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[160.740303] [020/130] (876s left) kms_plane_cursor (overlay)
[161.109830] Starting subtest: overlay
[161.112371] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[163.775958] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.663s)
[163.834528] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[166.520631] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.694s)
[166.578901] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[169.264399] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.694s)
[169.408573] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[172.163385] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.765s)
[172.221807] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[174.907655] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.694s)
[174.967905] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[177.651694] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.694s)
[177.786754] Subtest overlay: SUCCESS (16.678s)
[178.330611] [021/130] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[178.710992] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[180.564452] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (1.853s)
[181.023899] [022/130] (856s left) kms_getfb (getfb-handle-valid)
[181.091399] Starting subtest: getfb-handle-valid
[181.092220] Subtest getfb-handle-valid: SUCCESS (0.000s)
[181.191456] [023/130] (856s left) gem_exercise_blt (fast-copy-emit)
[181.259089] Subtest fast-copy-emit: SKIP (0.000s)
[181.321172] [024/130] (856s left) gem_softpin (evict-snoop-interruptible)
[181.390410] Starting subtest: evict-snoop-interruptible
[181.392211] Subtest evict-snoop-interruptible: SKIP (0.000s)
[181.474441] [025/130] (856s left) kms_big_fb (linear-64bpp-rotate-0)
[181.861067] Starting subtest: linear-64bpp-rotate-0
[183.758422] Subtest linear-64bpp-rotate-0: SUCCESS (1.896s)
[184.221577] [026/130] (853s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[184.288913] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[184.344417] [027/130] (853s left) gem_exec_fence (basic-wait)
[184.529894] Subtest basic-wait: SKIP (0.000s)
[184.950755] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[184.953834] [028/130] (852s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[185.335235] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[185.355470] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.019s)
[185.821781] [029/130] (852s left) kms_cursor_crc (cursor-suspend)
[186.194407] Starting subtest: cursor-suspend
[186.195203] Starting dynamic subtest: pipe-A-HDMI-A-1
[220.251549] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.920s)
[220.265373] Starting dynamic subtest: pipe-B-HDMI-A-1
[255.240414] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.800s)
[255.241274] Subtest cursor-suspend: SUCCESS (3.724s)
[261.810659] [030/130] (847s left) syncobj_timeline (invalid-wait-bad-flags)
[261.880404] Starting subtest: invalid-wait-bad-flags
[261.881125] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[261.977427] [031/130] (847s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[262.041304] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[262.101007] [032/130] (847s left) prime_mmap_coherency (ioctl-errors)
[262.170000] Starting subtest: ioctl-errors
[271.339260] Subtest ioctl-errors: SUCCESS (9.168s)
[271.492730] [033/130] (838s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[271.977076] Starting subtest: cursor-vs-flip-toggle
[305.232457] Subtest cursor-vs-flip-toggle: SUCCESS (33.256s)
[305.777957] [034/130] (803s left) kms_addfb_basic (addfb25-modifier-no-flag)
[306.156414] Starting subtest: addfb25-modifier-no-flag
[306.157427] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[306.594595] [035/130] (803s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[306.666949] Starting subtest: multi-wait-for-submit-available-submitted
[306.669063] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[306.764431] [036/130] (802s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[307.108949] Starting subtest: syncobj-timeline-invalid-wait
[307.110905] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s)
[307.340440] [037/130] (802s left) gem_exec_whisper (basic-fds-priority)
[307.416979] Starting subtest: basic-fds-priority
[307.418559] Subtest basic-fds-priority: SKIP (0.001s)
[307.628283] [038/130] (802s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[307.701946] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[307.702769] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[307.794999] [039/130] (802s left) kms_addfb_basic (bad-pitch-65536)
[307.859600] Starting subtest: bad-pitch-65536
[307.860320] Subtest bad-pitch-65536: SUCCESS (0.000s)
[308.622499] [040/130] (801s left) vgem_slow (nohang)
[308.689283] Starting subtest: nohang
[318.909500] Subtest nohang: SUCCESS (10.221s)
[318.985470] [041/130] (790s left) gem_exec_schedule (fifo)
[319.066162] Starting subtest: fifo
[319.067022] Starting dynamic subtest: rcs0
[319.096877] Dynamic subtest rcs0: SUCCESS (0.030s)
[319.110402] Starting dynamic subtest: bcs0
[319.125871] Dynamic subtest bcs0: SUCCESS (0.028s)
[319.126842] Subtest fifo: SUCCESS (0.060s)
[319.352579] [042/130] (790s left) kms_chamelium_frames (vga-frame-dump)
[319.797740] Subtest vga-frame-dump: SKIP (0.000s)
[320.156634] [043/130] (789s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render)
[320.539390] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render
[320.540981] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[320.980462] [044/130] (789s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[321.360084] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[321.361738] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[321.810306] [045/130] (788s left) kms_atomic_interruptible (legacy-cursor)
[322.198222] Starting subtest: legacy-cursor
[322.199068] Starting dynamic subtest: pipe-A-HDMI-A-1
[328.522358] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.324s)
[328.523126] Subtest legacy-cursor: SUCCESS (6.326s)
[329.067604] [046/130] (781s left) gem_mmap_offset (clear)
[329.140761] Starting subtest: clear
[329.142555] Starting dynamic subtest: smem0
[352.932327] Dynamic subtest smem0: SUCCESS (23.789s)
[352.933093] Subtest clear: SUCCESS (23.791s)
[353.110795] [047/130] (757s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[353.599035] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[353.602033] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[354.039780] [048/130] (756s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[354.106953] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[354.161637] [049/130] (756s left) i915_pm_rps (fence-order)
[354.231675] Starting subtest: fence-order
[355.512579] Subtest fence-order: SUCCESS (1.280s)
[355.643529] [050/130] (754s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[355.708301] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[355.772285] [051/130] (754s left) kms_psr (fbc-pr-cursor-render)
[356.141759] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[356.377520] [052/130] (754s left) gem_pxp (create-regular-buffer)
[358.957692] Starting subtest: create-regular-buffer
[358.959267] Subtest create-regular-buffer: SKIP (0.000s)
[359.060862] [053/130] (751s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[359.440645] Starting subtest: yf-tiled-32bpp-rotate-90
[359.442128] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[359.874823] [054/130] (750s left) gem_exec_balancer (parallel-ordering)
[359.943575] Subtest parallel-ordering: SKIP (0.000s)
[360.038956] [055/130] (750s left) kms_psr (pr-primary-mmap-cpu)
[360.407690] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[360.649518] [056/130] (750s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[361.020481] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[361.022243] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[361.453818] [057/130] (749s left) kms_dsc (dsc-with-bpc-formats)
[361.825887] Subtest dsc-with-bpc-formats: SKIP (0.000s)
[362.063777] [058/130] (748s left) kms_atomic (test-only)
[362.436825] Starting subtest: test-only
[362.554006] Starting dynamic subtest: pipe-A-HDMI-A-1
[363.058470] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.506s)
[363.059412] Subtest test-only: SUCCESS (0.623s)
[363.606397] [059/130] (747s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[363.980783] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[363.982473] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[364.426496] [060/130] (746s left) gem_eio (in-flight-suspend)
[364.505798] Starting subtest: in-flight-suspend
[401.561168] Subtest in-flight-suspend: SUCCESS (6.295s)
[410.275497] [061/130] (739s left) kms_big_fb (linear-32bpp-rotate-0)
[410.646683] Starting subtest: linear-32bpp-rotate-0
[412.145062] Subtest linear-32bpp-rotate-0: SUCCESS (1.497s)
[412.628479] [062/130] (737s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[413.010728] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[413.012582] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[413.462563] [063/130] (736s left) kms_psr (psr-dpms)
[413.837227] Subtest psr-dpms: SKIP (0.000s)
[414.070227] [064/130] (735s left) kms_feature_discovery (display-4x)
[414.439183] Starting subtest: display-4x
[414.442956] Subtest display-4x: SKIP (0.000s)
[414.882597] [065/130] (734s left) gem_workarounds (suspend-resume-fd)
[414.958701] Starting subtest: suspend-resume-fd
[432.033298] Subtest suspend-resume-fd: SUCCESS (0.517s)
[440.091434] [066/130] (734s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[440.476148] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[440.477723] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[440.933358] [067/130] (733s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[441.000212] Starting subtest: invalid-bsd2-flag-on-vebox
[441.001920] Subtest invalid-bsd2-flag-on-vebox: SKIP (0.000s)
[441.117426] [068/130] (733s left) vgem_basic (sysfs)
[441.198793] Starting subtest: sysfs
[441.199832] Subtest sysfs: SUCCESS (0.001s)
[441.283277] [069/130] (733s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[441.657363] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[441.658847] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[442.098805] [070/130] (732s left) syncobj_timeline (host-signal-points)
[442.177344] Starting subtest: host-signal-points
[442.188712] Subtest host-signal-points: SUCCESS (0.011s)
[442.291308] [071/130] (732s left) kms_psr (psr2-no-drrs)
[442.667397] Subtest psr2-no-drrs: SKIP (0.000s)
[442.907827] [072/130] (731s left) gem_userptr_blits (vma-merge)
[443.014426] Starting subtest: vma-merge
[443.107776] Subtest vma-merge: SUCCESS (0.095s)
[443.246451] [073/130] (731s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[443.616334] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[443.617118] Starting dynamic subtest: pipe-A
[443.618993] Dynamic subtest pipe-A: SKIP (0.001s)
[443.633117] Starting dynamic subtest: pipe-B
[443.636068] Dynamic subtest pipe-B: SKIP (0.001s)
[443.637824] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.005s)
[444.067879] [074/130] (730s left) gem_exec_fence (basic-wait-all)
[444.148312] Starting subtest: basic-wait-all
[444.174668] Subtest basic-wait-all: SUCCESS (0.026s)
[444.680490] [075/130] (730s left) syncobj_wait (multi-wait-all-submitted)
[444.747556] Starting subtest: multi-wait-all-submitted
[444.856931] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[444.959564] [076/130] (729s left) kms_color (ctm-blue-to-red)
[445.327952] Starting subtest: ctm-blue-to-red
[445.329125] Starting dynamic subtest: pipe-A-HDMI-A-1
[445.789560] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.460s)
[445.803673] Starting dynamic subtest: pipe-B-HDMI-A-1
[446.284420] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.493s)
[446.285548] Subtest ctm-blue-to-red: SUCCESS (0.956s)
[446.841784] [077/130] (728s left) kms_addfb_basic (basic-x-tiled-legacy)
[446.909883] Starting subtest: basic-x-tiled-legacy
[446.910721] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[447.664327] [078/130] (727s left) api_intel_allocator (two-level-inception-interruptible)
[447.731727] Starting subtest: two-level-inception-interruptible
[453.204578] Subtest two-level-inception-interruptible: SUCCESS (5.472s)
[453.305967] [079/130] (721s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[453.677706] Starting subtest: psr-rgb565-draw-blt
[453.679273] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[454.124583] [080/130] (720s left) syncobj_wait (wait-for-submit-delayed-submit)
[454.190383] Starting subtest: wait-for-submit-delayed-submit
[454.292089] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[454.388927] [081/130] (720s left) perf_pmu (most-busy-check-all)
[454.456766] Starting subtest: most-busy-check-all
[454.457522] Starting dynamic subtest: rcs0
[454.977388] Dynamic subtest rcs0: SUCCESS (0.521s)
[454.993669] Starting dynamic subtest: bcs0
[455.497564] Dynamic subtest bcs0: SUCCESS (0.517s)
[455.514289] Starting dynamic subtest: vcs0
[456.015576] Dynamic subtest vcs0: SUCCESS (0.515s)
[456.017058] Subtest most-busy-check-all: SUCCESS (1.561s)
[456.115091] [082/130] (719s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[456.488170] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[456.729511] [083/130] (718s left) kms_getfb (getfb-handle-zero)
[456.795669] Starting subtest: getfb-handle-zero
[456.796588] Subtest getfb-handle-zero: SUCCESS (0.000s)
[456.916198] [084/130] (718s left) gem_readwrite (beyond-eob)
[456.979212] Starting subtest: beyond-EOB
[456.980613] Subtest beyond-EOB: SUCCESS (0.000s)
[457.085746] [085/130] (718s left) kms_flip (flip-vs-rmfb)
[457.453409] Starting subtest: flip-vs-rmfb
[457.454153] Starting dynamic subtest: A-VGA1
[465.214820] Dynamic subtest A-VGA1: SUCCESS (7.760s)
[465.233448] Starting dynamic subtest: B-VGA1
[472.932567] Dynamic subtest B-VGA1: SUCCESS (7.718s)
[472.948975] Starting dynamic subtest: A-HDMI-A1
[480.651561] Dynamic subtest A-HDMI-A1: SUCCESS (7.717s)
[480.668666] Starting dynamic subtest: B-HDMI-A1
[488.401726] Dynamic subtest B-HDMI-A1: SUCCESS (7.746s)
[488.402612] Subtest flip-vs-rmfb: SUCCESS (30.954s)
[489.044099] [086/130] (686s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[489.420280] Starting subtest: short-busy-flip-before-cursor-toggle
[489.421922] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[489.855936] [087/130] (685s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[490.236840] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[490.237733] Starting dynamic subtest: pipe-A
[490.239948] Dynamic subtest pipe-A: SKIP (0.001s)
[490.257365] Starting dynamic subtest: pipe-B
[490.260169] Dynamic subtest pipe-B: SKIP (0.001s)
[490.262127] Subtest plane-downscale-factor-0-75-with-pixel-format: SKIP (0.006s)
[490.693340] [088/130] (684s left) kms_getfb (getfb2-handle-protection)
[490.762710] Starting subtest: getfb2-handle-protection
[490.804739] Subtest getfb2-handle-protection: SUCCESS (0.042s)
[490.935778] [089/130] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[491.310502] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[491.312067] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[491.778220] [090/130] (683s left) kms_psr2_su (page_flip-xrgb8888)
[491.847562] Subtest page_flip-XRGB8888: SKIP (0.000s)
[491.913608] [091/130] (683s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[491.989440] Starting subtest: y-tiled-to-vebox-x-tiled
[491.991116] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[492.203851] [092/130] (683s left) sysfs_preempt_timeout (timeout)
[492.274560] Starting subtest: timeout
[492.277337] Starting dynamic subtest: vcs0
[492.278795] Dynamic subtest vcs0: SKIP (0.000s)
[492.297887] Starting dynamic subtest: bcs0
[492.300111] Dynamic subtest bcs0: SKIP (0.000s)
[492.318603] Starting dynamic subtest: rcs0
[492.320891] Dynamic subtest rcs0: SKIP (0.000s)
[492.322863] Subtest timeout: SKIP (0.007s)
[492.383785] [093/130] (683s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[492.447998] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[492.512014] [094/130] (683s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[492.573188] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[492.681075] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[492.781755] [095/130] (683s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[492.846770] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[492.918609] [096/130] (683s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[493.289442] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[493.291269] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[493.731294] [097/130] (682s left) kms_setmode (basic-clone-single-crtc)
[493.804950] Starting subtest: basic-clone-single-crtc
[493.807014] Subtest basic-clone-single-crtc: SKIP (0.000s)
[493.899950] [098/130] (682s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[494.271422] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[494.272965] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[494.709785] [099/130] (681s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[495.080959] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[496.970093] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.889s)
[497.457443] [100/130] (678s left) dmabuf_sync_file (export-before-signal)
[497.537911] Starting subtest: export-before-signal
[497.538974] Subtest export-before-signal: SUCCESS (0.002s)
[497.626378] [101/130] (678s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[497.690863] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.000s)
[497.749493] [102/130] (678s left) kms_flip (plain-flip-interruptible)
[498.128782] Starting subtest: plain-flip-interruptible
[498.132120] Starting dynamic subtest: A-VGA1
[498.844673] Dynamic subtest A-VGA1: SUCCESS (0.713s)
[498.861145] Starting dynamic subtest: B-VGA1
[499.511774] Dynamic subtest B-VGA1: SUCCESS (0.664s)
[499.530834] Starting dynamic subtest: A-HDMI-A1
[500.248656] Dynamic subtest A-HDMI-A1: SUCCESS (0.733s)
[500.268503] Starting dynamic subtest: B-HDMI-A1
[501.041161] Dynamic subtest B-HDMI-A1: SUCCESS (0.788s)
[501.042709] Subtest plain-flip-interruptible: SUCCESS (2.914s)
[501.649522] [103/130] (674s left) api_intel_bb (purge-bb)
[501.718951] Starting subtest: purge-bb
[501.719899] Subtest purge-bb: SUCCESS (0.002s)
[501.847380] [104/130] (674s left) kms_lease (empty-lease)
[502.223218] Starting subtest: empty-lease
[502.224120] Starting dynamic subtest: pipe-A-HDMI-A-1
[502.225028] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[502.244389] Starting dynamic subtest: pipe-B-HDMI-A-1
[502.245218] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[502.245978] Subtest empty-lease: SUCCESS (0.007s)
[502.679419] [105/130] (673s left) kms_scaling_modes (scaling-mode-full)
[503.053452] Starting subtest: scaling-mode-full
[503.056416] Subtest scaling-mode-full: SKIP (0.000s)
[503.497520] [106/130] (673s left) gem_ctx_isolation (clean)
[503.577244] Starting subtest: clean
[503.578041] Starting dynamic subtest: rcs0
[503.645538] Dynamic subtest rcs0: SUCCESS (0.069s)
[503.646353] Subtest clean: SUCCESS (0.070s)
[503.883499] [107/130] (672s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[504.259145] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[504.261007] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[504.709927] [108/130] (672s left) kms_chamelium_frames (dp-frame-dump)
[505.155842] Subtest dp-frame-dump: SKIP (0.000s)
[505.502745] [109/130] (671s left) gem_busy (busy)
[505.582327] Starting subtest: busy
[505.583087] Starting dynamic subtest: all-engines
[505.617679] Dynamic subtest all-engines: SUCCESS (0.036s)
[505.637430] Starting dynamic subtest: rcs0
[505.638642] Dynamic subtest rcs0: SUCCESS (0.002s)
[505.657566] Starting dynamic subtest: bcs0
[505.658682] Dynamic subtest bcs0: SUCCESS (0.018s)
[505.675133] Starting dynamic subtest: vcs0
[505.676000] Dynamic subtest vcs0: SUCCESS (0.015s)
[505.676896] Subtest busy: SUCCESS (0.077s)
[506.035481] [110/130] (670s left) gem_gtt_cpu_tlb
[506.226653] [111/130] (670s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[506.300854] Starting subtest: x-tiled-to-vebox-y-tiled
[506.303137] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[506.506693] [112/130] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[506.884286] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[506.885976] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[507.318874] [113/130] (669s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[507.388175] Starting subtest: cpuset-medium-copy-XY
[509.143392] Subtest cpuset-medium-copy-XY: SUCCESS (1.758s)
[509.264113] [114/130] (667s left) gem_userptr_blits (sync-unmap)
[509.440112] Starting subtest: sync-unmap
[509.452660] Subtest sync-unmap: SUCCESS (0.012s)
[509.594727] [115/130] (667s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[509.978962] Starting subtest: cursor-vs-flip-legacy
[541.058852] Subtest cursor-vs-flip-legacy: SUCCESS (31.079s)
[541.606016] [116/130] (635s left) kms_rotation_crc (bad-pixel-format)
[541.985167] Starting subtest: bad-pixel-format
[541.986836] Subtest bad-pixel-format: SKIP (0.001s)
[542.423297] [117/130] (634s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[542.789262] Starting subtest: short-flip-before-cursor-atomic-transitions
[543.779847] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.990s)
[544.333490] [118/130] (632s left) kms_pm_rpm (cursor-dpms)
[545.897676] Subtest cursor-dpms: SKIP (0.000s)
[546.141101] [119/130] (631s left) i915_module_load (reload)
[546.206977] Starting subtest: reload
[549.242178] Subtest reload: SUCCESS (3.034s)
[549.262498] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         2028 [max: 8192]
 direct dependencies:                 23042 [max: 524288]
 indirect dependencies:              169100
 all direct dependencies:            400833
 dependency chains:                   33449 [max: 524288]
 dependency chain hlocks used:       145849 [max: 2621440]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     143
 in-softirq chains:                     980
 in-process chains:                   32326
 stack-trace entries:                246855 [max: 524288]
 number of stack traces:              11937
 number of stack hash chains:          8489
 combined max dependencies:       271674032
 hardirq-safe locks:                     71
 hardirq-unsafe locks:                 1207
 softirq-safe locks:                    233
 softirq-unsafe locks:                 1094
 irq-safe locks:                        242
 irq-unsafe locks:                     1207
 hardirq-read-safe locks:                 5
 hardirq-read-unsafe locks:             373
 softirq-read-safe locks:                 9
 softirq-read-unsafe locks:             368
 irq-read-safe locks:                    10
 irq-read-unsafe locks:                 373
 uncategorized locks:                   344
 unused locks:                            1
 max locking depth:                      18
 max bfs queue depth:                   391
 max lock class index:                 2156
 debug_locks:                             0

 zapped classes:                        139
 zapped lock chains:                   4306
 large chain blocks:                      1

[549.293470] [FACT i915_module_load (reload)] new: kernel.is_tainted.taint_bad_page: true
[549.293499] [FACT i915_module_load (reload)] new: kernel.is_tainted.taint_warn: true
[549.294794] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: debugfs_test
results: parsing output: 3/ for test: sriov_basic
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_atomic_transition
results: parsing output: 15/ for test: gem_partial_pwrite_pread
results: parsing output: 16/ for test: kms_atomic
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_plane_cursor
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_getfb
results: parsing output: 22/ for test: gem_exercise_blt
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_pipe_b_c_ivb
results: parsing output: 31/ for test: prime_mmap_coherency
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: vgem_slow
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_chamelium_frames
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_atomic_interruptible
results: parsing output: 45/ for test: gem_mmap_offset
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: i915_pm_rps
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_dsc
results: parsing output: 57/ for test: kms_atomic
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_eio
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_feature_discovery
results: parsing output: 64/ for test: gem_workarounds
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_exec_params
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: gem_exec_fence
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_color
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_getfb
results: parsing output: 83/ for test: gem_readwrite
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: kms_getfb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_su
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: sysfs_preempt_timeout
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_setmode
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: dmabuf_sync_file
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: kms_scaling_modes
results: parsing output: 105/ for test: gem_ctx_isolation
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_chamelium_frames
results: parsing output: 108/ for test: gem_busy
results: parsing output: 109/ for test: gem_gtt_cpu_tlb
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_mmap_gtt
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: i915_module_load
results: parsing output: 119/ for test: perf
results: no output, setting notrun
results: parsing output: 120/ for test: gem_exec_schedule
results: no output, setting notrun
results: parsing output: 121/ for test: kms_joiner
results: no output, setting notrun
results: parsing output: 122/ for test: prime_self_import
results: no output, setting notrun
results: parsing output: 123/ for test: kms_prop_blob
results: no output, setting notrun
results: parsing output: 124/ for test: gem_exec_schedule
results: no output, setting notrun
results: parsing output: 125/ for test: drm_fdinfo
results: no output, setting notrun
results: parsing output: 126/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 127/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 128/ for test: kms_plane_multiple
results: no output, setting notrun
results: parsing output: 129/ for test: perf
results: no output, setting notrun
Done.