[72.826203] Initializing watchdogs
[72.826396]   /dev/watchdog0
[72.853118] [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)
[72.860830] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[72.865533] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.869152] [001/133] (960s left) gem_reg_read (bad-register)
[72.952946] Starting subtest: bad-register
[72.953654] Subtest bad-register: SUCCESS (0.000s)
[73.079855] [002/133] (960s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[73.580677] Starting subtest: 2x-flip-vs-rmfb-interruptible
[73.581445] Starting dynamic subtest: AB-VGA1-HDMI-A1
[103.973691] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.386s)
[103.975332] Subtest 2x-flip-vs-rmfb-interruptible: SUCCESS (30.389s)
[104.756735] [003/133] (928s left) api_intel_bb (bb-with-allocator)
[104.828922] Starting subtest: bb-with-allocator
[104.830385] Subtest bb-with-allocator: SKIP (0.000s)
[104.953104] [004/133] (928s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[105.453969] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[105.458255] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.001s)
[106.033337] [005/133] (927s left) gem_exec_fence (syncobj-repeat)
[106.272997] Starting subtest: syncobj-repeat
[106.704902] Subtest syncobj-repeat: SUCCESS (0.432s)
[107.092388] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[107.095070] [006/133] (926s left) syncobj_basic (bad-destroy-pad)
[107.149212] Starting subtest: bad-destroy-pad
[107.149974] Subtest bad-destroy-pad: SUCCESS (0.000s)
[107.269207] [007/133] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[107.760820] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[107.762280] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[108.370564] [008/133] (925s left) gem_exec_schedule (preemptive-hang)
[108.440036] Subtest preemptive-hang: SKIP (0.000s)
[108.670727] [009/133] (925s left) i915_hangman (error-state-basic)
[108.729666] Starting subtest: error-state-basic
[108.734204] Subtest error-state-basic: SUCCESS (0.005s)
[108.813813] [010/133] (924s left) kms_chamelium_color (gamma)
[109.305348] Subtest gamma: SKIP (0.000s)
[109.629455] [011/133] (924s left) syncobj_wait (single-wait-all-signaled)
[109.687766] Starting subtest: single-wait-all-signaled
[109.688496] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[109.816151] [012/133] (924s left) kms_psr (fbc-pr-cursor-blt)
[110.301176] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[110.609277] [013/133] (923s left) gem_exec_schedule (preempt-queue-contexts-chain)
[110.677624] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[110.915202] [014/133] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[111.409099] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[112.954760] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.545s)
[113.603340] [015/133] (920s left) kms_vblank (wait-forked-busy-hang)
[114.099199] Starting subtest: wait-forked-busy-hang
[114.100587] Starting dynamic subtest: pipe-A-HDMI-A-1
[119.938902] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.838s)
[119.966675] Starting dynamic subtest: pipe-B-HDMI-A-1
[125.939723] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.998s)
[125.940444] Subtest wait-forked-busy-hang: SUCCESS (11.841s)
[126.654055] [016/133] (907s left) perf_pmu (busy-accuracy-50)
[126.719763] Starting subtest: busy-accuracy-50
[126.720655] Starting dynamic subtest: rcs0
[126.722195] Dynamic subtest rcs0: SKIP (0.000s)
[126.733587] Starting dynamic subtest: bcs0
[126.735833] Dynamic subtest bcs0: SKIP (0.000s)
[126.749805] Starting dynamic subtest: vcs0
[126.752143] Dynamic subtest vcs0: SKIP (0.000s)
[126.753890] Subtest busy-accuracy-50: SKIP (0.002s)
[126.854128] [017/133] (907s left) gem_softpin (evict-prime-sanity-check)
[126.911323] Subtest evict-prime-sanity-check: SKIP (0.000s)
[127.036509] [018/133] (907s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[127.532775] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[128.953529] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (1.420s)
[129.600228] [019/133] (904s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[130.094133] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[130.131800] Starting dynamic subtest: pipe-A-plane-0
[130.133899] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[130.144990] Starting dynamic subtest: pipe-A-plane-1
[130.146293] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[130.155793] Starting dynamic subtest: pipe-A-plane-2
[130.157337] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[130.353924] Starting dynamic subtest: pipe-B-plane-0
[130.355274] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[130.364993] Starting dynamic subtest: pipe-B-plane-1
[130.366718] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[130.376107] Starting dynamic subtest: pipe-B-plane-2
[130.377687] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[130.429301] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.331s)
[131.141827] [020/133] (903s left) kms_chamelium_audio (hdmi-audio-edid)
[131.723765] Subtest hdmi-audio-edid: SKIP (0.000s)
[132.129423] [021/133] (902s left) gem_pread (display)
[132.187328] Starting subtest: display
[133.444935] Subtest display: SUCCESS (1.257s)
[133.579622] [022/133] (900s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[134.078792] Starting subtest: 4-tiled-32bpp-rotate-180
[134.081466] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[134.695164] [023/133] (899s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[134.754544] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[134.820822] [024/133] (899s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[134.871401] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[134.978270] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[135.109791] [025/133] (899s left) gem_exec_whisper (basic-contexts-all)
[135.173634] Starting subtest: basic-contexts-all
[136.501339] Subtest basic-contexts-all: SUCCESS (1.326s)
[136.738609] [026/133] (897s left) kms_invalid_mode (bad-hsync-end)
[137.235021] Starting subtest: bad-hsync-end
[137.248717] Starting dynamic subtest: pipe-A-HDMI-A-1
[137.305854] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.070s)
[137.318199] Starting dynamic subtest: pipe-B-HDMI-A-1
[137.318883] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[137.319521] Subtest bad-hsync-end: SUCCESS (0.073s)
[137.819268] [027/133] (896s left) i915_suspend (basic-s3-without-i915)
[137.873711] Starting subtest: basic-s3-without-i915
[157.819464] Subtest basic-s3-without-i915: SUCCESS (3.393s)
[163.898054] [028/133] (876s left) kms_addfb_basic (bad-pitch-65536)
[163.982848] Starting subtest: bad-pitch-65536
[163.983636] Subtest bad-pitch-65536: SUCCESS (0.001s)
[165.050616] [029/133] (875s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[165.544093] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[165.545540] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[166.154558] [030/133] (874s left) gem_flink_basic (double-flink)
[166.213556] Starting subtest: double-flink
[166.214717] Subtest double-flink: SUCCESS (0.000s)
[166.352251] [031/133] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[166.842741] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[166.844230] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[167.440727] [032/133] (873s left) kms_big_fb (linear-16bpp-rotate-90)
[167.942899] Starting subtest: linear-16bpp-rotate-90
[168.093479] Subtest linear-16bpp-rotate-90: SKIP (0.149s)
[168.722971] [033/133] (872s left) gen7_exec_parse (oacontrol-tracking)
[168.784526] Subtest oacontrol-tracking: SKIP (0.000s)
[168.854717] [034/133] (872s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[168.906885] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[168.968068] [035/133] (872s left) prime_vgem (coherency-blt)
[169.026231] Starting subtest: coherency-blt
[169.669757] Subtest coherency-blt: SUCCESS (0.643s)
[169.841336] [036/133] (871s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[170.327734] Starting subtest: compare-crc-sanitycheck-nv12
[170.328697] Starting dynamic subtest: pipe-A-HDMI-A-1
[170.330085] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[170.342370] Starting dynamic subtest: pipe-B-HDMI-A-1
[170.343796] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[170.345144] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[170.903928] [037/133] (870s left) kms_chamelium_hpd (hdmi-hpd)
[171.469672] Subtest hdmi-hpd: SKIP (0.000s)
[171.875926] [038/133] (869s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[172.369851] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[172.414045] Starting dynamic subtest: pipe-A-plane-0
[172.415929] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[172.431677] Starting dynamic subtest: pipe-A-plane-1
[172.434059] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[172.446063] Starting dynamic subtest: pipe-A-plane-2
[172.447589] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[172.660740] Starting dynamic subtest: pipe-B-plane-0
[172.662929] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[172.674666] Starting dynamic subtest: pipe-B-plane-1
[172.676307] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[172.687475] Starting dynamic subtest: pipe-B-plane-2
[172.688836] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[172.742960] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.371s)
[173.454806] [039/133] (867s left) gem_mmap_offset (open-flood)
[173.512139] Starting subtest: open-flood
[195.020361] Subtest open-flood: SUCCESS (21.509s)
[195.188966] [040/133] (846s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[195.727382] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[195.728930] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[196.310365] [041/133] (845s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[196.370273] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[196.474227] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[196.605590] [042/133] (844s left) vgem_basic (create)
[196.675027] Starting subtest: create
[196.675858] Subtest create: SUCCESS (0.000s)
[196.792955] [043/133] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[197.283730] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[197.285239] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[197.870046] [044/133] (843s left) kms_psr (fbc-psr-cursor-plane-move)
[198.361564] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[198.662378] [045/133] (843s left) kms_vblank (accuracy-idle)
[199.147674] Starting subtest: accuracy-idle
[199.148398] Starting dynamic subtest: pipe-A-HDMI-A-1
[201.379146] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.230s)
[201.392123] Starting dynamic subtest: pipe-B-HDMI-A-1
[203.636011] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.254s)
[203.636895] Subtest accuracy-idle: SUCCESS (4.489s)
[204.367574] [046/133] (837s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[204.429243] Starting subtest: cpuset-medium-copy-XY
[206.601161] Subtest cpuset-medium-copy-XY: SUCCESS (2.173s)
[206.766252] [047/133] (835s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[207.378139] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[207.686976] [048/133] (834s left) kms_flip (2x-flip-vs-suspend-interruptible)
[208.185747] Starting subtest: 2x-flip-vs-suspend-interruptible
[208.187790] Starting dynamic subtest: AB-VGA1-HDMI-A1
[412.404498] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[419.255703] Closing watchdogs
[419.261073] Initializing watchdogs
[419.261139]   /dev/watchdog0
[419.284831] [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)
[419.296335] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[419.298155] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[419.298876] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[419.303064] [049/133] (628s left) kms_busy (extended-pageflip-hang-newfb)
[419.843291] Starting subtest: extended-pageflip-hang-newfb
[419.844930] Starting dynamic subtest: pipe-A
[425.858307] Dynamic subtest pipe-A: SUCCESS (6.012s)
[425.872926] Starting dynamic subtest: pipe-B
[431.866060] Dynamic subtest pipe-B: SUCCESS (6.005s)
[431.868212] Subtest extended-pageflip-hang-newfb: SUCCESS (12.024s)
[432.606638] [050/133] (615s left) kms_draw_crc (draw-method-render)
[433.099633] Starting subtest: draw-method-render
[433.100378] Starting dynamic subtest: xrgb8888-untiled
[433.399199] Dynamic subtest xrgb8888-untiled: SUCCESS (0.300s)
[433.416974] Starting dynamic subtest: rgb565-untiled
[433.682534] Dynamic subtest rgb565-untiled: SUCCESS (0.281s)
[433.698916] Starting dynamic subtest: xrgb2101010-untiled
[433.998569] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.313s)
[434.015270] Starting dynamic subtest: xbgr16161616f-untiled
[434.347987] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.347s)
[434.364372] Starting dynamic subtest: xrgb8888-xtiled
[434.514599] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.163s)
[434.531053] Starting dynamic subtest: rgb565-xtiled
[434.663996] Dynamic subtest rgb565-xtiled: SUCCESS (0.147s)
[434.681335] Starting dynamic subtest: xrgb2101010-xtiled
[434.830335] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.164s)
[434.847198] Starting dynamic subtest: xbgr16161616f-xtiled
[435.013272] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.181s)
[435.014413] Subtest draw-method-render: SUCCESS (1.916s)
[435.619589] [051/133] (612s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[435.693542] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[435.765237] [052/133] (612s left) syncobj_wait (invalid-single-wait-unsubmitted)
[435.828702] Starting subtest: invalid-single-wait-unsubmitted
[435.829477] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[435.962989] [053/133] (612s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[436.445915] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[436.446558] Starting dynamic subtest: pipe-A
[436.448501] Dynamic subtest pipe-A: SKIP (0.001s)
[436.465074] Starting dynamic subtest: pipe-B
[436.467086] Dynamic subtest pipe-B: SKIP (0.001s)
[436.468469] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.004s)
[437.034073] [054/133] (611s left) gen9_exec_parse (unaligned-jump)
[437.095259] Subtest unaligned-jump: SKIP (0.000s)
[437.158027] [055/133] (611s left) gem_eio (in-flight-suspend)
[437.226332] Starting subtest: in-flight-suspend
[475.125020] Subtest in-flight-suspend: SUCCESS (6.473s)
[482.174552] [056/133] (572s left) kms_pm_rpm (universal-planes)
[493.970856] Subtest universal-planes: SKIP (0.000s)
[494.292058] [057/133] (560s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[494.796709] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[494.798341] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[495.402362] [058/133] (559s left) api_intel_bb (simple-bb)
[495.461002] Starting subtest: simple-bb
[495.463756] Subtest simple-bb: SUCCESS (0.002s)
[495.626866] [059/133] (558s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[496.121136] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[496.122536] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[496.706739] [060/133] (557s left) kms_psr (pr-cursor-mmap-cpu)
[497.195257] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[497.501093] [061/133] (557s left) kms_cursor_crc (cursor-random-32x10)
[497.994543] Starting subtest: cursor-random-32x10
[498.050101] Subtest cursor-random-32x10: SKIP (0.055s)
[498.668442] [062/133] (556s left) gem_pwrite (basic-self)
[498.730657] Starting subtest: basic-self
[498.823128] Subtest basic-self: SUCCESS (0.093s)
[498.972547] [063/133] (555s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[499.031243] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[499.032015] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[499.170769] [064/133] (555s left) prime_mmap (test_userptr)
[499.230138] Starting subtest: test_userptr
[499.233424] Starting dynamic subtest: test_userptr-smem
[499.234145] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[499.234973] Subtest test_userptr: SUCCESS (0.004s)
[499.371979] [065/133] (555s left) gem_create (hog-create)
[499.438383] Starting subtest: hog-create
[499.439060] Starting dynamic subtest: smem0
[531.692916] Dynamic subtest smem0: SUCCESS (32.257s)
[531.696791] Subtest hog-create: SUCCESS (32.260s)
[531.930726] [066/133] (522s left) syncobj_timeline (invalid-signal-illegal-handle)
[531.991486] Starting subtest: invalid-signal-illegal-handle
[531.992298] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[532.118540] [067/133] (522s left) gem_userptr_blits (unsync-unmap)
[532.178546] Subtest unsync-unmap: SKIP (0.000s)
[532.344361] [068/133] (522s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[532.832312] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[532.833911] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[533.446968] [069/133] (521s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[533.946876] Starting subtest: dp-mst-type-1-suspend-resume
[533.948235] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[534.561016] [070/133] (520s left) syncobj_timeline (etime-multi-wait-submitted)
[534.621101] Starting subtest: etime-multi-wait-submitted
[534.731354] Subtest etime-multi-wait-submitted: SUCCESS (0.109s)
[534.862613] [071/133] (520s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[535.362939] Starting subtest: x-tiled-64bpp-rotate-90
[535.373073] Subtest x-tiled-64bpp-rotate-90: SKIP (0.010s)
[535.989603] [072/133] (519s left) gem_exec_balancer (parallel-contexts)
[536.050162] Subtest parallel-contexts: SKIP (0.000s)
[536.175003] [073/133] (519s left) kms_hdr (invalid-hdr)
[536.657987] Starting subtest: invalid-hdr
[536.660000] Subtest invalid-hdr: SKIP (0.000s)
[537.271941] [074/133] (518s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[537.755115] Starting subtest: flip-vs-cursor-atomic
[547.498107] Subtest flip-vs-cursor-atomic: SUCCESS (9.742s)
[548.212200] [075/133] (507s left) perf (whitelisted-registers-userspace-config)
[548.414174] Subtest whitelisted-registers-userspace-config: SKIP (0.000s)
[548.488547] [076/133] (506s left) gem_ccs (block-copy-compressed)
[548.549168] Subtest block-copy-compressed: SKIP (0.000s)
[548.623330] [077/133] (506s left) prime_mmap (test_aperture_limit)
[548.676168] Starting subtest: test_aperture_limit
[548.677481] Starting dynamic subtest: test_aperture_limit-smem
[548.686734] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.010s)
[548.687575] Subtest test_aperture_limit: SUCCESS (0.011s)
[548.812210] [078/133] (506s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[548.868636] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[548.942898] [079/133] (506s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[549.426351] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[549.427734] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[550.039951] [080/133] (505s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[550.094992] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[550.169724] [081/133] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[550.655032] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[550.656619] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[551.268099] [082/133] (504s left) syncobj_timeline (wait-all-complex)
[551.330949] Starting subtest: wait-all-complex
[551.545405] Subtest wait-all-complex: SUCCESS (0.215s)
[551.685454] [083/133] (504s left) gem_exec_balancer (nop)
[551.741100] Subtest nop: SKIP (0.000s)
[551.848446] [084/133] (504s left) gem_ctx_param (invalid-get-ringsize)
[551.904225] Starting subtest: invalid-get-ringsize
[551.904889] Subtest invalid-get-ringsize: SUCCESS (0.000s)
[552.035122] [085/133] (503s left) kms_cursor_crc (cursor-onscreen-max-size)
[552.532399] Starting subtest: cursor-onscreen-max-size
[552.534561] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[553.135925] [086/133] (502s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[553.628828] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[553.630276] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[554.233262] [087/133] (501s left) kms_psr (psr-dpms)
[554.722929] Subtest psr-dpms: SKIP (0.000s)
[555.021896] [088/133] (501s left) kms_pm_dc (dc9-dpms)
[566.130065] Subtest dc9-dpms: SKIP (0.000s)
[566.198612] [089/133] (489s left) i915_pm_rpm (reg-read-ioctl)
[577.978098] Subtest reg-read-ioctl: SKIP (0.000s)
[578.305190] [090/133] (477s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[578.800158] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[579.111915] [091/133] (477s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[579.598838] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[579.600146] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[580.214293] [092/133] (476s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[580.280244] Starting subtest: basic-batch-kernel-default-cmd
[580.283226] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[580.529556] [093/133] (475s left) gem_exec_fence (syncobj-unused-fence)
[580.736953] Starting subtest: syncobj-unused-fence
[580.739463] Subtest syncobj-unused-fence: SUCCESS (0.003s)
[581.124922] [094/133] (475s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[581.622964] Starting subtest: 4-tiled-16bpp-rotate-180
[581.624220] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[582.236968] [095/133] (474s left) gem_softpin (noreloc-s3)
[582.298250] Starting subtest: noreloc-S3
[636.705969] Subtest noreloc-S3: SUCCESS (5.402s)
[644.847851] [096/133] (419s left) kms_psr (psr2-sprite-plane-move)
[645.340646] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[645.648108] [097/133] (419s left) kms_color (ctm-0-25)
[646.140116] Starting subtest: ctm-0-25
[646.140780] Starting dynamic subtest: pipe-A-HDMI-A-1
[647.566039] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.426s)
[647.584848] Starting dynamic subtest: pipe-B-HDMI-A-1
[649.002730] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.434s)
[649.003953] Subtest ctm-0-25: SUCCESS (2.864s)
[649.759763] [098/133] (414s left) syncobj_wait (wait-zero-handles)
[649.833011] Starting subtest: wait-zero-handles
[649.834209] Subtest wait-zero-handles: SUCCESS (0.000s)
[649.973325] [099/133] (414s left) gem_workarounds (basic-read-context)
[650.040930] Starting subtest: basic-read-context
[650.045228] Subtest basic-read-context: SUCCESS (0.004s)
[650.210935] [100/133] (414s left) kms_flip (busy-flip)
[650.696919] Starting subtest: busy-flip
[650.699489] Starting dynamic subtest: A-VGA1
[651.446081] Dynamic subtest A-VGA1: SUCCESS (0.748s)
[651.462994] Starting dynamic subtest: B-VGA1
[652.147947] Dynamic subtest B-VGA1: SUCCESS (0.698s)
[652.164417] Starting dynamic subtest: A-HDMI-A1
[652.937279] Dynamic subtest A-HDMI-A1: SUCCESS (0.787s)
[652.957131] Starting dynamic subtest: B-HDMI-A1
[653.738348] Dynamic subtest B-HDMI-A1: SUCCESS (0.798s)
[653.742032] Subtest busy-flip: SUCCESS (3.044s)
[654.550709] [101/133] (410s left) gem_fence_thrash (bo-write-verify-none)
[654.610859] Starting subtest: bo-write-verify-none
[655.739218] Subtest bo-write-verify-none: SUCCESS (1.129s)
[655.898850] [102/133] (409s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[656.390027] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[656.392127] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[656.990468] [103/133] (408s left) syncobj_wait (wait-for-submit-snapshot)
[657.050141] Starting subtest: wait-for-submit-snapshot
[657.133265] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[657.256677] [104/133] (407s left) kms_mmap_write_crc (main)
[657.748453] Starting subtest: main
[657.750699] Starting dynamic subtest: pipe-A-HDMI-A-1
[660.546982] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.796s)
[660.549469] Subtest main: SUCCESS (2.800s)
[661.277709] [105/133] (403s left) gem_pxp (hw-rejects-pxp-buffer)
[663.853128] Starting subtest: hw-rejects-pxp-buffer
[663.853955] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[664.001480] [106/133] (401s left) syncobj_wait (wait-all-interrupted)
[664.064955] Starting subtest: wait-all-interrupted
[664.166657] Subtest wait-all-interrupted: SUCCESS (0.102s)
[664.300943] [107/133] (400s left) gem_mmap_gtt (basic-short)
[664.356348] Starting subtest: basic-short
[664.383247] Subtest basic-short: SUCCESS (0.027s)
[664.539920] [108/133] (400s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[665.034200] Starting subtest: fbc-rgb565-draw-mmap-wc
[666.858404] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.823s)
[667.531064] [109/133] (397s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[668.018974] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[668.020490] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[668.623643] [110/133] (396s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[669.110710] Starting subtest: short-busy-flip-before-cursor-toggle
[669.112487] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[669.731535] [111/133] (395s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[670.222132] Starting subtest: fbcpsr-tiling-4
[670.225988] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[670.835771] [112/133] (394s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[671.322345] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[671.323058] Starting dynamic subtest: pipe-A
[671.325059] Dynamic subtest pipe-A: SKIP (0.001s)
[671.341589] Starting dynamic subtest: pipe-B
[671.343346] Dynamic subtest pipe-B: SKIP (0.001s)
[671.344512] Subtest plane-scaler-with-clipping-clamping-modifiers: SKIP (0.005s)
[671.937009] [113/133] (393s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[672.425962] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[672.729843] [114/133] (392s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[673.220732] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[673.222279] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[673.855193] [115/133] (391s left) intel_hwmon (hwmon-write)
[673.911385] Subtest hwmon-write: SKIP (0.000s)
[673.975226] [116/133] (391s left) perf_pmu (gt-awake)
[674.032166] Starting subtest: gt-awake
[676.047734] Subtest gt-awake: SUCCESS (2.014s)
[676.195937] [117/133] (389s left) gem_exec_async (forked-writes)
[676.260909] Starting subtest: forked-writes
[676.261977] Starting dynamic subtest: rcs0
[676.277205] Dynamic subtest rcs0: SUCCESS (0.016s)
[676.294956] Starting dynamic subtest: bcs0
[676.295829] Dynamic subtest bcs0: SUCCESS (0.014s)
[676.311292] Starting dynamic subtest: vcs0
[676.315934] Dynamic subtest vcs0: SUCCESS (0.021s)
[676.316784] Subtest forked-writes: SUCCESS (0.056s)
[676.590578] [118/133] (389s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[677.076494] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[679.000656] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.925s)
[679.651090] [119/133] (386s left) gem_fence_thrash (bo-write-verify-threaded-none)
[679.712544] Starting subtest: bo-write-verify-threaded-none
[681.523106] Subtest bo-write-verify-threaded-none: SUCCESS (1.811s)
[681.650786] [120/133] (384s left) gem_exec_whisper (basic-queues-forked-all)
[681.718635] Starting subtest: basic-queues-forked-all
[681.720392] Subtest basic-queues-forked-all: SKIP (0.002s)
[681.966727] [121/133] (384s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[682.024220] Starting subtest: write-cpu-read-wc-unflushed
[682.144975] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.121s)
[682.280351] [122/133] (383s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[682.336121] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[682.336914] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[682.460124] [123/133] (383s left) gem_wait (write-busy)
[682.533263] Starting subtest: write-busy
[682.534222] Starting dynamic subtest: all-engines
[683.054993] Dynamic subtest all-engines: SUCCESS (0.521s)
[683.072164] Starting dynamic subtest: rcs0
[683.573710] Dynamic subtest rcs0: SUCCESS (0.516s)
[683.591271] Starting dynamic subtest: bcs0
[684.090635] Dynamic subtest bcs0: SUCCESS (0.514s)
[684.108043] Starting dynamic subtest: vcs0
[684.608813] Dynamic subtest vcs0: SUCCESS (0.515s)
[684.612713] Subtest write-busy: SUCCESS (2.077s)
[684.878076] [124/133] (381s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[685.375264] Starting subtest: y-tiled-32bpp-rotate-90
[685.376493] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[685.959065] [125/133] (380s left) gem_ctx_persistence (heartbeat-many)
[686.019826] Subtest heartbeat-many: SKIP (0.000s)
[686.089204] [126/133] (380s left) dmabuf_sync_file (export-before-signal)
[686.156633] Starting subtest: export-before-signal
[686.157335] Subtest export-before-signal: SUCCESS (0.002s)
[686.274995] [127/133] (380s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[686.759982] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[686.761334] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[687.374400] [128/133] (379s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[687.854449] Starting subtest: basic-flip-after-cursor-atomic
[688.829806] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.975s)
[689.533102] [129/133] (376s left) gem_tiled_wb
[698.268772] [130/133] (368s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[698.333791] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[698.335901] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[698.581951] [131/133] (368s left) perf_pmu (all-busy-idle-check-all)
[698.638492] Starting subtest: all-busy-idle-check-all
[699.256740] Subtest all-busy-idle-check-all: SUCCESS (0.619s)
[699.411574] [132/133] (367s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[699.468998] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[699.539927] [133/133] (367s left) kms_cursor_crc (cursor-suspend)
[700.032059] Starting subtest: cursor-suspend
[700.034916] Starting dynamic subtest: pipe-A-HDMI-A-1
[734.394227] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.908s)
[734.410648] Starting dynamic subtest: pipe-B-HDMI-A-1
[769.433123] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.066s)
[769.433846] Subtest cursor-suspend: SUCCESS (3.980s)
[777.194648] Closing watchdogs
results: parsing output: 0/ for test: gem_reg_read
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: api_intel_bb
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: syncobj_basic
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: i915_hangman
results: parsing output: 9/ for test: kms_chamelium_color
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_vblank
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: gem_softpin
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: kms_chamelium_audio
results: parsing output: 20/ for test: gem_pread
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: kms_invalid_mode
results: parsing output: 26/ for test: i915_suspend
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_flink_basic
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gen7_exec_parse
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: kms_pipe_crc_basic
results: parsing output: 36/ for test: kms_chamelium_hpd
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: gem_mmap_offset
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: vgem_basic
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_busy
results: parsing output: 49/ for test: kms_draw_crc
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: gem_pwrite
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: prime_mmap
results: parsing output: 64/ for test: gem_create
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_content_protection
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: kms_hdr
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: gem_ccs
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_pm_dc
results: parsing output: 88/ for test: i915_pm_rpm
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_flush
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_color
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: gem_workarounds
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: gem_fence_thrash
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_mmap_write_crc
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: intel_hwmon
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: gem_exec_async
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_fence_thrash
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_wait
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: dmabuf_sync_file
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: gem_tiled_wb
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: kms_pipe_b_c_ivb
results: parsing output: 132/ for test: kms_cursor_crc
Done.