[115.008193] Initializing watchdogs
[115.008337]   /dev/watchdog0
[115.031117] [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)
[115.039180] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[115.043170] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[115.046023] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[115.546653] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[117.133215] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SUCCESS (1.587s)
[117.277266] [002/133] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[117.765016] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[117.765982] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[117.854329] [003/133] (957s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[118.355349] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[119.572238] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.216s)
[119.818545] [004/133] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[120.311142] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[120.312570] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[120.418897] [005/133] (955s left) gem_exec_balancer (noheartbeat)
[120.484348] Subtest noheartbeat: SKIP (0.000s)
[120.566643] [006/133] (955s left) syncobj_wait (multi-wait-submitted-signaled)
[120.625495] Starting subtest: multi-wait-submitted-signaled
[120.626177] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[120.720400] [007/133] (955s left) gen7_exec_parse (batch-without-end)
[120.778971] Subtest batch-without-end: SKIP (0.000s)
[120.827819] [008/133] (955s left) gem_pread (exhaustion)
[120.886601] Starting subtest: exhaustion
[126.447736] Subtest exhaustion: SUCCESS (5.560s)
[126.561258] [FACT gem_pread (exhaustion)] new: kernel.kmod_is_loaded.vgem: true
[126.563500] [009/133] (949s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[127.058191] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[128.868459] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.810s)
[129.084954] [010/133] (946s left) kms_cursor_crc (cursor-sliding-max-size)
[129.595454] Starting subtest: cursor-sliding-max-size
[129.598050] Subtest cursor-sliding-max-size: SKIP (0.000s)
[129.702209] [011/133] (946s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[130.184173] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[130.185215] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[130.286951] [012/133] (945s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[130.771357] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[130.843613] [013/133] (945s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[131.326395] Starting subtest: fbc-rgb565-draw-blt
[133.148647] Subtest fbc-rgb565-draw-blt: SUCCESS (1.821s)
[133.382869] [014/133] (942s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[133.873939] Starting subtest: plane-upscale-20x20-with-rotation
[133.874714] Starting dynamic subtest: pipe-A
[133.876748] Dynamic subtest pipe-A: SKIP (0.002s)
[133.887370] Starting dynamic subtest: pipe-B
[133.890212] Dynamic subtest pipe-B: SKIP (0.001s)
[133.891515] Subtest plane-upscale-20x20-with-rotation: SKIP (0.004s)
[133.963862] [015/133] (942s left) gem_exec_flush (basic-wb-ro-before-default)
[134.034797] Starting subtest: basic-wb-ro-before-default
[139.489407] Subtest basic-wb-ro-before-default: SUCCESS (5.454s)
[139.690888] [016/133] (936s left) gem_eio (in-flight-internal-immediate)
[139.760471] Starting subtest: in-flight-internal-immediate
[139.800937] Subtest in-flight-internal-immediate: SUCCESS (0.038s)
[140.319529] [017/133] (935s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[140.800894] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[140.802465] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[140.884886] [018/133] (935s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[141.372818] Starting subtest: cursor-rapid-movement-256x256
[141.391796] Starting dynamic subtest: pipe-A-VGA-1
[141.796586] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.404s)
[141.832674] Starting dynamic subtest: pipe-B-HDMI-A-1
[142.184871] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.361s)
[142.185548] Subtest cursor-rapid-movement-256x256: SUCCESS (0.812s)
[142.443888] [019/133] (933s left) kms_psr (psr2-sprite-plane-move)
[142.929272] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[142.987798] [020/133] (933s left) kms_invalid_mode (bad-vsync-start)
[143.474720] Starting subtest: bad-vsync-start
[143.475616] Starting dynamic subtest: pipe-A-VGA-1
[143.594463] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.120s)
[143.607754] Starting dynamic subtest: pipe-A-HDMI-A-1
[143.608855] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[143.619365] Starting dynamic subtest: pipe-B-VGA-1
[143.620060] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s)
[143.629778] Starting dynamic subtest: pipe-B-HDMI-A-1
[143.630467] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[143.631119] Subtest bad-vsync-start: SUCCESS (0.125s)
[143.853661] [021/133] (932s left) kms_cursor_crc (cursor-size-change)
[144.341283] Starting subtest: cursor-size-change
[144.342132] Starting dynamic subtest: pipe-A-VGA-1
[145.043641] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.702s)
[145.054942] Starting dynamic subtest: pipe-B-HDMI-A-1
[145.708575] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.663s)
[145.709030] Subtest cursor-size-change: SUCCESS (1.368s)
[145.983238] [022/133] (930s left) kms_addfb_basic (legacy-format)
[146.041351] Starting subtest: legacy-format
[146.107965] Subtest legacy-format: SUCCESS (0.064s)
[146.611245] [023/133] (929s left) gem_exec_schedule (promotion)
[146.683826] Subtest promotion: SKIP (0.000s)
[146.877469] [024/133] (929s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[147.344796] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[147.345967] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[147.443376] [025/133] (929s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[148.014625] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[148.242123] [026/133] (928s left) gem_exec_schedule (fairslice-all)
[148.306907] Subtest fairslice-all: SKIP (0.000s)
[148.504436] [027/133] (928s left) kms_lease (implicit-plane-lease)
[148.969657] Starting subtest: implicit-plane-lease
[148.972113] Subtest implicit-plane-lease: SUCCESS (0.003s)
[149.060156] [028/133] (927s left) kms_cursor_crc (cursor-alpha-opaque)
[149.519683] Starting subtest: cursor-alpha-opaque
[149.521728] Starting dynamic subtest: pipe-A-VGA-1
[149.985918] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.465s)
[149.997743] Starting dynamic subtest: pipe-B-HDMI-A-1
[150.414804] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.427s)
[150.415470] Subtest cursor-alpha-opaque: SUCCESS (0.895s)
[150.682682] [029/133] (926s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[150.740793] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[150.798832] [030/133] (926s left) syncobj_timeline (reset-signaled)
[150.853975] Starting subtest: reset-signaled
[150.855623] Subtest reset-signaled: SUCCESS (0.001s)
[150.949119] [031/133] (925s left) gem_exec_reloc (basic-cpu-active)
[151.011567] Starting subtest: basic-cpu-active
[151.121728] Subtest basic-cpu-active: SUCCESS (0.110s)
[151.632340] [032/133] (925s left) gem_exec_parallel (fds)
[151.701100] Starting subtest: fds
[151.701880] Starting dynamic subtest: rcs0
[153.607684] Dynamic subtest rcs0: SUCCESS (1.906s)
[153.619560] Starting dynamic subtest: bcs0
[155.267174] Dynamic subtest bcs0: SUCCESS (1.658s)
[155.268588] Subtest fds: SUCCESS (3.567s)
[155.493310] [033/133] (921s left) kms_vblank (wait-busy)
[155.976329] Starting subtest: wait-busy
[155.977516] Starting dynamic subtest: pipe-A-VGA-1
[158.442797] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.466s)
[158.453921] Starting dynamic subtest: pipe-A-HDMI-A-1
[160.890568] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.446s)
[160.901633] Starting dynamic subtest: pipe-B-VGA-1
[163.247295] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.355s)
[163.257858] Starting dynamic subtest: pipe-B-HDMI-A-1
[165.674333] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.425s)
[165.674927] Subtest wait-busy: SUCCESS (9.699s)
[165.929400] [034/133] (911s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[165.985599] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[166.051053] [035/133] (911s left) kms_sequence (queue-busy)
[166.529894] Starting subtest: queue-busy
[166.530638] Starting dynamic subtest: pipe-A-VGA-1
[169.039661] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.509s)
[169.051604] Starting dynamic subtest: pipe-A-HDMI-A-1
[171.504471] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.464s)
[171.516347] Starting dynamic subtest: pipe-B-VGA-1
[173.876165] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.364s)
[173.888393] Starting dynamic subtest: pipe-B-HDMI-A-1
[176.313885] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.442s)
[176.314597] Subtest queue-busy: SUCCESS (9.786s)
[176.563677] [036/133] (900s left) gem_exec_whisper (basic-fds-forked-all)
[176.634406] Starting subtest: basic-fds-forked-all
[180.218220] Subtest basic-fds-forked-all: SUCCESS (3.583s)
[180.422157] [037/133] (896s left) kms_cursor_legacy (torture-bo)
[180.897674] Starting subtest: torture-bo
[180.898459] Starting dynamic subtest: pipe-A
[186.452249] Dynamic subtest pipe-A: SUCCESS (5.553s)
[186.464979] Starting dynamic subtest: pipe-B
[192.045277] Dynamic subtest pipe-B: SUCCESS (5.590s)
[192.061163] Starting dynamic subtest: all-pipes
[198.316056] Dynamic subtest all-pipes: SUCCESS (6.268s)
[198.317048] Subtest torture-bo: SUCCESS (17.418s)
[198.415573] [038/133] (878s left) perf_pmu (most-busy-idle-check-all)
[198.474566] Starting subtest: most-busy-idle-check-all
[198.475379] Starting dynamic subtest: rcs0
[199.091992] Dynamic subtest rcs0: SUCCESS (0.617s)
[199.106149] Starting dynamic subtest: bcs0
[199.712163] Dynamic subtest bcs0: SUCCESS (0.618s)
[199.725759] Starting dynamic subtest: vcs0
[200.334476] Dynamic subtest vcs0: SUCCESS (0.620s)
[200.337363] Subtest most-busy-idle-check-all: SUCCESS (1.861s)
[200.429912] [039/133] (876s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[200.912202] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[200.913346] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[201.034404] [040/133] (876s left) gem_exec_fence (basic-wait)
[201.211844] Subtest basic-wait: SKIP (0.000s)
[201.614411] [041/133] (875s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[201.674350] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[201.740389] [042/133] (875s left) gem_lmem_swapping (verify-ccs)
[201.797592] Subtest verify-ccs: SKIP (0.000s)
[201.860372] [043/133] (875s left) sw_sync (timeline_closed_signaled)
[201.917213] Starting subtest: timeline_closed_signaled
[201.917871] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[201.997487] [044/133] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[202.475962] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[202.477255] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[202.591173] [045/133] (875s left) kms_prop_blob (invalid-set-prop-any)
[202.647011] Starting subtest: invalid-set-prop-any
[202.647578] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[202.739562] [046/133] (874s left) kms_flip (2x-flip-vs-expired-vblank)
[203.214400] Starting subtest: 2x-flip-vs-expired-vblank
[203.216094] Starting dynamic subtest: AB-VGA1-HDMI-A1
[233.613297] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.396s)
[233.615736] Subtest 2x-flip-vs-expired-vblank: SUCCESS (30.400s)
[233.868316] [047/133] (843s left) gem_lmem_swapping (parallel-random-engines)
[233.926632] Subtest parallel-random-engines: SKIP (0.000s)
[233.990296] [048/133] (843s left) kms_flip (plain-flip-fb-recreate-interruptible)
[234.473333] Starting subtest: plain-flip-fb-recreate-interruptible
[234.474942] Starting dynamic subtest: A-VGA1
[242.541999] Dynamic subtest A-VGA1: SUCCESS (8.066s)
[242.556204] Starting dynamic subtest: B-VGA1
[250.516077] Dynamic subtest B-VGA1: SUCCESS (7.971s)
[250.529924] Starting dynamic subtest: A-HDMI-A1
[258.507177] Dynamic subtest A-HDMI-A1: SUCCESS (7.988s)
[258.521027] Starting dynamic subtest: B-HDMI-A1
[266.542781] Dynamic subtest B-HDMI-A1: SUCCESS (8.032s)
[266.544974] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.068s)
[266.714753] [049/133] (811s left) api_intel_bb (object-reloc-keep-cache)
[266.774520] Starting subtest: object-reloc-keep-cache
[266.777723] Subtest object-reloc-keep-cache: SUCCESS (0.004s)
[266.899185] [050/133] (811s left) kms_pm_dc (dc5-dpms)
[278.002483] Subtest dc5-dpms: SKIP (0.000s)
[278.062317] [051/133] (799s left) kms_plane_cursor (overlay)
[278.535695] Starting subtest: overlay
[278.537115] Starting dynamic subtest: pipe-A-VGA-1-size-64
[281.309859] Dynamic subtest pipe-A-VGA-1-size-64: SUCCESS (2.773s)
[281.373685] Starting dynamic subtest: pipe-A-VGA-1-size-128
[284.067912] Dynamic subtest pipe-A-VGA-1-size-128: SUCCESS (2.707s)
[284.134916] Starting dynamic subtest: pipe-A-VGA-1-size-256
[286.825858] Dynamic subtest pipe-A-VGA-1-size-256: SUCCESS (2.707s)
[286.926783] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[289.708725] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.793s)
[289.772225] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[292.469686] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.710s)
[292.531949] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[295.230486] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.710s)
[295.364633] Subtest overlay: SUCCESS (16.831s)
[295.608534] [052/133] (782s left) gem_exec_reloc (basic-wc-active)
[295.667999] Starting subtest: basic-wc-active
[295.778825] Subtest basic-wc-active: SUCCESS (0.110s)
[296.291106] [053/133] (781s left) kms_psr (pr-primary-mmap-gtt)
[296.771364] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[296.836092] [054/133] (781s left) gem_exec_schedule (lateslice)
[296.906964] Subtest lateslice: SKIP (0.000s)
[297.108697] [055/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[297.587623] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[297.589083] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[297.693841] [056/133] (780s left) kms_color (ctm-max)
[298.171716] Starting subtest: ctm-max
[298.172424] Starting dynamic subtest: pipe-A-VGA-1
[298.703596] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.531s)
[298.715497] Starting dynamic subtest: pipe-A-HDMI-A-1
[299.199872] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.495s)
[299.211579] Starting dynamic subtest: pipe-B-VGA-1
[299.610676] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.409s)
[299.623205] Starting dynamic subtest: pipe-B-HDMI-A-1
[300.110167] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.495s)
[300.112131] Subtest ctm-max: SUCCESS (1.937s)
[300.370746] [057/133] (777s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[300.431148] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[300.432867] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[300.531911] [058/133] (777s left) gem_eio (reset-stress)
[300.601500] Starting subtest: reset-stress
[300.602022] Starting dynamic subtest: render
[302.204511] Dynamic subtest render: SUCCESS (1.602s)
[302.217398] Starting dynamic subtest: bsd
[304.016741] Dynamic subtest bsd: FAIL (1.783s)
[304.029623] Starting dynamic subtest: blt
[305.596934] Dynamic subtest blt: SUCCESS (1.606s)
[305.597788] Subtest reset-stress: FAIL (4.997s)
[306.140225] [059/133] (772s left) kms_addfb_basic (bad-pitch-256)
[306.195795] Starting subtest: bad-pitch-256
[306.196386] Subtest bad-pitch-256: SUCCESS (0.000s)
[306.726826] [060/133] (771s left) kms_addfb_basic (bo-too-small)
[307.205901] Starting subtest: bo-too-small
[307.206918] Subtest bo-too-small: SUCCESS (0.000s)
[307.308781] [061/133] (771s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[307.791293] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[307.792529] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[307.905246] [062/133] (770s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[308.376992] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[308.378233] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[308.471994] [063/133] (770s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[308.950407] Starting subtest: disable-crc-after-crtc
[308.950896] Starting dynamic subtest: pipe-A-VGA-1
[309.494736] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.542s)
[309.509319] Starting dynamic subtest: pipe-B-HDMI-A-1
[310.026632] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.529s)
[310.027319] Subtest disable-crc-after-crtc: SUCCESS (1.077s)
[310.291465] [064/133] (768s left) kms_chamelium_frames (hdmi-crc-multiple)
[310.893971] Subtest hdmi-crc-multiple: SKIP (0.000s)
[311.110383] [065/133] (767s left) perf (oa-formats)
[311.249522] Subtest oa-formats: SKIP (0.000s)
[311.308883] [066/133] (767s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[311.779925] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.000s)
[311.840236] [067/133] (766s left) syncobj_eventfd (timeline-wait)
[311.900709] Starting subtest: timeline-wait
[311.912640] Subtest timeline-wait: SUCCESS (0.011s)
[312.011697] [068/133] (766s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[312.065978] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[312.121434] [069/133] (766s left) gem_mmap_offset (isolation)
[312.178198] Starting subtest: isolation
[312.184932] Subtest isolation: SUCCESS (0.007s)
[312.295889] [070/133] (766s left) kms_chamelium_color (ctm-negative)
[312.772532] Subtest ctm-negative: SKIP (0.000s)
[312.840635] [071/133] (766s left) kms_hdmi_inject (inject-audio)
[313.012675] Starting subtest: inject-audio
[313.013704] Subtest inject-audio: SKIP (0.000s)
[313.270240] [072/133] (765s left) i915_drm_fdinfo (virtual-idle)
[313.326691] Subtest virtual-idle: SKIP (0.000s)
[313.383034] [073/133] (765s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[313.867860] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[313.868977] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[313.984733] [074/133] (765s left) gem_set_tiling_vs_gtt
[314.218173] [075/133] (764s left) api_intel_allocator (reopen-fork)
[314.276290] Starting subtest: reopen-fork
[317.729379] Subtest reopen-fork: SUCCESS (3.453s)
[317.833690] [076/133] (761s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[317.890715] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SKIP (0.000s)
[317.962722] [077/133] (761s left) gem_eio (wait-1us)
[318.029344] Starting subtest: wait-1us
[318.060975] Subtest wait-1us: SUCCESS (0.031s)
[318.590660] [078/133] (760s left) gem_exec_create (forked)
[318.657403] Starting subtest: forked
[318.658764] Starting dynamic subtest: smem
[338.768762] Dynamic subtest smem: SUCCESS (20.110s)
[338.772873] Subtest forked: SUCCESS (20.113s)
[338.980381] [079/133] (740s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[339.040401] Starting subtest: etime-single-wait-all-for-submit-submitted
[339.142603] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[339.244614] [080/133] (740s left) gem_exec_params (rel-constants-invalid-ring)
[339.306400] Starting subtest: rel-constants-invalid-ring
[339.307210] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[339.417918] [081/133] (740s left) kms_flip (plain-flip-interruptible)
[339.899339] Starting subtest: plain-flip-interruptible
[339.901258] Starting dynamic subtest: A-VGA1
[340.646518] Dynamic subtest A-VGA1: SUCCESS (0.745s)
[340.661771] Starting dynamic subtest: B-VGA1
[341.331609] Dynamic subtest B-VGA1: SUCCESS (0.681s)
[341.346368] Starting dynamic subtest: A-HDMI-A1
[342.070050] Dynamic subtest A-HDMI-A1: SUCCESS (0.735s)
[342.084257] Starting dynamic subtest: B-HDMI-A1
[342.838150] Dynamic subtest B-HDMI-A1: SUCCESS (0.765s)
[342.841464] Subtest plain-flip-interruptible: SUCCESS (2.941s)
[343.028724] [082/133] (736s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[343.508496] Starting subtest: short-flip-before-cursor-atomic-transitions
[344.561034] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.049s)
[344.824778] [083/133] (734s left) gem_userptr_blits (forbidden-operations)
[344.883691] Starting subtest: forbidden-operations
[344.885466] Subtest forbidden-operations: SUCCESS (0.001s)
[345.023468] [084/133] (734s left) gem_ctx_engines (invalid-engines)
[345.089244] Starting subtest: invalid-engines
[345.093832] Subtest invalid-engines: SUCCESS (0.006s)
[345.321719] [085/133] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[345.801178] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[345.802548] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[345.904460] [086/133] (733s left) kms_pm_rpm (i2c)
[357.666368] Subtest i2c: SKIP (0.000s)
[357.734437] [087/133] (722s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[358.220114] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[358.221381] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[358.327817] [088/133] (721s left) kms_atomic (plane-overlay-legacy)
[358.803891] Starting subtest: plane-overlay-legacy
[358.805719] Starting dynamic subtest: pipe-A-VGA-1
[359.100518] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.294s)
[359.100940] Subtest plane-overlay-legacy: SUCCESS (0.297s)
[359.381729] [089/133] (720s left) syncobj_timeline (wait-all-for-submit-complex)
[359.440201] Starting subtest: wait-all-for-submit-complex
[359.657219] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[359.759610] [090/133] (720s left) gem_request_retire (retire-vma-not-inactive)
[359.821219] Starting subtest: retire-vma-not-inactive
[359.826934] Subtest retire-vma-not-inactive: SUCCESS (0.005s)
[359.948868] [091/133] (720s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[360.012773] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[360.014842] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[360.212649] [092/133] (719s left) gem_pxp (reject-modify-context-protection-on)
[362.781358] Starting subtest: reject-modify-context-protection-on
[362.783010] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[362.874731] [093/133] (717s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[362.932399] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[362.997621] [094/133] (717s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[363.053219] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[363.120438] [095/133] (717s left) gem_exec_fence (syncobj-export)
[363.328414] Starting subtest: syncobj-export
[363.330856] Subtest syncobj-export: SUCCESS (0.003s)
[363.672596] [096/133] (716s left) dumb_buffer (map-invalid-size)
[363.727787] Starting subtest: map-invalid-size
[363.728495] Subtest map-invalid-size: SUCCESS (0.000s)
[363.838381] [097/133] (716s left) kms_psr (fbc-psr-primary-render)
[364.316654] Subtest fbc-psr-primary-render: SKIP (0.000s)
[364.383611] [098/133] (715s left) fbdev (eof)
[364.444132] Starting subtest: eof
[364.444844] Subtest eof: SUCCESS (0.000s)
[364.564072] [099/133] (715s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[365.046805] Starting subtest: fbc-rgb101010-draw-pwrite
[367.717750] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.671s)
[367.939517] [100/133] (712s left) kms_vrr (negative-basic)
[368.417983] Starting subtest: negative-basic
[368.420266] Subtest negative-basic: SKIP (0.000s)
[368.538199] [101/133] (711s left) gem_exec_schedule (smoketest-all)
[368.609859] Subtest smoketest-all: SKIP (0.000s)
[368.805269] [102/133] (711s left) kms_big_fb (y-tiled-addfb-size-overflow)
[369.293622] Starting subtest: y-tiled-addfb-size-overflow
[369.294707] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[369.407730] [103/133] (711s left) vgem_basic (bad-fence)
[369.478267] Starting subtest: bad-fence
[369.479268] Subtest bad-fence: SUCCESS (0.000s)
[369.555832] [104/133] (711s left) gem_ctx_persistence (engines-hostile)
[369.617829] Subtest engines-hostile: SKIP (0.000s)
[369.685646] [105/133] (711s left) prime_mmap (test_forked)
[369.741877] Starting subtest: test_forked
[369.743533] Starting dynamic subtest: test_forked-smem
[369.761423] Dynamic subtest test_forked-smem: SUCCESS (0.018s)
[369.764748] Subtest test_forked: SUCCESS (0.021s)
[369.873077] [106/133] (710s left) gem_spin_batch (resubmit-all)
[369.940764] Starting subtest: resubmit-all
[369.941496] Starting dynamic subtest: rcs0
[369.943642] Dynamic subtest rcs0: SUCCESS (0.002s)
[369.959619] Starting dynamic subtest: bcs0
[369.960321] Dynamic subtest bcs0: SUCCESS (0.001s)
[369.972012] Starting dynamic subtest: vcs0
[369.972680] Dynamic subtest vcs0: SUCCESS (0.001s)
[369.973218] Subtest resubmit-all: SUCCESS (0.009s)
[370.156912] [107/133] (710s left) i915_drm_fdinfo (busy-idle)
[370.215241] Subtest busy-idle: SKIP (0.000s)
[370.279615] [108/133] (710s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[370.766342] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[370.767569] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[370.882608] [109/133] (710s left) perf (non-sampling-read-error)
[371.015537] Subtest non-sampling-read-error: SKIP (0.000s)
[371.079843] [110/133] (709s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[371.557276] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[371.558455] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[371.669461] [111/133] (709s left) kms_force_connector_basic (force-load-detect)
[371.739193] Starting subtest: force-load-detect
[371.997962] Subtest force-load-detect: SUCCESS (0.259s)
[372.794788] [112/133] (708s left) kms_content_protection (lic-type-0-hdcp14)
[373.285492] Starting subtest: lic-type-0-hdcp14
[373.286863] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[373.402109] [113/133] (707s left) gem_ctx_shared (q-in-order)
[373.463613] Subtest Q-in-order: SKIP (0.000s)
[373.568158] [114/133] (707s left) i915_suspend (basic-s3-without-i915)
[373.624822] Starting subtest: basic-s3-without-i915
[392.868482] Subtest basic-s3-without-i915: SUCCESS (4.084s)
[397.936659] [115/133] (688s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[398.430255] Starting subtest: yf-tiled-32bpp-rotate-270
[398.431387] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[398.544290] [116/133] (687s left) gem_ctx_persistence (legacy-engines-persistence)
[398.614204] Subtest legacy-engines-persistence: SKIP (0.000s)
[398.679170] [117/133] (687s left) kms_rotation_crc (primary-rotation-90)
[399.155869] Starting subtest: primary-rotation-90
[399.157075] Subtest primary-rotation-90: SKIP (0.001s)
[399.249328] [118/133] (687s left) syncobj_wait (multi-wait-all-signaled)
[399.306344] Starting subtest: multi-wait-all-signaled
[399.306972] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[399.400271] [119/133] (687s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[399.884735] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[401.752335] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (1.868s)
[401.904745] [120/133] (684s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[402.379456] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[402.452968] [121/133] (684s left) kms_force_connector_basic (prune-stale-modes)
[402.527045] Starting subtest: prune-stale-modes
[402.545777] Subtest prune-stale-modes: SUCCESS (0.019s)
[402.957366] [122/133] (683s left) perf (stress-open-close)
[403.079054] Subtest stress-open-close: SKIP (0.000s)
[403.146228] [123/133] (683s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[403.203742] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[403.204391] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[403.327353] [124/133] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[403.821008] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[403.822035] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[403.946292] [125/133] (682s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[404.426859] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[404.494826] [126/133] (682s left) sw_sync (sync_merge_same)
[404.551777] Starting subtest: sync_merge_same
[404.552484] Subtest sync_merge_same: SUCCESS (0.000s)
[404.630846] [127/133] (682s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[405.118272] Starting subtest: 4-tiled-32bpp-rotate-0
[405.119445] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[405.231837] [128/133] (681s left) i915_pm_rc6_residency (media-rc6-accuracy)
[405.289044] Starting subtest: media-rc6-accuracy
[405.290282] Subtest media-rc6-accuracy: SKIP (0.000s)
[405.382240] [129/133] (681s left) kms_psr (psr-primary-render)
[405.858280] Subtest psr-primary-render: SKIP (0.000s)
[405.924368] [130/133] (681s left) kms_getfb (getfb2-handle-closed)
[406.402193] Starting subtest: getfb2-handle-closed
[406.402739] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[406.520920] [131/133] (680s left) gem_wait (write-busy)
[406.599414] Starting subtest: write-busy
[406.600251] Starting dynamic subtest: all-engines
[407.122225] Dynamic subtest all-engines: SUCCESS (0.524s)
[407.138096] Starting dynamic subtest: rcs0
[407.641183] Dynamic subtest rcs0: SUCCESS (0.516s)
[407.657524] Starting dynamic subtest: bcs0
[408.165088] Dynamic subtest bcs0: SUCCESS (0.521s)
[408.182390] Starting dynamic subtest: vcs0
[408.682985] Dynamic subtest vcs0: SUCCESS (0.515s)
[408.686866] Subtest write-busy: SUCCESS (2.088s)
[408.908898] [132/133] (678s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[409.383903] Starting subtest: cursorB-vs-flipB-legacy
[420.351381] Subtest cursorB-vs-flipB-legacy: SUCCESS (10.965s)
[420.612156] [133/133] (666s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[421.084846] Starting subtest: primary-x-tiled-reflect-x-0
[421.085904] Subtest primary-x-tiled-reflect-x-0: SKIP (0.001s)
[421.211918] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: gen7_exec_parse
results: parsing output: 7/ for test: gem_pread
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: gem_eio
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_invalid_mode
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: gem_exec_parallel
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_sequence
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_prop_blob
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_pm_dc
results: parsing output: 50/ for test: kms_plane_cursor
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_color
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_chamelium_frames
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_dsc
results: parsing output: 66/ for test: syncobj_eventfd
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_mmap_offset
results: parsing output: 69/ for test: kms_chamelium_color
results: parsing output: 70/ for test: kms_hdmi_inject
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_set_tiling_vs_gtt
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_exec_create
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_ctx_engines
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_atomic
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_request_retire
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: gem_pxp
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: dumb_buffer
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: fbdev
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_vrr
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: prime_mmap
results: parsing output: 105/ for test: gem_spin_batch
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_force_connector_basic
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_force_connector_basic
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: i915_pm_rc6_residency
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_getfb
results: parsing output: 130/ for test: gem_wait
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_rotation_crc
Done.