[86.916188] Initializing watchdogs
[86.916405]   /dev/watchdog0
[86.956343] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[86.970217] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[86.976737] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[86.981808] [001/132] (960s left) gem_exec_params (invalid-flag)
[87.109133] Starting subtest: invalid-flag
[87.110198] Subtest invalid-flag: SUCCESS (0.001s)
[87.265396] [002/132] (960s left) gem_exec_fence (syncobj-timeline-unused-fence)
[87.986736] Starting subtest: syncobj-timeline-unused-fence
[87.991490] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[88.272507] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[88.276270] [003/132] (959s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[88.374161] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[88.376408] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.002s)
[88.522129] [004/132] (959s left) gem_exec_flush (basic-uc-prw-default)
[88.639248] Starting subtest: basic-uc-prw-default
[94.086523] Subtest basic-uc-prw-default: SUCCESS (5.448s)
[94.343360] [005/132] (953s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[94.446649] Starting subtest: multi-wait-available-submitted-signaled
[94.447587] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.002s)
[94.571810] [006/132] (953s left) kms_cursor_legacy (torture-move)
[94.743627] Starting subtest: torture-move
[94.746194] Starting dynamic subtest: pipe-A
[100.259043] Dynamic subtest pipe-A: SUCCESS (5.519s)
[100.286419] Starting dynamic subtest: pipe-B
[105.779063] Dynamic subtest pipe-B: SUCCESS (5.520s)
[105.795920] Starting dynamic subtest: pipe-C
[111.303999] Dynamic subtest pipe-C: SUCCESS (5.523s)
[111.322921] Starting dynamic subtest: all-pipes
[116.814725] Dynamic subtest all-pipes: SUCCESS (5.510s)
[116.817457] Subtest torture-move: SUCCESS (22.077s)
[116.971308] [007/132] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[117.153747] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[117.155541] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[117.301730] [008/132] (930s left) kms_big_fb (linear-32bpp-rotate-90)
[117.491585] Starting subtest: linear-32bpp-rotate-90
[117.972803] Subtest linear-32bpp-rotate-90: SKIP (0.480s)
[118.205692] [009/132] (929s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[118.374597] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[118.375606] Starting dynamic subtest: pipe-A-HDMI-A-1
[118.384135] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[118.400316] Starting dynamic subtest: pipe-A-HDMI-A-2
[118.408641] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[118.424986] Starting dynamic subtest: pipe-B-HDMI-A-1
[118.433570] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[118.449839] Starting dynamic subtest: pipe-B-HDMI-A-2
[118.458919] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[118.475330] Starting dynamic subtest: pipe-C-HDMI-A-1
[118.483942] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[118.500208] Starting dynamic subtest: pipe-C-HDMI-A-2
[118.508381] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[118.510107] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.028s)
[119.261747] [010/132] (928s left) kms_psr (psr2-primary-mmap-gtt)
[119.434240] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[119.535201] [011/132] (928s left) gem_exec_schedule (u-semaphore-resolve)
[119.661254] Starting subtest: u-semaphore-resolve
[119.707106] Subtest u-semaphore-resolve: SUCCESS (0.046s)
[120.113720] [012/132] (928s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[120.224239] Starting subtest: y-tiled-to-vebox-x-tiled
[120.226278] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[120.462145] [013/132] (928s left) gem_eio (in-flight-internal-immediate)
[120.582925] Starting subtest: in-flight-internal-immediate
[120.662505] Subtest in-flight-internal-immediate: SUCCESS (0.080s)
[120.877365] [014/132] (927s left) gem_exec_whisper (basic-sync)
[120.993839] Starting subtest: basic-sync
[127.629849] Subtest basic-sync: SUCCESS (6.635s)
[127.881890] [015/132] (920s left) syncobj_eventfd (invalid-bad-flags)
[127.980939] Starting subtest: invalid-bad-flags
[127.981991] Subtest invalid-bad-flags: SUCCESS (0.000s)
[128.115685] [016/132] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[128.298949] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[131.176698] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.877s)
[131.463985] [017/132] (917s left) gem_mmap (big-bo)
[131.556883] Starting subtest: big-bo
[133.287063] Subtest big-bo: SUCCESS (1.729s)
[133.427089] [018/132] (915s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[133.722020] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[133.724866] Starting dynamic subtest: pipe-A-HDMI-A-1
[133.758823] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.010s)
[133.778339] Starting dynamic subtest: pipe-A-HDMI-A-2
[133.812160] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.010s)
[133.833255] Starting dynamic subtest: pipe-B-HDMI-A-1
[133.867704] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.010s)
[133.888687] Starting dynamic subtest: pipe-B-HDMI-A-2
[133.921301] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.010s)
[133.941155] Starting dynamic subtest: pipe-C-HDMI-A-1
[133.975714] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.010s)
[133.994943] Starting dynamic subtest: pipe-C-HDMI-A-2
[134.028993] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.010s)
[134.030771] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.077s)
[134.700105] [019/132] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[134.882883] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[134.886593] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[135.050890] [020/132] (914s left) kms_plane (planar-pixel-format-settings)
[135.216179] Starting subtest: planar-pixel-format-settings
[135.503196] Subtest planar-pixel-format-settings: SUCCESS (0.289s)
[135.736276] [021/132] (913s left) gem_workarounds (suspend-resume-context)
[135.865267] Starting subtest: suspend-resume-context
[154.512806] Subtest suspend-resume-context: SUCCESS (1.671s)
[161.626552] [022/132] (894s left) gem_mmap_wc (write-wc-read-gtt)
[161.733028] Starting subtest: write-wc-read-gtt
[162.245121] Subtest write-wc-read-gtt: SUCCESS (0.509s)
[162.405383] [023/132] (894s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[162.599798] Starting subtest: 4-tiled-16bpp-rotate-0
[162.603241] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[162.752518] [024/132] (893s left) kms_frontbuffer_tracking (fbc-1p-rte)
[162.927957] Starting subtest: fbc-1p-rte
[166.543362] Subtest fbc-1p-rte: SUCCESS (3.610s)
[166.848351] [025/132] (889s left) gem_exec_schedule (u-submit-golden-slice)
[166.981554] Starting subtest: u-submit-golden-slice
[166.982557] Starting dynamic subtest: rcs0
[167.031192] Dynamic subtest rcs0: SUCCESS (0.050s)
[167.059631] Starting dynamic subtest: bcs0
[167.074005] Dynamic subtest bcs0: SUCCESS (0.043s)
[167.103251] Starting dynamic subtest: vcs0
[167.119907] Dynamic subtest vcs0: SUCCESS (0.042s)
[167.147496] Starting dynamic subtest: vecs0
[167.158525] Dynamic subtest vecs0: SUCCESS (0.041s)
[167.160081] Subtest u-submit-golden-slice: SUCCESS (0.179s)
[167.569439] [026/132] (889s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[167.733795] Starting subtest: primary-4-tiled-reflect-x-0
[167.739796] Subtest primary-4-tiled-reflect-x-0: SKIP (0.003s)
[167.869531] [027/132] (888s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[168.038618] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[168.143618] [028/132] (888s left) core_getversion (all-cards)
[168.235026] Starting subtest: all-cards
[168.273892] Subtest all-cards: SUCCESS (0.042s)
[168.369592] [029/132] (888s left) perf (unprivileged-single-ctx-counters)
[168.613123] Starting subtest: unprivileged-single-ctx-counters
[168.615605] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[168.718665] [030/132] (888s left) gem_exec_balancer (smoke)
[168.831499] Starting subtest: smoke
[173.002693] Subtest smoke: SUCCESS (4.168s)
[173.290607] [031/132] (883s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[173.478042] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[173.479909] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[173.639946] [032/132] (883s left) i915_drm_fdinfo (idle)
[173.743535] Starting subtest: idle
[173.744476] Starting dynamic subtest: rcs0
[174.251142] Dynamic subtest rcs0: SUCCESS (0.508s)
[174.273716] Starting dynamic subtest: bcs0
[174.760064] Dynamic subtest bcs0: SUCCESS (0.507s)
[174.782139] Starting dynamic subtest: vcs0
[175.268211] Dynamic subtest vcs0: SUCCESS (0.507s)
[175.290679] Starting dynamic subtest: vecs0
[175.777501] Dynamic subtest vecs0: SUCCESS (0.507s)
[175.778700] Subtest idle: SUCCESS (2.033s)
[175.926010] [033/132] (881s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[176.110814] Starting subtest: yf-tiled-16bpp-rotate-180
[179.685731] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (3.572s)
[180.109419] [034/132] (877s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[180.221293] Starting subtest: yf-tiled-ccs-to-yf-tiled
[180.222601] Starting dynamic subtest: smem
[180.594520] Dynamic subtest smem: SUCCESS (0.374s)
[180.595579] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.375s)
[180.847973] [035/132] (876s left) kms_chamelium_color (ctm-0-50)
[181.014870] Subtest ctm-0-50: SKIP (0.000s)
[181.116396] [036/132] (876s left) gem_exec_reloc (basic-wc-active)
[181.219469] Starting subtest: basic-wc-active
[181.358689] Subtest basic-wc-active: SUCCESS (0.139s)
[181.575582] [037/132] (876s left) kms_chamelium_frames (hdmi-frame-dump)
[182.106330] Subtest hdmi-frame-dump: SKIP (0.000s)
[182.356984] [038/132] (875s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[182.535332] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[186.093405] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SUCCESS (3.553s)
[186.362691] [039/132] (871s left) gem_ctx_bad_destroy (invalid-pad)
[186.455597] Starting subtest: invalid-pad
[186.456629] Subtest invalid-pad: SUCCESS (0.000s)
[186.598696] [040/132] (871s left) gem_reg_read (timestamp-moving)
[186.696994] Starting subtest: timestamp-moving
[187.698022] Subtest timestamp-moving: SUCCESS (1.001s)
[187.831975] [041/132] (870s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[188.001387] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[188.104988] [042/132] (870s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[188.267578] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[188.271098] Starting dynamic subtest: pipe-A-valid-mode
[189.195961] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.925s)
[189.197292] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SUCCESS (0.928s)
[189.506870] [043/132] (868s left) gem_ctx_param (root-set)
[189.601061] Starting subtest: root-set
[189.602049] Subtest root-set: SUCCESS (0.000s)
[189.744693] [044/132] (868s left) kms_properties (crtc-properties-atomic)
[189.916291] Starting subtest: crtc-properties-atomic
[189.918302] Starting dynamic subtest: pipe-A-HDMI-A-1
[190.470790] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.555s)
[190.497445] Starting dynamic subtest: pipe-B-HDMI-A-2
[190.893945] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.420s)
[190.921979] Starting dynamic subtest: pipe-C-HDMI-A-1
[191.326221] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.429s)
[191.327395] Subtest crtc-properties-atomic: SUCCESS (1.413s)
[191.646313] [045/132] (866s left) gem_watchdog (default-physical)
[191.757857] Starting subtest: default-physical
[192.775983] Subtest default-physical: SUCCESS (1.018s)
[192.911347] [046/132] (865s left) perf_pmu (most-busy-idle-check-all)
[193.014624] Starting subtest: most-busy-idle-check-all
[193.015661] Starting dynamic subtest: rcs0
[193.644953] Dynamic subtest rcs0: SUCCESS (0.632s)
[193.674255] Starting dynamic subtest: bcs0
[194.275068] Dynamic subtest bcs0: SUCCESS (0.628s)
[194.303339] Starting dynamic subtest: vcs0
[194.899338] Dynamic subtest vcs0: SUCCESS (0.623s)
[194.928293] Starting dynamic subtest: vecs0
[195.532179] Dynamic subtest vecs0: SUCCESS (0.631s)
[195.535524] Subtest most-busy-idle-check-all: SUCCESS (2.521s)
[195.686675] [047/132] (862s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[196.208262] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[196.448807] [048/132] (862s left) gem_ctx_sseu (mmap-args)
[196.551842] Subtest mmap-args: SKIP (0.000s)
[196.660835] [049/132] (862s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[196.838826] Starting subtest: fbcpsr-indfb-scaledprimary
[196.840769] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[197.003776] [050/132] (861s left) kms_sequence (queue-busy)
[197.173985] Starting subtest: queue-busy
[197.174934] Starting dynamic subtest: pipe-A-HDMI-A-1
[200.044387] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.869s)
[200.070323] Starting dynamic subtest: pipe-A-HDMI-A-2
[202.647433] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.597s)
[202.672458] Starting dynamic subtest: pipe-B-HDMI-A-1
[205.221730] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.571s)
[205.245941] Starting dynamic subtest: pipe-B-HDMI-A-2
[207.797704] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.573s)
[207.823378] Starting dynamic subtest: pipe-C-HDMI-A-1
[210.381204] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.580s)
[210.406987] Starting dynamic subtest: pipe-C-HDMI-A-2
[212.966428] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.578s)
[212.967303] Subtest queue-busy: SUCCESS (15.789s)
[213.236339] [051/132] (845s left) prime_busy (hang-wait)
[213.339166] Starting subtest: hang-wait
[213.341687] Starting dynamic subtest: rcs0
[220.599016] Dynamic subtest rcs0: SUCCESS (7.253s)
[220.621836] Starting dynamic subtest: bcs0
[227.569312] Dynamic subtest bcs0: SUCCESS (6.970s)
[227.592715] Starting dynamic subtest: vcs0
[234.609711] Dynamic subtest vcs0: SUCCESS (7.035s)
[234.633479] Starting dynamic subtest: vecs0
[241.585508] Dynamic subtest vecs0: SUCCESS (6.971s)
[241.586472] Subtest hang-wait: SUCCESS (28.240s)
[241.724900] [052/132] (817s left) syncobj_wait (multi-wait-submitted)
[241.823551] Starting subtest: multi-wait-submitted
[241.926076] Subtest multi-wait-submitted: SUCCESS (0.102s)
[242.061002] [053/132] (817s left) api_intel_allocator (open-vm)
[242.155989] Starting subtest: open-vm
[242.159354] Subtest open-vm: SUCCESS (0.004s)
[242.325687] [054/132] (816s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[242.506796] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[242.509020] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[242.658636] [055/132] (816s left) i915_suspend (forcewake)
[242.756598] Starting subtest: forcewake