[76.363836] Initializing watchdogs
[76.364043]   /dev/watchdog0
[76.383279] [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)
[76.390913] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[76.394662] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[76.398365] [001/133] (960s left) perf (global-sseu-config-invalid)
[76.555248] Subtest global-sseu-config-invalid: SKIP (0.000s)
[76.602379] [002/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[77.110459] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[77.111902] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[77.721236] [003/133] (959s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[78.219874] Starting subtest: fb-8bpc-vs-panel-8bpc
[78.221821] Starting dynamic subtest: pipe-A-HDMI-A-1
[78.313458] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.089s)
[78.316766] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.091s)
[79.019720] [004/133] (958s left) kms_vblank (query-busy)
[79.518809] Starting subtest: query-busy
[79.521217] Starting dynamic subtest: pipe-A-HDMI-A-1
[81.922846] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.403s)
[81.932363] Starting dynamic subtest: pipe-B-HDMI-A-1
[84.361721] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.437s)
[84.362552] Subtest query-busy: SUCCESS (4.843s)
[85.074105] [005/133] (951s left) gem_exec_fence (syncobj-timeline-export)
[85.434681] Starting subtest: syncobj-timeline-export
[85.437637] Subtest syncobj-timeline-export: SUCCESS (0.004s)
[85.695865] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[85.698501] [006/133] (951s left) kms_vblank (wait-forked-hang)
[86.190970] Starting subtest: wait-forked-hang
[86.191914] Starting dynamic subtest: pipe-A-HDMI-A-1
[91.967875] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.777s)
[91.979841] Starting dynamic subtest: pipe-B-HDMI-A-1
[97.986728] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.017s)
[97.987409] Subtest wait-forked-hang: SUCCESS (11.798s)
[98.735904] [007/133] (938s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[98.801073] Starting subtest: invalid-bsd1-flag-on-blt
[98.801834] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[98.917310] [008/133] (938s left) gem_media_vme
[99.028397] [009/133] (938s left) kms_cursor_crc (cursor-random-64x64)
[99.542259] Starting subtest: cursor-random-64x64
[99.544139] Starting dynamic subtest: pipe-A-HDMI-A-1
[103.278836] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.733s)
[103.322929] Starting dynamic subtest: pipe-B-HDMI-A-1
[107.004256] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.690s)
[107.004922] Subtest cursor-random-64x64: SUCCESS (7.463s)
[107.723570] [010/133] (929s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[108.224693] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[108.226238] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[108.825168] [011/133] (928s left) kms_psr (psr2-cursor-render)
[109.327370] Subtest psr2-cursor-render: SKIP (0.000s)
[109.619427] [012/133] (927s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[110.117632] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[110.120450] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[110.721084] [013/133] (926s left) gem_set_tiling_vs_pwrite
[110.933445] [014/133] (926s left) gem_exec_balancer (parallel-keep-in-fence)
[110.991131] Subtest parallel-keep-in-fence: SKIP (0.000s)
[111.117564] [015/133] (926s left) gem_userptr_blits (create-destroy-sync)
[111.187835] Starting subtest: create-destroy-sync
[116.206647] Subtest create-destroy-sync: SUCCESS (5.018s)
[116.374899] [016/133] (921s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[116.431965] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[116.538088] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[116.659019] [017/133] (921s left) gem_mmap_gtt (basic-small-copy-xy)
[116.711017] Starting subtest: basic-small-copy-XY
[117.523031] Subtest basic-small-copy-XY: SUCCESS (0.812s)
[117.678686] [018/133] (920s left) gem_caching (read-writes)
[117.852499] Starting subtest: read-writes
[122.801169] Subtest read-writes: SUCCESS (4.950s)
[122.978054] [019/133] (914s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[123.053243] Starting subtest: multi-wait-all-for-submit-available-signaled
[123.054939] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[123.180048] [020/133] (914s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[123.689980] Starting subtest: plane-lut1d-pre-ctm3x4
[123.942925] Subtest plane-lut1d-pre-ctm3x4: SKIP (0.252s)
[124.657807] [021/133] (913s left) sysfs_heartbeat_interval (idempotent)
[124.720426] Starting subtest: idempotent
[124.722037] Starting dynamic subtest: vcs0
[124.723663] Dynamic subtest vcs0: SUCCESS (0.001s)
[124.733815] Starting dynamic subtest: bcs0
[124.734648] Dynamic subtest bcs0: SUCCESS (0.001s)
[124.745048] Starting dynamic subtest: rcs0
[124.746214] Dynamic subtest rcs0: SUCCESS (0.001s)
[124.747372] Subtest idempotent: SUCCESS (0.007s)
[124.858810] [022/133] (913s left) kms_atomic (atomic-invalid-params)
[125.358782] Starting subtest: atomic-invalid-params
[125.359746] Starting dynamic subtest: pipe-A-HDMI-A-1
[125.640355] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.281s)
[125.642239] Subtest atomic-invalid-params: SUCCESS (0.283s)
[126.377182] [023/133] (911s left) gem_pxp (hw-rejects-pxp-buffer)
[128.948993] Starting subtest: hw-rejects-pxp-buffer
[128.950128] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[129.101876] [024/133] (908s left) perf (non-system-wide-paranoid)
[129.275016] Subtest non-system-wide-paranoid: SKIP (0.000s)
[129.323967] [025/133] (908s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[129.819941] Starting subtest: psr-rgb565-draw-mmap-gtt
[129.821205] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[130.446540] [026/133] (907s left) i915_query (hwconfig_table)
[130.505013] Starting subtest: hwconfig_table
[130.506641] Subtest hwconfig_table: SKIP (0.000s)
[130.628291] [027/133] (907s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[131.127970] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[132.943290] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (1.816s)
[133.588558] [028/133] (904s left) gem_ctx_param (invalid-set-ringsize)
[133.651809] Starting subtest: invalid-set-ringsize
[133.652669] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[133.771822] [029/133] (904s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[134.274970] Starting subtest: 4-tiled-addfb-size-offset-overflow
[134.276568] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[134.888342] [030/133] (903s left) kms_dsc (dsc-fractional-bpp)
[135.387725] Subtest dsc-fractional-bpp: SKIP (0.000s)
[135.694142] [031/133] (902s left) drm_buddy (drm_buddy)
[135.750782] Starting subtest: drm_buddy
[135.752864] Subtest drm_buddy: SKIP (0.001s)
[135.869358] [032/133] (902s left) kms_chamelium_hpd (common-hpd-after-suspend)
[136.434351] Subtest common-hpd-after-suspend: SKIP (0.000s)
[136.836956] [033/133] (901s left) gem_exec_schedule (u-submit-golden-slice)
[136.908387] Subtest u-submit-golden-slice: SKIP (0.000s)
[137.144686] [034/133] (901s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[137.199618] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[137.254122] [035/133] (901s left) syncobj_wait (single-wait-signaled)
[137.310645] Starting subtest: single-wait-signaled
[137.311627] Subtest single-wait-signaled: SUCCESS (0.000s)
[137.443480] [036/133] (901s left) kms_pm_backlight (fade-with-dpms)
[137.936525] Subtest fade-with-dpms: SKIP (0.000s)
[138.235109] [037/133] (900s left) kms_rmfb (close-fd)
[138.732967] Starting subtest: close-fd
[138.733772] Starting dynamic subtest: pipe-A-HDMI-A-1
[138.846615] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.114s)
[138.858080] Starting dynamic subtest: pipe-B-HDMI-A-1
[139.119776] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.272s)
[139.120558] Subtest close-fd: SUCCESS (0.390s)
[139.867808] [038/133] (898s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[140.368553] Starting subtest: read-crc-frame-sequence
[140.371064] Starting dynamic subtest: pipe-A-HDMI-A-1
[140.864423] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.494s)
[140.875883] Starting dynamic subtest: pipe-B-HDMI-A-1
[141.377043] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.511s)
[141.377857] Subtest read-crc-frame-sequence: SUCCESS (1.009s)
[142.096095] [039/133] (896s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[142.157524] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[142.218423] [040/133] (896s left) syncobj_wait (wait-all-interrupted)
[142.278443] Starting subtest: wait-all-interrupted
[142.386171] Subtest wait-all-interrupted: SUCCESS (0.107s)
[142.510352] [041/133] (896s left) kms_fbcon_fbt (psr-suspend)
[142.572909] Starting subtest: psr-suspend
[142.574773] Subtest psr-suspend: SKIP (0.000s)
[142.707565] [042/133] (896s left) gem_render_copy (y-tiled)
[142.771882] Starting subtest: y-tiled
[142.772694] Starting dynamic subtest: smem
[142.837178] Dynamic subtest smem: SUCCESS (0.065s)
[142.838023] Subtest y-tiled: SUCCESS (0.066s)
[143.075141] [043/133] (895s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[143.563465] Starting subtest: cursorA-vs-flipA-legacy
[154.465156] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.903s)
[155.188352] [044/133] (883s left) syncobj_wait (single-wait-for-submit-signaled)
[155.252091] Starting subtest: single-wait-for-submit-signaled
[155.252868] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[155.369228] [045/133] (883s left) kms_psr (fbc-pr-sprite-plane-move)
[155.859410] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[156.161186] [046/133] (882s left) gem_mmap_offset (partial-mmap)
[156.223518] Starting subtest: partial-mmap
[156.224418] Starting dynamic subtest: smem0
[156.228701] Dynamic subtest smem0: SUCCESS (0.005s)
[156.229431] Subtest partial-mmap: SUCCESS (0.006s)
[156.402224] [047/133] (882s left) gem_spin_batch (resubmit)
[156.465531] Starting subtest: resubmit
[156.466341] Starting dynamic subtest: rcs0
[156.468698] Dynamic subtest rcs0: SUCCESS (0.002s)
[156.479910] Starting dynamic subtest: bcs0
[156.480671] Dynamic subtest bcs0: SUCCESS (0.001s)
[156.490685] Starting dynamic subtest: vcs0
[156.491515] Dynamic subtest vcs0: SUCCESS (0.001s)
[156.492228] Subtest resubmit: SUCCESS (0.007s)
[156.689209] [048/133] (882s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[157.184347] Starting subtest: fbcpsr-rgb565-draw-render
[157.187108] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[157.784697] [049/133] (881s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[158.284385] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[158.285866] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[158.907175] [050/133] (880s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[158.966258] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[159.023982] [051/133] (880s left) kms_setmode (invalid-clone-single-crtc-stealing)
[159.083946] Starting subtest: invalid-clone-single-crtc-stealing
[159.085843] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[159.217360] [052/133] (880s left) kms_invalid_mode (bad-vtotal)
[159.705670] Starting subtest: bad-vtotal
[159.709114] Starting dynamic subtest: pipe-A-HDMI-A-1
[159.780498] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.073s)
[159.793770] Starting dynamic subtest: pipe-B-HDMI-A-1
[159.794549] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[159.795333] Subtest bad-vtotal: SUCCESS (0.077s)
[160.264429] [053/133] (879s left) gem_mmap (short-mmap)
[160.320801] Starting subtest: short-mmap
[160.321518] Subtest short-mmap: SUCCESS (0.000s)
[160.464601] [054/133] (879s left) gem_close (many-handles-one-vma)
[160.521212] Starting subtest: many-handles-one-vma
[160.557580] Subtest many-handles-one-vma: SUCCESS (0.036s)
[160.697533] [055/133] (878s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[160.754256] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[160.756626] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[160.879757] [056/133] (878s left) gem_exec_fence (syncobj-timeline-wait)
[161.194392] Starting subtest: syncobj-timeline-wait
[161.230753] Subtest syncobj-timeline-wait: SUCCESS (0.038s)
[161.493516] [057/133] (878s left) api_intel_allocator (default-alignment)
[161.549744] Starting subtest: default-alignment
[161.554309] Subtest default-alignment: SUCCESS (0.005s)
[161.712137] [058/133] (878s left) kms_psr (fbc-pr-basic)
[162.196923] Subtest fbc-pr-basic: SKIP (0.000s)
[162.517291] [059/133] (877s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[162.573029] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[162.635484] [060/133] (877s left) kms_content_protection (dp-mst-lic-type-0)
[163.140347] Starting subtest: dp-mst-lic-type-0
[163.141899] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[163.739944] [061/133] (876s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[164.235722] Starting subtest: cursorA-vs-flipB-legacy
[164.237912] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[164.838210] [062/133] (875s left) gem_eio (suspend)
[164.907291] Starting subtest: suspend
[176.190656] Subtest suspend: SUCCESS (11.105s)
[183.241459] [063/133] (862s left) gem_exec_schedule (implicit-write-read)
[183.332323] Starting subtest: implicit-write-read
[183.333088] Starting dynamic subtest: rcs0
[183.364073] Dynamic subtest rcs0: SUCCESS (0.031s)
[183.378991] Starting dynamic subtest: bcs0
[183.393638] Dynamic subtest bcs0: SUCCESS (0.028s)
[183.394448] Subtest implicit-write-read: SUCCESS (0.062s)
[183.676407] [064/133] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[184.167747] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[184.169168] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[184.768290] [065/133] (861s left) api_intel_bb (reset-flags)
[184.828430] Starting subtest: reset-flags
[184.834204] Subtest reset-flags: SUCCESS (0.006s)
[185.015772] [066/133] (861s left) i915_drm_fdinfo (virtual-idle)
[185.071368] Subtest virtual-idle: SKIP (0.000s)
[185.127891] [067/133] (861s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[185.182454] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[185.183182] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[185.317059] [068/133] (860s left) gem_exec_reloc (basic-write-cpu)
[185.378038] Starting subtest: basic-write-cpu
[185.380411] Subtest basic-write-cpu: SUCCESS (0.003s)
[186.407610] [069/133] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[186.909178] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[189.140546] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.231s)
[189.775073] [070/133] (856s left) gem_busy (busy)
[189.846799] Starting subtest: busy
[189.847588] Starting dynamic subtest: all-engines
[189.876099] Dynamic subtest all-engines: SUCCESS (0.028s)
[189.901413] Starting dynamic subtest: rcs0
[189.902608] Dynamic subtest rcs0: SUCCESS (0.017s)
[189.923622] Starting dynamic subtest: bcs0
[189.924990] Dynamic subtest bcs0: SUCCESS (0.014s)
[189.939887] Starting dynamic subtest: vcs0
[189.940895] Dynamic subtest vcs0: SUCCESS (0.016s)
[189.941844] Subtest busy: SUCCESS (0.082s)
[190.323533] [071/133] (856s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[190.811951] Starting subtest: cursor-vs-flip-toggle
[224.802072] Subtest cursor-vs-flip-toggle: SUCCESS (33.990s)
[225.508119] [072/133] (821s left) gen7_exec_parse (oacontrol-tracking)
[225.569698] Subtest oacontrol-tracking: SKIP (0.000s)
[225.634429] [073/133] (820s left) kms_chamelium_frames (hdmi-crc-multiple)
[226.209996] Subtest hdmi-crc-multiple: SKIP (0.000s)
[226.629089] [074/133] (819s left) i915_pm_rps (min-max-config-idle)
[226.693276] Starting subtest: min-max-config-idle
[226.890017] Subtest min-max-config-idle: SUCCESS (0.198s)
[227.050323] [075/133] (819s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[227.542487] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[227.543759] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[228.152791] [076/133] (818s left) kms_big_fb (linear-32bpp-rotate-270)
[228.648308] Starting subtest: linear-32bpp-rotate-270
[228.663689] Subtest linear-32bpp-rotate-270: SKIP (0.014s)
[229.280968] [077/133] (817s left) gem_mmap_wc (pf-nonblock)
[229.341718] Starting subtest: pf-nonblock
[229.342537] Subtest pf-nonblock: SUCCESS (0.001s)
[229.495171] [078/133] (817s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[229.556470] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.000s)
[229.624631] [079/133] (817s left) gem_exec_schedule (u-submit-early-slice)
[229.693388] Subtest u-submit-early-slice: SKIP (0.000s)
[229.951639] [080/133] (817s left) kms_lease (implicit-plane-lease)
[230.441959] Starting subtest: implicit-plane-lease
[230.444435] Subtest implicit-plane-lease: SUCCESS (0.002s)
[231.042925] [081/133] (815s left) perf_pmu (multi-client)
[231.106491] Starting subtest: multi-client
[231.107237] Starting dynamic subtest: rcs0
[232.127802] Dynamic subtest rcs0: SUCCESS (1.020s)
[232.146256] Starting dynamic subtest: bcs0
[233.159613] Dynamic subtest bcs0: SUCCESS (1.030s)
[233.185677] Starting dynamic subtest: vcs0
[234.686730] Dynamic subtest vcs0: SUCCESS (1.526s)
[234.687568] Subtest multi-client: SUCCESS (3.581s)
[234.835969] [082/133] (812s left) gem_wait (wait)
[234.905312] Starting subtest: wait
[234.906077] Starting dynamic subtest: all-engines
[235.935700] Dynamic subtest all-engines: SUCCESS (1.029s)
[235.952071] Starting dynamic subtest: rcs0
[236.953493] Dynamic subtest rcs0: SUCCESS (1.015s)
[236.968499] Starting dynamic subtest: bcs0
[237.984736] Dynamic subtest bcs0: SUCCESS (1.029s)
[238.001110] Starting dynamic subtest: vcs0
[239.007515] Dynamic subtest vcs0: SUCCESS (1.020s)
[239.011139] Subtest wait: SUCCESS (4.104s)
[239.260779] [083/133] (807s left) kms_busy (extended-pageflip-hang-newfb)
[239.749682] Starting subtest: extended-pageflip-hang-newfb
[239.750506] Starting dynamic subtest: pipe-A
[245.992860] Dynamic subtest pipe-A: SUCCESS (6.241s)
[246.007877] Starting dynamic subtest: pipe-B
[252.025442] Dynamic subtest pipe-B: SUCCESS (6.028s)
[252.026239] Subtest extended-pageflip-hang-newfb: SUCCESS (12.277s)
[252.747823] [084/133] (794s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[253.245370] Starting subtest: yf-tiled-8bpp-rotate-90
[253.246690] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[253.844298] [085/133] (793s left) kms_prime (basic-modeset-hybrid)
[254.351488] Subtest basic-modeset-hybrid: SKIP (0.000s)
[255.391536] [086/133] (791s left) gem_exec_balancer (bonded-dual)
[255.459395] Subtest bonded-dual: SKIP (0.000s)
[255.593723] [087/133] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[256.079432] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[256.080743] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[256.706139] [088/133] (790s left) prime_mmap (test_correct_cpu_write)
[256.762816] Starting subtest: test_correct_cpu_write
[256.763491] Starting dynamic subtest: test_correct_cpu_write-smem
[256.764304] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[256.764985] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[256.903240] [089/133] (790s left) gem_ctx_persistence (smoketest)
[256.960833] Subtest smoketest: SKIP (0.000s)
[257.033218] [090/133] (790s left) syncobj_wait (multi-wait-submitted)
[257.087365] Starting subtest: multi-wait-submitted
[257.194202] Subtest multi-wait-submitted: SUCCESS (0.106s)
[257.321709] [091/133] (790s left) syncobj_timeline (wait-all-complex)
[257.381111] Starting subtest: wait-all-complex
[257.596038] Subtest wait-all-complex: SUCCESS (0.215s)
[257.720718] [092/133] (789s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[258.217547] Starting subtest: y-tiled-16bpp-rotate-0
[258.219091] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[258.835316] [093/133] (788s left) sw_sync (sync_busy)
[258.891610] Starting subtest: sync_busy
[258.896924] Subtest sync_busy: SUCCESS (0.005s)
[259.017115] [094/133] (788s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[259.510392] Starting subtest: psr-rgb565-draw-pwrite
[259.513206] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[260.116527] [095/133] (787s left) kms_flip (basic-flip-vs-dpms)
[260.608946] Starting subtest: basic-flip-vs-dpms
[260.611108] Starting dynamic subtest: A-VGA1
[261.401339] Dynamic subtest A-VGA1: SUCCESS (0.790s)
[261.414568] Starting dynamic subtest: B-VGA1
[262.089529] Dynamic subtest B-VGA1: SUCCESS (0.687s)
[262.104165] Starting dynamic subtest: A-HDMI-A1
[262.882825] Dynamic subtest A-HDMI-A1: SUCCESS (0.790s)
[262.896018] Starting dynamic subtest: B-HDMI-A1
[263.679213] Dynamic subtest B-HDMI-A1: SUCCESS (0.796s)
[263.681898] Subtest basic-flip-vs-dpms: SUCCESS (3.071s)
[264.419749] [096/133] (783s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[264.926918] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[265.225819] [097/133] (782s left) gem_create (busy-create)
[265.293324] Starting subtest: busy-create
[265.293928] Starting dynamic subtest: smem0
[297.540491] Dynamic subtest smem0: SUCCESS (32.248s)
[297.544420] Subtest busy-create: SUCCESS (32.251s)
[297.760133] [098/133] (750s left) kms_plane_cursor (viewport)
[298.258407] Starting subtest: viewport
[298.259780] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[300.954644] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.695s)
[301.019113] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[303.715751] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.710s)
[303.782323] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[306.476806] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.710s)
[306.628592] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[309.404312] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.791s)
[309.468047] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[312.165412] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.710s)
[312.228667] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[314.926340] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.710s)
[315.058238] Subtest viewport: SUCCESS (16.802s)
[315.773242] [099/133] (732s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[316.274028] Starting subtest: short-flip-after-cursor-toggle
[317.246874] Subtest short-flip-after-cursor-toggle: SUCCESS (0.974s)
[317.989375] [100/133] (730s left) gem_tiled_blits (normal)
[318.322304] Starting subtest: normal
[325.745362] Subtest normal: SUCCESS (7.424s)
[325.904502] [101/133] (722s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[326.075975] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[326.145607] [102/133] (722s left) kms_psr (psr-no-drrs)
[326.644226] Subtest psr-no-drrs: SKIP (0.000s)
[326.957740] [103/133] (721s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[327.447704] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[327.448466] Starting dynamic subtest: pipe-A
[327.450522] Dynamic subtest pipe-A: SKIP (0.001s)
[327.464182] Starting dynamic subtest: pipe-B
[327.466353] Dynamic subtest pipe-B: SKIP (0.001s)
[327.467473] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.005s)
[328.056454] [104/133] (720s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[328.117688] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[328.185774] [105/133] (720s left) i915_drm_fdinfo (busy)
[328.243544] Subtest busy: SKIP (0.000s)
[328.302669] [106/133] (720s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[328.787948] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[328.792185] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[329.404700] [107/133] (719s left) kms_cursor_crc (cursor-offscreen-64x21)
[329.917171] Starting subtest: cursor-offscreen-64x21
[329.974869] Subtest cursor-offscreen-64x21: SKIP (0.057s)
[330.584336] [108/133] (717s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[331.081526] Starting subtest: async-flip-with-page-flip-events-linear
[331.218311] Subtest async-flip-with-page-flip-events-linear: SKIP (0.137s)
[331.939490] [109/133] (716s left) gem_readwrite (beyond-eob)
[332.001180] Starting subtest: beyond-EOB
[332.002513] Subtest beyond-EOB: SUCCESS (0.000s)
[332.160550] [110/133] (716s left) gem_exec_whisper (basic-queues-all)
[332.225933] Starting subtest: basic-queues-all
[332.229092] Subtest basic-queues-all: SKIP (0.003s)
[332.470477] [111/133] (716s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[332.962934] Starting subtest: cursorB-vs-flipB-varying-size
[332.964431] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[333.580461] [112/133] (715s left) prime_self_import (basic-with_one_bo)
[333.639945] Starting subtest: basic-with_one_bo
[333.643830] Subtest basic-with_one_bo: SUCCESS (0.004s)
[333.797826] [113/133] (715s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[334.289378] Starting subtest: 2x-plain-flip-ts-check-interruptible
[334.291472] Starting dynamic subtest: AB-VGA1-HDMI-A1
[364.949528] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.658s)
[364.953272] Subtest 2x-plain-flip-ts-check-interruptible: SUCCESS (30.663s)
[365.778388] [114/133] (683s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[365.846734] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[365.848694] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[366.090065] [115/133] (682s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[366.587066] Starting subtest: x-tiled-32bpp-rotate-270
[366.603431] Subtest x-tiled-32bpp-rotate-270: SKIP (0.015s)
[367.234937] [116/133] (681s left) gem_ctx_sseu (engines)
[367.295914] Subtest engines: SKIP (0.000s)
[367.363914] [117/133] (681s left) kms_cursor_edge_walk (64x64-top-bottom)
[367.859889] Starting subtest: 64x64-top-bottom
[367.860814] Starting dynamic subtest: pipe-A-HDMI-A-1
[371.275413] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.414s)
[371.290353] Starting dynamic subtest: pipe-B-HDMI-A-1
[374.609387] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.331s)
[374.610268] Subtest 64x64-top-bottom: SUCCESS (6.751s)
[375.328254] [118/133] (673s left) kms_psr (pr-primary-page-flip)
[375.824429] Subtest pr-primary-page-flip: SKIP (0.000s)
[376.122628] [119/133] (673s left) i915_query (query-topology-matches-eu-total)
[376.184306] Starting subtest: query-topology-matches-eu-total
[376.186066] Subtest query-topology-matches-eu-total: SKIP (0.000s)
[376.309824] [120/133] (672s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[376.368339] Starting subtest: tiled-to-untiled
[376.398492] Subtest tiled-to-untiled: SUCCESS (0.029s)
[376.558770] [121/133] (672s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[376.624362] Starting subtest: etime-multi-wait-all-submitted-signaled
[376.730157] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[376.840026] [122/133] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[377.331108] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[377.332935] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[377.940251] [123/133] (671s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[378.429459] Starting subtest: fbc-rgb565-draw-mmap-gtt
[380.248760] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (1.819s)
[380.890866] [124/133] (668s left) prime_busy (hang)
[380.957018] Starting subtest: hang
[380.957816] Starting dynamic subtest: rcs0
[386.870251] Dynamic subtest rcs0: SUCCESS (5.912s)
[386.887387] Starting dynamic subtest: bcs0
[392.882582] Dynamic subtest bcs0: SUCCESS (6.010s)
[392.896281] Starting dynamic subtest: vcs0
[398.831932] Dynamic subtest vcs0: SUCCESS (5.948s)
[398.832781] Subtest hang: SUCCESS (17.876s)
[398.997955] [125/133] (650s left) kms_setmode (invalid-clone-single-crtc)
[399.058397] Starting subtest: invalid-clone-single-crtc
[399.060727] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[399.200644] [126/133] (650s left) kms_properties (colorop-properties-atomic)
[399.687743] Starting subtest: colorop-properties-atomic
[399.688543] Starting dynamic subtest: pipe-A-HDMI-A-1
[399.809798] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.122s)
[399.824819] Starting dynamic subtest: pipe-B-HDMI-A-1
[400.011741] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.200s)
[400.012351] Subtest colorop-properties-atomic: SUCCESS (0.327s)
[400.726697] [127/133] (648s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[401.216436] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[401.219773] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[401.827265] [128/133] (647s left) kms_plane_scaling (invalid-num-scalers)
[402.314440] Starting subtest: invalid-num-scalers
[402.315974] Subtest invalid-num-scalers: SKIP (0.002s)
[402.935962] [129/133] (646s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[403.434180] Starting subtest: yf-tiled-16bpp-rotate-0
[403.435812] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[404.039842] [130/133] (645s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[404.531399] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[404.532822] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[405.119690] [131/133] (644s left) kms_psr (fbc-psr-primary-page-flip)
[405.605092] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[405.910538] [132/133] (643s left) gem_render_copy_redux (normal)
[405.972376] Starting subtest: normal
[406.511753] Subtest normal: SUCCESS (0.539s)
[406.667140] [133/133] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[407.155988] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[407.157290] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[407.774987] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_dither
results: parsing output: 3/ for test: kms_vblank
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: gem_media_vme
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: gem_caching
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_color_pipeline
results: parsing output: 20/ for test: sysfs_heartbeat_interval
results: parsing output: 21/ for test: kms_atomic
results: parsing output: 22/ for test: gem_pxp
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: i915_query
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_ctx_param
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_dsc
results: parsing output: 30/ for test: drm_buddy
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: kms_rmfb
results: parsing output: 37/ for test: kms_pipe_crc_basic
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: kms_fbcon_fbt
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: gem_mmap_offset
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_setmode
results: parsing output: 51/ for test: kms_invalid_mode
results: parsing output: 52/ for test: gem_mmap
results: parsing output: 53/ for test: gem_close
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: api_intel_allocator
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_content_protection
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_eio
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: api_intel_bb
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_busy
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: gen7_exec_parse
results: parsing output: 72/ for test: kms_chamelium_frames
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_mmap_wc
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: gem_wait
results: parsing output: 82/ for test: kms_busy
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_prime
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: prime_mmap
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: gem_create
results: parsing output: 97/ for test: kms_plane_cursor
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: gem_tiled_blits
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: gem_readwrite
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: prime_self_import
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_sseu
results: parsing output: 116/ for test: kms_cursor_edge_walk
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: gem_set_tiling_vs_blt
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: prime_busy
results: parsing output: 124/ for test: kms_setmode
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_render_copy_redux
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.