[47.023312] Initializing watchdogs [47.023356] /dev/watchdog0 [47.030120] [001/130] (960s left) kms_cursor_crc (cursor-onscreen-64x21) [49.145581] Starting subtest: cursor-onscreen-64x21 [49.158448] Starting dynamic subtest: pipe-A-HDMI-A-3 [51.674963] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.516s) [51.710071] Starting dynamic subtest: pipe-D-HDMI-A-3 [54.078853] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.373s) [54.079584] Subtest cursor-onscreen-64x21: SUCCESS (4.933s) [54.366057] [002/130] (953s left) syncobj_timeline (wait-any-complex) [54.417905] Starting subtest: wait-any-complex [54.480722] Subtest wait-any-complex: SUCCESS (0.063s) [54.585948] [003/130] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [56.620343] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [56.622036] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [56.700866] [004/130] (950s left) gem_eio (wait-wedge-1us) [57.036321] Starting subtest: wait-wedge-1us [58.320617] Subtest wait-wedge-1us: SUCCESS (1.285s) [60.330884] [005/130] (947s left) kms_lease (lease-unleased-connector) [62.363923] Starting subtest: lease-unleased-connector [62.364919] Starting dynamic subtest: pipe-A-HDMI-A-3 [62.423141] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.058s) [62.429380] Starting dynamic subtest: pipe-B-HDMI-A-3 [62.483805] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.060s) [62.500823] Starting dynamic subtest: pipe-C-HDMI-A-3 [62.551492] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.066s) [62.568413] Starting dynamic subtest: pipe-D-HDMI-A-3 [62.619556] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.066s) [62.620765] Subtest lease-unleased-connector: SUCCESS (0.256s) [62.684646] [006/130] (944s left) i915_pm_freq_mult (media-freq) [62.766020] Starting subtest: media-freq [62.766853] Starting dynamic subtest: gt0 [63.248217] Dynamic subtest gt0: SUCCESS (0.483s) [63.249196] Subtest media-freq: SUCCESS (0.483s) [63.348647] [007/130] (944s left) kms_hdr (static-swap) [65.340061] Starting subtest: static-swap [65.342901] Subtest static-swap: SKIP (0.000s) [65.397288] [008/130] (942s left) prime_vgem (coherency-blt) [65.567738] Starting subtest: coherency-blt [67.175456] Subtest coherency-blt: SUCCESS (1.607s) [67.325495] [009/130] (940s left) kms_busy (extended-modeset-hang-oldfb) [69.374141] Starting subtest: extended-modeset-hang-oldfb [69.375103] Starting dynamic subtest: pipe-A [77.281813] Dynamic subtest pipe-A: SUCCESS (7.907s) [77.291773] Starting dynamic subtest: pipe-D [85.136810] Dynamic subtest pipe-D: SUCCESS (7.851s) [85.137707] Subtest extended-modeset-hang-oldfb: SUCCESS (15.763s) [85.268875] [010/130] (922s left) gem_ctx_exec (basic-invalid-context) [85.329022] Starting subtest: basic-invalid-context [85.331752] Subtest basic-invalid-context: SUCCESS (0.003s) [85.439230] [011/130] (922s left) kms_vblank (wait-forked-hang) [87.442217] Starting subtest: wait-forked-hang [87.444475] Starting dynamic subtest: pipe-A-HDMI-A-3 [100.912539] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (13.469s) [100.920893] Starting dynamic subtest: pipe-D-HDMI-A-3 [125.908135] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.992s) [125.909250] Subtest wait-forked-hang: SUCCESS (38.465s) [126.052758] [012/130] (881s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [128.073489] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [128.129088] [013/130] (879s left) i915_hangman (engine-engine-hang) [128.266871] Starting subtest: engine-engine-hang [128.267658] Starting dynamic subtest: rcs0 [129.020825] Dynamic subtest rcs0: SUCCESS (0.754s) [129.036465] Starting dynamic subtest: bcs0 [129.751890] Dynamic subtest bcs0: SUCCESS (0.731s) [129.765693] Starting dynamic subtest: vcs0 [130.472275] Dynamic subtest vcs0: SUCCESS (0.721s) [130.479251] Starting dynamic subtest: vcs1 [131.188660] Dynamic subtest vcs1: SUCCESS (0.716s) [131.196696] Starting dynamic subtest: vecs0 [131.896363] Dynamic subtest vecs0: SUCCESS (0.708s) [131.902584] Starting dynamic subtest: vecs1 [132.622873] Dynamic subtest vecs1: SUCCESS (0.726s) [132.637049] Starting dynamic subtest: ccs0 [133.385720] Dynamic subtest ccs0: SUCCESS (0.763s) [133.386809] Subtest engine-engine-hang: SUCCESS (5.119s) [133.498593] [014/130] (874s left) kms_addfb_basic (master-rmfb) [133.548989] Starting subtest: master-rmfb [133.549953] Subtest master-rmfb: SUCCESS (0.001s) [135.562463] [015/130] (872s left) gem_pxp (fail-invalid-protected-context) [138.186979] Subtest fail-invalid-protected-context: SKIP (0.000s) [138.252957] [016/130] (869s left) gem_partial_pwrite_pread (write-display) [138.315080] Subtest write-display: SKIP (0.000s) [138.363152] [017/130] (869s left) gem_ctx_shared (exec-single-timeline) [138.456140] Starting subtest: exec-single-timeline [138.457089] Starting dynamic subtest: rcs0 [139.497607] Dynamic subtest rcs0: SUCCESS (1.040s) [139.505501] Starting dynamic subtest: bcs0 [140.521107] Dynamic subtest bcs0: SUCCESS (1.023s) [140.529352] Starting dynamic subtest: vcs0 [141.545237] Dynamic subtest vcs0: SUCCESS (1.023s) [141.553381] Starting dynamic subtest: vcs1 [142.569128] Dynamic subtest vcs1: SUCCESS (1.023s) [142.577409] Starting dynamic subtest: vecs0 [143.593041] Dynamic subtest vecs0: SUCCESS (1.023s) [143.601376] Starting dynamic subtest: vecs1 [144.617248] Dynamic subtest vecs1: SUCCESS (1.023s) [144.625650] Starting dynamic subtest: ccs0 [145.641229] Dynamic subtest ccs0: SUCCESS (1.023s) [145.643271] Subtest exec-single-timeline: SUCCESS (7.184s) [145.861286] [018/130] (862s left) core_auth (basic-auth) [145.922053] Starting subtest: basic-auth [145.923014] Subtest basic-auth: SUCCESS (0.001s) [146.007332] [019/130] (861s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [148.001031] Starting subtest: plane-downscale-factor-0-5-with-modifiers [148.001934] Starting dynamic subtest: pipe-A [148.582493] Dynamic subtest pipe-A: SUCCESS (0.581s) [148.602982] Starting dynamic subtest: pipe-B [149.156211] Dynamic subtest pipe-B: SUCCESS (0.573s) [149.172261] Starting dynamic subtest: pipe-C [149.731800] Dynamic subtest pipe-C: SUCCESS (0.575s) [149.746834] Starting dynamic subtest: pipe-D [150.306470] Dynamic subtest pipe-D: SUCCESS (0.574s) [150.307864] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.305s) [150.460673] [020/130] (857s left) gem_eio (in-flight-immediate) [150.720955] Starting subtest: in-flight-immediate [155.566904] Subtest in-flight-immediate: SUCCESS (4.847s) [157.578194] [021/130] (850s left) gem_exec_reloc (basic-softpin) [157.686184] Subtest basic-softpin: SKIP (0.000s) [157.750218] [022/130] (850s left) api_intel_bb (blit-reloc-purge-cache) [157.833824] Starting subtest: blit-reloc-purge-cache [157.835696] Subtest blit-reloc-purge-cache: SKIP (0.000s) [157.958398] [023/130] (850s left) gem_exec_schedule (noreorder-corked) [158.175867] Starting subtest: noreorder-corked [158.177078] Starting dynamic subtest: rcs0 [159.356509] Dynamic subtest rcs0: SUCCESS (1.181s) [159.364731] Starting dynamic subtest: bcs0 [160.491167] Dynamic subtest bcs0: SUCCESS (1.134s) [160.500443] Starting dynamic subtest: vcs0 [161.633501] Dynamic subtest vcs0: SUCCESS (1.143s) [161.641146] Starting dynamic subtest: vcs1 [162.764294] Dynamic subtest vcs1: SUCCESS (1.131s) [162.771670] Starting dynamic subtest: vecs0 [163.881199] Dynamic subtest vecs0: SUCCESS (1.117s) [163.887412] Starting dynamic subtest: vecs1 [165.007269] Dynamic subtest vecs1: SUCCESS (1.126s) [165.014107] Starting dynamic subtest: ccs0 [166.133139] Dynamic subtest ccs0: SUCCESS (1.126s) [166.133979] Subtest noreorder-corked: SUCCESS (7.958s) [166.346498] [024/130] (841s left) gem_exec_balancer (full-late-pulse) [166.412944] Starting subtest: full-late-pulse [167.819158] Subtest full-late-pulse: SUCCESS (1.406s) [168.129020] [025/130] (839s left) gem_exec_reloc (basic-cpu-read-noreloc) [168.182456] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [168.229859] [026/130] (839s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [170.262264] Starting subtest: fbc-modesetfrombusy [171.458992] Subtest fbc-modesetfrombusy: SUCCESS (1.198s) [171.592696] [027/130] (836s left) gem_ctx_bad_destroy (invalid-pad) [171.643238] Starting subtest: invalid-pad [171.644201] Subtest invalid-pad: SUCCESS (0.000s) [171.741562] [028/130] (836s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [173.790866] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [173.801471] [029/130] (834s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [175.801440] Starting subtest: yf-tiled-64bpp-rotate-90 [175.803375] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [175.876257] [030/130] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [177.944881] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [177.946511] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [178.028851] [031/130] (830s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [180.100089] Starting subtest: primary-x-tiled-reflect-x-0 [190.273964] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.173s) [190.476905] [032/130] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [192.479370] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [192.480907] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [192.559720] [033/130] (815s left) kms_flip (basic-flip-vs-modeset) [194.663580] Starting subtest: basic-flip-vs-modeset [194.669459] Starting dynamic subtest: A-HDMI-A3 [195.386822] Dynamic subtest A-HDMI-A3: SUCCESS (0.716s) [195.395909] Starting dynamic subtest: B-HDMI-A3 [196.066290] Dynamic subtest B-HDMI-A3: SUCCESS (0.679s) [196.073114] Starting dynamic subtest: C-HDMI-A3 [196.732264] Dynamic subtest C-HDMI-A3: SUCCESS (0.666s) [196.739113] Starting dynamic subtest: D-HDMI-A3 [197.403299] Dynamic subtest D-HDMI-A3: SUCCESS (0.670s) [197.404197] Subtest basic-flip-vs-modeset: SUCCESS (2.740s) [197.542059] [034/130] (810s left) kms_content_protection (mei-interface) [199.584721] Starting subtest: mei-interface [199.922908] Subtest mei-interface: SKIP (0.335s) [200.141156] [035/130] (808s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render) [202.150429] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render [202.152210] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s) [202.226637] [036/130] (805s left) kms_psr (pr-cursor-plane-move) [204.290207] Subtest pr-cursor-plane-move: SKIP (0.000s) [204.318221] [037/130] (803s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [206.327247] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [206.328863] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [206.391148] [038/130] (801s left) syncobj_wait (invalid-wait-zero-handles) [206.483928] Starting subtest: invalid-wait-zero-handles [206.523135] Subtest invalid-wait-zero-handles: FAIL (0.021s) [206.583674] [039/130] (801s left) kms_plane (plane-position-hole) [208.624252] Starting subtest: plane-position-hole [208.986369] Starting dynamic subtest: pipe-A-plane-1 [209.380409] Dynamic subtest pipe-A-plane-1: SUCCESS (0.396s) [209.387354] Starting dynamic subtest: pipe-A-plane-2 [209.734046] Dynamic subtest pipe-A-plane-2: SUCCESS (0.353s) [209.741962] Starting dynamic subtest: pipe-A-plane-3 [210.088890] Dynamic subtest pipe-A-plane-3: SUCCESS (0.355s) [210.097940] Starting dynamic subtest: pipe-A-plane-4 [210.448168] Dynamic subtest pipe-A-plane-4: SUCCESS (0.359s) [210.456952] Starting dynamic subtest: pipe-A-plane-5 [210.464344] Dynamic subtest pipe-A-plane-5: SUCCESS (0.016s) [210.723830] Starting dynamic subtest: pipe-B-plane-1 [211.071471] Dynamic subtest pipe-B-plane-1: SUCCESS (0.356s) [211.078497] Starting dynamic subtest: pipe-B-plane-2 [211.412347] Dynamic subtest pipe-B-plane-2: SUCCESS (0.340s) [211.420535] Starting dynamic subtest: pipe-B-plane-3 [211.753488] Dynamic subtest pipe-B-plane-3: SUCCESS (0.342s) [211.761622] Starting dynamic subtest: pipe-B-plane-4 [212.094570] Dynamic subtest pipe-B-plane-4: SUCCESS (0.341s) [212.102973] Starting dynamic subtest: pipe-B-plane-5 [212.110912] Dynamic subtest pipe-B-plane-5: SUCCESS (0.016s) [212.112326] Subtest plane-position-hole: SUCCESS (3.488s) [212.261874] [040/130] (796s left) syncobj_wait (invalid-single-wait-unsubmitted) [212.337134] Starting subtest: invalid-single-wait-unsubmitted [212.337963] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [212.418237] [041/130] (795s left) gem_exec_create (madvise) [212.521785] Starting subtest: madvise [212.522775] Starting dynamic subtest: smem [232.663797] Dynamic subtest smem: SUCCESS (20.141s) [232.671152] Starting dynamic subtest: lmem0 [252.954481] Dynamic subtest lmem0: SUCCESS (20.290s) [252.955331] Subtest madvise: SUCCESS (40.433s) [253.823212] [042/130] (754s left) drm_fdinfo (busy-check-all) [253.901518] Starting subtest: busy-check-all [253.902443] Starting dynamic subtest: rcs0 [253.921708] Dynamic subtest rcs0: SKIP (0.019s) [253.929028] Starting dynamic subtest: bcs0 [253.930473] Dynamic subtest bcs0: SKIP (0.000s) [253.937257] Starting dynamic subtest: vcs0 [253.939203] Dynamic subtest vcs0: SKIP (0.000s) [253.946208] Starting dynamic subtest: vcs1 [253.948215] Dynamic subtest vcs1: SKIP (0.000s) [253.955165] Starting dynamic subtest: vecs0 [253.957132] Dynamic subtest vecs0: SKIP (0.000s) [253.964221] Starting dynamic subtest: vecs1 [253.966580] Dynamic subtest vecs1: SKIP (0.000s) [253.973821] Starting dynamic subtest: ccs0 [253.976077] Dynamic subtest ccs0: SKIP (0.000s) [253.978241] Subtest busy-check-all: SKIP (0.023s) [253.990270] [043/130] (754s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [254.085435] Starting subtest: invalid-bsd2-flag-on-vebox [254.086557] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [254.181389] [044/130] (754s left) gem_basic (create-fd-close) [254.244259] Starting subtest: create-fd-close [254.246243] Subtest create-fd-close: SUCCESS (0.000s) [254.360178] [045/130] (754s left) perf_pmu (busy-check-all) [254.413228] Starting subtest: busy-check-all [254.414156] Starting dynamic subtest: rcs0 [254.989178] Dynamic subtest rcs0: SUCCESS (0.576s) [254.997291] Starting dynamic subtest: bcs0 [255.537540] Dynamic subtest bcs0: SUCCESS (0.547s) [255.547733] Starting dynamic subtest: vcs0 [256.088609] Dynamic subtest vcs0: SUCCESS (0.550s) [256.098694] Starting dynamic subtest: vcs1 [256.639612] Dynamic subtest vcs1: SUCCESS (0.549s) [256.649711] Starting dynamic subtest: vecs0 [257.192185] Dynamic subtest vecs0: SUCCESS (0.551s) [257.201824] Starting dynamic subtest: vecs1 [257.743775] Dynamic subtest vecs1: SUCCESS (0.550s) [257.753778] Starting dynamic subtest: ccs0 [258.297721] Dynamic subtest ccs0: SUCCESS (0.553s) [258.298738] Subtest busy-check-all: SUCCESS (3.885s) [258.395630] [046/130] (750s left) dumb_buffer (create-clear) [258.449932] Starting subtest: create-clear [293.746698] Subtest create-clear: SUCCESS (35.296s) [293.924227] [047/130] (714s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [295.921527] Starting subtest: psr-2p-scndscrn-spr-indfb-move [295.923262] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [295.996890] [048/130] (712s left) gem_mmap_gtt (fault-concurrent) [296.123342] Subtest fault-concurrent: SKIP (0.000s) [296.161495] [049/130] (712s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [298.179391] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [298.180302] Starting dynamic subtest: pipe-A-valid-mode [299.461664] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.275s) [299.462552] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.276s) [299.630491] [050/130] (708s left) kms_flip (wf_vblank-ts-check-interruptible) [301.639908] Starting subtest: wf_vblank-ts-check-interruptible [301.646928] Starting dynamic subtest: A-HDMI-A3 [309.693928] Dynamic subtest A-HDMI-A3: SUCCESS (8.047s) [309.703203] Starting dynamic subtest: B-HDMI-A3 [317.624953] Dynamic subtest B-HDMI-A3: SUCCESS (7.930s) [317.632990] Starting dynamic subtest: C-HDMI-A3 [325.554894] Dynamic subtest C-HDMI-A3: SUCCESS (7.929s) [325.562470] Starting dynamic subtest: D-HDMI-A3 [333.487574] Dynamic subtest D-HDMI-A3: SUCCESS (7.931s) [333.489613] Subtest wf_vblank-ts-check-interruptible: SUCCESS (31.847s) [333.643050] [051/130] (674s left) gem_create (create-invalid-size) [333.708095] Starting subtest: create-invalid-size [333.708975] Subtest create-invalid-size: SUCCESS (0.000s) [333.896157] [052/130] (674s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [333.949216] Starting subtest: etime-single-wait-available-unsubmitted [334.055784] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s) [334.152335] [053/130] (674s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [336.148977] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s) [336.169865] [054/130] (672s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [338.156496] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [338.158385] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [338.227020] [055/130] (670s left) gem_exec_whisper (basic-contexts-priority) [338.353584] Starting subtest: basic-contexts-priority [360.782802] Subtest basic-contexts-priority: SUCCESS (22.428s) [360.975638] [056/130] (647s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [362.986419] Starting subtest: crc-primary-basic-yf-tiled-ccs [362.987367] Starting dynamic subtest: pipe-A-HDMI-A-3 [362.995993] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [363.003418] Starting dynamic subtest: pipe-B-HDMI-A-3 [363.012033] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [363.019333] Starting dynamic subtest: pipe-C-HDMI-A-3 [363.027726] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [363.034848] Starting dynamic subtest: pipe-D-HDMI-A-3 [363.045634] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [363.047264] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s) [363.202256] [057/130] (645s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [363.309511] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [363.311609] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [363.509380] [058/130] (645s left) gem_exec_fair (basic-none-solo) [363.605914] Subtest basic-none-solo: SKIP (0.000s) [363.636590] [059/130] (645s left) gem_mmap_gtt (fault-concurrent-x) [363.702228] Subtest fault-concurrent-X: SKIP (0.000s) [363.739211] [060/130] (645s left) gem_exec_reloc (basic-concurrent0) [363.824280] Subtest basic-concurrent0: SKIP (0.000s) [363.877245] [061/130] (644s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [365.887325] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [365.888971] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [365.959095] [062/130] (642s left) kms_cursor_legacy (flip-vs-cursor-legacy) [368.028554] Starting subtest: flip-vs-cursor-legacy [376.632053] Subtest flip-vs-cursor-legacy: SUCCESS (8.603s) [376.764572] [063/130] (632s left) kms_big_fb (x-tiled-16bpp-rotate-270) [378.768090] Starting subtest: x-tiled-16bpp-rotate-270 [378.814141] Subtest x-tiled-16bpp-rotate-270: SKIP (0.045s) [378.959579] [064/130] (629s left) kms_universal_plane (cursor-fb-leak) [381.009534] Starting subtest: cursor-fb-leak [381.010478] Starting dynamic subtest: pipe-A-HDMI-A-3 [381.448367] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.438s) [381.478617] Starting dynamic subtest: pipe-B-HDMI-A-3 [381.906217] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.452s) [381.921972] Starting dynamic subtest: pipe-C-HDMI-A-3 [382.346513] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.434s) [382.375285] Starting dynamic subtest: pipe-D-HDMI-A-3 [382.801078] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.448s) [382.802849] Subtest cursor-fb-leak: SUCCESS (1.793s) [382.989542] [065/130] (625s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [385.005725] Starting subtest: fbcpsr-rgb565-draw-render [385.007431] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s) [385.073775] [066/130] (623s left) kms_psr (pr-basic) [387.138922] Subtest pr-basic: SKIP (0.000s) [387.166092] [067/130] (621s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [389.139721] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [389.140709] Starting dynamic subtest: pipe-A-HDMI-A-3 [389.150195] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [389.157372] Starting dynamic subtest: pipe-B-HDMI-A-3 [389.166782] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [389.173901] Starting dynamic subtest: pipe-C-HDMI-A-3 [389.183548] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [389.190259] Starting dynamic subtest: pipe-D-HDMI-A-3 [389.200115] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [389.201800] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s) [389.320485] [068/130] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [391.348337] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [391.350104] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [391.441032] [069/130] (617s left) gen9_exec_parse (bb-secure) [391.596429] Subtest bb-secure: SKIP (0.000s) [391.688102] [070/130] (617s left) kms_pm_rpm (dpms-non-lpsp) [396.470537] Starting subtest: dpms-non-lpsp [396.587520] Subtest dpms-non-lpsp: SUCCESS (0.116s) [397.613471] [071/130] (611s left) i915_query (query-topology-garbage-items) [397.668214] Starting subtest: query-topology-garbage-items [397.669182] Subtest query-topology-garbage-items: SUCCESS (0.000s) [397.744801] [072/130] (611s left) perf_pmu (busy-no-semaphores) [397.842999] Starting subtest: busy-no-semaphores [397.843998] Starting dynamic subtest: rcs0 [398.405326] Dynamic subtest rcs0: SUCCESS (0.561s) [398.417196] Starting dynamic subtest: bcs0 [398.952940] Dynamic subtest bcs0: SUCCESS (0.546s) [398.964051] Starting dynamic subtest: vcs0 [399.501712] Dynamic subtest vcs0: SUCCESS (0.546s) [399.513014] Starting dynamic subtest: vcs1 [400.049922] Dynamic subtest vcs1: SUCCESS (0.546s) [400.061012] Starting dynamic subtest: vecs0 [400.599533] Dynamic subtest vecs0: SUCCESS (0.547s) [400.608571] Starting dynamic subtest: vecs1 [401.149756] Dynamic subtest vecs1: SUCCESS (0.548s) [401.161580] Starting dynamic subtest: ccs0 [401.699531] Dynamic subtest ccs0: SUCCESS (0.548s) [401.701381] Subtest busy-no-semaphores: SUCCESS (3.857s) [401.800704] [073/130] (607s left) gem_exec_balancer (bonded-dual) [401.860908] Starting subtest: bonded-dual [401.862552] Subtest bonded-dual: SKIP (0.000s) [402.136126] [074/130] (606s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [404.150469] Starting subtest: basic-flip-after-cursor-legacy [405.121886] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.972s) [405.281872] [075/130] (603s left) kms_dsc (dsc-with-output-formats) [407.290922] Starting subtest: dsc-with-output-formats [407.292819] Subtest dsc-with-output-formats: SKIP (0.000s) [407.346834] [076/130] (601s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [409.362776] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt [409.364418] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [409.432719] [077/130] (599s left) tools_test (sysfs_l3_parity) [409.538567] Starting subtest: sysfs_l3_parity [409.651456] Subtest sysfs_l3_parity: SKIP (0.121s) [409.706722] [078/130] (599s left) kms_addfb_basic (bad-pitch-999) [409.782236] Starting subtest: bad-pitch-999 [409.783139] Subtest bad-pitch-999: SUCCESS (0.000s) [411.818045] [079/130] (597s left) kms_big_fb (4-tiled-16bpp-rotate-270) [413.924450] Starting subtest: 4-tiled-16bpp-rotate-270 [413.982430] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.058s) [414.110177] [080/130] (595s left) gem_blits (basic) [414.239289] Starting subtest: basic [418.755227] Subtest basic: SUCCESS (4.516s) [418.888108] [081/130] (590s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [420.913562] Starting subtest: short-flip-after-cursor-atomic-transitions [421.887076] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.973s) [422.055608] [082/130] (587s left) kms_concurrent (multi-plane-atomic-lowres) [424.056241] Starting subtest: multi-plane-atomic-lowres [424.057179] Starting dynamic subtest: pipe-A-HDMI-A-3 [424.440311] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.383s) [424.441308] Subtest multi-plane-atomic-lowres: SUCCESS (0.384s) [424.608574] [083/130] (584s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [426.627044] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [426.642889] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.015s) [426.702785] [084/130] (582s left) kms_psr (psr2-sprite-mmap-gtt) [428.717381] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s) [428.746515] [085/130] (580s left) kms_psr (fbc-pr-primary-mmap-gtt) [430.740745] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [430.763516] [086/130] (578s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [432.794461] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [432.852810] [087/130] (576s left) gem_exec_whisper (basic-queues-priority-all) [432.921030] Starting subtest: basic-queues-priority-all [454.827872] Subtest basic-queues-priority-all: SUCCESS (21.905s) [455.024914] [088/130] (554s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [457.052399] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [457.053373] Starting dynamic subtest: pipe-A-HDMI-A-3 [460.530310] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.458s) [460.542382] Starting dynamic subtest: pipe-B-HDMI-A-3 [461.004936] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.468s) [461.019825] Starting dynamic subtest: pipe-C-HDMI-A-3 [461.495199] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.485s) [461.516801] Starting dynamic subtest: pipe-D-HDMI-A-3 [462.005341] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.502s) [462.007192] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (4.933s) [462.153688] [089/130] (547s left) gem_exec_reloc (basic-wc-gtt) [462.226992] Subtest basic-wc-gtt: SKIP (0.000s) [462.263315] [090/130] (547s left) gem_userptr_blits (probe) [462.342116] Starting subtest: probe [462.419933] Subtest probe: SUCCESS (0.078s) [462.513435] [091/130] (546s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [464.516029] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [465.721332] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.205s) [465.863841] [092/130] (543s left) syncobj_timeline (wait-any-snapshot) [465.915280] Starting subtest: wait-any-snapshot [465.997220] Subtest wait-any-snapshot: SUCCESS (0.082s) [466.092872] [093/130] (543s left) kms_big_fb (yf-tiled-addfb-size-overflow) [468.093903] Starting subtest: yf-tiled-addfb-size-overflow [468.095534] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [468.172821] [094/130] (541s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [470.236554] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [471.221216] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.984s) [471.393794] [095/130] (538s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [471.450970] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [471.452070] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [471.574487] [096/130] (538s left) kms_getfb (getfb-addfb-different-handles) [471.647914] Starting subtest: getfb-addfb-different-handles [471.649732] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [471.775948] [097/130] (537s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [473.792790] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [473.794523] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [473.874412] [098/130] (535s left) kms_cursor_crc (cursor-sliding-512x170) [476.158465] Starting subtest: cursor-sliding-512x170 [476.160370] Subtest cursor-sliding-512x170: SKIP (0.001s) [476.320771] [099/130] (533s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [478.348663] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [478.350407] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [478.443758] [100/130] (531s left) gem_softpin (evict-prime) [478.604069] Starting subtest: evict-prime [478.605071] Starting dynamic subtest: rcs0 [479.763489] Dynamic subtest rcs0: SUCCESS (1.159s) [479.771061] Starting dynamic subtest: bcs0 [480.978274] Dynamic subtest bcs0: SUCCESS (1.214s) [480.986405] Starting dynamic subtest: vcs0 [482.147774] Dynamic subtest vcs0: SUCCESS (1.169s) [482.155898] Starting dynamic subtest: vcs1 [483.339099] Dynamic subtest vcs1: SUCCESS (1.190s) [483.347026] Starting dynamic subtest: vecs0 [484.548782] Dynamic subtest vecs0: SUCCESS (1.208s) [484.556242] Starting dynamic subtest: vecs1 [485.753514] Dynamic subtest vecs1: SUCCESS (1.206s) [485.761283] Starting dynamic subtest: ccs0 [486.863282] Dynamic subtest ccs0: SUCCESS (1.109s) [486.871669] Starting dynamic subtest: all [488.048275] Dynamic subtest all: SUCCESS (1.185s) [488.049071] Subtest evict-prime: SUCCESS (9.445s) [488.164034] [101/130] (521s left) kms_rotation_crc (multiplane-rotation) [490.200518] Starting subtest: multiplane-rotation [502.174446] Subtest multiplane-rotation: SUCCESS (11.974s) [502.347608] [102/130] (507s left) gem_tiled_partial_pwrite_pread (reads) [502.422115] Subtest reads: SKIP (0.000s) [502.464836] [103/130] (507s left) gem_ctx_persistence (engines-persistence) [502.529172] Starting subtest: engines-persistence [502.529973] Starting dynamic subtest: rcs0 [503.308408] Dynamic subtest rcs0: SUCCESS (0.779s) [503.317444] Starting dynamic subtest: bcs0 [504.050284] Dynamic subtest bcs0: SUCCESS (0.740s) [504.063314] Starting dynamic subtest: vcs0 [504.824305] Dynamic subtest vcs0: SUCCESS (0.771s) [504.836893] Starting dynamic subtest: vcs1 [505.585415] Dynamic subtest vcs1: SUCCESS (0.758s) [505.600545] Starting dynamic subtest: vecs0 [506.354285] Dynamic subtest vecs0: SUCCESS (0.766s) [506.369633] Starting dynamic subtest: vecs1 [507.128239] Dynamic subtest vecs1: SUCCESS (0.771s) [507.143269] Starting dynamic subtest: ccs0 [507.894213] Dynamic subtest ccs0: SUCCESS (0.763s) [507.896238] Subtest engines-persistence: SUCCESS (5.365s) [508.006876] [104/130] (501s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [510.006725] Starting subtest: plane-upscale-20x20-with-rotation [510.007573] Starting dynamic subtest: pipe-A [510.388486] Dynamic subtest pipe-A: SUCCESS (0.382s) [510.406857] Starting dynamic subtest: pipe-B [510.795813] Dynamic subtest pipe-B: SUCCESS (0.406s) [510.817359] Starting dynamic subtest: pipe-C [511.203923] Dynamic subtest pipe-C: SUCCESS (0.407s) [511.223423] Starting dynamic subtest: pipe-D [511.610937] Dynamic subtest pipe-D: SUCCESS (0.406s) [511.612351] Subtest plane-upscale-20x20-with-rotation: SUCCESS (1.605s) [511.773526] [105/130] (498s left) gem_userptr_blits (readonly-unsync) [511.834498] Subtest readonly-unsync: SKIP (0.000s) [511.951798] [106/130] (497s left) core_auth (getclient-simple) [511.989680] Starting subtest: getclient-simple [511.998212] Subtest getclient-simple: SUCCESS (0.008s) [512.123333] [107/130] (497s left) gem_exec_schedule (smoketest) [512.308038] Starting subtest: smoketest [512.309178] Starting dynamic subtest: rcs0 [517.755053] Dynamic subtest rcs0: SUCCESS (5.441s) [517.762799] Starting dynamic subtest: bcs0 [523.195689] Dynamic subtest bcs0: SUCCESS (5.440s) [523.203322] Starting dynamic subtest: vcs0 [528.631875] Dynamic subtest vcs0: SUCCESS (5.435s) [528.639866] Starting dynamic subtest: vcs1 [534.061228] Dynamic subtest vcs1: SUCCESS (5.429s) [534.069411] Starting dynamic subtest: vecs0 [539.499051] Dynamic subtest vecs0: SUCCESS (5.437s) [539.506701] Starting dynamic subtest: vecs1 [544.937707] Dynamic subtest vecs1: SUCCESS (5.438s) [544.945587] Starting dynamic subtest: ccs0 [550.368721] Dynamic subtest ccs0: SUCCESS (5.431s) [550.369518] Subtest smoketest: SUCCESS (38.057s) [550.623031] [108/130] (459s left) gem_exec_await (wide-contexts) [550.843648] Starting subtest: wide-contexts [572.998127] Subtest wide-contexts: SUCCESS (22.154s) [573.227207] [109/130] (436s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [575.279816] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [575.280799] Starting dynamic subtest: pipe-A-HDMI-A-3 [575.289319] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [575.297249] Starting dynamic subtest: pipe-B-HDMI-A-3 [575.305257] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [575.313144] Starting dynamic subtest: pipe-C-HDMI-A-3 [575.321540] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [575.329207] Starting dynamic subtest: pipe-D-HDMI-A-3 [575.339980] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [575.341775] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s) [575.493367] [110/130] (434s left) kms_chamelium_frames (dp-crc-fast) [577.575569] Subtest dp-crc-fast: SKIP (0.000s) [577.632327] [111/130] (432s left) kms_pm_rpm (modeset-lpsp) [582.420268] Starting subtest: modeset-lpsp [583.593465] Subtest modeset-lpsp: SKIP (1.171s) [584.750673] [112/130] (425s left) syncobj_eventfd (invalid-bad-pad) [584.801743] Starting subtest: invalid-bad-pad [584.802668] Subtest invalid-bad-pad: SUCCESS (0.000s) [584.873300] [113/130] (425s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [586.912439] Starting subtest: basic-max-pipe-crc-check [586.914511] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [586.929824] [114/130] (423s left) gem_userptr_blits (create-destroy-sync) [586.998446] Starting subtest: create-destroy-sync [592.009241] Subtest create-destroy-sync: SUCCESS (5.010s) [592.131913] [115/130] (418s left) sw_sync (timeline_closed_signaled) [592.180144] Starting subtest: timeline_closed_signaled [592.181242] Subtest timeline_closed_signaled: SUCCESS (0.000s) [592.217518] [116/130] (417s left) gem_mmap_wc (write-wc-read-gtt) [592.270243] Subtest write-wc-read-gtt: SKIP (0.000s) [592.296640] [117/130] (417s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [594.295775] Starting subtest: basic-busy-flip-before-cursor-varying-size [594.297642] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [594.353894] [118/130] (415s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [596.384450] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [596.385304] Starting dynamic subtest: pipe-A-valid-mode [599.585215] Dynamic subtest pipe-A-valid-mode: SUCCESS (3.200s) [599.586260] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SUCCESS (3.201s) [599.709397] [119/130] (410s left) gem_exec_fence (syncobj-signal) [600.149843] Starting subtest: syncobj-signal [600.172688] Subtest syncobj-signal: SUCCESS (0.023s) [600.549533] [120/130] (409s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [600.614494] Starting subtest: invalid-multi-wait-unsubmitted [600.615423] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [600.709496] [121/130] (409s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [602.734586] Starting subtest: fbcpsr-tiling-4 [602.736142] Subtest fbcpsr-tiling-4: SKIP (0.000s) [602.829038] [122/130] (407s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [604.921521] Starting subtest: cursorB-vs-flipA-legacy [604.923371] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s) [604.991058] [123/130] (405s left) kms_addfb_basic (bad-pitch-65536) [605.106232] Starting subtest: bad-pitch-65536 [605.107625] Subtest bad-pitch-65536: SUCCESS (0.001s) [607.185214] [124/130] (403s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [609.261590] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [609.277531] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.015s) [609.339148] [125/130] (401s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [609.422305] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [609.528703] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s) [609.624406] [126/130] (400s left) gem_mmap_gtt (basic-read) [609.694907] Subtest basic-read: SKIP (0.000s) [609.734110] [127/130] (400s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [611.733164] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [611.734815] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [611.807048] [128/130] (398s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [613.864271] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [613.866196] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [613.943333] [129/130] (396s left) gem_mmap_gtt (bad-object) [614.070709] Subtest bad-object: SKIP (0.000s) [614.141876] [130/130] (396s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [616.166449] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [616.168011] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [616.239623] Closing watchdogs Done.