[109.179993] Initializing watchdogs [109.180081] /dev/watchdog0 [109.184597] [001/144] (960s left) gem_exec_fence (basic-wait) [109.383797] Starting subtest: basic-wait [109.384669] Starting dynamic subtest: rcs0 [109.413832] Dynamic subtest rcs0: SUCCESS (0.038s) [109.422233] Starting dynamic subtest: bcs0 [109.445784] Dynamic subtest bcs0: SUCCESS (0.032s) [109.453677] Starting dynamic subtest: vcs0 [109.475476] Dynamic subtest vcs0: SUCCESS (0.029s) [109.483090] Starting dynamic subtest: vcs1 [109.505574] Dynamic subtest vcs1: SUCCESS (0.030s) [109.513193] Starting dynamic subtest: vecs0 [109.540622] Dynamic subtest vecs0: SUCCESS (0.035s) [109.541982] Subtest basic-wait: SUCCESS (0.165s) [109.996189] [002/144] (959s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [110.092589] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [110.093424] Starting dynamic subtest: pipe-A-valid-mode [110.145391] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s) [110.147012] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.052s) [110.215593] [003/144] (959s left) gem_exec_balancer (full) [110.276489] Starting subtest: full [111.336628] Subtest full: SUCCESS (1.058s) [111.614636] [004/144] (958s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [111.668955] Starting subtest: multi-wait-for-submit-available-submitted-signaled [111.669823] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s) [111.722090] [005/144] (958s left) kms_psr2_sf (fbc-overlay-plane-update-sf-dmg-area) [111.786221] Subtest fbc-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [111.817432] [006/144] (957s left) kms_psr (pr-primary-mmap-gtt) [111.921539] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [111.940800] [007/144] (957s left) gem_mmap_gtt (medium-copy-xy) [111.986037] Starting subtest: medium-copy-XY [117.389762] Subtest medium-copy-XY: SUCCESS (5.403s) [117.434014] [008/144] (952s left) gem_pxp (hw-rejects-pxp-buffer) [120.056126] Starting subtest: hw-rejects-pxp-buffer [120.057279] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s) [120.107257] [009/144] (949s left) gem_close (many-handles-one-vma) [120.161012] Starting subtest: many-handles-one-vma [120.185014] Subtest many-handles-one-vma: SUCCESS (0.024s) [120.255636] [010/144] (949s left) gem_linear_blits (basic) [120.369830] Starting subtest: basic [120.376226] Subtest basic: SUCCESS (0.007s) [120.467565] [011/144] (949s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render) [120.608080] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render [120.609642] Subtest psr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s) [120.660854] [012/144] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [120.760943] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [120.762667] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [120.809215] [013/144] (949s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [120.908540] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [120.910099] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [120.950737] [014/144] (948s left) perf (sysctl-defaults) [121.031134] Starting subtest: sysctl-defaults [121.031869] Subtest sysctl-defaults: SUCCESS (0.000s) [121.055209] [015/144] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [121.159850] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [121.161314] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [121.199867] [016/144] (948s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [121.291383] Starting subtest: fbc-rgb101010-draw-render [123.730150] Subtest fbc-rgb101010-draw-render: SUCCESS (2.440s) [123.809285] [017/144] (946s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc) [123.918167] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc [123.919632] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [123.969689] [018/144] (945s left) gem_eio (hibernate) [124.031950] Starting subtest: hibernate [140.820999] Subtest hibernate: SUCCESS (16.789s) [147.933642] [019/144] (929s left) kms_lease (simple-lease) [148.035974] Starting subtest: simple-lease [148.036955] Starting dynamic subtest: pipe-A-HDMI-A-1 [148.317980] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.282s) [148.330429] Starting dynamic subtest: pipe-B-HDMI-A-1 [148.491976] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.172s) [148.496982] Starting dynamic subtest: pipe-C-HDMI-A-1 [148.668878] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.176s) [148.678429] Starting dynamic subtest: pipe-D-HDMI-A-1 [148.846594] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.176s) [148.847376] Subtest simple-lease: SUCCESS (0.811s) [148.920141] [020/144] (928s left) drm_fdinfo (busy-check-all) [148.956267] Starting subtest: busy-check-all [148.957053] Starting dynamic subtest: rcs0 [149.473901] Dynamic subtest rcs0: SUCCESS (0.517s) [149.480918] Starting dynamic subtest: bcs0 [149.991486] Dynamic subtest bcs0: SUCCESS (0.514s) [149.996391] Starting dynamic subtest: vcs0 [150.505622] Dynamic subtest vcs0: SUCCESS (0.517s) [150.512248] Starting dynamic subtest: vcs1 [151.024274] Dynamic subtest vcs1: SUCCESS (0.519s) [151.031375] Starting dynamic subtest: vecs0 [151.541897] Dynamic subtest vecs0: SUCCESS (0.517s) [151.543166] Subtest busy-check-all: SUCCESS (2.584s) [151.586784] [021/144] (925s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [151.680742] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [152.758046] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.078s) [152.844119] [022/144] (924s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [152.938228] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [152.939876] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [152.998893] [023/144] (923s left) v3d/v3d_submit_csd (bad-bo) [153.058028] Subtest bad-bo: SKIP (0.000s) [153.088953] [024/144] (923s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [153.189948] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [153.741388] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: FAIL (0.302s) [153.780326] [025/144] (923s left) gem_exec_store (cachelines) [153.840168] Starting subtest: cachelines [153.841183] Starting dynamic subtest: rcs0 [153.893083] Dynamic subtest rcs0: SUCCESS (0.052s) [153.904830] Starting dynamic subtest: bcs0 [153.931053] Dynamic subtest bcs0: SUCCESS (0.038s) [153.941807] Starting dynamic subtest: vcs0 [153.958624] Dynamic subtest vcs0: SUCCESS (0.028s) [153.970199] Starting dynamic subtest: vcs1 [153.993972] Dynamic subtest vcs1: SUCCESS (0.035s) [154.005706] Starting dynamic subtest: vecs0 [154.038913] Dynamic subtest vecs0: SUCCESS (0.045s) [154.040308] Subtest cachelines: SUCCESS (0.198s) [154.189915] [026/144] (922s left) kms_cdclk (plane-scaling) [154.242568] Subtest plane-scaling: SKIP (0.000s) [154.279390] [027/144] (922s left) kms_big_fb (linear-64bpp-rotate-0) [154.384736] Starting subtest: linear-64bpp-rotate-0 [155.583230] Subtest linear-64bpp-rotate-0: SUCCESS (1.198s) [155.730806] [028/144] (921s left) gen7_exec_parse (basic-allocation) [155.776806] Subtest basic-allocation: SKIP (0.000s) [155.805694] [029/144] (921s left) kms_busy (extended-pageflip-hang-newfb) [155.903399] Starting subtest: extended-pageflip-hang-newfb [155.905428] Starting dynamic subtest: pipe-A [169.991903] Dynamic subtest pipe-A: SUCCESS (14.087s) [169.998447] Starting dynamic subtest: pipe-D [183.807148] Dynamic subtest pipe-D: SUCCESS (13.812s) [183.807977] Subtest extended-pageflip-hang-newfb: SUCCESS (27.903s) [183.922119] [030/144] (893s left) gem_userptr_blits (coherency-sync) [183.990037] Starting subtest: coherency-sync [184.101140] Subtest coherency-sync: SKIP (0.103s) [184.194754] [031/144] (892s left) gem_ctx_param (invalid-set-ringsize) [184.284245] Starting subtest: invalid-set-ringsize [184.285106] Subtest invalid-set-ringsize: SUCCESS (0.000s) [184.331921] [032/144] (892s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [184.447655] Starting subtest: primary-y-tiled-reflect-x-180 [189.565672] Subtest primary-y-tiled-reflect-x-180: SUCCESS (5.117s) [189.725416] [033/144] (887s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [189.822311] Starting subtest: flip-vs-cursor-atomic-transitions [195.603880] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (5.782s) [195.684769] [034/144] (881s left) kms_pm_dc (dc6-dpms) [196.786196] Starting subtest: dc6-dpms [198.199785] Subtest dc6-dpms: SUCCESS (1.405s) [198.231952] [035/144] (878s left) v3d/v3d_perfmon (create-perfmon-exceed) [198.297936] Subtest create-perfmon-exceed: SKIP (0.000s) [198.328947] [036/144] (878s left) gem_lmem_swapping (heavy-verify-multi-ccs) [198.377514] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [198.394677] [037/144] (878s left) vc4/vc4_create_bo (create-bo-4096) [198.456059] Subtest create-bo-4096: SKIP (0.000s) [198.495310] [038/144] (878s left) kms_psr (fbc-psr-cursor-plane-onoff) [198.596462] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [198.611553] [039/144] (878s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-dg2-rc-ccs) [198.755776] Starting subtest: pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs [198.757291] Subtest pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s) [198.926381] [040/144] (878s left) gem_exec_gttfill (engines) [198.989094] Starting subtest: engines [198.989904] Starting dynamic subtest: rcs0 [221.729853] Dynamic subtest rcs0: SUCCESS (22.732s) [221.734903] Starting dynamic subtest: bcs0 [244.481306] Dynamic subtest bcs0: SUCCESS (22.760s) [244.486998] Starting dynamic subtest: vcs0 [267.147313] Dynamic subtest vcs0: SUCCESS (22.666s) [267.152390] Starting dynamic subtest: vcs1 [289.966773] Dynamic subtest vcs1: SUCCESS (22.811s) [289.971757] Starting dynamic subtest: vecs0 [312.674322] Dynamic subtest vecs0: SUCCESS (22.716s) [312.675175] Subtest engines: SUCCESS (113.685s) [312.830434] [041/144] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [312.986937] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [312.988562] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [313.041187] [042/144] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [313.151792] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [313.153298] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [313.207774] [043/144] (764s left) prime_self_import (export-vs-gem_close-race) [313.248494] Starting subtest: export-vs-gem_close-race [318.304188] Subtest export-vs-gem_close-race: SUCCESS (5.039s) [318.334549] [044/144] (759s left) vc4/vc4_wait_bo (used-bo) [318.424599] Subtest used-bo: SKIP (0.000s) [318.458935] [045/144] (758s left) kms_ccs (pipe-b-ccs-on-another-bo-yf-tiled-ccs) [318.646627] Starting subtest: pipe-B-ccs-on-another-bo-yf-tiled-ccs [318.648230] Subtest pipe-B-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s) [318.774635] [046/144] (758s left) kms_ccs (pipe-c-bad-pixel-format-y-tiled-gen12-mc-ccs) [318.959137] Starting subtest: pipe-C-bad-pixel-format-y-tiled-gen12-mc-ccs [318.960618] Subtest pipe-C-bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.000s) [319.080120] [047/144] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [319.181883] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [320.517349] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (1.335s) [320.623421] [048/144] (756s left) gem_eio (wait-wedge-1us) [320.694404] Starting subtest: wait-wedge-1us [320.936442] Subtest wait-wedge-1us: SUCCESS (0.241s) [321.031928] [049/144] (756s left) kms_psr (psr-no-drrs) [321.121192] Subtest psr-no-drrs: SKIP (0.000s) [321.139955] [050/144] (756s left) i915_pm_rpm (debugfs-forcewake-user) [322.677394] Starting subtest: debugfs-forcewake-user [333.207246] Subtest debugfs-forcewake-user: SUCCESS (10.530s) [333.342102] [051/144] (744s left) syncobj_wait (multi-wait-for-submit-submitted) [333.385958] Starting subtest: multi-wait-for-submit-submitted [333.489819] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s) [333.536395] [052/144] (743s left) kms_scaling_modes (scaling-mode-full-aspect) [333.652360] Starting subtest: scaling-mode-full-aspect [333.655513] Subtest scaling-mode-full-aspect: SKIP (0.003s) [333.691708] [053/144] (743s left) syncobj_timeline (single-wait-all-for-submit-signaled) [333.739049] Starting subtest: single-wait-all-for-submit-signaled [333.739955] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [333.811343] [054/144] (743s left) perf (gen12-mi-rpc) [333.896365] Starting subtest: gen12-mi-rpc [333.897313] Starting dynamic subtest: rcs0 [333.907843] Dynamic subtest rcs0: SUCCESS (0.011s) [333.908644] Subtest gen12-mi-rpc: SUCCESS (0.012s) [333.922761] [055/144] (743s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [334.014575] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [334.016033] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [334.060259] [056/144] (743s left) kms_ccs (pipe-d-missing-ccs-buffer-y-tiled-ccs) [334.290811] Starting subtest: pipe-D-missing-ccs-buffer-y-tiled-ccs [334.292302] Subtest pipe-D-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s) [334.372757] [057/144] (743s left) gem_exec_schedule (preemptive-hang) [334.550542] Starting subtest: preemptive-hang [334.551866] Starting dynamic subtest: rcs0 [340.412469] Dynamic subtest rcs0: SUCCESS (5.837s) [340.417502] Starting dynamic subtest: bcs0 [346.356677] Dynamic subtest bcs0: SUCCESS (5.943s) [346.361943] Starting dynamic subtest: vcs0 [352.347856] Dynamic subtest vcs0: SUCCESS (6.015s) [352.353284] Starting dynamic subtest: vcs1 [358.396542] Dynamic subtest vcs1: SUCCESS (6.023s) [358.401562] Starting dynamic subtest: vecs0 [364.414433] Dynamic subtest vecs0: SUCCESS (6.016s) [364.415575] Subtest preemptive-hang: SUCCESS (29.839s) [364.537641] [058/144] (712s left) gem_userptr_blits (dmabuf-sync) [364.614126] Starting subtest: dmabuf-sync [364.618175] Subtest dmabuf-sync: SKIP (0.003s) [364.700064] [059/144] (712s left) kms_cursor_crc (cursor-alpha-transparent) [364.800193] Starting subtest: cursor-alpha-transparent [364.801031] Starting dynamic subtest: pipe-A-HDMI-A-1 [365.065059] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.265s) [365.072582] Starting dynamic subtest: pipe-D-HDMI-A-1 [365.307028] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.239s) [365.307853] Subtest cursor-alpha-transparent: SUCCESS (0.508s) [365.411898] [060/144] (712s left) kms_prime (basic-modeset-hybrid) [366.160304] Subtest basic-modeset-hybrid: SKIP (0.000s) [366.203934] [061/144] (711s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [366.298012] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [367.156857] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (0.858s) [367.256304] [062/144] (710s left) kms_atomic (plane-cursor-legacy) [367.359453] Starting subtest: plane-cursor-legacy [367.360223] Starting dynamic subtest: pipe-A-HDMI-A-1 [367.508436] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.149s) [367.509154] Subtest plane-cursor-legacy: SUCCESS (0.151s) [367.615288] [063/144] (709s left) kms_sysfs_edid_timing [368.150381] [064/144] (709s left) kms_chamelium_hpd (dp-hpd-storm) [368.293886] Subtest dp-hpd-storm: SKIP (0.000s) [368.352292] [065/144] (709s left) kms_pm_rpm (dpms-mode-unset-lpsp) [369.834958] Starting subtest: dpms-mode-unset-lpsp [370.868469] Subtest dpms-mode-unset-lpsp: SUCCESS (1.033s) [371.002371] [066/144] (706s left) kms_vblank (wait-forked-busy) [371.093096] Starting subtest: wait-forked-busy [371.095014] Starting dynamic subtest: pipe-A-HDMI-A-1 [372.363403] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.269s) [372.370950] Starting dynamic subtest: pipe-D-HDMI-A-1 [373.612308] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.245s) [373.613039] Subtest wait-forked-busy: SUCCESS (2.519s) [373.703611] [067/144] (703s left) kms_psr (fbc-pr-sprite-blt) [373.814079] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [373.829241] [068/144] (703s left) perf_pmu (rc6-suspend) [373.867214] Starting subtest: rc6-suspend [396.139520] Subtest rc6-suspend: SUCCESS (7.432s) [397.491208] [069/144] (696s left) gem_exec_schedule (preempt) [397.554148] Starting subtest: preempt [397.554976] Starting dynamic subtest: rcs0 [397.570665] Dynamic subtest rcs0: SUCCESS (0.016s) [397.576553] Starting dynamic subtest: bcs0 [397.587384] Dynamic subtest bcs0: SUCCESS (0.016s) [397.593400] Starting dynamic subtest: vcs0 [397.604170] Dynamic subtest vcs0: SUCCESS (0.016s) [397.610457] Starting dynamic subtest: vcs1 [397.619816] Dynamic subtest vcs1: SUCCESS (0.015s) [397.626013] Starting dynamic subtest: vecs0 [397.635333] Dynamic subtest vecs0: SUCCESS (0.015s) [397.636202] Subtest preempt: SUCCESS (0.081s) [397.907695] [070/144] (695s left) perf (invalid-open-flags) [397.982995] Starting subtest: invalid-open-flags [397.983780] Subtest invalid-open-flags: SUCCESS (0.000s) [398.005444] [071/144] (695s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [398.063986] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [398.064695] Starting dynamic subtest: smem [398.176348] Dynamic subtest smem: SUCCESS (0.112s) [398.177199] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (0.112s) [398.332557] [072/144] (695s left) gem_userptr_blits (usage-restrictions) [398.390494] Starting subtest: usage-restrictions [398.391178] Subtest usage-restrictions: SUCCESS (0.000s) [398.475689] [073/144] (695s left) kms_color (ctm-blue-to-red) [398.571832] Starting subtest: ctm-blue-to-red [398.572553] Starting dynamic subtest: pipe-A [398.842546] Dynamic subtest pipe-A: SUCCESS (0.271s) [398.850870] Starting dynamic subtest: pipe-B [399.105623] Dynamic subtest pipe-B: SUCCESS (0.262s) [399.110932] Starting dynamic subtest: pipe-C [399.372972] Dynamic subtest pipe-C: SUCCESS (0.267s) [399.378554] Starting dynamic subtest: pipe-D [399.636223] Dynamic subtest pipe-D: SUCCESS (0.262s) [399.637130] Subtest ctm-blue-to-red: SUCCESS (1.064s) [399.720453] [074/144] (693s left) kms_plane_scaling (planes-scaler-unity-scaling) [399.810890] Starting subtest: planes-scaler-unity-scaling [399.821972] Starting dynamic subtest: pipe-A-HDMI-A-1 [399.882002] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.061s) [399.899063] Starting dynamic subtest: pipe-B-HDMI-A-1 [400.015604] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.122s) [400.031525] Starting dynamic subtest: pipe-C-HDMI-A-1 [400.148467] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.122s) [400.165891] Starting dynamic subtest: pipe-D-HDMI-A-1 [400.281301] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.120s) [400.282170] Subtest planes-scaler-unity-scaling: SUCCESS (0.472s) [400.411529] [075/144] (693s left) kms_draw_crc (draw-method-blt) [400.504913] Starting subtest: draw-method-blt [400.505934] Starting dynamic subtest: xrgb8888-untiled [400.674086] Dynamic subtest xrgb8888-untiled: SUCCESS (0.169s) [400.689429] Starting dynamic subtest: rgb565-untiled [400.849148] Dynamic subtest rgb565-untiled: SUCCESS (0.174s) [400.861315] Starting dynamic subtest: xrgb2101010-untiled [400.999051] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.149s) [401.009632] Starting dynamic subtest: xrgb8888-xtiled [401.091052] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.090s) [401.104724] Starting dynamic subtest: rgb565-xtiled [401.174195] Dynamic subtest rgb565-xtiled: SUCCESS (0.082s) [401.187429] Starting dynamic subtest: xrgb2101010-xtiled [401.257200] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s) [401.269654] Starting dynamic subtest: xrgb8888-ytiled [401.357524] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.099s) [401.371341] Starting dynamic subtest: rgb565-ytiled [401.449119] Dynamic subtest rgb565-ytiled: SUCCESS (0.090s) [401.462959] Starting dynamic subtest: xrgb2101010-ytiled [401.540476] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.090s) [401.541854] Subtest draw-method-blt: SUCCESS (1.037s) [401.621704] [076/144] (692s left) gem_exec_nop (basic-parallel) [401.682612] Starting subtest: basic-parallel [404.980233] Subtest basic-parallel: SUCCESS (3.300s) [405.166915] [077/144] (688s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [405.224628] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [405.329041] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [405.387083] [078/144] (688s left) kms_chamelium_edid (dp-edid-read) [405.539880] Subtest dp-edid-read: SKIP (0.000s) [405.605882] [079/144] (688s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-xe2-ccs) [405.785699] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-xe2-ccs [405.787266] Subtest pipe-B-crc-primary-rotation-180-4-tiled-xe2-ccs: SKIP (0.000s) [405.923067] [080/144] (687s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [406.017248] Starting subtest: cursorB-vs-flipA-atomic [406.019934] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s) [406.056931] [081/144] (687s left) syncobj_basic (bad-handle-to-fd) [406.107475] Starting subtest: bad-handle-to-fd [406.108405] Subtest bad-handle-to-fd: SUCCESS (0.000s) [406.168157] [082/144] (687s left) gen7_exec_parse (oacontrol-tracking) [406.231297] Subtest oacontrol-tracking: SKIP (0.000s) [406.283064] [083/144] (687s left) dumb_buffer (create-clear) [406.337322] Starting subtest: create-clear [439.060878] Subtest create-clear: SUCCESS (32.723s) [439.155304] [084/144] (654s left) kms_ccs (pipe-c-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [439.367464] Starting subtest: pipe-C-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [439.368382] Subtest pipe-C-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.000s) [439.475443] [085/144] (654s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [439.574361] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [439.575749] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [439.631042] [086/144] (654s left) gem_create (create-ext-placement-each) [439.801800] Starting subtest: create-ext-placement-each [439.803139] Subtest create-ext-placement-each: SUCCESS (0.000s) [439.868764] [087/144] (653s left) kms_frontbuffer_tracking (plane-fbc-rte) [439.982515] Starting subtest: plane-fbc-rte [439.984135] Subtest plane-fbc-rte: SKIP (0.000s) [440.039932] [088/144] (653s left) i915_pm_freq_api (freq-reset) [440.093134] Subtest freq-reset: SKIP (0.000s) [440.136845] [089/144] (653s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [440.249432] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [440.251014] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [440.305057] [090/144] (653s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [440.356695] Starting subtest: single-wait-all-for-submit-unsubmitted [440.457090] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.100s) [440.504187] [091/144] (653s left) kms_flip (absolute-wf_vblank) [440.603064] Starting subtest: absolute-wf_vblank [440.605110] Starting dynamic subtest: A-HDMI-A1 [448.282230] Dynamic subtest A-HDMI-A1: SUCCESS (7.676s) [448.291280] Starting dynamic subtest: B-HDMI-A1 [455.939977] Dynamic subtest B-HDMI-A1: SUCCESS (7.656s) [455.949752] Starting dynamic subtest: C-HDMI-A1 [463.594449] Dynamic subtest C-HDMI-A1: SUCCESS (7.654s) [463.602442] Starting dynamic subtest: D-HDMI-A1 [471.254027] Dynamic subtest D-HDMI-A1: SUCCESS (7.659s) [471.259679] Subtest absolute-wf_vblank: SUCCESS (30.658s) [471.385618] [092/144] (622s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [471.481367] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [472.621575] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.140s) [472.703100] [093/144] (621s left) gem_ccs (ctrl-surf-copy) [472.754390] Starting subtest: ctrl-surf-copy [472.755931] Subtest ctrl-surf-copy: SKIP (0.000s) [472.819035] [094/144] (621s left) sw_sync (sync_multi_timeline_wait) [472.859488] Starting subtest: sync_multi_timeline_wait [472.860378] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [472.883615] [095/144] (621s left) gem_exec_create (forked) [472.935151] Starting subtest: forked [472.936058] Starting dynamic subtest: smem [493.023363] Dynamic subtest smem: SUCCESS (20.088s) [493.024169] Subtest forked: SUCCESS (20.089s) [493.183349] [096/144] (600s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-mtl-mc-ccs) [493.422146] Starting subtest: pipe-D-bad-pixel-format-4-tiled-mtl-mc-ccs [493.423670] Subtest pipe-D-bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s) [493.519740] [097/144] (600s left) gem_softpin (safe-alignment) [493.566066] Starting subtest: safe-alignment [493.577486] Subtest safe-alignment: SUCCESS (0.011s) [493.656865] [098/144] (600s left) syncobj_timeline (single-wait-signaled) [493.716636] Starting subtest: single-wait-signaled [493.717745] Subtest single-wait-signaled: SUCCESS (0.000s) [493.778555] [099/144] (600s left) gem_exec_fair (basic-deadline) [493.838487] Starting subtest: basic-deadline [504.622246] Subtest basic-deadline: SUCCESS (10.784s) [504.817764] [100/144] (589s left) gem_mmap_offset (close-race) [504.876622] Starting subtest: close-race [524.930519] Subtest close-race: SUCCESS (20.054s) [525.006367] [101/144] (569s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [525.200073] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [526.072150] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (0.872s) [526.275605] [102/144] (567s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-mtl-mc-ccs) [526.422456] Starting subtest: pipe-A-crc-primary-basic-4-tiled-mtl-mc-ccs [526.424037] Subtest pipe-A-crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.000s) [526.588658] [103/144] (567s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [526.633323] Starting subtest: etime-single-wait-for-submit-unsubmitted [526.736961] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s) [526.789758] [104/144] (567s left) prime_self_import (basic-with_one_bo) [526.827951] Starting subtest: basic-with_one_bo [526.847402] Subtest basic-with_one_bo: SUCCESS (0.020s) [526.914691] [105/144] (567s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [527.014849] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [528.250642] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (1.236s) [528.346813] [106/144] (565s left) v3d/v3d_perfmon (destroy-valid-perfmon) [528.401474] Subtest destroy-valid-perfmon: SKIP (0.000s) [528.435783] [107/144] (565s left) syncobj_wait (wait-for-submit-complex) [528.494446] Starting subtest: wait-for-submit-complex [528.556478] Subtest wait-for-submit-complex: SUCCESS (0.062s) [528.607893] [108/144] (565s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [528.704336] Starting subtest: compare-crc-sanitycheck-xr24 [528.705068] Starting dynamic subtest: pipe-A-HDMI-A-1 [528.952477] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.247s) [528.959135] Starting dynamic subtest: pipe-B-HDMI-A-1 [529.177232] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.224s) [529.187154] Starting dynamic subtest: pipe-C-HDMI-A-1 [529.407071] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.228s) [529.414795] Starting dynamic subtest: pipe-D-HDMI-A-1 [529.633191] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.224s) [529.633953] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.930s) [529.721527] [109/144] (564s left) api_intel_allocator (reopen-fork) [529.774945] Starting subtest: reopen-fork [533.093129] Subtest reopen-fork: SUCCESS (3.318s) [533.139182] [110/144] (561s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [533.201997] Starting subtest: invalid-bsd1-flag-on-vebox [533.202788] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [533.275110] [111/144] (560s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [533.326530] Starting subtest: addfb25-x-tiled-mismatch-legacy [533.327326] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [533.434684] [112/144] (560s left) gem_render_copy (linear) [533.487592] Starting subtest: linear [533.488420] Starting dynamic subtest: smem [533.551298] Dynamic subtest smem: SUCCESS (0.063s) [533.552306] Subtest linear: SUCCESS (0.064s) [533.706954] [113/144] (560s left) kms_psr (pr-primary-render) [533.820797] Subtest pr-primary-render: SKIP (0.000s) [533.840759] [114/144] (560s left) kms_atomic_interruptible (universal-setplane-cursor) [533.935030] Starting subtest: universal-setplane-cursor [533.935844] Starting dynamic subtest: pipe-A-HDMI-A-1 [540.139389] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.203s) [540.140263] Subtest universal-setplane-cursor: SUCCESS (6.205s) [540.236498] [115/144] (554s left) prime_mmap (test_correct_cpu_write) [540.288537] Starting subtest: test_correct_cpu_write [540.289639] Starting dynamic subtest: test_correct_cpu_write-smem [540.290673] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [540.291676] Subtest test_correct_cpu_write: SUCCESS (0.001s) [540.354810] [116/144] (553s left) kms_cursor_crc (cursor-random-512x512) [540.460384] Starting subtest: cursor-random-512x512 [540.463043] Subtest cursor-random-512x512: SKIP (0.001s) [540.524668] [117/144] (553s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [540.631107] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [540.632809] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [540.681060] [118/144] (553s left) i915_suspend (debugfs-reader) [540.736070] Starting subtest: debugfs-reader [559.004204] Subtest debugfs-reader: SUCCESS (3.087s) [562.046764] [119/144] (550s left) kms_ccs (pipe-b-bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [562.253573] Starting subtest: pipe-B-bad-aux-stride-y-tiled-gen12-rc-ccs-cc [562.254498] Subtest pipe-B-bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.001s) [562.380981] [120/144] (550s left) kms_flip (flip-vs-absolute-wf_vblank) [562.468727] Starting subtest: flip-vs-absolute-wf_vblank [562.471381] Starting dynamic subtest: A-HDMI-A1 [570.284399] Dynamic subtest A-HDMI-A1: SUCCESS (7.812s) [570.291838] Starting dynamic subtest: B-HDMI-A1 [578.066237] Dynamic subtest B-HDMI-A1: SUCCESS (7.780s) [578.072702] Starting dynamic subtest: C-HDMI-A1 [585.855667] Dynamic subtest C-HDMI-A1: SUCCESS (7.789s) [585.864448] Starting dynamic subtest: D-HDMI-A1 [593.639145] Dynamic subtest D-HDMI-A1: SUCCESS (7.783s) [593.641783] Subtest flip-vs-absolute-wf_vblank: SUCCESS (31.174s) [593.762597] [121/144] (518s left) gem_tiled_wb [600.072392] [122/144] (512s left) kms_ccs (pipe-c-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [600.288119] Starting subtest: pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [600.289542] Subtest pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [600.393490] [123/144] (512s left) gem_userptr_blits (invalid-null-pointer) [600.450935] Starting subtest: invalid-null-pointer [600.451878] Subtest invalid-null-pointer: SUCCESS (0.001s) [600.537959] [124/144] (512s left) gem_ctx_shared (q-in-order) [600.600558] Starting subtest: Q-in-order [600.601412] Starting dynamic subtest: rcs0 [600.643906] Dynamic subtest rcs0: SUCCESS (0.042s) [600.653413] Starting dynamic subtest: bcs0 [600.691195] Dynamic subtest bcs0: SUCCESS (0.046s) [600.704630] Starting dynamic subtest: vcs0 [600.743789] Dynamic subtest vcs0: SUCCESS (0.051s) [600.756626] Starting dynamic subtest: vcs1 [600.792472] Dynamic subtest vcs1: SUCCESS (0.047s) [600.804582] Starting dynamic subtest: vecs0 [600.841954] Dynamic subtest vecs0: SUCCESS (0.048s) [600.843338] Subtest Q-in-order: SUCCESS (0.241s) [600.999440] [125/144] (511s left) syncobj_eventfd (timeline-wait-signaled) [601.050267] Starting subtest: timeline-wait-signaled [601.051127] Subtest timeline-wait-signaled: SUCCESS (0.000s) [601.113159] [126/144] (511s left) api_intel_bb (offset-control) [601.163165] Starting subtest: offset-control [601.166596] Subtest offset-control: SUCCESS (0.004s) [601.245255] [127/144] (511s left) kms_cursor_edge_walk (128x128-top-bottom) [601.335214] Starting subtest: 128x128-top-bottom [601.336023] Starting dynamic subtest: pipe-A-HDMI-A-1 [603.063984] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.728s) [603.071081] Starting dynamic subtest: pipe-D-HDMI-A-1 [604.708418] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.643s) [604.709176] Subtest 128x128-top-bottom: SUCCESS (3.374s) [604.780951] [128/144] (507s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [604.869841] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [604.870572] Starting dynamic subtest: pipe-A-valid-mode [604.924920] Dynamic subtest pipe-A-valid-mode: SKIP (0.053s) [604.926329] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.055s) [604.997348] [129/144] (507s left) kms_getfb (getfb-handle-protection) [605.049344] Starting subtest: getfb-handle-protection [605.070874] Subtest getfb-handle-protection: SUCCESS (0.022s) [605.150598] [130/144] (507s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [605.258504] Starting subtest: yf-tiled-8bpp-rotate-270 [605.259928] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [605.322268] [131/144] (507s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [605.505043] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [605.508411] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.003s) [605.661189] [132/144] (507s left) gem_mmap_wc (bad-size) [605.709559] Starting subtest: bad-size [605.710584] Subtest bad-size: SUCCESS (0.001s) [605.780163] [133/144] (507s left) core_setmaster_vs_auth [605.882387] [134/144] (506s left) kms_vblank (ts-continuation-dpms-suspend) [605.979518] Starting subtest: ts-continuation-dpms-suspend [605.981705] Starting dynamic subtest: pipe-A-HDMI-A-1 [622.044874] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.247s) [622.054645] Starting dynamic subtest: pipe-D-HDMI-A-1 [638.064337] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.240s) [638.065163] Subtest ts-continuation-dpms-suspend: SUCCESS (2.493s) [643.207427] [135/144] (504s left) gem_lmem_swapping (verify) [643.253246] Subtest verify: SKIP (0.000s) [643.278030] [136/144] (504s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [643.341649] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [643.447057] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s) [643.502217] [137/144] (503s left) gem_render_copy_redux (flink-interruptible) [643.567421] Starting subtest: flink-interruptible [644.598693] Subtest flink-interruptible: SUCCESS (1.032s) [644.678363] [138/144] (502s left) kms_cursor_edge_walk (128x128-top-edge) [644.783277] Starting subtest: 128x128-top-edge [644.784097] Starting dynamic subtest: pipe-A-HDMI-A-1 [646.527994] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.744s) [646.534769] Starting dynamic subtest: pipe-D-HDMI-A-1 [648.194510] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.665s) [648.195300] Subtest 128x128-top-edge: SUCCESS (3.412s) [648.272684] [139/144] (499s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [648.368889] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [648.370581] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [648.426223] [140/144] (499s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf-tiled-ccs) [648.643584] Starting subtest: pipe-C-crc-sprite-planes-basic-yf-tiled-ccs [648.646596] Subtest pipe-C-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.002s) [648.747797] [141/144] (498s left) kms_ccs (pipe-d-ccs-on-another-bo-y-tiled-ccs) [648.982302] Starting subtest: pipe-D-ccs-on-another-bo-y-tiled-ccs [648.983874] Subtest pipe-D-ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s) [649.064365] [142/144] (498s left) kms_plane_multiple (tiling-x) [649.163836] Starting subtest: tiling-x [649.164651] Starting dynamic subtest: pipe-A-HDMI-A-1 [649.703003] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.538s) [649.709866] Starting dynamic subtest: pipe-B-HDMI-A-1 [650.218053] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.513s) [650.224902] Starting dynamic subtest: pipe-C-HDMI-A-1 [650.727351] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.508s) [650.735861] Starting dynamic subtest: pipe-D-HDMI-A-1 [651.250459] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.522s) [651.251256] Subtest tiling-x: SUCCESS (2.087s) [651.348604] [143/144] (496s left) gem_exec_alignment (pi-isolated)