[39.096533] Initializing watchdogs [39.096651] /dev/watchdog0 [39.108214] [001/139] (960s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-gen12-rc-ccs) [39.557229] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-gen12-rc-ccs [39.562627] Subtest pipe-B-missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.000s) [40.404667] [002/139] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [40.491064] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [40.495254] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [40.562114] [003/139] (959s left) kms_busy (extended-modeset-hang-newfb-with-reset) [40.650768] Starting subtest: extended-modeset-hang-newfb-with-reset [40.653174] Starting dynamic subtest: pipe-A [45.470263] Dynamic subtest pipe-A: SUCCESS (4.814s) [45.481878] Starting dynamic subtest: pipe-D [52.441445] Dynamic subtest pipe-D: SUCCESS (6.971s) [52.444454] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (11.791s) [53.345714] [004/139] (946s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [53.437479] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [53.439650] Starting dynamic subtest: pipe-A-default-mode [56.370865] Dynamic subtest pipe-A-default-mode: SUCCESS (2.933s) [56.373377] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.934s) [57.260374] [005/139] (942s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc) [57.330880] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc [61.866231] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.538s) [61.992536] [006/139] (937s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [62.070070] Starting subtest: fbcpsr-rgb101010-draw-blt [66.862501] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.797s) [66.972702] [007/139] (932s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [67.060070] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [68.057465] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.000s) [68.186466] [008/139] (931s left) v3d/v3d_create_bo (create-bo-4096) [68.253055] Subtest create-bo-4096: SKIP (0.000s) [68.296512] [009/139] (931s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [68.633046] Starting subtest: pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs-cc [68.637285] Subtest pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [69.547545] [010/139] (930s left) gem_exec_reloc (basic-gtt-wc-noreloc) [69.609202] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [69.662778] [011/139] (930s left) kms_ccs (pipe-b-crc-primary-rotation-180-y-tiled-ccs) [70.046859] Starting subtest: pipe-B-crc-primary-rotation-180-y-tiled-ccs [70.052270] Subtest pipe-B-crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s) [70.943573] [012/139] (928s left) gem_busy (busy) [71.013912] Starting subtest: busy [71.016892] Starting dynamic subtest: all-engines [71.064133] Dynamic subtest all-engines: SUCCESS (0.050s) [71.075708] Starting dynamic subtest: rcs0 [72.407480] Dynamic subtest rcs0: SUCCESS (1.341s) [72.418658] Starting dynamic subtest: bcs0 [72.445483] Dynamic subtest bcs0: SUCCESS (0.038s) [72.455987] Starting dynamic subtest: vcs0 [72.484099] Dynamic subtest vcs0: SUCCESS (0.038s) [72.494752] Starting dynamic subtest: vcs1 [74.444438] Dynamic subtest vcs1: SUCCESS (1.959s) [74.455223] Starting dynamic subtest: vecs0 [76.428440] Dynamic subtest vecs0: SUCCESS (1.984s) [76.439573] Starting dynamic subtest: ccs0 [78.413391] Dynamic subtest ccs0: SUCCESS (1.985s) [78.415810] Subtest busy: SUCCESS (7.398s) [78.748307] [013/139] (921s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [79.131488] Starting subtest: pipe-A-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [79.136980] Subtest pipe-A-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.001s) [80.030189] [014/139] (919s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [80.111675] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [81.133270] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.024s) [81.263778] [015/139] (918s left) syncobj_wait (multi-wait-submitted) [81.315866] Starting subtest: multi-wait-submitted [81.423925] Subtest multi-wait-submitted: SUCCESS (0.106s) [81.487054] [016/139] (918s left) kms_psr (psr2_cursor_plane_onoff) [81.567074] Starting subtest: psr2_cursor_plane_onoff [83.316332] Subtest psr2_cursor_plane_onoff: SUCCESS (1.748s) [84.205766] [017/139] (915s left) syncobj_wait (single-wait-for-submit-signaled) [84.256078] Starting subtest: single-wait-for-submit-signaled [84.258373] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [84.294683] [018/139] (915s left) prime_vgem (basic-fence-read) [84.383767] Starting subtest: basic-fence-read [84.391309] Subtest basic-fence-read: SKIP (0.005s) [84.468800] [019/139] (915s left) gen7_exec_parse (load-register-reg) [84.511942] Subtest load-register-reg: SKIP (0.000s) [84.529731] [020/139] (915s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [84.602304] Starting subtest: fbc-1p-primscrn-cur-indfb-move [87.594230] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.997s) [87.730422] [021/139] (912s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [87.797628] Starting subtest: short-flip-after-cursor-atomic-transitions [88.751311] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.951s) [89.634187] [022/139] (910s left) sw_sync (sync_busy) [89.687631] Starting subtest: sync_busy [89.689890] Subtest sync_busy: SUCCESS (0.001s) [89.731611] [023/139] (910s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [89.781068] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [89.783432] Starting dynamic subtest: pipe-A-eDP-1 [89.787994] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s) [89.799670] Starting dynamic subtest: pipe-B-eDP-1 [89.804683] Dynamic subtest pipe-B-eDP-1: SKIP (0.011s) [89.811294] Starting dynamic subtest: pipe-C-eDP-1 [89.821912] Dynamic subtest pipe-C-eDP-1: SKIP (0.022s) [89.832223] Starting dynamic subtest: pipe-D-eDP-1 [89.836826] Dynamic subtest pipe-D-eDP-1: SKIP (0.012s) [89.841365] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.052s) [89.915547] [024/139] (910s left) kms_dither (fb-8bpc-vs-panel-6bpc) [90.002193] Starting subtest: fb-8bpc-vs-panel-6bpc [90.004577] Starting dynamic subtest: pipe-A-eDP-1 [91.501759] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.499s) [91.504214] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.500s) [92.392055] [025/139] (907s left) kms_getfb (getfb-reject-ccs) [92.430381] Starting subtest: getfb-reject-ccs [92.432500] Subtest getfb-reject-ccs: SUCCESS (0.000s) [92.516937] [026/139] (907s left) kms_vblank (query-busy) [92.606478] Starting subtest: query-busy [92.608892] Starting dynamic subtest: pipe-A-eDP-1 [94.488633] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s) [94.498909] Starting dynamic subtest: pipe-D-eDP-1 [97.151775] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.660s) [97.154284] Subtest query-busy: SUCCESS (4.545s) [98.074785] [027/139] (902s left) i915_suspend (debugfs-reader) [98.112809] Starting subtest: debugfs-reader [116.350986] Subtest debugfs-reader: SUCCESS (3.249s) [116.493003] [028/139] (898s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [116.558454] Starting subtest: psr-rgb101010-draw-mmap-gtt [116.562850] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [116.629358] [029/139] (898s left) gem_exec_whisper (basic-sync-all) [116.689026] Starting subtest: basic-sync-all [125.693291] Subtest basic-sync-all: SUCCESS (9.005s) [125.871570] [030/139] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [125.950538] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [125.955246] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [126.032172] [031/139] (889s left) gem_userptr_blits (create-destroy-sync) [126.112736] Starting subtest: create-destroy-sync [131.131936] Subtest create-destroy-sync: SUCCESS (5.018s) [131.230744] [032/139] (884s left) kms_color (invalid-degamma-lut-sizes) [131.315975] Starting subtest: invalid-degamma-lut-sizes [131.318828] Starting dynamic subtest: pipe-A [131.619423] Dynamic subtest pipe-A: SUCCESS (0.301s) [131.634049] Starting dynamic subtest: pipe-B [131.636445] Dynamic subtest pipe-B: SUCCESS (0.001s) [131.650242] Starting dynamic subtest: pipe-C [131.652605] Dynamic subtest pipe-C: SUCCESS (0.001s) [131.663631] Starting dynamic subtest: pipe-D [131.666013] Dynamic subtest pipe-D: SUCCESS (0.001s) [131.668295] Subtest invalid-degamma-lut-sizes: SUCCESS (0.307s) [132.540013] [033/139] (882s left) core_getstats [132.629087] [034/139] (882s left) vgem_basic (setversion) [132.671738] Starting subtest: setversion [132.675863] Subtest setversion: SUCCESS (0.000s) [132.722722] [035/139] (882s left) kms_rotation_crc (sprite-rotation-90) [132.792166] Starting subtest: sprite-rotation-90 [132.796669] Subtest sprite-rotation-90: SKIP (0.001s) [132.854829] [036/139] (882s left) kms_sequence (get-busy) [132.922590] Starting subtest: get-busy [132.925087] Starting dynamic subtest: pipe-A-eDP-1 [134.853024] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.927s) [134.867417] Starting dynamic subtest: pipe-B-eDP-1 [137.511372] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.659s) [137.525494] Starting dynamic subtest: pipe-C-eDP-1 [140.184904] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.671s) [140.198813] Starting dynamic subtest: pipe-D-eDP-1 [142.874710] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.686s) [142.877694] Subtest get-busy: SUCCESS (9.951s) [143.789121] [037/139] (871s left) kms_cursor_crc (cursor-random-256x256) [143.897544] Starting subtest: cursor-random-256x256 [143.899913] Starting dynamic subtest: pipe-A-eDP-1 [147.265534] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.364s) [147.300476] Starting dynamic subtest: pipe-D-eDP-1 [151.326231] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.034s) [151.329135] Subtest cursor-random-256x256: SUCCESS (7.425s) [152.218285] [038/139] (863s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [152.277342] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [152.281341] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [152.363110] [039/139] (863s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [152.430856] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [152.433279] Starting dynamic subtest: pipe-A-default-mode [152.718091] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [152.722951] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.285s) [153.597731] [040/139] (862s left) v3d/v3d_perfmon (create-single-perfmon) [153.683389] Subtest create-single-perfmon: SKIP (0.000s) [153.731778] [041/139] (861s left) gem_exec_whisper (basic-fds-forked-all) [153.784315] Starting subtest: basic-fds-forked-all [186.395773] Subtest basic-fds-forked-all: SUCCESS (32.606s) [186.574094] [042/139] (829s left) syncobj_wait (multi-wait-all-submitted-signaled) [186.617858] Starting subtest: multi-wait-all-submitted-signaled [186.718008] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s) [186.789765] [043/139] (828s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [186.831758] Starting subtest: multi-wait-all-for-submit-available-submitted [186.834121] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [186.882871] [044/139] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc) [186.955803] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc [191.607853] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.655s) [191.740144] [045/139] (824s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [191.809475] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [197.131605] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (5.325s) [197.244856] [046/139] (818s left) kms_pipe_crc_basic (read-crc) [197.306368] Starting subtest: read-crc [197.308952] Starting dynamic subtest: pipe-A-eDP-1 [198.036018] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.727s) [198.050637] Starting dynamic subtest: pipe-B-eDP-1 [199.574585] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.537s) [199.589248] Starting dynamic subtest: pipe-C-eDP-1 [201.011981] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.434s) [201.028734] Starting dynamic subtest: pipe-D-eDP-1 [202.441086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.426s) [202.443607] Subtest read-crc: SUCCESS (5.134s) [203.392207] [047/139] (812s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [203.466603] Starting subtest: fbc-2p-primscrn-cur-indfb-move [203.471297] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [203.547937] [048/139] (812s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [203.640397] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [208.772983] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (5.136s) [208.885474] [049/139] (807s left) v3d/v3d_submit_csd (bad-multisync-extension) [208.975150] Subtest bad-multisync-extension: SKIP (0.000s) [209.025357] [050/139] (806s left) kms_big_fb (4-tiled-16bpp-rotate-180) [209.096161] Starting subtest: 4-tiled-16bpp-rotate-180 [210.341254] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.246s) [210.481952] [051/139] (805s left) kms_ccs (pipe-b-bad-rotation-90-y-tiled-gen12-mc-ccs) [210.852073] Starting subtest: pipe-B-bad-rotation-90-y-tiled-gen12-mc-ccs [210.856820] Subtest pipe-B-bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.000s) [211.770262] [052/139] (804s left) gem_close (basic) [211.809965] Starting subtest: basic [211.812295] Subtest basic: SUCCESS (0.000s) [211.894779] [053/139] (804s left) gem_mmap (basic-small-bo) [211.954045] Subtest basic-small-bo: SKIP (0.000s) [211.979129] [054/139] (804s left) dmabuf_sync_file (import-basic) [212.038580] Starting subtest: import-basic [212.040998] Subtest import-basic: SUCCESS (0.003s) [212.088465] [055/139] (803s left) gem_spin_batch (spin-all) [212.168815] Starting subtest: spin-all [212.182484] Subtest spin-all: SUCCESS (0.013s) [213.467145] [056/139] (802s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [213.532639] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [213.546980] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.013s) [213.609370] [057/139] (802s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted) [213.664837] Starting subtest: invalid-multi-wait-available-unsubmitted [213.667199] Subtest invalid-multi-wait-available-unsubmitted: SUCCESS (0.000s) [213.727997] [058/139] (802s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [213.800467] Starting subtest: psr-2p-primscrn-cur-indfb-move [213.804763] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [213.872821] [059/139] (802s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [213.986087] Starting subtest: flip-vs-cursor-atomic-transitions [220.176062] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (6.189s) [221.108382] [060/139] (795s left) kms_panel_fitting (atomic-fastset) [221.169757] Starting subtest: atomic-fastset [221.172098] Starting dynamic subtest: pipe-A-eDP-1 [221.308658] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s) [221.322215] Starting dynamic subtest: pipe-B-eDP-1 [222.620801] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.310s) [222.636406] Starting dynamic subtest: pipe-C-eDP-1 [223.864846] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.242s) [223.871126] Starting dynamic subtest: pipe-D-eDP-1 [225.057314] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.190s) [225.059838] Subtest atomic-fastset: SUCCESS (3.888s) [226.302109] [061/139] (789s left) gem_exec_reloc (basic-cpu-gtt-active) [226.361154] Subtest basic-cpu-gtt-active: SKIP (0.000s) [226.421631] [062/139] (789s left) kms_atomic_interruptible (universal-setplane-primary) [226.495237] Starting subtest: universal-setplane-primary [226.497745] Starting dynamic subtest: pipe-A-eDP-1 [233.992243] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.499s) [233.994704] Subtest universal-setplane-primary: SUCCESS (7.501s) [234.943889] [063/139] (781s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [235.008640] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [235.011113] Starting dynamic subtest: A-eDP1 [238.911122] Dynamic subtest A-eDP1: SUCCESS (3.903s) [238.925085] Starting dynamic subtest: B-eDP1 [242.433589] Dynamic subtest B-eDP1: SUCCESS (3.520s) [242.450729] Starting dynamic subtest: C-eDP1 [245.862902] Dynamic subtest C-eDP1: SUCCESS (3.430s) [245.877817] Starting dynamic subtest: D-eDP1 [249.331297] Dynamic subtest D-eDP1: SUCCESS (3.466s) [249.337276] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (14.334s) [250.212797] [064/139] (766s left) kms_rmfb (close-fd) [250.271516] Starting subtest: close-fd [250.273938] Starting dynamic subtest: pipe-A-eDP-1 [250.400756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.124s) [250.411083] Starting dynamic subtest: pipe-B-eDP-1 [251.685930] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.286s) [251.701129] Starting dynamic subtest: pipe-C-eDP-1 [252.986523] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s) [253.002049] Starting dynamic subtest: pipe-D-eDP-1 [254.237524] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s) [254.239837] Subtest close-fd: SUCCESS (3.965s) [255.488693] [065/139] (760s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [255.535021] Starting subtest: x-tiled-to-vebox-y-tiled [255.539541] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [255.710752] [066/139] (760s left) vc4/vc4_perfmon (get-values-valid-perfmon) [255.808748] Subtest get-values-valid-perfmon: SKIP (0.000s) [255.860926] [067/139] (760s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [256.265284] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [261.496004] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (5.231s) [262.747829] [068/139] (753s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [262.814111] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [262.816586] Starting dynamic subtest: pipe-A-default-mode [264.021529] Dynamic subtest pipe-A-default-mode: SKIP (1.204s) [264.026094] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.205s) [264.172620] [069/139] (752s left) i915_pm_rps (basic-api) [264.227990] Starting subtest: basic-api [264.232771] Subtest basic-api: SKIP (0.000s) [264.275512] [070/139] (752s left) kms_prop_blob (blob-prop-validate) [264.321299] Starting subtest: blob-prop-validate [264.323740] Subtest blob-prop-validate: SUCCESS (0.000s) [264.378847] [071/139] (752s left) gem_ctx_shared (q-independent) [264.448695] Starting subtest: Q-independent [264.451119] Starting dynamic subtest: rcs0 [264.478306] Dynamic subtest rcs0: SUCCESS (0.033s) [264.496130] Starting dynamic subtest: vcs0 [264.498860] Dynamic subtest vcs0: SUCCESS (0.016s) [264.511336] Starting dynamic subtest: vcs1 [264.513954] Dynamic subtest vcs1: SUCCESS (0.015s) [264.520417] Starting dynamic subtest: vecs0 [264.551397] Dynamic subtest vecs0: SUCCESS (0.040s) [264.563486] Starting dynamic subtest: ccs0 [264.598922] Dynamic subtest ccs0: SUCCESS (0.046s) [264.601829] Subtest Q-independent: SUCCESS (0.153s) [266.499613] [072/139] (749s left) syncobj_timeline (device-signal-unordered) [266.555195] Starting subtest: device-signal-unordered [266.557594] Subtest device-signal-unordered: SUCCESS (0.000s) [266.617053] [073/139] (749s left) kms_atomic (plane-immutable-zpos) [266.686602] Starting subtest: plane-immutable-zpos [266.689055] Starting dynamic subtest: pipe-A-eDP-1 [267.287532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s) [267.290106] Subtest plane-immutable-zpos: SUCCESS (0.602s) [268.265305] [074/139] (748s left) vc4/vc4_create_bo (create-bo-zeroed) [268.350853] Subtest create-bo-zeroed: SKIP (0.000s) [268.396436] [075/139] (748s left) gem_ppgtt (shrink-vs-evict-any) [268.450930] Starting subtest: shrink-vs-evict-any [276.406439] Subtest shrink-vs-evict-any: SUCCESS (7.959s) [276.459398] [076/139] (740s left) gem_softpin (allocator-nopin) [276.520469] Starting subtest: allocator-nopin [276.560075] Subtest allocator-nopin: SUCCESS (0.041s) [276.656385] [077/139] (739s left) gem_exec_reloc (basic-wc-cpu) [276.698155] Subtest basic-wc-cpu: SKIP (0.000s) [276.742944] [078/139] (739s left) kms_flip (dpms-off-confusion) [276.809719] Starting subtest: dpms-off-confusion [276.812087] Starting dynamic subtest: A-eDP1 [285.556611] Dynamic subtest A-eDP1: SUCCESS (8.748s) [285.573716] Starting dynamic subtest: B-eDP1 [294.326380] Dynamic subtest B-eDP1: SUCCESS (8.768s) [294.340914] Starting dynamic subtest: C-eDP1 [303.080665] Dynamic subtest C-eDP1: SUCCESS (8.753s) [303.096002] Starting dynamic subtest: D-eDP1 [311.839620] Dynamic subtest D-eDP1: SUCCESS (8.757s) [311.846490] Subtest dpms-off-confusion: SUCCESS (35.040s) [313.088608] [079/139] (703s left) gem_exec_fence (syncobj-timeline-invalid-flags) [313.633597] Starting subtest: syncobj-timeline-invalid-flags [313.636165] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s) [315.503543] [080/139] (701s left) gem_exec_capture (capture-recoverable) [315.566026] Starting subtest: capture-recoverable [315.568416] Subtest capture-recoverable: SUCCESS (0.003s) [315.662927] [081/139] (701s left) kms_chamelium_hpd (hdmi-hpd) [316.002968] Subtest hdmi-hpd: SKIP (0.000s) [316.890674] [082/139] (699s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [316.978937] Starting subtest: basic-flip-after-cursor-atomic [317.906542] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.925s) [318.850992] [083/139] (697s left) gem_mmap_gtt (hang) [318.910655] Subtest hang: SKIP (0.000s) [318.928979] [084/139] (697s left) gem_exec_schedule (semaphore-resolve) [318.977619] Starting subtest: semaphore-resolve [318.987156] Subtest semaphore-resolve: SUCCESS (0.020s) [319.315064] [085/139] (697s left) perf_pmu (render-node-busy) [319.356725] Starting subtest: render-node-busy [319.359042] Starting dynamic subtest: rcs0 [319.915481] Dynamic subtest rcs0: SUCCESS (0.558s) [319.932477] Starting dynamic subtest: bcs0 [320.467386] Dynamic subtest bcs0: SUCCESS (0.551s) [320.483927] Starting dynamic subtest: vcs0 [322.390938] Dynamic subtest vcs0: SUCCESS (1.921s) [322.407203] Starting dynamic subtest: vcs1 [324.375851] Dynamic subtest vcs1: SUCCESS (1.983s) [324.392065] Starting dynamic subtest: vecs0 [326.423852] Dynamic subtest vecs0: SUCCESS (2.046s) [326.440018] Starting dynamic subtest: ccs0 [326.989912] Dynamic subtest ccs0: SUCCESS (0.565s) [326.992933] Subtest render-node-busy: SUCCESS (7.634s) [327.061106] [086/139] (689s left) perf (gen12-mi-rpc) [327.198551] Starting subtest: gen12-mi-rpc [327.201043] Starting dynamic subtest: rcs0 [327.207080] Dynamic subtest rcs0: SUCCESS (0.009s) [327.209489] Subtest gen12-mi-rpc: SUCCESS (0.010s) [327.229126] [087/139] (689s left) kms_content_protection (type1) [327.397216] Starting subtest: type1 [330.893191] Subtest type1: SKIP (3.492s) [332.160094] [088/139] (684s left) gem_exec_create (forked) [332.227028] Starting subtest: forked [332.229488] Starting dynamic subtest: smem [352.415515] Dynamic subtest smem: SUCCESS (20.188s) [352.418077] Subtest forked: SUCCESS (20.189s) [352.598096] [089/139] (664s left) gem_mmap_gtt (cpuset-big-copy) [352.643013] Subtest cpuset-big-copy: SKIP (0.000s) [352.672956] [090/139] (664s left) i915_module_load (load) [352.710899] Starting subtest: load [352.715269] Subtest load: SKIP (0.000s) [352.758221] [091/139] (664s left) gem_pxp (hw-rejects-pxp-context) [355.334865] Starting subtest: hw-rejects-pxp-context [355.339017] Subtest hw-rejects-pxp-context: SUCCESS (0.001s) [355.403379] [092/139] (661s left) perf_pmu (busy-hang) [355.447954] Starting subtest: busy-hang [355.450344] Starting dynamic subtest: rcs0 [356.748424] Dynamic subtest rcs0: SUCCESS (1.300s) [356.764435] Starting dynamic subtest: bcs0 [357.998159] Dynamic subtest bcs0: SUCCESS (1.248s) [358.014792] Starting dynamic subtest: vcs0 [359.893677] Dynamic subtest vcs0: SUCCESS (1.895s) [359.909642] Starting dynamic subtest: vcs1 [361.943190] Dynamic subtest vcs1: SUCCESS (2.049s) [361.960632] Starting dynamic subtest: vecs0 [363.924605] Dynamic subtest vecs0: SUCCESS (1.980s) [363.940464] Starting dynamic subtest: ccs0 [365.189455] Dynamic subtest ccs0: SUCCESS (1.263s) [365.192089] Subtest busy-hang: SUCCESS (9.742s) [365.265100] [093/139] (651s left) api_intel_bb (reset-bb) [365.329679] Starting subtest: reset-bb [365.335326] Subtest reset-bb: SUCCESS (0.004s) [365.425869] [094/139] (651s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [365.479460] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [366.587738] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.112s) [366.725419] [095/139] (650s left) syncobj_timeline (single-wait-for-submit-signaled) [366.773052] Starting subtest: single-wait-for-submit-signaled [366.775484] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [366.841831] [096/139] (650s left) template (a) [366.894491] Starting subtest: A [366.896645] Subtest A: SUCCESS (0.000s) [366.958941] [097/139] (650s left) kms_ccs (pipe-d-crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [367.376027] Starting subtest: pipe-D-crc-primary-rotation-180-4-tiled-mtl-mc-ccs [369.725605] Subtest pipe-D-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (2.351s) [370.933846] [098/139] (646s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [371.017111] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [371.021060] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [371.109109] [099/139] (646s left) api_intel_allocator (reloc-allocator) [371.168423] Starting subtest: reloc-allocator [371.170690] Starting dynamic subtest: basic [371.172885] Dynamic subtest basic: SUCCESS (0.001s) [371.189040] Starting dynamic subtest: parallel-one [371.191050] Dynamic subtest parallel-one: SUCCESS (0.010s) [371.204512] Starting dynamic subtest: print [371.206814] Dynamic subtest print: SUCCESS (0.000s) [371.216671] Starting dynamic subtest: reuse [371.218937] Dynamic subtest reuse: SUCCESS (0.000s) [371.232403] Starting dynamic subtest: fork-reopen-allocator [371.234753] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s) [371.236977] Subtest reloc-allocator: SUCCESS (0.029s) [371.286293] [100/139] (645s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [371.354535] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [371.360758] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [371.440295] [101/139] (645s left) kms_plane (planar-pixel-format-settings) [371.507743] Starting subtest: planar-pixel-format-settings [371.548047] Subtest planar-pixel-format-settings: SUCCESS (0.040s) [371.634004] [102/139] (645s left) kms_chamelium_edid (hdmi-mode-timings) [372.003049] Subtest hdmi-mode-timings: SKIP (0.000s) [372.890313] [103/139] (644s left) gem_ctx_persistence (heartbeat-close) [372.945048] Starting subtest: heartbeat-close [372.950870] Subtest heartbeat-close: SKIP (0.000s) [373.005217] [104/139] (644s left) gem_partial_pwrite_pread (write-uncached) [373.058361] Subtest write-uncached: SKIP (0.000s) [373.110068] [105/139] (644s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-rc-ccs) [373.540356] Starting subtest: pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs [373.545537] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s) [374.402984] [106/139] (642s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-gen12-rc-ccs) [374.825699] Starting subtest: pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs [374.830690] Subtest pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.000s) [375.673032] [107/139] (641s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [375.754670] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [375.758601] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [375.842992] [108/139] (641s left) gem_exec_reloc (basic-cpu-wc) [375.914012] Subtest basic-cpu-wc: SKIP (0.000s) [375.971128] [109/139] (641s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [376.008191] Starting subtest: invalid-multi-wait-unsubmitted-signaled [376.010351] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s) [376.061703] [110/139] (641s left) kms_pm_rpm (universal-planes-dpms) [377.664894] Starting subtest: universal-planes-dpms [377.668403] Starting dynamic subtest: plane-31 [405.785017] Dynamic subtest plane-31: SUCCESS (28.119s) [405.801575] Starting dynamic subtest: plane-40 [430.081030] Dynamic subtest plane-40: SUCCESS (24.294s) [430.097659] Starting dynamic subtest: plane-49 [454.339050] Dynamic subtest plane-49: SUCCESS (24.256s) [454.355616] Starting dynamic subtest: plane-58 [478.601950] Dynamic subtest plane-58: SUCCESS (24.259s) [478.619812] Starting dynamic subtest: plane-67 [502.926499] Dynamic subtest plane-67: SUCCESS (24.322s) [502.944020] Starting dynamic subtest: plane-76 [527.153705] Dynamic subtest plane-76: SUCCESS (24.227s) [527.156496] Subtest universal-planes-dpms: SUCCESS (149.490s) [528.220740] [111/139] (489s left) kms_cursor_crc (cursor-sliding-64x64) [528.311124] Starting subtest: cursor-sliding-64x64 [528.313592] Starting dynamic subtest: pipe-A-eDP-1 [531.568324] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.253s) [531.608204] Starting dynamic subtest: pipe-D-eDP-1 [535.545909] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.946s) [535.548352] Subtest cursor-sliding-64x64: SUCCESS (7.234s) [536.444547] [112/139] (481s left) gem_exec_capture (many-4k-zero) [536.494800] Starting subtest: many-4K-zero [536.999800] Subtest many-4K-zero: FAIL (0.445s) [537.057995] [113/139] (480s left) gem_exec_gttfill (multigpu-basic) [537.315964] Starting subtest: multigpu-basic [537.320607] Subtest multigpu-basic: SKIP (0.000s) [537.386206] [114/139] (480s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [537.748142] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [537.753065] Subtest pipe-A-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [538.612074] [115/139] (479s left) gem_mmap (big-bo) [538.667261] Subtest big-bo: SKIP (0.000s) [538.692421] [116/139] (478s left) kms_frontbuffer_tracking (fbc-tiling-y) [538.772702] Starting subtest: fbc-tiling-y [538.777474] Subtest fbc-tiling-y: SKIP (0.000s) [538.866272] [117/139] (478s left) kms_chamelium_audio (dp-audio-edid) [539.225732] Subtest dp-audio-edid: SKIP (0.000s) [540.119453] [118/139] (477s left) kms_ccs (pipe-a-ccs-on-another-bo-y-tiled-gen12-rc-ccs) [540.503727] Starting subtest: pipe-A-ccs-on-another-bo-y-tiled-gen12-rc-ccs [540.509324] Subtest pipe-A-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s) [541.364134] [119/139] (476s left) kms_plane_scaling (invalid-parameters) [541.451890] Starting subtest: invalid-parameters [541.454318] Starting dynamic subtest: less-than-1-height-src [541.460739] Dynamic subtest less-than-1-height-src: SUCCESS (0.008s) [541.474792] Starting dynamic subtest: less-than-1-width-src [541.476983] Dynamic subtest less-than-1-width-src: SUCCESS (0.006s) [541.479214] Subtest invalid-parameters: SUCCESS (0.015s) [541.568773] [120/139] (476s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [541.955248] Starting subtest: pipe-C-bad-rotation-90-4-tiled-dg2-rc-ccs-cc [541.961234] Subtest pipe-C-bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [542.847078] [121/139] (474s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [542.926744] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [542.930983] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [543.015642] [122/139] (474s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [543.070726] Starting subtest: fbc-rgb101010-draw-pwrite [546.729777] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.663s) [546.848804] [123/139] (471s left) gem_create (busy-create) [546.915151] Starting subtest: busy-create [546.917653] Starting dynamic subtest: smem0 [580.468950] Dynamic subtest smem0: SUCCESS (33.551s) [580.472011] Subtest busy-create: SUCCESS (33.553s) [580.654784] [124/139] (437s left) kms_invalid_mode (uint-max-clock) [580.740341] Starting subtest: uint-max-clock [580.742859] Starting dynamic subtest: pipe-A-eDP-1 [581.033610] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s) [581.048001] Starting dynamic subtest: pipe-B-eDP-1 [581.050604] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [581.060599] Starting dynamic subtest: pipe-C-eDP-1 [581.062934] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [581.071543] Starting dynamic subtest: pipe-D-eDP-1 [581.073880] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [581.076172] Subtest uint-max-clock: SUCCESS (0.306s) [581.953980] [125/139] (435s left) gem_eio (in-flight-contexts-immediate) [582.176489] Starting subtest: in-flight-contexts-immediate [595.818317] Subtest in-flight-contexts-immediate: SUCCESS (13.640s) [597.538468] [126/139] (420s left) gem_ctx_param (invalid-get-engines) [597.596848] Starting subtest: invalid-get-engines [597.599518] Subtest invalid-get-engines: SUCCESS (0.000s) [597.658425] [127/139] (420s left) kms_addfb_basic (bo-too-small-due-to-tiling) [597.704771] Starting subtest: bo-too-small-due-to-tiling [597.709056] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [597.799871] [128/139] (420s left) gem_exec_schedule (preempt-other) [597.870051] Starting subtest: preempt-other [597.872540] Starting dynamic subtest: rcs0 [597.927550] Dynamic subtest rcs0: SUCCESS (0.061s) [597.935272] Starting dynamic subtest: bcs0 [597.985572] Dynamic subtest bcs0: SUCCESS (0.057s) [597.994476] Starting dynamic subtest: vcs0 [598.042619] Dynamic subtest vcs0: SUCCESS (0.057s) [598.061480] Starting dynamic subtest: vcs1 [598.111828] Dynamic subtest vcs1: SUCCESS (0.069s) [598.129845] Starting dynamic subtest: vecs0 [598.167434] Dynamic subtest vecs0: SUCCESS (0.055s) [598.178072] Starting dynamic subtest: ccs0 [598.228204] Dynamic subtest ccs0: SUCCESS (0.061s) [598.230585] Subtest preempt-other: SUCCESS (0.362s) [599.486466] [129/139] (418s left) syncobj_timeline (invalid-single-wait-available-unsubmitted) [599.555183] Starting subtest: invalid-single-wait-available-unsubmitted [599.557783] Subtest invalid-single-wait-available-unsubmitted: SUCCESS (0.000s) [599.620259] [130/139] (418s left) gen9_exec_parse (bb-start-param) [599.674792] Subtest bb-start-param: SKIP (0.000s) [599.701948] [131/139] (418s left) vc4/vc4_wait_seqno (bad-seqno-0ns) [599.784223] Subtest bad-seqno-0ns: SKIP (0.000s) [599.836618] [132/139] (418s left) sw_sync (sync_busy_fork) [599.903522] Starting subtest: sync_busy_fork [600.927019] Subtest sync_busy_fork: SUCCESS (1.022s) [600.986577] [133/139] (417s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-mtl-rc-ccs) [601.411074] Starting subtest: pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs [602.218333] Subtest pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (0.808s) [603.456729] [134/139] (414s left) gem_pread (uncached) [603.514157] Subtest uncached: SKIP (0.000s) [603.545622] [135/139] (414s left) kms_pm_rpm (dpms-lpsp) [605.590336] Starting subtest: dpms-lpsp [605.916073] Subtest dpms-lpsp: SUCCESS (0.324s) [606.027857] [136/139] (412s left) api_intel_allocator (fork-simple-stress) [606.097257] Starting subtest: fork-simple-stress [611.508437] Subtest fork-simple-stress: SUCCESS (5.412s) [611.635865] [137/139] (406s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [612.021067] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [613.651634] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (1.631s) [614.838597] [138/139] (403s left) gem_exec_alignment (pi) [614.902503] Starting subtest: pi [627.866194] Killing the test because the kernel is tainted. [629.608241] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1847 [max: 8192] direct dependencies: 19708 [max: 32768] indirect dependencies: 159757 all direct dependencies: 421200 dependency chains: 29564 [max: 131072] dependency chain hlocks used: 127457 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 345 in-softirq chains: 666 in-process chains: 28553 stack-trace entries: 183521 [max: 1048576] number of stack traces: 9319 number of stack hash chains: 7077 combined max dependencies: 2294781932 hardirq-safe locks: 117 hardirq-unsafe locks: 1103 softirq-safe locks: 225 softirq-unsafe locks: 1013 irq-safe locks: 247 irq-unsafe locks: 1103 hardirq-read-safe locks: 4 hardirq-read-unsafe locks: 322 softirq-read-safe locks: 7 softirq-read-unsafe locks: 317 irq-read-safe locks: 8 irq-read-unsafe locks: 322 uncategorized locks: 291 unused locks: 1 max locking depth: 17 max bfs queue depth: 416 max lock class index: 1846 chain lookup misses: 30157 chain lookup hits: 635705048 cyclic checks: 30485 redundant checks: 0 redundant links: 0 find-mask forwards checks: 5353 find-mask backwards checks: 2757 hardirq on events: 373175052 hardirq off events: 373175030 redundant hardirq ons: 130 redundant hardirq offs: 40 softirq on events: 1394836 softirq off events: 1394836 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 110 large chain blocks: 1 [629.611652] Closing watchdogs Done.