[58.512260] Initializing watchdogs
[58.512325]   /dev/watchdog0
[58.532732] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[58.544549] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[58.548341] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.550588] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[58.743626] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[58.744544] Starting dynamic subtest: pipe-A-valid-mode
[58.819925] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s)
[58.821627] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.075s)
[59.055197] [002/133] (960s left) kms_cdclk (mode-transition-all-outputs)
[59.236557] Starting subtest: mode-transition-all-outputs
[59.316405] Subtest mode-transition-all-outputs: SKIP (0.078s)
[59.516227] [003/133] (959s left) gen7_exec_parse (bitmasks)
[59.604803] Subtest bitmasks: SKIP (0.000s)
[59.656580] [004/133] (959s left) sw_sync (sync_merge_same)
[59.702076] Starting subtest: sync_merge_same
[59.703031] Subtest sync_merge_same: SUCCESS (0.000s)
[59.821766] [005/133] (959s left) gem_exec_schedule (u-lateslice)
[59.908066] Starting subtest: u-lateslice
[59.909039] Starting dynamic subtest: rcs0
[59.960173] Dynamic subtest rcs0: SUCCESS (0.053s)
[59.968446] Starting dynamic subtest: bcs0
[59.981964] Dynamic subtest bcs0: SUCCESS (0.022s)
[59.990305] Starting dynamic subtest: vcs0
[60.003297] Dynamic subtest vcs0: SUCCESS (0.021s)
[60.011264] Starting dynamic subtest: vcs1
[60.026615] Dynamic subtest vcs1: SUCCESS (0.023s)
[60.034700] Starting dynamic subtest: vecs0
[60.047165] Dynamic subtest vecs0: SUCCESS (0.020s)
[60.055131] Starting dynamic subtest: vecs1
[60.070427] Dynamic subtest vecs1: SUCCESS (0.023s)
[60.078641] Starting dynamic subtest: ccs0
[60.092269] Dynamic subtest ccs0: SUCCESS (0.022s)
[60.093422] Subtest u-lateslice: SUCCESS (0.186s)
[60.582600] [006/133] (958s left) gem_tiled_partial_pwrite_pread (writes)
[60.660926] Subtest writes: SKIP (0.000s)
[60.751038] [007/133] (958s left) gem_exec_fence (submit)
[60.951052] Starting subtest: submit
[60.953378] Subtest submit: SKIP (0.000s)
[61.719556] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[61.721263] [008/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[61.916604] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[61.918291] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[62.121032] [009/133] (957s left) i915_pm_freq_api (freq-reset-multiple)
[62.217567] Starting subtest: freq-reset-multiple
[62.218596] Starting dynamic subtest: gt0
[83.218018] Dynamic subtest gt0: SUCCESS (21.008s)
[83.219082] Subtest freq-reset-multiple: SUCCESS (21.009s)
[83.376928] [010/133] (936s left) i915_pm_rps (thresholds-idle)
[83.465465] Starting subtest: thresholds-idle
[83.467319] Subtest thresholds-idle: SKIP (0.000s)
[83.578528] [011/133] (936s left) perf_pmu (most-busy-idle-check-all)
[83.649432] Starting subtest: most-busy-idle-check-all
[83.650445] Starting dynamic subtest: rcs0
[84.360947] Dynamic subtest rcs0: SUCCESS (0.711s)
[84.375470] Starting dynamic subtest: bcs0
[85.019968] Dynamic subtest bcs0: SUCCESS (0.658s)
[85.035242] Starting dynamic subtest: vcs0
[85.679038] Dynamic subtest vcs0: SUCCESS (0.659s)
[85.690133] Starting dynamic subtest: vcs1
[86.333690] Dynamic subtest vcs1: SUCCESS (0.653s)
[86.347820] Starting dynamic subtest: vecs0
[86.991306] Dynamic subtest vecs0: SUCCESS (0.658s)
[87.003123] Starting dynamic subtest: vecs1
[87.644705] Dynamic subtest vecs1: SUCCESS (0.653s)
[87.654635] Starting dynamic subtest: ccs0
[88.297643] Dynamic subtest ccs0: SUCCESS (0.653s)
[88.298576] Subtest most-busy-idle-check-all: SUCCESS (4.649s)
[88.454999] [012/133] (931s left) syncobj_wait (wait-any-snapshot)
[88.541293] Starting subtest: wait-any-snapshot
[88.624976] Subtest wait-any-snapshot: SUCCESS (0.082s)
[88.773634] [013/133] (931s left) gem_ctx_param (invalid-get-engines)
[88.852402] Starting subtest: invalid-get-engines
[88.854354] Subtest invalid-get-engines: SUCCESS (0.001s)
[89.006302] [014/133] (930s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[89.094567] Starting subtest: yf-tiled-to-vebox-x-tiled
[89.096603] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[89.357977] [015/133] (930s left) gem_ctx_persistence (userptr)
[89.446516] Starting subtest: userptr
[89.686740] Subtest userptr: SUCCESS (0.239s)
[89.811672] [016/133] (930s left) kms_addfb_basic (bad-pitch-128)
[89.890940] Starting subtest: bad-pitch-128
[89.891908] Subtest bad-pitch-128: SUCCESS (0.000s)
[90.208302] [017/133] (929s left) kms_vblank (query-idle)
[90.396375] Starting subtest: query-idle
[90.397309] Starting dynamic subtest: pipe-A-DP-3
[92.698497] Dynamic subtest pipe-A-DP-3: SUCCESS (2.301s)
[92.710449] Starting dynamic subtest: pipe-D-DP-3
[94.939165] Dynamic subtest pipe-D-DP-3: SUCCESS (2.237s)
[94.940174] Subtest query-idle: SUCCESS (4.543s)
[95.214146] [018/133] (924s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[95.415982] Starting subtest: cursor-vs-flip-varying-size
[128.423984] Subtest cursor-vs-flip-varying-size: SUCCESS (33.009s)
[128.756964] [019/133] (891s left) gem_exec_schedule (independent)
[128.847740] Starting subtest: independent
[128.848639] Starting dynamic subtest: rcs0
[129.293481] Dynamic subtest rcs0: SUCCESS (0.445s)
[129.304784] Starting dynamic subtest: bcs0
[129.690913] Dynamic subtest bcs0: SUCCESS (0.397s)
[129.704547] Starting dynamic subtest: vcs0
[130.077389] Dynamic subtest vcs0: SUCCESS (0.386s)
[130.087985] Starting dynamic subtest: vcs1
[130.464194] Dynamic subtest vcs1: SUCCESS (0.387s)
[130.474405] Starting dynamic subtest: vecs0
[130.844522] Dynamic subtest vecs0: SUCCESS (0.380s)
[130.856485] Starting dynamic subtest: vecs1
[131.258177] Dynamic subtest vecs1: SUCCESS (0.413s)
[131.271474] Starting dynamic subtest: ccs0
[131.625414] Dynamic subtest ccs0: SUCCESS (0.367s)
[131.626458] Subtest independent: SUCCESS (2.778s)
[132.039793] [020/133] (888s left) kms_async_flips (test-time-stamp-atomic)
[132.229938] Starting subtest: test-time-stamp-atomic
[132.454750] Starting dynamic subtest: pipe-A-DP-3
[132.788853] Dynamic subtest pipe-A-DP-3: SUCCESS (0.333s)
[133.027070] Starting dynamic subtest: pipe-B-DP-3
[133.162405] Dynamic subtest pipe-B-DP-3: SUCCESS (0.143s)
[133.388491] Starting dynamic subtest: pipe-C-DP-3
[133.532031] Dynamic subtest pipe-C-DP-3: SUCCESS (0.151s)
[133.754516] Starting dynamic subtest: pipe-D-DP-3
[133.888675] Dynamic subtest pipe-D-DP-3: SUCCESS (0.141s)
[133.889686] Subtest test-time-stamp-atomic: SUCCESS (1.659s)
[134.375143] [021/133] (886s left) syncobj_basic (bad-pad-handle-to-fd)
[134.460147] Starting subtest: bad-pad-handle-to-fd
[134.461063] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[134.610430] [022/133] (885s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[134.812224] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[135.528392] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.716s)
[135.813666] [023/133] (884s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[136.011055] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[136.102600] [024/133] (884s left) kms_colorop (plane-xr30-xr30-pq_eotf)
[136.399803] Subtest plane-XR30-XR30-pq_eotf: SKIP (0.000s)
[136.560885] [025/133] (884s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[136.647568] Starting subtest: x-tiled-to-vebox-yf-tiled
[136.649584] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[136.877531] [026/133] (883s left) gen3_render_mixed_blits
[137.042556] [027/133] (883s left) gem_vm_create (invalid-create)
[137.130065] Starting subtest: invalid-create
[137.133949] Subtest invalid-create: SUCCESS (0.005s)
[137.293459] [028/133] (883s left) api_intel_bb (blit-reloc-keep-cache)
[137.374197] Starting subtest: blit-reloc-keep-cache
[137.376197] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[137.548931] [029/133] (883s left) gem_flink_basic (bad-open)
[137.628992] Starting subtest: bad-open
[137.629968] Subtest bad-open: SUCCESS (0.000s)
[137.781226] [030/133] (883s left) gen9_exec_parse (unaligned-jump)
[137.867419] Subtest unaligned-jump: SKIP (0.000s)
[137.939035] [031/133] (883s left) kms_writeback (writeback-fb-id)
[138.132336] Subtest writeback-fb-id: SKIP (0.000s)
[138.189036] [032/133] (882s left) gem_ctx_shared (q-out-order)
[138.282460] Starting subtest: Q-out-order
[138.283441] Starting dynamic subtest: rcs0
[138.554998] Dynamic subtest rcs0: SUCCESS (0.272s)
[138.565367] Starting dynamic subtest: bcs0
[138.738303] Dynamic subtest bcs0: SUCCESS (0.183s)
[138.748683] Starting dynamic subtest: vcs0
[138.930518] Dynamic subtest vcs0: SUCCESS (0.192s)
[138.942835] Starting dynamic subtest: vcs1
[139.124775] Dynamic subtest vcs1: SUCCESS (0.194s)
[139.135124] Starting dynamic subtest: vecs0
[139.311825] Dynamic subtest vecs0: SUCCESS (0.187s)
[139.322105] Starting dynamic subtest: vecs1
[139.501440] Dynamic subtest vecs1: SUCCESS (0.189s)
[139.511837] Starting dynamic subtest: ccs0
[139.693530] Dynamic subtest ccs0: SUCCESS (0.192s)
[139.694419] Subtest Q-out-order: SUCCESS (1.411s)
[140.105960] [033/133] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[140.306504] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[140.308216] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[140.459521] [034/133] (880s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[140.659621] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[140.661431] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[140.866992] [035/133] (880s left) gem_spin_batch (legacy-resubmit)
[140.964362] Starting subtest: legacy-resubmit
[140.965297] Starting dynamic subtest: default
[140.996576] Dynamic subtest default: SUCCESS (0.032s)
[141.006754] Starting dynamic subtest: render
[141.007689] Dynamic subtest render: SUCCESS (0.002s)
[141.017747] Starting dynamic subtest: bsd
[141.018854] Dynamic subtest bsd: SUCCESS (0.002s)
[141.028800] Starting dynamic subtest: bsd1
[141.029984] Dynamic subtest bsd1: SUCCESS (0.002s)
[141.039548] Starting dynamic subtest: bsd2
[141.040759] Dynamic subtest bsd2: SUCCESS (0.003s)
[141.050106] Starting dynamic subtest: blt
[141.051137] Dynamic subtest blt: SUCCESS (0.003s)
[141.060650] Starting dynamic subtest: vebox
[141.061831] Dynamic subtest vebox: SUCCESS (0.002s)
[141.062954] Subtest legacy-resubmit: SUCCESS (0.048s)
[141.331713] [036/133] (880s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[141.523561] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[141.525247] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[141.711172] [037/133] (879s left) gem_exec_capture (userptr)
[141.799062] Starting subtest: userptr
[142.778060] Subtest userptr: SUCCESS (0.980s)
[142.929092] [038/133] (878s left) kms_pwrite_crc
[144.091611] [039/133] (877s left) prime_vgem (shrink)
[144.200963] Starting subtest: shrink
[144.207903] Subtest shrink: SUCCESS (0.007s)
[144.389100] [040/133] (877s left) kms_cursor_crc (cursor-onscreen-512x170)
[144.888133] Starting subtest: cursor-onscreen-512x170
[144.889960] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[145.119893] [041/133] (876s left) prime_mmap_coherency (ioctl-errors)
[145.207927] Starting subtest: ioctl-errors
[151.077177] Subtest ioctl-errors: SUCCESS (5.869s)
[151.292560] [042/133] (870s left) kms_legacy_colorkey (invalid-plane)
[151.555825] Starting subtest: invalid-plane
[151.556732] Starting dynamic subtest: zero-id
[151.557588] Dynamic subtest zero-id: SUCCESS (0.000s)
[151.567936] Starting dynamic subtest: outrange-id
[151.568871] Dynamic subtest outrange-id: SUCCESS (0.000s)
[151.569799] Subtest invalid-plane: SUCCESS (0.001s)
[151.691945] [043/133] (870s left) core_setmaster (master-drop-set-user)
[151.872533] Starting subtest: master-drop-set-user
[151.909758] Subtest master-drop-set-user: SUCCESS (0.037s)
[151.958493] [044/133] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[152.156500] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[152.158220] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[152.327670] [045/133] (869s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[152.529613] Starting subtest: yf-tiled-8bpp-rotate-270
[152.531428] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[152.698076] [046/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[152.898907] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[152.900576] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[153.088368] [047/133] (869s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[153.284110] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[153.284847] Starting dynamic subtest: pipe-A
[153.372388] Dynamic subtest pipe-A: SUCCESS (0.089s)
[153.384234] Starting dynamic subtest: pipe-B
[153.568843] Dynamic subtest pipe-B: SUCCESS (0.196s)
[153.584562] Starting dynamic subtest: pipe-C
[153.784040] Dynamic subtest pipe-C: SUCCESS (0.215s)
[153.801453] Starting dynamic subtest: pipe-D
[154.015353] Dynamic subtest pipe-D: SUCCESS (0.231s)
[154.016107] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.732s)
[154.329620] [048/133] (868s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[154.418041] Starting subtest: rel-constants-invalid-rel-gen5
[154.418955] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[154.585156] [049/133] (867s left) gem_mmap_gtt (basic-copy)
[154.668057] Subtest basic-copy: SKIP (0.000s)
[154.738827] [050/133] (867s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[154.934614] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[154.936300] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[155.128016] [051/133] (867s left) kms_colorop (plane-xr24-xr24-pq_125_inv_eotf)
[155.420877] Subtest plane-XR24-XR24-pq_125_inv_eotf: SKIP (0.000s)
[155.581606] [052/133] (867s left) kms_addfb_basic (invalid-get-prop-any)
[155.662217] Starting subtest: invalid-get-prop-any
[155.663148] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[155.949797] [053/133] (866s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[156.143930] Starting subtest: fbc-farfromfence-mmap-gtt
[156.145584] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[156.317271] [054/133] (866s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[156.509479] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[156.510424] Starting dynamic subtest: pipe-A-DP-3
[156.519124] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[156.529460] Starting dynamic subtest: pipe-B-DP-3
[156.538179] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[156.548454] Starting dynamic subtest: pipe-C-DP-3
[156.556981] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[156.567220] Starting dynamic subtest: pipe-D-DP-3
[156.576718] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[156.578759] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[157.005513] [055/133] (865s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[157.091515] Starting subtest: y-tiled-ccs-to-y-tiled
[157.093574] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[157.305422] [056/133] (865s left) intel_hwmon (hwmon-write)
[157.385447] Starting subtest: hwmon-write
[157.403030] Subtest hwmon-write: SUCCESS (0.018s)
[157.552465] [057/133] (865s left) gem_render_copy_redux (flink)
[157.642579] Starting subtest: flink
[160.930066] Subtest flink: SUCCESS (3.287s)
[161.133859] [058/133] (861s left) kms_psr (pr-primary-page-flip)
[161.324660] Subtest pr-primary-page-flip: SKIP (0.000s)
[161.380546] [059/133] (861s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[161.589499] Starting subtest: y-tiled-8bpp-rotate-0
[161.591319] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[161.789432] [060/133] (861s left) gem_exec_fence (basic-wait)
[162.012625] Starting subtest: basic-wait
[162.013657] Starting dynamic subtest: rcs0
[162.135797] Dynamic subtest rcs0: SUCCESS (0.127s)
[162.150601] Starting dynamic subtest: bcs0
[162.189451] Dynamic subtest bcs0: SUCCESS (0.052s)
[162.210173] Starting dynamic subtest: vcs0
[162.244703] Dynamic subtest vcs0: SUCCESS (0.054s)
[162.283032] Starting dynamic subtest: vcs1
[162.305509] Dynamic subtest vcs1: SUCCESS (0.060s)
[162.322870] Starting dynamic subtest: vecs0
[162.359103] Dynamic subtest vecs0: SUCCESS (0.052s)
[162.391023] Starting dynamic subtest: vecs1
[162.409784] Dynamic subtest vecs1: SUCCESS (0.050s)
[162.430071] Starting dynamic subtest: ccs0
[162.463745] Dynamic subtest ccs0: SUCCESS (0.053s)
[162.464906] Subtest basic-wait: SUCCESS (0.457s)
[163.221832] [061/133] (860s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[163.411903] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[196.888717] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (33.476s)
[197.182197] [062/133] (826s left) kms_cursor_crc (cursor-sliding-512x512)
[197.654092] Starting subtest: cursor-sliding-512x512
[197.657135] Subtest cursor-sliding-512x512: SKIP (0.001s)
[197.896643] [063/133] (825s left) kms_color (ctm-blue-to-red)
[198.086633] Starting subtest: ctm-blue-to-red
[198.087540] Starting dynamic subtest: pipe-A-DP-3
[198.767465] Dynamic subtest pipe-A-DP-3: SUCCESS (0.678s)
[198.790020] Starting dynamic subtest: pipe-B-DP-3
[199.364170] Dynamic subtest pipe-B-DP-3: SUCCESS (0.597s)
[199.375176] Starting dynamic subtest: pipe-C-DP-3
[199.950600] Dynamic subtest pipe-C-DP-3: SUCCESS (0.586s)
[199.962538] Starting dynamic subtest: pipe-D-DP-3
[200.528494] Dynamic subtest pipe-D-DP-3: SUCCESS (0.577s)
[200.529462] Subtest ctm-blue-to-red: SUCCESS (2.442s)
[200.852312] [064/133] (822s left) kms_pm_dc (dc5-dpms-negative)
[202.056102] Starting subtest: dc5-dpms-negative
[206.286245] Subtest dc5-dpms-negative: SUCCESS (4.229s)
[206.418531] [065/133] (817s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[206.618830] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[206.620492] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[206.819155] [066/133] (816s left) gem_caching (writes)
[206.911760] Starting subtest: writes
[211.309246] Subtest writes: SUCCESS (4.397s)
[211.510344] [067/133] (812s left) kms_colorop (plane-xr24-xr24-ctm_3x4_50_desat)
[211.815196] Subtest plane-XR24-XR24-ctm_3x4_50_desat: SKIP (0.000s)
[211.960465] [068/133] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[212.155983] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[212.157794] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[212.366587] [069/133] (811s left) kms_dp_linktrain_fallback (dp-fallback)
[212.557987] Starting subtest: dp-fallback
[222.527472] Subtest dp-fallback: SUCCESS (9.968s)
[222.977241] [070/133] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[223.175204] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[223.176989] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[223.381555] [071/133] (800s left) gem_create (busy-create)
[223.477997] Starting subtest: busy-create
[223.478964] Starting dynamic subtest: lmem0
[255.759260] Dynamic subtest lmem0: SUCCESS (32.280s)
[255.770480] Starting dynamic subtest: smem0
[288.020270] Dynamic subtest smem0: SUCCESS (32.259s)
[288.021234] Subtest busy-create: SUCCESS (64.541s)
[288.344016] [072/133] (735s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[288.536920] Starting subtest: plane-downscale-factor-0-5-with-rotation
[288.537775] Starting dynamic subtest: pipe-A
[288.913202] Dynamic subtest pipe-A: SUCCESS (0.376s)
[288.928779] Starting dynamic subtest: pipe-B
[289.376676] Dynamic subtest pipe-B: SUCCESS (0.462s)
[289.397372] Starting dynamic subtest: pipe-C
[289.859598] Dynamic subtest pipe-C: SUCCESS (0.481s)
[289.884263] Starting dynamic subtest: pipe-D
[290.341584] Dynamic subtest pipe-D: SUCCESS (0.480s)
[290.342736] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.806s)
[290.704986] [073/133] (733s left) kms_flip (modeset-vs-vblank-race)
[290.902863] Starting subtest: modeset-vs-vblank-race
[290.907559] Starting dynamic subtest: A-DP3
[294.079679] Dynamic subtest A-DP3: SUCCESS (3.171s)
[294.122636] Starting dynamic subtest: B-DP3
[297.292816] Dynamic subtest B-DP3: SUCCESS (3.207s)
[297.337450] Starting dynamic subtest: C-DP3
[300.379227] Dynamic subtest C-DP3: SUCCESS (3.081s)
[300.422598] Starting dynamic subtest: D-DP3
[303.624357] Dynamic subtest D-DP3: SUCCESS (3.238s)
[303.628194] Subtest modeset-vs-vblank-race: SUCCESS (12.725s)
[304.023028] [074/133] (720s left) gem_softpin (softpin)
[304.116388] Starting subtest: softpin
[336.433321] Subtest softpin: SUCCESS (32.315s)
[336.618853] [075/133] (687s left) i915_pm_rps (reset)
[336.707643] Starting subtest: reset
[341.534505] Subtest reset: SUCCESS (4.827s)
[341.694950] [076/133] (682s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[341.890202] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[342.060434] [077/133] (682s left) gem_exec_reloc (basic-cpu-active)
[342.162840] Subtest basic-cpu-active: SKIP (0.000s)
[342.260550] [078/133] (682s left) kms_selftest (drm_cmdline_parser)
[342.314333] Starting subtest: drm_cmdline_parser
[342.370298] Starting dynamic subtest: drm_test_cmdline_force_d_only
[342.446634] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.076s)
[342.488391] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[342.529515] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.079s)
[342.563068] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[342.597274] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.065s)
[342.622476] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[342.678724] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.076s)
[342.694076] Starting dynamic subtest: drm_test_cmdline_force_e_only
[342.752738] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.072s)
[342.793767] Starting dynamic subtest: drm_test_cmdline_res
[342.845665] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.088s)
[342.889794] Starting dynamic subtest: drm_test_cmdline_res_vesa
[342.928226] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.079s)
[342.951589] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[343.023544] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.092s)
[343.069146] Starting dynamic subtest: drm_test_cmdline_res_rblank
[343.110630] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.082s)
[343.134182] Starting dynamic subtest: drm_test_cmdline_res_bpp
[343.196755] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.083s)
[343.239682] Starting dynamic subtest: drm_test_cmdline_res_refresh
[343.282502] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.080s)
[343.310065] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[343.387438] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.103s)
[343.400468] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[343.464878] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.075s)
[343.509404] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[343.561990] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.092s)
[343.606561] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[343.659027] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.093s)
[343.698189] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[343.763565] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.100s)
[343.808470] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[343.846173] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.077s)
[343.866569] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[343.921426] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.074s)
[343.933655] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[344.006583] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.083s)
[344.049407] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[344.102338] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.090s)
[344.141013] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[344.195097] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.089s)
[344.238548] Starting dynamic subtest: drm_test_cmdline_name
[344.296929] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.098s)
[344.336046] Starting dynamic subtest: drm_test_cmdline_name_bpp
[344.391195] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.089s)
[344.434286] Starting dynamic subtest: drm_test_cmdline_name_option
[344.471542] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.076s)
[344.491575] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[344.556487] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.083s)
[344.571379] Starting dynamic subtest: drm_test_cmdline_rotate_0
[344.642717] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.080s)
[344.668536] Starting dynamic subtest: drm_test_cmdline_rotate_90
[344.740704] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.092s)
[344.784075] Starting dynamic subtest: drm_test_cmdline_rotate_180
[344.833504] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.088s)
[344.868670] Starting dynamic subtest: drm_test_cmdline_rotate_270
[344.933588] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.096s)
[344.975466] Starting dynamic subtest: drm_test_cmdline_hmirror
[345.035452] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.096s)
[345.075829] Starting dynamic subtest: drm_test_cmdline_vmirror
[345.125358] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.086s)
[345.165947] Starting dynamic subtest: drm_test_cmdline_margin_options
[345.196023] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.068s)
[345.215154] Starting dynamic subtest: drm_test_cmdline_multiple_options
[345.268924] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.070s)
[345.312877] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[345.345075] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.072s)
[345.363534] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[345.441955] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.094s)
[345.455552] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[345.528583] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.082s)
[345.572130] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[345.607369] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.076s)
[345.628193] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[345.697586] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.087s)
[345.742353] Starting dynamic subtest: drm_test_cmdline_invalid
[345.813098] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.111s)
[345.850532] Starting dynamic subtest: drm_test_cmdline_tv_options
[345.890211] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.073s)
[345.891279] Subtest drm_cmdline_parser: SUCCESS (3.577s)
[346.140832] [079/133] (678s left) perf_pmu (busy)
[346.215443] Starting subtest: busy
[346.216463] Starting dynamic subtest: rcs0
[346.838796] Dynamic subtest rcs0: SUCCESS (0.622s)
[346.854395] Starting dynamic subtest: bcs0
[347.403719] Dynamic subtest bcs0: SUCCESS (0.560s)
[347.419148] Starting dynamic subtest: vcs0
[347.971797] Dynamic subtest vcs0: SUCCESS (0.563s)
[347.987100] Starting dynamic subtest: vcs1
[348.537863] Dynamic subtest vcs1: SUCCESS (0.561s)
[348.553117] Starting dynamic subtest: vecs0
[349.101755] Dynamic subtest vecs0: SUCCESS (0.559s)
[349.117236] Starting dynamic subtest: vecs1
[349.669652] Dynamic subtest vecs1: SUCCESS (0.563s)
[349.685258] Starting dynamic subtest: ccs0
[350.235722] Dynamic subtest ccs0: SUCCESS (0.561s)
[350.240679] Subtest busy: SUCCESS (4.022s)
[350.391332] [080/133] (674s left) kms_psr (pr-suspend)
[350.584232] Subtest pr-suspend: SKIP (0.000s)
[350.650822] [081/133] (674s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[350.853422] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[350.855286] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[351.057147] [082/133] (673s left) gem_tiled_fence_blits (basic)
[351.145981] Subtest basic: SKIP (0.000s)
[351.234942] [083/133] (673s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[351.422438] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[351.423328] Starting dynamic subtest: pipe-A-valid-mode
[351.511571] Dynamic subtest pipe-A-valid-mode: SKIP (0.086s)
[351.514275] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.088s)
[351.793960] [084/133] (673s left) kms_pm_rpm (dpms-lpsp)
[354.025646] Starting subtest: dpms-lpsp
[354.027822] Subtest dpms-lpsp: SKIP (0.000s)
[354.438816] [085/133] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[354.633230] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[354.634866] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[354.786652] [086/133] (670s left) kms_psr (psr-primary-mmap-gtt)
[354.976394] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[355.037168] [087/133] (670s left) kms_rotation_crc (bad-tiling)
[355.229427] Starting subtest: bad-tiling
[355.231212] Subtest bad-tiling: SKIP (0.001s)
[355.396617] [088/133] (669s left) gem_exec_parallel (userptr)
[355.492983] Starting subtest: userptr
[355.493999] Starting dynamic subtest: rcs0
[357.015278] Dynamic subtest rcs0: SUCCESS (1.522s)
[357.031293] Starting dynamic subtest: bcs0
[358.500547] Dynamic subtest bcs0: SUCCESS (1.484s)
[358.516376] Starting dynamic subtest: vcs0
[360.039478] Dynamic subtest vcs0: SUCCESS (1.538s)
[360.053283] Starting dynamic subtest: vcs1
[361.526280] Dynamic subtest vcs1: SUCCESS (1.485s)
[361.541520] Starting dynamic subtest: vecs0
[363.017592] Dynamic subtest vecs0: SUCCESS (1.490s)
[363.032395] Starting dynamic subtest: vecs1
[364.498499] Dynamic subtest vecs1: SUCCESS (1.480s)
[364.513019] Starting dynamic subtest: ccs0
[365.973173] Dynamic subtest ccs0: SUCCESS (1.473s)
[365.974195] Subtest userptr: SUCCESS (10.481s)
[366.309562] [089/133] (659s left) gem_exercise_blt (fast-copy-emit)
[366.401361] Starting subtest: fast-copy-emit
[366.402312] Starting dynamic subtest: linear-smem-smem-emit
[366.449663] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.048s)
[366.462277] Starting dynamic subtest: linear-smem-lmem0-emit
[366.465515] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s)
[366.478023] Starting dynamic subtest: linear-lmem0-smem-emit
[366.567034] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.100s)
[366.579709] Starting dynamic subtest: linear-lmem0-lmem0-emit
[366.666734] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.099s)
[366.679481] Starting dynamic subtest: xmajor-smem-smem-emit
[366.683005] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.015s)
[366.695591] Starting dynamic subtest: xmajor-smem-lmem0-emit
[366.698278] Dynamic subtest xmajor-smem-lmem0-emit: SUCCESS (0.014s)
[366.710951] Starting dynamic subtest: xmajor-lmem0-smem-emit
[366.804129] Dynamic subtest xmajor-lmem0-smem-emit: SUCCESS (0.105s)
[366.816822] Starting dynamic subtest: xmajor-lmem0-lmem0-emit
[366.916581] Dynamic subtest xmajor-lmem0-lmem0-emit: SUCCESS (0.111s)
[366.929374] Starting dynamic subtest: tile4-smem-smem-emit
[366.933512] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[366.946125] Starting dynamic subtest: tile4-smem-lmem0-emit
[366.949073] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s)
[366.961574] Starting dynamic subtest: tile4-lmem0-smem-emit
[367.063298] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.113s)
[367.076243] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[367.176507] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.112s)
[367.189340] Starting dynamic subtest: tile64-smem-smem-emit
[367.194496] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[367.207200] Starting dynamic subtest: tile64-smem-lmem0-emit
[367.209927] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s)
[367.222352] Starting dynamic subtest: tile64-lmem0-smem-emit
[367.321862] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.111s)
[367.334655] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[367.433772] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.111s)
[367.434603] Subtest fast-copy-emit: SUCCESS (1.033s)
[367.594371] [090/133] (657s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[367.804571] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[367.856072] [091/133] (657s left) kms_getfb (getfb2-handle-zero)
[368.049508] Starting subtest: getfb2-handle-zero
[368.050410] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[368.227377] [092/133] (657s left) syncobj_timeline (single-wait-all-available-signaled)
[368.308570] Starting subtest: single-wait-all-available-signaled
[368.309472] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[368.493694] [093/133] (657s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[368.693442] Starting subtest: 2x-long-flip-vs-cursor-legacy
[368.695209] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[368.870261] [094/133] (656s left) kms_plane_lowres (tiling-yf)
[369.064376] Starting subtest: tiling-yf
[369.066164] Subtest tiling-yf: SKIP (0.000s)
[369.199135] [095/133] (656s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[369.279469] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[369.280437] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[369.492791] [096/133] (656s left) perf (disabled-read-error)
[369.925939] Starting subtest: disabled-read-error
[369.960538] Subtest disabled-read-error: SUCCESS (0.035s)
[370.024607] [097/133] (655s left) kms_chamelium_frames (hdmi-frame-dump)
[370.305538] Subtest hdmi-frame-dump: SKIP (0.000s)
[370.461693] [098/133] (655s left) gem_exec_whisper (basic-fds-forked)
[370.556626] Starting subtest: basic-fds-forked
[393.002800] Subtest basic-fds-forked: SUCCESS (22.444s)
[393.293645] [099/133] (632s left) kms_feature_discovery (display-2x)
[393.487787] Starting subtest: display-2x
[393.489530] Subtest display-2x: SKIP (0.000s)
[393.679799] [100/133] (632s left) gem_pread (self)
[393.761262] Subtest self: SKIP (0.000s)
[393.853644] [101/133] (632s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[394.053953] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[394.055674] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[394.251202] [102/133] (632s left) syncobj_timeline (wait-any-complex)
[394.332508] Starting subtest: wait-any-complex
[394.395231] Subtest wait-any-complex: SUCCESS (0.062s)
[394.568311] [103/133] (631s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[394.765328] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[394.767055] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[394.915048] [104/133] (631s left) gem_lmem_swapping (parallel-random-verify)
[397.851627] Starting subtest: parallel-random-verify
[397.852480] Starting dynamic subtest: lmem0
[455.450893] Dynamic subtest lmem0: SUCCESS (57.599s)
[455.451892] Subtest parallel-random-verify: SUCCESS (57.600s)
[456.674370] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[456.675439] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: kernel.kmod_is_loaded.i915: true
[456.677456] [105/133] (569s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[458.295815] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[458.398552] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[458.499643] [FACT syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[458.502092] [FACT syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)] new: kernel.kmod_is_loaded.i915: true
[458.504788] [106/133] (568s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[458.714774] Starting subtest: 4-tiled-16bpp-rotate-270
[458.798260] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.083s)
[459.012957] [107/133] (567s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[459.217976] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[459.219782] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[459.344768] [108/133] (567s left) gem_basic (create-close)
[459.426729] Starting subtest: create-close
[459.428668] Subtest create-close: SUCCESS (0.000s)
[459.613556] [109/133] (567s left) kms_psr (fbc-psr-cursor-plane-onoff)
[459.803245] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[459.858215] [110/133] (567s left) fbdev (read)
[459.914131] Starting subtest: read
[463.032040] Subtest read: SUCCESS (3.118s)
[463.130576] [111/133] (563s left) gem_partial_pwrite_pread (writes-after-reads)
[463.225064] Subtest writes-after-reads: SKIP (0.000s)
[463.291316] [112/133] (563s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[463.483249] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[463.484990] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[463.646406] [113/133] (563s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[463.841132] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[463.842951] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[464.047477] [114/133] (563s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[464.248403] Starting subtest: x-tiled-32bpp-rotate-90
[464.314254] Subtest x-tiled-32bpp-rotate-90: SKIP (0.065s)
[464.531558] [115/133] (562s left) kms_cursor_legacy (forked-move)
[464.719917] Starting subtest: forked-move
[464.720833] Starting dynamic subtest: pipe-A
[470.140355] Dynamic subtest pipe-A: SUCCESS (5.419s)
[470.160083] Starting dynamic subtest: pipe-B
[475.569823] Dynamic subtest pipe-B: SUCCESS (5.427s)
[475.593217] Starting dynamic subtest: pipe-C
[481.002160] Dynamic subtest pipe-C: SUCCESS (5.429s)
[481.028039] Starting dynamic subtest: pipe-D
[486.443700] Dynamic subtest pipe-D: SUCCESS (5.439s)
[486.469384] Starting dynamic subtest: all-pipes
[491.871796] Dynamic subtest all-pipes: SUCCESS (5.426s)
[491.872650] Subtest forked-move: SUCCESS (27.151s)
[491.998177] [116/133] (535s left) api_intel_bb (object-noreloc-keep-cache-simple)
[492.081505] Starting subtest: object-noreloc-keep-cache-simple
[492.116583] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.035s)
[492.280715] [117/133] (535s left) gem_mmap_gtt (basic-short)
[492.364262] Subtest basic-short: SKIP (0.000s)
[492.448179] [118/133] (534s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[492.640191] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[492.641142] Starting dynamic subtest: pipe-A-DP-3
[496.619470] Dynamic subtest pipe-A-DP-3: SUCCESS (3.976s)
[496.630212] Starting dynamic subtest: pipe-B-DP-3
[496.637932] Dynamic subtest pipe-B-DP-3: SUCCESS (0.015s)
[496.648880] Starting dynamic subtest: pipe-C-DP-3
[496.656925] Dynamic subtest pipe-C-DP-3: SUCCESS (0.016s)
[496.667639] Starting dynamic subtest: pipe-D-DP-3
[496.676043] Dynamic subtest pipe-D-DP-3: SUCCESS (0.016s)
[496.677034] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SUCCESS (4.030s)
[497.194931] [119/133] (530s left) syncobj_timeline (multi-wait-available-signaled)
[497.276567] Starting subtest: multi-wait-available-signaled
[497.277476] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[497.441915] [120/133] (530s left) kms_content_protection (dp-mst-type-0)
[497.701893] Starting subtest: dp-mst-type-0
[497.703632] Subtest dp-mst-type-0: SKIP (0.000s)
[497.910452] [121/133] (529s left) gem_mmap_offset (bad-extensions)
[497.992775] Starting subtest: bad-extensions
[497.993753] Subtest bad-extensions: SUCCESS (0.000s)
[498.178075] [122/133] (529s left) gem_exec_flush (basic-wb-ro-before-default)
[498.263454] Subtest basic-wb-ro-before-default: SKIP (0.000s)
[498.340812] [123/133] (529s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[498.538482] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[498.592504] [124/133] (529s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[498.677167] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[498.760528] [125/133] (529s left) kms_psr (fbc-psr2-cursor-render)
[498.952125] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[499.010766] [126/133] (528s left) gem_exec_balancer (bonded-sync)
[499.103763] Starting subtest: bonded-sync
[499.105645] Subtest bonded-sync: SKIP (0.000s)
[499.519315] [127/133] (528s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[499.715580] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[499.717950] Starting dynamic subtest: pipe-A-DP-3
[499.726453] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[499.737256] Starting dynamic subtest: pipe-B-DP-3
[499.745951] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[499.756467] Starting dynamic subtest: pipe-C-DP-3
[499.764877] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[499.775322] Starting dynamic subtest: pipe-D-DP-3
[499.786436] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[499.788554] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.010s)
[500.219838] [128/133] (527s left) gem_exec_reloc (basic-gtt-active)
[500.309174] Subtest basic-gtt-active: SKIP (0.000s)
[500.408101] [129/133] (527s left) syncobj_wait (multi-wait-for-submit-signaled)
[500.488475] Starting subtest: multi-wait-for-submit-signaled
[500.489431] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[500.617716] [130/133] (527s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[500.813439] Starting subtest: crc-primary-basic-y-tiled-ccs
[500.814428] Starting dynamic subtest: pipe-A-DP-3
[500.823130] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[500.833677] Starting dynamic subtest: pipe-B-DP-3
[500.842240] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[500.852726] Starting dynamic subtest: pipe-C-DP-3
[500.860946] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[500.871078] Starting dynamic subtest: pipe-D-DP-3
[500.881502] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[500.883521] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.010s)
[501.304338] [131/133] (527s left) prime_mmap (test_forked_cpu_write)
[501.384794] Starting subtest: test_forked_cpu_write
[501.385686] Starting dynamic subtest: test_forked_cpu_write-smem
[501.394174] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[501.406465] Starting dynamic subtest: test_forked_cpu_write-lmem0
[501.407439] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.009s)
[501.408591] Subtest test_forked_cpu_write: SUCCESS (0.020s)
[501.598516] [132/133] (526s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[501.798589] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[502.866395] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.068s)
[503.137338] [133/133] (525s left) gem_exec_alignment (single)
[503.224416] Starting subtest: single
[503.230100] Subtest single: SUCCESS (0.006s)
[503.364766] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_cdclk
results: parsing output: 2/ for test: gen7_exec_parse
results: parsing output: 3/ for test: sw_sync
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: i915_pm_freq_api
results: parsing output: 9/ for test: i915_pm_rps
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_ctx_param
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: syncobj_basic
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: kms_colorop
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: gen3_render_mixed_blits
results: parsing output: 26/ for test: gem_vm_create
results: parsing output: 27/ for test: api_intel_bb
results: parsing output: 28/ for test: gem_flink_basic
results: parsing output: 29/ for test: gen9_exec_parse
results: parsing output: 30/ for test: kms_writeback
results: parsing output: 31/ for test: gem_ctx_shared
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_spin_batch
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_capture
results: parsing output: 37/ for test: kms_pwrite_crc
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: prime_mmap_coherency
results: parsing output: 41/ for test: kms_legacy_colorkey
results: parsing output: 42/ for test: core_setmaster
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_colorop
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: intel_hwmon
results: parsing output: 56/ for test: gem_render_copy_redux
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: kms_pm_dc
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_caching
results: parsing output: 66/ for test: kms_colorop
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_dp_linktrain_fallback
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_create
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: i915_pm_rps
results: parsing output: 75/ for test: kms_joiner
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_selftest
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_tiled_fence_blits
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_rotation_crc
results: parsing output: 87/ for test: gem_exec_parallel
results: parsing output: 88/ for test: gem_exercise_blt
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_plane_lowres
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: perf
results: parsing output: 96/ for test: kms_chamelium_frames
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: kms_feature_discovery
results: parsing output: 99/ for test: gem_pread
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_lmem_swapping
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_basic
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: fbdev
results: parsing output: 110/ for test: gem_partial_pwrite_pread
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: gem_mmap_offset
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_pipe_b_c_ivb
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: prime_mmap
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: gem_exec_alignment
Done.