[91.473160] Initializing watchdogs
[91.473343]   /dev/watchdog0
[91.513664] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[91.529168] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.536379] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.544510] [001/132] (960s left) gem_exec_reloc (basic-write-read-active)
[91.698497] Starting subtest: basic-write-read-active
[91.844417] Subtest basic-write-read-active: SUCCESS (0.146s)
[92.094945] [002/132] (960s left) kms_cdclk (mode-transition)
[92.217108] Subtest mode-transition: SKIP (0.000s)
[92.319971] [003/132] (959s left) kms_color (invalid-ctm-matrix-sizes)
[92.508077] Starting subtest: invalid-ctm-matrix-sizes
[92.512049] Starting dynamic subtest: pipe-A
[92.524086] Dynamic subtest pipe-A: SUCCESS (0.012s)
[92.557844] Starting dynamic subtest: pipe-B
[92.562156] Dynamic subtest pipe-B: SUCCESS (0.013s)
[92.583156] Starting dynamic subtest: pipe-C
[92.588094] Dynamic subtest pipe-C: SUCCESS (0.017s)
[92.591661] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.044s)
[92.704119] [004/132] (959s left) gem_reg_read (timestamp-monotonic)
[92.821391] Starting subtest: timestamp-monotonic
[97.278242] Subtest timestamp-monotonic: SUCCESS (4.460s)
[97.412666] [005/132] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[97.630078] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[97.638297] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[97.767367] [006/132] (954s left) i915_drm_fdinfo (busy-check-all)
[97.931740] Starting subtest: busy-check-all
[97.936403] Starting dynamic subtest: rcs0
[98.464308] Dynamic subtest rcs0: SUCCESS (0.528s)
[98.483229] Starting dynamic subtest: bcs0
[98.992929] Dynamic subtest bcs0: SUCCESS (0.533s)
[99.014087] Starting dynamic subtest: vcs0
[99.524056] Dynamic subtest vcs0: SUCCESS (0.529s)
[99.546379] Starting dynamic subtest: vecs0
[100.057692] Dynamic subtest vecs0: SUCCESS (0.530s)
[100.062527] Subtest busy-check-all: SUCCESS (2.123s)
[100.198296] [007/132] (952s left) i915_pm_freq_mult (media-freq)
[100.328274] Starting subtest: media-freq
[100.333323] Starting dynamic subtest: gt0
[100.344740] Dynamic subtest gt0: SKIP (0.000s)
[100.353536] Subtest media-freq: SKIP (0.001s)
[100.477987] [008/132] (952s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[100.603590] Starting subtest: y-tiled-to-vebox-y-tiled
[100.611729] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[100.863710] [009/132] (951s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[101.044076] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[101.051271] Starting dynamic subtest: pipe-A-valid-mode
[102.114857] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.066s)
[102.118546] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SUCCESS (1.070s)
[102.470253] [010/132] (950s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[102.681294] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[102.686114] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[105.173889] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.489s)
[105.202166] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[107.204267] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (2.023s)
[107.223368] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[109.306246] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.989s)
[109.371464] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (6.516s)
[109.931941] [011/132] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[110.497615] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[110.506392] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[110.594960] [012/132] (942s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[111.238043] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[111.528518] [013/132] (942s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[111.760295] Starting subtest: 4-tiled-64bpp-rotate-0
[111.767580] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[111.911139] [014/132] (941s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[112.027456] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[112.138148] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.111s)
[112.298644] [015/132] (941s left) gem_exec_suspend (basic-s4-devices)
[112.436048] Starting subtest: basic-S4-devices
[112.441169] Starting dynamic subtest: smem
[124.060335] Dynamic subtest smem: SUCCESS (11.626s)
[124.064979] Subtest basic-S4-devices: SUCCESS (11.627s)
[130.348366] [016/132] (929s left) kms_psr (psr-sprite-render)
[130.550255] Subtest psr-sprite-render: SKIP (0.000s)
[130.657509] [017/132] (929s left) perf (whitelisted-registers-userspace-config)
[130.913597] Starting subtest: whitelisted-registers-userspace-config
[130.917213] Subtest whitelisted-registers-userspace-config: SUCCESS (0.003s)
[131.021467] [018/132] (929s left) kms_legacy_colorkey (basic)
[131.224664] Starting subtest: basic
[131.227547] Starting dynamic subtest: pipe-A
[131.261190] Dynamic subtest pipe-A: SUCCESS (0.038s)
[131.282514] Starting dynamic subtest: pipe-B
[131.298096] Dynamic subtest pipe-B: SUCCESS (0.035s)
[131.323564] Starting dynamic subtest: pipe-C
[131.326597] Dynamic subtest pipe-C: SUCCESS (0.001s)
[131.331280] Subtest basic: SUCCESS (0.078s)
[131.455698] [019/132] (928s left) kms_content_protection (suspend-resume)
[131.662212] Starting subtest: suspend-resume
[131.678184] Subtest suspend-resume: SKIP (0.011s)
[131.825742] [020/132] (928s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[132.028580] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[132.038455] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[132.782665] [021/132] (927s left) dmabuf_sync_file (import-multiple-read-only)
[133.000885] Starting subtest: import-multiple-read-only
[133.008526] Subtest import-multiple-read-only: SUCCESS (0.015s)
[133.134889] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[133.141963] [022/132] (927s left) gem_vm_create (execbuf)
[133.261812] Starting subtest: execbuf
[133.276125] Subtest execbuf: SUCCESS (0.009s)
[133.439493] [023/132] (927s left) kms_flip (nonexisting-fb)
[133.641070] Starting subtest: nonexisting-fb
[133.645084] Starting dynamic subtest: A-HDMI-A1
[134.317229] Dynamic subtest A-HDMI-A1: SUCCESS (0.680s)
[134.360098] Starting dynamic subtest: B-HDMI-A1
[134.769387] Dynamic subtest B-HDMI-A1: SUCCESS (0.445s)
[134.812926] Starting dynamic subtest: C-HDMI-A1
[135.195764] Dynamic subtest C-HDMI-A1: SUCCESS (0.428s)
[135.224044] Starting dynamic subtest: A-HDMI-A2
[135.644927] Dynamic subtest A-HDMI-A2: SUCCESS (0.440s)
[135.680275] Starting dynamic subtest: B-HDMI-A2
[136.081395] Dynamic subtest B-HDMI-A2: SUCCESS (0.437s)
[136.120805] Starting dynamic subtest: C-HDMI-A2
[136.487087] Dynamic subtest C-HDMI-A2: SUCCESS (0.399s)
[136.491170] Subtest nonexisting-fb: SUCCESS (2.852s)
[136.991769] [024/132] (923s left) gem_mmap_offset (perf)
[137.117750] Starting subtest: perf
[137.120886] Starting dynamic subtest: smem0
[137.398267] Dynamic subtest smem0: SUCCESS (0.283s)
[137.401871] Subtest perf: SUCCESS (0.285s)
[137.558559] [025/132] (923s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[137.744111] Starting subtest: coverage-vs-premult-vs-constant
[137.901064] Starting dynamic subtest: pipe-A-HDMI-A-1
[138.674355] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.771s)
[138.718430] Starting dynamic subtest: pipe-C-HDMI-A-1
[139.344318] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.668s)
[139.348151] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.603s)
[139.720731] [026/132] (921s left) gem_pread (self)
[139.842405] Starting subtest: self
[139.853180] Subtest self: SUCCESS (0.017s)
[140.016428] [027/132] (920s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[140.226879] Starting subtest: yf-tiled-16bpp-rotate-270
[140.563099] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.335s)
[140.866082] [028/132] (920s left) kms_big_fb (linear-64bpp-rotate-270)
[141.093266] Starting subtest: linear-64bpp-rotate-270
[141.460150] Subtest linear-64bpp-rotate-270: SKIP (0.363s)
[141.755738] [029/132] (919s left) kms_vblank (wait-forked-busy-hang)
[141.963488] Starting subtest: wait-forked-busy-hang
[141.966955] Starting dynamic subtest: pipe-A-HDMI-A-1
[149.873166] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.905s)
[149.919423] Starting dynamic subtest: pipe-A-HDMI-A-2
[156.904474] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.029s)
[156.942522] Starting dynamic subtest: pipe-C-HDMI-A-1
[163.865729] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.948s)
[163.913566] Starting dynamic subtest: pipe-C-HDMI-A-2
[170.898680] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.026s)
[170.905644] Subtest wait-forked-busy-hang: SUCCESS (28.939s)
[171.228373] [030/132] (890s left) gem_exec_schedule (submit-golden-slice)
[171.384510] Starting subtest: submit-golden-slice
[171.388407] Starting dynamic subtest: rcs0
[171.438626] Dynamic subtest rcs0: SUCCESS (0.054s)
[171.468560] Starting dynamic subtest: bcs0
[171.486368] Dynamic subtest bcs0: SUCCESS (0.046s)
[171.514939] Starting dynamic subtest: vcs0
[171.550120] Dynamic subtest vcs0: SUCCESS (0.057s)
[171.575946] Starting dynamic subtest: vecs0
[171.594057] Dynamic subtest vecs0: SUCCESS (0.043s)
[171.598774] Subtest submit-golden-slice: SUCCESS (0.213s)
[172.003716] [031/132] (889s left) kms_prop_blob (invalid-get-prop-any)
[172.120586] Starting subtest: invalid-get-prop-any
[172.123909] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[172.275252] [032/132] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[172.496959] Starting subtest: psr-1p-primscrn-spr-indfb-move
[172.503731] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[172.657463] [033/132] (888s left) kms_chamelium_edid (dp-mode-timings)
[173.268130] Subtest dp-mode-timings: SKIP (0.000s)
[173.626817] [034/132] (888s left) gem_mmap_wc (coherency)
[173.743161] Starting subtest: coherency
[173.821068] Subtest coherency: SUCCESS (0.077s)
[173.972851] [035/132] (887s left) gem_mmap_gtt (cpuset-big-copy)
[174.083374] Starting subtest: cpuset-big-copy
[190.449246] Subtest cpuset-big-copy: SUCCESS (16.368s)
[190.646481] [036/132] (871s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[191.029289] Starting subtest: y-tiled-16bpp-rotate-180
[195.333340] Subtest y-tiled-16bpp-rotate-180: SUCCESS (4.306s)
[195.735869] [037/132] (866s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[195.935215] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[195.939097] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[206.967918] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.034s)
[207.001334] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[218.075662] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.103s)
[218.099643] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[229.086063] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.997s)
[229.093066] Subtest 2x-flip-vs-blocking-wf-vblank: SUCCESS (33.151s)
[229.761648] [038/132] (832s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[229.983818] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[229.999408] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[230.143275] [039/132] (832s left) kms_pm_rpm (system-suspend-idle)
[231.973084] Starting subtest: system-suspend-idle
[249.423337] Subtest system-suspend-idle: SUCCESS (2.091s)
[255.885603] [040/132] (812s left) sw_sync (alloc_timeline)
[256.016162] Starting subtest: alloc_timeline
[256.020364] Subtest alloc_timeline: SUCCESS (0.000s)
[256.167111] [041/132] (812s left) kms_invalid_mode (bad-vsync-end)
[256.359261] Starting subtest: bad-vsync-end
[256.367387] Starting dynamic subtest: pipe-A-HDMI-A-1
[256.798151] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.452s)
[256.850786] Starting dynamic subtest: pipe-A-HDMI-A-2
[256.858162] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[256.908019] Starting dynamic subtest: pipe-B-HDMI-A-1
[256.913844] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[256.956738] Starting dynamic subtest: pipe-B-HDMI-A-2
[256.960069] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[256.984400] Starting dynamic subtest: pipe-C-HDMI-A-1
[256.987576] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[257.019148] Starting dynamic subtest: pipe-C-HDMI-A-2
[257.023029] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[257.027048] Subtest bad-vsync-end: SUCCESS (0.493s)
[257.154185] [042/132] (811s left) gem_ctx_param (invalid-get-ringsize)
[257.268908] Starting subtest: invalid-get-ringsize
[257.272346] Subtest invalid-get-ringsize: SUCCESS (0.000s)
[257.420754] [043/132] (811s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[257.614110] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[257.727123] [044/132] (811s left) kms_cursor_edge_walk (128x128-top-edge)
[257.919061] Starting subtest: 128x128-top-edge
[257.922113] Starting dynamic subtest: pipe-A-HDMI-A-1
[261.799254] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.969s)
[261.827530] Starting dynamic subtest: pipe-C-HDMI-A-1
[265.223085] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.473s)
[265.226938] Subtest 128x128-top-edge: SUCCESS (7.455s)
[265.593120] [045/132] (803s left) gem_create (create-size-update)
[265.711124] Starting subtest: create-size-update
[265.714648] Subtest create-size-update: SUCCESS (0.000s)
[265.983916] [046/132] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[266.189604] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[266.196576] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[266.375343] [047/132] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[266.585971] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[266.593196] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[266.773078] [048/132] (802s left) kms_plane_lowres (tiling-x)
[266.968244] Starting subtest: tiling-x
[266.971766] Starting dynamic subtest: pipe-A-HDMI-A-1
[274.905975] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.988s)
[275.248120] Starting dynamic subtest: pipe-A-HDMI-A-2
[282.834881] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.656s)
[283.165468] Starting dynamic subtest: pipe-B-HDMI-A-1
[290.506022] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (7.389s)
[290.810021] Starting dynamic subtest: pipe-B-HDMI-A-2
[298.357519] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (7.589s)
[298.675015] Starting dynamic subtest: pipe-C-HDMI-A-1
[306.116273] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.488s)
[306.434823] Starting dynamic subtest: pipe-C-HDMI-A-2
[313.689455] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.304s)
[313.968484] Subtest tiling-x: SUCCESS (47.066s)
[314.436240] [049/132] (754s left) api_intel_allocator (alloc-simple)
[314.567276] Starting subtest: alloc-simple
[314.573699] Subtest alloc-simple: SUCCESS (0.005s)
[314.743411] [050/132] (754s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[314.964034] Starting subtest: fbc-indfb-scaledprimary
[318.517235] Subtest fbc-indfb-scaledprimary: SUCCESS (3.559s)
[318.839893] [051/132] (750s left) syncobj_wait (reset-signaled)
[318.955608] Starting subtest: reset-signaled
[318.959455] Subtest reset-signaled: SUCCESS (0.001s)
[319.107297] [052/132] (750s left) i915_query (query-topology-kernel-writes)
[319.225523] Starting subtest: query-topology-kernel-writes
[319.228761] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[319.386485] [053/132] (750s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[319.594626] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[319.603288] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[321.381444] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.778s)
[321.413998] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[323.119229] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.731s)
[323.150512] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[324.885787] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.759s)
[324.891877] Subtest 2x-flip-vs-wf_vblank-interruptible: SUCCESS (5.293s)
[325.555140] [054/132] (744s left) perf_pmu (pmu-read)
[325.687056] Starting subtest: pmu-read
[325.697999] Subtest pmu-read: SUCCESS (0.012s)
[325.854765] [055/132] (744s left) gem_exec_whisper (basic-sync)
[326.002470] Starting subtest: basic-sync
[332.148648] Subtest basic-sync: SUCCESS (6.143s)
[332.419500] [056/132] (737s left) gem_userptr_blits (unsync-unmap-cycles)
[332.559218] Subtest unsync-unmap-cycles: SKIP (0.000s)
[332.757023] [057/132] (737s left) syncobj_timeline (wait-any-interrupted)
[332.871550] Starting subtest: wait-any-interrupted
[332.979212] Subtest wait-any-interrupted: SUCCESS (0.110s)
[333.137092] [058/132] (737s left) core_getstats (basic)
[333.253166] Starting subtest: basic
[333.257418] Subtest basic: SUCCESS (0.000s)
[333.416043] [059/132] (737s left) kms_cursor_crc (cursor-random-128x128)
[333.614317] Starting subtest: cursor-random-128x128
[333.667052] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.849092] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.182s)
[337.984065] Starting dynamic subtest: pipe-C-HDMI-A-1
[341.791643] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.866s)
[341.796050] Subtest cursor-random-128x128: SUCCESS (8.184s)
[342.189520] [060/132] (728s left) gem_userptr_blits (coherency-unsync)
[342.340014] Subtest coherency-unsync: SKIP (0.000s)
[342.568185] [061/132] (728s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[342.767053] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[342.772055] Starting dynamic subtest: pipe-A-HDMI-A-1