[91.783097] Initializing watchdogs
[91.783281]   /dev/watchdog0
[91.823972] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[91.838922] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.846154] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.853884] [001/131] (960s left) kms_async_flips (alternate-sync-async-flip)
[92.062239] Starting subtest: alternate-sync-async-flip
[92.653477] Starting dynamic subtest: pipe-A-HDMI-A-1
[94.835536] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.180s)
[95.197920] Starting dynamic subtest: pipe-A-HDMI-A-2
[97.375076] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.194s)
[97.729341] Starting dynamic subtest: pipe-B-HDMI-A-1
[99.880048] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.166s)
[100.223219] Starting dynamic subtest: pipe-B-HDMI-A-2
[102.435570] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.237s)
[102.774897] Starting dynamic subtest: pipe-C-HDMI-A-1
[104.928652] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.173s)
[105.292192] Starting dynamic subtest: pipe-C-HDMI-A-2
[107.459070] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.197s)
[107.463970] Subtest alternate-sync-async-flip: SUCCESS (15.396s)
[108.082621] [002/131] (944s left) i915_pm_freq_api (freq-suspend)
[108.218766] Subtest freq-suspend: SKIP (0.000s)
[108.328288] [003/131] (944s left) kms_cursor_crc (cursor-offscreen-128x128)
[108.520581] Starting subtest: cursor-offscreen-128x128
[108.562085] Starting dynamic subtest: pipe-A-HDMI-A-1
[111.486688] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.921s)
[111.600066] Starting dynamic subtest: pipe-C-HDMI-A-1
[114.135726] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.563s)
[114.141090] Subtest cursor-offscreen-128x128: SUCCESS (5.616s)
[114.503454] [004/131] (938s left) kms_plane (pixel-format-x-tiled-modifier)
[114.684707] Starting subtest: pixel-format-x-tiled-modifier
[114.898479] Starting dynamic subtest: pipe-A-plane-0
[115.597733] Dynamic subtest pipe-A-plane-0: SUCCESS (0.700s)
[115.617234] Starting dynamic subtest: pipe-A-plane-1
[116.282555] Dynamic subtest pipe-A-plane-1: SUCCESS (0.683s)
[116.301640] Starting dynamic subtest: pipe-A-plane-2
[116.764679] Dynamic subtest pipe-A-plane-2: SUCCESS (0.481s)
[116.783499] Starting dynamic subtest: pipe-A-plane-3
[117.247276] Dynamic subtest pipe-A-plane-3: SUCCESS (0.483s)
[117.270654] Starting dynamic subtest: pipe-A-plane-4
[117.280549] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[117.618104] Starting dynamic subtest: pipe-B-plane-0
[118.257435] Dynamic subtest pipe-B-plane-0: SUCCESS (0.650s)
[118.277279] Starting dynamic subtest: pipe-B-plane-1
[118.952457] Dynamic subtest pipe-B-plane-1: SUCCESS (0.699s)
[118.972504] Starting dynamic subtest: pipe-B-plane-2
[119.435184] Dynamic subtest pipe-B-plane-2: SUCCESS (0.483s)
[119.454501] Starting dynamic subtest: pipe-B-plane-3
[119.917613] Dynamic subtest pipe-B-plane-3: SUCCESS (0.483s)
[119.942531] Starting dynamic subtest: pipe-B-plane-4
[119.956599] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[120.140137] Subtest pixel-format-x-tiled-modifier: SUCCESS (5.453s)
[120.452261] [005/131] (932s left) gem_exec_balancer (full-late-pulse)
[120.591926] Starting subtest: full-late-pulse
[125.263906] Subtest full-late-pulse: SUCCESS (4.660s)
[125.519934] [006/131] (927s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[125.630976] Starting subtest: multi-wait-for-submit-unsubmitted
[125.733092] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[125.867084] [007/131] (927s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[126.062288] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[126.068372] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[126.209496] [008/131] (926s left) kms_color (ctm-negative)
[126.397516] Starting subtest: ctm-negative
[126.400677] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.352375] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.952s)
[127.377517] Starting dynamic subtest: pipe-A-HDMI-A-2
[128.035649] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.684s)
[128.078169] Starting dynamic subtest: pipe-B-HDMI-A-1
[128.668126] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.631s)
[128.701479] Starting dynamic subtest: pipe-B-HDMI-A-2
[129.338940] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.668s)
[129.372507] Starting dynamic subtest: pipe-C-HDMI-A-1
[130.003152] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.665s)
[130.027469] Starting dynamic subtest: pipe-C-HDMI-A-2
[130.654424] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.649s)
[130.659447] Subtest ctm-negative: SUCCESS (4.254s)
[130.954473] [009/131] (922s left) gem_exec_reloc (basic-range-active)
[131.092427] Starting subtest: basic-range-active
[131.196232] Subtest basic-range-active: SUCCESS (0.091s)
[131.414412] [010/131] (921s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[131.623342] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[131.728851] [011/131] (921s left) kms_plane_cursor (viewport)
[131.922134] Starting subtest: viewport
[131.931065] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[134.660924] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.737s)
[134.758309] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[137.260056] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.532s)
[137.351432] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[139.860060] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.531s)
[140.177331] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64
[142.847054] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.697s)
[142.914630] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128
[145.463077] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.566s)
[145.534917] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256
[148.131059] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.617s)
[148.413605] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[150.981066] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.599s)
[151.047681] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[153.563074] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.530s)
[153.631504] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[156.163062] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.549s)
[156.407632] Subtest viewport: SUCCESS (24.486s)
[156.724789] [012/131] (896s left) perf_pmu (render-node-busy)
[156.878557] Starting subtest: render-node-busy
[156.882057] Starting dynamic subtest: rcs0
[157.409613] Dynamic subtest rcs0: SUCCESS (0.530s)
[157.431249] Starting dynamic subtest: bcs0
[157.944259] Dynamic subtest bcs0: SUCCESS (0.532s)
[157.965991] Starting dynamic subtest: vcs0
[158.474881] Dynamic subtest vcs0: SUCCESS (0.528s)
[158.497659] Starting dynamic subtest: vecs0
[159.006837] Dynamic subtest vecs0: SUCCESS (0.529s)
[159.010152] Subtest render-node-busy: SUCCESS (2.132s)
[159.154800] [013/131] (894s left) vgem_slow (nohang)
[159.357501] Starting subtest: nohang
[169.645820] Subtest nohang: SUCCESS (10.292s)
[169.803947] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[169.810928] [014/131] (883s left) perf_pmu (busy-accuracy-50)
[169.936476] Starting subtest: busy-accuracy-50
[169.941082] Starting dynamic subtest: rcs0
[171.489924] Dynamic subtest rcs0: SUCCESS (1.552s)
[171.511371] Starting dynamic subtest: bcs0
[173.044585] Dynamic subtest bcs0: SUCCESS (1.554s)
[173.065599] Starting dynamic subtest: vcs0
[174.599288] Dynamic subtest vcs0: SUCCESS (1.554s)
[174.621423] Starting dynamic subtest: vecs0
[176.154343] Dynamic subtest vecs0: SUCCESS (1.553s)
[176.158062] Subtest busy-accuracy-50: SUCCESS (6.220s)
[176.299823] [015/131] (877s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[176.484094] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[176.493786] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[176.635921] [016/131] (877s left) kms_flip (2x-flip-vs-fences)
[176.836367] Starting subtest: 2x-flip-vs-fences
[176.842088] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[187.694247] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.855s)
[187.720849] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[198.535136] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.839s)
[198.560626] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[209.319157] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.773s)
[209.324143] Subtest 2x-flip-vs-fences: SUCCESS (32.484s)
[209.944336] [017/131] (843s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[210.158756] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[210.166224] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[210.312185] [018/131] (843s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[210.528075] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[210.535420] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[210.705919] [019/131] (843s left) gem_userptr_blits (usage-restrictions)
[210.844049] Starting subtest: usage-restrictions
[210.848867] Subtest usage-restrictions: SUCCESS (0.000s)
[211.044310] [020/131] (843s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[211.256153] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[211.262474] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[211.414991] [021/131] (842s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[211.612073] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[211.734845] [022/131] (842s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[211.953152] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[211.960565] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[212.112259] [023/131] (842s left) gem_ringfill (legacy-basic)
[212.491925] Starting subtest: legacy-basic
[212.495250] Starting dynamic subtest: default
[212.515186] Dynamic subtest default: SUCCESS (0.017s)
[212.540443] Starting dynamic subtest: render
[212.544218] Dynamic subtest render: SUCCESS (0.023s)
[212.572496] Starting dynamic subtest: bsd
[212.576657] Dynamic subtest bsd: SUCCESS (0.022s)
[212.602639] Starting dynamic subtest: bsd1
[212.606283] Dynamic subtest bsd1: SUCCESS (0.015s)
[212.629487] Starting dynamic subtest: blt
[212.632867] Dynamic subtest blt: SUCCESS (0.024s)
[212.656741] Starting dynamic subtest: vebox
[212.660947] Dynamic subtest vebox: SUCCESS (0.020s)
[212.665116] Subtest legacy-basic: SUCCESS (0.141s)
[212.788432] [024/131] (841s left) kms_joiner (basic-max-non-joiner)
[212.983084] Starting subtest: basic-max-non-joiner
[212.989298] Subtest basic-max-non-joiner: SKIP (0.000s)
[213.141950] [025/131] (841s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[213.269243] Starting subtest: untiled-to-tiled
[213.394511] Subtest untiled-to-tiled: SUCCESS (0.125s)
[213.543875] [026/131] (841s left) gem_exec_schedule (semaphore-resolve)
[213.683727] Starting subtest: semaphore-resolve
[213.725898] Subtest semaphore-resolve: SUCCESS (0.041s)
[214.126337] [027/131] (840s left) gem_ctx_engines (execute-one)
[214.251861] Starting subtest: execute-one
[216.948648] Subtest execute-one: SUCCESS (2.696s)
[217.211365] [028/131] (837s left) sriov_basic (bind-unbind-vf)
[217.333196] Subtest bind-unbind-vf: SKIP (0.000s)
[217.452250] [029/131] (837s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[218.000087] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[218.314951] [030/131] (836s left) sw_sync (alloc_merge_fence)
[218.430395] Starting subtest: alloc_merge_fence
[218.435091] Subtest alloc_merge_fence: SUCCESS (0.002s)
[218.572642] [031/131] (836s left) gem_mmap_gtt (cpuset-big-copy-odd)
[218.684321] Starting subtest: cpuset-big-copy-odd
[237.566109] Subtest cpuset-big-copy-odd: SUCCESS (18.878s)
[237.781663] [032/131] (817s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[238.136031] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[238.252272] [033/131] (817s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[238.467324] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[238.475629] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[238.649460] [034/131] (817s left) kms_draw_crc (draw-method-blt)
[238.848625] Starting subtest: draw-method-blt
[238.852068] Starting dynamic subtest: xrgb8888-untiled
[239.455573] Dynamic subtest xrgb8888-untiled: SUCCESS (0.510s)
[239.524664] Starting dynamic subtest: rgb565-untiled
[239.730689] Dynamic subtest rgb565-untiled: SUCCESS (0.281s)
[239.801829] Starting dynamic subtest: xrgb2101010-untiled
[240.005936] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.298s)
[240.074030] Starting dynamic subtest: xbgr16161616f-untiled
[240.346378] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.281s)
[240.412980] Starting dynamic subtest: xrgb8888-xtiled
[240.561119] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.182s)
[240.584921] Starting dynamic subtest: rgb565-xtiled
[240.588489] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s)
[240.611878] Starting dynamic subtest: xrgb2101010-xtiled
[240.758793] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.162s)
[240.787407] Starting dynamic subtest: xbgr16161616f-xtiled
[240.902469] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.146s)
[240.935969] Starting dynamic subtest: xrgb8888-ytiled
[241.091029] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.181s)
[241.116060] Starting dynamic subtest: rgb565-ytiled
[241.288222] Dynamic subtest rgb565-ytiled: SUCCESS (0.195s)
[241.311625] Starting dynamic subtest: xrgb2101010-ytiled
[241.472824] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.179s)
[241.505031] Starting dynamic subtest: xbgr16161616f-ytiled
[241.658597] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.182s)
[241.662666] Subtest draw-method-blt: SUCCESS (2.814s)
[241.910521] [035/131] (813s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[242.206208] Starting subtest: basic-test-pattern-with-chamelium
[242.213062] Subtest basic-test-pattern-with-chamelium: SKIP (0.001s)
[242.361468] [036/131] (813s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[242.534160] Starting subtest: x-tiled-8bpp-rotate-270
[242.901546] Subtest x-tiled-8bpp-rotate-270: SKIP (0.361s)
[243.177202] [037/131] (812s left) sysfs_timeslice_duration (timeout)
[243.314100] Starting subtest: timeout
[243.319158] Starting dynamic subtest: vecs0
[244.153986] Dynamic subtest vecs0: SUCCESS (0.842s)
[244.180941] Starting dynamic subtest: vcs0
[244.993118] Dynamic subtest vcs0: SUCCESS (0.833s)
[245.021496] Starting dynamic subtest: bcs0
[245.828470] Dynamic subtest bcs0: SUCCESS (0.836s)
[245.854842] Starting dynamic subtest: rcs0
[246.680829] Dynamic subtest rcs0: SUCCESS (0.849s)
[246.685477] Subtest timeout: SUCCESS (3.374s)
[246.824492] [038/131] (809s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[246.943091] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[247.061389] [039/131] (809s left) syncobj_timeline (etime-single-wait-submitted)
[247.191265] Starting subtest: etime-single-wait-submitted
[247.293511] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[247.472657] [040/131] (808s left) gem_ctx_sseu (mmap-args)
[247.595265] Subtest mmap-args: SKIP (0.000s)
[247.712922] [041/131] (808s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[247.861974] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[249.187546] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.326s)
[249.526945] [042/131] (807s left) prime_vgem (basic-write)
[249.665654] Starting subtest: basic-write
[249.754966] Subtest basic-write: SUCCESS (0.092s)
[249.953559] [043/131] (806s left) gen3_render_mixed_blits
[250.184868] [044/131] (806s left) kms_cursor_crc (cursor-suspend)
[250.334577] Starting subtest: cursor-suspend
[250.338096] Starting dynamic subtest: pipe-A-HDMI-A-1