[73.141752] Initializing watchdogs
[73.141899]   /dev/watchdog0
[73.167867] [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)
[73.175810] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.179788] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.183563] [001/134] (960s left) syncobj_wait (wait-for-submit-snapshot)
[73.252323] Starting subtest: wait-for-submit-snapshot
[73.335368] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[73.422111] [002/134] (960s left) gem_mmap_gtt (basic-read-write-distinct)
[73.478352] Starting subtest: basic-read-write-distinct
[73.494734] Subtest basic-read-write-distinct: SUCCESS (0.017s)
[73.622056] [003/134] (960s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[74.197528] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[74.594589] [004/134] (959s left) prime_vgem (coherency-blt)
[74.699576] Starting subtest: coherency-blt
[75.380217] Subtest coherency-blt: SUCCESS (0.636s)
[75.497810] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[75.501291] [005/134] (958s left) gem_mmap_gtt (fault-concurrent-y)
[75.558608] Starting subtest: fault-concurrent-Y
[78.529385] Subtest fault-concurrent-Y: SUCCESS (2.970s)
[78.761443] [006/134] (955s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[78.824784] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[78.827556] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[79.063392] [007/134] (954s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[79.126210] Starting subtest: basic-batch-kernel-default-cmd
[79.128666] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[79.360245] [008/134] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[79.861648] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[79.864467] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[80.476694] [009/134] (953s left) gem_exec_whisper (basic-queues)
[80.542324] Starting subtest: basic-queues
[80.546645] Subtest basic-queues: SKIP (0.003s)
[80.775282] [010/134] (953s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[80.835184] Subtest saturated-hostile-nopreempt: SKIP (0.000s)
[80.887655] [011/134] (953s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[81.394878] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[81.397185] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[82.025145] [012/134] (952s left) kms_flip (2x-plain-flip-fb-recreate)
[82.520992] Starting subtest: 2x-plain-flip-fb-recreate
[82.523493] Starting dynamic subtest: AB-VGA1-HDMI-A1
[113.215208] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.692s)
[113.216262] Subtest 2x-plain-flip-fb-recreate: SUCCESS (30.695s)
[114.048259] [013/134] (920s left) kms_psr (pr-primary-render)
[114.545529] Subtest pr-primary-render: SKIP (0.000s)
[114.840982] [014/134] (919s left) kms_plane_scaling (invalid-parameters)
[115.333895] Subtest invalid-parameters: SKIP (0.000s)
[115.928585] [015/134] (918s left) kms_frontbuffer_tracking (fbc-stridechange)
[116.427550] Starting subtest: fbc-stridechange
[117.844379] Subtest fbc-stridechange: SUCCESS (1.417s)
[118.492288] [016/134] (915s left) kms_chamelium_edid (vga-edid-read)
[119.059358] Subtest vga-edid-read: SKIP (0.000s)
[119.460140] [017/134] (915s left) kms_getfb (getfb2-into-addfb2)
[119.952570] Starting subtest: getfb2-into-addfb2
[119.953648] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[120.566271] [018/134] (913s left) kms_pm_dc (dc3co-vpb-simulation)
[131.666485] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[131.726859] [019/134] (902s left) gem_eio (in-flight-contexts-immediate)
[131.790191] Starting subtest: in-flight-contexts-immediate
[136.119654] Subtest in-flight-contexts-immediate: SUCCESS (4.329s)
[137.185211] [020/134] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[137.690991] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[137.693251] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[138.297913] [021/134] (896s left) gem_eio (in-flight-1us)
[138.358841] Starting subtest: in-flight-1us
[139.742434] Subtest in-flight-1us: SUCCESS (1.385s)
[140.776151] [022/134] (893s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[141.269513] Starting subtest: cursor-tearing-framebuffer-change
[141.270537] Starting dynamic subtest: pipe-A-HDMI-A-1
[141.624413] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.352s)
[141.637284] Starting dynamic subtest: pipe-B-HDMI-A-1
[141.987411] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.362s)
[141.988429] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.717s)
[142.683181] [023/134] (892s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[143.180970] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[143.183219] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[143.779695] [024/134] (891s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[143.842600] Starting subtest: etime-single-wait-for-submit-unsubmitted
[143.947239] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[144.079846] [025/134] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[144.577458] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[144.579588] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[145.177999] [026/134] (889s left) gem_exec_gttfill (engines)
[145.245442] Starting subtest: engines
[145.246590] Starting dynamic subtest: rcs0
[169.467704] Dynamic subtest rcs0: SUCCESS (24.220s)
[169.480585] Starting dynamic subtest: bcs0
[193.651191] Dynamic subtest bcs0: SUCCESS (24.184s)
[193.652461] Subtest engines: SUCCESS (48.406s)
[193.884747] [027/134] (841s left) kms_cursor_crc (cursor-random-256x85)
[194.477767] Starting subtest: cursor-random-256x85
[194.533105] Subtest cursor-random-256x85: SKIP (0.054s)
[195.142803] [028/134] (839s left) gem_exec_balancer (sliced)
[195.202458] Subtest sliced: SKIP (0.000s)
[195.308575] [029/134] (839s left) kms_rotation_crc (multiplane-rotation)
[195.795664] Starting subtest: multiplane-rotation
[195.799105] Subtest multiplane-rotation: SKIP (0.000s)
[196.426854] [030/134] (838s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[196.921147] Starting subtest: fbcpsr-rgb565-draw-blt
[196.923234] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[197.520963] [031/134] (837s left) gem_tiled_pread_basic
[197.844942] [032/134] (837s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[198.345530] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[198.649544] [033/134] (836s left) kms_addfb_basic (clobberred-modifier)
[198.705847] Starting subtest: clobberred-modifier
[198.706943] Subtest clobberred-modifier: SUCCESS (0.000s)
[199.754938] [034/134] (835s left) kms_flip (plain-flip-ts-check)
[200.251844] Starting subtest: plain-flip-ts-check
[200.252949] Starting dynamic subtest: A-VGA1
[208.333296] Dynamic subtest A-VGA1: SUCCESS (8.081s)
[208.346505] Starting dynamic subtest: B-VGA1
[216.322808] Dynamic subtest B-VGA1: SUCCESS (7.987s)
[216.338827] Starting dynamic subtest: A-HDMI-A1
[224.345922] Dynamic subtest A-HDMI-A1: SUCCESS (8.020s)
[224.360360] Starting dynamic subtest: B-HDMI-A1
[232.400382] Dynamic subtest B-HDMI-A1: SUCCESS (8.052s)
[232.401739] Subtest plain-flip-ts-check: SUCCESS (32.151s)
[233.173314] [035/134] (802s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[233.670898] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[235.483430] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (1.814s)
[236.115912] [036/134] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[236.612333] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[236.614571] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[237.214109] [037/134] (798s left) kms_addfb_basic (invalid-get-prop-any)
[237.270977] Starting subtest: invalid-get-prop-any
[237.272164] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[238.312133] [038/134] (797s left) gen9_exec_parse (shadow-peek)
[238.369043] Subtest shadow-peek: SKIP (0.000s)
[238.426204] [039/134] (797s left) core_getstats (basic)
[238.481187] Starting subtest: basic
[238.482320] Subtest basic: SUCCESS (0.000s)
[238.611488] [040/134] (797s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[239.099957] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[239.103159] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[239.706716] [041/134] (796s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[240.199398] Starting subtest: short-flip-before-cursor-toggle
[241.170365] Subtest short-flip-before-cursor-toggle: SUCCESS (0.973s)
[241.921219] [042/134] (793s left) core_auth (getclient-master-drop)
[241.974479] Starting subtest: getclient-master-drop
[241.978138] Subtest getclient-master-drop: SUCCESS (0.003s)
[242.108831] [043/134] (793s left) gem_eio (in-flight-external)
[242.171232] Starting subtest: in-flight-external
[242.210106] Subtest in-flight-external: SUCCESS (0.038s)
[243.252066] [044/134] (792s left) gem_mmap (big-bo)
[243.309178] Starting subtest: big-bo
[243.906944] Subtest big-bo: SUCCESS (0.597s)
[244.048703] [045/134] (791s left) syncobj_eventfd (invalid-illegal-eventfd)
[244.222681] Starting subtest: invalid-illegal-eventfd
[244.223788] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[244.354499] [046/134] (791s left) kms_cursor_crc (cursor-offscreen-64x64)
[244.872546] Starting subtest: cursor-offscreen-64x64
[244.875351] Starting dynamic subtest: pipe-A-HDMI-A-1
[247.275341] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.401s)
[247.312447] Starting dynamic subtest: pipe-B-HDMI-A-1
[249.690974] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.388s)
[249.692142] Subtest cursor-offscreen-64x64: SUCCESS (4.819s)
[250.416946] [047/134] (785s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[250.475534] Starting subtest: basic-wc-gtt-noreloc
[250.478476] Subtest basic-wc-gtt-noreloc: SUCCESS (0.003s)
[251.516553] [048/134] (784s left) kms_atomic_transition (modeset-transition-nonblocking)
[252.005477] Starting subtest: modeset-transition-nonblocking
[252.006554] Starting dynamic subtest: 1x-outputs
[252.958223] Dynamic subtest 1x-outputs: SUCCESS (0.952s)
[252.960147] Subtest modeset-transition-nonblocking: SUCCESS (0.954s)
[253.678860] [049/134] (782s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[254.167322] Starting subtest: primary-y-tiled-reflect-x-90
[254.169496] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[254.757778] [050/134] (781s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[255.247748] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[255.249999] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[255.857543] [051/134] (780s left) syncobj_timeline (multi-wait-available-submitted)
[255.915367] Starting subtest: multi-wait-available-submitted
[255.916470] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[256.052376] [052/134] (780s left) gem_exec_reloc (basic-cpu-read)
[256.110964] Starting subtest: basic-cpu-read
[256.113369] Subtest basic-cpu-read: SUCCESS (0.003s)
[257.134547] [053/134] (779s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[257.633730] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[257.638189] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[258.233317] [054/134] (778s left) kms_plane_scaling (planes-scaler-unity-scaling)
[258.719264] Starting subtest: planes-scaler-unity-scaling
[258.720279] Starting dynamic subtest: pipe-A
[258.723329] Dynamic subtest pipe-A: SKIP (0.001s)
[258.737212] Starting dynamic subtest: pipe-B
[258.740162] Dynamic subtest pipe-B: SKIP (0.001s)
[258.742133] Subtest planes-scaler-unity-scaling: SKIP (0.004s)
[259.328719] [055/134] (777s left) sw_sync (sync_busy_fork_unixsocket)
[259.382294] Starting subtest: sync_busy_fork_unixsocket
[259.397443] Subtest sync_busy_fork_unixsocket: SUCCESS (0.015s)
[259.513995] [056/134] (777s left) gem_pxp (reject-modify-context-protection-on)
[262.086220] Starting subtest: reject-modify-context-protection-on
[262.088386] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[262.228205] [057/134] (774s left) kms_color (ctm-0-25)
[262.719510] Starting subtest: ctm-0-25
[262.720871] Starting dynamic subtest: pipe-A-HDMI-A-1
[264.151922] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.434s)
[264.171463] Starting dynamic subtest: pipe-B-HDMI-A-1
[265.608612] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.455s)
[265.609784] Subtest ctm-0-25: SUCCESS (2.893s)
[266.327935] [058/134] (770s left) kms_psr2_su (page_flip-nv12)
[266.390447] Subtest page_flip-NV12: SKIP (0.000s)
[266.457586] [059/134] (770s left) gem_readwrite (read-bad-handle)
[266.514390] Starting subtest: read-bad-handle
[266.516474] Subtest read-bad-handle: SUCCESS (0.000s)
[266.660167] [060/134] (770s left) kms_async_flips (alternate-sync-async-flip)
[267.137537] Starting subtest: alternate-sync-async-flip
[267.278051] Starting dynamic subtest: pipe-A-HDMI-A-1
[269.431774] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.153s)
[269.594057] Starting dynamic subtest: pipe-B-HDMI-A-1
[271.696158] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.112s)
[271.697418] Subtest alternate-sync-async-flip: SUCCESS (4.559s)
[272.541193] [061/134] (764s left) kms_vblank (wait-busy-hang)
[273.030381] Starting subtest: wait-busy-hang
[273.033701] Starting dynamic subtest: pipe-A-HDMI-A-1
[278.909172] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.877s)
[278.923205] Starting dynamic subtest: pipe-B-HDMI-A-1
[284.933828] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.022s)
[284.936448] Subtest wait-busy-hang: SUCCESS (11.906s)
[285.667600] [062/134] (751s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[286.157440] Starting subtest: cursorA-vs-flipB-legacy
[286.159720] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[286.761035] [063/134] (750s left) gem_mmap_wc (set-cache-level)
[286.815238] Starting subtest: set-cache-level
[286.816276] Subtest set-cache-level: SUCCESS (0.001s)
[286.942891] [064/134] (750s left) gem_exec_alignment (pi)
[287.004317] Starting subtest: pi
[287.006653] Subtest pi: SKIP (0.000s)
[287.160267] [065/134] (749s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[287.648429] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[289.555321] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (1.909s)
[290.189483] [066/134] (746s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[290.245275] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[290.299810] [067/134] (746s left) gen9_exec_parse (bb-start-far)
[290.358432] Subtest bb-start-far: SKIP (0.000s)
[290.414836] [068/134] (746s left) gem_ctx_exec (basic-norecovery)
[290.471293] Starting subtest: basic-norecovery
[290.480105] Subtest basic-norecovery: SUCCESS (0.009s)
[290.636441] [069/134] (746s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[291.122327] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[291.124571] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[291.720997] [070/134] (745s left) gem_tiled_blits (interruptible)
[291.910089] Starting subtest: interruptible
[299.524750] Subtest interruptible: SUCCESS (7.615s)
[299.693344] [071/134] (737s left) kms_dp_link_training (uhbr-sst)
[300.287230] Starting subtest: uhbr-sst
[300.289419] Subtest uhbr-sst: SKIP (0.000s)
[300.617823] [072/134] (736s left) sysfs_heartbeat_interval (precise)
[300.680654] Starting subtest: precise
[300.681758] Starting dynamic subtest: vcs0
[300.683994] Dynamic subtest vcs0: SKIP (0.000s)
[300.698783] Starting dynamic subtest: bcs0
[300.701535] Dynamic subtest bcs0: SKIP (0.000s)
[300.720032] Starting dynamic subtest: rcs0
[300.722832] Dynamic subtest rcs0: SKIP (0.000s)
[300.725503] Subtest precise: SKIP (0.005s)
[300.818779] [073/134] (736s left) gem_exec_schedule (preempt-queue-contexts-chain)
[300.898720] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[301.130598] [074/134] (736s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[301.185663] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (0.000s)
[301.246557] [075/134] (736s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[301.302166] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.000s)
[301.360653] [076/134] (736s left) kms_joiner (basic-force-ultra-joiner)
[301.843363] Starting subtest: basic-force-ultra-joiner
[301.845468] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[302.445371] [077/134] (735s left) gem_workarounds (reset-fd)
[302.518289] Starting subtest: reset-fd
[302.525879] Subtest reset-fd: SUCCESS (0.008s)
[302.697351] [078/134] (734s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[303.191855] Starting subtest: x-tiled-8bpp-rotate-90
[303.212849] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[303.826424] [079/134] (733s left) gem_userptr_blits (nohangcheck)
[303.915192] Starting subtest: nohangcheck
[303.964163] Subtest nohangcheck: SUCCESS (0.048s)
[304.126396] [080/134] (733s left) gem_spin_batch (legacy)
[304.191602] Starting subtest: legacy
[304.192736] Starting dynamic subtest: default
[307.503669] Dynamic subtest default: SUCCESS (3.310s)
[307.514956] Starting dynamic subtest: render
[310.815686] Dynamic subtest render: SUCCESS (3.310s)
[310.827369] Starting dynamic subtest: bsd
[314.127663] Dynamic subtest bsd: SUCCESS (3.310s)
[314.139311] Starting dynamic subtest: bsd1
[317.439582] Dynamic subtest bsd1: SUCCESS (3.310s)
[317.451138] Starting dynamic subtest: blt
[320.751383] Dynamic subtest blt: SUCCESS (3.310s)
[320.752396] Subtest legacy: SUCCESS (16.560s)
[321.009796] [081/134] (716s left) gem_exec_schedule (preempt-queue-chain)
[321.080083] Subtest preempt-queue-chain: SKIP (0.000s)
[321.310237] [082/134] (716s left) gem_render_copy (y-tiled)
[321.373763] Starting subtest: y-tiled
[321.374916] Starting dynamic subtest: smem
[321.450635] Dynamic subtest smem: SUCCESS (0.076s)
[321.451802] Subtest y-tiled: SUCCESS (0.078s)
[321.691436] [083/134] (716s left) kms_psr (psr-primary-blt)
[322.172287] Subtest psr-primary-blt: SKIP (0.000s)
[322.483827] [084/134] (715s left) kms_lease (lease-again)
[322.970625] Starting subtest: lease-again
[322.971692] Starting dynamic subtest: pipe-A-HDMI-A-1
[322.974527] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[322.988203] Starting dynamic subtest: pipe-B-HDMI-A-1
[322.989296] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[322.990428] Subtest lease-again: SUCCESS (0.009s)
[323.593828] [085/134] (714s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[324.083295] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[324.381843] [086/134] (713s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[324.877156] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[324.879291] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[325.500601] [087/134] (712s left) i915_hangman (error-state-basic)
[325.562206] Starting subtest: error-state-basic
[325.564946] Subtest error-state-basic: SUCCESS (0.003s)
[325.646623] [088/134] (712s left) kms_big_fb (y-tiled-addfb)
[326.145386] Starting subtest: y-tiled-addfb
[326.147535] Subtest y-tiled-addfb: SKIP (0.000s)
[326.747927] [089/134] (711s left) kms_big_fb (4-tiled-addfb-size-overflow)
[327.244384] Starting subtest: 4-tiled-addfb-size-overflow
[327.246598] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[327.845855] [090/134] (710s left) kms_vblank (query-forked-hang)
[328.327937] Starting subtest: query-forked-hang
[328.330873] Starting dynamic subtest: pipe-A-HDMI-A-1
[331.967344] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.637s)
[331.980815] Starting dynamic subtest: pipe-B-HDMI-A-1
[335.928233] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.958s)
[335.931454] Subtest query-forked-hang: SUCCESS (7.602s)
[336.646521] [091/134] (701s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[336.706341] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[336.774742] [092/134] (701s left) syncobj_timeline (single-wait-signaled)
[336.831481] Starting subtest: single-wait-signaled
[336.832614] Subtest single-wait-signaled: SUCCESS (0.001s)
[336.960075] [093/134] (701s left) gem_lmem_swapping (parallel-random-verify-ccs)
[337.024382] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[337.088827] [094/134] (701s left) kms_content_protection (legacy)
[337.593766] Starting subtest: legacy
[337.596102] Subtest legacy: SKIP (0.000s)
[338.207876] [095/134] (700s left) syncobj_timeline (multi-wait-available-signaled)
[338.267064] Starting subtest: multi-wait-available-signaled
[338.268123] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[338.389714] [096/134] (700s left) gem_workarounds (suspend-resume-context)
[338.461055] Starting subtest: suspend-resume-context
[355.017658] Subtest suspend-resume-context: SUCCESS (0.518s)
[364.168702] [097/134] (683s left) kms_prime (basic-crc-vgem)
[364.684330] Starting subtest: basic-crc-vgem
[364.685500] Starting dynamic subtest: second-to-first
[366.138403] Dynamic subtest second-to-first: SUCCESS (1.408s)
[366.140102] Subtest basic-crc-vgem: SUCCESS (1.410s)
[367.331917] [098/134] (680s left) gem_userptr_blits (coherency-sync)
[367.407084] Starting subtest: coherency-sync
[393.020384] Subtest coherency-sync: SUCCESS (25.423s)
[393.206044] [099/134] (654s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[393.361497] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[393.418194] [100/134] (654s left) gem_ctx_engines (execute-oneforall)
[393.483403] Starting subtest: execute-oneforall
[393.567484] Subtest execute-oneforall: SUCCESS (0.084s)
[393.840877] [101/134] (654s left) i915_pm_rpm (debugfs-forcewake-user)
[405.700702] Subtest debugfs-forcewake-user: SKIP (0.000s)
[406.002199] [102/134] (642s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[406.496490] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[407.949834] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.454s)
[408.572385] [103/134] (639s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[409.073559] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[410.160792] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.088s)
[410.812930] [104/134] (637s left) gem_exec_balancer (bonded-pair)
[410.874927] Subtest bonded-pair: SKIP (0.000s)
[411.012985] [105/134] (637s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[411.499866] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[411.502045] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[412.111072] [106/134] (636s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[412.167469] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[412.224989] [107/134] (636s left) kms_properties (invalid-properties-atomic)
[412.704460] Starting subtest: invalid-properties-atomic
[412.741449] Subtest invalid-properties-atomic: SUCCESS (0.038s)
[413.326897] [108/134] (635s left) gem_exec_whisper (basic-contexts-priority-all)
[413.394734] Starting subtest: basic-contexts-priority-all
[413.398527] Subtest basic-contexts-priority-all: SKIP (0.001s)
[413.646123] [109/134] (634s left) syncobj_wait (multi-wait-signaled)
[413.715084] Starting subtest: multi-wait-signaled
[413.716198] Subtest multi-wait-signaled: SUCCESS (0.001s)
[413.842214] [110/134] (634s left) gem_exec_fence (expired-history)
[414.034486] Starting subtest: expired-history
[414.096252] Subtest expired-history: SUCCESS (0.062s)
[414.459613] [111/134] (634s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[414.515757] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[414.584194] [112/134] (633s left) prime_vgem (fence-write-hang)
[414.664014] Subtest fence-write-hang: SKIP (0.000s)
[414.793117] [113/134] (633s left) gem_fence_thrash (bo-write-verify-threaded-x)
[414.848066] Starting subtest: bo-write-verify-threaded-x
[416.612647] Subtest bo-write-verify-threaded-x: SUCCESS (1.762s)
[416.775394] [114/134] (631s left) gem_render_copy_redux (flink-interruptible)
[416.835393] Starting subtest: flink-interruptible
[418.000760] Subtest flink-interruptible: SUCCESS (1.164s)
[418.152447] [115/134] (630s left) gem_softpin (evict-snoop)
[418.218662] Starting subtest: evict-snoop
[418.221072] Subtest evict-snoop: SKIP (0.000s)
[418.368440] [116/134] (630s left) gem_exec_reloc (basic-cpu-wc-active)
[418.429777] Starting subtest: basic-cpu-wc-active
[418.538209] Subtest basic-cpu-wc-active: SUCCESS (0.110s)
[419.568044] [117/134] (629s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[420.059781] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[420.062056] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[420.666310] [118/134] (628s left) gem_blits (basic)
[420.723312] Starting subtest: basic
[422.657975] Subtest basic: SUCCESS (1.932s)
[422.812313] [119/134] (626s left) kms_flip (2x-plain-flip)
[423.301904] Starting subtest: 2x-plain-flip
[423.303025] Starting dynamic subtest: AB-VGA1-HDMI-A1
[425.644878] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.342s)
[425.648047] Subtest 2x-plain-flip: SUCCESS (2.345s)
[426.454123] [120/134] (622s left) kms_psr (fbc-psr2-sprite-blt)
[426.944810] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[427.246565] [121/134] (621s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[427.735283] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[427.782270] Starting dynamic subtest: pipe-A-plane-0
[427.784707] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[427.802724] Starting dynamic subtest: pipe-A-plane-1
[427.804895] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[427.818792] Starting dynamic subtest: pipe-A-plane-2
[427.820871] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[428.027481] Starting dynamic subtest: pipe-B-plane-0
[428.030190] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[428.044104] Starting dynamic subtest: pipe-B-plane-1
[428.046377] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[428.060275] Starting dynamic subtest: pipe-B-plane-2
[428.063023] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[428.111955] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.377s)
[428.827061] [122/134] (620s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[429.319798] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[429.321943] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[429.940888] [123/134] (619s left) perf (gen12-group-exclusive-stream-sample-oa)
[430.110855] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s)
[430.171092] [124/134] (619s left) kms_pipe_crc_basic (suspend-read-crc)
[430.655813] Starting subtest: suspend-read-crc
[430.656901] Starting dynamic subtest: pipe-A-HDMI-A-1
[448.403019] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.579s)
[448.419659] Starting dynamic subtest: pipe-B-HDMI-A-1
[466.409719] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.599s)
[466.410786] Subtest suspend-read-crc: SUCCESS (3.183s)
[476.138360] [125/134] (582s left) gem_pxp (display-protected-crc)
[478.754123] Starting subtest: display-protected-crc
[478.756793] Subtest display-protected-crc: SKIP (0.000s)
[478.875925] [126/134] (579s left) i915_suspend (debugfs-reader)
[478.935613] Starting subtest: debugfs-reader
[497.813031] Subtest debugfs-reader: SUCCESS (2.444s)
[504.896209] [127/134] (560s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[505.395035] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[505.397364] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[505.980251] [128/134] (559s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[506.474289] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[506.516516] Starting dynamic subtest: pipe-A-plane-0
[506.519264] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[506.538984] Starting dynamic subtest: pipe-A-plane-1
[506.541727] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[506.556237] Starting dynamic subtest: pipe-A-plane-2
[506.558456] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[506.766680] Starting dynamic subtest: pipe-B-plane-0
[506.769341] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[506.784934] Starting dynamic subtest: pipe-B-plane-1
[506.787138] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[506.802171] Starting dynamic subtest: pipe-B-plane-2
[506.804881] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[506.849199] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.369s)
[507.588461] [129/134] (557s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[507.647626] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[507.756074] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[507.889507] [130/134] (557s left) kms_psr (fbc-psr-dpms)
[508.379019] Subtest fbc-psr-dpms: SKIP (0.000s)
[508.699104] [131/134] (557s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[509.191921] Starting subtest: flip-vs-cursor-busy-crc-legacy
[509.752920] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.556s)
[510.479476] [132/134] (555s left) perf_pmu (idle)
[510.537916] Starting subtest: idle
[510.539003] Starting dynamic subtest: rcs0
[511.060668] Dynamic subtest rcs0: SUCCESS (0.516s)
[511.080234] Starting dynamic subtest: bcs0
[511.590181] Dynamic subtest bcs0: SUCCESS (0.519s)
[511.614939] Starting dynamic subtest: vcs0
[512.109768] Dynamic subtest vcs0: SUCCESS (0.514s)
[512.112670] Subtest idle: SUCCESS (1.558s)
[512.246286] [133/134] (553s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[512.735820] Starting subtest: short-busy-flip-before-cursor-toggle
[512.738015] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[513.360107] [134/134] (552s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[513.853155] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[513.857927] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[514.472678] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: prime_vgem
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: gem_exec_flush
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_whisper
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_chamelium_edid
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: kms_pm_dc
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_gttfill
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_tiled_pread_basic
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: gen9_exec_parse
results: parsing output: 38/ for test: core_getstats
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: core_auth
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: syncobj_eventfd
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_atomic_transition
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: kms_color
results: parsing output: 57/ for test: kms_psr2_su
results: parsing output: 58/ for test: gem_readwrite
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: kms_vblank
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: gem_mmap_wc
results: parsing output: 63/ for test: gem_exec_alignment
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: gem_ctx_exec
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_tiled_blits
results: parsing output: 70/ for test: kms_dp_link_training
results: parsing output: 71/ for test: sysfs_heartbeat_interval
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_joiner
results: parsing output: 76/ for test: gem_workarounds
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: gem_spin_batch
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_lease
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_content_protection
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_workarounds
results: parsing output: 96/ for test: kms_prime
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_ctx_engines
results: parsing output: 100/ for test: i915_pm_rpm
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_properties
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: gem_exec_fence
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: prime_vgem
results: parsing output: 112/ for test: gem_fence_thrash
results: parsing output: 113/ for test: gem_render_copy_redux
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_blits
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_plane
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: kms_pipe_crc_basic
results: parsing output: 124/ for test: gem_pxp
results: parsing output: 125/ for test: i915_suspend
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: perf_pmu
results: parsing output: 132/ for test: kms_cursor_legacy
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.