[78.323188] Initializing watchdogs [78.323305] /dev/watchdog0 [78.332136] [001/130] (960s left) gem_partial_pwrite_pread (writes-after-reads) [78.403241] Subtest writes-after-reads: SKIP (0.000s) [78.451750] [002/130] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [78.546811] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [78.551250] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [78.609387] [003/130] (960s left) syncobj_wait (wait-all-for-submit-snapshot) [78.669523] Starting subtest: wait-all-for-submit-snapshot [78.750815] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [78.801940] [004/130] (960s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [78.890547] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [78.902696] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s) [78.952906] [005/130] (959s left) syncobj_timeline (invalid-transfer-non-existent-point) [79.003090] Starting subtest: invalid-transfer-non-existent-point [79.004865] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [79.064165] [006/130] (959s left) kms_cursor_legacy (single-move) [79.174074] Starting subtest: single-move [79.175891] Starting dynamic subtest: pipe-A [84.529846] Dynamic subtest pipe-A: SUCCESS (5.381s) [84.535558] Starting dynamic subtest: pipe-B [89.902951] Dynamic subtest pipe-B: SUCCESS (5.386s) [89.909995] Starting dynamic subtest: pipe-C [95.278667] Dynamic subtest pipe-C: SUCCESS (5.382s) [95.286834] Starting dynamic subtest: pipe-D [100.655801] Dynamic subtest pipe-D: SUCCESS (5.382s) [100.664461] Starting dynamic subtest: all-pipes [106.043510] Dynamic subtest all-pipes: SUCCESS (5.389s) [106.046123] Subtest single-move: SUCCESS (26.921s) [106.163829] [007/130] (932s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [106.280239] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [106.284589] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [106.356403] [008/130] (932s left) gem_workarounds (suspend-resume-context) [106.433816] Starting subtest: suspend-resume-context [122.911358] Subtest suspend-resume-context: SUCCESS (1.182s) [123.024962] [009/130] (931s left) gem_exec_fence (syncobj-timeline-export) [123.586919] Starting subtest: syncobj-timeline-export [123.592132] Subtest syncobj-timeline-export: SUCCESS (0.007s) [125.299647] [010/130] (928s left) gem_basic (multigpu-create-close) [125.348570] Starting subtest: multigpu-create-close [125.352923] Subtest multigpu-create-close: SKIP (0.000s) [125.428383] [011/130] (928s left) gem_exec_endless (dispatch) [125.494244] Starting subtest: dispatch [125.496670] Starting dynamic subtest: rcs0 [125.501739] Dynamic subtest rcs0: SUCCESS (0.005s) [125.510149] Starting dynamic subtest: bcs0 [125.514945] Dynamic subtest bcs0: SUCCESS (0.004s) [125.522269] Starting dynamic subtest: vcs0 [125.526693] Dynamic subtest vcs0: SUCCESS (0.004s) [125.532674] Starting dynamic subtest: vcs1 [125.536697] Dynamic subtest vcs1: SUCCESS (0.005s) [125.542764] Starting dynamic subtest: vecs0 [125.546803] Dynamic subtest vecs0: SUCCESS (0.004s) [125.552657] Starting dynamic subtest: ccs0 [125.556666] Dynamic subtest ccs0: SUCCESS (0.005s) [125.558531] Subtest dispatch: SUCCESS (0.028s) [127.205814] [012/130] (927s left) kms_psr (pr-suspend) [127.304583] Starting subtest: pr-suspend [127.309009] Subtest pr-suspend: SKIP (0.000s) [127.354854] [013/130] (926s left) kms_scaling_modes (scaling-mode-none) [127.458387] Starting subtest: scaling-mode-none [127.460807] Starting dynamic subtest: pipe-A-eDP-1 [127.555328] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s) [127.567248] Starting dynamic subtest: pipe-B-eDP-1 [127.585418] Dynamic subtest pipe-B-eDP-1: SKIP (0.030s) [127.594089] Starting dynamic subtest: pipe-C-eDP-1 [127.614943] Dynamic subtest pipe-C-eDP-1: SKIP (0.030s) [127.622593] Starting dynamic subtest: pipe-D-eDP-1 [127.649434] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s) [127.653666] Subtest scaling-mode-none: SKIP (0.191s) [127.766540] [014/130] (926s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [127.874715] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [127.878857] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [127.958366] [015/130] (926s left) kms_chamelium_color (ctm-red-to-blue) [128.066572] Subtest ctm-red-to-blue: SKIP (0.000s) [128.088675] [016/130] (926s left) prime_mmap (test_reprime) [128.139226] Starting subtest: test_reprime [128.141129] Starting dynamic subtest: test_reprime-smem [128.172367] Dynamic subtest test_reprime-smem: SUCCESS (0.036s) [128.174592] Subtest test_reprime: SUCCESS (0.036s) [128.237973] [017/130] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [128.337425] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [128.340984] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [128.405615] [018/130] (925s left) kms_cursor_crc (cursor-offscreen-512x512) [128.640037] Starting subtest: cursor-offscreen-512x512 [128.643833] Subtest cursor-offscreen-512x512: SKIP (0.001s) [128.783393] [019/130] (925s left) kms_addfb_basic (bo-too-small-due-to-tiling) [128.901153] Starting subtest: bo-too-small-due-to-tiling [128.904963] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [128.973666] [020/130] (925s left) gem_mmap_gtt (basic-small-bo) [129.037566] Subtest basic-small-bo: SKIP (0.000s) [129.086091] [021/130] (925s left) gem_exec_params (no-vebox) [129.145502] Starting subtest: no-vebox [129.147605] Subtest no-vebox: SUCCESS (0.002s) [131.287021] [022/130] (923s left) gem_create (create-ext-cpu-access-sanity-check) [131.468139] Starting subtest: create-ext-cpu-access-sanity-check [131.472992] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s) [131.519811] [023/130] (922s left) gem_eio (wait-wedge-1us) [131.699711] Starting subtest: wait-wedge-1us [133.249648] Subtest wait-wedge-1us: SUCCESS (1.557s) [133.351726] [024/130] (921s left) gem_mmap_gtt (cpuset-big-copy) [133.407761] Subtest cpuset-big-copy: SKIP (0.000s) [133.448868] [025/130] (920s left) gem_pwrite (basic-self) [133.507288] Subtest basic-self: SKIP (0.000s) [133.538726] [026/130] (920s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [133.588537] Starting subtest: etime-single-wait-all-for-submit-submitted [133.695895] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s) [133.749470] [027/130] (920s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [133.864342] Starting subtest: yf-tiled-8bpp-rotate-0 [133.868982] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [133.937703] [028/130] (920s left) kms_plane (plane-position-covered) [134.032374] Starting subtest: plane-position-covered [134.507148] Starting dynamic subtest: pipe-A-plane-1 [135.898099] Dynamic subtest pipe-A-plane-1: SUCCESS (1.397s) [135.907606] Starting dynamic subtest: pipe-A-plane-2 [137.194037] Dynamic subtest pipe-A-plane-2: SUCCESS (1.300s) [137.202607] Starting dynamic subtest: pipe-A-plane-3 [138.539242] Dynamic subtest pipe-A-plane-3: SUCCESS (1.348s) [138.552815] Starting dynamic subtest: pipe-A-plane-4 [139.891397] Dynamic subtest pipe-A-plane-4: SUCCESS (1.355s) [139.902546] Starting dynamic subtest: pipe-A-plane-5 [139.914434] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s) [141.156854] Starting dynamic subtest: pipe-B-plane-1 [142.493712] Dynamic subtest pipe-B-plane-1: SUCCESS (1.345s) [142.503365] Starting dynamic subtest: pipe-B-plane-2 [143.798960] Dynamic subtest pipe-B-plane-2: SUCCESS (1.307s) [143.807224] Starting dynamic subtest: pipe-B-plane-3 [145.158104] Dynamic subtest pipe-B-plane-3: SUCCESS (1.360s) [145.173260] Starting dynamic subtest: pipe-B-plane-4 [146.489639] Dynamic subtest pipe-B-plane-4: SUCCESS (1.334s) [146.499828] Starting dynamic subtest: pipe-B-plane-5 [146.511832] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [146.514257] Subtest plane-position-covered: SUCCESS (12.507s) [147.352482] [029/130] (907s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [147.470606] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [150.012335] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.548s) [150.151346] [030/130] (904s left) kms_color (legacy-gamma) [150.243975] Starting subtest: legacy-gamma [150.245840] Starting dynamic subtest: pipe-A-eDP-1 [150.908318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.662s) [150.917009] Starting dynamic subtest: pipe-B-eDP-1 [152.358043] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.450s) [152.366016] Starting dynamic subtest: pipe-C-eDP-1 [153.785581] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.429s) [153.792778] Starting dynamic subtest: pipe-D-eDP-1 [155.193364] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.408s) [155.195890] Subtest legacy-gamma: SUCCESS (4.950s) [156.093486] [031/130] (898s left) gem_ctx_param (invalid-param-get) [156.150122] Starting subtest: invalid-param-get [156.152485] Subtest invalid-param-get: SUCCESS (0.001s) [156.248407] [032/130] (898s left) gem_exec_reloc (basic-write-cpu-active) [156.307849] Subtest basic-write-cpu-active: SKIP (0.000s) [156.366437] [033/130] (898s left) kms_properties (crtc-properties-legacy) [156.462661] Starting subtest: crtc-properties-legacy [156.465118] Starting dynamic subtest: pipe-A-eDP-1 [156.919607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s) [156.928161] Starting dynamic subtest: pipe-B-eDP-1 [158.163582] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s) [158.171968] Starting dynamic subtest: pipe-C-eDP-1 [159.364258] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s) [159.373303] Starting dynamic subtest: pipe-D-eDP-1 [160.586719] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.218s) [160.588974] Subtest crtc-properties-legacy: SUCCESS (4.120s) [161.463873] [034/130] (893s left) gem_exec_params (rel-constants-invalid) [161.523283] Starting subtest: rel-constants-invalid [161.525749] Subtest rel-constants-invalid: SUCCESS (0.000s) [161.601558] [035/130] (892s left) kms_psr (fbc-psr-primary-render) [161.697485] Starting subtest: fbc-psr-primary-render [161.699842] Starting dynamic subtest: eDP-1 [161.704286] Dynamic subtest eDP-1: SKIP (0.000s) [161.708704] Subtest fbc-psr-primary-render: SKIP (0.000s) [161.749205] [036/130] (892s left) kms_big_fb (x-tiled-addfb) [161.857066] Starting subtest: x-tiled-addfb [161.859047] Subtest x-tiled-addfb: SUCCESS (0.000s) [161.946051] [037/130] (892s left) kms_psr (fbc-psr2-cursor-blt) [162.040906] Starting subtest: fbc-psr2-cursor-blt [162.043283] Starting dynamic subtest: eDP-1 [162.047861] Dynamic subtest eDP-1: SKIP (0.000s) [162.052373] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [162.093814] [038/130] (892s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [162.197815] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [162.202189] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [162.296801] [039/130] (892s left) api_intel_bb (purge-bb) [162.365459] Starting subtest: purge-bb [162.370354] Subtest purge-bb: SUCCESS (0.004s) [162.493203] [040/130] (892s left) kms_psr (psr-primary-blt) [162.586025] Starting subtest: psr-primary-blt [162.587932] Starting dynamic subtest: eDP-1 [164.380451] Dynamic subtest eDP-1: SUCCESS (1.792s) [164.383013] Subtest psr-primary-blt: SUCCESS (1.793s) [165.309232] [041/130] (889s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [165.362993] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [165.472052] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s) [165.526869] [042/130] (889s left) kms_lease (lease-invalid-plane) [165.627491] Starting subtest: lease-invalid-plane [165.629945] Starting dynamic subtest: pipe-A-eDP-1 [165.632208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [165.639137] Starting dynamic subtest: pipe-B-eDP-1 [165.641090] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [165.648276] Starting dynamic subtest: pipe-C-eDP-1 [165.650560] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [165.657574] Starting dynamic subtest: pipe-D-eDP-1 [165.659385] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [165.661236] Subtest lease-invalid-plane: SUCCESS (0.003s) [165.679166] [043/130] (889s left) kms_addfb_basic (bad-pitch-65536) [165.743623] Starting subtest: bad-pitch-65536 [165.746041] Subtest bad-pitch-65536: SUCCESS (0.000s) [165.884047] [044/130] (888s left) gem_sync (basic-many-each) [165.958725] Starting subtest: basic-many-each [168.244353] Subtest basic-many-each: SUCCESS (2.295s) [168.405899] [045/130] (886s left) kms_feature_discovery (dp-mst) [168.506378] Starting subtest: dp-mst [168.510593] Subtest dp-mst: SKIP (0.000s) [168.555808] [046/130] (886s left) gem_flink_race (flink_close) [168.593013] Starting subtest: flink_close [173.676618] Subtest flink_close: SUCCESS (5.084s) [173.726941] [047/130] (881s left) gem_exec_schedule (in-order) [173.805987] Starting subtest: in-order [173.808318] Starting dynamic subtest: rcs0 [173.982012] Dynamic subtest rcs0: SUCCESS (0.180s) [173.989572] Starting dynamic subtest: vcs0 [174.093594] Dynamic subtest vcs0: SUCCESS (0.112s) [174.103380] Starting dynamic subtest: vcs1 [174.208650] Dynamic subtest vcs1: SUCCESS (0.115s) [174.219589] Starting dynamic subtest: vecs0 [174.321701] Dynamic subtest vecs0: SUCCESS (0.113s) [174.329118] Starting dynamic subtest: ccs0 [174.465686] Dynamic subtest ccs0: SUCCESS (0.143s) [174.468155] Subtest in-order: SUCCESS (0.666s) [175.291603] [048/130] (879s left) kms_busy (extended-modeset-hang-newfb) [175.403487] Starting subtest: extended-modeset-hang-newfb [175.405792] Starting dynamic subtest: pipe-A [210.043064] Dynamic subtest pipe-A: SUCCESS (34.645s) [210.052148] Starting dynamic subtest: pipe-D [233.084070] Dynamic subtest pipe-D: SUCCESS (23.035s) [233.086617] Subtest extended-modeset-hang-newfb: SUCCESS (57.685s) [233.955088] [049/130] (820s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [234.065560] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [234.067860] Starting dynamic subtest: pipe-A [234.076954] Dynamic subtest pipe-A: SKIP (0.004s) [234.084757] Starting dynamic subtest: pipe-B [234.093846] Dynamic subtest pipe-B: SKIP (0.016s) [234.101735] Starting dynamic subtest: pipe-C [234.110578] Dynamic subtest pipe-C: SKIP (0.017s) [234.119956] Starting dynamic subtest: pipe-D [234.128561] Dynamic subtest pipe-D: SKIP (0.016s) [234.133118] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.054s) [234.215676] [050/130] (820s left) kms_pipe_crc_basic (bad-source) [234.309967] Starting subtest: bad-source [234.312101] Subtest bad-source: SUCCESS (0.000s) [234.361192] [051/130] (820s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [234.460582] Starting subtest: primary-yf-tiled-reflect-x-0 [234.522303] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s) [234.607395] [052/130] (820s left) kms_big_fb (y-tiled-64bpp-rotate-0) [234.710898] Starting subtest: y-tiled-64bpp-rotate-0 [234.715022] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [234.812425] [053/130] (820s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [234.886579] Starting subtest: stress-mm-invalidate-close-overlap [237.037606] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.149s) [237.145363] [054/130] (817s left) drm_fdinfo (memory-info-active) [237.188361] Starting subtest: memory-info-active [237.190695] Starting dynamic subtest: smem0 [239.800596] Dynamic subtest smem0: SUCCESS (2.614s) [239.802730] Subtest memory-info-active: SUCCESS (2.614s) [239.850940] [055/130] (815s left) kms_big_fb (4-tiled-16bpp-rotate-270) [239.967111] Starting subtest: 4-tiled-16bpp-rotate-270 [239.986060] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.018s) [240.100377] [056/130] (814s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [240.204559] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [245.453405] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.252s) [245.568916] [057/130] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [245.660736] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [245.665091] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [245.747417] [058/130] (809s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [245.854745] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [245.858845] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [245.945277] [059/130] (809s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [246.044638] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [250.928004] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.885s) [251.028277] [060/130] (803s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [251.134697] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [256.046273] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.915s) [256.150740] [061/130] (798s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [256.251327] Starting subtest: plane-scaler-unity-scaling-with-rotation [256.253779] Starting dynamic subtest: pipe-A [256.481191] Dynamic subtest pipe-A: SUCCESS (0.229s) [256.490826] Starting dynamic subtest: pipe-B [257.829327] Dynamic subtest pipe-B: SUCCESS (1.348s) [257.837572] Starting dynamic subtest: pipe-C [259.193926] Dynamic subtest pipe-C: SUCCESS (1.364s) [259.203610] Starting dynamic subtest: pipe-D [260.580812] Dynamic subtest pipe-D: SUCCESS (1.386s) [260.583227] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.330s) [261.817705] [062/130] (793s left) syncobj_timeline (multi-wait-available-submitted-signaled) [261.867961] Starting subtest: multi-wait-available-submitted-signaled [261.870308] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [261.944970] [063/130] (793s left) i915_query (hwconfig_table) [262.000061] Starting subtest: hwconfig_table [262.302788] Subtest hwconfig_table: SUCCESS (0.003s) [262.320179] [064/130] (792s left) kms_universal_plane (universal-plane-functional) [262.420349] Starting subtest: universal-plane-functional [262.422838] Starting dynamic subtest: pipe-A-eDP-1 [266.314001] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.892s) [266.323462] Starting dynamic subtest: pipe-B-eDP-1 [270.921060] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.606s) [270.929267] Starting dynamic subtest: pipe-C-eDP-1 [275.368533] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.444s) [275.377087] Starting dynamic subtest: pipe-D-eDP-1 [279.846725] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.479s) [279.849266] Subtest universal-plane-functional: SUCCESS (17.427s) [280.763256] [065/130] (774s left) gem_exec_schedule (noreorder) [280.945170] Starting subtest: noreorder [280.947826] Starting dynamic subtest: rcs0 [281.021390] Dynamic subtest rcs0: SUCCESS (0.076s) [281.032177] Starting dynamic subtest: vcs0 [282.170884] Dynamic subtest vcs0: SUCCESS (1.147s) [282.181712] Starting dynamic subtest: vcs1 [284.162794] Dynamic subtest vcs1: SUCCESS (1.990s) [284.173371] Starting dynamic subtest: vecs0 [286.200266] Dynamic subtest vecs0: SUCCESS (2.036s) [286.211009] Starting dynamic subtest: ccs0 [286.287349] Dynamic subtest ccs0: SUCCESS (0.087s) [286.289848] Subtest noreorder: SUCCESS (5.344s) [286.454935] [066/130] (768s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [291.580375] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [291.582617] Starting dynamic subtest: pipe-A-eDP-1 [303.352886] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.774s) [303.361585] Starting dynamic subtest: pipe-B-eDP-1 [315.142797] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.790s) [315.144981] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.569s) [316.026238] [067/130] (739s left) syncobj_wait (wait-all-for-submit-delayed-submit) [316.087931] Starting subtest: wait-all-for-submit-delayed-submit [316.191710] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s) [316.243057] [068/130] (738s left) i915_pm_rpm (gem-pread) [318.373846] Starting subtest: gem-pread [320.071302] Subtest gem-pread: SUCCESS (1.696s) [320.153268] [069/130] (735s left) gem_ctx_persistence (heartbeat-hostile) [320.222335] Starting subtest: heartbeat-hostile [320.226838] Subtest heartbeat-hostile: SKIP (0.000s) [320.326457] [070/130] (734s left) gem_eio (wait-wedge-immediate) [320.565129] Starting subtest: wait-wedge-immediate [322.274980] Subtest wait-wedge-immediate: SUCCESS (1.709s) [322.410336] [071/130] (732s left) gem_exec_reloc (basic-cpu-read-noreloc) [322.463961] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [322.529937] [072/130] (732s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [322.622633] Starting subtest: fbc-rgb101010-draw-pwrite [327.048244] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (4.430s) [327.165952] [073/130] (728s left) drm_fdinfo (idle) [327.207316] Starting subtest: idle [327.209627] Starting dynamic subtest: rcs0 [327.817540] Dynamic subtest rcs0: SUCCESS (0.610s) [327.828786] Starting dynamic subtest: bcs0 [328.326449] Dynamic subtest bcs0: SUCCESS (0.503s) [328.334550] Starting dynamic subtest: vcs0 [328.828224] Dynamic subtest vcs0: SUCCESS (0.503s) [328.836465] Starting dynamic subtest: vcs1 [329.331545] Dynamic subtest vcs1: SUCCESS (0.502s) [329.339617] Starting dynamic subtest: vecs0 [329.837400] Dynamic subtest vecs0: SUCCESS (0.503s) [329.845992] Starting dynamic subtest: ccs0 [330.342279] Dynamic subtest ccs0: SUCCESS (0.503s) [330.345492] Subtest idle: SUCCESS (3.135s) [330.398684] [074/130] (724s left) vgem_basic (bad-handle) [330.438768] Starting subtest: bad-handle [330.441090] Subtest bad-handle: SUCCESS (0.000s) [330.472879] [075/130] (724s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [330.582808] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [330.585272] Starting dynamic subtest: pipe-A-eDP-1 [330.606028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [330.615814] Starting dynamic subtest: pipe-B-eDP-1 [330.634768] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [330.642205] Starting dynamic subtest: pipe-C-eDP-1 [330.661604] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [330.668784] Starting dynamic subtest: pipe-D-eDP-1 [330.688267] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [330.690141] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s) [332.922630] [076/130] (722s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [333.027702] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [333.031641] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [333.116534] [077/130] (722s left) kms_getfb (getfb2-handle-closed) [333.169843] Starting subtest: getfb2-handle-closed [333.172165] Subtest getfb2-handle-closed: SUCCESS (0.000s) [333.265305] [078/130] (722s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [333.363611] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [333.365898] Starting dynamic subtest: pipe-A-eDP-1 [333.388497] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [333.396730] Starting dynamic subtest: pipe-B-eDP-1 [333.417773] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [333.424941] Starting dynamic subtest: pipe-C-eDP-1 [333.446356] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [333.453162] Starting dynamic subtest: pipe-D-eDP-1 [333.474775] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [333.479072] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s) [335.738317] [079/130] (719s left) gem_render_copy (yf-tiled-ccs-to-linear) [335.809902] Starting subtest: yf-tiled-ccs-to-linear [335.814260] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [335.972638] [080/130] (719s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [336.085929] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [336.088309] Starting dynamic subtest: pipe-A-default-mode [336.377333] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [336.382034] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.286s) [337.297005] [081/130] (718s left) syncobj_wait (invalid-reset-one-illegal-handle) [337.362382] Starting subtest: invalid-reset-one-illegal-handle [337.364833] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [337.450929] [082/130] (717s left) gem_readwrite (read-bad-handle) [337.515182] Subtest read-bad-handle: SKIP (0.000s) [337.558808] [083/130] (717s left) gem_mmap_gtt (basic-write) [337.621066] Subtest basic-write: SKIP (0.000s) [337.690580] [084/130] (717s left) kms_getfb (getfb2-handle-not-fb) [337.754195] Starting subtest: getfb2-handle-not-fb [337.796001] Subtest getfb2-handle-not-fb: SUCCESS (0.043s) [337.895237] [085/130] (717s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [337.987586] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [337.989849] Starting dynamic subtest: pipe-A-eDP-1 [338.012725] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [338.022116] Starting dynamic subtest: pipe-B-eDP-1 [338.040571] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [338.047736] Starting dynamic subtest: pipe-C-eDP-1 [338.064736] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [338.071615] Starting dynamic subtest: pipe-D-eDP-1 [338.089559] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [338.093148] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s) [340.350092] [086/130] (715s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [340.466822] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [341.320314] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.855s) [341.446499] [087/130] (714s left) kms_writeback (writeback-pixel-formats) [341.554613] Subtest writeback-pixel-formats: SKIP (0.000s) [341.578819] [088/130] (713s left) kms_psr2_su (page_flip-p010) [341.643003] Subtest page_flip-P010: SKIP (0.000s) [341.683724] [089/130] (713s left) kms_feature_discovery (display-2x) [341.781727] Starting subtest: display-2x [341.785321] Subtest display-2x: SKIP (0.000s) [341.831795] [090/130] (713s left) kms_chamelium_hpd (vga-hpd) [342.224125] Subtest vga-hpd: SKIP (0.000s) [343.079041] [091/130] (712s left) gem_mmap_offset (bad-flags) [343.141235] Starting subtest: bad-flags [343.143134] Subtest bad-flags: SUCCESS (0.000s) [343.201925] [092/130] (712s left) kms_prop_blob (invalid-get-prop) [343.260229] Starting subtest: invalid-get-prop [343.262526] Subtest invalid-get-prop: SUCCESS (0.000s) [343.341941] [093/130] (712s left) kms_cursor_crc (cursor-sliding-64x21) [343.513143] Starting subtest: cursor-sliding-64x21 [343.552174] Subtest cursor-sliding-64x21: SKIP (0.036s) [343.766331] [094/130] (711s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [343.883574] Starting subtest: cursorB-vs-flipB-varying-size [343.887583] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [343.976351] [095/130] (711s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [344.069386] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [344.071406] Starting dynamic subtest: pipe-A-eDP-1 [344.121814] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [344.130729] Starting dynamic subtest: pipe-B-eDP-1 [344.179245] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [344.187357] Starting dynamic subtest: pipe-C-eDP-1 [344.234045] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [344.242010] Starting dynamic subtest: pipe-D-eDP-1 [344.297529] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [344.301063] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s) [346.426204] [096/130] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [346.531868] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [346.536162] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [346.600858] [097/130] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [346.708133] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [346.712625] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [346.788085] [098/130] (708s left) kms_atomic (plane-invalid-params-fence) [346.873617] Starting subtest: plane-invalid-params-fence [346.875888] Starting dynamic subtest: pipe-A-eDP-1 [347.228391] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.353s) [347.230842] Subtest plane-invalid-params-fence: SUCCESS (0.354s) [348.093999] [099/130] (707s left) gem_fence_thrash (bo-write-verify-threaded-none) [348.130154] Starting subtest: bo-write-verify-threaded-none [348.152455] Subtest bo-write-verify-threaded-none: SKIP (0.020s) [348.205368] [100/130] (707s left) i915_pm_freq_api (freq-suspend) [348.268643] Starting subtest: freq-suspend [348.271058] Starting dynamic subtest: gt0 [364.900076] Dynamic subtest gt0: SUCCESS (1.164s) [364.908887] Starting dynamic subtest: gt1 [380.819142] Dynamic subtest gt1: SUCCESS (1.076s) [380.822569] Subtest freq-suspend: SUCCESS (2.242s) [381.872085] [101/130] (705s left) gem_exec_schedule (semaphore-resolve) [381.941125] Starting subtest: semaphore-resolve [381.967972] Subtest semaphore-resolve: SUCCESS (0.035s) [382.310859] [102/130] (704s left) perf (gen8-unprivileged-single-ctx-counters) [382.526970] Starting subtest: gen8-unprivileged-single-ctx-counters [382.530825] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [382.552262] [103/130] (704s left) perf_pmu (init-wait) [382.596068] Starting subtest: init-wait [382.598320] Starting dynamic subtest: rcs0 [382.600513] Dynamic subtest rcs0: SUCCESS (0.002s) [382.611340] Starting dynamic subtest: bcs0 [382.613569] Dynamic subtest bcs0: SUCCESS (0.001s) [382.621658] Starting dynamic subtest: vcs0 [382.623763] Dynamic subtest vcs0: SUCCESS (0.001s) [382.631193] Starting dynamic subtest: vcs1 [382.633349] Dynamic subtest vcs1: SUCCESS (0.001s) [382.640925] Starting dynamic subtest: vecs0 [382.643013] Dynamic subtest vecs0: SUCCESS (0.001s) [382.650641] Starting dynamic subtest: ccs0 [382.652809] Dynamic subtest ccs0: SUCCESS (0.001s) [382.655147] Subtest init-wait: SUCCESS (0.009s) [382.695161] [104/130] (704s left) gem_exercise_blt (fast-copy) [382.763962] Starting subtest: fast-copy [382.766394] Starting dynamic subtest: linear-smem-smem [382.787840] Dynamic subtest linear-smem-smem: SUCCESS (0.024s) [382.797721] Starting dynamic subtest: xmajor-smem-smem [382.806466] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s) [382.814070] Starting dynamic subtest: tile4-smem-smem [382.823563] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s) [382.831356] Starting dynamic subtest: tile64-smem-smem [382.843361] Dynamic subtest tile64-smem-smem: SUCCESS (0.019s) [382.845745] Subtest fast-copy: SUCCESS (0.081s) [382.939618] [105/130] (704s left) gem_userptr_blits (readonly-unsync) [383.001235] Subtest readonly-unsync: SKIP (0.000s) [383.114852] [106/130] (704s left) kms_pm_dc (dc5-dpms-negative) [384.218660] Starting subtest: dc5-dpms-negative [384.223045] Subtest dc5-dpms-negative: SKIP (0.000s) [384.271064] [107/130] (702s left) gem_exec_whisper (basic-fds-priority) [384.329660] Starting subtest: basic-fds-priority [404.484469] Subtest basic-fds-priority: SUCCESS (20.225s) [404.651064] [108/130] (682s left) gem_spin_batch (legacy-resubmit-new) [404.723002] Starting subtest: legacy-resubmit-new [404.725446] Starting dynamic subtest: default [404.736212] Dynamic subtest default: SUCCESS (0.012s) [404.746146] Starting dynamic subtest: render [404.748652] Dynamic subtest render: SUCCESS (0.004s) [404.759553] Starting dynamic subtest: bsd [404.761891] Dynamic subtest bsd: SUCCESS (0.006s) [404.770453] Starting dynamic subtest: bsd1 [404.772757] Dynamic subtest bsd1: SUCCESS (0.007s) [404.781201] Starting dynamic subtest: bsd2 [404.783559] Dynamic subtest bsd2: SUCCESS (0.003s) [404.793692] Starting dynamic subtest: blt [404.795666] Dynamic subtest blt: SUCCESS (0.006s) [404.803983] Starting dynamic subtest: vebox [404.805885] Dynamic subtest vebox: SUCCESS (0.006s) [404.807783] Subtest legacy-resubmit-new: SUCCESS (0.050s) [406.537838] [109/130] (680s left) syncobj_timeline (single-wait-available-submitted) [406.593622] Starting subtest: single-wait-available-submitted [406.596202] Subtest single-wait-available-submitted: SUCCESS (0.000s) [406.676062] [110/130] (680s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [406.735844] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [406.740212] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [406.904980] [111/130] (680s left) kms_vblank (ts-continuation-dpms-rpm) [407.022154] Starting subtest: ts-continuation-dpms-rpm [407.024470] Starting dynamic subtest: pipe-A-eDP-1 [409.553320] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.533s) [409.566962] Starting dynamic subtest: pipe-D-eDP-1 [411.871764] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.316s) [411.874181] Subtest ts-continuation-dpms-rpm: SUCCESS (4.854s) [412.764632] [112/130] (674s left) kms_cursor_crc (cursor-onscreen-max-size) [413.030498] Starting subtest: cursor-onscreen-max-size [413.036814] Subtest cursor-onscreen-max-size: SKIP (0.000s) [413.160222] [113/130] (674s left) prime_vgem (coherency-blt) [413.230872] Starting subtest: coherency-blt [414.165333] Subtest coherency-blt: SUCCESS (0.933s) [414.313295] [114/130] (672s left) gem_exec_balancer (invalid-bonds) [414.370282] Starting subtest: invalid-bonds [414.375075] Subtest invalid-bonds: SKIP (0.000s) [414.642454] [115/130] (672s left) gem_ctx_sseu (mmap-args) [414.701477] Subtest mmap-args: SKIP (0.000s) [414.771193] [116/130] (672s left) kms_chamelium_audio (dp-audio) [415.159438] Subtest dp-audio: SKIP (0.000s) [416.006869] [117/130] (671s left) gem_eio (in-flight-contexts-immediate) [416.244709] Starting subtest: in-flight-contexts-immediate [427.522660] Subtest in-flight-contexts-immediate: SUCCESS (11.279s) [427.690894] [118/130] (659s left) kms_pm_rpm (i2c) [429.618542] Starting subtest: i2c [435.542556] Subtest i2c: SUCCESS (5.924s) [435.612273] [119/130] (651s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [435.736202] Starting subtest: cursor-vs-flip-varying-size [466.104981] Subtest cursor-vs-flip-varying-size: SUCCESS (30.380s) [466.972464] [120/130] (620s left) kms_plane_alpha_blend (alpha-transparent-fb) [467.079916] Starting subtest: alpha-transparent-fb [467.351920] Starting dynamic subtest: pipe-A-eDP-1 [467.905845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s) [467.915759] Starting dynamic subtest: pipe-D-eDP-1 [469.339188] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.433s) [469.341524] Subtest alpha-transparent-fb: SUCCESS (2.258s) [470.234710] [121/130] (617s left) kms_big_fb (linear-64bpp-rotate-90) [470.340966] Starting subtest: linear-64bpp-rotate-90 [470.359582] Subtest linear-64bpp-rotate-90: SKIP (0.018s) [470.465640] [122/130] (616s left) perf (sysctl-defaults) [470.553330] Starting subtest: sysctl-defaults [470.555978] Subtest sysctl-defaults: SUCCESS (0.000s) [470.598338] [123/130] (616s left) prime_mmap (test_userptr) [470.650327] Starting subtest: test_userptr [470.652635] Starting dynamic subtest: test_userptr-smem [470.654670] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [470.657055] Subtest test_userptr: SUCCESS (0.001s) [470.726608] [124/130] (616s left) gen7_exec_parse (bitmasks) [470.787038] Subtest bitmasks: SKIP (0.000s) [470.839724] [125/130] (616s left) kms_flip (2x-plain-flip-ts-check-interruptible) [470.938262] Starting subtest: 2x-plain-flip-ts-check-interruptible [470.950996] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s) [471.037833] [126/130] (616s left) gem_tiled_partial_pwrite_pread (reads) [471.110499] Subtest reads: SKIP (0.000s) [471.159332] [127/130] (616s left) api_intel_allocator (fork-simple-stress) [471.222070] Starting subtest: fork-simple-stress [476.625444] Subtest fork-simple-stress: SUCCESS (5.405s) [476.732210] [128/130] (610s left) gem_ctx_persistence (legacy-engines-cleanup) [476.794168] Starting subtest: legacy-engines-cleanup [476.796669] Starting dynamic subtest: render [476.900576] Dynamic subtest render: SUCCESS (0.106s) [476.912332] Starting dynamic subtest: bsd1 [476.964003] Dynamic subtest bsd1: SUCCESS (0.061s) [476.975734] Starting dynamic subtest: bsd2 [477.005050] Dynamic subtest bsd2: SUCCESS (0.038s) [477.016091] Starting dynamic subtest: blt [477.084554] Dynamic subtest blt: SUCCESS (0.077s) [477.096003] Starting dynamic subtest: vebox [477.120549] Dynamic subtest vebox: SUCCESS (0.034s) [477.122953] Subtest legacy-engines-cleanup: SUCCESS (0.327s) [477.241250] [129/130] (610s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu) [477.347914] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu [482.033995] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.685s) [482.127213] [130/130] (605s left) i915_getparams_basic (basic-subslice-total) [482.189239] Starting subtest: basic-subslice-total [482.193699] Subtest basic-subslice-total: SUCCESS (0.000s) [482.252453] Closing watchdogs Done.