[58.288287] Initializing watchdogs [58.288331] /dev/watchdog0 [58.301714] [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.305959] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.308710] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.311687] [001/132] (960s left) kms_big_fb (linear-32bpp-rotate-270) [58.444533] Starting subtest: linear-32bpp-rotate-270 [58.479110] Subtest linear-32bpp-rotate-270: SKIP (0.032s) [58.582351] [002/132] (960s left) kms_psr2_su (page_flip-nv12) [58.632103] Subtest page_flip-NV12: SKIP (0.000s) [58.686665] [003/132] (960s left) syncobj_wait (invalid-signal-illegal-handle) [58.732487] Starting subtest: invalid-signal-illegal-handle [58.734794] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [58.816564] [004/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [58.926404] Starting subtest: fbcpsr-2p-rte [58.930644] Subtest fbcpsr-2p-rte: SKIP (0.000s) [59.016841] [005/132] (959s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [59.110096] Starting subtest: fbc-rgb101010-draw-pwrite [64.765583] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.645s) [65.870601] [006/132] (953s left) gem_exec_reloc (basic-range-active) [65.930544] Subtest basic-range-active: SKIP (0.000s) [65.997873] [007/132] (953s left) i915_pm_rps (thresholds-idle) [66.051934] Starting subtest: thresholds-idle [66.056258] Subtest thresholds-idle: SKIP (0.001s) [66.161686] [008/132] (952s left) kms_force_connector_basic (force-load-detect) [66.237836] Starting subtest: force-load-detect [66.242755] Subtest force-load-detect: SKIP (0.000s) [66.355673] [009/132] (952s left) kms_chamelium_hpd (dp-hpd-storm-disable) [66.747385] Subtest dp-hpd-storm-disable: SKIP (0.000s) [67.575419] [010/132] (951s left) kms_joiner (basic-force-big-joiner) [67.735414] Starting subtest: basic-force-big-joiner [67.739839] Subtest basic-force-big-joiner: SKIP (0.000s) [67.810305] [011/132] (951s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [67.928991] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [67.931393] Starting dynamic subtest: pipe-A-eDP-1 [67.955696] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [67.965328] Starting dynamic subtest: pipe-B-eDP-1 [67.987563] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [67.995071] Starting dynamic subtest: pipe-C-eDP-1 [68.017302] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [68.024708] Starting dynamic subtest: pipe-D-eDP-1 [68.047040] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [68.051173] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s) [70.171630] [012/132] (949s left) kms_frontbuffer_tracking (fbc-tiling-4) [70.293638] Starting subtest: fbc-tiling-4 [74.488983] Subtest fbc-tiling-4: SUCCESS (4.197s) [75.677165] [013/132] (943s left) i915_hangman (gt-error-state-capture) [75.741357] Starting subtest: gt-error-state-capture [75.743710] Starting dynamic subtest: rcs0 [85.876183] Dynamic subtest rcs0: SUCCESS (10.131s) [85.885829] Starting dynamic subtest: bcs0 [97.844541] Dynamic subtest bcs0: SUCCESS (11.964s) [97.855628] Starting dynamic subtest: vcs0 [109.814213] Dynamic subtest vcs0: SUCCESS (11.967s) [109.823746] Starting dynamic subtest: vcs1 [120.820889] Dynamic subtest vcs1: SUCCESS (11.004s) [120.830740] Starting dynamic subtest: vecs0 [131.829085] Dynamic subtest vecs0: SUCCESS (11.007s) [131.839981] Starting dynamic subtest: ccs0 [143.861063] Dynamic subtest ccs0: SUCCESS (12.030s) [143.863959] Subtest gt-error-state-capture: SUCCESS (68.110s) [143.939066] [014/132] (875s left) kms_flip (flip-vs-fences) [144.038890] Starting subtest: flip-vs-fences [144.043287] Subtest flip-vs-fences: SKIP (0.000s) [144.144698] [015/132] (875s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [144.231263] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [144.235808] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [144.327878] [016/132] (875s left) prime_vgem (fence-write-hang) [144.430567] Subtest fence-write-hang: SKIP (0.000s) [144.514553] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [144.517525] [017/132] (874s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [144.571151] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [144.573509] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s) [144.659792] [018/132] (874s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [144.771726] Starting subtest: 2x-long-flip-vs-cursor-legacy [144.776243] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [144.913855] [019/132] (874s left) kms_flip (plain-flip-interruptible) [144.999649] Starting subtest: plain-flip-interruptible [145.001592] Starting dynamic subtest: A-eDP1 [146.677613] Dynamic subtest A-eDP1: SUCCESS (1.675s) [146.689109] Starting dynamic subtest: B-eDP1 [148.292480] Dynamic subtest B-eDP1: SUCCESS (1.614s) [148.300322] Starting dynamic subtest: C-eDP1 [149.909510] Dynamic subtest C-eDP1: SUCCESS (1.616s) [149.919437] Starting dynamic subtest: D-eDP1 [151.529862] Dynamic subtest D-eDP1: SUCCESS (1.619s) [151.532415] Subtest plain-flip-interruptible: SUCCESS (6.531s) [152.711539] [020/132] (866s left) gem_exec_reloc (basic-gtt-wc-active) [152.777727] Subtest basic-gtt-wc-active: SKIP (0.000s) [152.857341] [021/132] (866s left) kms_draw_crc (draw-method-pwrite) [152.954954] Starting subtest: draw-method-pwrite [152.956892] Starting dynamic subtest: xrgb8888-untiled [153.509020] Dynamic subtest xrgb8888-untiled: SUCCESS (0.555s) [153.517905] Starting dynamic subtest: rgb565-untiled [154.020181] Dynamic subtest rgb565-untiled: SUCCESS (0.510s) [154.029207] Starting dynamic subtest: xrgb2101010-untiled [154.553382] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.532s) [154.562273] Starting dynamic subtest: xbgr16161616f-untiled [155.297774] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.744s) [155.306422] Starting dynamic subtest: xrgb8888-xtiled [157.064675] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.766s) [157.073125] Starting dynamic subtest: rgb565-xtiled [158.131316] Dynamic subtest rgb565-xtiled: SUCCESS (1.066s) [158.140483] Starting dynamic subtest: xrgb2101010-xtiled [159.898094] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.766s) [159.906423] Starting dynamic subtest: xbgr16161616f-xtiled [163.142505] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.244s) [163.151983] Starting dynamic subtest: xrgb8888-4tiled [164.265061] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.121s) [164.273668] Starting dynamic subtest: rgb565-4tiled [164.820627] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s) [164.828256] Starting dynamic subtest: xrgb2101010-4tiled [165.910115] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.088s) [165.917864] Starting dynamic subtest: xbgr16161616f-4tiled [168.865726] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.955s) [168.868245] Subtest draw-method-pwrite: SUCCESS (15.911s) [168.970976] [022/132] (850s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [169.094518] Starting subtest: yf-tiled-16bpp-rotate-90 [169.099016] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [169.184903] [023/132] (850s left) gem_mmap_gtt (basic-write-read-distinct) [169.233291] Subtest basic-write-read-distinct: SKIP (0.000s) [169.290549] [024/132] (850s left) kms_psr (pr-sprite-blt) [169.373176] Starting subtest: pr-sprite-blt [169.377272] Subtest pr-sprite-blt: SKIP (0.000s) [169.443264] [025/132] (850s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [169.532439] Starting subtest: fbc-psr2-cursor-mmap-cpu [169.534695] Starting dynamic subtest: eDP-1 [169.539184] Dynamic subtest eDP-1: SKIP (0.000s) [169.543714] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s) [169.601908] [026/132] (850s left) kms_sequence (get-forked) [169.692781] Starting subtest: get-forked [169.694746] Starting dynamic subtest: pipe-A-eDP-1 [171.571996] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s) [171.581071] Starting dynamic subtest: pipe-B-eDP-1 [174.157143] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.583s) [174.166853] Starting dynamic subtest: pipe-C-eDP-1 [176.668719] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.511s) [176.679999] Starting dynamic subtest: pipe-D-eDP-1 [179.215272] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s) [179.217744] Subtest get-forked: SUCCESS (9.522s) [180.046441] [027/132] (839s left) gem_mmap_offset (close-race) [180.112373] Starting subtest: close-race [200.227978] Subtest close-race: SUCCESS (20.111s) [200.362278] [028/132] (819s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [200.452779] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [200.455012] Starting dynamic subtest: pipe-A-eDP-1 [200.477228] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [200.486850] Starting dynamic subtest: pipe-B-eDP-1 [200.507497] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [200.514746] Starting dynamic subtest: pipe-C-eDP-1 [200.535624] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [200.542781] Starting dynamic subtest: pipe-D-eDP-1 [200.564507] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [200.568573] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [202.708808] [029/132] (817s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [202.769470] Subtest writes-after-reads-snoop: SKIP (0.000s) [202.833022] [030/132] (817s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [202.920938] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [202.925093] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [203.010948] [031/132] (816s left) gem_exec_fence (syncobj-timeline-wait) [203.582062] Starting subtest: syncobj-timeline-wait [204.901676] Subtest syncobj-timeline-wait: SUCCESS (1.319s) [205.122874] [032/132] (814s left) syncobj_wait (reset-signaled) [205.187954] Starting subtest: reset-signaled [205.190479] Subtest reset-signaled: SUCCESS (0.000s) [205.274922] [033/132] (814s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [205.383322] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [205.387346] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [205.486369] [034/132] (814s left) gem_exec_parallel (basic) [205.543872] Starting subtest: basic [205.546202] Starting dynamic subtest: rcs0 [206.989207] Dynamic subtest rcs0: SUCCESS (1.447s) [206.999545] Starting dynamic subtest: bcs0 [208.449832] Dynamic subtest bcs0: SUCCESS (1.458s) [208.459157] Starting dynamic subtest: vcs0 [209.924943] Dynamic subtest vcs0: SUCCESS (1.473s) [209.935494] Starting dynamic subtest: vcs1 [211.861235] Dynamic subtest vcs1: SUCCESS (1.935s) [211.870589] Starting dynamic subtest: vecs0 [213.844645] Dynamic subtest vecs0: SUCCESS (1.982s) [213.854190] Starting dynamic subtest: ccs0 [215.331015] Dynamic subtest ccs0: SUCCESS (1.486s) [215.333361] Subtest basic: SUCCESS (9.790s) [215.518864] [035/132] (804s left) kms_prime (basic-crc-hybrid) [215.606526] Subtest basic-crc-hybrid: SKIP (0.000s) [215.694036] [036/132] (804s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [215.778676] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [215.780862] Starting dynamic subtest: pipe-A-eDP-1 [215.874088] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s) [215.887661] Starting dynamic subtest: pipe-B-eDP-1 [216.987423] Dynamic subtest pipe-B-eDP-1: SKIP (1.111s) [216.991642] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.213s) [218.183777] [037/132] (802s left) gem_exec_reloc (basic-wc-noreloc) [218.242057] Subtest basic-wc-noreloc: SKIP (0.000s) [218.306984] [038/132] (801s left) kms_color (invalid-degamma-lut-sizes) [218.391813] Starting subtest: invalid-degamma-lut-sizes [218.394105] Starting dynamic subtest: pipe-A [218.680937] Dynamic subtest pipe-A: SUCCESS (0.286s) [218.689334] Starting dynamic subtest: pipe-B [218.691807] Dynamic subtest pipe-B: SUCCESS (0.000s) [218.701340] Starting dynamic subtest: pipe-C [218.703625] Dynamic subtest pipe-C: SUCCESS (0.000s) [218.711398] Starting dynamic subtest: pipe-D [218.713250] Dynamic subtest pipe-D: SUCCESS (0.000s) [218.715108] Subtest invalid-degamma-lut-sizes: SUCCESS (0.289s) [219.520889] [039/132] (800s left) kms_pipe_crc_basic (bad-source) [219.612315] Starting subtest: bad-source [219.614611] Subtest bad-source: SUCCESS (0.000s) [219.681984] [040/132] (800s left) gem_exec_store (basic) [219.741040] Starting subtest: basic [219.843037] Subtest basic: SUCCESS (0.105s) [220.028736] [041/132] (800s left) kms_big_fb (4-tiled-16bpp-rotate-90) [220.117415] Starting subtest: 4-tiled-16bpp-rotate-90 [220.137082] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [220.287665] [042/132] (800s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [220.382951] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [220.385282] Starting dynamic subtest: pipe-A [220.406095] Dynamic subtest pipe-A: SKIP (0.019s) [220.414541] Starting dynamic subtest: pipe-B [220.435867] Dynamic subtest pipe-B: SKIP (0.031s) [220.443091] Starting dynamic subtest: pipe-C [220.472637] Dynamic subtest pipe-C: SKIP (0.034s) [220.480036] Starting dynamic subtest: pipe-D [220.511800] Dynamic subtest pipe-D: SKIP (0.040s) [220.516044] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.126s) [220.604231] [043/132] (799s left) kms_async_flips (invalid-async-flip-atomic) [220.693175] Starting subtest: invalid-async-flip-atomic [221.074912] Starting dynamic subtest: pipe-A-eDP-1 [221.944715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.869s) [222.308634] Starting dynamic subtest: pipe-B-eDP-1 [223.085652] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.784s) [223.440238] Starting dynamic subtest: pipe-C-eDP-1 [224.197985] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s) [224.549503] Starting dynamic subtest: pipe-D-eDP-1 [225.340120] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.799s) [225.342525] Subtest invalid-async-flip-atomic: SUCCESS (4.649s) [226.498724] [044/132] (793s left) kms_psr (psr2-sprite-plane-onoff) [226.586983] Starting subtest: psr2-sprite-plane-onoff [226.589224] Starting dynamic subtest: eDP-1 [228.303535] Dynamic subtest eDP-1: SUCCESS (1.715s) [228.305869] Subtest psr2-sprite-plane-onoff: SUCCESS (1.716s) [229.158652] [045/132] (791s left) gem_exec_balancer (bonded-chain) [229.237034] Starting subtest: bonded-chain [236.239994] Subtest bonded-chain: SUCCESS (7.001s) [236.568853] [046/132] (783s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [236.668064] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [236.670463] Starting dynamic subtest: pipe-A-eDP-1 [236.691408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s) [236.701526] Starting dynamic subtest: pipe-B-eDP-1 [236.721208] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s) [236.729418] Starting dynamic subtest: pipe-C-eDP-1 [236.749313] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s) [236.759629] Starting dynamic subtest: pipe-D-eDP-1 [236.780311] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s) [236.782725] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.089s) [239.014859] [047/132] (781s left) gem_eio (context-create) [239.220318] Starting subtest: context-create [239.512953] Subtest context-create: SUCCESS (0.292s) [239.673858] [048/132] (780s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [239.757903] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [239.762296] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [239.845121] [049/132] (780s left) gem_exec_schedule (preempt-queue-contexts-chain) [239.922066] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [240.205445] [050/132] (780s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [240.313790] Starting subtest: primary-yf-tiled-reflect-x-90 [240.318237] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [240.385243] [051/132] (780s left) gem_ringfill (legacy-basic) [245.913811] Starting subtest: legacy-basic [245.916454] Starting dynamic subtest: default [245.960272] Dynamic subtest default: SUCCESS (0.047s) [245.972048] Starting dynamic subtest: render [246.004811] Dynamic subtest render: SUCCESS (0.041s) [246.020069] Starting dynamic subtest: bsd [246.047275] Dynamic subtest bsd: SUCCESS (0.041s) [246.057205] Starting dynamic subtest: bsd1 [246.090605] Dynamic subtest bsd1: SUCCESS (0.041s) [246.099930] Starting dynamic subtest: bsd2 [246.132724] Dynamic subtest bsd2: SUCCESS (0.039s) [246.142032] Starting dynamic subtest: blt [246.176092] Dynamic subtest blt: SUCCESS (0.043s) [246.184528] Starting dynamic subtest: vebox [246.221339] Dynamic subtest vebox: SUCCESS (0.043s) [246.224327] Subtest legacy-basic: SUCCESS (0.310s) [246.315277] [052/132] (774s left) gem_eio (wait-wedge-1us) [246.526561] Starting subtest: wait-wedge-1us [247.968305] Subtest wait-wedge-1us: SUCCESS (1.440s) [248.113709] [053/132] (772s left) kms_cursor_crc (cursor-offscreen-64x64) [248.305852] Starting subtest: cursor-offscreen-64x64 [248.311384] Starting dynamic subtest: pipe-A-eDP-1 [250.256515] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.946s) [250.285999] Starting dynamic subtest: pipe-D-eDP-1 [252.817670] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s) [252.820034] Subtest cursor-offscreen-64x64: SUCCESS (4.509s) [253.682431] [054/132] (767s left) gem_exec_reloc (basic-write-read-noreloc) [253.740143] Subtest basic-write-read-noreloc: SKIP (0.000s) [253.817846] [055/132] (767s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [253.912952] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [253.927341] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.014s) [254.000809] [056/132] (766s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [254.108885] Starting subtest: cursor-tearing-framebuffer-change [254.111190] Starting dynamic subtest: pipe-A-eDP-1 [254.674690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [254.683599] Starting dynamic subtest: pipe-D-eDP-1 [255.919890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s) [255.922321] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.811s) [256.755056] [057/132] (764s left) gem_ccs (block-multicopy-inplace) [256.806365] Starting subtest: block-multicopy-inplace [256.810887] Subtest block-multicopy-inplace: SKIP (0.000s) [256.911151] [058/132] (764s left) syncobj_timeline (wait-delayed-signal) [256.959758] Starting subtest: wait-delayed-signal [257.060250] Subtest wait-delayed-signal: SUCCESS (0.102s) [257.138923] [059/132] (763s left) kms_chamelium_color (ctm-green-to-red) [257.233321] Subtest ctm-green-to-red: SKIP (0.000s) [257.276780] [060/132] (763s left) gem_mmap_gtt (bad-object) [257.343146] Subtest bad-object: SKIP (0.000s) [257.395974] [061/132] (763s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [257.501287] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [261.857589] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.359s) [262.990425] [062/132] (758s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [263.079256] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [263.081623] Starting dynamic subtest: pipe-A-eDP-1 [263.107933] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [263.118087] Starting dynamic subtest: pipe-B-eDP-1 [263.142570] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [263.150234] Starting dynamic subtest: pipe-C-eDP-1 [263.174357] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [263.182316] Starting dynamic subtest: pipe-D-eDP-1 [263.206812] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [263.210997] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s) [265.335813] [063/132] (755s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [265.441976] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [265.446145] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [265.514951] [064/132] (755s left) gem_tiled_partial_pwrite_pread (writes) [265.568078] Subtest writes: SKIP (0.000s) [265.630397] [065/132] (755s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [265.731043] Starting subtest: fbcpsr-rgb565-draw-blt [272.706077] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.977s) [272.849298] [066/132] (748s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [272.902889] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [272.905144] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [273.017078] [067/132] (748s left) kms_vblank (wait-forked-busy) [273.110404] Starting subtest: wait-forked-busy [273.112453] Starting dynamic subtest: pipe-A-eDP-1 [275.001310] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.892s) [275.015296] Starting dynamic subtest: pipe-D-eDP-1 [277.544278] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s) [277.546469] Subtest wait-forked-busy: SUCCESS (4.435s) [278.343582] [068/132] (743s left) kms_psr (fbc-psr-sprite-plane-move) [278.440231] Starting subtest: fbc-psr-sprite-plane-move [278.442532] Starting dynamic subtest: eDP-1 [278.446791] Dynamic subtest eDP-1: SKIP (0.000s) [278.451446] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [278.516065] [069/132] (742s left) perf_pmu (faulting-read) [278.553954] Starting subtest: faulting-read [278.556247] Starting dynamic subtest: wb [278.558158] Dynamic subtest wb: SUCCESS (0.001s) [278.568206] Starting dynamic subtest: wc [278.570337] Dynamic subtest wc: SUCCESS (0.000s) [278.578768] Starting dynamic subtest: uc [278.580596] Dynamic subtest uc: SUCCESS (0.000s) [278.582487] Subtest faulting-read: SUCCESS (0.003s) [278.679378] [070/132] (742s left) kms_rotation_crc (sprite-rotation-90) [278.774411] Starting subtest: sprite-rotation-90 [278.778508] Subtest sprite-rotation-90: SKIP (0.001s) [278.859072] [071/132] (742s left) kms_big_fb (x-tiled-8bpp-rotate-180) [278.961911] Starting subtest: x-tiled-8bpp-rotate-180 [280.187024] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.225s) [280.286045] [072/132] (741s left) gem_exec_params (no-vebox) [280.347925] Starting subtest: no-vebox [280.350327] Subtest no-vebox: SUCCESS (0.002s) [281.994724] [073/132] (739s left) kms_chamelium_frames (dp-crc-multiple) [282.382427] Subtest dp-crc-multiple: SKIP (0.000s) [283.142548] [074/132] (738s left) gem_exec_fence (concurrent) [283.313933] Starting subtest: concurrent [283.318802] Subtest concurrent: SKIP (0.000s) [284.959488] [075/132] (736s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [285.063417] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [285.067765] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [285.154601] [076/132] (736s left) kms_big_fb (y-tiled-64bpp-rotate-180) [285.245496] Starting subtest: y-tiled-64bpp-rotate-180 [285.249609] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [285.338830] [077/132] (736s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [285.390198] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [285.392556] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [285.481162] [078/132] (736s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [285.533780] Starting subtest: etime-multi-wait-for-submit-unsubmitted [285.641894] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s) [285.720193] [079/132] (736s left) prime_busy (hang) [285.777828] Starting subtest: hang [285.780234] Starting dynamic subtest: rcs0 [311.406275] Dynamic subtest rcs0: SUCCESS (25.625s) [311.414371] Starting dynamic subtest: bcs0 [318.562048] Dynamic subtest bcs0: SUCCESS (7.154s) [318.570560] Starting dynamic subtest: vcs0 [325.539573] Dynamic subtest vcs0: SUCCESS (6.976s) [325.547776] Starting dynamic subtest: vcs1 [332.577708] Dynamic subtest vcs1: SUCCESS (7.036s) [332.586453] Starting dynamic subtest: vecs0 [339.550078] Dynamic subtest vecs0: SUCCESS (6.971s) [339.558348] Starting dynamic subtest: ccs0 [353.456741] Dynamic subtest ccs0: SUCCESS (13.903s) [353.458933] Subtest hang: SUCCESS (67.674s) [353.585614] [080/132] (668s left) gem_lmem_evict (dontneed-evict-race) [353.633384] Subtest dontneed-evict-race: SKIP (0.000s) [353.669547] [081/132] (668s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [353.772383] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [353.776417] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [353.869994] [082/132] (668s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [353.963314] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [360.735696] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.775s) [360.874592] [083/132] (661s left) kms_content_protection (dp-mst-type-0) [361.013103] Starting subtest: dp-mst-type-0 [361.017572] Subtest dp-mst-type-0: SKIP (0.000s) [361.146897] [084/132] (660s left) kms_hdr (invalid-metadata-sizes) [361.250261] Starting subtest: invalid-metadata-sizes [361.256691] Subtest invalid-metadata-sizes: SKIP (0.000s) [361.323290] [085/132] (660s left) gem_sync (basic-all) [361.396051] Starting subtest: basic-all [364.887034] Subtest basic-all: SUCCESS (3.500s) [365.083851] [086/132] (657s left) i915_pm_rpm (gem-execbuf-stress-pc8) [367.114435] Starting subtest: gem-execbuf-stress-pc8 [367.151249] Subtest gem-execbuf-stress-pc8: SKIP (0.037s) [367.482172] [087/132] (654s left) syncobj_wait (wait-for-submit-snapshot) [367.545779] Starting subtest: wait-for-submit-snapshot [367.626865] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [367.729327] [088/132] (654s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [367.812055] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [374.605088] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.797s) [374.728605] [089/132] (647s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [374.827552] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [374.831608] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s) [374.899975] [090/132] (647s left) gem_exec_schedule (preempt) [374.968068] Starting subtest: preempt [374.969929] Starting dynamic subtest: rcs0 [374.983606] Dynamic subtest rcs0: SUCCESS (0.023s) [374.994277] Starting dynamic subtest: bcs0 [375.002817] Dynamic subtest bcs0: SUCCESS (0.019s) [375.011567] Starting dynamic subtest: vcs0 [375.030924] Dynamic subtest vcs0: SUCCESS (0.027s) [375.039231] Starting dynamic subtest: vcs1 [375.053202] Dynamic subtest vcs1: SUCCESS (0.022s) [375.064521] Starting dynamic subtest: vecs0 [375.074232] Dynamic subtest vecs0: SUCCESS (0.020s) [375.082822] Starting dynamic subtest: ccs0 [375.097080] Dynamic subtest ccs0: SUCCESS (0.022s) [375.099282] Subtest preempt: SUCCESS (0.137s) [376.996232] [091/132] (645s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [377.105354] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [377.109952] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [377.250251] [092/132] (645s left) gem_ctx_persistence (engines-mixed-process) [377.302668] Starting subtest: engines-mixed-process [377.304816] Starting dynamic subtest: rcs0 [378.903215] Dynamic subtest rcs0: SUCCESS (1.600s) [378.913241] Starting dynamic subtest: bcs0 [380.895558] Dynamic subtest bcs0: SUCCESS (1.991s) [380.905326] Starting dynamic subtest: vcs0 [382.884576] Dynamic subtest vcs0: SUCCESS (1.988s) [382.894872] Starting dynamic subtest: vcs1 [384.898950] Dynamic subtest vcs1: SUCCESS (2.013s) [384.908748] Starting dynamic subtest: vecs0 [386.842114] Dynamic subtest vecs0: SUCCESS (1.942s) [386.850980] Starting dynamic subtest: ccs0 [388.877714] Dynamic subtest ccs0: SUCCESS (2.034s) [388.879889] Subtest engines-mixed-process: SUCCESS (11.575s) [388.959992] [093/132] (633s left) device_reset (unbind-cold-reset-rebind) [389.009048] Starting subtest: unbind-cold-reset-rebind [389.013593] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [389.085929] [094/132] (633s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [389.184304] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [389.188573] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [389.278913] [095/132] (633s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [389.394149] Starting subtest: flip-vs-cursor-busy-crc-atomic [390.211981] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.816s) [391.014177] [096/132] (631s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [391.100133] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [391.104208] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s) [391.173835] [097/132] (631s left) perf (invalid-oa-exponent) [391.300101] Starting subtest: invalid-oa-exponent [391.313722] Subtest invalid-oa-exponent: SUCCESS (0.013s) [391.358217] [098/132] (631s left) kms_pm_backlight (fade-with-suspend) [391.452556] Starting subtest: fade-with-suspend [407.327337] Starting dynamic subtest: eDP-1 [409.832838] Dynamic subtest eDP-1: SUCCESS (2.471s) [409.835183] Subtest fade-with-suspend: SUCCESS (3.820s) [410.676737] [099/132] (612s left) i915_drm_fdinfo (busy-check-all) [410.728778] Starting subtest: busy-check-all [410.730712] Starting dynamic subtest: rcs0 [410.735283] Dynamic subtest rcs0: SKIP (0.003s) [410.750048] Starting dynamic subtest: bcs0 [410.754676] Dynamic subtest bcs0: SKIP (0.000s) [410.766469] Starting dynamic subtest: vcs0 [410.770645] Dynamic subtest vcs0: SKIP (0.000s) [410.779551] Starting dynamic subtest: vcs1 [410.783616] Dynamic subtest vcs1: SKIP (0.000s) [410.792573] Starting dynamic subtest: vecs0 [410.796619] Dynamic subtest vecs0: SKIP (0.000s) [410.805355] Starting dynamic subtest: ccs0 [410.809553] Dynamic subtest ccs0: SKIP (0.000s) [410.813662] Subtest busy-check-all: SKIP (0.008s) [410.850924] [100/132] (611s left) kms_flip (dpms-off-confusion) [410.978199] Starting subtest: dpms-off-confusion [410.980556] Starting dynamic subtest: A-eDP1 [419.699173] Dynamic subtest A-eDP1: SUCCESS (8.653s) [419.712996] Starting dynamic subtest: B-eDP1 [428.396239] Dynamic subtest B-eDP1: SUCCESS (8.670s) [428.408306] Starting dynamic subtest: C-eDP1 [437.030733] Dynamic subtest C-eDP1: SUCCESS (8.623s) [437.044612] Starting dynamic subtest: D-eDP1 [445.667375] Dynamic subtest D-eDP1: SUCCESS (8.634s) [445.672603] Subtest dpms-off-confusion: SUCCESS (34.593s) [446.836029] [101/132] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [446.935886] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [446.940007] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [447.031451] [102/132] (575s left) kms_pipe_crc_basic (suspend-read-crc) [447.113231] Starting subtest: suspend-read-crc [447.115482] Starting dynamic subtest: pipe-A-eDP-1 [464.220361] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.528s) [464.229855] Starting dynamic subtest: pipe-B-eDP-1 [482.252155] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.098s) [482.263344] Starting dynamic subtest: pipe-C-eDP-1 [500.186111] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.961s) [500.197305] Starting dynamic subtest: pipe-D-eDP-1 [518.239674] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.089s) [518.242240] Subtest suspend-read-crc: SUCCESS (11.683s) [519.079161] [103/132] (503s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [519.134636] Starting subtest: single-wait-all-for-submit-available-submitted [519.137285] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [519.234728] [104/132] (503s left) gem_ctx_persistence (legacy-engines-queued) [519.291486] Starting subtest: legacy-engines-queued [519.294681] Starting dynamic subtest: render [519.356014] Dynamic subtest render: SUCCESS (0.062s) [519.368899] Starting dynamic subtest: bsd1 [520.715937] Dynamic subtest bsd1: SUCCESS (1.338s) [520.729537] Starting dynamic subtest: bsd2 [522.699135] Dynamic subtest bsd2: SUCCESS (1.957s) [522.712231] Starting dynamic subtest: blt [522.735135] Dynamic subtest blt: SUCCESS (0.034s) [522.744619] Starting dynamic subtest: vebox [524.682779] Dynamic subtest vebox: SUCCESS (1.927s) [524.685512] Subtest legacy-engines-queued: SUCCESS (5.333s) [524.770924] [105/132] (498s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [524.871177] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [524.876265] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [524.941849] [106/132] (498s left) gem_exec_fence (syncobj-signal) [525.370595] Starting subtest: syncobj-signal [525.376758] Subtest syncobj-signal: SUCCESS (0.006s) [526.784952] [107/132] (496s left) kms_addfb_basic (bad-pitch-0) [526.852025] Starting subtest: bad-pitch-0 [526.854198] Subtest bad-pitch-0: SUCCESS (0.000s) [526.984341] [108/132] (496s left) gem_spin_batch (resubmit-new-all) [527.049330] Starting subtest: resubmit-new-all [527.051602] Starting dynamic subtest: rcs0 [527.061984] Dynamic subtest rcs0: SUCCESS (0.015s) [527.073196] Starting dynamic subtest: bcs0 [527.075487] Dynamic subtest bcs0: SUCCESS (0.010s) [527.084605] Starting dynamic subtest: vcs0 [527.086846] Dynamic subtest vcs0: SUCCESS (0.009s) [527.099444] Starting dynamic subtest: vcs1 [527.102537] Dynamic subtest vcs1: SUCCESS (0.009s) [527.112631] Starting dynamic subtest: vecs0 [527.115235] Dynamic subtest vecs0: SUCCESS (0.009s) [527.124520] Starting dynamic subtest: ccs0 [527.127085] Dynamic subtest ccs0: SUCCESS (0.010s) [527.129160] Subtest resubmit-new-all: SUCCESS (0.067s) [528.841905] [109/132] (494s left) gem_userptr_blits (mmap-offset-banned) [528.932399] Starting subtest: mmap-offset-banned [528.935317] Starting dynamic subtest: wb [528.938216] Dynamic subtest wb: SUCCESS (0.001s) [528.950670] Starting dynamic subtest: wc [528.953370] Dynamic subtest wc: SUCCESS (0.000s) [528.965876] Starting dynamic subtest: uc [528.968393] Dynamic subtest uc: SUCCESS (0.000s) [528.971175] Subtest mmap-offset-banned: SUCCESS (0.008s) [529.069530] [110/132] (494s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [529.169866] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [529.172402] Starting dynamic subtest: A-eDP1 [532.810424] Dynamic subtest A-eDP1: SUCCESS (3.628s) [532.821970] Starting dynamic subtest: B-eDP1 [536.018478] Dynamic subtest B-eDP1: SUCCESS (3.199s) [536.029610] Starting dynamic subtest: C-eDP1 [539.215327] Dynamic subtest C-eDP1: SUCCESS (3.188s) [539.226514] Starting dynamic subtest: D-eDP1 [542.413411] Dynamic subtest D-eDP1: SUCCESS (3.192s) [542.416219] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.215s) [543.205803] [111/132] (480s left) syncobj_wait (wait-delayed-signal) [543.259678] Starting subtest: wait-delayed-signal [543.360228] Subtest wait-delayed-signal: SUCCESS (0.103s) [543.439303] [112/132] (479s left) gem_close_race (multigpu-basic-process) [543.501245] Starting subtest: multigpu-basic-process [543.506822] Subtest multigpu-basic-process: SKIP (0.000s) [543.723639] [113/132] (479s left) api_intel_bb (reset-bb) [543.771617] Starting subtest: reset-bb [543.778510] Subtest reset-bb: SUCCESS (0.004s) [543.896540] [114/132] (479s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [543.993603] Starting subtest: fbc-rgb565-draw-mmap-wc [547.991048] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.997s) [549.121253] [115/132] (474s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [549.249254] Starting subtest: basic-flip-before-cursor-varying-size [550.175609] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.925s) [551.061146] [116/132] (472s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [551.154552] Starting subtest: async-flip-with-page-flip-events-tiled [551.532440] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [554.312514] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.781s) [554.322597] Starting dynamic subtest: pipe-A-eDP-1-4 [556.498464] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s) [556.510776] Starting dynamic subtest: pipe-A-eDP-1-4 [558.508140] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [558.518598] Starting dynamic subtest: pipe-A-eDP-1-x [560.709757] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s) [561.081181] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [563.841645] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.767s) [563.856748] Starting dynamic subtest: pipe-B-eDP-1-4 [566.038905] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s) [566.052052] Starting dynamic subtest: pipe-B-eDP-1-4 [568.050398] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [568.062678] Starting dynamic subtest: pipe-B-eDP-1-x [570.250611] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s) [570.620247] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [573.368410] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.755s) [573.381604] Starting dynamic subtest: pipe-C-eDP-1-4 [575.543337] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [575.554888] Starting dynamic subtest: pipe-C-eDP-1-4 [577.553389] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [577.563645] Starting dynamic subtest: pipe-C-eDP-1-x [579.744254] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s) [580.108630] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [582.894202] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.791s) [582.907339] Starting dynamic subtest: pipe-D-eDP-1-4 [585.068677] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [585.078910] Starting dynamic subtest: pipe-D-eDP-1-4 [587.079991] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [587.093608] Starting dynamic subtest: pipe-D-eDP-1-x [589.270536] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s) [589.273326] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.114s) [590.483841] [117/132] (433s left) kms_plane_multiple (tiling-4) [590.574287] Starting subtest: tiling-4 [590.576391] Starting dynamic subtest: pipe-A-eDP-1 [594.353471] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.777s) [594.363764] Starting dynamic subtest: pipe-B-eDP-1 [598.883540] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.526s) [598.894605] Starting dynamic subtest: pipe-C-eDP-1 [603.217182] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.331s) [603.228492] Starting dynamic subtest: pipe-D-eDP-1 [607.565504] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.345s) [607.568438] Subtest tiling-4: SUCCESS (16.986s) [608.367435] [118/132] (415s left) gen7_exec_parse (basic-offset) [608.434474] Subtest basic-offset: SKIP (0.000s) [608.518016] [119/132] (415s left) gem_eio (hibernate) [608.748186] Starting subtest: hibernate [623.377354] Subtest hibernate: SUCCESS (14.621s) [632.520765] [120/132] (400s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [632.651629] Starting subtest: primary-4-tiled-reflect-x-0 [640.134002] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.491s) [641.304650] [121/132] (391s left) prime_mmap (test_refcounting) [641.363386] Starting subtest: test_refcounting [641.365615] Starting dynamic subtest: test_refcounting-smem [641.392185] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s) [641.395473] Subtest test_refcounting: SUCCESS (0.031s) [641.501020] [122/132] (391s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [641.601600] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [641.606642] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [641.711540] [123/132] (391s left) gem_pxp (create-regular-context-2) [641.840016] Starting subtest: create-regular-context-2 [641.843252] Subtest create-regular-context-2: SUCCESS (0.002s) [641.958960] [124/132] (390s left) kms_cursor_crc (cursor-rapid-movement-64x64) [642.138772] Starting subtest: cursor-rapid-movement-64x64 [642.144402] Starting dynamic subtest: pipe-A-eDP-1 [642.672950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s) [642.702377] Starting dynamic subtest: pipe-D-eDP-1 [643.931232] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s) [643.933701] Subtest cursor-rapid-movement-64x64: SUCCESS (1.790s) [644.772686] [125/132] (388s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [644.872500] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [644.877933] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [644.972051] [126/132] (387s left) gem_pxp (verify-pxp-stale-buf-execution) [645.039765] Starting subtest: verify-pxp-stale-buf-execution [646.105164] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s) [646.224748] [127/132] (386s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [646.323310] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [646.328508] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [646.413145] [128/132] (386s left) perf_pmu (busy-double-start) [646.457612] Starting subtest: busy-double-start [646.460690] Starting dynamic subtest: rcs0 [650.107933] Dynamic subtest rcs0: FAIL (3.582s) [650.118921] Starting dynamic subtest: bcs0 [653.625111] Dynamic subtest bcs0: SUCCESS (3.589s) [653.638664] Starting dynamic subtest: vcs0 [657.280980] Dynamic subtest vcs0: SUCCESS (3.654s) [657.294347] Starting dynamic subtest: vcs1 [661.243121] Dynamic subtest vcs1: SUCCESS (3.960s) [661.257605] Starting dynamic subtest: vecs0 [665.259042] Dynamic subtest vecs0: SUCCESS (4.014s) [665.271874] Starting dynamic subtest: ccs0 [668.915479] Dynamic subtest ccs0: FAIL (3.567s) [668.917957] Subtest busy-double-start: FAIL (22.377s) [668.970621] [129/132] (364s left) syncobj_timeline (device-submit-unordered) [669.028579] Starting subtest: device-submit-unordered [669.031540] Subtest device-submit-unordered: SUCCESS (0.001s) [669.135492] [130/132] (363s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [669.239341] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [675.835555] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.600s) [675.950706] [131/132] (357s left) gem_userptr_blits (process-exit-busy) [676.016658] Starting subtest: process-exit-busy [676.027670] Subtest process-exit-busy: SUCCESS (0.014s) [676.155870] [132/132] (357s left) kms_lease (lease-unleased-crtc) [676.261343] Starting subtest: lease-unleased-crtc [676.264375] Starting dynamic subtest: pipe-A-eDP-1 [676.547540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [676.558850] Starting dynamic subtest: pipe-B-eDP-1 [677.270214] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.721s) [677.281957] Starting dynamic subtest: pipe-C-eDP-1 [677.284431] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [677.294533] Starting dynamic subtest: pipe-D-eDP-1 [677.297445] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [677.300289] Subtest lease-unleased-crtc: SUCCESS (1.022s) [677.623880] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: kms_psr2_su results: parsing output: 2/ for test: syncobj_wait results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: gem_exec_reloc results: parsing output: 6/ for test: i915_pm_rps results: parsing output: 7/ for test: kms_force_connector_basic results: parsing output: 8/ for test: kms_chamelium_hpd results: parsing output: 9/ for test: kms_joiner results: parsing output: 10/ for test: kms_ccs results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: i915_hangman results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: prime_vgem results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: kms_cursor_legacy results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: gem_exec_reloc results: parsing output: 20/ for test: kms_draw_crc results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: gem_mmap_gtt results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: kms_sequence results: parsing output: 26/ for test: gem_mmap_offset results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: gem_partial_pwrite_pread results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: gem_exec_fence results: parsing output: 31/ for test: syncobj_wait results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: gem_exec_parallel results: parsing output: 34/ for test: kms_prime results: parsing output: 35/ for test: kms_psr2_sf results: parsing output: 36/ for test: gem_exec_reloc results: parsing output: 37/ for test: kms_color results: parsing output: 38/ for test: kms_pipe_crc_basic results: parsing output: 39/ for test: gem_exec_store results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_plane_scaling results: parsing output: 42/ for test: kms_async_flips results: parsing output: 43/ for test: kms_psr results: parsing output: 44/ for test: gem_exec_balancer results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: gem_eio results: parsing output: 47/ for test: kms_plane results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: kms_rotation_crc results: parsing output: 50/ for test: gem_ringfill results: parsing output: 51/ for test: gem_eio results: parsing output: 52/ for test: kms_cursor_crc results: parsing output: 53/ for test: gem_exec_reloc results: parsing output: 54/ for test: kms_flip results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: gem_ccs results: parsing output: 57/ for test: syncobj_timeline results: parsing output: 58/ for test: kms_chamelium_color results: parsing output: 59/ for test: gem_mmap_gtt results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_ccs results: parsing output: 62/ for test: kms_flip_scaled_crc results: parsing output: 63/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: kms_vblank results: parsing output: 67/ for test: kms_psr results: parsing output: 68/ for test: perf_pmu results: parsing output: 69/ for test: kms_rotation_crc results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: gem_exec_params results: parsing output: 72/ for test: kms_chamelium_frames results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: syncobj_wait results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: prime_busy results: parsing output: 79/ for test: gem_lmem_evict results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_content_protection results: parsing output: 83/ for test: kms_hdr results: parsing output: 84/ for test: gem_sync results: parsing output: 85/ for test: i915_pm_rpm results: parsing output: 86/ for test: syncobj_wait results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_flip_scaled_crc results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_cursor_legacy results: parsing output: 91/ for test: gem_ctx_persistence results: parsing output: 92/ for test: device_reset results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: kms_plane results: parsing output: 96/ for test: perf results: parsing output: 97/ for test: kms_pm_backlight results: parsing output: 98/ for test: i915_drm_fdinfo results: parsing output: 99/ for test: kms_flip results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_pipe_crc_basic results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: gem_ctx_persistence results: parsing output: 104/ for test: kms_psr2_sf results: parsing output: 105/ for test: gem_exec_fence results: parsing output: 106/ for test: kms_addfb_basic results: parsing output: 107/ for test: gem_spin_batch results: parsing output: 108/ for test: gem_userptr_blits results: parsing output: 109/ for test: kms_flip results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: gem_close_race results: parsing output: 112/ for test: api_intel_bb results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_cursor_legacy results: parsing output: 115/ for test: kms_async_flips results: parsing output: 116/ for test: kms_plane_multiple results: parsing output: 117/ for test: gen7_exec_parse results: parsing output: 118/ for test: gem_eio results: parsing output: 119/ for test: kms_rotation_crc results: parsing output: 120/ for test: prime_mmap results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_pxp results: parsing output: 123/ for test: kms_cursor_crc results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: gem_pxp results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: perf_pmu results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_userptr_blits results: parsing output: 131/ for test: kms_lease Done.