[69.840309] Initializing watchdogs
[69.840438]   /dev/watchdog0
[69.863927] [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)
[69.872032] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.875641] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.878920] [001/130] (960s left) perf_pmu (gt-awake)
[69.954250] Starting subtest: gt-awake
[71.968031] Subtest gt-awake: SUCCESS (2.011s)
[72.108679] [002/130] (958s left) i915_getparams_basic (basic-eu-total)
[72.163917] Starting subtest: basic-eu-total
[72.166226] Subtest basic-eu-total: SUCCESS (0.000s)
[72.291502] [003/130] (958s left) kms_psr (fbc-psr2-sprite-plane-move)
[72.592404] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[72.802504] [004/130] (957s left) kms_getfb (getfb2-accept-nv12)
[73.099428] Starting subtest: getfb2-accept-nv12
[73.101552] Subtest getfb2-accept-nv12: SKIP (0.000s)
[73.507878] [005/130] (957s left) syncobj_timeline (etime-single-wait-submitted)
[73.563591] Starting subtest: etime-single-wait-submitted
[73.672308] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[73.790944] [006/130] (956s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[74.092535] Starting subtest: fbcpsr-tiling-4
[74.094835] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[74.490383] [007/130] (956s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[74.801538] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[74.803824] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[75.208282] [008/130] (955s left) gem_create (create-size-update)
[75.264937] Starting subtest: create-size-update
[75.266022] Subtest create-size-update: SUCCESS (0.000s)
[75.506128] [009/130] (955s left) gem_exec_nop (basic-parallel)
[75.574150] Starting subtest: basic-parallel
[78.383750] Subtest basic-parallel: SUCCESS (2.807s)
[78.657624] [010/130] (952s left) perf_pmu (rc6)
[78.713468] Starting subtest: rc6
[78.714530] Starting dynamic subtest: gt0
[85.055942] Dynamic subtest gt0: SUCCESS (6.337s)
[85.066387] Starting dynamic subtest: runtime-pm-gt0
[96.175424] Dynamic subtest runtime-pm-gt0: SKIP (11.112s)
[96.188929] Starting dynamic subtest: runtime-pm-long-gt0
[107.218012] Dynamic subtest runtime-pm-long-gt0: SKIP (11.040s)
[107.229638] Starting dynamic subtest: other-idle-gt0
[107.231907] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[107.232969] Subtest rc6: SUCCESS (28.491s)
[107.781775] [011/130] (923s left) kms_cursor_crc (cursor-sliding-64x64)
[108.097415] Starting subtest: cursor-sliding-64x64
[108.110986] Starting dynamic subtest: pipe-A-HDMI-A-1
[111.694804] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.584s)
[111.735344] Starting dynamic subtest: pipe-B-HDMI-A-1
[115.278758] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.554s)
[115.279892] Subtest cursor-sliding-64x64: SUCCESS (7.180s)
[115.731976] [012/130] (915s left) perf (rc6-disable)
[115.813130] Subtest rc6-disable: SKIP (0.000s)
[115.858175] [013/130] (915s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[115.915272] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[116.025228] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.109s)
[116.078162] [014/130] (914s left) gem_workarounds (suspend-resume-fd)
[116.147338] Starting subtest: suspend-resume-fd
[133.030103] Subtest suspend-resume-fd: SUCCESS (0.518s)
[141.082894] [015/130] (897s left) gem_basic (create-close)
[141.143460] Starting subtest: create-close
[141.145489] Subtest create-close: SUCCESS (0.000s)
[141.214346] [016/130] (897s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[141.271441] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[141.373219] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[141.429377] [017/130] (897s left) gen7_exec_parse (basic-allowed)
[141.488824] Subtest basic-allowed: SKIP (0.000s)
[141.538955] [018/130] (897s left) prime_busy (after-wait)
[141.592767] Starting subtest: after-wait
[141.600038] Starting dynamic subtest: rcs0
[141.623355] Dynamic subtest rcs0: SUCCESS (0.023s)
[141.647122] Starting dynamic subtest: bcs0
[141.648638] Dynamic subtest bcs0: SUCCESS (0.013s)
[141.667622] Starting dynamic subtest: vcs0
[141.669244] Dynamic subtest vcs0: SUCCESS (0.017s)
[141.760881] Subtest after-wait: SUCCESS (0.167s)
[141.811727] [019/130] (897s left) i915_query (engine-info-invalid)
[141.870117] Starting subtest: engine-info-invalid
[141.871141] Subtest engine-info-invalid: SUCCESS (0.000s)
[141.927521] [020/130] (897s left) kms_flip (2x-flip-vs-dpms-on-nop)
[142.225663] Starting subtest: 2x-flip-vs-dpms-on-nop
[142.226764] Starting dynamic subtest: AB-VGA1-HDMI-A1
[144.851261] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.625s)
[144.852492] Subtest 2x-flip-vs-dpms-on-nop: SUCCESS (2.627s)
[145.277069] [021/130] (894s left) gem_eio (in-flight-internal-1us)
[145.370191] Starting subtest: in-flight-internal-1us
[145.405339] Subtest in-flight-internal-1us: SUCCESS (0.036s)
[146.004873] [022/130] (893s left) kms_psr2_su (page_flip-xrgb8888)
[146.061419] Subtest page_flip-XRGB8888: SKIP (0.000s)
[146.109687] [023/130] (893s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[146.171831] Starting subtest: x-tiled-to-vebox-yf-tiled
[146.174417] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[146.335403] [024/130] (893s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[146.644742] Starting subtest: yf-tiled-16bpp-rotate-270
[146.647003] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[146.980570] [025/130] (892s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[147.035837] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.000s)
[147.095397] [026/130] (892s left) gem_exec_params (dr1-dirt)
[147.152993] Starting subtest: DR1-dirt
[147.154110] Subtest DR1-dirt: SUCCESS (0.000s)
[147.232567] [027/130] (892s left) kms_color (legacy-gamma)
[147.524596] Starting subtest: legacy-gamma
[147.525797] Starting dynamic subtest: pipe-A-HDMI-A-1
[147.998083] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.474s)
[148.011310] Starting dynamic subtest: pipe-B-HDMI-A-1
[148.498263] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.500s)
[148.499314] Subtest legacy-gamma: SUCCESS (0.974s)
[148.946738] [028/130] (890s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[149.258601] Starting subtest: x-tiled-8bpp-rotate-0
[150.397595] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.138s)
[150.775544] [029/130] (888s left) prime_mmap (test_correct)
[150.829029] Starting subtest: test_correct
[150.830078] Starting dynamic subtest: test_correct-smem
[150.832295] Dynamic subtest test_correct-smem: SUCCESS (0.004s)
[150.833366] Subtest test_correct: SUCCESS (0.004s)
[150.910936] [030/130] (888s left) kms_pm_backlight (fade-with-suspend)
[151.204375] Subtest fade-with-suspend: SKIP (0.000s)
[151.410591] [031/130] (888s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[151.712678] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[151.900846] [032/130] (887s left) gem_ppgtt (blt-vs-render-ctx0)
[151.956875] Starting subtest: blt-vs-render-ctx0
[184.722358] Subtest blt-vs-render-ctx0: SUCCESS (32.766s)
[184.807344] [033/130] (855s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[184.955224] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[185.015476] [034/130] (854s left) gem_lmem_swapping (verify-random-ccs)
[185.081451] Subtest verify-random-ccs: SKIP (0.000s)
[185.132773] [035/130] (854s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[185.424978] Starting subtest: plane-primary-toggle-with-vblank-wait
[185.426104] Starting dynamic subtest: pipe-A-HDMI-A-1
[185.641039] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.214s)
[185.741009] Starting dynamic subtest: pipe-B-HDMI-A-1
[186.063193] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.335s)
[186.144789] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.719s)
[186.595141] [036/130] (853s left) gem_exec_alignment (pi-isolated)
[186.656315] Starting subtest: pi-isolated
[186.658542] Subtest pi-isolated: SKIP (0.000s)
[186.749193] [037/130] (853s left) kms_pm_rpm (modeset-stress-extra-wait)
[198.315718] Subtest modeset-stress-extra-wait: SKIP (0.000s)
[198.507808] [038/130] (841s left) gem_exec_params (cliprects_ptr-dirt)
[198.565889] Starting subtest: cliprects_ptr-dirt
[198.567021] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[198.636853] [039/130] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[198.939568] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[198.941709] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[199.269706] [040/130] (841s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[199.327062] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[199.383005] [041/130] (840s left) kms_busy (extended-modeset-hang-newfb)
[199.677585] Starting subtest: extended-modeset-hang-newfb
[199.678657] Starting dynamic subtest: pipe-A
[212.225083] Dynamic subtest pipe-A: SUCCESS (12.546s)
[212.239100] Starting dynamic subtest: pipe-B
[224.167534] Dynamic subtest pipe-B: SUCCESS (11.940s)
[224.168545] Subtest extended-modeset-hang-newfb: SUCCESS (24.490s)
[224.631888] [042/130] (815s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[224.930798] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[224.933013] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[225.272145] [043/130] (815s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[225.330544] Starting subtest: multi-wait-available-unsubmitted-signaled
[225.331589] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[225.384251] [044/130] (815s left) gem_softpin (evict-prime)
[225.445118] Subtest evict-prime: SKIP (0.000s)
[225.504426] [045/130] (815s left) gem_exec_schedule (preempt-queue)
[225.570710] Subtest preempt-queue: SKIP (0.000s)
[225.740705] [046/130] (814s left) gem_userptr_blits (coherency-unsync)
[225.802262] Subtest coherency-unsync: SKIP (0.000s)
[225.903822] [047/130] (814s left) kms_cursor_legacy (single-move)
[226.200792] Starting subtest: single-move
[226.201960] Starting dynamic subtest: pipe-A
[231.586545] Dynamic subtest pipe-A: SUCCESS (5.384s)
[231.601839] Starting dynamic subtest: pipe-B
[236.970795] Dynamic subtest pipe-B: SUCCESS (5.383s)
[236.986841] Starting dynamic subtest: all-pipes
[242.354748] Dynamic subtest all-pipes: SUCCESS (5.383s)
[242.355875] Subtest single-move: SUCCESS (16.154s)
[242.700973] [048/130] (798s left) kms_vblank (query-forked-busy)
[242.996087] Starting subtest: query-forked-busy
[242.997384] Starting dynamic subtest: pipe-A-HDMI-A-1
[245.379595] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.383s)
[245.393907] Starting dynamic subtest: pipe-B-HDMI-A-1
[247.802217] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.422s)
[247.803369] Subtest query-forked-busy: SUCCESS (4.808s)
[248.252153] [049/130] (792s left) gem_pwrite (basic-exhaustion)
[248.306668] Starting subtest: basic-exhaustion
[253.765575] Subtest basic-exhaustion: SUCCESS (5.458s)
[253.856760] [FACT gem_pwrite (basic-exhaustion)] new: kernel.kmod_is_loaded.vgem: true
[253.859597] [050/130] (786s left) gem_userptr_blits (sync-unmap)
[253.928333] Starting subtest: sync-unmap
[253.940015] Subtest sync-unmap: SUCCESS (0.014s)
[254.047865] [051/130] (786s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[254.350921] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[254.353910] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[254.689950] [052/130] (786s left) perf_pmu (busy-double-start)
[254.748953] Starting subtest: busy-double-start
[254.750117] Starting dynamic subtest: rcs0
[258.289830] Dynamic subtest rcs0: SUCCESS (3.540s)
[258.316098] Starting dynamic subtest: bcs0
[261.808771] Dynamic subtest bcs0: SUCCESS (3.517s)
[261.835934] Starting dynamic subtest: vcs0
[265.825634] Dynamic subtest vcs0: SUCCESS (4.015s)
[265.827066] Subtest busy-double-start: SUCCESS (11.078s)
[265.902574] [053/130] (775s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[265.957699] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[266.061076] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[266.133101] [054/130] (774s left) gem_exec_fence (basic-wait)
[266.306782] Subtest basic-wait: SKIP (0.000s)
[266.668436] [055/130] (774s left) kms_addfb_basic (addfb25-modifier-no-flag)
[266.969530] Starting subtest: addfb25-modifier-no-flag
[266.970664] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[267.316767] [056/130] (773s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[267.371305] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[267.424363] [057/130] (773s left) kms_fb_coherency (memset-crc)
[267.721813] Starting subtest: memset-crc
[267.722957] Starting dynamic subtest: mmap-gtt
[268.099079] Dynamic subtest mmap-gtt: CRASH (0.123s)
[268.420199] Subtest memset-crc: CRASH (0.369s)
[268.475149] [058/130] (772s left) gem_lmem_swapping (massive)
[268.534815] Subtest massive: SKIP (0.000s)
[268.591658] [059/130] (772s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[268.961206] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[269.286161] [060/130] (772s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[269.588713] Starting subtest: async-flip-with-page-flip-events-linear
[269.738540] Subtest async-flip-with-page-flip-events-linear: SKIP (0.150s)
[270.196259] [061/130] (771s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[270.269877] Starting subtest: stress-mm-invalidate-close-overlap
[272.417877] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[272.510356] [062/130] (768s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[272.810405] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[274.751770] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.943s)
[275.140828] [063/130] (766s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[275.440383] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[275.441495] Starting dynamic subtest: AB-VGA1-HDMI-A1
[305.786297] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.343s)
[305.789608] Subtest 2x-flip-vs-expired-vblank-interruptible: SUCCESS (30.347s)
[306.349576] [064/130] (735s left) kms_flip (plain-flip-fb-recreate-interruptible)
[306.650330] Starting subtest: plain-flip-fb-recreate-interruptible
[306.651420] Starting dynamic subtest: A-VGA1
[314.662674] Dynamic subtest A-VGA1: SUCCESS (8.011s)
[314.679903] Starting dynamic subtest: B-VGA1
[322.621034] Dynamic subtest B-VGA1: SUCCESS (7.955s)
[322.641196] Starting dynamic subtest: A-HDMI-A1
[330.628666] Dynamic subtest A-HDMI-A1: SUCCESS (8.004s)
[330.648315] Starting dynamic subtest: B-HDMI-A1
[338.662712] Dynamic subtest B-HDMI-A1: SUCCESS (8.031s)
[338.666038] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.013s)
[339.172474] [065/130] (702s left) gem_exec_fence (syncobj-repeat)
[339.375071] Starting subtest: syncobj-repeat
[339.811155] Subtest syncobj-repeat: SUCCESS (0.436s)
[340.127472] [066/130] (701s left) i915_query (query-topology-coherent-slice-mask)
[340.184695] Starting subtest: query-topology-coherent-slice-mask
[340.186830] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[340.253043] [067/130] (701s left) kms_cursor_crc (cursor-onscreen-512x512)
[340.560937] Starting subtest: cursor-onscreen-512x512
[340.563183] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[340.919715] [068/130] (700s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[341.217028] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[341.219221] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[341.568464] [069/130] (700s left) kms_plane_scaling (invalid-num-scalers)
[341.863328] Starting subtest: invalid-num-scalers
[341.865498] Subtest invalid-num-scalers: SKIP (0.002s)
[342.214700] [070/130] (699s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[342.270590] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[342.325543] [071/130] (699s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[353.828926] Subtest gem-execbuf-stress-pc8: SKIP (0.000s)
[354.027886] [072/130] (688s left) syncobj_timeline (wait-any-interrupted)
[354.084405] Starting subtest: wait-any-interrupted
[354.187212] Subtest wait-any-interrupted: SUCCESS (0.102s)
[354.264509] [073/130] (687s left) sw_sync (sync_merge_same)
[354.316847] Starting subtest: sync_merge_same
[354.317988] Subtest sync_merge_same: SUCCESS (0.000s)
[354.372412] [074/130] (687s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[354.670096] Starting subtest: psr-2p-pri-indfb-multidraw
[354.672313] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[355.008380] [075/130] (687s left) kms_hdr (bpc-switch-suspend)
[355.300089] Starting subtest: bpc-switch-suspend
[360.506622] Subtest bpc-switch-suspend: SKIP (5.204s)
[361.018463] [076/130] (681s left) api_intel_bb (blit-noreloc-keep-cache)
[361.078247] Starting subtest: blit-noreloc-keep-cache
[361.080611] Subtest blit-noreloc-keep-cache: SKIP (0.000s)
[361.150785] [077/130] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[361.446138] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[361.448272] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[361.783339] [078/130] (680s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[361.840479] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[361.919799] [079/130] (680s left) kms_chamelium_frames (hdmi-crc-fast)
[362.288174] Subtest hdmi-crc-fast: SKIP (0.000s)
[362.584468] [080/130] (679s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[362.878684] Starting subtest: primary-4-tiled-reflect-x-0
[362.880852] Subtest primary-4-tiled-reflect-x-0: SKIP (0.001s)
[363.108327] [081/130] (679s left) sw_sync (sync_merge)
[363.186877] Starting subtest: sync_merge
[363.187970] Subtest sync_merge: SUCCESS (0.001s)
[363.244471] [082/130] (679s left) gem_ctx_persistence (engines-mixed-process)
[363.300684] Subtest engines-mixed-process: SKIP (0.000s)
[363.373759] [083/130] (679s left) gem_exec_parallel (userptr)
[363.439614] Starting subtest: userptr
[363.440697] Starting dynamic subtest: rcs0
[365.022982] Dynamic subtest rcs0: SUCCESS (1.582s)
[365.041683] Starting dynamic subtest: bcs0
[366.624391] Dynamic subtest bcs0: SUCCESS (1.599s)
[366.625918] Subtest userptr: SUCCESS (3.186s)
[366.807177] [084/130] (675s left) kms_flip (absolute-wf_vblank-interruptible)
[367.110119] Starting subtest: absolute-wf_vblank-interruptible
[367.112725] Starting dynamic subtest: A-VGA1
[374.853492] Dynamic subtest A-VGA1: SUCCESS (7.742s)
[374.870393] Starting dynamic subtest: B-VGA1
[382.572216] Dynamic subtest B-VGA1: SUCCESS (7.716s)
[382.588846] Starting dynamic subtest: A-HDMI-A1
[390.462582] Dynamic subtest A-HDMI-A1: SUCCESS (7.888s)
[390.479391] Starting dynamic subtest: B-HDMI-A1
[398.385648] Dynamic subtest B-HDMI-A1: SUCCESS (7.920s)
[398.391410] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.279s)
[398.934242] [085/130] (643s left) kms_force_connector_basic (prune-stale-modes)
[399.006204] Starting subtest: prune-stale-modes
[399.024292] Subtest prune-stale-modes: SUCCESS (0.019s)
[399.433096] [086/130] (643s left) gem_ctx_persistence (processes)
[399.491120] Subtest processes: SKIP (0.000s)
[399.559708] [087/130] (643s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[399.852990] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[399.855229] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[400.199442] [088/130] (642s left) gem_exec_flush (basic-uc-ro-default)
[400.269332] Starting subtest: basic-uc-ro-default
[405.713127] Subtest basic-uc-ro-default: SUCCESS (5.447s)
[405.883403] [089/130] (637s left) kms_psr (pr-dpms)
[406.181224] Subtest pr-dpms: SKIP (0.000s)
[406.374401] [090/130] (636s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[406.675538] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[406.677815] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[407.015498] [091/130] (636s left) kms_lease (lease-invalid-crtc)
[407.306768] Starting subtest: lease-invalid-crtc
[407.307898] Starting dynamic subtest: pipe-A-HDMI-A-1
[407.308933] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[407.326238] Starting dynamic subtest: pipe-B-HDMI-A-1
[407.327201] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[407.328312] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[407.530288] [092/130] (635s left) i915_query (query-topology-unsupported)
[407.604373] Starting subtest: query-topology-unsupported
[407.605375] Subtest query-topology-unsupported: SUCCESS (0.000s)
[407.674077] [093/130] (635s left) prime_self_import (export-vs-gem_close-race)
[407.729430] Starting subtest: export-vs-gem_close-race
[412.750563] Subtest export-vs-gem_close-race: SUCCESS (5.022s)
[412.819446] [094/130] (630s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[413.119119] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[415.027603] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (1.908s)
[415.399012] [095/130] (628s left) gem_exec_reloc (basic-cpu-active)
[415.459903] Starting subtest: basic-cpu-active
[415.570333] Subtest basic-cpu-active: SUCCESS (0.110s)
[416.149088] [096/130] (627s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[416.444293] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[416.446383] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[416.782246] [097/130] (626s left) syncobj_timeline (invalid-transfer-non-existent-point)
[416.837278] Starting subtest: invalid-transfer-non-existent-point
[416.838352] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[416.900754] [098/130] (626s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[417.207871] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[417.210156] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[417.550302] [099/130] (626s left) kms_vblank (query-idle-hang)
[417.845934] Starting subtest: query-idle-hang
[417.847338] Starting dynamic subtest: pipe-A-HDMI-A-1
[424.081942] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.235s)
[424.099527] Starting dynamic subtest: pipe-B-HDMI-A-1
[430.097211] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.014s)
[430.098310] Subtest query-idle-hang: SUCCESS (12.254s)
[430.535446] [100/130] (613s left) i915_drm_fdinfo (busy-idle)
[430.595517] Subtest busy-idle: SKIP (0.000s)
[430.661409] [101/130] (613s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[430.962118] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[432.879467] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (1.918s)
[433.265590] [102/130] (610s left) kms_psr (psr-primary-mmap-cpu)
[433.561359] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[433.763159] [103/130] (610s left) kms_pm_rpm (dpms-non-lpsp)
[445.255162] Subtest dpms-non-lpsp: SKIP (0.000s)
[445.461892] [104/130] (598s left) device_reset (unbind-reset-rebind)
[445.533587] Subtest unbind-reset-rebind: SKIP (0.000s)
[445.601068] [105/130] (598s left) kms_pipe_crc_basic (read-crc)
[445.894153] Starting subtest: read-crc
[445.895327] Starting dynamic subtest: pipe-A-HDMI-A-1
[446.400010] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.505s)
[446.416693] Starting dynamic subtest: pipe-B-HDMI-A-1
[446.918507] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.515s)
[446.919600] Subtest read-crc: SUCCESS (1.025s)
[447.357691] [106/130] (596s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[447.660831] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[447.662894] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[448.005156] [107/130] (596s left) kms_async_flips (test-time-stamp)
[448.305500] Starting subtest: test-time-stamp
[448.458389] Starting dynamic subtest: pipe-A-HDMI-A-1
[448.636207] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.176s)
[448.814605] Starting dynamic subtest: pipe-B-HDMI-A-1
[448.925030] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.132s)
[448.926365] Subtest test-time-stamp: SUCCESS (0.621s)
[449.537074] [108/130] (594s left) api_intel_bb (reset-bb)
[449.594996] Starting subtest: reset-bb
[449.596323] Subtest reset-bb: SUCCESS (0.001s)
[449.704824] [109/130] (594s left) gem_exec_whisper (basic-normal-all)
[449.770066] Starting subtest: basic-normal-all
[450.792475] Subtest basic-normal-all: SUCCESS (1.021s)
[450.969417] [110/130] (593s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[451.263605] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[451.467525] [111/130] (592s left) fbdev (eof)
[451.535864] Starting subtest: eof
[451.536979] Subtest eof: SUCCESS (0.000s)
[451.600207] [112/130] (592s left) kms_psr (pr-cursor-blt)
[451.896463] Subtest pr-cursor-blt: SKIP (0.000s)
[452.100259] [113/130] (592s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[452.163510] Starting subtest: y-tiled-to-vebox-yf-tiled
[452.166097] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[452.341766] [114/130] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[452.643340] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[452.645456] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[452.987663] [115/130] (591s left) kms_plane (pixel-format-source-clamping)
[453.281156] Starting subtest: pixel-format-source-clamping
[453.317465] Starting dynamic subtest: pipe-A-plane-0
[455.649485] Dynamic subtest pipe-A-plane-0: SUCCESS (2.332s)
[455.668602] Starting dynamic subtest: pipe-A-plane-1
[456.716181] Dynamic subtest pipe-A-plane-1: SUCCESS (1.064s)
[456.735731] Starting dynamic subtest: pipe-A-plane-2
[456.737025] Dynamic subtest pipe-A-plane-2: SUCCESS (0.000s)
[456.966534] Starting dynamic subtest: pipe-B-plane-0
[459.253390] Dynamic subtest pipe-B-plane-0: SUCCESS (2.315s)
[459.274143] Starting dynamic subtest: pipe-B-plane-1
[460.319969] Dynamic subtest pipe-B-plane-1: SUCCESS (1.064s)
[460.340076] Starting dynamic subtest: pipe-B-plane-2
[460.341265] Dynamic subtest pipe-B-plane-2: SUCCESS (0.000s)
[460.409381] Subtest pixel-format-source-clamping: SUCCESS (7.128s)
[460.872521] [116/130] (583s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[461.176098] Starting subtest: 4-tiled-addfb-size-offset-overflow
[461.178320] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[461.528876] [117/130] (583s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[461.585026] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (0.000s)
[461.660492] [118/130] (583s left) gem_mmap_offset (oob-read)
[461.715188] Starting subtest: oob-read
[461.716231] Subtest oob-read: SUCCESS (0.001s)
[461.797799] [119/130] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[462.103283] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[462.105329] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[462.447603] [120/130] (582s left) kms_chamelium_color (ctm-blue-to-red)
[462.740633] Subtest ctm-blue-to-red: SKIP (0.000s)
[462.944485] [121/130] (581s left) gem_eio (wait-immediate)
[463.010188] Starting subtest: wait-immediate
[463.039252] Subtest wait-immediate: SUCCESS (0.028s)
[463.631368] [122/130] (581s left) gem_exec_suspend (basic-s3-devices)
[463.696457] Starting subtest: basic-S3-devices
[463.697586] Starting dynamic subtest: smem
[469.967575] Dynamic subtest smem: SUCCESS (6.270s)
[469.970355] Subtest basic-S3-devices: SUCCESS (6.272s)
[478.151926] [123/130] (574s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[478.210668] Starting subtest: invalid-multi-wait-unsubmitted
[478.211916] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[478.274637] [124/130] (574s left) gem_exec_balancer (full-late-pulse)
[478.333366] Subtest full-late-pulse: SKIP (0.000s)
[478.396466] [125/130] (574s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[478.694247] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[478.696380] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[479.046723] [126/130] (574s left) syncobj_wait (single-wait-for-submit-submitted)
[479.105086] Starting subtest: single-wait-for-submit-submitted
[479.213209] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[479.274660] [127/130] (573s left) gem_exec_schedule (semaphore-resolve)
[479.344826] Subtest semaphore-resolve: SKIP (0.000s)
[479.510664] [128/130] (573s left) syncobj_basic (bad-pad-handle-to-fd)
[479.565968] Starting subtest: bad-pad-handle-to-fd
[479.567072] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[479.630868] [129/130] (573s left) gen7_exec_parse (chained-batch)
[479.688271] Subtest chained-batch: SKIP (0.000s)
[479.752670] [130/130] (573s left) kms_cursor_crc (cursor-onscreen-256x256)
[480.056311] Starting subtest: cursor-onscreen-256x256
[480.057410] Starting dynamic subtest: pipe-A-HDMI-A-1
[482.276631] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.219s)
[482.320772] Starting dynamic subtest: pipe-B-HDMI-A-1
[484.522549] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.216s)
[484.523645] Subtest cursor-onscreen-256x256: SUCCESS (4.468s)
[484.961813] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: i915_getparams_basic
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_getfb
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_create
results: parsing output: 8/ for test: gem_exec_nop
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_workarounds
results: parsing output: 14/ for test: gem_basic
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gen7_exec_parse
results: parsing output: 17/ for test: prime_busy
results: parsing output: 18/ for test: i915_query
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_psr2_su
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_color
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: kms_pm_backlight
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: gem_ppgtt
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: gem_exec_alignment
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: gem_pwrite
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_fb_coherency
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: i915_query
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_pipe_b_c_ivb
results: parsing output: 70/ for test: i915_pm_rpm
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_hdr
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_chamelium_frames
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: gem_exec_parallel
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_force_connector_basic
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: prime_self_import
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: device_reset
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_async_flips
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: gem_mmap_offset
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_chamelium_color
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gem_exec_suspend
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: syncobj_basic
results: parsing output: 128/ for test: gen7_exec_parse
results: parsing output: 129/ for test: kms_cursor_crc
Done.