[31.407302] Initializing watchdogs [31.407350] /dev/watchdog0 [31.412720] [001/142] (960s left) gem_gtt_cpu_tlb [31.525638] [002/142] (960s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs) [31.674739] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs [31.676878] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.001s) [31.789192] [003/142] (960s left) i915_selftest (live) [32.549602] Starting subtest: live [32.550488] Starting dynamic subtest: sanitycheck [34.216295] Dynamic subtest sanitycheck: SUCCESS (1.666s) [34.224380] Starting dynamic subtest: uncore [35.838369] Dynamic subtest uncore: SUCCESS (1.622s) [35.841286] Starting dynamic subtest: workarounds [37.661379] Dynamic subtest workarounds: SUCCESS (1.823s) [37.664218] Starting dynamic subtest: gt_engines [39.758067] Dynamic subtest gt_engines: SUCCESS (2.088s) [39.763867] Starting dynamic subtest: gt_timelines [46.955189] Dynamic subtest gt_timelines: SUCCESS (7.197s) [46.960371] Starting dynamic subtest: gt_contexts [48.675183] Dynamic subtest gt_contexts: SUCCESS (1.720s) [48.680350] Starting dynamic subtest: gt_lrc [52.626369] Dynamic subtest gt_lrc: SUCCESS (3.951s) [52.631472] Starting dynamic subtest: gt_mocs [54.310152] Dynamic subtest gt_mocs: SUCCESS (1.684s) [54.315804] Starting dynamic subtest: gt_pm [66.929577] Dynamic subtest gt_pm: SUCCESS (12.628s) [66.937785] Starting dynamic subtest: gt_heartbeat [68.611381] Dynamic subtest gt_heartbeat: SUCCESS (1.682s) [68.619065] Starting dynamic subtest: gt_tlb [71.314357] Dynamic subtest gt_tlb: SUCCESS (2.703s) [71.322346] Starting dynamic subtest: requests [79.153706] Dynamic subtest requests: SUCCESS (7.839s) [79.162428] Starting dynamic subtest: migrate [83.490955] Dynamic subtest migrate: SUCCESS (4.337s) [83.500086] Starting dynamic subtest: active [85.138059] Dynamic subtest active: SUCCESS (1.639s) [85.143421] Starting dynamic subtest: objects [87.300161] Dynamic subtest objects: SUCCESS (2.162s) [87.305813] Starting dynamic subtest: mman [92.394793] Dynamic subtest mman: SUCCESS (5.094s) [92.399809] Starting dynamic subtest: dmabuf [94.088438] Dynamic subtest dmabuf: SUCCESS (1.702s) [94.098788] Starting dynamic subtest: vma [95.719097] Dynamic subtest vma: SUCCESS (1.622s) [95.724379] Starting dynamic subtest: coherency [98.010203] Dynamic subtest coherency: SUCCESS (2.300s) [98.013678] Starting dynamic subtest: gtt [107.091425] Dynamic subtest gtt: SUCCESS (9.081s) [107.099917] Starting dynamic subtest: gem [108.818160] Dynamic subtest gem: SUCCESS (1.718s) [108.823867] Starting dynamic subtest: evict [111.026200] Dynamic subtest evict: SUCCESS (2.208s) [111.031879] Starting dynamic subtest: hugepages [119.098120] Dynamic subtest hugepages: SUCCESS (8.072s) [119.103780] Starting dynamic subtest: gem_contexts [131.652157] Dynamic subtest gem_contexts: SUCCESS (12.554s) [131.657915] Starting dynamic subtest: client [133.303107] Dynamic subtest client: SUCCESS (1.651s) [133.308927] Starting dynamic subtest: gem_migrate [134.929181] Dynamic subtest gem_migrate: SUCCESS (1.626s) [134.934886] Starting dynamic subtest: reset [140.449909] Dynamic subtest reset: SUCCESS (5.520s) [140.455459] Starting dynamic subtest: memory_region [142.094465] Dynamic subtest memory_region: SUCCESS (1.644s) [142.100854] Starting dynamic subtest: hangcheck [166.730094] Dynamic subtest hangcheck: SUCCESS (24.636s) [166.735322] Starting dynamic subtest: execlists [175.968074] Dynamic subtest execlists: SUCCESS (9.237s) [175.973427] Starting dynamic subtest: ring_submission [177.577571] Dynamic subtest ring_submission: SUCCESS (1.617s) [177.586366] Starting dynamic subtest: perf [179.268066] Dynamic subtest perf: SUCCESS (1.681s) [179.274219] Starting dynamic subtest: slpc [180.887184] Dynamic subtest slpc: SUCCESS (1.618s) [180.892620] Starting dynamic subtest: guc [182.514081] Dynamic subtest guc: SUCCESS (1.626s) [182.519983] Starting dynamic subtest: guc_multi_lrc [184.168056] Dynamic subtest guc_multi_lrc: SUCCESS (1.653s) [184.173760] Starting dynamic subtest: guc_hang [185.782510] Dynamic subtest guc_hang: SUCCESS (1.622s) [185.791395] Starting dynamic subtest: late_gt_pm [187.427472] Dynamic subtest late_gt_pm: SUCCESS (1.639s) [187.428974] Subtest live: SUCCESS (154.873s) [187.442823] [004/142] (804s left) gem_ctx_persistence (engines-persistence) [188.990492] Starting subtest: engines-persistence [188.991207] Starting dynamic subtest: rcs0 [189.785376] Dynamic subtest rcs0: SUCCESS (0.794s) [189.792381] Starting dynamic subtest: bcs0 [190.551289] Dynamic subtest bcs0: SUCCESS (0.765s) [190.559331] Starting dynamic subtest: vcs0 [191.319420] Dynamic subtest vcs0: SUCCESS (0.767s) [191.326142] Starting dynamic subtest: vecs0 [192.084250] Dynamic subtest vecs0: SUCCESS (0.764s) [192.085587] Subtest engines-persistence: SUCCESS (3.094s) [192.117959] [005/142] (799s left) kms_prop_blob (blob-prop-core) [192.165097] Starting subtest: blob-prop-core [192.165814] Subtest blob-prop-core: SUCCESS (0.000s) [192.242215] [006/142] (799s left) kms_flip (2x-flip-vs-wf_vblank) [192.330648] Starting subtest: 2x-flip-vs-wf_vblank [192.332020] Subtest 2x-flip-vs-wf_vblank: SKIP (0.001s) [192.434215] [007/142] (799s left) kms_atomic (plane-immutable-zpos) [192.625565] Starting subtest: plane-immutable-zpos [192.954968] Subtest plane-immutable-zpos: SUCCESS (0.329s) [193.128067] [008/142] (798s left) gem_exec_schedule (thriceslice) [193.177472] Starting subtest: thriceslice [193.178212] Starting dynamic subtest: rcs0 [193.180939] Dynamic subtest rcs0: SUCCESS (0.004s) [193.184731] Starting dynamic subtest: bcs0 [193.185463] Dynamic subtest bcs0: SUCCESS (0.002s) [193.189548] Starting dynamic subtest: vcs0 [193.190260] Dynamic subtest vcs0: SUCCESS (0.003s) [193.193819] Starting dynamic subtest: vecs0 [193.194511] Dynamic subtest vecs0: SUCCESS (0.003s) [193.195201] Subtest thriceslice: SUCCESS (0.013s) [193.498886] [009/142] (798s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_rc_ccs) [193.661781] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s) [193.765811] [010/142] (798s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [193.816282] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [193.816999] Starting dynamic subtest: smem [193.975101] Dynamic subtest smem: SUCCESS (0.150s) [193.975806] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (0.150s) [194.166722] [011/142] (797s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs) [194.259165] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs [194.260736] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s) [194.451336] [012/142] (797s left) i915_pm_rpm (gem-execbuf-stress) [195.876394] Starting subtest: gem-execbuf-stress [195.877700] Starting dynamic subtest: smem0 [197.434999] Dynamic subtest smem0: SUCCESS (1.558s) [197.442178] Starting dynamic subtest: extra-wait-smem0 [249.077871] Dynamic subtest extra-wait-smem0: SUCCESS (51.634s) [249.078608] Subtest gem-execbuf-stress: SUCCESS (53.194s) [249.291738] [013/142] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [249.382188] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [249.383548] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [249.488179] [014/142] (742s left) syncobj_timeline (invalid-single-wait-unsubmitted) [249.530568] Starting subtest: invalid-single-wait-unsubmitted [249.531276] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [249.615889] [015/142] (742s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs) [249.787928] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs [249.789262] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s) [249.894681] [016/142] (742s left) kms_plane (plane-panning-top-left) [249.971234] Starting subtest: plane-panning-top-left [249.971968] Starting dynamic subtest: pipe-A-planes [250.519163] Dynamic subtest pipe-A-planes: SUCCESS (0.545s) [250.525544] Starting dynamic subtest: pipe-B-planes [250.953504] Dynamic subtest pipe-B-planes: SUCCESS (0.433s) [250.954312] Subtest plane-panning-top-left: SUCCESS (0.982s) [251.095745] [017/142] (741s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_ccs) [251.248019] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_ccs [251.250241] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.001s) [251.347144] [018/142] (740s left) gem_mmap (bad-size) [251.386799] Starting subtest: bad-size [251.387539] Subtest bad-size: SUCCESS (0.000s) [251.491872] [019/142] (740s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [251.534032] Starting subtest: write-cpu-read-wc-unflushed [251.610803] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.077s) [251.697364] [020/142] (740s left) kms_plane_scaling (plane-scaler-with-modifiers-unity-scaling) [251.786314] Starting subtest: plane-scaler-with-modifiers-unity-scaling [251.787208] Starting dynamic subtest: pipe-A-HDMI-A-1 [252.504160] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.718s) [252.517320] Starting dynamic subtest: pipe-B-HDMI-A-1 [253.219382] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.712s) [253.220580] Subtest plane-scaler-with-modifiers-unity-scaling: SUCCESS (1.435s) [253.395121] [021/142] (738s left) perf_pmu (semaphore-wait-idle) [253.438560] Starting subtest: semaphore-wait-idle [253.439360] Starting dynamic subtest: rcs0 [253.956144] Dynamic subtest rcs0: SUCCESS (0.508s) [253.970090] Starting dynamic subtest: bcs0 [254.467044] Dynamic subtest bcs0: SUCCESS (0.509s) [254.480747] Starting dynamic subtest: vcs0 [254.977245] Dynamic subtest vcs0: SUCCESS (0.509s) [254.990847] Starting dynamic subtest: vecs0 [255.478503] Dynamic subtest vecs0: SUCCESS (0.509s) [255.479298] Subtest semaphore-wait-idle: SUCCESS (2.040s) [255.559976] [022/142] (736s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [255.644614] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [255.646197] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [255.731319] [023/142] (736s left) kms_big_fb (4-tiled-addfb-size-overflow) [255.817361] Starting subtest: 4-tiled-addfb-size-overflow [255.818751] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s) [255.919645] [024/142] (736s left) vc4/vc4_wait_bo (used-bo-0ns) [255.984511] Subtest used-bo-0ns: SKIP (0.000s) [256.050219] [025/142] (736s left) syncobj_wait (single-wait-submitted) [256.100609] Starting subtest: single-wait-submitted [256.204354] Subtest single-wait-submitted: SUCCESS (0.104s) [256.302415] [026/142] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [256.386465] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [256.387822] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [256.488747] [027/142] (735s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [256.575485] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [258.887277] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.314s) [259.062246] [028/142] (733s left) kms_frontbuffer_tracking (fbcpsr-suspend) [259.149086] Starting subtest: fbcpsr-suspend [259.150531] Subtest fbcpsr-suspend: SKIP (0.000s) [259.258876] [029/142] (733s left) gem_ctx_persistence (userptr) [259.302679] Starting subtest: userptr [259.385204] Subtest userptr: SUCCESS (0.080s) [259.468319] [030/142] (733s left) prime_vgem (basic-fence-read) [259.534720] Starting subtest: basic-fence-read [259.539681] Subtest basic-fence-read: SKIP (0.004s) [259.640924] [031/142] (732s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_mc_ccs) [259.790925] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s) [259.896734] [032/142] (732s left) api_intel_bb (intel-bb-blit-y) [259.939324] Starting subtest: intel-bb-blit-y [262.535051] Subtest intel-bb-blit-y: SUCCESS (2.588s) [262.623272] [033/142] (729s left) v3d/v3d_perfmon (get-values-invalid-pointer) [262.694308] Subtest get-values-invalid-pointer: SKIP (0.000s) [262.762107] [034/142] (729s left) gem_exec_fence (syncobj-timeline-wait) [263.205627] Starting subtest: syncobj-timeline-wait [263.239751] Subtest syncobj-timeline-wait: SUCCESS (0.043s) [263.429398] [035/142] (729s left) kms_cursor_edge_walk (256x256-top-bottom) [263.516633] Starting subtest: 256x256-top-bottom [263.517392] Starting dynamic subtest: pipe-A-HDMI-A-1 [267.210822] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.694s) [267.216067] Starting dynamic subtest: pipe-B-HDMI-A-1 [270.816869] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.605s) [270.817540] Subtest 256x256-top-bottom: SUCCESS (7.301s) [270.925538] [036/142] (721s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [270.965724] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [270.998688] [037/142] (721s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_mc_ccs) [271.145840] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs [271.147205] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s) [271.264551] [038/142] (721s left) kms_sequence (get-forked-busy) [271.352088] Starting subtest: get-forked-busy [271.352836] Starting dynamic subtest: HDMI-A-1-pipe-A [274.150519] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (2.798s) [274.160569] Starting dynamic subtest: HDMI-A-1-pipe-B [276.855410] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (2.703s) [276.856473] Subtest get-forked-busy: SUCCESS (5.504s) [276.984225] [039/142] (715s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [277.074544] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [277.075285] Starting dynamic subtest: pipe-A-valid-mode [277.113663] Dynamic subtest pipe-A-valid-mode: SKIP (0.038s) [277.115189] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.039s) [277.213429] [040/142] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [277.307219] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [277.308597] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [277.410219] [041/142] (715s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs) [277.591764] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s) [277.697187] [042/142] (715s left) kms_cursor_legacy (single-bo) [277.786216] Starting subtest: single-bo [277.786976] Starting dynamic subtest: pipe-A [283.202929] Dynamic subtest pipe-A: SUCCESS (5.380s) [283.207274] Starting dynamic subtest: pipe-B [288.580469] Dynamic subtest pipe-B: SUCCESS (5.379s) [288.584832] Starting dynamic subtest: all-pipes [293.932782] Dynamic subtest all-pipes: SUCCESS (5.378s) [293.933471] Subtest single-bo: SUCCESS (16.138s) [293.985660] [043/142] (698s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_ccs) [294.153136] Subtest pipe-C-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s) [294.259640] [044/142] (698s left) perf (invalid-remove-userspace-config) [294.368284] Starting subtest: invalid-remove-userspace-config [294.376342] Subtest invalid-remove-userspace-config: SUCCESS (0.009s) [294.391166] [045/142] (698s left) gem_mmap_offset (ptrace) [294.429689] Starting subtest: ptrace [294.430370] Starting dynamic subtest: smem0-gtt [294.456534] Dynamic subtest smem0-gtt: SUCCESS (0.026s) [294.460912] Starting dynamic subtest: smem0-wb [294.473765] Dynamic subtest smem0-wb: SUCCESS (0.017s) [294.478064] Starting dynamic subtest: smem0-wc [294.492558] Dynamic subtest smem0-wc: SUCCESS (0.018s) [294.496806] Starting dynamic subtest: smem0-uc [294.511974] Dynamic subtest smem0-uc: SUCCESS (0.019s) [294.512679] Subtest ptrace: SUCCESS (0.083s) [294.620680] [046/142] (698s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [294.714184] Starting subtest: yf-tiled-8bpp-rotate-180 [294.715583] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [294.802628] [047/142] (698s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite) [294.884817] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite [296.868436] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (1.986s) [297.032471] [048/142] (695s left) syncobj_wait (wait-delayed-signal) [297.081415] Starting subtest: wait-delayed-signal [297.182930] Subtest wait-delayed-signal: SUCCESS (0.101s) [297.281252] [049/142] (695s left) kms_lease (multimaster-lease) [297.362093] Starting subtest: multimaster-lease [297.364181] Subtest multimaster-lease: SUCCESS (0.002s) [297.449036] [050/142] (695s left) sysfs_timeslice_duration (duration) [297.490851] Starting subtest: duration [297.491607] Starting dynamic subtest: vecs0 [297.538762] Dynamic subtest vecs0: SUCCESS (0.047s) [297.554703] Starting dynamic subtest: vcs0 [297.604524] Dynamic subtest vcs0: SUCCESS (0.063s) [297.619361] Starting dynamic subtest: bcs0 [297.673875] Dynamic subtest bcs0: SUCCESS (0.067s) [297.689595] Starting dynamic subtest: rcs0 [297.732535] Dynamic subtest rcs0: SUCCESS (0.057s) [297.733718] Subtest duration: SUCCESS (0.242s) [297.829397] [051/142] (695s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [297.910359] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [297.911148] Starting dynamic subtest: pipe-A-HDMI-A-1 [298.041880] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.131s) [298.051251] Starting dynamic subtest: pipe-B-HDMI-A-1 [298.171057] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.123s) [298.171818] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.262s) [298.330948] [052/142] (694s left) prime_vgem (coherency-blt) [298.401515] Starting subtest: coherency-blt [299.038325] Subtest coherency-blt: SUCCESS (0.628s) [299.138614] [053/142] (693s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained) [299.208748] Subtest mark-unpurgeable-check-retained: SKIP (0.000s) [299.274789] [054/142] (693s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc) [299.430005] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [299.536836] [055/142] (693s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [299.626267] Starting subtest: primary-4-tiled-reflect-x-0 [299.734768] Subtest primary-4-tiled-reflect-x-0: SKIP (0.108s) [299.828778] [056/142] (693s left) gem_render_copy_redux (flink-interruptible) [299.867911] Starting subtest: flink-interruptible [300.610064] Subtest flink-interruptible: SUCCESS (0.742s) [300.726367] [057/142] (692s left) kms_lease (possible-crtcs-filtering) [300.811089] Starting subtest: possible-crtcs-filtering [300.813332] Subtest possible-crtcs-filtering: SUCCESS (0.001s) [300.903068] [058/142] (692s left) gem_exec_fence (submit) [301.072479] Starting subtest: submit [301.073362] Starting dynamic subtest: rcs0 [301.076677] Dynamic subtest rcs0: SUCCESS (0.012s) [301.081470] Starting dynamic subtest: bcs0 [301.083184] Dynamic subtest bcs0: SUCCESS (0.005s) [301.087673] Starting dynamic subtest: vcs0 [301.088412] Dynamic subtest vcs0: SUCCESS (0.004s) [301.093937] Starting dynamic subtest: vecs0 [301.094669] Dynamic subtest vecs0: SUCCESS (0.005s) [301.095370] Subtest submit: SUCCESS (0.029s) [301.549027] [059/142] (691s left) gem_wait (wait) [301.595192] Starting subtest: wait [301.595930] Starting dynamic subtest: all-engines [302.629566] Dynamic subtest all-engines: SUCCESS (1.033s) [302.644838] Starting dynamic subtest: rcs0 [303.654610] Dynamic subtest rcs0: SUCCESS (1.023s) [303.663103] Starting dynamic subtest: bcs0 [304.679336] Dynamic subtest bcs0: SUCCESS (1.023s) [304.689822] Starting dynamic subtest: vcs0 [305.701059] Dynamic subtest vcs0: SUCCESS (1.019s) [305.709671] Starting dynamic subtest: vecs0 [306.722070] Dynamic subtest vecs0: SUCCESS (1.015s) [306.723231] Subtest wait: SUCCESS (5.123s) [306.931829] [060/142] (686s left) kms_vblank (pipe-b-query-busy) [307.024890] Starting subtest: pipe-B-query-busy [309.841845] Subtest pipe-B-query-busy: SUCCESS (2.818s) [309.973553] [061/142] (683s left) kms_concurrent (pipe-d) [310.061537] Subtest pipe-D: SKIP (0.000s) [310.143989] [062/142] (683s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [310.228072] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [312.587336] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.361s) [312.754521] [063/142] (680s left) gem_pxp (create-regular-context-1) [315.310948] Subtest create-regular-context-1: SKIP (0.000s) [315.381595] [064/142] (677s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [315.469410] Starting subtest: fbc-modesetfrombusy [316.546817] Subtest fbc-modesetfrombusy: SUCCESS (1.079s) [316.672810] [065/142] (676s left) kms_cursor_crc (cursor-rapid-movement-512x170) [316.767654] Starting subtest: cursor-rapid-movement-512x170 [316.769025] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [316.861965] [066/142] (676s left) kms_universal_plane (disable-primary-vs-flip-pipe-c) [316.951163] Subtest disable-primary-vs-flip-pipe-C: SKIP (0.000s) [317.033651] [067/142] (676s left) kms_big_fb (x-tiled-16bpp-rotate-90) [317.122255] Starting subtest: x-tiled-16bpp-rotate-90 [317.186762] Subtest x-tiled-16bpp-rotate-90: SKIP (0.064s) [317.300852] [068/142] (676s left) kms_big_fb (linear-8bpp-rotate-90) [317.390590] Starting subtest: linear-8bpp-rotate-90 [317.450076] Subtest linear-8bpp-rotate-90: SKIP (0.059s) [317.565187] [069/142] (675s left) gem_exec_schedule (preempt-user) [317.612584] Starting subtest: preempt-user [317.613292] Starting dynamic subtest: rcs0 [317.627886] Dynamic subtest rcs0: SUCCESS (0.015s) [317.632629] Starting dynamic subtest: bcs0 [317.640505] Dynamic subtest bcs0: SUCCESS (0.012s) [317.645361] Starting dynamic subtest: vcs0 [317.654127] Dynamic subtest vcs0: SUCCESS (0.013s) [317.658977] Starting dynamic subtest: vecs0 [317.667599] Dynamic subtest vecs0: SUCCESS (0.013s) [317.668300] Subtest preempt-user: SUCCESS (0.055s) [317.975613] [070/142] (675s left) gem_exec_reloc (basic-write-read-active) [318.018965] Subtest basic-write-read-active: SKIP (0.000s) [318.082066] [071/142] (675s left) kms_addfb_basic (bo-too-small) [318.171166] Starting subtest: bo-too-small [318.172131] Subtest bo-too-small: SUCCESS (0.000s) [318.285994] [072/142] (675s left) gem_exec_reloc (basic-cpu-wc-active) [318.328893] Subtest basic-cpu-wc-active: SKIP (0.000s) [318.378624] [073/142] (675s left) gem_close_race (multigpu-basic-process) [318.421435] Starting subtest: multigpu-basic-process [318.422867] Subtest multigpu-basic-process: SKIP (0.000s) [318.609657] [074/142] (674s left) kms_chamelium_edid (dp-edid-read) [318.738147] Subtest dp-edid-read: SKIP (0.000s) [318.789654] [075/142] (674s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_mc_ccs) [318.946987] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s) [319.055467] [076/142] (674s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [319.090832] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [319.091554] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [319.169497] [077/142] (674s left) vc4/vc4_create_bo (create-bo-zeroed) [319.233489] Subtest create-bo-zeroed: SKIP (0.000s) [319.302419] [078/142] (674s left) gem_ctx_exec (basic-nohangcheck) [319.345843] Starting subtest: basic-nohangcheck [320.484986] Subtest basic-nohangcheck: FAIL (1.109s) [320.552990] [079/142] (673s left) gem_exec_params (larger-than-life-batch) [320.593662] Starting subtest: larger-than-life-batch [322.066749] Subtest larger-than-life-batch: SUCCESS (1.473s) [322.215909] [080/142] (671s left) kms_force_connector_basic (prune-stale-modes) [322.403278] Starting subtest: prune-stale-modes [322.623296] Subtest prune-stale-modes: SUCCESS (0.220s) [322.856320] [081/142] (670s left) kms_chamelium_audio (dp-audio-edid) [323.001658] Subtest dp-audio-edid: SKIP (0.000s) [323.052125] [082/142] (670s left) kms_big_fb (y-tiled-addfb-size-overflow) [323.139038] Starting subtest: y-tiled-addfb-size-overflow [323.139837] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.000s) [323.248485] [083/142] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [323.337633] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [323.339035] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [323.438285] [084/142] (670s left) kms_psr2_su (page_flip-xrgb8888) [323.477149] Subtest page_flip-XRGB8888: SKIP (0.000s) [323.509969] [085/142] (670s left) gem_userptr_blits (forbidden-operations) [323.550514] Starting subtest: forbidden-operations [323.551863] Subtest forbidden-operations: SKIP (0.000s) [323.663155] [086/142] (670s left) gem_exec_whisper (basic-queues-forked) [323.701900] Starting subtest: basic-queues-forked [328.476840] Subtest basic-queues-forked: SUCCESS (4.766s) [328.658911] [087/142] (665s left) gem_tiled_swapping (non-threaded) [332.188307] Starting subtest: non-threaded [338.721109] Subtest non-threaded: SUCCESS (6.524s) [339.891354] [088/142] (653s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [340.106483] Starting subtest: map-fixed-invalidate-overlap-busy [340.107289] Starting dynamic subtest: gtt [340.868767] Dynamic subtest gtt: SUCCESS (0.762s) [340.874840] Starting dynamic subtest: wb [341.618857] Dynamic subtest wb: SUCCESS (0.750s) [341.624991] Starting dynamic subtest: wc [342.375310] Dynamic subtest wc: SUCCESS (0.756s) [342.381443] Starting dynamic subtest: uc [343.192098] Dynamic subtest uc: SUCCESS (0.816s) [343.192877] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (3.086s) [343.319583] [089/142] (650s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [343.419522] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [343.420916] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [343.524588] [090/142] (650s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [343.573304] Starting subtest: stress-mm-invalidate-close-overlap [345.749827] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.169s) [345.913609] [091/142] (647s left) i915_pm_rps (thresholds-idle) [345.954396] Starting subtest: thresholds-idle [345.955282] Starting dynamic subtest: gt0 [356.322206] Dynamic subtest gt0: SUCCESS (10.367s) [356.323493] Subtest thresholds-idle: SUCCESS (10.368s) [356.409430] [092/142] (637s left) drm_read (short-buffer-wakeup) [356.591839] Starting subtest: short-buffer-wakeup [388.812909] Subtest short-buffer-wakeup: SUCCESS (32.214s) [388.966940] [093/142] (604s left) gem_mmap_wc (write-read-distinct) [389.007064] Starting subtest: write-read-distinct [389.007758] Subtest write-read-distinct: SUCCESS (0.001s) [389.126628] [094/142] (604s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [389.215863] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [390.325433] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.109s) [390.469976] [095/142] (603s left) gem_spin_batch (legacy-resubmit-new) [390.511316] Starting subtest: legacy-resubmit-new [390.512134] Starting dynamic subtest: default [390.514097] Dynamic subtest default: SUCCESS (0.002s) [390.520358] Starting dynamic subtest: render [390.521174] Dynamic subtest render: SUCCESS (0.001s) [390.527390] Starting dynamic subtest: bsd [390.528079] Dynamic subtest bsd: SUCCESS (0.001s) [390.533833] Starting dynamic subtest: bsd1 [390.534521] Dynamic subtest bsd1: SUCCESS (0.001s) [390.540249] Starting dynamic subtest: blt [390.540946] Dynamic subtest blt: SUCCESS (0.001s) [390.546687] Starting dynamic subtest: vebox [390.547380] Dynamic subtest vebox: SUCCESS (0.001s) [390.548088] Subtest legacy-resubmit-new: SUCCESS (0.012s) [390.722840] [096/142] (603s left) kms_chamelium_hpd (hdmi-hpd) [390.847767] Subtest hdmi-hpd: SKIP (0.000s) [390.904411] [097/142] (603s left) kms_addfb_basic (addfb25-modifier-no-flag) [390.941267] Starting subtest: addfb25-modifier-no-flag [390.941970] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [391.117311] [098/142] (602s left) v3d/v3d_submit_cl (simple-flush-cache) [391.176309] Subtest simple-flush-cache: SKIP (0.000s) [391.253735] [099/142] (602s left) gem_caching (writes) [391.290397] Starting subtest: writes [399.119147] Subtest writes: SUCCESS (7.829s) [399.226147] [100/142] (594s left) gem_exec_balancer (invalid-balancer) [399.271038] Starting subtest: invalid-balancer [400.057133] Subtest invalid-balancer: SUCCESS (0.777s) [401.043408] [101/142] (593s left) kms_feature_discovery (dp-mst) [401.133803] Starting subtest: dp-mst [401.135294] Subtest dp-mst: SKIP (0.000s) [401.231713] [102/142] (592s left) gem_exec_capture (capture-invisible) [401.273637] Starting subtest: capture-invisible [401.274382] Starting dynamic subtest: smem0 [401.275845] Dynamic subtest smem0: SKIP (0.000s) [401.277197] Subtest capture-invisible: SKIP (0.001s) [401.380323] [103/142] (592s left) i915_pm_freq_api (freq-reset) [401.420420] Subtest freq-reset: SKIP (0.000s) [401.458201] [104/142] (592s left) gem_userptr_blits (sync-unmap-cycles) [401.500979] Starting subtest: sync-unmap-cycles [406.874499] Subtest sync-unmap-cycles: SUCCESS (5.373s) [407.006805] [105/142] (587s left) syncobj_timeline (multi-wait-available-submitted-signaled) [407.039954] Starting subtest: multi-wait-available-submitted-signaled [407.040664] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [407.130270] [106/142] (587s left) gen9_exec_parse (bb-start-out) [407.170728] Subtest bb-start-out: SKIP (0.000s) [407.197996] [107/142] (587s left) gem_mmap (basic) [407.239159] Starting subtest: basic [407.242475] Subtest basic: SUCCESS (0.000s) [407.330628] [108/142] (586s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc) [407.477378] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc [407.478848] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [407.596383] [109/142] (586s left) kms_flip (plain-flip-fb-recreate-interruptible) [407.682426] Starting subtest: plain-flip-fb-recreate-interruptible [407.684148] Starting dynamic subtest: A-HDMI-A1 [423.182173] Dynamic subtest A-HDMI-A1: SUCCESS (15.498s) [423.192436] Starting dynamic subtest: B-HDMI-A1 [438.634777] Dynamic subtest B-HDMI-A1: SUCCESS (15.450s) [438.639217] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (30.956s) [438.808575] [110/142] (555s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_rc_ccs_cc) [438.973298] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [439.088578] [111/142] (555s left) gem_media_vme [439.151226] [112/142] (555s left) kms_color (gamma) [439.232473] Starting subtest: gamma [439.233363] Starting dynamic subtest: pipe-A [439.768166] Dynamic subtest pipe-A: SUCCESS (0.535s) [439.776010] Starting dynamic subtest: pipe-B [440.219950] Dynamic subtest pipe-B: SUCCESS (0.437s) [440.227691] Subtest gamma: SUCCESS (0.975s) [440.365918] [113/142] (554s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [440.460133] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [440.461653] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [440.566338] [114/142] (553s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [440.606114] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [440.708396] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s) [440.792488] [115/142] (553s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [440.830817] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [440.862971] [116/142] (553s left) api_intel_allocator (reopen) [440.898874] Starting subtest: reopen [440.899633] Subtest reopen: SUCCESS (0.001s) [441.007464] [117/142] (553s left) kms_vblank (pipe-b-query-forked-hang) [441.092550] Starting subtest: pipe-B-query-forked-hang [455.133120] Subtest pipe-B-query-forked-hang: SUCCESS (14.041s) [455.283752] [118/142] (539s left) gem_exec_reloc (basic-wc-gtt) [455.322031] Subtest basic-wc-gtt: SKIP (0.000s) [455.370524] [119/142] (539s left) kms_hdr (static-toggle-dpms) [455.448869] Starting subtest: static-toggle-dpms [455.450590] Subtest static-toggle-dpms: SKIP (0.000s) [455.528112] [120/142] (539s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [455.615548] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [455.616944] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [455.719523] [121/142] (538s left) gem_userptr_blits (huge-split) [455.766135] Starting subtest: huge-split [455.770088] Subtest huge-split: SUCCESS (0.004s) [455.892207] [122/142] (538s left) vgem_basic (setversion) [455.930696] Starting subtest: setversion [455.932022] Subtest setversion: SUCCESS (0.000s) [455.991788] [123/142] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [456.079732] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [456.081109] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [456.194695] [124/142] (538s left) gem_busy (busy) [456.238009] Starting subtest: busy [456.238739] Starting dynamic subtest: all-engines [456.258402] Dynamic subtest all-engines: SUCCESS (0.020s) [456.264609] Starting dynamic subtest: rcs0 [456.292178] Dynamic subtest rcs0: SUCCESS (0.033s) [456.307452] Starting dynamic subtest: bcs0 [456.326231] Dynamic subtest bcs0: SUCCESS (0.032s) [456.341733] Starting dynamic subtest: vcs0 [456.342487] Dynamic subtest vcs0: SUCCESS (0.012s) [456.348782] Starting dynamic subtest: vecs0 [456.349475] Dynamic subtest vecs0: SUCCESS (0.008s) [456.350158] Subtest busy: SUCCESS (0.111s) [456.698417] [125/142] (537s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [456.785220] Starting subtest: cursorB-vs-flipB-toggle [456.786710] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [456.876241] [126/142] (537s left) kms_vblank (pipe-a-query-busy) [456.962525] Starting subtest: pipe-A-query-busy [459.702498] Subtest pipe-A-query-busy: SUCCESS (2.740s) [459.851791] [127/142] (534s left) api_intel_bb (reset-flags) [459.886464] Starting subtest: reset-flags [459.889978] Subtest reset-flags: SUCCESS (0.004s) [460.022815] [128/142] (534s left) syncobj_wait (invalid-signal-bad-pad) [460.061488] Starting subtest: invalid-signal-bad-pad [460.062222] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [460.158139] [129/142] (534s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [460.244736] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [460.246108] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [460.345026] [130/142] (534s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [460.430343] Starting subtest: yf-tiled-64bpp-rotate-0 [460.431745] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [460.534784] [131/142] (534s left) kms_flip (flip-vs-expired-vblank-interruptible) [460.617118] Starting subtest: flip-vs-expired-vblank-interruptible [460.618776] Starting dynamic subtest: A-HDMI-A1 [475.810911] Dynamic subtest A-HDMI-A1: SUCCESS (15.192s) [475.821124] Starting dynamic subtest: B-HDMI-A1 [490.944937] Dynamic subtest B-HDMI-A1: SUCCESS (15.132s) [490.947338] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.329s) [491.108229] [132/142] (503s left) kms_flip (2x-plain-flip-ts-check-interruptible) [491.185041] Starting subtest: 2x-plain-flip-ts-check-interruptible [491.187332] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.001s) [491.290223] [133/142] (503s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [491.384928] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [491.386477] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [491.485656] [134/142] (503s left) syncobj_timeline (single-wait-all-available-submitted) [491.524013] Starting subtest: single-wait-all-available-submitted [491.524726] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [491.620118] [135/142] (503s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc) [491.756671] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc [491.810736] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.054s) [491.957538] [136/142] (503s left) gem_render_copy (linear) [491.997814] Starting subtest: linear [491.998515] Starting dynamic subtest: smem [492.061614] Dynamic subtest smem: SUCCESS (0.063s) [492.062392] Subtest linear: SUCCESS (0.064s) [492.263879] [137/142] (502s left) kms_content_protection (uevent) [492.353604] Starting subtest: uevent [492.494520] Subtest uevent: SKIP (0.136s) [492.662262] [138/142] (502s left) perf_pmu (busy) [492.701899] Starting subtest: busy [492.702599] Starting dynamic subtest: rcs0 [493.258723] Dynamic subtest rcs0: SUCCESS (0.554s) [493.267845] Starting dynamic subtest: bcs0 [493.790188] Dynamic subtest bcs0: SUCCESS (0.527s) [493.798174] Starting dynamic subtest: vcs0 [494.327925] Dynamic subtest vcs0: SUCCESS (0.539s) [494.337513] Starting dynamic subtest: vecs0 [494.860258] Dynamic subtest vecs0: SUCCESS (0.530s) [494.861503] Subtest busy: SUCCESS (2.157s) [494.936411] [139/142] (500s left) gem_softpin (softpin) [494.977090] Starting subtest: softpin [527.253503] Subtest softpin: SUCCESS (32.276s) [527.371764] [140/142] (467s left) gem_exec_fence (basic-wait-all) [527.411764] Starting subtest: basic-wait-all [527.466411] Subtest basic-wait-all: SUCCESS (0.054s) [528.057090] [141/142] (467s left) kms_vblank (pipe-d-ts-continuation-modeset-rpm) [528.137170] Subtest pipe-D-ts-continuation-modeset-rpm: SKIP (0.000s) [528.225892] [142/142] (466s left) gem_render_copy_redux (normal) [528.270183] Starting subtest: normal [528.610145] Subtest normal: SUCCESS (0.346s) [528.717177] Closing watchdogs Done.