[58.697406] Initializing watchdogs [58.697515] /dev/watchdog0 [58.713604] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.718558] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.720724] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.722746] [001/132] (960s left) syncobj_timeline (single-wait-for-submit-available-signaled) [58.786721] Starting subtest: single-wait-for-submit-available-signaled [58.787751] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [58.888203] [002/132] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [58.973142] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [58.975033] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [59.078901] [003/132] (960s left) gem_exec_schedule (submit-late-slice) [59.148159] Starting subtest: submit-late-slice [59.149187] Starting dynamic subtest: rcs0 [59.184080] Dynamic subtest rcs0: SUCCESS (0.036s) [59.191533] Starting dynamic subtest: bcs0 [59.216539] Dynamic subtest bcs0: SUCCESS (0.032s) [59.222645] Starting dynamic subtest: vcs0 [59.244766] Dynamic subtest vcs0: SUCCESS (0.028s) [59.250337] Starting dynamic subtest: vcs1 [59.275057] Dynamic subtest vcs1: SUCCESS (0.030s) [59.281203] Starting dynamic subtest: vecs0 [59.301968] Dynamic subtest vecs0: SUCCESS (0.027s) [59.308279] Starting dynamic subtest: ccs0 [59.332511] Dynamic subtest ccs0: SUCCESS (0.030s) [59.333524] Subtest submit-late-slice: SUCCESS (0.185s) [60.993956] [004/132] (958s left) syncobj_wait (wait-any-interrupted) [61.044518] Starting subtest: wait-any-interrupted [61.146693] Subtest wait-any-interrupted: SUCCESS (0.101s) [61.240912] [005/132] (958s left) gem_exec_params (rsvd2-dirt) [61.288938] Starting subtest: rsvd2-dirt [61.290784] Subtest rsvd2-dirt: SKIP (0.000s) [61.397676] [006/132] (957s left) kms_draw_crc (draw-method-render) [61.485270] Starting subtest: draw-method-render [61.486184] Starting dynamic subtest: xrgb8888-untiled [61.738414] Dynamic subtest xrgb8888-untiled: SUCCESS (0.254s) [61.745127] Starting dynamic subtest: rgb565-untiled [61.971833] Dynamic subtest rgb565-untiled: SUCCESS (0.233s) [61.979766] Starting dynamic subtest: xrgb2101010-untiled [62.193409] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [62.199422] Starting dynamic subtest: xbgr16161616f-untiled [62.393256] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.200s) [62.399599] Starting dynamic subtest: xrgb8888-xtiled [62.515154] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [62.521765] Starting dynamic subtest: rgb565-xtiled [62.626104] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s) [62.633074] Starting dynamic subtest: xrgb2101010-xtiled [62.737058] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s) [62.744042] Starting dynamic subtest: xbgr16161616f-xtiled [62.859045] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s) [62.865100] Starting dynamic subtest: xrgb8888-4tiled [62.981130] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s) [62.988262] Starting dynamic subtest: rgb565-4tiled [63.092383] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s) [63.099503] Starting dynamic subtest: xrgb2101010-4tiled [63.203259] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s) [63.209902] Starting dynamic subtest: xbgr16161616f-4tiled [63.325276] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s) [63.326249] Subtest draw-method-render: SUCCESS (1.843s) [63.458142] [007/132] (955s left) kms_content_protection (content-type-change) [63.596326] Starting subtest: content-type-change [63.598402] Subtest content-type-change: SKIP (0.000s) [63.736108] [008/132] (955s left) api_intel_bb (object-noreloc-purge-cache-simple) [63.793426] Starting subtest: object-noreloc-purge-cache-simple [63.798034] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s) [63.946340] [009/132] (955s left) kms_flip (2x-dpms-vs-vblank-race) [64.033539] Starting subtest: 2x-dpms-vs-vblank-race [64.043749] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [64.135579] [010/132] (955s left) gem_mmap_gtt (hang) [64.181653] Subtest hang: SKIP (0.000s) [64.231434] [011/132] (955s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [64.307165] Starting subtest: fbc-dirtyfb-ioctl [64.308220] Starting dynamic subtest: A-eDP-1 [66.870923] Dynamic subtest A-eDP-1: SUCCESS (2.566s) [66.871906] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.567s) [67.773264] [012/132] (951s left) kms_cursor_crc (cursor-onscreen-256x256) [67.986151] Starting subtest: cursor-onscreen-256x256 [67.989756] Starting dynamic subtest: pipe-A-eDP-1 [70.107835] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s) [70.134820] Starting dynamic subtest: pipe-D-eDP-1 [72.959660] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.832s) [72.960539] Subtest cursor-onscreen-256x256: SUCCESS (4.977s) [73.821800] [013/132] (945s left) kms_flip (2x-flip-vs-modeset) [73.908745] Starting subtest: 2x-flip-vs-modeset [73.919570] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [73.998899] [014/132] (945s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [74.092165] Starting subtest: fbc-farfromfence-mmap-gtt [74.093867] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [74.190716] [015/132] (945s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [74.578302] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [75.342945] [016/132] (944s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [75.440582] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [76.209603] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.770s) [76.380487] [017/132] (943s left) gem_cs_tlb (engines) [76.423055] Starting subtest: engines [76.423993] Starting dynamic subtest: rcs0 [78.576492] Dynamic subtest rcs0: SUCCESS (2.152s) [78.583234] Starting dynamic subtest: bcs0 [80.726439] Dynamic subtest bcs0: SUCCESS (2.151s) [80.733176] Starting dynamic subtest: vcs0 [82.877926] Dynamic subtest vcs0: SUCCESS (2.152s) [82.883889] Starting dynamic subtest: vcs1 [85.029506] Dynamic subtest vcs1: SUCCESS (2.151s) [85.036991] Starting dynamic subtest: vecs0 [87.180223] Dynamic subtest vecs0: SUCCESS (2.152s) [87.186875] Starting dynamic subtest: ccs0 [89.332211] Dynamic subtest ccs0: SUCCESS (2.154s) [89.333234] Subtest engines: SUCCESS (12.914s) [89.463992] [018/132] (930s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [89.558925] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [89.559796] Starting dynamic subtest: pipe-A-default-mode [89.848138] Dynamic subtest pipe-A-default-mode: SKIP (0.288s) [89.849901] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.289s) [90.704951] [019/132] (929s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [90.805634] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [90.807597] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [90.929044] [020/132] (928s left) kms_psr2_su (page_flip-xrgb8888) [90.987220] Subtest page_flip-XRGB8888: SKIP (0.000s) [91.047660] [021/132] (928s left) syncobj_wait (wait-delayed-signal) [91.112527] Starting subtest: wait-delayed-signal [91.216953] Subtest wait-delayed-signal: SUCCESS (0.102s) [91.307450] [022/132] (928s left) gem_ctx_shared (q-out-order) [91.372167] Starting subtest: Q-out-order [91.373116] Starting dynamic subtest: rcs0 [91.525229] Dynamic subtest rcs0: SUCCESS (0.153s) [91.539434] Starting dynamic subtest: vcs0 [91.607053] Dynamic subtest vcs0: SUCCESS (0.082s) [91.622065] Starting dynamic subtest: vcs1 [91.682169] Dynamic subtest vcs1: SUCCESS (0.075s) [91.696186] Starting dynamic subtest: vecs0 [91.752785] Dynamic subtest vecs0: SUCCESS (0.070s) [91.766726] Starting dynamic subtest: ccs0 [91.830460] Dynamic subtest ccs0: SUCCESS (0.078s) [91.831571] Subtest Q-out-order: SUCCESS (0.459s) [93.007626] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true [93.009282] [023/132] (926s left) kms_cursor_crc (cursor-random-32x10) [93.163610] Starting subtest: cursor-random-32x10 [93.202437] Subtest cursor-random-32x10: SKIP (0.036s) [93.483389] [024/132] (926s left) sysfs_timeslice_duration (invalid) [93.535128] Starting subtest: invalid [93.536119] Starting dynamic subtest: vecs0 [93.537011] Dynamic subtest vecs0: SUCCESS (0.000s) [93.543368] Starting dynamic subtest: ccs0 [93.544165] Dynamic subtest ccs0: SUCCESS (0.000s) [93.549983] Starting dynamic subtest: vcs0 [93.550818] Dynamic subtest vcs0: SUCCESS (0.000s) [93.556713] Starting dynamic subtest: bcs0 [93.557558] Dynamic subtest bcs0: SUCCESS (0.000s) [93.563558] Starting dynamic subtest: rcs0 [93.564392] Dynamic subtest rcs0: SUCCESS (0.000s) [93.570063] Starting dynamic subtest: vcs1 [93.570893] Dynamic subtest vcs1: SUCCESS (0.000s) [93.571758] Subtest invalid: SUCCESS (0.003s) [93.658214] [025/132] (926s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [93.757030] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [93.758992] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [93.880502] [026/132] (926s left) gem_eio (reset-stress) [94.109226] Starting subtest: reset-stress [153.450428] Subtest reset-stress: SUCCESS (59.340s) [154.944526] [027/132] (865s left) i915_drm_fdinfo (memory-info-purgeable) [154.975664] Starting subtest: memory-info-purgeable [154.976722] Starting dynamic subtest: smem0 [157.869672] Dynamic subtest smem0: SUCCESS (2.894s) [157.873157] Subtest memory-info-purgeable: SUCCESS (2.894s) [157.948980] [028/132] (862s left) kms_frontbuffer_tracking (fbc-2p-rte) [158.043401] Starting subtest: fbc-2p-rte [158.045226] Subtest fbc-2p-rte: SKIP (0.000s) [158.168923] [029/132] (861s left) gem_exec_schedule (preempt-other) [158.232776] Starting subtest: preempt-other [158.233666] Starting dynamic subtest: rcs0 [158.306357] Dynamic subtest rcs0: SUCCESS (0.073s) [158.315109] Starting dynamic subtest: bcs0 [158.373459] Dynamic subtest bcs0: SUCCESS (0.067s) [158.383632] Starting dynamic subtest: vcs0 [158.438797] Dynamic subtest vcs0: SUCCESS (0.065s) [158.447986] Starting dynamic subtest: vcs1 [158.504491] Dynamic subtest vcs1: SUCCESS (0.065s) [158.513489] Starting dynamic subtest: vecs0 [158.570068] Dynamic subtest vecs0: SUCCESS (0.065s) [158.579721] Starting dynamic subtest: ccs0 [158.634715] Dynamic subtest ccs0: SUCCESS (0.064s) [158.636054] Subtest preempt-other: SUCCESS (0.402s) [160.026910] [030/132] (860s left) gem_exec_params (invalid-fence-in) [160.073242] Starting subtest: invalid-fence-in [160.074481] Subtest invalid-fence-in: SUCCESS (0.000s) [160.196787] [031/132] (859s left) kms_atomic (plane-immutable-zpos) [160.282962] Starting subtest: plane-immutable-zpos [160.283898] Starting dynamic subtest: pipe-A-eDP-1 [160.895176] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s) [160.896156] Subtest plane-immutable-zpos: SUCCESS (0.613s) [161.732343] [032/132] (858s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [161.830120] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [162.895441] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.066s) [163.032370] [033/132] (857s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [163.084733] Starting subtest: invalid-multi-wait-all-unsubmitted [163.085768] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [163.205096] [034/132] (856s left) gem_exec_fence (parallel) [163.377434] Starting subtest: parallel [163.378767] Starting dynamic subtest: rcs0 [165.531222] Dynamic subtest rcs0: SUCCESS (2.154s) [165.539904] Starting dynamic subtest: bcs0 [167.684284] Dynamic subtest bcs0: SUCCESS (2.153s) [167.691602] Starting dynamic subtest: vcs0 [169.840257] Dynamic subtest vcs0: SUCCESS (2.155s) [169.849392] Starting dynamic subtest: vcs1 [171.993112] Dynamic subtest vcs1: SUCCESS (2.152s) [172.001467] Starting dynamic subtest: vecs0 [174.143217] Dynamic subtest vecs0: SUCCESS (2.149s) [174.152542] Starting dynamic subtest: ccs0 [176.292967] Dynamic subtest ccs0: SUCCESS (2.150s) [176.294108] Subtest parallel: SUCCESS (12.916s) [177.033304] [035/132] (843s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [177.403445] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [178.213562] [036/132] (842s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [178.271481] Starting subtest: single-wait-all-for-submit-unsubmitted [178.379588] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s) [178.474517] [037/132] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [178.572335] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [178.574102] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [178.686797] [038/132] (841s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [178.748385] Starting subtest: y-tiled-to-vebox-yf-tiled [178.750367] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [178.945396] [039/132] (841s left) kms_plane_multiple (2x-tiling-4) [179.034862] Starting subtest: 2x-tiling-4 [179.036647] Subtest 2x-tiling-4: SKIP (0.000s) [179.124706] [040/132] (841s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [179.223073] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [179.224689] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [179.351833] [041/132] (841s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [179.439026] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [179.440834] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [179.530162] [042/132] (840s left) kms_big_fb (4-tiled-32bpp-rotate-270) [179.617904] Starting subtest: 4-tiled-32bpp-rotate-270 [179.640412] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.021s) [179.781317] [043/132] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [179.876405] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [179.878709] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [179.977943] [044/132] (840s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [180.066629] Starting subtest: compare-crc-sanitycheck-nv12 [180.067601] Starting dynamic subtest: pipe-A-eDP-1 [180.720398] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.653s) [180.727337] Starting dynamic subtest: pipe-B-eDP-1 [181.995843] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.274s) [182.002542] Starting dynamic subtest: pipe-C-eDP-1 [183.180756] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.184s) [183.187748] Starting dynamic subtest: pipe-D-eDP-1 [184.433323] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s) [184.434338] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.367s) [185.277262] [045/132] (835s left) kms_cdclk (plane-scaling) [185.363519] Starting subtest: plane-scaling [185.364448] Starting dynamic subtest: pipe-A-eDP-1 [185.655462] Dynamic subtest pipe-A-eDP-1: SKIP (0.292s) [185.662425] Starting dynamic subtest: pipe-B-eDP-1 [185.664354] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [185.670761] Starting dynamic subtest: pipe-C-eDP-1 [185.672693] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [185.679488] Starting dynamic subtest: pipe-D-eDP-1 [185.681621] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [185.683449] Subtest plane-scaling: SKIP (0.298s) [186.526678] [046/132] (834s left) gem_exec_fence (syncobj-wait) [186.938370] Starting subtest: syncobj-wait [188.917047] Subtest syncobj-wait: SUCCESS (1.976s) [190.982803] [047/132] (829s left) kms_sharpness_filter (filter-dpms) [191.068983] Starting subtest: filter-dpms [191.074085] Subtest filter-dpms: SKIP (0.001s) [191.158060] [048/132] (829s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [191.203039] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [191.263522] [049/132] (829s left) kms_vrr (flip-basic-fastset) [191.340910] Starting subtest: flip-basic-fastset [191.343520] Subtest flip-basic-fastset: SKIP (0.000s) [191.432840] [050/132] (829s left) api_intel_allocator (simple-allocator) [191.490670] Starting subtest: simple-allocator [191.491878] Starting dynamic subtest: basic [191.495800] Dynamic subtest basic: SUCCESS (0.005s) [191.502694] Starting dynamic subtest: parallel-one [191.684392] Dynamic subtest parallel-one: SUCCESS (0.186s) [191.692570] Starting dynamic subtest: print [191.693625] Dynamic subtest print: SUCCESS (0.000s) [191.700630] Starting dynamic subtest: reuse [191.701679] Dynamic subtest reuse: SUCCESS (0.000s) [191.707966] Starting dynamic subtest: reserve [191.709253] Dynamic subtest reserve: SUCCESS (0.000s) [191.715462] Starting dynamic subtest: fork-reopen-allocator [191.716431] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s) [191.717408] Subtest simple-allocator: SUCCESS (0.207s) [191.822596] [051/132] (828s left) kms_getfb (getfb2-accept-nv12) [191.910362] Starting subtest: getfb2-accept-nv12 [191.911390] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [192.053493] [052/132] (828s left) perf_pmu (busy-accuracy-50) [192.095027] Starting subtest: busy-accuracy-50 [192.095900] Starting dynamic subtest: rcs0 [193.625804] Dynamic subtest rcs0: SUCCESS (1.529s) [193.634879] Starting dynamic subtest: bcs0 [195.168860] Dynamic subtest bcs0: SUCCESS (1.541s) [195.178860] Starting dynamic subtest: vcs0 [196.710435] Dynamic subtest vcs0: SUCCESS (1.540s) [196.719885] Starting dynamic subtest: vcs1 [198.254131] Dynamic subtest vcs1: SUCCESS (1.542s) [198.263432] Starting dynamic subtest: vecs0 [199.794547] Dynamic subtest vecs0: SUCCESS (1.540s) [199.803742] Starting dynamic subtest: ccs0 [201.339515] Dynamic subtest ccs0: SUCCESS (1.544s) [201.340618] Subtest busy-accuracy-50: SUCCESS (9.244s) [201.461600] [053/132] (819s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [201.555608] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [202.359311] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.803s) [202.557870] [054/132] (818s left) gem_exec_reloc (basic-cpu-read) [202.618232] Subtest basic-cpu-read: SKIP (0.000s) [202.667122] [055/132] (818s left) gem_workarounds (basic-read-fd) [202.729271] Starting subtest: basic-read-fd [202.740873] Subtest basic-read-fd: SUCCESS (0.012s) [202.868870] [056/132] (818s left) i915_pm_rpm (gem-execbuf) [205.090712] Starting subtest: gem-execbuf [205.092069] Starting dynamic subtest: smem0 [206.598817] Dynamic subtest smem0: SUCCESS (1.512s) [206.599772] Subtest gem-execbuf: SUCCESS (1.513s) [206.691509] [057/132] (814s left) perf_pmu (semaphore-wait) [206.723309] Starting subtest: semaphore-wait [206.724392] Starting dynamic subtest: rcs0 [207.239504] Dynamic subtest rcs0: SUCCESS (0.513s) [207.249597] Starting dynamic subtest: bcs0 [207.750894] Dynamic subtest bcs0: SUCCESS (0.510s) [207.758333] Starting dynamic subtest: vcs0 [208.261992] Dynamic subtest vcs0: SUCCESS (0.510s) [208.271517] Starting dynamic subtest: vcs1 [208.774549] Dynamic subtest vcs1: SUCCESS (0.511s) [208.782509] Starting dynamic subtest: vecs0 [209.287664] Dynamic subtest vecs0: SUCCESS (0.511s) [209.298579] Starting dynamic subtest: ccs0 [209.802863] Dynamic subtest ccs0: SUCCESS (0.513s) [209.804736] Subtest semaphore-wait: SUCCESS (3.077s) [210.922190] [058/132] (810s left) gen7_exec_parse (basic-offset) [210.970704] Subtest basic-offset: SKIP (0.000s) [211.030751] [059/132] (810s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [211.119944] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [218.588417] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.469s) [218.718381] [060/132] (802s left) drm_read (invalid-buffer) [218.854706] Starting subtest: invalid-buffer [218.855898] Subtest invalid-buffer: SUCCESS (0.000s) [219.019534] [061/132] (802s left) syncobj_wait (single-wait-for-submit-unsubmitted) [219.071316] Starting subtest: single-wait-for-submit-unsubmitted [219.179365] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s) [219.272923] [062/132] (801s left) gem_gtt_cpu_tlb [219.373282] [063/132] (801s left) kms_joiner (invalid-modeset-big-joiner) [219.462942] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [219.539886] [064/132] (801s left) gem_exec_whisper (basic-fds-forked) [219.594049] Starting subtest: basic-fds-forked [243.861417] Subtest basic-fds-forked: SUCCESS (24.263s) [244.045528] [065/132] (777s left) gem_eio (in-flight-immediate) [244.273477] Starting subtest: in-flight-immediate [252.818407] Subtest in-flight-immediate: SUCCESS (8.546s) [253.026006] [066/132] (768s left) kms_cursor_crc (cursor-sliding-256x256) [253.256084] Starting subtest: cursor-sliding-256x256 [253.258155] Starting dynamic subtest: pipe-A-eDP-1 [256.465794] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.207s) [256.492566] Starting dynamic subtest: pipe-D-eDP-1 [260.390525] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.904s) [260.391370] Subtest cursor-sliding-256x256: SUCCESS (7.135s) [261.265894] [067/132] (760s left) kms_rotation_crc (primary-rotation-270) [261.354981] Starting subtest: primary-rotation-270 [261.356965] Subtest primary-rotation-270: SKIP (0.001s) [261.461292] [068/132] (759s left) gem_eio (wait-wedge-10ms) [261.682136] Starting subtest: wait-wedge-10ms [263.008468] Subtest wait-wedge-10ms: SUCCESS (1.326s) [263.135566] [069/132] (758s left) gem_userptr_blits (vma-merge) [263.204391] Starting subtest: vma-merge [263.241880] Subtest vma-merge: SUCCESS (0.038s) [263.396769] [070/132] (758s left) kms_psr (pr-cursor-plane-move) [263.480838] Starting subtest: pr-cursor-plane-move [263.483042] Subtest pr-cursor-plane-move: SKIP (0.000s) [263.569200] [071/132] (757s left) gem_eio (wait-10ms) [263.789146] Starting subtest: wait-10ms [264.153799] Subtest wait-10ms: SUCCESS (0.365s) [264.296442] [072/132] (757s left) gem_ctx_param (non-root-set) [264.352233] Starting subtest: non-root-set [264.377398] Subtest non-root-set: SUCCESS (0.026s) [264.478124] [073/132] (757s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [264.563084] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [264.564072] Starting dynamic subtest: pipe-A-eDP-1 [298.340689] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.671s) [298.349897] Starting dynamic subtest: pipe-B-eDP-1 [333.251940] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.295s) [333.261462] Starting dynamic subtest: pipe-C-eDP-1 [368.252336] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.339s) [368.263489] Starting dynamic subtest: pipe-D-eDP-1 [403.250857] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.231s) [403.252329] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (16.541s) [409.484490] [074/132] (617s left) gem_exec_balancer (parallel-keep-submit-fence) [409.739058] Starting subtest: parallel-keep-submit-fence [410.924633] Subtest parallel-keep-submit-fence: SUCCESS (1.192s) [411.050420] [075/132] (615s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [416.023623] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [416.024722] Starting dynamic subtest: pipe-A-eDP-1 [422.649525] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.637s) [422.663286] Starting dynamic subtest: pipe-B-eDP-1 [429.295145] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.650s) [429.296318] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.291s) [430.180786] [076/132] (596s left) kms_vblank (wait-busy-hang) [430.272696] Starting subtest: wait-busy-hang [430.274105] Starting dynamic subtest: pipe-A-eDP-1 [456.886997] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.628s) [456.898112] Starting dynamic subtest: pipe-D-eDP-1 [471.805518] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.922s) [471.807317] Subtest wait-busy-hang: SUCCESS (41.555s) [472.635157] [077/132] (554s left) gem_linear_blits (normal) [472.965569] Starting subtest: normal [477.068264] Subtest normal: SUCCESS (4.102s) [477.230271] [078/132] (549s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [477.363565] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [477.364582] Starting dynamic subtest: pipe-A-default-mode [478.479505] Dynamic subtest pipe-A-default-mode: SKIP (1.114s) [478.481756] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.116s) [478.665243] [079/132] (548s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [478.763621] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [478.765169] Starting dynamic subtest: pipe-A [478.781509] Dynamic subtest pipe-A: SKIP (0.016s) [478.790147] Starting dynamic subtest: pipe-B [478.808958] Dynamic subtest pipe-B: SKIP (0.027s) [478.817602] Starting dynamic subtest: pipe-C [478.837285] Dynamic subtest pipe-C: SKIP (0.027s) [478.845844] Starting dynamic subtest: pipe-D [478.863160] Dynamic subtest pipe-D: SKIP (0.027s) [478.865092] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.100s) [478.995228] [080/132] (547s left) gem_ctx_param (invalid-get-engines) [479.048170] Starting subtest: invalid-get-engines [479.049618] Subtest invalid-get-engines: SUCCESS (0.001s) [479.166264] [081/132] (547s left) kms_prime (basic-crc-vgem) [479.249782] Starting subtest: basic-crc-vgem [479.251135] Starting dynamic subtest: second-to-first [480.312997] Dynamic subtest second-to-first: SUCCESS (1.065s) [480.314013] Subtest basic-crc-vgem: SUCCESS (1.066s) [480.424462] [082/132] (546s left) gem_softpin (safe-alignment) [480.518164] Starting subtest: safe-alignment [480.543767] Subtest safe-alignment: SUCCESS (0.026s) [482.086927] [083/132] (544s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [482.180479] Starting subtest: fbcpsr-modesetfrombusy [488.657034] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.481s) [488.802482] [084/132] (538s left) kms_psr (psr-cursor-plane-move) [488.887755] Starting subtest: psr-cursor-plane-move [488.889044] Starting dynamic subtest: eDP-1 [490.646198] Dynamic subtest eDP-1: SUCCESS (1.758s) [490.647598] Subtest psr-cursor-plane-move: SUCCESS (1.759s) [491.533945] [085/132] (535s left) gem_ccs (block-copy-compressed) [491.593878] Starting subtest: block-copy-compressed [491.596135] Subtest block-copy-compressed: SKIP (0.000s) [491.724775] [086/132] (535s left) kms_async_flips (async-flip-suspend-resume) [491.806400] Starting subtest: async-flip-suspend-resume [492.188393] Starting dynamic subtest: pipe-A-eDP-1 [510.168725] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.355s) [510.544005] Starting dynamic subtest: pipe-B-eDP-1 [529.092547] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.183s) [529.471639] Starting dynamic subtest: pipe-C-eDP-1 [548.102101] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.242s) [548.483524] Starting dynamic subtest: pipe-D-eDP-1 [567.113183] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.284s) [567.137944] Subtest async-flip-suspend-resume: SUCCESS (14.561s) [574.293767] [087/132] (458s left) kms_pwrite_crc [575.901963] [088/132] (457s left) kms_flip (dpms-vs-vblank-race-interruptible) [575.984298] Starting subtest: dpms-vs-vblank-race-interruptible [575.985364] Starting dynamic subtest: A-eDP1 [580.974450] Dynamic subtest A-eDP1: SUCCESS (5.003s) [580.985981] Starting dynamic subtest: B-eDP1 [585.616651] Dynamic subtest B-eDP1: SUCCESS (4.650s) [585.626801] Starting dynamic subtest: C-eDP1 [590.232608] Dynamic subtest C-eDP1: SUCCESS (4.619s) [590.241399] Starting dynamic subtest: D-eDP1 [594.849800] Dynamic subtest D-eDP1: SUCCESS (4.621s) [594.852308] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.902s) [595.733107] [089/132] (437s left) gem_render_copy_redux (flink) [595.792062] Starting subtest: flink [596.499788] Subtest flink: SUCCESS (0.710s) [596.650168] [090/132] (436s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [596.760298] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [597.741788] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.982s) [598.566981] [091/132] (434s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [598.663876] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [598.665520] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [598.788658] [092/132] (434s left) i915_suspend (basic-s3-without-i915) [598.815804] Starting subtest: basic-s3-without-i915 [602.399813] Subtest basic-s3-without-i915: SKIP (3.581s) [603.861802] [093/132] (429s left) kms_psr (pr-primary-mmap-gtt) [603.947815] Starting subtest: pr-primary-mmap-gtt [603.949662] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [604.012940] [094/132] (429s left) kms_pm_rpm (fences-dpms) [605.946293] Starting subtest: fences-dpms [605.948256] Subtest fences-dpms: SKIP (0.000s) [606.337907] [095/132] (426s left) gem_ctx_persistence (process) [606.390653] Starting subtest: process [606.613298] Subtest process: SUCCESS (0.221s) [606.712023] [096/132] (426s left) gem_exec_balancer (hang) [606.964424] Starting subtest: hang [608.801414] Subtest hang: SUCCESS (1.836s) [608.937536] [097/132] (424s left) gem_mmap_gtt (cpuset-big-copy-odd) [608.989310] Subtest cpuset-big-copy-odd: SKIP (0.000s) [609.050733] [098/132] (424s left) kms_psr (fbc-psr2-cursor-plane-move) [609.136139] Starting subtest: fbc-psr2-cursor-plane-move [609.136980] Starting dynamic subtest: eDP-1 [609.138529] Dynamic subtest eDP-1: SKIP (0.000s) [609.140109] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s) [609.218887] [099/132] (424s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [609.303420] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [609.304293] Starting dynamic subtest: pipe-A-default-mode [610.473592] Dynamic subtest pipe-A-default-mode: SKIP (1.168s) [610.475381] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.169s) [610.650946] [100/132] (422s left) vgem_basic (debugfs) [610.698084] Starting subtest: debugfs [610.699075] Subtest debugfs: SUCCESS (0.000s) [610.772742] [101/132] (422s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [610.862678] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [610.864455] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [610.980181] [102/132] (422s left) sysfs_heartbeat_interval (precise) [611.029405] Starting subtest: precise [611.030507] Starting dynamic subtest: vecs0 [618.860167] Dynamic subtest vecs0: SUCCESS (7.824s) [618.871106] Starting dynamic subtest: ccs0 [619.941018] Dynamic subtest ccs0: SUCCESS (1.081s) [619.951499] Starting dynamic subtest: vcs0 [627.796807] Dynamic subtest vcs0: SUCCESS (7.854s) [627.806874] Starting dynamic subtest: bcs0 [628.904576] Dynamic subtest bcs0: SUCCESS (1.103s) [628.911980] Starting dynamic subtest: rcs0 [630.075656] Dynamic subtest rcs0: SUCCESS (1.172s) [630.088580] Starting dynamic subtest: vcs1 [637.843094] Dynamic subtest vcs1: SUCCESS (7.765s) [637.844446] Subtest precise: SUCCESS (26.812s) [637.938860] [103/132] (395s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [638.030824] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [638.032535] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [638.160535] [104/132] (395s left) gem_mmap_gtt (zero-extend) [638.217685] Subtest zero-extend: SKIP (0.000s) [638.280642] [105/132] (395s left) kms_atomic_interruptible (atomic-setmode) [638.383701] Starting subtest: atomic-setmode [638.384657] Starting dynamic subtest: pipe-A-eDP-1 [645.276488] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.893s) [645.277331] Subtest atomic-setmode: SUCCESS (6.895s) [646.147340] [106/132] (387s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs) [646.245410] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs [646.246213] Starting dynamic subtest: pipe-A-eDP-1 [646.254654] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [646.263642] Starting dynamic subtest: pipe-B-eDP-1 [646.271716] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [646.279709] Starting dynamic subtest: pipe-C-eDP-1 [646.287626] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [646.294802] Starting dynamic subtest: pipe-D-eDP-1 [646.303635] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [646.305245] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s) [648.406942] [107/132] (385s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [648.498487] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [648.500295] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [648.629865] [108/132] (385s left) kms_flip (plain-flip-ts-check) [648.724239] Starting subtest: plain-flip-ts-check [648.726185] Starting dynamic subtest: A-eDP1 [657.701415] Dynamic subtest A-eDP1: SUCCESS (8.979s) [657.715567] Starting dynamic subtest: B-eDP1 [666.738600] Dynamic subtest B-eDP1: SUCCESS (9.039s) [666.748402] Starting dynamic subtest: C-eDP1 [675.748235] Dynamic subtest C-eDP1: SUCCESS (9.007s) [675.756289] Starting dynamic subtest: D-eDP1 [684.584487] Dynamic subtest D-eDP1: SUCCESS (8.832s) [684.587622] Subtest plain-flip-ts-check: SUCCESS (35.866s) [685.767647] [109/132] (347s left) dmabuf (all-tests) [685.798024] Starting subtest: all-tests [685.799073] Starting dynamic subtest: sanitycheck [685.932456] Dynamic subtest sanitycheck: SUCCESS (0.131s) [685.944111] Starting dynamic subtest: dma_fence [686.244189] Dynamic subtest dma_fence: SUCCESS (0.308s) [686.256136] Starting dynamic subtest: dma_fence_chain [694.595445] Dynamic subtest dma_fence_chain: SUCCESS (8.347s) [694.606437] Starting dynamic subtest: dma_fence_unwrap [694.727054] Dynamic subtest dma_fence_unwrap: SUCCESS (0.130s) [694.737094] Starting dynamic subtest: dma_resv [694.868150] Dynamic subtest dma_resv: SUCCESS (0.138s) [694.869959] Subtest all-tests: SUCCESS (9.068s) [694.944212] [110/132] (338s left) gem_pxp (hw-rejects-pxp-context) [695.058991] Starting subtest: hw-rejects-pxp-context [695.061931] Subtest hw-rejects-pxp-context: SKIP (0.000s) [695.175125] [111/132] (338s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [695.277443] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [695.279250] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [695.390146] [112/132] (338s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [700.439342] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [700.440386] Starting dynamic subtest: pipe-A-eDP-1 [701.233297] Dynamic subtest pipe-A-eDP-1: SKIP (0.793s) [701.243638] Starting dynamic subtest: pipe-B-eDP-1 [702.369216] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s) [702.370994] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.931s) [703.567696] [113/132] (330s left) gem_lmem_swapping (heavy-verify-multi-ccs) [703.603195] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [703.641765] [114/132] (330s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [703.742592] Starting subtest: short-flip-after-cursor-atomic-transitions [704.694504] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.951s) [705.509940] [115/132] (328s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [705.608512] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [705.609420] Starting dynamic subtest: pipe-A-eDP-1 [705.618064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [705.628354] Starting dynamic subtest: pipe-B-eDP-1 [705.637568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [705.646268] Starting dynamic subtest: pipe-C-eDP-1 [705.654738] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [705.662156] Starting dynamic subtest: pipe-D-eDP-1 [705.670718] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [705.672370] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s) [707.765694] [116/132] (326s left) kms_setmode (basic) [707.807791] Starting subtest: basic [708.133798] Starting dynamic subtest: pipe-A-eDP-1 [710.186310] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.048s) [710.526962] Starting dynamic subtest: pipe-B-eDP-1 [712.616932] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.094s) [712.921968] Subtest basic: SUCCESS (5.114s) [713.771162] [117/132] (320s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [713.821439] Starting subtest: etime-multi-wait-all-for-submit-submitted [713.927702] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s) [714.020340] [118/132] (320s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [714.126918] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [714.128749] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [714.247938] [119/132] (319s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [714.335572] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [714.336448] Starting dynamic subtest: pipe-A-eDP-1 [714.344805] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [714.353092] Starting dynamic subtest: pipe-B-eDP-1 [714.361916] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [714.369841] Starting dynamic subtest: pipe-C-eDP-1 [714.378190] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [714.385898] Starting dynamic subtest: pipe-D-eDP-1 [714.394476] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [714.396141] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.005s) [716.539094] [120/132] (317s left) gem_pread (bench) [716.589387] Subtest bench: SKIP (0.000s) [716.641292] [121/132] (317s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render) [716.722391] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render [716.724059] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [716.848841] [122/132] (317s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [716.934191] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [716.935955] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [718.084910] [123/132] (316s left) gem_exec_capture (userptr) [718.138256] Starting subtest: userptr [718.980440] Subtest userptr: SUCCESS (0.841s) [719.132481] [124/132] (315s left) kms_plane (plane-position-hole-dpms) [719.211765] Starting subtest: plane-position-hole-dpms [719.733560] Starting dynamic subtest: pipe-A-plane-1 [722.067162] Dynamic subtest pipe-A-plane-1: SUCCESS (2.333s) [722.076861] Starting dynamic subtest: pipe-A-plane-2 [724.350948] Dynamic subtest pipe-A-plane-2: SUCCESS (2.284s) [724.360191] Starting dynamic subtest: pipe-A-plane-3 [726.601285] Dynamic subtest pipe-A-plane-3: SUCCESS (2.249s) [726.609730] Starting dynamic subtest: pipe-A-plane-4 [728.894143] Dynamic subtest pipe-A-plane-4: SUCCESS (2.292s) [728.904606] Starting dynamic subtest: pipe-A-plane-5 [728.918111] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [730.095209] Starting dynamic subtest: pipe-B-plane-1 [732.374385] Dynamic subtest pipe-B-plane-1: SUCCESS (2.289s) [732.383095] Starting dynamic subtest: pipe-B-plane-2 [734.692173] Dynamic subtest pipe-B-plane-2: SUCCESS (2.317s) [734.701450] Starting dynamic subtest: pipe-B-plane-3 [736.948424] Dynamic subtest pipe-B-plane-3: SUCCESS (2.255s) [736.958293] Starting dynamic subtest: pipe-B-plane-4 [739.292363] Dynamic subtest pipe-B-plane-4: SUCCESS (2.344s) [739.300869] Starting dynamic subtest: pipe-B-plane-5 [739.317201] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [739.318123] Subtest plane-position-hole-dpms: SUCCESS (20.109s) [740.131335] [125/132] (294s left) kms_invalid_mode (bad-hsync-start) [740.223310] Starting subtest: bad-hsync-start [740.224169] Starting dynamic subtest: pipe-A-eDP-1 [740.514049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s) [740.521867] Starting dynamic subtest: pipe-B-eDP-1 [740.522657] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [740.530094] Starting dynamic subtest: pipe-C-eDP-1 [740.530963] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [740.538053] Starting dynamic subtest: pipe-D-eDP-1 [740.538861] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [740.539664] Subtest bad-hsync-start: SUCCESS (0.296s) [741.349642] [126/132] (292s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [741.411314] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [741.412292] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [741.528494] [127/132] (292s left) kms_psr (psr-sprite-render) [741.608755] Starting subtest: psr-sprite-render [741.609619] Starting dynamic subtest: eDP-1 [743.359480] Dynamic subtest eDP-1: SUCCESS (1.750s) [743.360374] Subtest psr-sprite-render: SUCCESS (1.751s) [744.205430] [128/132] (290s left) i915_query (query-topology-coherent-slice-mask) [744.251774] Starting subtest: query-topology-coherent-slice-mask [744.253617] Subtest query-topology-coherent-slice-mask: SKIP (0.000s) [744.377281] [129/132] (290s left) i915_hangman (engine-engine-hang) [744.440712] Starting subtest: engine-engine-hang [744.441998] Starting dynamic subtest: rcs0 [745.770445] Dynamic subtest rcs0: SUCCESS (1.328s) [745.781998] Starting dynamic subtest: bcs0 [747.753047] Dynamic subtest bcs0: SUCCESS (1.981s) [747.764078] Starting dynamic subtest: vcs0 [749.800775] Dynamic subtest vcs0: SUCCESS (2.047s) [749.813700] Starting dynamic subtest: vcs1 [751.723305] Dynamic subtest vcs1: SUCCESS (1.918s) [751.735104] Starting dynamic subtest: vecs0 [752.745854] Dynamic subtest vecs0: SUCCESS (1.020s) [752.757198] Starting dynamic subtest: ccs0 [754.794509] Dynamic subtest ccs0: SUCCESS (2.046s) [754.796277] Subtest engine-engine-hang: SUCCESS (10.357s) [754.880721] [130/132] (279s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [754.966726] Starting subtest: plane-use-after-nonblocking-unbind [754.967695] Starting dynamic subtest: pipe-A-eDP-1 [755.027319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s) [755.327769] Starting dynamic subtest: pipe-B-eDP-1 [756.095052] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.775s) [756.391822] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.425s) [757.254189] [131/132] (277s left) prime_vgem (busy) [757.345681] Starting subtest: busy [757.346799] Starting dynamic subtest: rcs0 [757.402497] Dynamic subtest rcs0: SUCCESS (0.056s) [757.410434] Starting dynamic subtest: bcs0 [757.494256] Dynamic subtest bcs0: SUCCESS (0.091s) [757.502484] Starting dynamic subtest: vcs0 [757.539754] Dynamic subtest vcs0: SUCCESS (0.045s) [757.547898] Starting dynamic subtest: vcs1 [757.584348] Dynamic subtest vcs1: SUCCESS (0.044s) [757.592443] Starting dynamic subtest: vecs0 [757.629201] Dynamic subtest vecs0: SUCCESS (0.044s) [757.637161] Starting dynamic subtest: ccs0 [757.674277] Dynamic subtest ccs0: SUCCESS (0.044s) [757.675603] Subtest busy: SUCCESS (0.329s) [757.828594] [132/132] (276s left) kms_flip (2x-plain-flip-ts-check) [757.924304] Starting subtest: 2x-plain-flip-ts-check [757.934937] Subtest 2x-plain-flip-ts-check: SKIP (0.011s) [758.041393] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: gem_exec_schedule results: parsing output: 3/ for test: syncobj_wait results: parsing output: 4/ for test: gem_exec_params results: parsing output: 5/ for test: kms_draw_crc results: parsing output: 6/ for test: kms_content_protection results: parsing output: 7/ for test: api_intel_bb results: parsing output: 8/ for test: kms_flip results: parsing output: 9/ for test: gem_mmap_gtt results: parsing output: 10/ for test: kms_dirtyfb results: parsing output: 11/ for test: kms_cursor_crc results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_chamelium_hpd results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: gem_cs_tlb results: parsing output: 17/ for test: kms_flip_scaled_crc results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: kms_psr2_su results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: gem_ctx_shared results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: sysfs_timeslice_duration results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: gem_eio results: parsing output: 26/ for test: i915_drm_fdinfo results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_exec_schedule results: parsing output: 29/ for test: gem_exec_params results: parsing output: 30/ for test: kms_atomic results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: syncobj_timeline results: parsing output: 33/ for test: gem_exec_fence results: parsing output: 34/ for test: kms_chamelium_frames results: parsing output: 35/ for test: syncobj_wait results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_render_copy results: parsing output: 38/ for test: kms_plane_multiple results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_pipe_crc_basic results: parsing output: 44/ for test: kms_cdclk results: parsing output: 45/ for test: gem_exec_fence results: parsing output: 46/ for test: kms_sharpness_filter results: parsing output: 47/ for test: kms_pipe_b_c_ivb results: parsing output: 48/ for test: kms_vrr results: parsing output: 49/ for test: api_intel_allocator results: parsing output: 50/ for test: kms_getfb results: parsing output: 51/ for test: perf_pmu results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: gem_exec_reloc results: parsing output: 54/ for test: gem_workarounds results: parsing output: 55/ for test: i915_pm_rpm results: parsing output: 56/ for test: perf_pmu results: parsing output: 57/ for test: gen7_exec_parse results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: drm_read results: parsing output: 60/ for test: syncobj_wait results: parsing output: 61/ for test: gem_gtt_cpu_tlb results: parsing output: 62/ for test: kms_joiner results: parsing output: 63/ for test: gem_exec_whisper results: parsing output: 64/ for test: gem_eio results: parsing output: 65/ for test: kms_cursor_crc results: parsing output: 66/ for test: kms_rotation_crc results: parsing output: 67/ for test: gem_eio results: parsing output: 68/ for test: gem_userptr_blits results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: gem_eio results: parsing output: 71/ for test: gem_ctx_param results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: gem_exec_balancer results: parsing output: 74/ for test: kms_psr2_sf results: parsing output: 75/ for test: kms_vblank results: parsing output: 76/ for test: gem_linear_blits results: parsing output: 77/ for test: kms_flip_scaled_crc results: parsing output: 78/ for test: kms_plane_scaling results: parsing output: 79/ for test: gem_ctx_param results: parsing output: 80/ for test: kms_prime results: parsing output: 81/ for test: gem_softpin results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: gem_ccs results: parsing output: 85/ for test: kms_async_flips results: parsing output: 86/ for test: kms_pwrite_crc results: parsing output: 87/ for test: kms_flip results: parsing output: 88/ for test: gem_render_copy_redux results: parsing output: 89/ for test: kms_cursor_legacy results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: i915_suspend results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: kms_pm_rpm results: parsing output: 94/ for test: gem_ctx_persistence results: parsing output: 95/ for test: gem_exec_balancer results: parsing output: 96/ for test: gem_mmap_gtt results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: kms_flip_scaled_crc results: parsing output: 99/ for test: vgem_basic results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: sysfs_heartbeat_interval results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_mmap_gtt results: parsing output: 104/ for test: kms_atomic_interruptible results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: dmabuf results: parsing output: 109/ for test: gem_pxp results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_psr2_sf results: parsing output: 112/ for test: gem_lmem_swapping results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: kms_ccs results: parsing output: 115/ for test: kms_setmode results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_ccs results: parsing output: 119/ for test: gem_pread results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_ccs results: parsing output: 122/ for test: gem_exec_capture results: parsing output: 123/ for test: kms_plane results: parsing output: 124/ for test: kms_invalid_mode results: parsing output: 125/ for test: syncobj_timeline results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: i915_query results: parsing output: 128/ for test: i915_hangman results: parsing output: 129/ for test: kms_atomic_transition results: parsing output: 130/ for test: prime_vgem results: parsing output: 131/ for test: kms_flip Done.