[43.331135] Initializing watchdogs [43.331245] /dev/watchdog0 [43.343594] [001/132] (960s left) core_auth (getclient-simple) [43.391273] Starting subtest: getclient-simple [43.405646] Subtest getclient-simple: SUCCESS (0.016s) [43.483479] [002/132] (960s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [43.582772] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [43.587289] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [43.652987] [003/132] (960s left) gem_exec_schedule (noreorder) [43.850550] Starting subtest: noreorder [43.853580] Starting dynamic subtest: rcs0 [43.898811] Dynamic subtest rcs0: SUCCESS (0.050s) [43.910940] Starting dynamic subtest: vcs0 [45.442382] Dynamic subtest vcs0: SUCCESS (1.541s) [45.455698] Starting dynamic subtest: vcs1 [47.490388] Dynamic subtest vcs1: SUCCESS (2.049s) [47.502465] Starting dynamic subtest: vecs0 [49.473913] Dynamic subtest vecs0: SUCCESS (1.983s) [49.488330] Starting dynamic subtest: ccs0 [49.551459] Dynamic subtest ccs0: SUCCESS (0.079s) [49.554149] Subtest noreorder: SUCCESS (5.703s) [49.730197] [004/132] (954s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [49.854358] Starting subtest: bad-rotation-90-y-tiled-ccs [49.856879] Starting dynamic subtest: pipe-A-eDP-1 [49.862046] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [49.872959] Starting dynamic subtest: pipe-B-eDP-1 [49.878151] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [49.889833] Starting dynamic subtest: pipe-C-eDP-1 [49.894706] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [49.906072] Starting dynamic subtest: pipe-D-eDP-1 [49.910951] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [49.915924] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.006s) [49.937350] [005/132] (954s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [50.014936] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [50.017402] Starting dynamic subtest: pipe-A-eDP-1 [50.022130] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [50.032854] Starting dynamic subtest: pipe-B-eDP-1 [50.037171] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [50.043482] Starting dynamic subtest: pipe-C-eDP-1 [50.048062] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [50.055073] Starting dynamic subtest: pipe-D-eDP-1 [50.060979] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [50.066359] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s) [50.087370] [006/132] (953s left) gem_exec_params (batch-first) [50.166973] Starting subtest: batch-first [50.180600] Subtest batch-first: SUCCESS (0.014s) [50.274570] [007/132] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [50.383365] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [50.388041] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [50.456172] [008/132] (953s left) kms_fb_coherency (memset-crc) [50.528720] Starting subtest: memset-crc [50.531202] Starting dynamic subtest: mmap-offset-wc [51.040606] Dynamic subtest mmap-offset-wc: SUCCESS (0.509s) [51.342885] Starting dynamic subtest: mmap-offset-uc [57.575442] Dynamic subtest mmap-offset-uc: SUCCESS (6.240s) [57.868223] Subtest memset-crc: SUCCESS (7.338s) [58.757677] [009/132] (945s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [58.851843] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [64.069909] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.224s) [64.184978] [010/132] (939s left) gem_ctx_param (set-priority-not-supported) [64.245557] Starting subtest: set-priority-not-supported [64.249952] Subtest set-priority-not-supported: SKIP (0.000s) [64.308654] [011/132] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render) [64.431714] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render [69.341241] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SUCCESS (4.913s) [69.477321] [012/132] (934s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [69.573126] Starting subtest: cursorB-vs-flipA-atomic-transitions [69.577939] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s) [69.675990] [013/132] (934s left) kms_dither (fb-8bpc-vs-panel-6bpc) [69.784639] Starting subtest: fb-8bpc-vs-panel-6bpc [69.787065] Starting dynamic subtest: pipe-A-eDP-1 [71.227806] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.445s) [71.230470] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.445s) [72.133385] [014/132] (932s left) kms_cursor_edge_walk (128x128-left-edge) [72.244945] Starting subtest: 128x128-left-edge [72.247382] Starting dynamic subtest: pipe-A-eDP-1 [75.797692] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.554s) [75.809308] Starting dynamic subtest: pipe-D-eDP-1 [79.025909] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.223s) [79.028533] Subtest 128x128-left-edge: SUCCESS (6.780s) [79.942228] [015/132] (924s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [80.030298] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [80.035053] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [80.097136] [016/132] (924s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu) [80.172290] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu [82.960539] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (2.794s) [83.077514] [017/132] (921s left) kms_vblank (ts-continuation-idle-hang) [83.188233] Starting subtest: ts-continuation-idle-hang [83.190759] Starting dynamic subtest: pipe-A-eDP-1 [97.299257] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.105s) [97.311832] Starting dynamic subtest: pipe-D-eDP-1 [122.251711] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.949s) [122.254431] Subtest ts-continuation-idle-hang: SUCCESS (39.064s) [123.140371] [018/132] (881s left) kms_cursor_crc (cursor-random-64x64) [123.309065] Starting subtest: cursor-random-64x64 [123.314039] Starting dynamic subtest: pipe-A-eDP-1 [127.250823] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.936s) [127.290467] Starting dynamic subtest: pipe-D-eDP-1 [131.891227] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.603s) [131.893810] Subtest cursor-random-64x64: SUCCESS (8.580s) [132.775077] [019/132] (871s left) kms_psr (fbc-pr-dpms) [132.853413] Starting subtest: fbc-pr-dpms [132.857795] Subtest fbc-pr-dpms: SKIP (0.000s) [132.912596] [020/132] (871s left) i915_pm_freq_mult (media-freq) [132.980114] Starting subtest: media-freq [132.982511] Starting dynamic subtest: gt0 [132.986884] Dynamic subtest gt0: SKIP (0.000s) [132.998623] Starting dynamic subtest: gt1 [133.003281] Dynamic subtest gt1: SKIP (0.000s) [133.008045] Subtest media-freq: SKIP (0.001s) [133.055589] [021/132] (871s left) gem_pxp (protected-encrypted-src-copy-not-readible) [135.710900] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s) [135.737745] [022/132] (868s left) kms_content_protection (atomic-dpms) [135.862671] Starting subtest: atomic-dpms [139.421622] Subtest atomic-dpms: SKIP (3.557s) [140.689342] [023/132] (863s left) v3d/v3d_submit_cl (bad-multisync-pad) [140.785390] Subtest bad-multisync-pad: SKIP (0.000s) [140.832068] [024/132] (863s left) perf_pmu (busy) [140.904787] Starting subtest: busy [140.907480] Starting dynamic subtest: rcs0 [141.498776] Dynamic subtest rcs0: SUCCESS (0.593s) [141.513783] Starting dynamic subtest: bcs0 [142.060475] Dynamic subtest bcs0: SUCCESS (0.561s) [142.073943] Starting dynamic subtest: vcs0 [143.499688] Dynamic subtest vcs0: SUCCESS (1.438s) [143.513051] Starting dynamic subtest: vcs1 [145.484606] Dynamic subtest vcs1: SUCCESS (1.984s) [145.498344] Starting dynamic subtest: vecs0 [147.467567] Dynamic subtest vecs0: SUCCESS (1.983s) [147.480885] Starting dynamic subtest: ccs0 [148.035755] Dynamic subtest ccs0: SUCCESS (0.568s) [148.038898] Subtest busy: SUCCESS (7.131s) [148.122650] [025/132] (856s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20) [148.187747] Starting subtest: planes-downscale-factor-0-25-upscale-20x20 [148.190824] Starting dynamic subtest: pipe-A-eDP-1 [148.200285] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s) [148.207364] Starting dynamic subtest: pipe-B-eDP-1 [148.215029] Dynamic subtest pipe-B-eDP-1: SKIP (0.016s) [148.221680] Starting dynamic subtest: pipe-C-eDP-1 [148.234985] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s) [148.254811] Starting dynamic subtest: pipe-D-eDP-1 [148.259814] Dynamic subtest pipe-D-eDP-1: SKIP (0.016s) [148.264593] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.060s) [148.310938] [026/132] (856s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [148.382176] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [148.387675] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [148.560155] [027/132] (855s left) kms_big_fb (4-tiled-8bpp-rotate-90) [148.675613] Starting subtest: 4-tiled-8bpp-rotate-90 [148.693569] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s) [148.790154] [028/132] (855s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [148.900322] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [148.904950] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [148.982748] [029/132] (855s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [149.044138] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [149.079703] [030/132] (855s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [149.159625] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [149.163596] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [149.226173] [031/132] (855s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt) [149.319236] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt [152.256997] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (2.940s) [152.373667] [032/132] (852s left) syncobj_timeline (multi-wait-all-available-submitted) [152.441049] Starting subtest: multi-wait-all-available-submitted [152.443301] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s) [152.517762] [033/132] (852s left) syncobj_timeline (wait-all-for-submit-snapshot) [152.588719] Starting subtest: wait-all-for-submit-snapshot [152.669844] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [152.737060] [034/132] (851s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [152.811282] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [152.813464] Starting dynamic subtest: pipe-A-default-mode [153.161713] Dynamic subtest pipe-A-default-mode: SKIP (0.348s) [153.167067] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.349s) [153.983348] [035/132] (850s left) gem_exec_params (invalid-ring) [154.041971] Starting subtest: invalid-ring [154.044217] Subtest invalid-ring: SUCCESS (0.000s) [154.143169] [036/132] (850s left) perf_pmu (busy-check-all) [154.203614] Starting subtest: busy-check-all [154.206375] Starting dynamic subtest: rcs0 [154.749387] Dynamic subtest rcs0: SUCCESS (0.550s) [154.762932] Starting dynamic subtest: bcs0 [155.302196] Dynamic subtest bcs0: SUCCESS (0.553s) [155.315767] Starting dynamic subtest: vcs0 [156.492240] Dynamic subtest vcs0: SUCCESS (1.188s) [156.505765] Starting dynamic subtest: vcs1 [158.475939] Dynamic subtest vcs1: SUCCESS (1.983s) [158.489956] Starting dynamic subtest: vecs0 [160.460391] Dynamic subtest vecs0: SUCCESS (1.983s) [160.474079] Starting dynamic subtest: ccs0 [161.021338] Dynamic subtest ccs0: SUCCESS (0.562s) [161.024704] Subtest busy-check-all: SUCCESS (6.822s) [161.113069] [037/132] (843s left) gem_bad_reloc (negative-reloc-lut) [161.181318] Subtest negative-reloc-lut: SKIP (0.000s) [161.232670] [038/132] (843s left) kms_cursor_crc (cursor-onscreen-512x170) [161.478052] Starting subtest: cursor-onscreen-512x170 [161.482743] Subtest cursor-onscreen-512x170: SKIP (0.001s) [161.587066] [039/132] (843s left) gem_exec_params (readonly) [161.660940] Starting subtest: readonly [161.666195] Subtest readonly: SUCCESS (0.005s) [161.757304] [040/132] (843s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [161.879810] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [161.884180] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [161.956878] [041/132] (842s left) gen9_exec_parse (valid-registers) [162.021491] Subtest valid-registers: SKIP (0.000s) [162.073331] [042/132] (842s left) kms_psr (psr-sprite-plane-onoff) [162.162491] Starting subtest: psr-sprite-plane-onoff [162.164687] Starting dynamic subtest: eDP-1 [163.992952] Dynamic subtest eDP-1: SUCCESS (1.830s) [163.995469] Subtest psr-sprite-plane-onoff: SUCCESS (1.831s) [164.868403] [043/132] (840s left) dumb_buffer (create-clear) [164.940440] Starting subtest: create-clear [199.063233] Subtest create-clear: SUCCESS (34.073s) [199.097473] [044/132] (805s left) gem_ctx_engines (execute-one) [199.173998] Starting subtest: execute-one [203.411167] Subtest execute-one: SUCCESS (4.237s) [203.592087] [045/132] (801s left) kms_big_joiner (basic) [203.688129] Subtest basic: SKIP (0.000s) [203.713327] [046/132] (801s left) kms_getfb (getfb2-handle-closed) [203.790578] Starting subtest: getfb2-handle-closed [203.793080] Subtest getfb2-handle-closed: SUCCESS (0.000s) [203.870795] [047/132] (801s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [203.949480] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs [203.952028] Starting dynamic subtest: pipe-A-eDP-1 [203.958367] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [203.969471] Starting dynamic subtest: pipe-B-eDP-1 [203.975872] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [203.988469] Starting dynamic subtest: pipe-C-eDP-1 [203.995941] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [204.008143] Starting dynamic subtest: pipe-D-eDP-1 [204.015164] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [204.019750] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.002s) [204.042664] [048/132] (801s left) kms_mmap_write_crc (main) [204.150591] Starting subtest: main [204.152533] Starting dynamic subtest: pipe-A-eDP-1 [207.982572] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.831s) [207.985190] Subtest main: SUCCESS (3.832s) [208.900257] [049/132] (796s left) gem_ctx_shared (q-promotion) [208.977861] Starting subtest: Q-promotion [208.980842] Starting dynamic subtest: rcs0 [209.140355] Dynamic subtest rcs0: SUCCESS (0.161s) [209.161924] Starting dynamic subtest: vcs0 [209.264622] Dynamic subtest vcs0: SUCCESS (0.123s) [209.286928] Starting dynamic subtest: vcs1 [209.350380] Dynamic subtest vcs1: SUCCESS (0.086s) [209.371351] Starting dynamic subtest: vecs0 [209.444270] Dynamic subtest vecs0: SUCCESS (0.093s) [209.462760] Starting dynamic subtest: ccs0 [209.543327] Dynamic subtest ccs0: SUCCESS (0.098s) [209.545911] Subtest Q-promotion: SUCCESS (0.566s) [210.580076] [050/132] (794s left) kms_psr (fbc-psr2-sprite-blt) [210.671645] Starting subtest: fbc-psr2-sprite-blt [210.673706] Starting dynamic subtest: eDP-1 [210.677754] Dynamic subtest eDP-1: SKIP (0.000s) [210.682146] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [210.734937] [051/132] (794s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [210.860772] Starting subtest: cursorA-vs-flipA-atomic [222.037349] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.176s) [222.912178] [052/132] (782s left) gem_ctx_isolation (nonpriv-switch) [222.983042] Starting subtest: nonpriv-switch [222.985837] Starting dynamic subtest: rcs0 [223.214259] Dynamic subtest rcs0: SUCCESS (0.231s) [223.230902] Starting dynamic subtest: bcs0 [223.502747] Dynamic subtest bcs0: SUCCESS (0.288s) [223.516349] Starting dynamic subtest: vcs0 [223.781648] Dynamic subtest vcs0: SUCCESS (0.279s) [223.795533] Starting dynamic subtest: vcs1 [225.721686] Dynamic subtest vcs1: SUCCESS (1.939s) [225.730691] Starting dynamic subtest: vecs0 [227.797074] Dynamic subtest vecs0: SUCCESS (2.075s) [227.810653] Starting dynamic subtest: ccs0 [229.767904] Dynamic subtest ccs0: SUCCESS (1.970s) [229.770459] Subtest nonpriv-switch: SUCCESS (6.785s) [230.011346] [053/132] (775s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [230.092041] Starting subtest: multi-wait-all-for-submit-available-submitted [230.094571] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [230.172148] [054/132] (775s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [230.264665] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [230.269622] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [230.344334] [055/132] (774s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [230.437689] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [230.442367] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [230.513278] [056/132] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [230.632302] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [230.636973] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [230.715628] [057/132] (774s left) syncobj_wait (multi-wait-submitted) [230.789801] Starting subtest: multi-wait-submitted [230.895983] Subtest multi-wait-submitted: SUCCESS (0.107s) [230.965545] [058/132] (774s left) kms_async_flips (test-time-stamp) [231.073938] Starting subtest: test-time-stamp [231.468549] Starting dynamic subtest: pipe-A-eDP-1 [232.327889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.856s) [232.712841] Starting dynamic subtest: pipe-B-eDP-1 [233.587626] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.885s) [233.963184] Starting dynamic subtest: pipe-C-eDP-1 [234.803848] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.849s) [235.190957] Starting dynamic subtest: pipe-D-eDP-1 [236.087644] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.901s) [236.091129] Subtest test-time-stamp: SUCCESS (5.011s) [237.376692] [059/132] (767s left) gem_mmap_gtt (zero-extend) [237.439897] Subtest zero-extend: SKIP (0.000s) [237.475514] [060/132] (767s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [237.579919] Starting subtest: nonblocking-modeset-vs-cursor-atomic [239.129046] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.548s) [240.006960] [061/132] (765s left) kms_pm_rpm (cursor-dpms) [241.628221] Starting subtest: cursor-dpms [273.439722] Subtest cursor-dpms: SUCCESS (31.782s) [274.569971] [062/132] (730s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render) [274.661751] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render [277.670213] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (3.014s) [277.785207] [063/132] (727s left) gem_lmem_swapping (verify-random) [277.833191] Subtest verify-random: SKIP (0.000s) [277.870504] [064/132] (727s left) kms_prop_blob (invalid-set-prop) [277.930040] Starting subtest: invalid-set-prop [277.931998] Subtest invalid-set-prop: SUCCESS (0.000s) [278.000336] [065/132] (727s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [278.078049] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [279.134460] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.059s) [279.251979] [066/132] (726s left) gem_fence_thrash (bo-write-verify-none) [279.307479] Starting subtest: bo-write-verify-none [279.324096] Subtest bo-write-verify-none: SKIP (0.015s) [279.370642] [067/132] (726s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [281.671865] Starting subtest: modeset-lpsp-stress-no-wait [292.952148] Subtest modeset-lpsp-stress-no-wait: SUCCESS (11.281s) [293.031500] [068/132] (712s left) prime_self_import (basic-with_one_bo) [293.079254] Starting subtest: basic-with_one_bo [293.092059] Subtest basic-with_one_bo: SUCCESS (0.012s) [293.166279] [069/132] (712s left) kms_plane_alpha_blend (constant-alpha-mid) [293.282823] Starting subtest: constant-alpha-mid [293.537067] Starting dynamic subtest: pipe-A-eDP-1 [294.521677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.983s) [294.536471] Starting dynamic subtest: pipe-D-eDP-1 [296.212075] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.685s) [296.214157] Subtest constant-alpha-mid: SUCCESS (2.930s) [297.095928] [070/132] (708s left) kms_sequence (queue-busy) [297.187737] Starting subtest: queue-busy [297.190674] Starting dynamic subtest: pipe-A-eDP-1 [299.122406] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s) [299.136439] Starting dynamic subtest: pipe-B-eDP-1 [301.830731] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.705s) [301.845310] Starting dynamic subtest: pipe-C-eDP-1 [304.488178] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.655s) [304.502532] Starting dynamic subtest: pipe-D-eDP-1 [307.196573] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.706s) [307.199062] Subtest queue-busy: SUCCESS (10.011s) [308.104698] [071/132] (697s left) gem_exec_whisper (basic-queues-all) [308.203873] Starting subtest: basic-queues-all [325.673695] Subtest basic-queues-all: SUCCESS (17.466s) [325.854689] [072/132] (679s left) gem_mmap_wc (copy) [325.915410] Subtest copy: SKIP (0.000s) [325.956978] [073/132] (679s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [326.057518] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [326.062520] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [326.154390] [074/132] (679s left) gem_render_copy (x-tiled) [326.234883] Starting subtest: x-tiled [326.237696] Starting dynamic subtest: smem [326.282444] Dynamic subtest smem: SUCCESS (0.046s) [326.285590] Subtest x-tiled: SUCCESS (0.047s) [326.465406] [075/132] (679s left) gem_spin_batch (resubmit-all) [326.556112] Starting subtest: resubmit-all [326.559139] Starting dynamic subtest: rcs0 [326.584049] Dynamic subtest rcs0: SUCCESS (0.027s) [326.594236] Starting dynamic subtest: bcs0 [326.597237] Dynamic subtest bcs0: SUCCESS (0.002s) [326.612143] Starting dynamic subtest: vcs0 [326.614735] Dynamic subtest vcs0: SUCCESS (0.002s) [326.626818] Starting dynamic subtest: vcs1 [326.629308] Dynamic subtest vcs1: SUCCESS (0.002s) [326.639503] Starting dynamic subtest: vecs0 [326.642182] Dynamic subtest vecs0: SUCCESS (0.002s) [326.657178] Starting dynamic subtest: ccs0 [326.659997] Dynamic subtest ccs0: SUCCESS (0.001s) [326.662669] Subtest resubmit-all: SUCCESS (0.043s) [328.495329] [076/132] (677s left) kms_properties (plane-properties-atomic) [328.581575] Starting subtest: plane-properties-atomic [332.412675] Subtest plane-properties-atomic: SUCCESS (3.831s) [333.320234] [077/132] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [333.424287] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [333.429061] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [333.519218] [078/132] (672s left) gem_exec_schedule (u-submit-early-slice) [333.615260] Starting subtest: u-submit-early-slice [333.617829] Starting dynamic subtest: rcs0 [333.677986] Dynamic subtest rcs0: SUCCESS (0.065s) [333.694699] Starting dynamic subtest: bcs0 [333.792723] Dynamic subtest bcs0: SUCCESS (0.113s) [333.808310] Starting dynamic subtest: vcs0 [333.856393] Dynamic subtest vcs0: SUCCESS (0.063s) [333.871507] Starting dynamic subtest: vcs1 [333.910094] Dynamic subtest vcs1: SUCCESS (0.053s) [333.921281] Starting dynamic subtest: vecs0 [333.961677] Dynamic subtest vecs0: SUCCESS (0.051s) [333.976173] Starting dynamic subtest: ccs0 [334.012068] Dynamic subtest ccs0: SUCCESS (0.050s) [334.014512] Subtest u-submit-early-slice: SUCCESS (0.400s) [335.575709] [079/132] (670s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [335.680454] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [335.685129] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [335.770309] [080/132] (670s left) perf (missing-sample-flags) [335.926398] Starting subtest: missing-sample-flags [335.928784] Subtest missing-sample-flags: SUCCESS (0.002s) [335.961243] [081/132] (669s left) gen7_exec_parse (basic-offset) [336.021176] Subtest basic-offset: SKIP (0.000s) [336.078841] [082/132] (669s left) kms_psr (psr2-cursor-plane-move) [336.172692] Starting subtest: psr2-cursor-plane-move [336.175402] Starting dynamic subtest: eDP-1 [337.943446] Dynamic subtest eDP-1: SUCCESS (1.772s) [337.946503] Subtest psr2-cursor-plane-move: SUCCESS (1.773s) [338.824448] [083/132] (667s left) api_intel_bb (delta-check) [338.893649] Starting subtest: delta-check [338.906138] Subtest delta-check: SUCCESS (0.015s) [339.004509] [084/132] (667s left) kms_big_fb (4-tiled-32bpp-rotate-90) [339.123854] Starting subtest: 4-tiled-32bpp-rotate-90 [339.147864] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.023s) [339.244650] [085/132] (666s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [339.334101] Starting subtest: missing-ccs-buffer-y-tiled-ccs [339.336965] Starting dynamic subtest: pipe-A-eDP-1 [339.341246] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [339.350993] Starting dynamic subtest: pipe-B-eDP-1 [339.355518] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [339.363242] Starting dynamic subtest: pipe-C-eDP-1 [339.368118] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [339.376265] Starting dynamic subtest: pipe-D-eDP-1 [339.381228] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [339.386119] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s) [339.405912] [086/132] (666s left) gen3_mixed_blits [339.494773] [087/132] (666s left) gem_exec_fence (invalid-fence-array) [339.979163] Starting subtest: invalid-fence-array [339.985430] Subtest invalid-fence-array: SUCCESS (0.003s) [341.495397] [088/132] (664s left) kms_addfb_basic (bo-too-small-due-to-tiling) [341.561643] Starting subtest: bo-too-small-due-to-tiling [341.566164] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [341.640760] [089/132] (664s left) gem_userptr_blits (sync-unmap-after-close) [341.726365] Starting subtest: sync-unmap-after-close [341.735962] Subtest sync-unmap-after-close: SUCCESS (0.012s) [341.847842] [090/132] (664s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [341.957657] Starting subtest: basic-busy-flip-before-cursor-atomic [341.962900] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [342.062050] [091/132] (664s left) prime_vgem (basic-fence-mmap) [342.159854] Starting subtest: basic-fence-mmap [342.164766] Subtest basic-fence-mmap: SKIP (0.000s) [342.249878] [092/132] (663s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [342.311728] Starting subtest: multi-wait-all-for-submit-unsubmitted [342.417643] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [342.486753] [093/132] (663s left) kms_chamelium_hpd (hdmi-hpd-fast) [342.861586] Subtest hdmi-hpd-fast: SKIP (0.000s) [343.722096] [094/132] (662s left) gem_ctx_persistence (legacy-engines-mixed) [343.792596] Starting subtest: legacy-engines-mixed [343.795582] Starting dynamic subtest: render [343.875867] Dynamic subtest render: SUCCESS (0.083s) [343.894080] Starting dynamic subtest: bsd1 [343.923653] Dynamic subtest bsd1: SUCCESS (0.046s) [343.939411] Starting dynamic subtest: bsd2 [343.979332] Dynamic subtest bsd2: SUCCESS (0.053s) [343.994433] Starting dynamic subtest: blt [344.026921] Dynamic subtest blt: SUCCESS (0.046s) [344.042270] Starting dynamic subtest: vebox [344.069761] Dynamic subtest vebox: SUCCESS (0.041s) [344.072363] Subtest legacy-engines-mixed: SUCCESS (0.278s) [344.143732] [095/132] (662s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [344.210038] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [344.311177] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.103s) [344.378698] [096/132] (661s left) kms_flip (2x-flip-vs-panning-vs-hang) [344.468143] Starting subtest: 2x-flip-vs-panning-vs-hang [344.479409] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.014s) [344.545981] [097/132] (661s left) gem_sync (basic-store-all) [344.638315] Starting subtest: basic-store-all [347.510722] Subtest basic-store-all: SUCCESS (2.860s) [347.671399] [098/132] (658s left) syncobj_basic (bad-fd-to-handle) [347.744487] Starting subtest: bad-fd-to-handle [347.746841] Subtest bad-fd-to-handle: SUCCESS (0.000s) [347.844150] [099/132] (658s left) kms_psr (pr-cursor-blt) [347.955720] Starting subtest: pr-cursor-blt [347.961095] Subtest pr-cursor-blt: SKIP (0.000s) [348.020153] [100/132] (658s left) kms_flip (2x-plain-flip-ts-check) [348.118383] Starting subtest: 2x-plain-flip-ts-check [348.129566] Subtest 2x-plain-flip-ts-check: SKIP (0.013s) [348.206839] [101/132] (658s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged) [348.312341] Subtest mark-unpurgeable-purged: SKIP (0.000s) [348.361404] [102/132] (658s left) gem_exec_balancer (nop) [348.420630] Starting subtest: nop [394.772377] Subtest nop: SUCCESS (46.352s) [395.039041] [103/132] (611s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [395.171056] Starting subtest: cursorA-vs-flipB-toggle [395.178579] Subtest cursorA-vs-flipB-toggle: SKIP (0.002s) [395.309886] [104/132] (611s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [395.398112] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [395.401843] Starting dynamic subtest: pipe-A-eDP-1 [400.489593] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.090s) [400.500489] Starting dynamic subtest: pipe-B-eDP-1 [406.715302] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.223s) [406.730450] Starting dynamic subtest: pipe-C-eDP-1 [408.122615] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.404s) [408.138311] Starting dynamic subtest: pipe-D-eDP-1 [409.485078] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.360s) [409.487537] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (14.090s) [410.765918] [105/132] (595s left) gem_pwrite (basic-random) [410.834030] Subtest basic-random: SKIP (0.000s) [410.889714] [106/132] (595s left) kms_addfb_basic (invalid-set-prop) [410.959552] Starting subtest: invalid-set-prop [410.962541] Subtest invalid-set-prop: SUCCESS (0.000s) [411.077292] [107/132] (595s left) kms_flip (2x-flip-vs-panning) [411.168372] Starting subtest: 2x-flip-vs-panning [411.180452] Subtest 2x-flip-vs-panning: SKIP (0.014s) [411.253081] [108/132] (595s left) gem_exec_schedule (submit-late-slice) [411.336347] Starting subtest: submit-late-slice [411.338822] Starting dynamic subtest: rcs0 [411.384630] Dynamic subtest rcs0: SUCCESS (0.048s) [411.399817] Starting dynamic subtest: bcs0 [411.467198] Dynamic subtest bcs0: SUCCESS (0.082s) [411.481850] Starting dynamic subtest: vcs0 [411.521955] Dynamic subtest vcs0: SUCCESS (0.052s) [411.536478] Starting dynamic subtest: vcs1 [411.563421] Dynamic subtest vcs1: SUCCESS (0.042s) [411.577901] Starting dynamic subtest: vecs0 [411.601586] Dynamic subtest vecs0: SUCCESS (0.037s) [411.609561] Starting dynamic subtest: ccs0 [411.655837] Dynamic subtest ccs0: SUCCESS (0.054s) [411.658733] Subtest submit-late-slice: SUCCESS (0.320s) [412.559984] [109/132] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [412.659830] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [418.060881] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.402s) [418.199275] [110/132] (588s left) vc4/vc4_label_bo (set-bad-handle) [418.290676] Subtest set-bad-handle: SKIP (0.000s) [418.340921] [111/132] (588s left) sysfs_timeslice_duration (timeout) [418.425322] Starting subtest: timeout [418.427955] Starting dynamic subtest: vecs0 [428.479880] Dynamic subtest vecs0: SUCCESS (10.050s) [428.503087] Starting dynamic subtest: ccs0 [429.173579] Dynamic subtest ccs0: SUCCESS (0.692s) [429.181305] Starting dynamic subtest: vcs0 [438.469507] Dynamic subtest vcs0: SUCCESS (9.294s) [438.484898] Starting dynamic subtest: bcs0 [439.083052] Dynamic subtest bcs0: SUCCESS (0.612s) [439.099040] Starting dynamic subtest: rcs0 [439.732804] Dynamic subtest rcs0: SUCCESS (0.651s) [439.747704] Starting dynamic subtest: vcs1 [449.472855] Dynamic subtest vcs1: SUCCESS (9.734s) [449.475783] Subtest timeout: SUCCESS (31.044s) [449.542206] [112/132] (557s left) prime_vgem (wait) [449.641046] Starting subtest: wait [449.643510] Starting dynamic subtest: rcs0 [449.688509] Dynamic subtest rcs0: SUCCESS (0.046s) [449.696243] Starting dynamic subtest: bcs0 [449.745042] Dynamic subtest bcs0: SUCCESS (0.056s) [449.757738] Starting dynamic subtest: vcs0 [449.809630] Dynamic subtest vcs0: SUCCESS (0.064s) [449.820759] Starting dynamic subtest: vcs1 [449.869326] Dynamic subtest vcs1: SUCCESS (0.057s) [449.881329] Starting dynamic subtest: vecs0 [449.928281] Dynamic subtest vecs0: SUCCESS (0.058s) [449.941362] Starting dynamic subtest: ccs0 [449.986249] Dynamic subtest ccs0: SUCCESS (0.057s) [449.989129] Subtest wait: SUCCESS (0.345s) [450.096924] [113/132] (556s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render) [450.207454] Starting subtest: psr-1p-offscren-pri-indfb-draw-render [455.006635] Subtest psr-1p-offscren-pri-indfb-draw-render: SUCCESS (4.802s) [455.127517] [114/132] (551s left) kms_psr (fbc-psr-sprite-blt) [455.228816] Starting subtest: fbc-psr-sprite-blt [455.231306] Starting dynamic subtest: eDP-1 [455.235956] Dynamic subtest eDP-1: SKIP (0.000s) [455.241184] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [455.293280] [115/132] (551s left) gem_exec_fair (basic-flow) [455.378519] Subtest basic-flow: SKIP (0.000s) [455.414558] [116/132] (551s left) gen9_exec_parse (bb-secure) [455.484787] Subtest bb-secure: SKIP (0.000s) [455.547743] [117/132] (551s left) syncobj_wait (signal) [455.610493] Starting subtest: signal [455.612540] Subtest signal: SUCCESS (0.000s) [455.685778] [118/132] (551s left) v3d/v3d_perfmon (get-values-invalid-pointer) [455.755356] Subtest get-values-invalid-pointer: SKIP (0.000s) [455.802910] [119/132] (551s left) kms_big_fb (linear-8bpp-rotate-90) [455.875695] Starting subtest: linear-8bpp-rotate-90 [455.894422] Subtest linear-8bpp-rotate-90: SKIP (0.020s) [456.005068] [120/132] (551s left) syncobj_wait (multi-wait-all-submitted-signaled) [456.080139] Starting subtest: multi-wait-all-submitted-signaled [456.183593] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.103s) [456.255776] [121/132] (550s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [456.335362] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [456.439524] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s) [456.510077] [122/132] (550s left) drm_fdinfo (busy-check-all) [456.567392] Starting subtest: busy-check-all [456.570342] Starting dynamic subtest: rcs0 [456.579542] Dynamic subtest rcs0: SKIP (0.008s) [456.594848] Starting dynamic subtest: bcs0 [456.600720] Dynamic subtest bcs0: SKIP (0.001s) [456.614266] Starting dynamic subtest: vcs0 [456.619546] Dynamic subtest vcs0: SKIP (0.001s) [456.634552] Starting dynamic subtest: vcs1 [456.639994] Dynamic subtest vcs1: SKIP (0.001s) [456.652746] Starting dynamic subtest: vecs0 [456.657700] Dynamic subtest vecs0: SKIP (0.001s) [456.668433] Starting dynamic subtest: ccs0 [456.673276] Dynamic subtest ccs0: SKIP (0.001s) [456.678578] Subtest busy-check-all: SKIP (0.018s) [456.700925] [123/132] (550s left) i915_pm_rps (reset) [456.769492] Starting subtest: reset [456.829579] Subtest reset: FAIL (0.025s) [456.872797] [124/132] (550s left) prime_mmap (test_correct) [456.943978] Starting subtest: test_correct [456.946812] Starting dynamic subtest: test_correct-smem [456.978073] Dynamic subtest test_correct-smem: SUCCESS (0.036s) [456.981195] Subtest test_correct: SUCCESS (0.037s) [457.057978] [125/132] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [457.175325] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [457.180032] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [457.255669] [126/132] (549s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [457.365116] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [457.369604] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [457.447533] [127/132] (549s left) kms_busy (extended-pageflip-hang-newfb) [457.530616] Starting subtest: extended-pageflip-hang-newfb [457.532638] Starting dynamic subtest: pipe-A [471.306915] Dynamic subtest pipe-A: SUCCESS (13.774s) [471.330888] Starting dynamic subtest: pipe-D [486.325499] Dynamic subtest pipe-D: SUCCESS (15.014s) [486.328230] Subtest extended-pageflip-hang-newfb: SUCCESS (28.796s) [487.240200] [128/132] (520s left) gem_ctx_param (non-root-set) [487.307301] Starting subtest: non-root-set [487.334678] Subtest non-root-set: SUCCESS (0.027s) [487.415878] [129/132] (519s left) kms_hdr (static-swap) [487.498116] Starting subtest: static-swap [487.502951] Subtest static-swap: SKIP (0.000s) [487.556579] [130/132] (519s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [487.641761] Starting subtest: plane-primary-toggle-with-vblank-wait [487.644391] Starting dynamic subtest: pipe-A-eDP-1 [487.818620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.177s) [488.157701] Starting dynamic subtest: pipe-B-eDP-1 [489.110901] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.967s) [489.424628] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.781s) [490.315267] [131/132] (517s left) kms_chamelium_edid (dp-mode-timings) [490.694049] Subtest dp-mode-timings: SKIP (0.000s) [491.558419] [132/132] (515s left) gem_pipe_control_store_loop (fresh-buffer) [491.640195] Starting subtest: fresh-buffer [493.846211] Subtest fresh-buffer: SUCCESS (2.153s) [493.889998] Closing watchdogs Done.