[61.920363] Initializing watchdogs [61.920411] /dev/watchdog0 [61.935364] [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] [61.939948] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.942433] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.944335] [001/133] (960s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [63.077252] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [63.377261] [002/133] (959s left) i915_power (sanity) [63.434599] Starting subtest: sanity [67.495936] Subtest sanity: SUCCESS (4.047s) [68.961684] [003/133] (953s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [69.017442] Subtest no-spare-fences-interruptible: SKIP (0.000s) [69.075214] [004/133] (953s left) i915_module_load (resize-bar) [69.106991] Starting subtest: resize-bar [69.113174] Subtest resize-bar: SKIP (0.006s) [69.151634] [005/133] (953s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [69.236370] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [69.238480] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [69.312101] [006/133] (953s left) gem_fenced_exec_thrash (no-spare-fences) [69.368140] Subtest no-spare-fences: SKIP (0.000s) [69.430692] [007/133] (953s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [69.522469] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [69.523446] Starting dynamic subtest: pipe-A-eDP-1 [69.527316] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [69.535370] Starting dynamic subtest: pipe-B-eDP-1 [69.538743] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [69.544666] Starting dynamic subtest: pipe-C-eDP-1 [69.548305] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [69.554171] Starting dynamic subtest: pipe-D-eDP-1 [69.558586] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [69.560564] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s) [71.684343] [008/133] (950s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [71.776018] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [71.777906] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [71.865390] [009/133] (950s left) perf_pmu (busy-accuracy-50) [71.915803] Starting subtest: busy-accuracy-50 [71.916795] Starting dynamic subtest: rcs0 [73.458642] Dynamic subtest rcs0: SUCCESS (1.536s) [73.466861] Starting dynamic subtest: bcs0 [75.003794] Dynamic subtest bcs0: SUCCESS (1.546s) [75.013784] Starting dynamic subtest: vcs0 [76.543509] Dynamic subtest vcs0: SUCCESS (1.539s) [76.551443] Starting dynamic subtest: vcs1 [78.088971] Dynamic subtest vcs1: SUCCESS (1.544s) [78.097280] Starting dynamic subtest: vecs0 [79.630044] Dynamic subtest vecs0: SUCCESS (1.541s) [79.639344] Starting dynamic subtest: ccs0 [81.180990] Dynamic subtest ccs0: SUCCESS (1.547s) [81.182481] Subtest busy-accuracy-50: SUCCESS (9.258s) [81.288409] [010/133] (941s left) kms_flip (2x-nonexisting-fb-interruptible) [81.391229] Starting subtest: 2x-nonexisting-fb-interruptible [81.402729] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s) [81.472015] [011/133] (941s left) gem_exec_whisper (basic-queues-priority-all) [81.535420] Starting subtest: basic-queues-priority-all [101.473071] Subtest basic-queues-priority-all: SUCCESS (19.924s) [101.638780] [012/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [101.730744] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [101.732345] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [101.823860] [013/133] (920s left) kms_psr (psr2-primary-render) [101.906833] Starting subtest: psr2-primary-render [101.907873] Starting dynamic subtest: eDP-1 [103.700345] Dynamic subtest eDP-1: SUCCESS (1.794s) [103.701330] Subtest psr2-primary-render: SUCCESS (1.795s) [104.552046] [014/133] (918s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [104.644066] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [104.645827] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [104.728659] [015/133] (918s left) syncobj_wait (single-wait-signaled) [104.769894] Starting subtest: single-wait-signaled [104.770804] Subtest single-wait-signaled: SUCCESS (0.000s) [104.858980] [016/133] (918s left) kms_properties (plane-properties-legacy) [104.938948] Starting subtest: plane-properties-legacy [104.940164] Starting dynamic subtest: pipe-A-eDP-1 [105.522644] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s) [105.530473] Starting dynamic subtest: pipe-B-eDP-1 [106.829080] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.305s) [106.839321] Starting dynamic subtest: pipe-C-eDP-1 [108.067361] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.238s) [108.074343] Starting dynamic subtest: pipe-D-eDP-1 [109.308934] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s) [109.310589] Subtest plane-properties-legacy: SUCCESS (4.371s) [110.097411] [017/133] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [110.196860] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [110.198515] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [110.292679] [018/133] (912s left) kms_prime (basic-modeset-hybrid) [110.375678] Subtest basic-modeset-hybrid: SKIP (0.000s) [110.503965] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true [110.506185] [019/133] (912s left) syncobj_timeline (wait-all-for-submit-snapshot) [110.550965] Starting subtest: wait-all-for-submit-snapshot [110.632597] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [110.724199] [020/133] (912s left) gem_exec_schedule (semaphore-power) [110.907675] Subtest semaphore-power: SKIP (0.000s) [111.075820] [021/133] (912s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [111.169346] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [115.274363] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.105s) [116.405201] [022/133] (906s left) kms_cursor_crc (cursor-onscreen-512x512) [116.677822] Starting subtest: cursor-onscreen-512x512 [116.679510] Subtest cursor-onscreen-512x512: SKIP (0.001s) [116.840737] [023/133] (906s left) kms_big_fb (linear-32bpp-rotate-180) [116.937277] Starting subtest: linear-32bpp-rotate-180 [118.459801] Subtest linear-32bpp-rotate-180: SUCCESS (1.523s) [118.588871] [024/133] (904s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [118.639377] Starting subtest: multi-wait-all-for-submit-submitted-signaled [118.744778] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s) [118.839236] [025/133] (904s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [118.907583] Starting subtest: mixed-tiled-to-y-tiled-ccs [118.909321] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [119.088273] [026/133] (904s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [119.158553] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [119.221883] [027/133] (904s left) gem_partial_pwrite_pread (reads-display) [119.272312] Subtest reads-display: SKIP (0.000s) [119.346390] [028/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [119.466981] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [119.470573] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.003s) [119.632210] [029/133] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [119.729739] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [119.731414] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [119.810881] [030/133] (903s left) drm_buddy (drm_buddy) [119.838340] Starting subtest: drm_buddy [119.840418] Subtest drm_buddy: SKIP (0.001s) [119.885757] [031/133] (903s left) gem_userptr_blits (set-cache-level) [119.937102] Starting subtest: set-cache-level [119.938827] Subtest set-cache-level: SKIP (0.000s) [120.061384] [032/133] (903s left) kms_addfb_basic (bad-pitch-1024) [120.109679] Starting subtest: bad-pitch-1024 [120.110518] Subtest bad-pitch-1024: SUCCESS (0.000s) [120.244221] [033/133] (903s left) gem_exec_alignment (forked) [120.299075] Starting subtest: forked [160.105583] Subtest forked: SUCCESS (39.759s) [160.141054] [034/133] (863s left) prime_self_import (basic-with_one_bo) [160.213204] Starting subtest: basic-with_one_bo [160.226909] Subtest basic-with_one_bo: SUCCESS (0.014s) [160.344727] [035/133] (863s left) gem_exec_schedule (in-order) [160.408206] Starting subtest: in-order [160.409163] Starting dynamic subtest: rcs0 [160.589915] Dynamic subtest rcs0: SUCCESS (0.182s) [160.600515] Starting dynamic subtest: vcs0 [160.688746] Dynamic subtest vcs0: SUCCESS (0.099s) [160.699592] Starting dynamic subtest: vcs1 [160.798369] Dynamic subtest vcs1: SUCCESS (0.109s) [160.808494] Starting dynamic subtest: vecs0 [160.912576] Dynamic subtest vecs0: SUCCESS (0.114s) [160.921937] Starting dynamic subtest: ccs0 [161.039380] Dynamic subtest ccs0: SUCCESS (0.126s) [161.040927] Subtest in-order: SUCCESS (0.632s) [162.020799] [036/133] (861s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [162.127083] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [162.128055] Starting dynamic subtest: pipe-A-eDP-1 [162.150687] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [162.158764] Starting dynamic subtest: pipe-B-eDP-1 [162.179686] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [162.187463] Starting dynamic subtest: pipe-C-eDP-1 [162.208149] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [162.216839] Starting dynamic subtest: pipe-D-eDP-1 [162.237351] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [162.238981] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [164.361046] [037/133] (859s left) gem_softpin (32b-excludes-last-page) [164.415558] Starting subtest: 32b-excludes-last-page [164.420989] Subtest 32b-excludes-last-page: SUCCESS (0.005s) [164.539213] [038/133] (859s left) kms_rotation_crc (primary-rotation-90) [164.635600] Starting subtest: primary-rotation-90 [164.637355] Subtest primary-rotation-90: SKIP (0.001s) [164.713102] [039/133] (858s left) kms_psr (fbc-psr-cursor-render) [164.789069] Starting subtest: fbc-psr-cursor-render [164.790044] Starting dynamic subtest: eDP-1 [164.791850] Dynamic subtest eDP-1: SKIP (0.000s) [164.793580] Subtest fbc-psr-cursor-render: SKIP (0.000s) [164.857054] [040/133] (858s left) kms_psr (fbc-pr-sprite-mmap-gtt) [164.949399] Starting subtest: fbc-pr-sprite-mmap-gtt [164.951359] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [165.028935] [041/133] (858s left) kms_draw_crc (draw-method-mmap-cpu) [165.111512] Starting subtest: draw-method-mmap-cpu [165.112506] Starting dynamic subtest: xrgb8888-untiled [165.378207] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s) [165.385511] Starting dynamic subtest: rgb565-untiled [165.600178] Dynamic subtest rgb565-untiled: SUCCESS (0.222s) [165.608381] Starting dynamic subtest: xrgb2101010-untiled [165.822534] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [165.830958] Starting dynamic subtest: xbgr16161616f-untiled [166.055902] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s) [166.063313] Starting dynamic subtest: xrgb8888-xtiled [166.189185] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [166.196640] Starting dynamic subtest: rgb565-xtiled [166.322779] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [166.331919] Starting dynamic subtest: xrgb2101010-xtiled [166.444631] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [166.452081] Starting dynamic subtest: xbgr16161616f-xtiled [166.578231] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [166.587894] Starting dynamic subtest: xrgb8888-4tiled [166.722715] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [166.730997] Starting dynamic subtest: rgb565-4tiled [166.900208] Dynamic subtest rgb565-4tiled: SUCCESS (0.177s) [166.907337] Starting dynamic subtest: xrgb2101010-4tiled [167.077907] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.177s) [167.085303] Starting dynamic subtest: xbgr16161616f-4tiled [167.244756] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s) [167.245634] Subtest draw-method-mmap-cpu: SUCCESS (2.134s) [167.333790] [042/133] (856s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [167.421859] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [167.422614] Starting dynamic subtest: pipe-A-eDP-1 [167.429951] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [167.437267] Starting dynamic subtest: pipe-B-eDP-1 [167.444698] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [167.451988] Starting dynamic subtest: pipe-C-eDP-1 [167.459856] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [167.466753] Starting dynamic subtest: pipe-D-eDP-1 [167.474572] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [167.476068] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [169.639804] [043/133] (854s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [169.737277] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [192.851107] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.114s) [192.995800] [044/133] (830s left) gem_exec_capture (capture) [193.065627] Starting subtest: capture [193.066584] Starting dynamic subtest: rcs0-smem [193.899533] Dynamic subtest rcs0-smem: SUCCESS (0.833s) [193.912991] Starting dynamic subtest: bcs0-smem [194.725503] Dynamic subtest bcs0-smem: SUCCESS (0.825s) [194.733498] Starting dynamic subtest: vcs0-smem [195.550157] Dynamic subtest vcs0-smem: SUCCESS (0.826s) [195.559089] Starting dynamic subtest: vcs1-smem [196.871269] Dynamic subtest vcs1-smem: SUCCESS (1.318s) [196.879429] Starting dynamic subtest: vecs0-smem [197.711507] Dynamic subtest vecs0-smem: FAIL (0.820s) [197.720428] Starting dynamic subtest: ccs0-smem [199.016987] Dynamic subtest ccs0-smem: SUCCESS (1.325s) [199.018032] Subtest capture: FAIL (5.952s) [199.116706] [045/133] (824s left) perf_pmu (busy-hang) [199.152821] Starting subtest: busy-hang [199.153784] Starting dynamic subtest: rcs0 [200.390767] Dynamic subtest rcs0: SUCCESS (1.236s) [200.400391] Starting dynamic subtest: bcs0 [201.599695] Dynamic subtest bcs0: SUCCESS (1.208s) [201.610710] Starting dynamic subtest: vcs0 [203.414432] Dynamic subtest vcs0: SUCCESS (1.810s) [203.424257] Starting dynamic subtest: vcs1 [205.398265] Dynamic subtest vcs1: SUCCESS (1.982s) [205.408064] Starting dynamic subtest: vecs0 [207.447641] Dynamic subtest vecs0: SUCCESS (2.046s) [207.457056] Starting dynamic subtest: ccs0 [208.651880] Dynamic subtest ccs0: SUCCESS (1.205s) [208.653021] Subtest busy-hang: SUCCESS (9.498s) [208.744435] [046/133] (815s left) prime_vgem (basic-write) [208.818208] Starting subtest: basic-write [208.851965] Subtest basic-write: SKIP (0.033s) [208.964835] [047/133] (815s left) gem_exec_await (wide-all) [209.260087] Starting subtest: wide-all [232.606504] Subtest wide-all: SUCCESS (23.338s) [232.791673] [048/133] (791s left) kms_dirtyfb (psr-dirtyfb-ioctl) [232.927078] Starting subtest: psr-dirtyfb-ioctl [232.927932] Starting dynamic subtest: A-eDP-1 [236.768869] Dynamic subtest A-eDP-1: SUCCESS (3.840s) [236.769748] Subtest psr-dirtyfb-ioctl: SUCCESS (3.842s) [237.558778] [049/133] (786s left) kms_cursor_crc (cursor-size-hints) [237.683972] Starting subtest: cursor-size-hints [237.684943] Starting dynamic subtest: pipe-A-eDP-1 [238.329850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.645s) [238.338901] Starting dynamic subtest: pipe-D-eDP-1 [239.563151] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s) [239.563970] Subtest cursor-size-hints: SUCCESS (1.880s) [240.353624] [050/133] (783s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [240.447113] Starting subtest: addfb25-y-tiled-small-legacy [240.448800] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [240.556155] [051/133] (783s left) kms_psr (psr-primary-mmap-cpu) [240.642443] Starting subtest: psr-primary-mmap-cpu [240.643332] Starting dynamic subtest: eDP-1 [242.358249] Dynamic subtest eDP-1: SUCCESS (1.715s) [242.359045] Subtest psr-primary-mmap-cpu: SUCCESS (1.716s) [243.209215] [052/133] (780s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [243.302864] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [243.304759] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [243.394958] [053/133] (780s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [243.500175] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [244.181267] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s) [244.342285] [054/133] (779s left) gem_exec_balancer (bonded-false-hang) [244.596332] Starting subtest: bonded-false-hang [244.598328] Subtest bonded-false-hang: SKIP (0.000s) [244.687255] [055/133] (779s left) kms_getfb (getfb2-accept-nv12) [244.790552] Starting subtest: getfb2-accept-nv12 [244.791515] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [244.886925] [056/133] (779s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [244.944835] Subtest writes-after-reads: SKIP (0.000s) [245.011129] [057/133] (779s left) kms_content_protection (suspend-resume) [245.146674] Starting subtest: suspend-resume [245.148504] Subtest suspend-resume: SKIP (0.000s) [245.263179] [058/133] (779s left) gem_mmap_wc (bad-offset) [245.310838] Subtest bad-offset: SKIP (0.000s) [245.371529] [059/133] (779s left) gem_ppgtt (blt-vs-render-ctxn) [245.420069] Starting subtest: blt-vs-render-ctxN [278.131838] Subtest blt-vs-render-ctxN: SUCCESS (32.701s) [278.261880] [060/133] (746s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [278.396036] Starting subtest: crc-primary-basic-y-tiled-ccs [278.396816] Starting dynamic subtest: pipe-A-eDP-1 [278.404537] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [278.412616] Starting dynamic subtest: pipe-B-eDP-1 [278.420527] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [278.428243] Starting dynamic subtest: pipe-C-eDP-1 [278.437452] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [278.446768] Starting dynamic subtest: pipe-D-eDP-1 [278.455358] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [278.456829] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.012s) [280.669535] [061/133] (743s left) perf (whitelisted-registers-userspace-config) [280.807987] Starting subtest: whitelisted-registers-userspace-config [280.808829] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [280.843137] [062/133] (743s left) kms_invalid_mode (overflow-vrefresh) [280.934502] Starting subtest: overflow-vrefresh [280.935335] Starting dynamic subtest: pipe-A-eDP-1 [281.234851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s) [281.244588] Starting dynamic subtest: pipe-B-eDP-1 [281.245485] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [281.253065] Starting dynamic subtest: pipe-C-eDP-1 [281.253907] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [281.261264] Starting dynamic subtest: pipe-D-eDP-1 [281.262223] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [281.263038] Subtest overflow-vrefresh: SUCCESS (0.316s) [282.096883] [063/133] (742s left) gem_spin_batch (resubmit-new-all) [282.163637] Starting subtest: resubmit-new-all [282.164760] Starting dynamic subtest: rcs0 [282.176464] Dynamic subtest rcs0: SUCCESS (0.013s) [282.184983] Starting dynamic subtest: bcs0 [282.187976] Dynamic subtest bcs0: SUCCESS (0.011s) [282.195712] Starting dynamic subtest: vcs0 [282.198250] Dynamic subtest vcs0: SUCCESS (0.009s) [282.206222] Starting dynamic subtest: vcs1 [282.208359] Dynamic subtest vcs1: SUCCESS (0.010s) [282.216865] Starting dynamic subtest: vecs0 [282.220766] Dynamic subtest vecs0: SUCCESS (0.011s) [282.228188] Starting dynamic subtest: ccs0 [282.233175] Dynamic subtest ccs0: SUCCESS (0.011s) [282.234230] Subtest resubmit-new-all: SUCCESS (0.071s) [283.961788] [064/133] (740s left) api_intel_bb (simple-bb) [284.014421] Starting subtest: simple-bb [284.019508] Subtest simple-bb: SUCCESS (0.006s) [284.105363] [065/133] (740s left) syncobj_timeline (etime-multi-wait-all-submitted) [284.171195] Starting subtest: etime-multi-wait-all-submitted [284.272809] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s) [284.356797] [066/133] (740s left) kms_big_fb (y-tiled-8bpp-rotate-180) [284.456077] Starting subtest: y-tiled-8bpp-rotate-180 [284.457628] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [284.548496] [067/133] (740s left) kms_psr (fbc-pr-cursor-mmap-gtt) [284.653870] Starting subtest: fbc-pr-cursor-mmap-gtt [284.656114] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [284.723781] [068/133] (739s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [286.290641] Starting subtest: dpms-mode-unset-non-lpsp [287.456746] Subtest dpms-mode-unset-non-lpsp: SKIP (1.167s) [287.828837] [069/133] (736s left) gem_ctx_param (root-set) [287.880633] Starting subtest: root-set [287.881721] Subtest root-set: SUCCESS (0.001s) [287.977798] [070/133] (736s left) syncobj_timeline (device-submit-unordered) [288.025845] Starting subtest: device-submit-unordered [288.026820] Subtest device-submit-unordered: SUCCESS (0.000s) [288.128761] [071/133] (736s left) gem_readwrite (read-write) [288.193067] Subtest read-write: SKIP (0.000s) [288.252131] [072/133] (736s left) gem_exec_schedule (u-submit-late-slice) [288.335379] Starting subtest: u-submit-late-slice [288.336277] Starting dynamic subtest: rcs0 [288.373935] Dynamic subtest rcs0: SUCCESS (0.039s) [288.383082] Starting dynamic subtest: bcs0 [288.410376] Dynamic subtest bcs0: SUCCESS (0.034s) [288.418486] Starting dynamic subtest: vcs0 [288.445367] Dynamic subtest vcs0: SUCCESS (0.034s) [288.453427] Starting dynamic subtest: vcs1 [288.480595] Dynamic subtest vcs1: SUCCESS (0.034s) [288.488569] Starting dynamic subtest: vecs0 [288.512237] Dynamic subtest vecs0: SUCCESS (0.031s) [288.519879] Starting dynamic subtest: ccs0 [288.553131] Dynamic subtest ccs0: SUCCESS (0.040s) [288.554268] Subtest u-submit-late-slice: SUCCESS (0.220s) [290.033787] [073/133] (734s left) sriov_basic (enable-vfs-autoprobe-on) [290.089201] Starting subtest: enable-vfs-autoprobe-on [290.090288] Starting dynamic subtest: numvfs-1 [290.125196] Dynamic subtest numvfs-1: FAIL (0.016s) [290.134424] Starting dynamic subtest: numvfs-2 [290.162212] Dynamic subtest numvfs-2: FAIL (0.004s) [290.169924] Starting dynamic subtest: numvfs-3 [290.196206] Dynamic subtest numvfs-3: FAIL (0.004s) [290.203777] Starting dynamic subtest: numvfs-4 [290.230402] Dynamic subtest numvfs-4: FAIL (0.004s) [290.239774] Starting dynamic subtest: numvfs-5 [290.265979] Dynamic subtest numvfs-5: FAIL (0.004s) [290.274346] Starting dynamic subtest: numvfs-6 [290.301610] Dynamic subtest numvfs-6: FAIL (0.004s) [290.308935] Starting dynamic subtest: numvfs-7 [290.335117] Dynamic subtest numvfs-7: FAIL (0.004s) [290.342285] Starting dynamic subtest: numvfs-random [290.367343] Dynamic subtest numvfs-random: FAIL (0.004s) [290.374661] Starting dynamic subtest: numvfs-all [290.400501] Dynamic subtest numvfs-all: FAIL (0.004s) [290.401344] Subtest enable-vfs-autoprobe-on: FAIL (0.054s) [290.431997] [074/133] (734s left) kms_plane_multiple (2x-tiling-y) [290.519227] Starting subtest: 2x-tiling-y [290.520897] Subtest 2x-tiling-y: SKIP (0.000s) [290.625130] [075/133] (734s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [290.729838] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [290.731772] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [290.835415] [076/133] (734s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [290.924350] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [290.925188] Starting dynamic subtest: pipe-A-eDP-1 [290.934536] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [290.942693] Starting dynamic subtest: pipe-B-eDP-1 [290.952224] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [290.960598] Starting dynamic subtest: pipe-C-eDP-1 [290.969267] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [290.978065] Starting dynamic subtest: pipe-D-eDP-1 [290.987255] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [290.988796] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [293.175660] [077/133] (731s left) gem_userptr_blits (process-exit-busy) [293.236607] Starting subtest: process-exit-busy [293.252031] Subtest process-exit-busy: SUCCESS (0.015s) [293.368665] [078/133] (731s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [293.458319] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [293.460019] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [293.549358] [079/133] (731s left) kms_vblank (ts-continuation-modeset-rpm) [293.641382] Starting subtest: ts-continuation-modeset-rpm [293.642263] Starting dynamic subtest: pipe-A-eDP-1 [296.178512] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.535s) [296.188809] Starting dynamic subtest: pipe-D-eDP-1 [298.418057] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.238s) [298.418898] Subtest ts-continuation-modeset-rpm: SUCCESS (4.777s) [299.212655] [080/133] (725s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [299.305373] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [300.473069] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.168s) [300.579690] [081/133] (724s left) syncobj_wait (multi-wait-all-for-submit-signaled) [300.630286] Starting subtest: multi-wait-all-for-submit-signaled [300.631182] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [300.714026] [082/133] (724s left) kms_plane (plane-panning-top-left) [300.798066] Starting subtest: plane-panning-top-left [300.800061] Starting dynamic subtest: pipe-A [302.466208] Dynamic subtest pipe-A: SUCCESS (1.666s) [302.483311] Starting dynamic subtest: pipe-B [304.845524] Dynamic subtest pipe-B: SUCCESS (2.378s) [304.846689] Subtest plane-panning-top-left: SUCCESS (4.048s) [305.716431] [083/133] (719s left) gem_exec_parallel (userptr) [305.779849] Starting subtest: userptr [305.780775] Starting dynamic subtest: rcs0 [307.217101] Dynamic subtest rcs0: SUCCESS (1.437s) [307.227866] Starting dynamic subtest: bcs0 [308.696771] Dynamic subtest bcs0: SUCCESS (1.478s) [308.707158] Starting dynamic subtest: vcs0 [311.900890] Dynamic subtest vcs0: SUCCESS (3.192s) [311.911676] Starting dynamic subtest: vcs1 [313.876720] Dynamic subtest vcs1: SUCCESS (1.982s) [313.887309] Starting dynamic subtest: vecs0 [315.868545] Dynamic subtest vecs0: SUCCESS (1.981s) [315.876849] Starting dynamic subtest: ccs0 [317.364071] Dynamic subtest ccs0: SUCCESS (1.502s) [317.367123] Subtest userptr: SUCCESS (11.585s) [317.548217] [084/133] (707s left) kms_hdmi_inject (inject-4k) [317.891084] Starting subtest: inject-4k [318.206119] Subtest inject-4k: SUCCESS (0.316s) [318.771876] [085/133] (706s left) kms_chamelium_edid (hdmi-mode-timings) [319.145635] Subtest hdmi-mode-timings: SKIP (0.000s) [319.922758] [086/133] (705s left) syncobj_wait (multi-wait-for-submit-submitted) [319.975035] Starting subtest: multi-wait-for-submit-submitted [320.080658] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s) [320.164806] [087/133] (705s left) gem_exec_schedule (smoketest-all) [320.236744] Starting subtest: smoketest-all [352.600466] Subtest smoketest-all: SUCCESS (32.334s) [353.959981] [088/133] (671s left) sysfs_heartbeat_interval (mixed) [354.009642] Starting subtest: mixed [354.010571] Starting dynamic subtest: vecs0 [359.201756] Dynamic subtest vecs0: SUCCESS (5.190s) [359.212471] Starting dynamic subtest: ccs0 [364.459942] Dynamic subtest ccs0: SUCCESS (5.258s) [364.471323] Starting dynamic subtest: vcs0 [369.687771] Dynamic subtest vcs0: SUCCESS (5.225s) [369.697784] Starting dynamic subtest: bcs0 [374.881682] Dynamic subtest bcs0: SUCCESS (5.193s) [374.892459] Starting dynamic subtest: rcs0 [380.116826] Dynamic subtest rcs0: SUCCESS (5.233s) [380.127054] Starting dynamic subtest: vcs1 [385.299273] Dynamic subtest vcs1: SUCCESS (5.181s) [385.300582] Subtest mixed: SUCCESS (31.289s) [385.372761] [089/133] (640s left) kms_cursor_crc (cursor-sliding-512x512) [385.658211] Starting subtest: cursor-sliding-512x512 [385.659862] Subtest cursor-sliding-512x512: SKIP (0.001s) [385.805259] [090/133] (639s left) perf (sysctl-defaults) [385.872616] Starting subtest: sysctl-defaults [385.873634] Subtest sysctl-defaults: SUCCESS (0.000s) [385.932595] [091/133] (639s left) gem_ctx_persistence (legacy-engines-hostile) [385.990890] Starting subtest: legacy-engines-hostile [385.991893] Starting dynamic subtest: render [386.069646] Dynamic subtest render: SUCCESS (0.077s) [386.079868] Starting dynamic subtest: bsd1 [386.156939] Dynamic subtest bsd1: SUCCESS (0.084s) [386.168624] Starting dynamic subtest: bsd2 [386.251458] Dynamic subtest bsd2: SUCCESS (0.092s) [386.263861] Starting dynamic subtest: blt [386.341488] Dynamic subtest blt: SUCCESS (0.087s) [386.353244] Starting dynamic subtest: vebox [386.430508] Dynamic subtest vebox: SUCCESS (0.086s) [386.431822] Subtest legacy-engines-hostile: SUCCESS (0.441s) [386.517738] [092/133] (639s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [386.608837] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [386.609691] Starting dynamic subtest: pipe-A-eDP-1 [386.758726] Dynamic subtest pipe-A-eDP-1: SKIP (0.149s) [386.767562] Starting dynamic subtest: pipe-B-eDP-1 [387.892971] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s) [387.894742] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.285s) [389.048176] [093/133] (636s left) kms_flip (basic-flip-vs-dpms) [389.143498] Starting subtest: basic-flip-vs-dpms [389.146249] Starting dynamic subtest: A-eDP1 [391.685936] Dynamic subtest A-eDP1: SUCCESS (2.540s) [391.695673] Starting dynamic subtest: B-eDP1 [393.887343] Dynamic subtest B-eDP1: SUCCESS (2.197s) [393.896612] Starting dynamic subtest: C-eDP1 [396.071515] Dynamic subtest C-eDP1: SUCCESS (2.182s) [396.082479] Starting dynamic subtest: D-eDP1 [398.276253] Dynamic subtest D-eDP1: SUCCESS (2.203s) [398.278172] Subtest basic-flip-vs-dpms: SUCCESS (9.135s) [399.140362] [094/133] (626s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [399.234462] Starting subtest: plane-scaler-with-clipping-clamping-rotation [399.235441] Starting dynamic subtest: pipe-A [399.473496] Dynamic subtest pipe-A: SUCCESS (0.240s) [399.481739] Starting dynamic subtest: pipe-B [400.837552] Dynamic subtest pipe-B: SUCCESS (1.363s) [400.846713] Starting dynamic subtest: pipe-C [402.095788] Dynamic subtest pipe-C: SUCCESS (1.256s) [402.105050] Starting dynamic subtest: pipe-D [403.416645] Dynamic subtest pipe-D: SUCCESS (1.319s) [403.417539] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.184s) [404.555792] [095/133] (621s left) gem_mmap_gtt (cpuset-basic-small-copy) [404.616301] Subtest cpuset-basic-small-copy: SKIP (0.000s) [404.674373] [096/133] (621s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [404.770478] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [411.712550] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.942s) [411.830848] [097/133] (613s left) gem_exec_fence (syncobj-channel) [412.310777] Starting subtest: syncobj-channel [413.339276] Subtest syncobj-channel: SUCCESS (1.019s) [414.003404] [098/133] (611s left) gem_ctx_param (invalid-get-engines) [414.049897] Starting subtest: invalid-get-engines [414.050898] Subtest invalid-get-engines: SUCCESS (0.001s) [414.175598] [099/133] (611s left) gem_exec_flush (basic-wb-rw-before-default) [414.249966] Starting subtest: basic-wb-rw-before-default [419.714166] Subtest basic-wb-rw-before-default: SUCCESS (5.465s) [419.909167] [100/133] (605s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [419.995064] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [419.996797] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [420.064353] [101/133] (605s left) gem_mmap_gtt (zero-extend) [420.108021] Subtest zero-extend: SKIP (0.000s) [420.162936] [102/133] (605s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [420.259932] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [421.283482] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.024s) [421.404696] [103/133] (604s left) gem_exec_flush (basic-batch-kernel-default-uc) [421.461249] Starting subtest: basic-batch-kernel-default-uc [428.670918] Subtest basic-batch-kernel-default-uc: SUCCESS (7.209s) [428.855548] [104/133] (597s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [428.947593] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [428.949336] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [429.047364] [105/133] (596s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [429.137065] Starting subtest: flip-vs-dpms-on-nop-interruptible [429.139815] Starting dynamic subtest: A-eDP1 [430.997521] Dynamic subtest A-eDP1: SUCCESS (1.858s) [431.007451] Starting dynamic subtest: B-eDP1 [432.806435] Dynamic subtest B-eDP1: SUCCESS (1.807s) [432.817823] Starting dynamic subtest: C-eDP1 [434.599748] Dynamic subtest C-eDP1: SUCCESS (1.788s) [434.609374] Starting dynamic subtest: D-eDP1 [436.387223] Dynamic subtest D-eDP1: SUCCESS (1.788s) [436.391684] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.254s) [437.528077] [106/133] (588s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [437.624119] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [444.129067] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.506s) [444.265710] [107/133] (581s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [444.372559] Starting subtest: psr-rgb101010-draw-mmap-gtt [444.374267] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [444.463366] [108/133] (581s left) i915_drm_fdinfo (virtual-busy) [444.500049] Starting subtest: virtual-busy [444.501688] Subtest virtual-busy: SKIP (0.000s) [444.597601] [109/133] (581s left) gem_mmap_gtt (basic-small-copy-odd) [444.653095] Subtest basic-small-copy-odd: SKIP (0.000s) [444.716511] [110/133] (581s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [444.818923] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [444.820676] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [444.910832] [111/133] (581s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [445.008454] Starting subtest: basic-max-pipe-crc-check [445.010357] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [445.050357] [112/133] (581s left) api_intel_allocator (fork-simple-stress-signal) [445.102120] Starting subtest: fork-simple-stress-signal [450.550918] Subtest fork-simple-stress-signal: SUCCESS (5.404s) [450.631651] [113/133] (575s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [450.727291] Starting subtest: primary-y-tiled-reflect-x-0 [450.799131] Subtest primary-y-tiled-reflect-x-0: SKIP (0.071s) [450.903671] [114/133] (575s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [451.002552] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [458.305795] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.303s) [458.426853] [115/133] (568s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping) [458.533535] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping [458.535295] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [458.601535] [116/133] (567s left) gem_create (create-ext-placement-all) [458.778309] Starting subtest: create-ext-placement-all [458.779267] Subtest create-ext-placement-all: SUCCESS (0.000s) [458.887290] [117/133] (567s left) gem_ctx_create (basic) [458.948195] Starting subtest: basic [458.949108] Subtest basic: SUCCESS (0.000s) [459.131881] [118/133] (567s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [459.170386] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [459.171452] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [459.276635] [119/133] (567s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [459.319109] Starting subtest: invalid-multi-wait-unsubmitted-submitted [459.319964] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [459.422858] [120/133] (567s left) gen9_exec_parse (bb-secure) [459.480685] Subtest bb-secure: SKIP (0.000s) [459.546938] [121/133] (567s left) kms_psr (pr-primary-page-flip) [459.638755] Starting subtest: pr-primary-page-flip [459.641066] Subtest pr-primary-page-flip: SKIP (0.000s) [459.708445] [122/133] (566s left) kms_flip (blocking-wf_vblank) [459.793575] Starting subtest: blocking-wf_vblank [459.796696] Starting dynamic subtest: A-eDP1 [468.773325] Dynamic subtest A-eDP1: SUCCESS (8.951s) [468.783632] Starting dynamic subtest: B-eDP1 [477.677592] Dynamic subtest B-eDP1: SUCCESS (8.900s) [477.687116] Starting dynamic subtest: C-eDP1 [486.573907] Dynamic subtest C-eDP1: SUCCESS (8.881s) [486.584529] Starting dynamic subtest: D-eDP1 [495.473474] Dynamic subtest D-eDP1: SUCCESS (8.899s) [495.474421] Subtest blocking-wf_vblank: SUCCESS (35.649s) [496.631243] [123/133] (530s left) kms_color_pipeline (plane-lut1d-lut1d) [496.715123] Starting subtest: plane-lut1d-lut1d [496.885727] Starting dynamic subtest: pipe-A-plane-0 [497.062494] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s) [497.078528] Starting dynamic subtest: pipe-A-plane-1 [497.228973] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [497.237393] Starting dynamic subtest: pipe-A-plane-2 [497.398596] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [498.606187] Starting dynamic subtest: pipe-B-plane-0 [498.775908] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [498.784217] Starting dynamic subtest: pipe-B-plane-1 [498.964789] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [498.978337] Starting dynamic subtest: pipe-B-plane-2 [499.131695] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [500.308730] Starting dynamic subtest: pipe-C-plane-0 [500.439062] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [500.448684] Starting dynamic subtest: pipe-C-plane-1 [500.605553] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [500.614511] Starting dynamic subtest: pipe-C-plane-2 [500.749974] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s) [502.002463] Starting dynamic subtest: pipe-D-plane-0 [502.150032] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s) [502.159044] Starting dynamic subtest: pipe-D-plane-1 [502.305768] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [502.314105] Starting dynamic subtest: pipe-D-plane-2 [502.461159] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [502.749718] Subtest plane-lut1d-lut1d: SUCCESS (6.034s) [503.565923] [124/133] (523s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [503.663712] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [510.229257] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.566s) [510.363271] [125/133] (516s left) kms_universal_plane (universal-plane-functional) [510.448979] Starting subtest: universal-plane-functional [510.449905] Starting dynamic subtest: pipe-A-eDP-1 [514.573447] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.123s) [514.585583] Starting dynamic subtest: pipe-B-eDP-1 [519.259903] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.685s) [519.269143] Starting dynamic subtest: pipe-C-eDP-1 [523.606455] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.344s) [523.617069] Starting dynamic subtest: pipe-D-eDP-1 [528.004110] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.393s) [528.004943] Subtest universal-plane-functional: SUCCESS (17.554s) [528.857592] [126/133] (498s left) kms_lease (lease-unleased-connector) [528.950219] Starting subtest: lease-unleased-connector [528.951070] Starting dynamic subtest: pipe-A-eDP-1 [528.958515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s) [528.970810] Starting dynamic subtest: pipe-B-eDP-1 [528.971640] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [528.979952] Starting dynamic subtest: pipe-C-eDP-1 [528.980869] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s) [528.988792] Starting dynamic subtest: pipe-D-eDP-1 [528.989818] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [528.990677] Subtest lease-unleased-connector: SUCCESS (0.031s) [529.080383] [127/133] (497s left) gem_exec_reloc (basic-gtt-wc-active) [529.126112] Subtest basic-gtt-wc-active: SKIP (0.000s) [529.188854] [128/133] (497s left) kms_getfb (getfb-handle-zero) [529.279695] Starting subtest: getfb-handle-zero [529.280594] Subtest getfb-handle-zero: SUCCESS (0.000s) [529.377814] [129/133] (497s left) i915_pm_rps (reset) [529.437268] Starting subtest: reset [537.916877] Subtest reset: SUCCESS (8.473s) [538.025325] [130/133] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [538.123262] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [544.827804] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.696s) [544.947855] [131/133] (482s left) kms_async_flips (test-cursor-atomic) [545.046841] Starting subtest: test-cursor-atomic [545.423077] Starting dynamic subtest: pipe-A-eDP-1 [546.181772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.760s) [546.562346] Starting dynamic subtest: pipe-B-eDP-1 [547.394285] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.839s) [547.792085] Starting dynamic subtest: pipe-C-eDP-1 [548.583449] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.801s) [548.958660] Starting dynamic subtest: pipe-D-eDP-1 [549.794053] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.843s) [549.794939] Subtest test-cursor-atomic: SUCCESS (4.748s) [551.023343] [132/133] (476s left) gem_exec_reloc (basic-gtt-wc) [551.075191] Subtest basic-gtt-wc: SKIP (0.000s) [551.131710] [133/133] (475s left) fbdev (pan) [551.166390] Starting subtest: pan [551.200838] Subtest pan: SUCCESS (0.034s) [551.265625] Closing watchdogs results: parsing output: 0/ for test: kms_chamelium_hpd results: parsing output: 1/ for test: i915_power results: parsing output: 2/ for test: gem_fenced_exec_thrash results: parsing output: 3/ for test: i915_module_load results: parsing output: 4/ for test: kms_psr2_sf results: parsing output: 5/ for test: gem_fenced_exec_thrash results: parsing output: 6/ for test: kms_ccs results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: perf_pmu results: parsing output: 9/ for test: kms_flip results: parsing output: 10/ for test: gem_exec_whisper results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: syncobj_wait results: parsing output: 15/ for test: kms_properties results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_prime results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: gem_exec_schedule results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_cursor_crc results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: syncobj_wait results: parsing output: 24/ for test: gem_render_copy results: parsing output: 25/ for test: gem_exec_reloc results: parsing output: 26/ for test: gem_partial_pwrite_pread results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: drm_buddy results: parsing output: 30/ for test: gem_userptr_blits results: parsing output: 31/ for test: kms_addfb_basic results: parsing output: 32/ for test: gem_exec_alignment results: parsing output: 33/ for test: prime_self_import results: parsing output: 34/ for test: gem_exec_schedule results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: gem_softpin results: parsing output: 37/ for test: kms_rotation_crc results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: kms_draw_crc results: parsing output: 41/ for test: kms_ccs results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_exec_capture results: parsing output: 44/ for test: perf_pmu results: parsing output: 45/ for test: prime_vgem results: parsing output: 46/ for test: gem_exec_await results: parsing output: 47/ for test: kms_dirtyfb results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: kms_addfb_basic results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: gem_exec_balancer results: parsing output: 54/ for test: kms_getfb results: parsing output: 55/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 56/ for test: kms_content_protection results: parsing output: 57/ for test: gem_mmap_wc results: parsing output: 58/ for test: gem_ppgtt results: parsing output: 59/ for test: kms_ccs results: parsing output: 60/ for test: perf results: parsing output: 61/ for test: kms_invalid_mode results: parsing output: 62/ for test: gem_spin_batch results: parsing output: 63/ for test: api_intel_bb results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: kms_psr results: parsing output: 67/ for test: kms_pm_rpm results: parsing output: 68/ for test: gem_ctx_param results: parsing output: 69/ for test: syncobj_timeline results: parsing output: 70/ for test: gem_readwrite results: parsing output: 71/ for test: gem_exec_schedule results: parsing output: 72/ for test: sriov_basic results: parsing output: 73/ for test: kms_plane_multiple results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_vblank results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: syncobj_wait results: parsing output: 81/ for test: kms_plane results: parsing output: 82/ for test: gem_exec_parallel results: parsing output: 83/ for test: kms_hdmi_inject results: parsing output: 84/ for test: kms_chamelium_edid results: parsing output: 85/ for test: syncobj_wait results: parsing output: 86/ for test: gem_exec_schedule results: parsing output: 87/ for test: sysfs_heartbeat_interval results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: perf results: parsing output: 90/ for test: gem_ctx_persistence results: parsing output: 91/ for test: kms_psr2_sf results: parsing output: 92/ for test: kms_flip results: parsing output: 93/ for test: kms_plane_scaling results: parsing output: 94/ for test: gem_mmap_gtt results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: gem_exec_fence results: parsing output: 97/ for test: gem_ctx_param results: parsing output: 98/ for test: gem_exec_flush results: parsing output: 99/ for test: kms_flip_scaled_crc results: parsing output: 100/ for test: gem_mmap_gtt results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: gem_exec_flush results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: i915_drm_fdinfo results: parsing output: 108/ for test: gem_mmap_gtt results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_multipipe_modeset results: parsing output: 111/ for test: api_intel_allocator results: parsing output: 112/ for test: kms_rotation_crc results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_plane results: parsing output: 115/ for test: gem_create results: parsing output: 116/ for test: gem_ctx_create results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: gen9_exec_parse results: parsing output: 120/ for test: kms_psr results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: kms_color_pipeline results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_universal_plane results: parsing output: 125/ for test: kms_lease results: parsing output: 126/ for test: gem_exec_reloc results: parsing output: 127/ for test: kms_getfb results: parsing output: 128/ for test: i915_pm_rps results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_async_flips results: parsing output: 131/ for test: gem_exec_reloc results: parsing output: 132/ for test: fbdev Done.