[71.097624] Initializing watchdogs
[71.097774]   /dev/watchdog0
[71.121964] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[71.129690] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.133669] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.137103] [001/133] (960s left) perf (global-sseu-config-invalid)
[71.282623] Subtest global-sseu-config-invalid: SKIP (0.000s)
[71.328700] [002/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[71.826188] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[71.828349] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[72.411313] [003/133] (959s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[72.909425] Starting subtest: fb-8bpc-vs-panel-8bpc
[72.910548] Starting dynamic subtest: pipe-A-HDMI-A-1
[73.003442] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.092s)
[73.005694] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.094s)
[73.711394] [004/133] (958s left) kms_vblank (query-busy)
[74.203630] Starting subtest: query-busy
[74.206087] Starting dynamic subtest: pipe-A-HDMI-A-1
[76.610115] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.405s)
[76.630851] Starting dynamic subtest: pipe-B-HDMI-A-1
[79.038282] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.428s)
[79.039384] Subtest query-busy: SUCCESS (4.836s)
[79.747796] [005/133] (952s left) gem_exec_fence (syncobj-timeline-export)
[80.102361] Starting subtest: syncobj-timeline-export
[80.105413] Subtest syncobj-timeline-export: SUCCESS (0.004s)
[80.378270] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[80.380992] [006/133] (951s left) kms_vblank (wait-forked-hang)
[80.878466] Starting subtest: wait-forked-hang
[80.879818] Starting dynamic subtest: pipe-A-HDMI-A-1
[86.968398] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.090s)
[86.978193] Starting dynamic subtest: pipe-B-HDMI-A-1
[92.916344] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.947s)
[92.917384] Subtest wait-forked-hang: SUCCESS (12.040s)
[93.642237] [007/133] (938s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[93.701493] Starting subtest: invalid-bsd1-flag-on-blt
[93.702514] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[93.841618] [008/133] (938s left) gem_media_vme
[93.955553] [009/133] (938s left) kms_cursor_crc (cursor-random-64x64)
[94.447773] Starting subtest: cursor-random-64x64
[94.449909] Starting dynamic subtest: pipe-A-HDMI-A-1
[98.153932] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.704s)
[98.191987] Starting dynamic subtest: pipe-B-HDMI-A-1
[101.869323] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.687s)
[101.870442] Subtest cursor-random-64x64: SUCCESS (7.421s)
[102.626138] [010/133] (929s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[103.126502] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[103.128571] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[103.706135] [011/133] (928s left) kms_psr (psr2-cursor-render)
[104.197108] Subtest psr2-cursor-render: SKIP (0.000s)
[104.500689] [012/133] (927s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[105.003189] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[105.006157] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[105.605153] [013/133] (926s left) gem_set_tiling_vs_pwrite
[105.808053] [014/133] (926s left) gem_exec_balancer (parallel-keep-in-fence)
[105.868347] Subtest parallel-keep-in-fence: SKIP (0.000s)
[105.985125] [015/133] (926s left) gem_userptr_blits (create-destroy-sync)
[106.053586] Starting subtest: create-destroy-sync
[111.069724] Subtest create-destroy-sync: SUCCESS (5.015s)
[111.225687] [016/133] (921s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[111.280746] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[111.386138] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[111.508539] [017/133] (920s left) gem_mmap_gtt (basic-small-copy-xy)
[111.561850] Starting subtest: basic-small-copy-XY
[112.251922] Subtest basic-small-copy-XY: SUCCESS (0.690s)
[112.377626] [018/133] (920s left) gem_caching (read-writes)
[112.523179] Starting subtest: read-writes
[117.223198] Subtest read-writes: SUCCESS (4.701s)
[117.390319] [019/133] (915s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[117.459310] Starting subtest: multi-wait-all-for-submit-available-signaled
[117.460350] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[117.577925] [020/133] (914s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[118.084233] Starting subtest: plane-lut1d-pre-ctm3x4
[118.362906] Subtest plane-lut1d-pre-ctm3x4: SKIP (0.280s)
[119.081518] [021/133] (913s left) sysfs_heartbeat_interval (idempotent)
[119.178073] Starting subtest: idempotent
[119.179151] Starting dynamic subtest: vcs0
[119.181360] Dynamic subtest vcs0: SUCCESS (0.002s)
[119.194231] Starting dynamic subtest: bcs0
[119.195364] Dynamic subtest bcs0: SUCCESS (0.002s)
[119.211653] Starting dynamic subtest: rcs0
[119.213129] Dynamic subtest rcs0: SUCCESS (0.001s)
[119.214310] Subtest idempotent: SUCCESS (0.007s)
[119.312176] [022/133] (913s left) kms_atomic (atomic-invalid-params)
[119.809756] Starting subtest: atomic-invalid-params
[119.812750] Starting dynamic subtest: pipe-A-HDMI-A-1
[120.062349] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.250s)
[120.063443] Subtest atomic-invalid-params: SUCCESS (0.253s)
[120.778785] [023/133] (911s left) gem_pxp (hw-rejects-pxp-buffer)
[123.355405] Starting subtest: hw-rejects-pxp-buffer
[123.356733] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[123.486469] [024/133] (909s left) perf (non-system-wide-paranoid)
[123.630555] Subtest non-system-wide-paranoid: SKIP (0.000s)
[123.684284] [025/133] (909s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[124.189844] Starting subtest: psr-rgb565-draw-mmap-gtt
[124.192027] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[124.785208] [026/133] (908s left) i915_query (hwconfig_table)
[124.840456] Starting subtest: hwconfig_table
[124.842491] Subtest hwconfig_table: SKIP (0.000s)
[124.951400] [027/133] (907s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[125.446345] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[127.267559] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (1.823s)
[127.897118] [028/133] (905s left) gem_ctx_param (invalid-set-ringsize)
[127.955252] Starting subtest: invalid-set-ringsize
[127.956429] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[128.081417] [029/133] (904s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[128.580284] Starting subtest: 4-tiled-addfb-size-offset-overflow
[128.582363] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[129.195666] [030/133] (903s left) kms_dsc (dsc-fractional-bpp)
[129.691723] Subtest dsc-fractional-bpp: SKIP (0.000s)
[130.006548] [031/133] (903s left) drm_buddy (drm_buddy)
[130.062581] Starting subtest: drm_buddy
[130.064920] Subtest drm_buddy: SKIP (0.001s)
[130.177585] [032/133] (902s left) kms_chamelium_hpd (common-hpd-after-suspend)
[130.744286] Subtest common-hpd-after-suspend: SKIP (0.000s)
[131.150330] [033/133] (902s left) gem_exec_schedule (u-submit-golden-slice)
[131.221590] Subtest u-submit-golden-slice: SKIP (0.000s)
[131.456503] [034/133] (901s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[131.512167] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[131.565855] [035/133] (901s left) syncobj_wait (single-wait-signaled)
[131.624578] Starting subtest: single-wait-signaled
[131.625734] Subtest single-wait-signaled: SUCCESS (0.000s)
[131.751996] [036/133] (901s left) kms_pm_backlight (fade-with-dpms)
[132.248142] Subtest fade-with-dpms: SKIP (0.000s)
[132.548215] [037/133] (900s left) kms_rmfb (close-fd)
[133.042293] Starting subtest: close-fd
[133.043392] Starting dynamic subtest: pipe-A-HDMI-A-1
[133.156056] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.114s)
[133.171332] Starting dynamic subtest: pipe-B-HDMI-A-1
[133.447550] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.289s)
[133.448604] Subtest close-fd: SUCCESS (0.406s)
[134.246152] [038/133] (899s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[134.734323] Starting subtest: read-crc-frame-sequence
[134.735399] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.242321] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.508s)
[135.253157] Starting dynamic subtest: pipe-B-HDMI-A-1
[135.767566] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.525s)
[135.768753] Subtest read-crc-frame-sequence: SUCCESS (1.036s)
[136.483225] [039/133] (897s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[136.539089] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[136.619219] [040/133] (896s left) syncobj_wait (wait-all-interrupted)
[136.677580] Starting subtest: wait-all-interrupted
[136.785174] Subtest wait-all-interrupted: SUCCESS (0.108s)
[136.914219] [041/133] (896s left) kms_fbcon_fbt (psr-suspend)
[136.973721] Starting subtest: psr-suspend
[136.976274] Subtest psr-suspend: SKIP (0.000s)
[137.129924] [042/133] (896s left) gem_render_copy (y-tiled)
[137.193467] Starting subtest: y-tiled
[137.194640] Starting dynamic subtest: smem
[137.258741] Dynamic subtest smem: SUCCESS (0.065s)
[137.259979] Subtest y-tiled: SUCCESS (0.066s)
[137.482258] [043/133] (896s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[137.975844] Starting subtest: cursorA-vs-flipA-legacy
[148.874733] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.897s)
[149.593434] [044/133] (884s left) syncobj_wait (single-wait-for-submit-signaled)
[149.649860] Starting subtest: single-wait-for-submit-signaled
[149.651044] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[149.776791] [045/133] (884s left) kms_psr (fbc-pr-sprite-plane-move)
[150.271324] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[150.568437] [046/133] (883s left) gem_mmap_offset (partial-mmap)
[150.622981] Starting subtest: partial-mmap
[150.624486] Starting dynamic subtest: smem0
[150.630235] Dynamic subtest smem0: SUCCESS (0.007s)
[150.631901] Subtest partial-mmap: SUCCESS (0.008s)
[150.790870] [047/133] (883s left) gem_spin_batch (resubmit)
[150.857801] Starting subtest: resubmit
[150.858859] Starting dynamic subtest: rcs0
[150.859871] Dynamic subtest rcs0: SUCCESS (0.003s)
[150.871728] Starting dynamic subtest: bcs0
[150.873078] Dynamic subtest bcs0: SUCCESS (0.002s)
[150.885617] Starting dynamic subtest: vcs0
[150.886810] Dynamic subtest vcs0: SUCCESS (0.001s)
[150.887981] Subtest resubmit: SUCCESS (0.010s)
[151.109877] [048/133] (882s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[151.602900] Starting subtest: fbcpsr-rgb565-draw-render
[151.605098] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[152.204366] [049/133] (881s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[152.697020] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[152.699272] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[153.302856] [050/133] (880s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[153.358801] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[153.411888] [051/133] (880s left) kms_setmode (invalid-clone-single-crtc-stealing)
[153.468322] Starting subtest: invalid-clone-single-crtc-stealing
[153.471583] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[153.613427] [052/133] (880s left) kms_invalid_mode (bad-vtotal)
[154.100365] Starting subtest: bad-vtotal
[154.101381] Starting dynamic subtest: pipe-A-HDMI-A-1
[154.183081] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.080s)
[154.194087] Starting dynamic subtest: pipe-B-HDMI-A-1
[154.195394] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[154.196702] Subtest bad-vtotal: SUCCESS (0.084s)
[154.676568] [053/133] (879s left) gem_mmap (short-mmap)
[154.734126] Starting subtest: short-mmap
[154.735244] Subtest short-mmap: SUCCESS (0.000s)
[154.877501] [054/133] (879s left) gem_close (many-handles-one-vma)
[154.937797] Starting subtest: many-handles-one-vma
[154.971944] Subtest many-handles-one-vma: SUCCESS (0.035s)
[155.116308] [055/133] (879s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[155.174226] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[155.175260] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[155.294672] [056/133] (879s left) gem_exec_fence (syncobj-timeline-wait)
[155.606250] Starting subtest: syncobj-timeline-wait
[155.658203] Subtest syncobj-timeline-wait: SUCCESS (0.052s)
[155.927273] [057/133] (878s left) api_intel_allocator (default-alignment)
[155.989025] Starting subtest: default-alignment
[155.992880] Subtest default-alignment: SUCCESS (0.005s)
[156.159421] [058/133] (878s left) kms_psr (fbc-pr-basic)
[156.652275] Subtest fbc-pr-basic: SKIP (0.000s)
[156.954267] [059/133] (877s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[157.007972] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[157.069642] [060/133] (877s left) kms_content_protection (dp-mst-lic-type-0)
[157.574275] Starting subtest: dp-mst-lic-type-0
[157.576999] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[158.193890] [061/133] (876s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[158.680376] Starting subtest: cursorA-vs-flipB-legacy
[158.682465] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[159.290835] [062/133] (875s left) gem_eio (suspend)
[159.356662] Starting subtest: suspend
[170.638187] Subtest suspend: SUCCESS (11.131s)
[183.714126] [063/133] (863s left) gem_exec_schedule (implicit-write-read)
[183.787044] Starting subtest: implicit-write-read
[183.788299] Starting dynamic subtest: rcs0
[183.817723] Dynamic subtest rcs0: SUCCESS (0.031s)
[183.832678] Starting dynamic subtest: bcs0
[183.849207] Dynamic subtest bcs0: SUCCESS (0.029s)
[183.850396] Subtest implicit-write-read: SUCCESS (0.063s)
[184.123631] [064/133] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[184.611544] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[184.613684] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[185.221298] [065/133] (861s left) api_intel_bb (reset-flags)
[185.277733] Starting subtest: reset-flags
[185.282910] Subtest reset-flags: SUCCESS (0.005s)
[185.440605] [066/133] (861s left) i915_drm_fdinfo (virtual-idle)
[185.498259] Subtest virtual-idle: SKIP (0.000s)
[185.572727] [067/133] (861s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[185.627344] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[185.628357] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[185.755718] [068/133] (861s left) gem_exec_reloc (basic-write-cpu)
[185.813342] Starting subtest: basic-write-cpu
[185.815829] Subtest basic-write-cpu: SUCCESS (0.002s)
[186.855550] [069/133] (860s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[187.348346] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[189.545689] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.199s)
[190.181687] [070/133] (857s left) gem_busy (busy)
[190.249646] Starting subtest: busy
[190.250711] Starting dynamic subtest: all-engines
[190.277907] Dynamic subtest all-engines: SUCCESS (0.027s)
[190.292512] Starting dynamic subtest: rcs0
[190.295485] Dynamic subtest rcs0: SUCCESS (0.016s)
[190.311466] Starting dynamic subtest: bcs0
[190.314289] Dynamic subtest bcs0: SUCCESS (0.017s)
[190.329754] Starting dynamic subtest: vcs0
[190.332456] Dynamic subtest vcs0: SUCCESS (0.016s)
[190.333517] Subtest busy: SUCCESS (0.082s)
[190.768898] [071/133] (856s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[191.253918] Starting subtest: cursor-vs-flip-toggle
[225.389956] Subtest cursor-vs-flip-toggle: SUCCESS (34.136s)
[226.106245] [072/133] (821s left) gen7_exec_parse (oacontrol-tracking)
[226.169910] Subtest oacontrol-tracking: SKIP (0.000s)
[226.232349] [073/133] (821s left) kms_chamelium_frames (hdmi-crc-multiple)
[226.787094] Subtest hdmi-crc-multiple: SKIP (0.000s)
[227.193949] [074/133] (820s left) i915_pm_rps (min-max-config-idle)
[227.257759] Starting subtest: min-max-config-idle
[227.458773] Subtest min-max-config-idle: SUCCESS (0.201s)
[227.633860] [075/133] (819s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[228.127389] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[228.129745] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[228.714369] [076/133] (818s left) kms_big_fb (linear-32bpp-rotate-270)
[229.212037] Starting subtest: linear-32bpp-rotate-270
[229.225473] Subtest linear-32bpp-rotate-270: SKIP (0.014s)
[229.843791] [077/133] (817s left) gem_mmap_wc (pf-nonblock)
[229.904290] Starting subtest: pf-nonblock
[229.905358] Subtest pf-nonblock: SUCCESS (0.001s)
[230.078207] [078/133] (817s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[230.135578] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.000s)
[230.203862] [079/133] (817s left) gem_exec_schedule (u-submit-early-slice)
[230.269370] Subtest u-submit-early-slice: SKIP (0.000s)
[230.509676] [080/133] (817s left) kms_lease (implicit-plane-lease)
[231.000251] Starting subtest: implicit-plane-lease
[231.003020] Subtest implicit-plane-lease: SUCCESS (0.003s)
[231.607565] [081/133] (816s left) perf_pmu (multi-client)
[231.667778] Starting subtest: multi-client
[231.669024] Starting dynamic subtest: rcs0
[232.687750] Dynamic subtest rcs0: SUCCESS (1.018s)
[232.712580] Starting dynamic subtest: bcs0
[233.719723] Dynamic subtest bcs0: SUCCESS (1.030s)
[233.737577] Starting dynamic subtest: vcs0
[235.243900] Dynamic subtest vcs0: SUCCESS (1.523s)
[235.245085] Subtest multi-client: SUCCESS (3.576s)
[235.383646] [082/133] (812s left) gem_wait (wait)
[235.453745] Starting subtest: wait
[235.454889] Starting dynamic subtest: all-engines
[236.480783] Dynamic subtest all-engines: SUCCESS (1.026s)
[236.496665] Starting dynamic subtest: rcs0
[237.510706] Dynamic subtest rcs0: SUCCESS (1.027s)
[237.527909] Starting dynamic subtest: bcs0
[238.533879] Dynamic subtest bcs0: SUCCESS (1.020s)
[238.551560] Starting dynamic subtest: vcs0
[239.561646] Dynamic subtest vcs0: SUCCESS (1.024s)
[239.565440] Subtest wait: SUCCESS (4.109s)
[239.825078] [083/133] (808s left) kms_busy (extended-pageflip-hang-newfb)
[240.315573] Starting subtest: extended-pageflip-hang-newfb
[240.316655] Starting dynamic subtest: pipe-A
[247.006044] Dynamic subtest pipe-A: SUCCESS (6.688s)
[247.019819] Starting dynamic subtest: pipe-B
[252.961815] Dynamic subtest pipe-B: SUCCESS (5.955s)
[252.962939] Subtest extended-pageflip-hang-newfb: SUCCESS (12.649s)
[253.686982] [084/133] (794s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[254.181554] Starting subtest: yf-tiled-8bpp-rotate-90
[254.184079] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[254.800409] [085/133] (793s left) kms_prime (basic-modeset-hybrid)
[255.307579] Subtest basic-modeset-hybrid: SKIP (0.000s)
[256.389054] [086/133] (791s left) gem_exec_balancer (bonded-dual)
[256.449370] Subtest bonded-dual: SKIP (0.000s)
[256.585858] [087/133] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[257.077329] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[257.079383] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[257.666491] [088/133] (790s left) prime_mmap (test_correct_cpu_write)
[257.722241] Starting subtest: test_correct_cpu_write
[257.723277] Starting dynamic subtest: test_correct_cpu_write-smem
[257.724384] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[257.725355] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[257.865882] [089/133] (790s left) gem_ctx_persistence (smoketest)
[257.923908] Subtest smoketest: SKIP (0.000s)
[257.992937] [090/133] (790s left) syncobj_wait (multi-wait-submitted)
[258.050034] Starting subtest: multi-wait-submitted
[258.153452] Subtest multi-wait-submitted: SUCCESS (0.102s)
[258.281404] [091/133] (790s left) syncobj_timeline (wait-all-complex)
[258.338505] Starting subtest: wait-all-complex
[258.554055] Subtest wait-all-complex: SUCCESS (0.215s)
[258.696296] [092/133] (789s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[259.190312] Starting subtest: y-tiled-16bpp-rotate-0
[259.192363] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[259.796514] [093/133] (788s left) sw_sync (sync_busy)
[259.852266] Starting subtest: sync_busy
[259.856958] Subtest sync_busy: SUCCESS (0.005s)
[259.980462] [094/133] (788s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[260.482361] Starting subtest: psr-rgb565-draw-pwrite
[260.486587] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[261.096424] [095/133] (787s left) kms_flip (basic-flip-vs-dpms)
[261.585344] Starting subtest: basic-flip-vs-dpms
[261.586445] Starting dynamic subtest: A-VGA1
[262.356557] Dynamic subtest A-VGA1: SUCCESS (0.770s)
[262.370321] Starting dynamic subtest: B-VGA1
[263.055854] Dynamic subtest B-VGA1: SUCCESS (0.698s)
[263.071604] Starting dynamic subtest: A-HDMI-A1
[263.847739] Dynamic subtest A-HDMI-A1: SUCCESS (0.789s)
[263.862796] Starting dynamic subtest: B-HDMI-A1
[264.645395] Dynamic subtest B-HDMI-A1: SUCCESS (0.796s)
[264.646499] Subtest basic-flip-vs-dpms: SUCCESS (3.061s)
[265.387710] [096/133] (783s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[265.878247] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[266.181358] [097/133] (782s left) gem_create (busy-create)
[266.242658] Starting subtest: busy-create
[266.243719] Starting dynamic subtest: smem0
[298.488684] Dynamic subtest smem0: SUCCESS (32.246s)
[298.492768] Subtest busy-create: SUCCESS (32.249s)
[298.739846] [098/133] (750s left) kms_plane_cursor (viewport)
[299.228979] Starting subtest: viewport
[299.231174] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[301.943259] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.712s)
[302.008052] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[304.704133] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.709s)
[304.768202] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[307.482040] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.726s)
[307.629774] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[310.391453] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.774s)
[310.455721] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[313.152532] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.709s)
[313.216825] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[315.913618] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.710s)
[316.047283] Subtest viewport: SUCCESS (16.818s)
[316.762584] [099/133] (732s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[317.250876] Starting subtest: short-flip-after-cursor-toggle
[318.208771] Subtest short-flip-after-cursor-toggle: SUCCESS (0.957s)
[318.940374] [100/133] (730s left) gem_tiled_blits (normal)
[319.265382] Starting subtest: normal
[326.711066] Subtest normal: SUCCESS (7.448s)
[326.883381] [101/133] (722s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[327.025044] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[327.084964] [102/133] (721s left) kms_psr (psr-no-drrs)
[327.591190] Subtest psr-no-drrs: SKIP (0.000s)
[327.895807] [103/133] (721s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[328.383381] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[328.384389] Starting dynamic subtest: pipe-A
[328.387515] Dynamic subtest pipe-A: SKIP (0.001s)
[328.401873] Starting dynamic subtest: pipe-B
[328.405029] Dynamic subtest pipe-B: SKIP (0.001s)
[328.407143] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.005s)
[328.996648] [104/133] (720s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[329.054318] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[329.121311] [105/133] (720s left) i915_drm_fdinfo (busy)
[329.178319] Subtest busy: SKIP (0.000s)
[329.253618] [106/133] (720s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[329.746670] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[329.750162] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[330.352419] [107/133] (719s left) kms_cursor_crc (cursor-offscreen-64x21)
[330.853969] Starting subtest: cursor-offscreen-64x21
[330.912176] Subtest cursor-offscreen-64x21: SKIP (0.056s)
[331.498664] [108/133] (717s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[331.987729] Starting subtest: async-flip-with-page-flip-events-linear
[332.128296] Subtest async-flip-with-page-flip-events-linear: SKIP (0.141s)
[332.848757] [109/133] (716s left) gem_readwrite (beyond-eob)
[332.903284] Starting subtest: beyond-EOB
[332.905444] Subtest beyond-EOB: SUCCESS (0.000s)
[333.047842] [110/133] (716s left) gem_exec_whisper (basic-queues-all)
[333.113144] Starting subtest: basic-queues-all
[333.117797] Subtest basic-queues-all: SKIP (0.003s)
[333.379974] [111/133] (716s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[333.866478] Starting subtest: cursorB-vs-flipB-varying-size
[333.868593] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[334.482866] [112/133] (715s left) prime_self_import (basic-with_one_bo)
[334.536595] Starting subtest: basic-with_one_bo
[334.540876] Subtest basic-with_one_bo: SUCCESS (0.004s)
[334.672603] [113/133] (715s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[335.158328] Starting subtest: 2x-plain-flip-ts-check-interruptible
[335.161958] Starting dynamic subtest: AB-VGA1-HDMI-A1
[365.809488] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.648s)
[365.815201] Subtest 2x-plain-flip-ts-check-interruptible: SUCCESS (30.653s)
[366.654980] [114/133] (683s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[366.720583] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[366.723238] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[366.957277] [115/133] (682s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[367.456140] Starting subtest: x-tiled-32bpp-rotate-270
[367.466799] Subtest x-tiled-32bpp-rotate-270: SKIP (0.011s)
[368.085820] [116/133] (681s left) gem_ctx_sseu (engines)
[368.145420] Subtest engines: SKIP (0.000s)
[368.216637] [117/133] (681s left) kms_cursor_edge_walk (64x64-top-bottom)
[368.706350] Starting subtest: 64x64-top-bottom
[368.707407] Starting dynamic subtest: pipe-A-HDMI-A-1
[372.122017] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.414s)
[372.135899] Starting dynamic subtest: pipe-B-HDMI-A-1
[375.452533] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.329s)
[375.453573] Subtest 64x64-top-bottom: SUCCESS (6.749s)
[376.192463] [118/133] (673s left) kms_psr (pr-primary-page-flip)
[376.676788] Subtest pr-primary-page-flip: SKIP (0.000s)
[377.002233] [119/133] (673s left) i915_query (query-topology-matches-eu-total)
[377.058973] Starting subtest: query-topology-matches-eu-total
[377.061221] Subtest query-topology-matches-eu-total: SKIP (0.000s)
[377.189776] [120/133] (672s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[377.250247] Starting subtest: tiled-to-untiled
[377.279532] Subtest tiled-to-untiled: SUCCESS (0.030s)
[377.444942] [121/133] (672s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[377.509823] Starting subtest: etime-multi-wait-all-submitted-signaled
[377.616812] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[377.754587] [122/133] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[378.248236] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[378.250323] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[378.854152] [123/133] (671s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[379.341386] Starting subtest: fbc-rgb565-draw-mmap-gtt
[381.145750] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (1.806s)
[381.782531] [124/133] (668s left) prime_busy (hang)
[381.845743] Starting subtest: hang
[381.846885] Starting dynamic subtest: rcs0
[387.895557] Dynamic subtest rcs0: SUCCESS (6.050s)
[387.911237] Starting dynamic subtest: bcs0
[393.903128] Dynamic subtest bcs0: SUCCESS (6.004s)
[393.920728] Starting dynamic subtest: vcs0
[399.860165] Dynamic subtest vcs0: SUCCESS (5.956s)
[399.861188] Subtest hang: SUCCESS (18.017s)
[400.029810] [125/133] (650s left) kms_setmode (invalid-clone-single-crtc)
[400.088719] Starting subtest: invalid-clone-single-crtc
[400.092101] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[400.227409] [126/133] (650s left) kms_properties (colorop-properties-atomic)
[400.721498] Starting subtest: colorop-properties-atomic
[400.722661] Starting dynamic subtest: pipe-A-HDMI-A-1
[400.854831] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.133s)
[400.871633] Starting dynamic subtest: pipe-B-HDMI-A-1
[401.057378] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.201s)
[401.058353] Subtest colorop-properties-atomic: SUCCESS (0.339s)
[401.779193] [127/133] (648s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[402.271206] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[402.273532] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[402.875867] [128/133] (647s left) kms_plane_scaling (invalid-num-scalers)
[403.363534] Starting subtest: invalid-num-scalers
[403.365644] Subtest invalid-num-scalers: SKIP (0.002s)
[403.971930] [129/133] (646s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[404.469131] Starting subtest: yf-tiled-16bpp-rotate-0
[404.471223] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[405.086821] [130/133] (645s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[405.581610] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[405.583822] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[406.183919] [131/133] (644s left) kms_psr (fbc-psr-primary-page-flip)
[406.671170] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[406.981935] [132/133] (643s left) gem_render_copy_redux (normal)
[407.041294] Starting subtest: normal
[407.590160] Subtest normal: SUCCESS (0.549s)
[407.735237] [133/133] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[408.225250] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[408.227392] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[408.810661] 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.