[51.394278] Initializing watchdogs
[51.394541]   /dev/watchdog0
[51.411951] [001/142] (960s left) gem_exec_schedule (promotion)
[51.697151] Starting subtest: promotion
[51.698680] Starting dynamic subtest: rcs0
[51.869258] Dynamic subtest rcs0: SUCCESS (0.172s)
[51.890994] Starting dynamic subtest: bcs0
[52.031425] Dynamic subtest bcs0: SUCCESS (0.162s)
[52.052324] Starting dynamic subtest: vcs0
[52.183876] Dynamic subtest vcs0: SUCCESS (0.150s)
[52.200198] Starting dynamic subtest: vecs0
[52.321911] Dynamic subtest vecs0: SUCCESS (0.139s)
[52.324355] Subtest promotion: SUCCESS (0.626s)
[52.675897] [002/142] (959s left) gem_exec_fence (expired-history)
[53.421574] Starting subtest: expired-history
[59.232779] Subtest expired-history: SUCCESS (5.810s)
[59.821066] [003/142] (952s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[60.132327] Starting subtest: short-flip-before-cursor-atomic-transitions
[61.497612] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.365s)
[61.831253] [004/142] (950s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[62.139421] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[62.140806] Starting dynamic subtest: pipe-A-DP-1
[62.225695] Dynamic subtest pipe-A-DP-1: SUCCESS (0.088s)
[62.245960] Starting dynamic subtest: pipe-B-DP-1
[62.611381] Dynamic subtest pipe-B-DP-1: SUCCESS (0.382s)
[62.635953] Starting dynamic subtest: pipe-C-DP-1
[62.724684] Dynamic subtest pipe-C-DP-1: SKIP (0.106s)
[62.725996] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.586s)
[63.100464] [005/142] (948s left) kms_flip (2x-wf_vblank-ts-check)
[63.391857] Starting subtest: 2x-wf_vblank-ts-check
[63.394412] Subtest 2x-wf_vblank-ts-check: SKIP (0.003s)
[63.501253] [006/142] (948s left) gem_mmap_wc (copy)
[63.710215] Starting subtest: copy
[64.050826] Subtest copy: SUCCESS (0.340s)
[64.133880] [007/142] (947s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[64.440268] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[64.442224] Starting dynamic subtest: pipe-A-valid-mode
[64.548479] Dynamic subtest pipe-A-valid-mode: SKIP (0.107s)
[64.551065] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.109s)
[64.856390] [008/142] (947s left) i915_pm_rc6_residency (media-rc6-accuracy)
[65.231455] Starting subtest: media-rc6-accuracy
[65.234741] Subtest media-rc6-accuracy: SKIP (0.000s)
[65.322906] [009/142] (946s left) gem_exec_fence (basic-wait-all)
[65.551623] Starting subtest: basic-wait-all
[65.584698] Subtest basic-wait-all: SUCCESS (0.033s)
[66.433491] [010/142] (945s left) perf (polling-small-buf)
[67.070126] Starting subtest: polling-small-buf
[67.203348] Subtest polling-small-buf: SUCCESS (0.133s)
[67.253858] [011/142] (945s left) gem_reg_read (timestamp-monotonic)
[67.459664] Starting subtest: timestamp-monotonic
[72.074557] Subtest timestamp-monotonic: SUCCESS (4.614s)
[72.156081] [012/142] (940s left) gen3_mixed_blits
[72.404090] [013/142] (939s left) core_getstats
[72.687729] [014/142] (939s left) kms_vblank (pipe-a-query-idle)
[72.993216] Starting subtest: pipe-A-query-idle
[75.250825] Subtest pipe-A-query-idle: SUCCESS (2.260s)
[75.584089] [015/142] (936s left) gem_ctx_persistence (engines-mixed)
[75.795055] Starting subtest: engines-mixed
[75.796681] Starting dynamic subtest: rcs0
[75.864282] Dynamic subtest rcs0: SUCCESS (0.069s)
[75.881096] Starting dynamic subtest: bcs0
[75.913651] Dynamic subtest bcs0: SUCCESS (0.050s)
[75.928901] Starting dynamic subtest: vcs0
[75.960557] Dynamic subtest vcs0: SUCCESS (0.047s)
[75.975849] Starting dynamic subtest: vecs0
[76.005652] Dynamic subtest vecs0: SUCCESS (0.045s)
[76.007086] Subtest engines-mixed: SUCCESS (0.211s)
[76.086966] [016/142] (936s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf_tiled_ccs)
[76.647135] Starting subtest: pipe-B-crc-sprite-planes-basic-yf_tiled_ccs
[77.165790] Subtest pipe-B-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (0.519s)
[77.686681] [017/142] (934s left) gem_eio (in-flight-contexts-10ms)
[77.926060] Starting subtest: in-flight-contexts-10ms
[89.215795] Subtest in-flight-contexts-10ms: SUCCESS (11.290s)
[89.422257] [018/142] (923s left) kms_big_joiner (invalid-modeset)
[89.731567] Subtest invalid-modeset: SKIP (0.000s)
[89.787211] [019/142] (922s left) gem_set_tiling_vs_gtt
[90.369727] [020/142] (922s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[90.671287] Starting subtest: flip-vs-cursor-crc-legacy
[91.307096] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.631s)
[91.633043] [021/142] (921s left) kms_cursor_legacy (forked-move)
[91.930247] Starting subtest: forked-move
[91.931587] Starting dynamic subtest: pipe-A
[97.437585] Dynamic subtest pipe-A: SUCCESS (5.504s)
[97.455676] Starting dynamic subtest: pipe-B
[102.909709] Dynamic subtest pipe-B: SUCCESS (5.473s)
[102.932738] Starting dynamic subtest: pipe-C
[108.379471] Dynamic subtest pipe-C: SUCCESS (5.466s)
[108.395567] Starting dynamic subtest: all-pipes
[113.839459] Dynamic subtest all-pipes: SUCCESS (5.462s)
[113.842120] Subtest forked-move: SUCCESS (21.908s)
[113.933126] [022/142] (898s left) v3d/v3d_create_bo (create-bo-4096)
[114.194821] Subtest create-bo-4096: SKIP (0.000s)
[114.263676] [023/142] (898s left) kms_atomic (plane-invalid-params-fence)
[114.686249] Starting subtest: plane-invalid-params-fence
[114.727413] Subtest plane-invalid-params-fence: SUCCESS (0.041s)
[115.155337] [024/142] (897s left) kms_addfb_basic (bad-pitch-256)
[115.357744] Starting subtest: bad-pitch-256
[115.359220] Subtest bad-pitch-256: SUCCESS (0.000s)
[115.552428] [025/142] (897s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs)
[116.266243] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[116.591519] [026/142] (896s left) vc4/vc4_perfmon (destroy-invalid-perfmon)
[116.855287] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[116.924394] [027/142] (895s left) gem_exec_schedule (submit-late-slice)
[117.162680] Starting subtest: submit-late-slice
[117.164169] Starting dynamic subtest: rcs0
[117.222616] Dynamic subtest rcs0: SUCCESS (0.060s)
[117.244843] Starting dynamic subtest: bcs0
[117.276329] Dynamic subtest bcs0: SUCCESS (0.053s)
[117.299473] Starting dynamic subtest: vcs0
[117.329242] Dynamic subtest vcs0: SUCCESS (0.052s)
[117.352840] Starting dynamic subtest: vecs0
[117.380719] Dynamic subtest vecs0: SUCCESS (0.051s)
[117.382098] Subtest submit-late-slice: SUCCESS (0.218s)
[117.742246] [028/142] (895s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[118.053227] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[118.055821] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[118.158113] [029/142] (894s left) gem_ctx_isolation (preservation-s3)
[118.385156] Starting subtest: preservation-S3
[118.386894] Starting dynamic subtest: rcs0
[136.455337] Dynamic subtest rcs0: SUCCESS (2.714s)
[136.475889] Starting dynamic subtest: bcs0
[155.544754] Dynamic subtest bcs0: SUCCESS (2.711s)
[155.567202] Starting dynamic subtest: vcs0
[174.410684] Dynamic subtest vcs0: SUCCESS (2.347s)
[174.432572] Starting dynamic subtest: vecs0
[193.464798] Dynamic subtest vecs0: SUCCESS (2.501s)
[193.466609] Subtest preservation-S3: SUCCESS (10.274s)
[198.715649] [030/142] (884s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[199.042976] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[199.048811] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[199.160003] [031/142] (883s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[199.766665] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[199.771195] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[200.141869] [032/142] (882s left) v3d/v3d_wait_bo (used-bo-0ns)
[200.400819] Subtest used-bo-0ns: SKIP (0.000s)
[200.473667] [033/142] (882s left) dmabuf_sync_file (import-multiple-read-only)
[200.683460] Starting subtest: import-multiple-read-only
[200.696040] Subtest import-multiple-read-only: SUCCESS (0.014s)
[200.774767] [034/142] (882s left) kms_cursor_legacy (torture-bo)
[201.072882] Starting subtest: torture-bo
[201.074140] Starting dynamic subtest: pipe-A
[207.928465] Dynamic subtest pipe-A: SUCCESS (6.854s)
[207.950518] Starting dynamic subtest: pipe-B
[213.531645] Dynamic subtest pipe-B: SUCCESS (5.600s)
[213.552465] Starting dynamic subtest: pipe-C
[219.102521] Dynamic subtest pipe-C: SUCCESS (5.572s)
[219.123172] Starting dynamic subtest: all-pipes
[224.668211] Dynamic subtest all-pipes: SUCCESS (5.567s)
[224.669862] Subtest torture-bo: SUCCESS (23.597s)
[224.758268] [035/142] (858s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[225.060062] Starting subtest: sprite-rotation-90-pos-100-0
[231.210936] Subtest sprite-rotation-90-pos-100-0: SUCCESS (6.150s)
[231.638515] [036/142] (851s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[231.939298] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[232.755988] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (0.815s)
[233.074041] [037/142] (849s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[233.755510] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[234.076372] [038/142] (849s left) gem_exec_store (cachelines)
[234.302192] Starting subtest: cachelines
[234.303649] Starting dynamic subtest: rcs0
[234.346644] Dynamic subtest rcs0: SUCCESS (0.043s)
[234.368906] Starting dynamic subtest: bcs0
[234.382301] Dynamic subtest bcs0: SUCCESS (0.035s)
[234.404051] Starting dynamic subtest: vcs0
[234.415452] Dynamic subtest vcs0: SUCCESS (0.032s)
[234.437241] Starting dynamic subtest: vecs0
[234.444472] Dynamic subtest vecs0: SUCCESS (0.028s)
[234.445859] Subtest cachelines: SUCCESS (0.142s)
[234.643078] [039/142] (848s left) i915_pm_rpm (gem-mmap-type)
[236.536289] Starting subtest: gem-mmap-type
[236.539777] Starting dynamic subtest: gtt-smem0
[238.914059] Dynamic subtest gtt-smem0: SUCCESS (2.375s)
[238.936235] Starting dynamic subtest: wb-smem0
[240.276293] Dynamic subtest wb-smem0: SUCCESS (1.363s)
[240.300279] Starting dynamic subtest: wc-smem0
[241.623153] Dynamic subtest wc-smem0: SUCCESS (1.345s)
[241.651652] Starting dynamic subtest: uc-smem0
[242.950615] Dynamic subtest uc-smem0: SUCCESS (1.324s)
[242.953358] Subtest gem-mmap-type: SUCCESS (6.412s)
[243.185765] [040/142] (840s left) gem_exec_create (madvise)
[243.413134] Starting subtest: madvise
[243.414821] Starting dynamic subtest: smem
[263.569848] Dynamic subtest smem: SUCCESS (20.155s)
[263.571204] Subtest madvise: SUCCESS (20.157s)
[265.049835] [041/142] (818s left) gem_mmap_gtt (medium-copy-xy)
[265.254007] Starting subtest: medium-copy-XY
[272.613945] Subtest medium-copy-XY: SUCCESS (7.358s)
[272.719698] [042/142] (810s left) kms_color (ctm-red-to-blue)
[273.154510] Starting subtest: ctm-red-to-blue
[273.155895] Starting dynamic subtest: pipe-A
[273.690152] Dynamic subtest pipe-A: SUCCESS (0.537s)
[273.721021] Starting dynamic subtest: pipe-B
[274.513714] Dynamic subtest pipe-B: SUCCESS (0.822s)
[274.541936] Starting dynamic subtest: pipe-C
[275.494338] Dynamic subtest pipe-C: SUCCESS (0.978s)
[275.495851] Subtest ctm-red-to-blue: SUCCESS (2.341s)
[275.827079] [043/142] (807s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[276.140652] Starting subtest: fbcpsr-suspend
[276.143320] Subtest fbcpsr-suspend: SKIP (0.000s)
[276.243808] [044/142] (807s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[276.445862] Starting subtest: basic-write-cpu-read-gtt
[276.448633] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[276.527547] [045/142] (806s left) kms_vblank (pipe-d-ts-continuation-modeset-rpm)
[276.834555] Subtest pipe-D-ts-continuation-modeset-rpm: SKIP (0.000s)
[276.926763] [046/142] (806s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[277.331906] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[277.334659] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[277.919256] [047/142] (805s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[278.230108] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[278.232867] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[278.335697] [048/142] (805s left) gem_exec_reloc (basic-concurrent0)
[278.554996] Starting subtest: basic-concurrent0
[284.010669] Subtest basic-concurrent0: SUCCESS (5.457s)
[284.219940] [049/142] (799s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[284.439367] Starting subtest: invalid-multi-wait-unsubmitted
[284.441105] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[284.535248] [050/142] (799s left) syncobj_basic (bad-create-flags)
[284.737358] Starting subtest: bad-create-flags
[284.739489] Subtest bad-create-flags: SUCCESS (0.000s)
[284.834536] [051/142] (798s left) gem_mmap_offset (open-flood)
[285.036095] Starting subtest: open-flood
[306.591618] Subtest open-flood: SUCCESS (21.557s)
[306.702206] [052/142] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[307.010908] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[307.013582] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[307.119974] [053/142] (776s left) gem_ctx_shared (q-smoketest)
[307.350264] Starting subtest: Q-smoketest
[307.352043] Starting dynamic subtest: rcs0
[312.827822] Dynamic subtest rcs0: SUCCESS (5.471s)
[312.850060] Starting dynamic subtest: bcs0
[318.289952] Dynamic subtest bcs0: SUCCESS (5.459s)
[318.313426] Starting dynamic subtest: vcs0
[323.760433] Dynamic subtest vcs0: SUCCESS (5.467s)
[323.786271] Starting dynamic subtest: vecs0
[329.225279] Dynamic subtest vecs0: SUCCESS (5.464s)
[329.226757] Subtest Q-smoketest: SUCCESS (21.871s)
[329.436344] [054/142] (754s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[329.750849] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[332.108545] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.359s)
[332.235032] [055/142] (751s left) kms_cursor_crc (cursor-random-32x32)
[332.541291] Starting subtest: cursor-random-32x32
[332.659426] Subtest cursor-random-32x32: SKIP (0.115s)
[332.786786] [056/142] (751s left) sw_sync (sync_busy)
[332.983530] Starting subtest: sync_busy
[332.990804] Subtest sync_busy: SUCCESS (0.008s)
[333.068954] [057/142] (750s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[333.643106] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[333.647079] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[334.117912] [058/142] (749s left) kms_vblank (pipe-b-wait-forked-busy-hang)
[334.426361] Starting subtest: pipe-B-wait-forked-busy-hang
[341.783012] Subtest pipe-B-wait-forked-busy-hang: SUCCESS (7.358s)
[342.132097] [059/142] (741s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf_tiled_ccs)
[342.538502] Starting subtest: pipe-A-crc-primary-rotation-180-yf_tiled_ccs
[343.378157] Subtest pipe-A-crc-primary-rotation-180-yf_tiled_ccs: SUCCESS (0.837s)
[344.076065] [060/142] (739s left) kms_chamelium_edid (dp-edid-read)
[344.478174] Subtest dp-edid-read: SKIP (0.000s)
[344.773744] [061/142] (739s left) gem_bad_reloc (negative-reloc-lut)
[344.984015] Starting subtest: negative-reloc-lut
[344.990514] Subtest negative-reloc-lut: SUCCESS (0.002s)
[345.102151] [062/142] (739s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[345.576844] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[345.583195] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.005s)
[346.110202] [063/142] (738s left) kms_plane (pixel-format-source-clamping)
[346.412822] Starting subtest: pixel-format-source-clamping
[346.414243] Starting dynamic subtest: pipe-A-planes
[353.048508] Dynamic subtest pipe-A-planes: SUCCESS (6.633s)
[353.077875] Starting dynamic subtest: pipe-B-planes
[359.851983] Dynamic subtest pipe-B-planes: SUCCESS (6.799s)
[359.853432] Subtest pixel-format-source-clamping: SUCCESS (13.441s)
[360.208218] [064/142] (724s left) perf (i915-ref-count)
[360.521880] Starting subtest: i915-ref-count
[360.579150] Subtest i915-ref-count: SUCCESS (0.060s)
[360.655985] [065/142] (723s left) syncobj_timeline (reset-multiple-signaled)
[360.859688] Starting subtest: reset-multiple-signaled
[360.864127] Subtest reset-multiple-signaled: SUCCESS (0.002s)
[360.956983] [066/142] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[361.272622] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[361.275529] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[361.391517] [067/142] (722s left) gem_exec_reloc (basic-cpu-wc)
[361.606449] Starting subtest: basic-cpu-wc
[361.627828] Subtest basic-cpu-wc: SUCCESS (0.021s)
[361.824722] [068/142] (722s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[362.131744] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[362.134463] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[362.240637] [069/142] (722s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-signaled)
[362.441736] Starting subtest: invalid-multi-wait-all-available-unsubmitted-signaled
[362.443488] Subtest invalid-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.001s)
[362.540810] [070/142] (721s left) i915_pm_rpm (universal-planes-dpms)
[364.341559] Starting subtest: universal-planes-dpms
[364.344365] Starting dynamic subtest: plane-31
[366.751025] Dynamic subtest plane-31: SUCCESS (2.409s)
[366.779638] Starting dynamic subtest: plane-39
[369.205665] Dynamic subtest plane-39: SUCCESS (2.452s)
[369.233405] Starting dynamic subtest: plane-47
[371.573001] Dynamic subtest plane-47: SUCCESS (2.364s)
[371.607114] Starting dynamic subtest: plane-55
[373.924174] Dynamic subtest plane-55: SUCCESS (2.349s)
[373.927139] Subtest universal-planes-dpms: SUCCESS (9.585s)
[374.393678] [071/142] (710s left) gem_pxp (create-valid-protected-context)
[377.115862] Subtest create-valid-protected-context: SKIP (0.000s)
[377.211581] [072/142] (707s left) kms_cursor_crc (cursor-onscreen-32x10)
[377.547614] Starting subtest: cursor-onscreen-32x10
[377.676987] Subtest cursor-onscreen-32x10: SKIP (0.126s)
[377.797149] [073/142] (706s left) gem_readwrite (read-write)
[378.009687] Starting subtest: read-write
[378.015769] Subtest read-write: SUCCESS (0.001s)
[378.110915] [074/142] (706s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[378.445726] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[378.449320] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[378.562846] [075/142] (706s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[378.893769] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[378.897085] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[378.995890] [076/142] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[379.365850] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[379.371581] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[379.476644] [077/142] (705s left) gen9_exec_parse (batch-without-end)
[379.724864] Starting subtest: batch-without-end
[379.728870] Subtest batch-without-end: SUCCESS (0.004s)
[379.968223] [078/142] (704s left) kms_psr (cursor_blt)
[380.211274] Subtest cursor_blt: SKIP (0.000s)
[380.275514] [079/142] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[380.604616] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[380.607571] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[380.712274] [080/142] (704s left) kms_plane_scaling (plane-upscale-with-pixel-format-20x20)
[381.038145] Starting subtest: plane-upscale-with-pixel-format-20x20
[381.039714] Starting dynamic subtest: pipe-A-DP-1
[381.545214] Dynamic subtest pipe-A-DP-1: SUCCESS (0.507s)
[381.625534] Starting dynamic subtest: pipe-B-DP-1
[382.364792] Dynamic subtest pipe-B-DP-1: SUCCESS (0.814s)
[382.402196] Starting dynamic subtest: pipe-C-DP-1
[382.738913] Dynamic subtest pipe-C-DP-1: SUCCESS (0.369s)
[382.740565] Subtest plane-upscale-with-pixel-format-20x20: SUCCESS (1.707s)
[383.154330] [081/142] (701s left) gem_userptr_blits (set-cache-level)
[383.377633] Starting subtest: set-cache-level
[383.379239] Subtest set-cache-level: SUCCESS (0.002s)
[383.554935] [082/142] (701s left) api_intel_bb (simple-bb-ctx)
[383.759415] Starting subtest: simple-bb-ctx
[383.773884] Subtest simple-bb-ctx: SUCCESS (0.015s)
[383.886260] [083/142] (701s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb)
[384.090331] Subtest primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[384.152884] [084/142] (700s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[384.462011] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[384.464683] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[384.570515] [085/142] (700s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[384.852545] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[384.855163] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.003s)
[384.987309] [086/142] (700s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[385.287511] Starting subtest: 2x-flip-vs-rmfb-interruptible
[385.292839] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.003s)
[385.404962] [087/142] (699s left) kms_panel_fitting (legacy)
[385.716008] Starting subtest: legacy
[385.718537] Subtest legacy: SKIP (0.000s)
[385.803563] [088/142] (699s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[386.058808] Subtest bad-multisync-out-sync: SKIP (0.000s)
[386.137021] [089/142] (699s left) kms_legacy_colorkey (basic)
[386.446241] Starting subtest: basic
[386.447533] Starting dynamic subtest: pipe-A
[386.472819] Dynamic subtest pipe-A: SUCCESS (0.030s)
[386.501371] Starting dynamic subtest: pipe-B
[386.502690] Dynamic subtest pipe-B: SUCCESS (0.001s)
[386.525534] Starting dynamic subtest: pipe-C
[386.526777] Dynamic subtest pipe-C: SUCCESS (0.000s)
[386.528046] Subtest basic: SUCCESS (0.039s)
[386.571232] [090/142] (698s left) kms_vblank (pipe-c-ts-continuation-modeset-hang)
[386.874275] Starting subtest: pipe-C-ts-continuation-modeset-hang
[394.769990] Subtest pipe-C-ts-continuation-modeset-hang: SUCCESS (7.895s)
[395.117182] [091/142] (690s left) api_intel_allocator (open-vm)
[395.321124] Starting subtest: open-vm
[395.325870] Subtest open-vm: SUCCESS (0.005s)
[395.449970] [092/142] (690s left) api_intel_bb (destroy-bb)
[395.656256] Starting subtest: destroy-bb
[395.678240] Subtest destroy-bb: SUCCESS (0.024s)
[395.800221] [093/142] (689s left) gem_softpin (allocator-nopin)
[396.011130] Starting subtest: allocator-nopin
[396.253698] Subtest allocator-nopin: SUCCESS (0.242s)
[396.383458] [094/142] (689s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[396.917206] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[396.920038] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[397.387445] [095/142] (688s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[397.691660] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[400.107180] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.418s)
[400.254302] [096/142] (685s left) vc4/vc4_wait_seqno (bad-seqno-1ns)
[400.525857] Subtest bad-seqno-1ns: SKIP (0.000s)
[400.603977] [097/142] (685s left) syncobj_timeline (etime-multi-wait-all-submitted)
[400.811037] Starting subtest: etime-multi-wait-all-submitted
[400.917727] Subtest etime-multi-wait-all-submitted: SUCCESS (0.106s)
[401.021658] [098/142] (684s left) kms_chamelium_edid (hdmi-mode-timings)
[401.426293] Subtest hdmi-mode-timings: SKIP (0.000s)
[401.729018] [099/142] (684s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[402.406637] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[402.409360] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[402.786891] [100/142] (683s left) gem_exec_balancer (bonded-true-hang)
[406.895147] Starting subtest: bonded-true-hang
[410.570075] Subtest bonded-true-hang: SUCCESS (3.674s)
[410.670692] [101/142] (675s left) gem_mmap_gtt (fault-concurrent-y)
[410.875726] Starting subtest: fault-concurrent-Y
[414.262806] Subtest fault-concurrent-Y: SUCCESS (3.387s)
[414.486549] [102/142] (671s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[414.695038] Starting subtest: invalid-single-wait-all-unsubmitted
[414.696636] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[414.785337] [103/142] (671s left) i915_pciid
[415.087250] [104/142] (670s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[415.393874] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[415.396483] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[415.504489] [105/142] (670s left) gem_wait (write-busy)
[415.746108] Starting subtest: write-busy
[415.747800] Starting dynamic subtest: all-engines
[416.279502] Dynamic subtest all-engines: SUCCESS (0.532s)
[416.312040] Starting dynamic subtest: rcs0
[416.802336] Dynamic subtest rcs0: SUCCESS (0.520s)
[416.833774] Starting dynamic subtest: bcs0
[417.325197] Dynamic subtest bcs0: SUCCESS (0.520s)
[417.355004] Starting dynamic subtest: vcs0
[417.851672] Dynamic subtest vcs0: SUCCESS (0.522s)
[417.879837] Starting dynamic subtest: vecs0
[418.374375] Dynamic subtest vecs0: SUCCESS (0.520s)
[418.376125] Subtest write-busy: SUCCESS (2.630s)
[418.621348] [106/142] (667s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[418.936702] Starting subtest: multiplane-rotation-cropping-top
[433.058305] Subtest multiplane-rotation-cropping-top: SUCCESS (14.126s)
[433.170307] [107/142] (653s left) gem_partial_pwrite_pread (write-display)
[433.388567] Starting subtest: write-display
[447.829845] Subtest write-display: SUCCESS (14.442s)
[447.953420] [108/142] (638s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[448.272309] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[448.275324] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[448.387249] [109/142] (637s left) gem_exec_balancer (individual)
[448.616064] Starting subtest: individual
[452.556817] Subtest individual: SUCCESS (3.938s)
[456.555215] [110/142] (629s left) v3d/v3d_get_param (get-bad-flags)
[456.825516] Subtest get-bad-flags: SKIP (0.000s)
[456.905298] [111/142] (629s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[457.243769] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[458.624106] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.379s)
[458.773458] [112/142] (627s left) kms_big_fb (linear-32bpp-rotate-90)
[459.101309] Starting subtest: linear-32bpp-rotate-90
[459.183481] Subtest linear-32bpp-rotate-90: SKIP (0.081s)
[459.305691] [113/142] (627s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[459.634613] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[459.637847] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[459.740175] [114/142] (626s left) kms_invalid_mode (bad-hsync-start)
[460.044645] Starting subtest: bad-hsync-start
[460.046024] Starting dynamic subtest: DP-1-pipe-A
[460.147066] Dynamic subtest DP-1-pipe-A: SUCCESS (0.103s)
[460.185087] Starting dynamic subtest: DP-1-pipe-B
[460.186807] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[460.227869] Starting dynamic subtest: DP-1-pipe-C
[460.229767] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[460.231690] Subtest bad-hsync-start: SUCCESS (0.145s)
[460.516610] [115/142] (626s left) gem_lmem_swapping (parallel-random-verify-ccs)
[460.729225] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[460.797603] [116/142] (625s left) perf (global-sseu-config)
[461.087516] Starting subtest: global-sseu-config
[461.089177] Starting dynamic subtest: 0-rcs0
[461.204768] Dynamic subtest 0-rcs0: SUCCESS (0.115s)
[461.206325] Subtest global-sseu-config: SUCCESS (0.118s)
[461.270365] [117/142] (625s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[461.584415] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[463.683450] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.102s)
[463.832176] [118/142] (622s left) kms_addfb_basic (small-bo)
[464.139055] Starting subtest: small-bo
[464.140480] Subtest small-bo: SUCCESS (0.000s)
[464.249842] [119/142] (622s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_mc_ccs)
[464.888054] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs
[464.890834] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[465.224766] [120/142] (621s left) kms_plane_lowres (tiling-none)
[465.527587] Starting subtest: tiling-none
[465.528959] Starting dynamic subtest: pipe-A-DP-1
[470.853802] Dynamic subtest pipe-A-DP-1: SUCCESS (5.326s)
[470.980951] Starting dynamic subtest: pipe-B-DP-1
[476.225776] Dynamic subtest pipe-B-DP-1: SUCCESS (5.269s)
[476.352746] Starting dynamic subtest: pipe-C-DP-1
[479.815306] Dynamic subtest pipe-C-DP-1: SUCCESS (3.488s)
[479.930579] Subtest tiling-none: SUCCESS (14.405s)
[480.405121] [121/142] (606s left) gem_create (create-ext-cpu-access-big)
[480.751076] Starting subtest: create-ext-cpu-access-big
[480.754220] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[480.853815] [122/142] (606s left) gem_exec_fence (syncobj-unused-fence)
[481.528716] Starting subtest: syncobj-unused-fence
[481.535328] Subtest syncobj-unused-fence: SUCCESS (0.007s)
[481.904068] [123/142] (605s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[482.574579] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[482.901179] [124/142] (604s left) kms_async_flips (crc)
[483.206538] Starting subtest: crc
[483.676327] Starting dynamic subtest: pipe-A-DP-1
[487.300033] Dynamic subtest pipe-A-DP-1: FAIL (3.127s)
[487.361711] Starting dynamic subtest: pipe-B-DP-1
[490.333595] Dynamic subtest pipe-B-DP-1: FAIL (2.591s)
[490.367421] Starting dynamic subtest: pipe-C-DP-1
[493.331002] Dynamic subtest pipe-C-DP-1: FAIL (2.582s)
[493.332270] Subtest crc: FAIL (9.689s)
[493.544338] [125/142] (593s left) gem_mmap (short-mmap)
[493.754485] Starting subtest: short-mmap
[493.756318] Subtest short-mmap: SUCCESS (0.001s)
[493.859685] [126/142] (593s left) kms_flip (2x-plain-flip)
[494.163199] Starting subtest: 2x-plain-flip
[494.166032] Subtest 2x-plain-flip: SKIP (0.003s)
[494.294127] [127/142] (592s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[494.502371] Starting subtest: single-wait-all-for-submit-available-signaled
[494.504156] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[494.609128] [128/142] (592s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs)
[495.167405] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs
[495.172121] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SUCCESS (0.002s)
[495.611030] [129/142] (591s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[495.920277] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[495.922967] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[496.027028] [130/142] (591s left) perf (mi-rpc)
[496.329250] Starting subtest: mi-rpc
[496.382698] Subtest mi-rpc: SUCCESS (0.053s)
[496.442471] [131/142] (590s left) gem_mmap_wc (read-write)
[496.646244] Starting subtest: read-write
[496.677956] Subtest read-write: SUCCESS (0.031s)
[496.776212] [132/142] (590s left) gem_exec_flush (basic-wb-prw-default)
[497.007222] Starting subtest: basic-wb-prw-default
[502.505577] Subtest basic-wb-prw-default: SUCCESS (5.497s)
[502.727247] [133/142] (584s left) gem_mmap_wc (write-read)
[502.932461] Starting subtest: write-read
[502.966555] Subtest write-read: SUCCESS (0.031s)
[503.076580] [134/142] (584s left) gem_mmap_gtt (big-bo-tiledy)
[503.281510] Starting subtest: big-bo-tiledY
[506.024873] Subtest big-bo-tiledY: SUCCESS (2.744s)
[506.253700] [135/142] (581s left) gem_ppgtt (blt-vs-render-ctxn)
[506.594328] Starting subtest: blt-vs-render-ctxN
[539.218189] Subtest blt-vs-render-ctxN: SUCCESS (32.623s)
[539.329756] [136/142] (548s left) kms_big_fb (x-tiled-addfb)
[539.781437] Starting subtest: x-tiled-addfb
[539.783028] Subtest x-tiled-addfb: SUCCESS (0.001s)
[539.893117] [137/142] (547s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf_tiled_ccs)
[540.566978] Starting subtest: pipe-C-crc-sprite-planes-basic-yf_tiled_ccs
[540.572614] Subtest pipe-C-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.004s)
[540.897957] [138/142] (546s left) kms_content_protection (atomic-dpms)
[541.234080] Starting subtest: atomic-dpms
[541.268114] Starting dynamic subtest: pipe-A-DP-1
[661.382404] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[662.145919] Closing watchdogs
[662.149164] Initializing watchdogs
[662.149353]   /dev/watchdog0
[662.179069] [139/142] (425s left) prime_mmap_coherency (write)
[662.398141] Starting subtest: write
[667.805046] Subtest write: SUCCESS (5.407s)
[668.344669] [140/142] (419s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[668.570326] Starting subtest: yf-tiled-ccs-to-y-tiled
[668.572111] Starting dynamic subtest: smem
[668.888335] Dynamic subtest smem: SUCCESS (0.316s)
[668.890328] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.320s)
[669.099126] [141/142] (418s left) vgem_basic (dmabuf-fence)
[669.316419] Starting subtest: dmabuf-fence
[669.318056] Subtest dmabuf-fence: SUCCESS (0.001s)
[669.396846] [142/142] (418s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[669.719701] Starting subtest: 4-tiled-64bpp-rotate-180
[669.722572] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[669.826227] Closing watchdogs
Done.