[68.740784] Initializing watchdogs
[68.740934]   /dev/watchdog0
[68.771267] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[68.779235] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.783345] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.788051] [001/132] (960s left) gem_sync (basic-all)
[68.873302] Starting subtest: basic-all
[70.922647] Subtest basic-all: SUCCESS (2.050s)
[71.134684] [002/132] (958s left) gem_mmap_gtt (zero-extend)
[71.191262] Starting subtest: zero-extend
[71.192445] Subtest zero-extend: SUCCESS (0.000s)
[71.295527] [003/132] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[71.790766] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[73.736800] Subtest fbc-2p-primscrn-indfb-msflip-blt: SUCCESS (1.947s)
[73.880793] [004/132] (955s left) prime_self_import (basic-with_two_bos)
[73.938191] Starting subtest: basic-with_two_bos
[73.941403] Subtest basic-with_two_bos: SUCCESS (0.005s)
[74.045185] [005/132] (955s left) gem_readwrite (read-bad-handle)
[74.100303] Starting subtest: read-bad-handle
[74.102390] Subtest read-bad-handle: SUCCESS (0.000s)
[74.195639] [006/132] (955s left) gem_exec_parallel (fds)
[74.269158] Starting subtest: fds
[74.270361] Starting dynamic subtest: rcs0
[76.051075] Dynamic subtest rcs0: SUCCESS (1.781s)
[76.061660] Starting dynamic subtest: bcs0
[77.770184] Dynamic subtest bcs0: SUCCESS (1.719s)
[77.771545] Subtest fds: SUCCESS (3.501s)
[77.989044] [007/132] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[78.482475] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[78.488440] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[78.586142] [008/132] (951s left) gem_exec_schedule (u-fairslice)
[78.658420] Subtest u-fairslice: SKIP (0.000s)
[78.854774] [009/132] (950s left) kms_plane_multiple (2x-tiling-yf)
[79.336534] Starting subtest: 2x-tiling-yf
[79.339070] Subtest 2x-tiling-yf: SKIP (0.000s)
[79.429264] [010/132] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[79.923070] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[79.925378] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[80.028921] [011/132] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[80.520390] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[80.522782] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[80.620932] [012/132] (949s left) gem_lmem_swapping (basic)
[80.685173] Subtest basic: SKIP (0.000s)
[80.743092] [013/132] (949s left) gem_mmap_wc (bad-size)
[80.800528] Starting subtest: bad-size
[80.801557] Subtest bad-size: SUCCESS (0.001s)
[80.900570] [014/132] (948s left) kms_psr (pr-sprite-plane-onoff)
[81.384286] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[81.442798] [015/132] (948s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[81.936814] Starting subtest: 4-tiled-16bpp-rotate-0
[81.939552] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[82.036807] [016/132] (947s left) syncobj_timeline (etime-single-wait-submitted)
[82.101200] Starting subtest: etime-single-wait-submitted
[82.203369] Subtest etime-single-wait-submitted: SUCCESS (0.102s)
[82.295641] [017/132] (947s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[82.791909] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[82.794638] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[82.893768] [018/132] (947s left) kms_plane (plane-position-hole-dpms)
[83.378793] Starting subtest: plane-position-hole-dpms
[83.705292] Starting dynamic subtest: pipe-A-plane-1
[84.165589] Dynamic subtest pipe-A-plane-1: SUCCESS (0.461s)
[84.175482] Starting dynamic subtest: pipe-A-plane-2
[84.177462] Dynamic subtest pipe-A-plane-2: SUCCESS (0.004s)
[84.474181] Starting dynamic subtest: pipe-B-plane-1
[85.040642] Dynamic subtest pipe-B-plane-1: SUCCESS (0.576s)
[85.052644] Starting dynamic subtest: pipe-B-plane-2
[85.056054] Dynamic subtest pipe-B-plane-2: SUCCESS (0.014s)
[85.057141] Subtest plane-position-hole-dpms: SUCCESS (1.677s)
[85.309977] [019/132] (944s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[85.377939] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[85.482196] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[85.576056] [020/132] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[86.072295] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[88.087398] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SUCCESS (2.015s)
[88.213914] [021/132] (941s left) gem_mmap_wc (set-cache-level)
[88.273067] Starting subtest: set-cache-level
[88.274115] Subtest set-cache-level: SUCCESS (0.001s)
[88.382270] [022/132] (941s left) kms_vblank (query-busy-hang)
[88.865279] Starting subtest: query-busy-hang
[88.866617] Starting dynamic subtest: pipe-A-VGA-1
[94.945390] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.081s)
[94.958600] Starting dynamic subtest: pipe-A-HDMI-A-1
[100.919540] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.972s)
[100.932921] Starting dynamic subtest: pipe-B-VGA-1
[106.897441] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.978s)
[106.912251] Starting dynamic subtest: pipe-B-HDMI-A-1
[112.947411] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.048s)
[112.948483] Subtest query-busy-hang: SUCCESS (24.084s)
[113.213248] [023/132] (917s left) gem_partial_pwrite_pread (write-display)
[113.277144] Starting subtest: write-display
[117.153370] Subtest write-display: SUCCESS (3.876s)
[117.256762] [024/132] (913s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[117.748354] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[119.171659] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.424s)
[119.416227] [025/132] (910s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[119.904933] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[119.907548] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[119.998591] [026/132] (910s left) gem_ccs (block-multicopy-compressed)
[120.061294] Subtest block-multicopy-compressed: SKIP (0.000s)
[120.110815] [027/132] (910s left) kms_flip (wf_vblank-ts-check-interruptible)
[120.603677] Starting subtest: wf_vblank-ts-check-interruptible
[120.606164] Starting dynamic subtest: A-VGA1
[128.724401] Dynamic subtest A-VGA1: SUCCESS (8.119s)
[128.735353] Starting dynamic subtest: B-VGA1
[136.715501] Dynamic subtest B-VGA1: SUCCESS (7.989s)
[136.727687] Starting dynamic subtest: A-HDMI-A1
[144.865261] Dynamic subtest A-HDMI-A1: SUCCESS (8.148s)
[144.878289] Starting dynamic subtest: B-HDMI-A1
[153.047694] Dynamic subtest B-HDMI-A1: SUCCESS (8.181s)
[153.049104] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.445s)
[153.225885] [028/132] (877s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[153.709831] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[153.710934] Starting dynamic subtest: pipe-A
[153.715737] Dynamic subtest pipe-A: SKIP (0.002s)
[153.727707] Starting dynamic subtest: pipe-B
[153.732825] Dynamic subtest pipe-B: SKIP (0.001s)
[153.735372] Subtest plane-upscale-factor-0-25-with-modifiers: SKIP (0.005s)
[153.807631] [029/132] (876s left) kms_flip (2x-busy-flip)
[154.285810] Starting subtest: 2x-busy-flip
[154.286907] Starting dynamic subtest: AB-VGA1-HDMI-A1
[155.709823] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.423s)
[155.712662] Subtest 2x-busy-flip: SUCCESS (1.427s)
[155.985984] [030/132] (874s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[156.051437] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[156.113127] [031/132] (874s left) kms_chamelium_frames (dp-crc-fast)
[156.710388] Subtest dp-crc-fast: SKIP (0.000s)
[156.920165] [032/132] (873s left) kms_big_fb (linear-8bpp-rotate-270)
[157.412874] Starting subtest: linear-8bpp-rotate-270
[157.509124] Subtest linear-8bpp-rotate-270: SKIP (0.095s)
[157.722623] [033/132] (873s left) gem_madvise (dontneed-before-pwrite)
[157.780561] Starting subtest: dontneed-before-pwrite
[157.783901] Subtest dontneed-before-pwrite: SUCCESS (0.004s)
[157.892509] [034/132] (872s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[158.377095] Starting subtest: primary-4-tiled-reflect-x-0
[158.379676] Subtest primary-4-tiled-reflect-x-0: SKIP (0.001s)
[158.475444] [035/132] (872s left) kms_flip (absolute-wf_vblank)
[158.962910] Starting subtest: absolute-wf_vblank
[158.964039] Starting dynamic subtest: A-VGA1
[166.761818] Dynamic subtest A-VGA1: SUCCESS (7.799s)
[166.775323] Starting dynamic subtest: B-VGA1
[174.488287] Dynamic subtest B-VGA1: SUCCESS (7.722s)
[174.499230] Starting dynamic subtest: A-HDMI-A1
[182.378319] Dynamic subtest A-HDMI-A1: SUCCESS (7.888s)
[182.388778] Starting dynamic subtest: B-HDMI-A1
[190.295275] Dynamic subtest B-HDMI-A1: SUCCESS (7.917s)
[190.296497] Subtest absolute-wf_vblank: SUCCESS (31.335s)
[190.474098] [036/132] (840s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[190.535478] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[190.583490] [037/132] (840s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[191.067762] Starting subtest: async-flip-with-page-flip-events-linear
[191.329347] Subtest async-flip-with-page-flip-events-linear: SKIP (0.261s)
[191.587555] [038/132] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[192.077791] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[193.979843] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.903s)
[194.123387] [039/132] (836s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[194.609189] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[194.668952] [040/132] (836s left) gem_softpin (full)
[194.730739] Subtest full: SKIP (0.000s)
[194.825795] [041/132] (836s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[194.888286] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[194.939221] [042/132] (836s left) kms_cursor_crc (cursor-offscreen-128x42)
[195.428446] Starting subtest: cursor-offscreen-128x42
[195.479891] Subtest cursor-offscreen-128x42: SKIP (0.049s)
[195.591904] [043/132] (835s left) kms_color_pipeline (plane-ctm3x4)
[196.077914] Starting subtest: plane-ctm3x4
[196.695146] Subtest plane-ctm3x4: SKIP (0.612s)
[196.932166] [044/132] (834s left) gem_mmap (bad-size)
[196.993662] Starting subtest: bad-size
[196.994760] Subtest bad-size: SUCCESS (0.001s)
[197.108107] [045/132] (834s left) prime_vgem (basic-fence-mmap)
[197.241340] Starting subtest: basic-fence-mmap
[197.274336] Subtest basic-fence-mmap: SUCCESS (0.034s)
[197.378616] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[197.382186] [046/132] (833s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[197.868785] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[199.890706] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.022s)
[200.042740] [047/132] (831s left) kms_frontbuffer_tracking (psr-suspend)
[200.531057] Starting subtest: psr-suspend
[200.533671] Subtest psr-suspend: SKIP (0.000s)
[200.642996] [048/132] (830s left) gem_exec_params (cliprects-invalid)
[200.702523] Starting subtest: cliprects-invalid
[200.703605] Subtest cliprects-invalid: SUCCESS (0.000s)
[200.807814] [049/132] (830s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[201.291138] Starting subtest: stress-xrgb8888-xtiled
[208.635487] Subtest stress-xrgb8888-xtiled: SUCCESS (7.350s)
[208.866905] [050/132] (822s left) prime_self_import (reimport-vs-gem_close-race)
[208.933193] Starting subtest: reimport-vs-gem_close-race
[213.949282] Subtest reimport-vs-gem_close-race: SUCCESS (5.021s)
[214.046904] [051/132] (817s left) gem_mmap_gtt (hang)
[214.103202] Starting subtest: hang
[219.574526] Subtest hang: SUCCESS (5.471s)
[219.696497] [052/132] (811s left) gem_ctx_param (invalid-ctx-get)
[219.758277] Starting subtest: invalid-ctx-get
[219.759328] Subtest invalid-ctx-get: SUCCESS (0.000s)
[219.849461] [053/132] (811s left) syncobj_timeline (single-wait-signaled)
[219.905793] Starting subtest: single-wait-signaled
[219.906880] Subtest single-wait-signaled: SUCCESS (0.001s)
[219.996963] [054/132] (811s left) gem_exec_balancer (parallel)
[220.054479] Subtest parallel: SKIP (0.000s)
[220.147642] [055/132] (811s left) kms_psr (fbc-psr-cursor-plane-move)
[220.610062] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[220.673419] [056/132] (811s left) gem_ctx_engines (execute-one)
[220.741400] Starting subtest: execute-one
[221.148540] Subtest execute-one: SUCCESS (0.407s)
[221.350423] [057/132] (810s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[221.837401] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[221.839454] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[221.964168] [058/132] (810s left) syncobj_eventfd (timeline-wait)
[222.026130] Starting subtest: timeline-wait
[222.036648] Subtest timeline-wait: SUCCESS (0.011s)
[222.139161] [059/132] (809s left) gem_exec_fence (submit-chain)
[222.309334] Subtest submit-chain: SKIP (0.000s)
[222.690313] [060/132] (809s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[222.762072] Starting subtest: map-fixed-invalidate-overlap-busy
[222.763217] Starting dynamic subtest: gtt
[223.819444] Dynamic subtest gtt: SUCCESS (1.057s)
[223.831394] Starting dynamic subtest: wb
[225.053432] Dynamic subtest wb: SUCCESS (1.233s)
[225.067857] Starting dynamic subtest: wc
[226.082068] Dynamic subtest wc: SUCCESS (1.027s)
[226.093380] Starting dynamic subtest: uc
[227.112586] Dynamic subtest uc: SUCCESS (1.029s)
[227.114163] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (4.352s)
[227.252438] [061/132] (804s left) kms_fbcon_fbt (psr-suspend)
[227.310514] Starting subtest: psr-suspend
[227.312771] Subtest psr-suspend: SKIP (0.000s)
[227.452976] [062/132] (804s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[227.509838] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[227.510945] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[227.604469] [063/132] (804s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[228.070128] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[228.072373] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[228.182390] [064/132] (804s left) kms_chamelium_color (ctm-blue-to-red)
[228.647139] Subtest ctm-blue-to-red: SKIP (0.000s)
[228.710514] [065/132] (803s left) core_setmaster (master-drop-set-user)
[228.845454] Starting subtest: master-drop-set-user
[228.870863] Subtest master-drop-set-user: SUCCESS (0.025s)
[228.918587] [066/132] (803s left) syncobj_wait (wait-all-complex)
[228.976022] Starting subtest: wait-all-complex
[229.188818] Subtest wait-all-complex: SUCCESS (0.214s)
[229.276907] [067/132] (803s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[229.333234] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[229.334321] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[229.425421] [068/132] (803s left) gem_exec_parallel (userptr)
[229.491870] Starting subtest: userptr
[229.492968] Starting dynamic subtest: rcs0
[231.440366] Dynamic subtest rcs0: SUCCESS (1.948s)
[231.453672] Starting dynamic subtest: bcs0
[233.142500] Dynamic subtest bcs0: SUCCESS (1.701s)
[233.143539] Subtest userptr: SUCCESS (3.652s)
[233.337929] [069/132] (799s left) kms_pm_rpm (pm-tiling)
[245.078933] Subtest pm-tiling: SKIP (0.000s)
[245.141485] [070/132] (787s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[245.617834] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[245.673435] [071/132] (787s left) kms_psr (psr2-cursor-mmap-gtt)
[246.154531] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[246.207268] [072/132] (786s left) i915_pm_rps (waitboost)
[246.270894] Starting subtest: waitboost
[249.803175] Subtest waitboost: SUCCESS (3.532s)
[249.938419] [073/132] (782s left) gem_ctx_persistence (hang)
[249.997437] Subtest hang: SKIP (0.000s)
[250.072561] [074/132] (782s left) kms_psr (fbc-psr2-sprite-blt)
[250.548414] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[250.615620] [075/132] (782s left) kms_lease (empty-lease)
[251.091650] Starting subtest: empty-lease
[251.092759] Starting dynamic subtest: pipe-A-VGA-1
[251.093859] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.001s)
[251.105587] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.106633] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[251.117934] Starting dynamic subtest: pipe-B-VGA-1
[251.119037] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s)
[251.130568] Starting dynamic subtest: pipe-B-HDMI-A-1
[251.131991] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[251.134114] Subtest empty-lease: SUCCESS (0.012s)
[251.198671] [076/132] (781s left) syncobj_wait (wait-all-for-submit-complex)
[251.259594] Starting subtest: wait-all-for-submit-complex
[251.476338] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[251.576753] [077/132] (781s left) api_intel_bb (reset-bb)
[251.636069] Starting subtest: reset-bb
[251.637174] Subtest reset-bb: SUCCESS (0.001s)
[251.751558] [078/132] (781s left) kms_chamelium_hpd (hdmi-hpd-storm)
[252.350391] Subtest hdmi-hpd-storm: SKIP (0.000s)
[252.562618] [079/132] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[253.044478] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[253.046907] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[253.147635] [080/132] (780s left) gem_exec_schedule (u-submit-late-slice)
[253.220931] Subtest u-submit-late-slice: SKIP (0.000s)
[253.411821] [081/132] (779s left) kms_invalid_mode (int-max-clock)
[253.889300] Starting subtest: int-max-clock
[253.890432] Starting dynamic subtest: pipe-A-VGA-1
[254.014323] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.123s)
[254.028567] Starting dynamic subtest: pipe-A-HDMI-A-1
[254.029858] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[254.047547] Starting dynamic subtest: pipe-B-VGA-1
[254.050243] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.001s)
[254.066577] Starting dynamic subtest: pipe-B-HDMI-A-1
[254.069524] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[254.072508] Subtest int-max-clock: SUCCESS (0.135s)
[254.303320] [082/132] (778s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[254.360645] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[254.431542] [083/132] (778s left) gem_exec_suspend (basic-s3)
[254.500870] Starting subtest: basic-S3
[254.502045] Starting dynamic subtest: smem
[272.021866] Dynamic subtest smem: SUCCESS (1.529s)
[272.025825] Subtest basic-S3: SUCCESS (1.531s)
[285.243537] [084/132] (761s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[287.864760] Starting subtest: verify-pxp-key-change-after-suspend-resume
[287.867118] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[287.978592] [085/132] (758s left) gem_exec_schedule (pi-common)
[288.057639] Subtest pi-common: SKIP (0.000s)
[288.266146] [086/132] (758s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[288.764687] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[288.767180] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[288.876626] [087/132] (757s left) gem_exec_balancer (parallel-contexts)
[288.941720] Subtest parallel-contexts: SKIP (0.000s)
[289.053805] [088/132] (757s left) i915_hangman (gt-engine-error)
[289.119568] Starting subtest: gt-engine-error
[289.121787] Subtest gt-engine-error: SKIP (0.000s)
[289.197812] [089/132] (757s left) kms_cursor_crc (cursor-random-512x512)
[289.695401] Starting subtest: cursor-random-512x512
[289.697519] Subtest cursor-random-512x512: SKIP (0.001s)
[289.821841] [090/132] (756s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[290.309727] Starting subtest: fb-8bpc-vs-panel-6bpc
[290.312488] Starting dynamic subtest: pipe-A-HDMI-A-1
[290.419382] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.106s)
[290.422037] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.110s)
[290.706663] [091/132] (756s left) perf_pmu (busy-start)
[290.771033] Starting subtest: busy-start
[290.772233] Starting dynamic subtest: rcs0
[293.301939] Dynamic subtest rcs0: SUCCESS (2.497s)
[293.320017] Starting dynamic subtest: bcs0
[295.823959] Dynamic subtest bcs0: SUCCESS (2.496s)
[295.842082] Starting dynamic subtest: vcs0
[298.849878] Dynamic subtest vcs0: SUCCESS (3.002s)
[298.851570] Subtest busy-start: SUCCESS (8.003s)
[298.950889] [092/132] (747s left) gem_fence_thrash (bo-write-verify-threaded-x)
[299.011156] Starting subtest: bo-write-verify-threaded-x
[300.775979] Subtest bo-write-verify-threaded-x: SUCCESS (1.755s)
[300.891467] [093/132] (746s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[301.378499] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[301.380782] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[301.487979] [094/132] (745s left) kms_flip (2x-plain-flip-interruptible)
[301.978735] Starting subtest: 2x-plain-flip-interruptible
[301.979860] Starting dynamic subtest: AB-VGA1-HDMI-A1
[304.373959] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.386s)
[304.377986] Subtest 2x-plain-flip-interruptible: SUCCESS (2.391s)
[304.639355] [095/132] (742s left) gem_exec_reloc (basic-cpu-wc-active)
[304.706152] Starting subtest: basic-cpu-wc-active
[304.816452] Subtest basic-cpu-wc-active: SUCCESS (0.110s)
[305.336166] [096/132] (741s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[305.394633] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[305.463828] [097/132] (741s left) kms_vrr (lobf)
[305.941991] Starting subtest: lobf
[305.944539] Subtest lobf: SKIP (0.000s)
[306.039111] [098/132] (741s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[306.524441] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[306.526838] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[306.641206] [099/132] (740s left) kms_busy (extended-modeset-hang-oldfb)
[307.119520] Starting subtest: extended-modeset-hang-oldfb
[307.120583] Starting dynamic subtest: pipe-A
[313.060565] Dynamic subtest pipe-A: SUCCESS (5.930s)
[313.077638] Starting dynamic subtest: pipe-B
[319.108195] Dynamic subtest pipe-B: SUCCESS (6.043s)
[319.111138] Subtest extended-modeset-hang-oldfb: SUCCESS (11.979s)
[319.406761] [100/132] (727s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[319.474711] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[319.477143] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[319.687671] [101/132] (727s left) sw_sync (sync_multi_producer_single_consumer)
[319.746779] Starting subtest: sync_multi_producer_single_consumer
[320.821657] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[320.904111] [102/132] (726s left) kms_content_protection (dp-mst-type-1)
[321.397056] Starting subtest: dp-mst-type-1
[321.399488] Subtest dp-mst-type-1: SKIP (0.000s)
[321.505143] [103/132] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[321.989145] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[323.911404] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.923s)
[324.136346] [104/132] (723s left) gem_ctx_isolation (preservation-reset)
[324.313920] Starting subtest: preservation-reset
[324.315489] Starting dynamic subtest: rcs0
[324.800622] Dynamic subtest rcs0: SUCCESS (0.486s)
[324.803518] Subtest preservation-reset: SUCCESS (0.488s)
[324.936172] [105/132] (722s left) gem_userptr_blits (probe)
[325.028769] Starting subtest: probe
[325.225864] Subtest probe: SUCCESS (0.199s)
[325.338123] [106/132] (722s left) kms_rotation_crc (exhaust-fences)
[325.816295] Starting subtest: exhaust-fences
[325.818623] Subtest exhaust-fences: SKIP (0.000s)
[325.936965] [107/132] (721s left) kms_feature_discovery (display-4x)
[326.416163] Starting subtest: display-4x
[326.418736] Subtest display-4x: SKIP (0.000s)
[326.524139] [108/132] (721s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[327.003248] Starting subtest: psr-farfromfence-mmap-gtt
[327.005681] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[327.115648] [109/132] (720s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[327.600931] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[327.603299] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[327.713272] [110/132] (720s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[328.198889] Starting subtest: y-tiled-64bpp-rotate-0
[328.201470] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[328.312167] [111/132] (719s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[328.788962] Starting subtest: cursorA-vs-flipB-legacy
[339.742734] Subtest cursorA-vs-flipB-legacy: SUCCESS (10.949s)
[340.005998] [112/132] (707s left) kms_pm_lpsp (screens-disabled)
[351.539386] Starting subtest: screens-disabled
[351.801701] Subtest screens-disabled: SKIP (0.262s)
[352.052008] [113/132] (695s left) syncobj_wait (reset-signaled)
[352.111363] Starting subtest: reset-signaled
[352.112417] Subtest reset-signaled: SUCCESS (0.000s)
[352.215518] [114/132] (695s left) i915_drm_fdinfo (memory-info-resident)
[352.277985] Subtest memory-info-resident: SKIP (0.000s)
[352.344309] [115/132] (695s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[352.404070] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[352.405392] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[352.499050] [116/132] (695s left) i915_pm_rpm (gem-evict-pwrite)
[364.268347] Subtest gem-evict-pwrite: SKIP (0.000s)
[364.330958] [117/132] (683s left) gem_eio (in-flight-internal-immediate)
[364.398079] Starting subtest: in-flight-internal-immediate
[364.429883] Subtest in-flight-internal-immediate: SUCCESS (0.032s)
[364.956581] [118/132] (683s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[365.018872] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[365.092849] [119/132] (683s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[365.155047] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[365.224592] [120/132] (683s left) vgem_basic (dmabuf-mmap)
[365.294666] Starting subtest: dmabuf-mmap
[365.324013] Subtest dmabuf-mmap: SUCCESS (0.031s)
[365.412828] [121/132] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[365.892614] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[365.894822] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[366.008848] [122/132] (682s left) gem_exec_async (forked-writes)
[366.078344] Starting subtest: forked-writes
[366.079480] Starting dynamic subtest: rcs0
[366.093830] Dynamic subtest rcs0: SUCCESS (0.016s)
[366.111671] Starting dynamic subtest: bcs0
[366.112724] Dynamic subtest bcs0: SUCCESS (0.016s)
[366.128673] Starting dynamic subtest: vcs0
[366.135787] Dynamic subtest vcs0: SUCCESS (0.023s)
[366.136843] Subtest forked-writes: SUCCESS (0.060s)
[366.377497] [123/132] (682s left) gem_exec_alignment (single)
[366.437381] Starting subtest: single
[366.440051] Subtest single: SUCCESS (0.002s)
[366.581983] [124/132] (682s left) api_intel_allocator (reserve-simple)
[366.638664] Starting subtest: reserve-simple
[366.643820] Subtest reserve-simple: SUCCESS (0.005s)
[366.789540] [125/132] (681s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[366.851199] Starting subtest: multi-wait-for-submit-available-signaled
[366.852347] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[366.966643] [126/132] (681s left) gen7_exec_parse (batch-without-end)
[367.027452] Subtest batch-without-end: SKIP (0.000s)
[367.092305] [127/132] (681s left) kms_vblank (wait-forked-busy-hang)
[367.567289] Starting subtest: wait-forked-busy-hang
[367.568706] Starting dynamic subtest: pipe-A-VGA-1
[373.918395] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.347s)
[373.936247] Starting dynamic subtest: pipe-A-HDMI-A-1
[379.953492] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.031s)
[379.974501] Starting dynamic subtest: pipe-B-VGA-1
[385.929613] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.976s)
[385.950607] Starting dynamic subtest: pipe-B-HDMI-A-1
[391.926269] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.997s)
[391.929113] Subtest wait-forked-busy-hang: SUCCESS (24.363s)
[392.207909] [128/132] (656s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[392.697964] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[392.799477] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.102s)
[393.026091] [129/132] (655s left) gen3_render_mixed_blits
[393.153772] [130/132] (655s left) kms_psr (fbc-pr-primary-mmap-gtt)
[393.632706] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[393.703764] [131/132] (655s left) kms_cursor_crc (cursor-suspend)
[394.183419] Starting subtest: cursor-suspend
[394.184657] Starting dynamic subtest: pipe-A-VGA-1
[428.899995] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.796s)
[428.920573] Starting dynamic subtest: pipe-B-HDMI-A-1
[463.961929] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.810s)
[463.962939] Subtest cursor-suspend: SUCCESS (3.612s)
[471.253288] [132/132] (584s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[471.753999] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[472.955334] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.166s)
[473.218491] 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.