[73.571566] Initializing watchdogs
[73.571685]   /dev/watchdog0
[73.596244] [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.603932] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.607647] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.611088] [001/130] (960s left) gem_softpin (evict-prime)
[73.712446] Subtest evict-prime: SKIP (0.000s)
[73.836685] [002/130] (960s left) gem_mmap_gtt (hang)
[73.891784] Starting subtest: hang
[79.354901] Subtest hang: SUCCESS (5.464s)
[79.547315] [003/130] (954s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[79.920146] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[82.057922] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.139s)
[82.529837] [004/130] (951s left) kms_dsc (dsc-with-formats)
[82.891894] Subtest dsc-with-formats: SKIP (0.000s)
[83.122483] [005/130] (951s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[83.478094] Starting subtest: cursor-rapid-movement-64x21
[83.538365] Subtest cursor-rapid-movement-64x21: SKIP (0.056s)
[84.009946] [006/130] (950s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[84.361309] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[84.362838] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[84.823231] [007/130] (949s left) kms_psr (fbc-psr-sprite-plane-move)
[85.172760] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[85.386562] [008/130] (949s left) gem_ccs (block-multicopy-compressed)
[85.448195] Subtest block-multicopy-compressed: SKIP (0.000s)
[85.503340] [009/130] (948s left) gem_mmap_offset (ptrace)
[85.560279] Starting subtest: ptrace
[85.561286] Starting dynamic subtest: smem0-gtt
[85.587275] Dynamic subtest smem0-gtt: SUCCESS (0.027s)
[85.598303] Starting dynamic subtest: smem0-wb
[85.616340] Dynamic subtest smem0-wb: SUCCESS (0.029s)
[85.625790] Starting dynamic subtest: smem0-wc
[85.643287] Dynamic subtest smem0-wc: SUCCESS (0.026s)
[85.652741] Starting dynamic subtest: smem0-uc
[85.667908] Dynamic subtest smem0-uc: SUCCESS (0.025s)
[85.668938] Subtest ptrace: SUCCESS (0.109s)
[85.822192] [010/130] (948s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[85.873904] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[85.933917] [011/130] (948s left) kms_flip (2x-wf_vblank-ts-check)
[86.280640] Starting subtest: 2x-wf_vblank-ts-check
[86.282616] Starting dynamic subtest: AB-VGA1-HDMI-A1
[117.044538] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.762s)
[117.045779] Subtest 2x-wf_vblank-ts-check: SUCCESS (30.766s)
[117.763200] [012/130] (916s left) syncobj_wait (invalid-reset-one-illegal-handle)
[117.818349] Starting subtest: invalid-reset-one-illegal-handle
[117.819066] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[117.941802] [013/130] (916s left) kms_big_fb (4-tiled-addfb-size-overflow)
[118.310532] Starting subtest: 4-tiled-addfb-size-overflow
[118.311951] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[118.779176] [014/130] (915s left) kms_prop_blob (basic)
[118.834962] Starting subtest: basic
[118.835802] Subtest basic: SUCCESS (0.000s)
[118.959014] [015/130] (915s left) dmabuf_sync_file (export-wait-after-attach)
[119.049912] Starting subtest: export-wait-after-attach
[119.051680] Subtest export-wait-after-attach: SUCCESS (0.003s)
[119.160508] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[119.162991] [016/130] (915s left) kms_joiner (basic-max-non-joiner)
[119.515845] Starting subtest: basic-max-non-joiner
[119.517455] Subtest basic-max-non-joiner: SKIP (0.000s)
[119.993310] [017/130] (914s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[120.053628] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[120.106325] [018/130] (914s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[120.470260] Starting subtest: pipe-fbc-rte
[120.472587] Starting dynamic subtest: pipe-B-HDMI-A-1
[123.818299] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.348s)
[123.819504] Subtest pipe-fbc-rte: SUCCESS (3.350s)
[124.501142] [019/130] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[124.872597] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[124.873985] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[125.335572] [020/130] (909s left) gem_exec_fence (syncobj-timeline-repeat)
[125.651453] Starting subtest: syncobj-timeline-repeat
[126.205827] Subtest syncobj-timeline-repeat: SUCCESS (0.554s)
[126.465749] [021/130] (908s left) kms_chamelium_color (ctm-blue-to-red)
[126.827784] Subtest ctm-blue-to-red: SKIP (0.000s)
[127.057554] [022/130] (908s left) intel_hwmon (hwmon-write)
[127.116600] Subtest hwmon-write: SKIP (0.000s)
[127.174690] [023/130] (907s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[127.226081] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[127.291180] [024/130] (907s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[127.646074] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[127.870942] [025/130] (907s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[128.225436] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[130.060990] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.834s)
[130.567039] [026/130] (904s left) gen9_exec_parse (unaligned-access)
[130.627730] Subtest unaligned-access: SKIP (0.000s)
[130.702144] [027/130] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[131.065915] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt
[131.067710] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[131.539014] [028/130] (903s left) gem_exec_whisper (basic-fds-forked-all)
[131.608428] Starting subtest: basic-fds-forked-all
[135.107831] Subtest basic-fds-forked-all: SUCCESS (3.498s)
[135.351331] [029/130] (900s left) kms_psr (psr-suspend)
[135.712842] Subtest psr-suspend: SKIP (0.000s)
[135.943100] [030/130] (899s left) kms_atomic (plane-immutable-zpos)
[136.304569] Starting subtest: plane-immutable-zpos
[136.305674] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.662676] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.356s)
[136.664788] Subtest plane-immutable-zpos: SUCCESS (0.359s)
[137.253235] [031/130] (898s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[137.608564] Starting subtest: fbcpsr-indfb-scaledprimary
[137.609732] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[138.094300] [032/130] (897s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[138.456694] Starting subtest: 4-tiled-64bpp-rotate-90
[138.458058] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[138.930197] [033/130] (896s left) kms_content_protection (lic-type-1)
[139.301127] Starting subtest: lic-type-1
[139.521803] Subtest lic-type-1: SKIP (0.218s)
[140.157335] [034/130] (895s left) gem_ctx_engines (independent)
[140.225851] Starting subtest: independent
[140.227953] Subtest independent: SKIP (0.000s)
[140.458282] [035/130] (895s left) kms_psr (psr2-primary-page-flip)
[140.816980] Subtest psr2-primary-page-flip: SKIP (0.000s)
[141.047906] [036/130] (894s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[141.408803] Starting subtest: primary-yf-tiled-reflect-x-0
[141.410332] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.001s)
[141.855234] [037/130] (894s left) kms_plane_scaling (2x-scaler-multi-pipe)
[142.212262] Starting subtest: 2x-scaler-multi-pipe
[142.213660] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[142.687421] [038/130] (893s left) kms_pm_rpm (legacy-planes-dpms)
[154.279348] Subtest legacy-planes-dpms: SKIP (0.000s)
[154.510534] [039/130] (881s left) i915_power (sanity)
[154.573544] Starting subtest: sanity
[158.579351] Subtest sanity: SUCCESS (4.005s)
[158.736424] [040/130] (877s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[159.093968] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[159.095547] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[159.566419] [041/130] (876s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[159.937580] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[159.939104] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[160.419437] [042/130] (875s left) gem_lmem_swapping (parallel-random)
[160.477877] Subtest parallel-random: SKIP (0.000s)
[160.547347] [043/130] (875s left) i915_pm_freq_api (freq-suspend)
[160.604537] Subtest freq-suspend: SKIP (0.000s)
[160.665274] [044/130] (875s left) gem_exec_await (wide-contexts)
[160.750215] Starting subtest: wide-contexts
[182.721523] Subtest wide-contexts: SUCCESS (21.969s)
[182.932540] [045/130] (853s left) gem_exec_schedule (submit-late-slice)
[183.113235] Subtest submit-late-slice: SKIP (0.000s)
[183.356712] [046/130] (852s left) kms_color (gamma)
[183.730185] Starting subtest: gamma
[183.731144] Starting dynamic subtest: pipe-A-HDMI-A-1
[184.202714] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.472s)
[184.217381] Starting dynamic subtest: pipe-B-HDMI-A-1
[184.707193] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.504s)
[184.707843] Subtest gamma: SUCCESS (0.979s)
[185.287114] [047/130] (851s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[185.655625] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[185.656488] Starting dynamic subtest: pipe-A
[185.658338] Dynamic subtest pipe-A: SKIP (0.001s)
[185.670201] Starting dynamic subtest: pipe-B
[185.671978] Dynamic subtest pipe-B: SKIP (0.001s)
[185.673228] Subtest plane-scaler-unity-scaling-with-modifiers: SKIP (0.004s)
[186.136416] [048/130] (850s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[186.499181] Starting subtest: basic-flip-after-cursor-varying-size
[187.530996] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.032s)
[188.090613] [049/130] (848s left) kms_cursor_crc (cursor-onscreen-32x10)
[188.448323] Starting subtest: cursor-onscreen-32x10
[188.511349] Subtest cursor-onscreen-32x10: SKIP (0.061s)
[188.988909] [050/130] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[189.347077] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[189.348394] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[189.823565] [051/130] (846s left) gem_exec_params (invalid-fence-in)
[189.884370] Starting subtest: invalid-fence-in
[189.885148] Subtest invalid-fence-in: SUCCESS (0.000s)
[190.032189] [052/130] (846s left) gem_workarounds (reset-fd)
[190.104725] Starting subtest: reset-fd
[190.114229] Subtest reset-fd: SUCCESS (0.007s)
[190.273879] [053/130] (846s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[190.332325] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[190.440114] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[190.567994] [054/130] (846s left) syncobj_timeline (wait-all-for-submit-snapshot)
[190.625673] Starting subtest: wait-all-for-submit-snapshot
[190.708224] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[190.827433] [055/130] (845s left) gem_ctx_param (invalid-param-get)
[190.882726] Starting subtest: invalid-param-get
[190.883526] Subtest invalid-param-get: SUCCESS (0.000s)
[191.010622] [056/130] (845s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[191.065877] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[191.066730] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[191.198567] [057/130] (845s left) gem_exec_flush (basic-uc-rw-default)
[191.261570] Starting subtest: basic-uc-rw-default
[196.704605] Subtest basic-uc-rw-default: SUCCESS (5.443s)
[196.939904] [058/130] (840s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[197.303764] Starting subtest: yf-tiled-64bpp-rotate-180
[197.305127] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[197.774089] [059/130] (839s left) gem_pxp (display-protected-crc)
[200.345052] Starting subtest: display-protected-crc
[200.347017] Subtest display-protected-crc: SKIP (0.000s)
[200.486686] [060/130] (836s left) i915_hangman (engine-error-state-capture)
[200.550806] Subtest engine-error-state-capture: SKIP (0.000s)
[200.627635] [061/130] (836s left) gem_exec_balancer (full-pulse)
[200.685958] Subtest full-pulse: SKIP (0.000s)
[200.819878] [062/130] (836s left) prime_mmap_coherency (write)
[200.877233] Starting subtest: write
[206.256642] Subtest write: SUCCESS (5.376s)
[206.864337] [063/130] (830s left) api_intel_bb (render)
[206.921869] Starting subtest: render
[206.922518] Starting dynamic subtest: render-none-512
[207.009539] Dynamic subtest render-none-512: SUCCESS (0.086s)
[207.021622] Starting dynamic subtest: render-none-reloc-512
[207.093882] Dynamic subtest render-none-reloc-512: SUCCESS (0.085s)
[207.108888] Starting dynamic subtest: render-none-1024
[207.425167] Dynamic subtest render-none-1024: SUCCESS (0.330s)
[207.437926] Starting dynamic subtest: render-none-reloc-1024
[207.749703] Dynamic subtest render-none-reloc-1024: SUCCESS (0.323s)
[207.762352] Starting dynamic subtest: render-x-512
[207.827909] Dynamic subtest render-x-512: SUCCESS (0.078s)
[207.842035] Starting dynamic subtest: render-x-reloc-512
[207.902992] Dynamic subtest render-x-reloc-512: SUCCESS (0.074s)
[207.915966] Starting dynamic subtest: render-x-1024
[208.192932] Dynamic subtest render-x-1024: SUCCESS (0.288s)
[208.204632] Starting dynamic subtest: render-x-reloc-1024
[208.483961] Dynamic subtest render-x-reloc-1024: SUCCESS (0.290s)
[208.497168] Starting dynamic subtest: render-y-512
[208.561129] Dynamic subtest render-y-512: SUCCESS (0.077s)
[208.573912] Starting dynamic subtest: render-y-reloc-512
[208.637463] Dynamic subtest render-y-reloc-512: SUCCESS (0.075s)
[208.650390] Starting dynamic subtest: render-y-1024
[208.929091] Dynamic subtest render-y-1024: SUCCESS (0.290s)
[208.944273] Starting dynamic subtest: render-y-reloc-1024
[209.223716] Dynamic subtest render-y-reloc-1024: SUCCESS (0.293s)
[209.224477] Subtest render: SUCCESS (2.302s)
[209.380562] [064/130] (827s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[209.735714] Starting subtest: fb-8bpc-vs-panel-8bpc
[209.736514] Starting dynamic subtest: pipe-A-HDMI-A-1
[209.829217] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.092s)
[209.832259] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.095s)
[210.423560] [065/130] (826s left) gem_vm_create (create-ext)
[210.483030] Subtest create-ext: SKIP (0.000s)
[210.541704] [066/130] (826s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[210.898019] Starting subtest: primary-x-tiled-reflect-x-0
[210.900528] Subtest primary-x-tiled-reflect-x-0: SKIP (0.002s)
[211.377720] [067/130] (826s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[211.739174] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[211.740442] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[212.191402] [068/130] (825s left) gem_eio (in-flight-contexts-immediate)
[212.261037] Starting subtest: in-flight-contexts-immediate
[217.054514] Subtest in-flight-contexts-immediate: SUCCESS (4.795s)
[217.833920] [069/130] (819s left) kms_flip (flip-vs-panning-vs-hang)
[218.198920] Starting subtest: flip-vs-panning-vs-hang
[218.199652] Starting dynamic subtest: A-VGA1
[219.488327] Dynamic subtest A-VGA1: SUCCESS (1.288s)
[219.502478] Starting dynamic subtest: B-VGA1
[220.558205] Dynamic subtest B-VGA1: SUCCESS (1.067s)
[220.569944] Starting dynamic subtest: A-HDMI-A1
[221.863288] Dynamic subtest A-HDMI-A1: SUCCESS (1.303s)
[221.876844] Starting dynamic subtest: B-HDMI-A1
[223.177324] Dynamic subtest B-HDMI-A1: SUCCESS (1.315s)
[223.179534] Subtest flip-vs-panning-vs-hang: SUCCESS (4.980s)
[223.835373] [070/130] (813s left) syncobj_timeline (multi-wait-submitted-signaled)
[223.898989] Starting subtest: multi-wait-submitted-signaled
[223.899778] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[224.040719] [071/130] (813s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[224.400047] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[224.401523] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[224.868292] [072/130] (812s left) prime_vgem (basic-fence-mmap)
[224.938101] Starting subtest: basic-fence-mmap
[224.975575] Subtest basic-fence-mmap: SUCCESS (0.034s)
[225.116594] [073/130] (812s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[225.172881] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[225.240682] [074/130] (812s left) syncobj_timeline (etime-single-wait-submitted)
[225.295381] Starting subtest: etime-single-wait-submitted
[225.400109] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[225.531673] [075/130] (812s left) gem_exec_gttfill (basic)
[225.601096] Starting subtest: basic
[229.021040] Subtest basic: SUCCESS (3.421s)
[229.278053] [076/130] (808s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[229.732174] Starting subtest: coverage-vs-premult-vs-constant
[229.906535] Subtest coverage-vs-premult-vs-constant: SKIP (0.176s)
[230.562460] [077/130] (807s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[230.927333] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[230.929089] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[231.410390] [078/130] (806s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[231.777851] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[231.779379] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[232.259825] [079/130] (805s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[232.612281] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[232.846786] [080/130] (805s left) gem_exec_schedule (semaphore-codependency)
[232.928967] Subtest semaphore-codependency: SKIP (0.000s)
[233.173118] [081/130] (805s left) vgem_basic (dmabuf-fence)
[233.238157] Starting subtest: dmabuf-fence
[233.238904] Subtest dmabuf-fence: SUCCESS (0.001s)
[233.334521] [082/130] (804s left) kms_pm_dc (dc3co-vpb-simulation)
[244.435314] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[244.494425] [083/130] (793s left) kms_writeback (writeback-fb-id)
[244.853886] Subtest writeback-fb-id: SKIP (0.000s)
[245.094505] [084/130] (793s left) kms_fence_pin_leak
[247.312479] [085/130] (791s left) gem_render_copy (linear-to-vebox-y-tiled)
[247.383038] Starting subtest: linear-to-vebox-y-tiled
[247.385395] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[247.627755] [086/130] (790s left) kms_lease (page-flip-implicit-plane)
[247.978135] Starting subtest: page-flip-implicit-plane
[247.979041] Starting dynamic subtest: pipe-A-HDMI-A-1
[248.240121] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.261s)
[248.256669] Starting dynamic subtest: pipe-B-HDMI-A-1
[248.529655] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.287s)
[248.530381] Subtest page-flip-implicit-plane: SUCCESS (0.554s)
[249.094681] [087/130] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[249.453316] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[249.455690] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[249.925076] [088/130] (788s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[250.300492] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[250.303109] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[250.771754] [089/130] (787s left) gem_exec_fence (submit-chain)
[250.948394] Subtest submit-chain: SKIP (0.000s)
[251.339969] [090/130] (787s left) kms_pipe_crc_basic (suspend-read-crc)
[251.694788] Starting subtest: suspend-read-crc
[251.695513] Starting dynamic subtest: pipe-A-HDMI-A-1
[269.350748] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.625s)
[269.364976] Starting dynamic subtest: pipe-B-HDMI-A-1
[287.320520] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.718s)
[287.321235] Subtest suspend-read-crc: SUCCESS (3.348s)
[293.887654] [091/130] (750s left) gem_unref_active_buffers
[294.150098] [092/130] (750s left) perf_pmu (rc6-all-gts)
[294.211491] Starting subtest: rc6-all-gts
[294.212792] Subtest rc6-all-gts: SKIP (0.000s)
[294.328555] [093/130] (750s left) kms_busy (extended-modeset-hang-newfb)
[294.693794] Starting subtest: extended-modeset-hang-newfb
[294.694494] Starting dynamic subtest: pipe-A
[307.316760] Dynamic subtest pipe-A: SUCCESS (12.569s)
[307.332426] Starting dynamic subtest: pipe-B
[319.352199] Dynamic subtest pipe-B: SUCCESS (12.018s)
[319.352799] Subtest extended-modeset-hang-newfb: SUCCESS (24.594s)
[319.944007] [094/130] (725s left) syncobj_wait (single-wait-for-submit-submitted)
[320.007567] Starting subtest: single-wait-for-submit-submitted
[320.111682] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[320.242348] [095/130] (724s left) kms_chamelium_hpd (hdmi-hpd)
[320.676001] Subtest hdmi-hpd: SKIP (0.000s)
[321.039375] [096/130] (724s left) gem_tiled_fence_blits (basic)
[321.204478] Starting subtest: basic
[321.213291] Subtest basic: SUCCESS (0.007s)
[321.351264] [097/130] (723s left) api_intel_bb (crc32)
[321.513023] Starting subtest: crc32
[321.514570] Subtest crc32: SKIP (0.000s)
[321.627870] [098/130] (723s left) kms_addfb_basic (small-bo)
[321.996772] Starting subtest: small-bo
[321.997542] Subtest small-bo: SUCCESS (0.000s)
[322.476761] [099/130] (722s left) kms_addfb_basic (bad-pitch-256)
[322.535633] Starting subtest: bad-pitch-256
[322.536268] Subtest bad-pitch-256: SUCCESS (0.000s)
[323.309393] [100/130] (721s left) gem_partial_pwrite_pread (write-snoop)
[323.374828] Starting subtest: write-snoop
[327.278303] Subtest write-snoop: SUCCESS (3.905s)
[327.436075] [101/130] (717s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[327.799942] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[327.801192] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[328.284213] [102/130] (717s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[328.638216] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[330.125025] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (1.487s)
[330.624424] [103/130] (714s left) kms_vblank (invalid)
[330.981096] Starting subtest: invalid
[330.981761] Starting dynamic subtest: pipe-A-HDMI-A-1
[331.170174] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.188s)
[331.170934] Subtest invalid: SUCCESS (0.191s)
[331.760310] [104/130] (713s left) perf (whitelisted-registers-userspace-config)
[331.979318] Subtest whitelisted-registers-userspace-config: SKIP (0.000s)
[332.040317] [105/130] (713s left) gem_eio (in-flight-contexts-1us)
[332.102282] Starting subtest: in-flight-contexts-1us
[335.438147] Subtest in-flight-contexts-1us: SUCCESS (3.338s)
[336.219743] [106/130] (709s left) syncobj_wait (multi-wait-for-submit-submitted)
[336.279670] Starting subtest: multi-wait-for-submit-submitted
[336.385454] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s)
[336.522803] [107/130] (709s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[336.580515] Starting subtest: writes-after-reads
[337.279753] Subtest writes-after-reads: SUCCESS (0.699s)
[337.446225] [108/130] (708s left) gem_ctx_persistence (legacy-engines-mixed)
[337.505206] Subtest legacy-engines-mixed: SKIP (0.000s)
[337.580603] [109/130] (708s left) gen9_exec_parse (batch-invalid-length)
[337.635881] Subtest batch-invalid-length: SKIP (0.000s)
[337.709076] [110/130] (708s left) prime_vgem (wait)
[337.782779] Starting subtest: wait
[337.783580] Starting dynamic subtest: rcs0
[337.803882] Dynamic subtest rcs0: SUCCESS (0.021s)
[337.823985] Starting dynamic subtest: bcs0
[337.825006] Dynamic subtest bcs0: SUCCESS (0.015s)
[337.825886] Subtest wait: SUCCESS (0.039s)
[337.988430] [111/130] (707s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[338.046751] Starting subtest: cpuset-basic-small-copy-XY
[338.905633] Subtest cpuset-basic-small-copy-XY: SUCCESS (0.860s)
[339.048116] [112/130] (706s left) kms_setmode (clone-exclusive-crtc)
[339.213716] Starting subtest: clone-exclusive-crtc
[339.215964] Subtest clone-exclusive-crtc: SKIP (0.000s)
[339.346602] [113/130] (706s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[339.723914] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[339.726292] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.002s)
[340.205209] [114/130] (705s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[340.576427] Starting subtest: x-tiled-16bpp-rotate-90
[340.587770] Subtest x-tiled-16bpp-rotate-90: SKIP (0.009s)
[341.077906] [115/130] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[341.438753] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[341.440020] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[341.925939] [116/130] (704s left) kms_vblank (wait-idle-hang)
[342.287417] Starting subtest: wait-idle-hang
[342.288286] Starting dynamic subtest: pipe-A-HDMI-A-1
[348.234803] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.947s)
[348.251587] Starting dynamic subtest: pipe-B-HDMI-A-1
[354.257016] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.017s)
[354.257669] Subtest wait-idle-hang: SUCCESS (11.971s)
[354.838887] [117/130] (691s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[355.212987] Starting subtest: extended-modeset-hang-oldfb-with-reset
[355.215661] Starting dynamic subtest: pipe-A
[365.972362] Dynamic subtest pipe-A: SUCCESS (10.754s)
[365.987025] Starting dynamic subtest: pipe-B
[376.715578] Dynamic subtest pipe-B: SUCCESS (10.737s)
[376.716360] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.496s)
[377.312090] [118/130] (668s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[377.691573] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[377.938351] [119/130] (668s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[377.995449] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[378.077338] [120/130] (668s left) syncobj_timeline (multi-wait-all-available-submitted)
[378.143846] Starting subtest: multi-wait-all-available-submitted
[378.147083] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[378.277803] [121/130] (668s left) gem_exec_balancer (hang)
[378.335772] Subtest hang: SKIP (0.000s)
[378.478349] [122/130] (668s left) gem_ctx_persistence (legacy-engines-cleanup)
[378.538367] Subtest legacy-engines-cleanup: SKIP (0.000s)
[378.602061] [123/130] (667s left) gem_exec_schedule (fairslice-all)
[378.672703] Subtest fairslice-all: SKIP (0.000s)
[378.913950] [124/130] (667s left) gem_softpin (overlap)
[378.975570] Starting subtest: overlap
[379.159153] Subtest overlap: SUCCESS (0.181s)
[379.322260] [125/130] (667s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[379.671986] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[379.673451] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.002s)
[380.166333] [126/130] (666s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[380.527748] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[380.529073] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[381.004195] [127/130] (665s left) prime_vgem (basic-fence-flip)
[381.072385] Starting subtest: basic-fence-flip
[381.853553] Subtest basic-fence-flip: SUCCESS (0.781s)
[382.469789] [128/130] (664s left) kms_psr (pr-primary-render)
[382.824907] Subtest pr-primary-render: SKIP (0.000s)
[383.060977] [129/130] (663s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[383.415377] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[383.644993] [130/130] (663s left) kms_flip (flip-vs-blocking-wf-vblank)
[384.009763] Starting subtest: flip-vs-blocking-wf-vblank
[384.010377] Starting dynamic subtest: A-VGA1
[392.066132] Dynamic subtest A-VGA1: SUCCESS (8.055s)
[392.083744] Starting dynamic subtest: B-VGA1
[400.071745] Dynamic subtest B-VGA1: SUCCESS (8.004s)
[400.086110] Starting dynamic subtest: A-HDMI-A1
[408.240349] Dynamic subtest A-HDMI-A1: SUCCESS (8.169s)
[408.257824] Starting dynamic subtest: B-HDMI-A1
[416.460925] Dynamic subtest B-HDMI-A1: SUCCESS (8.218s)
[416.463403] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.459s)
[417.115784] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_dsc
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_ccs
results: parsing output: 8/ for test: gem_mmap_offset
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_prop_blob
results: parsing output: 14/ for test: dmabuf_sync_file
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_chamelium_color
results: parsing output: 21/ for test: intel_hwmon
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gen9_exec_parse
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_whisper
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_atomic
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_content_protection
results: parsing output: 33/ for test: gem_ctx_engines
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_rotation_crc
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: i915_power
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: i915_pm_freq_api
results: parsing output: 43/ for test: gem_exec_await
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_color
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: gem_workarounds
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_ctx_param
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_exec_flush
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_pxp
results: parsing output: 59/ for test: i915_hangman
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: prime_mmap_coherency
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_dither
results: parsing output: 64/ for test: gem_vm_create
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_eio
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: prime_vgem
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: gem_exec_gttfill
results: parsing output: 75/ for test: kms_plane_alpha_blend
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: vgem_basic
results: parsing output: 81/ for test: kms_pm_dc
results: parsing output: 82/ for test: kms_writeback
results: parsing output: 83/ for test: kms_fence_pin_leak
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_lease
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: kms_pipe_crc_basic
results: parsing output: 90/ for test: gem_unref_active_buffers
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: kms_busy
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: gem_tiled_fence_blits
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: gem_partial_pwrite_pread
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_vblank
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: gem_eio
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: prime_vgem
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_setmode
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: kms_busy
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: gem_ctx_persistence
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: gem_softpin
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: prime_vgem
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_flip
Done.