[71.542566] Initializing watchdogs
[71.542710]   /dev/watchdog0
[71.562575] [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)
[71.570724] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.574416] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.580669] [001/132] (960s left) gem_sync (basic-all)
[71.672453] Starting subtest: basic-all
[73.702321] Subtest basic-all: SUCCESS (2.031s)
[73.912907] [002/132] (958s left) gem_mmap_gtt (zero-extend)
[73.971940] Starting subtest: zero-extend
[73.973830] Subtest zero-extend: SUCCESS (0.000s)
[74.076757] [003/132] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[74.567870] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[76.528518] Subtest fbc-2p-primscrn-indfb-msflip-blt: SUCCESS (1.961s)
[76.670205] [004/132] (955s left) prime_self_import (basic-with_two_bos)
[76.731901] Starting subtest: basic-with_two_bos
[76.738116] Subtest basic-with_two_bos: SUCCESS (0.005s)
[76.837380] [005/132] (955s left) gem_readwrite (read-bad-handle)
[76.902853] Starting subtest: read-bad-handle
[76.906936] Subtest read-bad-handle: SUCCESS (0.000s)
[77.004624] [006/132] (955s left) gem_exec_parallel (fds)
[77.078664] Starting subtest: fds
[77.080537] Starting dynamic subtest: rcs0
[78.881145] Dynamic subtest rcs0: SUCCESS (1.802s)
[78.894380] Starting dynamic subtest: bcs0
[80.642082] Dynamic subtest bcs0: SUCCESS (1.759s)
[80.644205] Subtest fds: SUCCESS (3.563s)
[80.846969] [007/132] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[81.336483] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[81.340712] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[81.438921] [008/132] (950s left) gem_exec_schedule (u-fairslice)
[81.511890] Subtest u-fairslice: SKIP (0.000s)
[81.712202] [009/132] (950s left) kms_plane_multiple (2x-tiling-yf)
[82.187034] Starting subtest: 2x-tiling-yf
[82.191136] Subtest 2x-tiling-yf: SKIP (0.000s)
[82.276971] [010/132] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[82.771204] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[82.775327] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[82.876092] [011/132] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[83.359884] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[83.363687] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[83.456870] [012/132] (949s left) gem_lmem_swapping (basic)
[83.524651] Subtest basic: SKIP (0.000s)
[83.571609] [013/132] (949s left) gem_mmap_wc (bad-size)
[83.634173] Starting subtest: bad-size
[83.635853] Subtest bad-size: SUCCESS (0.001s)
[83.742836] [014/132] (948s left) kms_psr (pr-sprite-plane-onoff)
[84.223619] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[84.275059] [015/132] (948s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[84.774747] Starting subtest: 4-tiled-16bpp-rotate-0
[84.778748] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[84.874532] [016/132] (947s left) syncobj_timeline (etime-single-wait-submitted)
[84.942243] Starting subtest: etime-single-wait-submitted
[85.045508] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[85.138623] [017/132] (947s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[85.629194] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[85.633293] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[85.732894] [018/132] (947s left) kms_plane (plane-position-hole-dpms)
[86.216341] Starting subtest: plane-position-hole-dpms
[86.581663] Starting dynamic subtest: pipe-A-plane-1
[87.068652] Dynamic subtest pipe-A-plane-1: SUCCESS (0.486s)
[87.078790] Starting dynamic subtest: pipe-A-plane-2
[87.084855] Dynamic subtest pipe-A-plane-2: SUCCESS (0.004s)
[87.394975] Starting dynamic subtest: pipe-B-plane-1
[87.983503] Dynamic subtest pipe-B-plane-1: SUCCESS (0.596s)
[87.996132] Starting dynamic subtest: pipe-B-plane-2
[88.000105] Dynamic subtest pipe-B-plane-2: SUCCESS (0.011s)
[88.002090] Subtest plane-position-hole-dpms: SUCCESS (1.777s)
[88.256703] [019/132] (944s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[88.328354] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[88.428908] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[88.524340] [020/132] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[89.014489] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[90.967484] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SUCCESS (1.954s)
[91.110457] [021/132] (941s left) gem_mmap_wc (set-cache-level)
[91.180866] Starting subtest: set-cache-level
[91.182748] Subtest set-cache-level: SUCCESS (0.001s)
[91.277616] [022/132] (941s left) kms_vblank (query-busy-hang)
[91.758506] Starting subtest: query-busy-hang
[91.760784] Starting dynamic subtest: pipe-A-VGA-1
[97.891921] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.133s)
[97.905233] Starting dynamic subtest: pipe-A-HDMI-A-1
[103.939716] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.045s)
[103.950730] Starting dynamic subtest: pipe-B-VGA-1
[109.916979] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.975s)
[109.929801] Starting dynamic subtest: pipe-B-HDMI-A-1
[115.967676] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.050s)
[115.972776] Subtest query-busy-hang: SUCCESS (24.210s)
[116.250585] [023/132] (916s left) gem_partial_pwrite_pread (write-display)
[116.318714] Starting subtest: write-display
[120.251870] Subtest write-display: SUCCESS (3.933s)
[120.361996] [024/132] (912s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[120.855010] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[122.258505] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.406s)
[122.489099] [025/132] (910s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[122.969268] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[122.973313] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[123.051027] [026/132] (910s left) gem_ccs (block-multicopy-compressed)
[123.117313] Subtest block-multicopy-compressed: SKIP (0.000s)
[123.179184] [027/132] (910s left) kms_flip (wf_vblank-ts-check-interruptible)
[123.664874] Starting subtest: wf_vblank-ts-check-interruptible
[123.666671] Starting dynamic subtest: A-VGA1
[131.775784] Dynamic subtest A-VGA1: SUCCESS (8.109s)
[131.786726] Starting dynamic subtest: B-VGA1
[139.750059] Dynamic subtest B-VGA1: SUCCESS (7.972s)
[139.763194] Starting dynamic subtest: A-HDMI-A1
[147.906185] Dynamic subtest A-HDMI-A1: SUCCESS (8.154s)
[147.919779] Starting dynamic subtest: B-HDMI-A1
[156.092358] Dynamic subtest B-HDMI-A1: SUCCESS (8.183s)
[156.098901] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.428s)
[156.271923] [028/132] (877s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[156.752103] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[156.753938] Starting dynamic subtest: pipe-A
[156.761899] Dynamic subtest pipe-A: SKIP (0.002s)
[156.776908] Starting dynamic subtest: pipe-B
[156.784813] Dynamic subtest pipe-B: SKIP (0.001s)
[156.788656] Subtest plane-upscale-factor-0-25-with-modifiers: SKIP (0.004s)
[156.852406] [029/132] (876s left) kms_flip (2x-busy-flip)
[157.334840] Starting subtest: 2x-busy-flip
[157.336618] Starting dynamic subtest: AB-VGA1-HDMI-A1
[158.722268] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.385s)
[158.724089] Subtest 2x-busy-flip: SUCCESS (1.390s)
[158.986993] [030/132] (874s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[159.052080] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[159.112833] [031/132] (874s left) kms_chamelium_frames (dp-crc-fast)
[159.692646] Subtest dp-crc-fast: SKIP (0.000s)
[159.897506] [032/132] (873s left) kms_big_fb (linear-8bpp-rotate-270)
[160.389724] Starting subtest: linear-8bpp-rotate-270
[160.491258] Subtest linear-8bpp-rotate-270: SKIP (0.099s)
[160.703127] [033/132] (872s left) gem_madvise (dontneed-before-pwrite)
[160.770681] Starting subtest: dontneed-before-pwrite
[160.774066] Subtest dontneed-before-pwrite: SUCCESS (0.002s)
[160.868956] [034/132] (872s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[161.348156] Starting subtest: primary-4-tiled-reflect-x-0
[161.352128] Subtest primary-4-tiled-reflect-x-0: SKIP (0.001s)
[161.435720] [035/132] (872s left) kms_flip (absolute-wf_vblank)
[161.913783] Starting subtest: absolute-wf_vblank
[161.915452] Starting dynamic subtest: A-VGA1
[169.724106] Dynamic subtest A-VGA1: SUCCESS (7.808s)
[169.735535] Starting dynamic subtest: B-VGA1
[177.446454] Dynamic subtest B-VGA1: SUCCESS (7.721s)
[177.458401] Starting dynamic subtest: A-HDMI-A1
[185.338420] Dynamic subtest A-HDMI-A1: SUCCESS (7.889s)
[185.349935] Starting dynamic subtest: B-HDMI-A1
[193.255401] Dynamic subtest B-HDMI-A1: SUCCESS (7.916s)
[193.257631] Subtest absolute-wf_vblank: SUCCESS (31.344s)
[193.432805] [036/132] (840s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[193.501168] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[193.561106] [037/132] (840s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[194.045833] Starting subtest: async-flip-with-page-flip-events-linear
[194.289943] Subtest async-flip-with-page-flip-events-linear: SKIP (0.244s)
[194.526607] [038/132] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[195.022442] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[196.886481] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.867s)
[197.050256] [039/132] (836s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[197.534350] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[197.593238] [040/132] (836s left) gem_softpin (full)
[197.663664] Subtest full: SKIP (0.000s)
[197.750613] [041/132] (836s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[197.814077] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[197.876305] [042/132] (836s left) kms_cursor_crc (cursor-offscreen-128x42)
[198.361726] Starting subtest: cursor-offscreen-128x42
[198.426960] Subtest cursor-offscreen-128x42: SKIP (0.063s)
[198.534903] [043/132] (835s left) kms_color_pipeline (plane-ctm3x4)
[199.023073] Starting subtest: plane-ctm3x4
[199.629394] Subtest plane-ctm3x4: SKIP (0.608s)
[199.864534] [044/132] (834s left) gem_mmap (bad-size)
[199.925488] Starting subtest: bad-size
[199.927472] Subtest bad-size: SUCCESS (0.001s)
[200.030801] [045/132] (834s left) prime_vgem (basic-fence-mmap)
[200.158856] Starting subtest: basic-fence-mmap
[200.188335] Subtest basic-fence-mmap: SUCCESS (0.029s)
[200.299683] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[200.303378] [046/132] (833s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[200.796795] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[202.792939] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.999s)
[202.924131] [047/132] (831s left) kms_frontbuffer_tracking (psr-suspend)
[203.415998] Starting subtest: psr-suspend
[203.420139] Subtest psr-suspend: SKIP (0.000s)
[203.526259] [048/132] (830s left) gem_exec_params (cliprects-invalid)
[203.592830] Starting subtest: cliprects-invalid
[203.594757] Subtest cliprects-invalid: SUCCESS (0.000s)
[203.711650] [049/132] (830s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[204.199036] Starting subtest: stress-xrgb8888-xtiled
[215.095177] Subtest stress-xrgb8888-xtiled: SUCCESS (10.902s)
[215.379714] [050/132] (819s left) prime_self_import (reimport-vs-gem_close-race)
[215.443961] Starting subtest: reimport-vs-gem_close-race
[220.472984] Subtest reimport-vs-gem_close-race: SUCCESS (5.028s)
[220.572860] [051/132] (813s left) gem_mmap_gtt (hang)
[220.635086] Starting subtest: hang
[226.109607] Subtest hang: SUCCESS (5.472s)
[226.258163] [052/132] (808s left) gem_ctx_param (invalid-ctx-get)
[226.324084] Starting subtest: invalid-ctx-get
[226.325696] Subtest invalid-ctx-get: SUCCESS (0.000s)
[226.424967] [053/132] (808s left) syncobj_timeline (single-wait-signaled)
[226.483678] Starting subtest: single-wait-signaled
[226.486070] Subtest single-wait-signaled: SUCCESS (0.001s)
[226.575683] [054/132] (808s left) gem_exec_balancer (parallel)
[226.640857] Subtest parallel: SKIP (0.000s)
[226.727347] [055/132] (808s left) kms_psr (fbc-psr-cursor-plane-move)
[227.197167] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[227.271868] [056/132] (807s left) gem_ctx_engines (execute-one)
[227.341120] Starting subtest: execute-one
[227.710192] Subtest execute-one: SUCCESS (0.368s)
[227.916075] [057/132] (806s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[228.394683] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[228.397982] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[228.516120] [058/132] (806s left) syncobj_eventfd (timeline-wait)
[228.577019] Starting subtest: timeline-wait
[228.586741] Subtest timeline-wait: SUCCESS (0.012s)
[228.706095] [059/132] (806s left) gem_exec_fence (submit-chain)
[228.888854] Subtest submit-chain: SKIP (0.000s)
[229.253582] [060/132] (805s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[229.325475] Starting subtest: map-fixed-invalidate-overlap-busy
[229.327062] Starting dynamic subtest: gtt
[230.411149] Dynamic subtest gtt: SUCCESS (1.084s)
[230.423038] Starting dynamic subtest: wb
[231.440237] Dynamic subtest wb: SUCCESS (1.027s)
[231.452077] Starting dynamic subtest: wc
[232.552708] Dynamic subtest wc: SUCCESS (1.111s)
[232.564741] Starting dynamic subtest: uc
[233.597447] Dynamic subtest uc: SUCCESS (1.044s)
[233.599085] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (4.272s)
[233.730626] [061/132] (801s left) kms_fbcon_fbt (psr-suspend)
[233.791573] Starting subtest: psr-suspend
[233.794742] Subtest psr-suspend: SKIP (0.000s)
[233.913800] [062/132] (801s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[233.971581] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[233.973366] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[234.064121] [063/132] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[234.542837] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[234.546093] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[234.655810] [064/132] (800s left) kms_chamelium_color (ctm-blue-to-red)
[235.124754] Subtest ctm-blue-to-red: SKIP (0.000s)
[235.189514] [065/132] (800s left) core_setmaster (master-drop-set-user)
[235.327617] Starting subtest: master-drop-set-user
[235.350112] Subtest master-drop-set-user: SUCCESS (0.027s)
[235.399534] [066/132] (799s left) syncobj_wait (wait-all-complex)
[235.457083] Starting subtest: wait-all-complex
[235.672370] Subtest wait-all-complex: SUCCESS (0.214s)
[235.770983] [067/132] (799s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[235.831497] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[235.833175] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[235.922311] [068/132] (799s left) gem_exec_parallel (userptr)
[235.989112] Starting subtest: userptr
[235.990863] Starting dynamic subtest: rcs0
[237.619081] Dynamic subtest rcs0: SUCCESS (1.629s)
[237.630763] Starting dynamic subtest: bcs0
[239.180911] Dynamic subtest bcs0: SUCCESS (1.560s)
[239.182733] Subtest userptr: SUCCESS (3.193s)
[239.382938] [069/132] (796s left) kms_pm_rpm (pm-tiling)
[251.121163] Subtest pm-tiling: SKIP (0.000s)
[251.182592] [070/132] (784s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[251.663516] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[251.724121] [071/132] (783s left) kms_psr (psr2-cursor-mmap-gtt)
[252.205755] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[252.271902] [072/132] (783s left) i915_pm_rps (waitboost)
[252.342024] Starting subtest: waitboost
[255.875807] Subtest waitboost: SUCCESS (3.534s)
[256.007351] [073/132] (779s left) gem_ctx_persistence (hang)
[256.074933] Subtest hang: SKIP (0.000s)
[256.133967] [074/132] (779s left) kms_psr (fbc-psr2-sprite-blt)
[256.613936] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[256.665606] [075/132] (779s left) kms_lease (empty-lease)
[257.146834] Starting subtest: empty-lease
[257.148648] Starting dynamic subtest: pipe-A-VGA-1
[257.150262] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.001s)
[257.162098] Starting dynamic subtest: pipe-A-HDMI-A-1
[257.163884] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[257.175781] Starting dynamic subtest: pipe-B-VGA-1
[257.177395] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.001s)
[257.189334] Starting dynamic subtest: pipe-B-HDMI-A-1
[257.191494] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[257.193573] Subtest empty-lease: SUCCESS (0.016s)
[257.253528] [076/132] (778s left) syncobj_wait (wait-all-for-submit-complex)
[257.320266] Starting subtest: wait-all-for-submit-complex
[257.537717] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[257.635952] [077/132] (778s left) api_intel_bb (reset-bb)
[257.700403] Starting subtest: reset-bb
[257.702048] Subtest reset-bb: SUCCESS (0.001s)
[257.827789] [078/132] (778s left) kms_chamelium_hpd (hdmi-hpd-storm)
[258.420209] Subtest hdmi-hpd-storm: SKIP (0.000s)
[258.630257] [079/132] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[259.120792] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[259.124906] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[259.231703] [080/132] (776s left) gem_exec_schedule (u-submit-late-slice)
[259.303775] Subtest u-submit-late-slice: SKIP (0.000s)
[259.499078] [081/132] (776s left) kms_invalid_mode (int-max-clock)
[259.982965] Starting subtest: int-max-clock
[259.984733] Starting dynamic subtest: pipe-A-VGA-1
[260.097887] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.115s)
[260.112622] Starting dynamic subtest: pipe-A-HDMI-A-1
[260.114868] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[260.131210] Starting dynamic subtest: pipe-B-VGA-1
[260.133413] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.001s)
[260.146339] Starting dynamic subtest: pipe-B-HDMI-A-1
[260.147966] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[260.149696] Subtest int-max-clock: SUCCESS (0.128s)
[260.394733] [082/132] (775s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[260.456902] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[260.522472] [083/132] (775s left) gem_exec_suspend (basic-s3)
[260.592844] Starting subtest: basic-S3
[260.594725] Starting dynamic subtest: smem
[278.254034] Dynamic subtest smem: SUCCESS (1.552s)
[278.256447] Subtest basic-S3: SUCCESS (1.554s)
[285.473742] [084/132] (757s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[288.065892] Starting subtest: verify-pxp-key-change-after-suspend-resume
[288.069850] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[288.158276] [085/132] (755s left) gem_exec_schedule (pi-common)
[288.230917] Subtest pi-common: SKIP (0.000s)
[288.445419] [086/132] (754s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[288.937938] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[288.941936] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[289.041737] [087/132] (754s left) gem_exec_balancer (parallel-contexts)
[289.109566] Subtest parallel-contexts: SKIP (0.000s)
[289.208903] [088/132] (754s left) i915_hangman (gt-engine-error)
[289.283846] Starting subtest: gt-engine-error
[289.287811] Subtest gt-engine-error: SKIP (0.000s)
[289.371679] [089/132] (754s left) kms_cursor_crc (cursor-random-512x512)
[289.857768] Starting subtest: cursor-random-512x512
[289.861302] Subtest cursor-random-512x512: SKIP (0.001s)
[289.982237] [090/132] (753s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[290.459559] Starting subtest: fb-8bpc-vs-panel-6bpc
[290.462926] Starting dynamic subtest: pipe-A-HDMI-A-1
[290.573089] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.108s)
[290.577139] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.111s)
[290.849467] [091/132] (752s left) perf_pmu (busy-start)
[290.918853] Starting subtest: busy-start
[290.920883] Starting dynamic subtest: rcs0
[293.436272] Dynamic subtest rcs0: SUCCESS (2.517s)
[293.455390] Starting dynamic subtest: bcs0
[295.954041] Dynamic subtest bcs0: SUCCESS (2.515s)
[295.977265] Starting dynamic subtest: vcs0
[298.972074] Dynamic subtest vcs0: SUCCESS (3.015s)
[298.973979] Subtest busy-start: SUCCESS (8.055s)
[299.068197] [092/132] (744s left) gem_fence_thrash (bo-write-verify-threaded-x)
[299.129413] Starting subtest: bo-write-verify-threaded-x
[300.884306] Subtest bo-write-verify-threaded-x: SUCCESS (1.755s)
[301.001530] [093/132] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[301.490121] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[301.493997] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[301.601539] [094/132] (742s left) kms_flip (2x-plain-flip-interruptible)
[302.082279] Starting subtest: 2x-plain-flip-interruptible
[302.087227] Starting dynamic subtest: AB-VGA1-HDMI-A1
[304.462927] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.376s)
[304.467353] Subtest 2x-plain-flip-interruptible: SUCCESS (2.383s)
[304.736431] [095/132] (739s left) gem_exec_reloc (basic-cpu-wc-active)
[304.803906] Starting subtest: basic-cpu-wc-active
[304.913267] Subtest basic-cpu-wc-active: SUCCESS (0.110s)
[305.437480] [096/132] (738s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[305.502815] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[305.566713] [097/132] (738s left) kms_vrr (lobf)
[306.045696] Starting subtest: lobf
[306.049793] Subtest lobf: SKIP (0.000s)
[306.138593] [098/132] (737s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[306.619925] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[306.623836] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[306.739490] [099/132] (737s left) kms_busy (extended-modeset-hang-oldfb)
[307.221204] Starting subtest: extended-modeset-hang-oldfb
[307.222924] Starting dynamic subtest: pipe-A
[313.180799] Dynamic subtest pipe-A: SUCCESS (5.958s)
[313.195739] Starting dynamic subtest: pipe-B
[319.278564] Dynamic subtest pipe-B: SUCCESS (6.093s)
[319.280403] Subtest extended-modeset-hang-oldfb: SUCCESS (12.057s)
[319.555444] [100/132] (724s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[319.629863] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[319.633824] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[319.834905] [101/132] (724s left) sw_sync (sync_multi_producer_single_consumer)
[319.899625] Starting subtest: sync_multi_producer_single_consumer
[320.974113] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[321.055580] [102/132] (723s left) kms_content_protection (dp-mst-type-1)
[321.556698] Starting subtest: dp-mst-type-1
[321.560684] Subtest dp-mst-type-1: SKIP (0.000s)
[321.674479] [103/132] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[322.160981] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[324.077007] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.918s)
[324.302559] [104/132] (720s left) gem_ctx_isolation (preservation-reset)
[324.484553] Starting subtest: preservation-reset
[324.486329] Starting dynamic subtest: rcs0
[324.988110] Dynamic subtest rcs0: SUCCESS (0.503s)
[324.989936] Subtest preservation-reset: SUCCESS (0.505s)
[325.136738] [105/132] (719s left) gem_userptr_blits (probe)
[325.225595] Starting subtest: probe
[325.426642] Subtest probe: SUCCESS (0.200s)
[325.537265] [106/132] (719s left) kms_rotation_crc (exhaust-fences)
[326.020974] Starting subtest: exhaust-fences
[326.024709] Subtest exhaust-fences: SKIP (0.000s)
[326.119461] [107/132] (718s left) kms_feature_discovery (display-4x)
[326.603100] Starting subtest: display-4x
[326.606903] Subtest display-4x: SKIP (0.000s)
[326.709010] [108/132] (717s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[327.204559] Starting subtest: psr-farfromfence-mmap-gtt
[327.208421] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[327.311503] [109/132] (717s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[327.798608] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[327.802741] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[327.910531] [110/132] (716s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[328.394387] Starting subtest: y-tiled-64bpp-rotate-0
[328.398487] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[328.512588] [111/132] (716s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[328.991090] Starting subtest: cursorA-vs-flipB-legacy
[339.934325] Subtest cursorA-vs-flipB-legacy: SUCCESS (10.944s)
[340.203420] [112/132] (704s left) kms_pm_lpsp (screens-disabled)
[351.726858] Starting subtest: screens-disabled
[351.994525] Subtest screens-disabled: SKIP (0.267s)
[352.245831] [113/132] (692s left) syncobj_wait (reset-signaled)
[352.321501] Starting subtest: reset-signaled
[352.323294] Subtest reset-signaled: SUCCESS (0.000s)
[352.423324] [114/132] (692s left) i915_drm_fdinfo (memory-info-resident)
[352.489182] Subtest memory-info-resident: SKIP (0.000s)
[352.556607] [115/132] (692s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[352.625644] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[352.627441] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[352.722813] [116/132] (692s left) i915_pm_rpm (gem-evict-pwrite)
[364.494688] Subtest gem-evict-pwrite: SKIP (0.000s)
[364.567898] [117/132] (680s left) gem_eio (in-flight-internal-immediate)
[364.644009] Starting subtest: in-flight-internal-immediate
[364.685684] Subtest in-flight-internal-immediate: SUCCESS (0.041s)
[365.214803] [118/132] (680s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[365.283063] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[365.354917] [119/132] (680s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[365.422119] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[365.493614] [120/132] (679s left) vgem_basic (dmabuf-mmap)
[365.565056] Starting subtest: dmabuf-mmap
[365.589687] Subtest dmabuf-mmap: SUCCESS (0.028s)
[365.684183] [121/132] (679s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[366.174909] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[366.179233] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[366.280774] [122/132] (679s left) gem_exec_async (forked-writes)
[366.355159] Starting subtest: forked-writes
[366.357057] Starting dynamic subtest: rcs0
[366.372783] Dynamic subtest rcs0: SUCCESS (0.017s)
[366.389531] Starting dynamic subtest: bcs0
[366.391284] Dynamic subtest bcs0: SUCCESS (0.015s)
[366.406984] Starting dynamic subtest: vcs0
[366.414624] Dynamic subtest vcs0: SUCCESS (0.023s)
[366.416500] Subtest forked-writes: SUCCESS (0.061s)
[366.663272] [123/132] (678s left) gem_exec_alignment (single)
[366.729856] Starting subtest: single
[366.734106] Subtest single: SUCCESS (0.003s)
[366.867059] [124/132] (678s left) api_intel_allocator (reserve-simple)
[366.929448] Starting subtest: reserve-simple
[366.933833] Subtest reserve-simple: SUCCESS (0.006s)
[367.063896] [125/132] (678s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[367.159674] Starting subtest: multi-wait-for-submit-available-signaled
[367.161835] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[367.230677] [126/132] (678s left) gen7_exec_parse (batch-without-end)
[367.295984] Subtest batch-without-end: SKIP (0.000s)
[367.361698] [127/132] (678s left) kms_vblank (wait-forked-busy-hang)
[367.838706] Starting subtest: wait-forked-busy-hang
[367.840825] Starting dynamic subtest: pipe-A-VGA-1
[374.019557] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.178s)
[374.035244] Starting dynamic subtest: pipe-A-HDMI-A-1
[380.068134] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.047s)
[380.086775] Starting dynamic subtest: pipe-B-VGA-1
[386.061728] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.991s)
[386.084392] Starting dynamic subtest: pipe-B-HDMI-A-1
[392.035902] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.973s)
[392.037655] Subtest wait-forked-busy-hang: SUCCESS (24.201s)
[392.313070] [128/132] (653s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[392.802546] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[392.909580] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.103s)
[393.139141] [129/132] (652s left) gen3_render_mixed_blits
[393.272416] [130/132] (652s left) kms_psr (fbc-pr-primary-mmap-gtt)
[393.748196] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[393.810541] [131/132] (652s left) kms_cursor_crc (cursor-suspend)
[394.299257] Starting subtest: cursor-suspend
[394.301234] Starting dynamic subtest: pipe-A-VGA-1
[428.663604] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.775s)
[428.684081] Starting dynamic subtest: pipe-B-HDMI-A-1
[463.695665] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.812s)
[463.697407] Subtest cursor-suspend: SUCCESS (3.592s)
[469.985234] [132/132] (582s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[470.486446] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[471.671306] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.183s)
[471.931517] Closing watchdogs
results: parsing output: 0/ for test: gem_sync
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: prime_self_import
results: parsing output: 4/ for test: gem_readwrite
results: parsing output: 5/ for test: gem_exec_parallel
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_plane_multiple
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: gem_mmap_wc
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: gem_partial_pwrite_pread
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: gem_ccs
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_madvise
results: parsing output: 33/ for test: kms_rotation_crc
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_color_pipeline
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: prime_vgem
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_pipe_stress
results: parsing output: 49/ for test: prime_self_import
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_ctx_engines
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_eventfd
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_fbcon_fbt
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: core_setmaster
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_exec_parallel
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: i915_pm_rps
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_invalid_mode
results: parsing output: 81/ for test: sriov_basic
results: parsing output: 82/ for test: gem_exec_suspend
results: parsing output: 83/ for test: gem_pxp
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: i915_hangman
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_dither
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: gem_fence_thrash
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_vrr
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_busy
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_content_protection
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_isolation
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: kms_feature_discovery
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_big_fb
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_pm_lpsp
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: vgem_basic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_async
results: parsing output: 122/ for test: gem_exec_alignment
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gen3_render_mixed_blits
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_big_fb
Done.