[62.623541] Initializing watchdogs [62.623586] /dev/watchdog0 [62.637818] [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] [62.642119] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.644306] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.647679] [001/133] (960s left) kms_addfb_basic (unused-offsets) [62.720722] Starting subtest: unused-offsets [62.723010] Subtest unused-offsets: SUCCESS (0.000s) [62.874775] [002/133] (960s left) gem_exec_params (larger-than-life-batch) [62.933280] Starting subtest: larger-than-life-batch [65.207959] Subtest larger-than-life-batch: SUCCESS (2.280s) [65.926077] [003/133] (957s left) kms_draw_crc (draw-method-blt) [66.065141] Starting subtest: draw-method-blt [66.067437] Starting dynamic subtest: xrgb8888-untiled [66.297184] Dynamic subtest xrgb8888-untiled: SUCCESS (0.234s) [66.305254] Starting dynamic subtest: rgb565-untiled [66.541054] Dynamic subtest rgb565-untiled: SUCCESS (0.244s) [66.548382] Starting dynamic subtest: xrgb2101010-untiled [66.773757] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s) [66.782890] Starting dynamic subtest: xbgr16161616f-untiled [66.995500] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s) [67.004109] Starting dynamic subtest: xrgb8888-xtiled [67.117340] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s) [67.126135] Starting dynamic subtest: rgb565-xtiled [67.239368] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [67.252366] Starting dynamic subtest: xrgb2101010-xtiled [67.350474] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [67.360499] Starting dynamic subtest: xbgr16161616f-xtiled [67.450270] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.100s) [67.458335] Starting dynamic subtest: xrgb8888-4tiled [67.560968] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.109s) [67.569695] Starting dynamic subtest: rgb565-4tiled [67.671777] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s) [67.679383] Starting dynamic subtest: xrgb2101010-4tiled [67.771598] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s) [67.780284] Starting dynamic subtest: xbgr16161616f-4tiled [67.882383] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.111s) [67.884481] Subtest draw-method-blt: SUCCESS (1.823s) [68.000129] [004/133] (955s left) gem_exec_reloc (basic-write-read-active) [68.063125] Subtest basic-write-read-active: SKIP (0.000s) [68.142739] [005/133] (955s left) vgem_basic (busy-fence) [68.266371] Starting subtest: busy-fence [68.268264] Subtest busy-fence: SUCCESS (0.000s) [68.318971] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true [68.321750] [006/133] (955s left) gem_eio (in-flight-suspend) [68.469687] Starting subtest: in-flight-suspend [111.508093] Subtest in-flight-suspend: SUCCESS (13.331s) [111.658685] [007/133] (911s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [111.761099] Starting subtest: missing-ccs-buffer-y-tiled-ccs [111.763313] Starting dynamic subtest: pipe-A-eDP-1 [111.793927] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [111.802435] Starting dynamic subtest: pipe-B-eDP-1 [111.823879] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [111.832031] Starting dynamic subtest: pipe-C-eDP-1 [111.853120] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [111.865055] Starting dynamic subtest: pipe-D-eDP-1 [111.885979] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [111.889965] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s) [114.002355] [008/133] (909s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [114.100018] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [114.104593] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [114.196436] [009/133] (909s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [114.290660] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [114.295040] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [114.362247] [010/133] (909s left) kms_flip (absolute-wf_vblank) [114.454774] Starting subtest: absolute-wf_vblank [114.457225] Starting dynamic subtest: A-eDP1 [123.233668] Dynamic subtest A-eDP1: SUCCESS (8.899s) [123.244949] Starting dynamic subtest: B-eDP1 [131.913959] Dynamic subtest B-eDP1: SUCCESS (8.719s) [131.927671] Starting dynamic subtest: C-eDP1 [140.615870] Dynamic subtest C-eDP1: SUCCESS (8.714s) [140.627845] Starting dynamic subtest: D-eDP1 [149.336639] Dynamic subtest D-eDP1: SUCCESS (8.722s) [149.339004] Subtest absolute-wf_vblank: SUCCESS (35.059s) [150.549738] [011/133] (872s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [150.660647] Starting subtest: yf-tiled-32bpp-rotate-90 [150.664902] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [150.765097] [012/133] (872s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [150.866175] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [150.870366] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [150.937665] [013/133] (872s left) i915_pm_rpm (debugfs-forcewake-user) [152.777178] Starting subtest: debugfs-forcewake-user [164.176373] Subtest debugfs-forcewake-user: SUCCESS (11.403s) [164.555983] [014/133] (859s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [164.666462] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [165.490822] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s) [165.651193] [015/133] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [165.775668] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [165.779648] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [165.879678] [016/133] (857s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [165.980165] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [165.984791] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [166.070082] [017/133] (857s left) kms_flip (nonexisting-fb-interruptible) [166.169682] Starting subtest: nonexisting-fb-interruptible [166.172048] Starting dynamic subtest: A-eDP1 [167.325927] Dynamic subtest A-eDP1: SUCCESS (1.156s) [167.337378] Starting dynamic subtest: B-eDP1 [168.461232] Dynamic subtest B-eDP1: SUCCESS (1.135s) [168.472641] Starting dynamic subtest: C-eDP1 [169.592915] Dynamic subtest C-eDP1: SUCCESS (1.131s) [169.604678] Starting dynamic subtest: D-eDP1 [170.725840] Dynamic subtest D-eDP1: SUCCESS (1.132s) [170.728185] Subtest nonexisting-fb-interruptible: SUCCESS (4.561s) [171.897942] [018/133] (851s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [171.987266] Starting subtest: primary-y-tiled-reflect-x-0 [172.046909] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s) [172.149731] [019/133] (851s left) gem_exec_params (sol-reset-invalid) [172.196955] Starting subtest: sol-reset-invalid [172.199093] Subtest sol-reset-invalid: SUCCESS (0.003s) [173.658762] [020/133] (850s left) gem_ctx_isolation (preservation-reset) [173.836926] Starting subtest: preservation-reset [173.839576] Starting dynamic subtest: rcs0 [174.110048] Dynamic subtest rcs0: SUCCESS (0.276s) [174.120967] Starting dynamic subtest: bcs0 [174.386071] Dynamic subtest bcs0: SUCCESS (0.276s) [174.395849] Starting dynamic subtest: vcs0 [174.693841] Dynamic subtest vcs0: SUCCESS (0.307s) [174.704502] Starting dynamic subtest: vcs1 [175.875332] Dynamic subtest vcs1: SUCCESS (1.181s) [175.886101] Starting dynamic subtest: vecs0 [177.958708] Dynamic subtest vecs0: SUCCESS (2.084s) [177.969828] Starting dynamic subtest: ccs0 [179.893325] Dynamic subtest ccs0: SUCCESS (1.933s) [179.896253] Subtest preservation-reset: SUCCESS (6.063s) [180.017506] [021/133] (843s left) gem_exec_reloc (basic-write-read-noreloc) [180.077279] Subtest basic-write-read-noreloc: SKIP (0.000s) [180.162870] [022/133] (843s left) kms_big_fb (y-tiled-8bpp-rotate-270) [180.269074] Starting subtest: y-tiled-8bpp-rotate-270 [180.273290] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [180.377715] [023/133] (843s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [180.475784] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [180.478418] Starting dynamic subtest: pipe-A [180.494839] Dynamic subtest pipe-A: SKIP (0.016s) [180.508937] Starting dynamic subtest: pipe-B [180.521672] Dynamic subtest pipe-B: SKIP (0.028s) [180.535212] Starting dynamic subtest: pipe-C [180.552053] Dynamic subtest pipe-C: SKIP (0.028s) [180.563507] Starting dynamic subtest: pipe-D [180.578573] Dynamic subtest pipe-D: SKIP (0.028s) [180.583136] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.100s) [180.682848] [024/133] (843s left) gem_exec_schedule (u-fairslice) [180.762777] Starting subtest: u-fairslice [180.764837] Starting dynamic subtest: rcs0 [182.795055] Dynamic subtest rcs0: SUCCESS (2.030s) [182.804140] Starting dynamic subtest: bcs0 [184.813123] Dynamic subtest bcs0: SUCCESS (2.020s) [184.823161] Starting dynamic subtest: vcs0 [186.837658] Dynamic subtest vcs0: SUCCESS (2.023s) [186.847745] Starting dynamic subtest: vcs1 [188.857216] Dynamic subtest vcs1: SUCCESS (2.019s) [188.867333] Starting dynamic subtest: vecs0 [190.875633] Dynamic subtest vecs0: SUCCESS (2.019s) [190.885507] Starting dynamic subtest: ccs0 [192.897703] Dynamic subtest ccs0: SUCCESS (2.022s) [192.900036] Subtest u-fairslice: SUCCESS (12.137s) [193.209752] [025/133] (830s left) gem_pxp (create-regular-context-1) [193.337346] Starting subtest: create-regular-context-1 [193.339882] Subtest create-regular-context-1: SUCCESS (0.002s) [193.465283] [026/133] (830s left) syncobj_basic (bad-destroy) [193.517131] Starting subtest: bad-destroy [193.519625] Subtest bad-destroy: SUCCESS (0.000s) [193.600577] [027/133] (830s left) gem_set_tiling_vs_gtt [193.714065] [028/133] (830s left) kms_big_fb (x-tiled-64bpp-rotate-0) [193.811449] Starting subtest: x-tiled-64bpp-rotate-0 [195.423899] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.613s) [195.592791] [029/133] (828s left) kms_psr (psr2-cursor-mmap-gtt) [195.682491] Starting subtest: psr2-cursor-mmap-gtt [195.684447] Starting dynamic subtest: eDP-1 [197.353993] Dynamic subtest eDP-1: SUCCESS (1.673s) [197.356341] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.674s) [198.151188] [030/133] (826s left) kms_psr (fbc-pr-primary-page-flip) [198.256588] Starting subtest: fbc-pr-primary-page-flip [198.261032] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [198.333703] [031/133] (826s left) kms_lease (lease-again) [198.431213] Starting subtest: lease-again [198.433565] Starting dynamic subtest: pipe-A-eDP-1 [198.435731] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s) [198.445699] Starting dynamic subtest: pipe-B-eDP-1 [198.447810] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [198.457165] Starting dynamic subtest: pipe-C-eDP-1 [198.459321] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [198.468547] Starting dynamic subtest: pipe-D-eDP-1 [198.470615] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [198.472683] Subtest lease-again: SUCCESS (0.011s) [198.555372] [032/133] (825s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [198.659262] Starting subtest: psr-1p-primscrn-cur-indfb-move [206.028527] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.376s) [206.151146] [033/133] (818s left) gem_exec_balancer (full-late) [206.215890] Starting subtest: full-late [210.483226] Subtest full-late: SUCCESS (4.265s) [210.802015] [034/133] (813s left) gem_exec_fence (basic-busy) [210.980445] Starting subtest: basic-busy [210.982999] Starting dynamic subtest: rcs0 [211.072256] Dynamic subtest rcs0: SUCCESS (0.092s) [211.086580] Starting dynamic subtest: bcs0 [211.128221] Dynamic subtest bcs0: SUCCESS (0.055s) [211.139360] Starting dynamic subtest: vcs0 [211.184908] Dynamic subtest vcs0: SUCCESS (0.055s) [211.197423] Starting dynamic subtest: vcs1 [211.256691] Dynamic subtest vcs1: SUCCESS (0.070s) [211.268107] Starting dynamic subtest: vecs0 [211.320274] Dynamic subtest vecs0: SUCCESS (0.062s) [211.331378] Starting dynamic subtest: ccs0 [211.385112] Dynamic subtest ccs0: SUCCESS (0.063s) [211.387500] Subtest basic-busy: SUCCESS (0.406s) [213.687710] [035/133] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [213.789460] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [213.793599] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [213.892330] [036/133] (810s left) kms_rmfb (rmfb-ioctl) [213.991639] Starting subtest: rmfb-ioctl [213.993547] Starting dynamic subtest: pipe-A-eDP-1 [214.096358] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [214.107764] Starting dynamic subtest: pipe-B-eDP-1 [215.239127] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s) [215.250905] Starting dynamic subtest: pipe-C-eDP-1 [216.361666] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s) [216.372998] Starting dynamic subtest: pipe-D-eDP-1 [217.496755] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [217.499052] Subtest rmfb-ioctl: SUCCESS (3.506s) [218.637324] [037/133] (805s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [218.745873] Starting subtest: yf-tiled-16bpp-rotate-0 [218.750286] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [218.850219] [038/133] (805s left) kms_joiner (basic-big-joiner) [218.946105] Starting subtest: basic-big-joiner [218.950102] Subtest basic-big-joiner: SKIP (0.000s) [219.017937] [039/133] (805s left) kms_chamelium_hpd (dp-hpd-storm) [219.411191] Subtest dp-hpd-storm: SKIP (0.000s) [220.235811] [040/133] (804s left) prime_mmap_kms (buffer-sharing) [220.331425] Starting subtest: buffer-sharing [220.755187] Subtest buffer-sharing: SUCCESS (0.425s) [221.587608] [041/133] (803s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [223.737813] Starting subtest: dpms-mode-unset-non-lpsp [224.888026] Subtest dpms-mode-unset-non-lpsp: SKIP (1.148s) [225.254377] [042/133] (799s left) gem_exec_schedule (preempt-queue-contexts) [225.323620] Subtest preempt-queue-contexts: SKIP (0.000s) [225.607857] [043/133] (799s left) kms_plane_scaling (planes-downscale-factor-0-75) [225.718063] Starting subtest: planes-downscale-factor-0-75 [225.720458] Starting dynamic subtest: pipe-A [225.741554] Dynamic subtest pipe-A: SKIP (0.019s) [225.753773] Starting dynamic subtest: pipe-B [225.774117] Dynamic subtest pipe-B: SKIP (0.032s) [225.784313] Starting dynamic subtest: pipe-C [225.803777] Dynamic subtest pipe-C: SKIP (0.030s) [225.813762] Starting dynamic subtest: pipe-D [225.833799] Dynamic subtest pipe-D: SKIP (0.030s) [225.838151] Subtest planes-downscale-factor-0-75: SKIP (0.114s) [225.926182] [044/133] (798s left) gem_exec_async (concurrent-writes) [225.993533] Starting subtest: concurrent-writes [225.995669] Starting dynamic subtest: rcs0 [226.008694] Dynamic subtest rcs0: SUCCESS (0.018s) [226.019430] Starting dynamic subtest: bcs0 [226.021351] Dynamic subtest bcs0: SUCCESS (0.006s) [226.031292] Starting dynamic subtest: vcs0 [226.033504] Dynamic subtest vcs0: SUCCESS (0.006s) [226.043605] Starting dynamic subtest: vcs1 [226.045434] Dynamic subtest vcs1: SUCCESS (0.006s) [226.054458] Starting dynamic subtest: vecs0 [226.056448] Dynamic subtest vecs0: SUCCESS (0.006s) [226.065209] Starting dynamic subtest: ccs0 [226.067049] Dynamic subtest ccs0: SUCCESS (0.006s) [226.068934] Subtest concurrent-writes: SUCCESS (0.051s) [226.265740] [045/133] (798s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait) [227.782457] Starting subtest: modeset-non-lpsp-stress-no-wait [227.837177] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.053s) [228.502765] [046/133] (796s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [228.888618] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [229.677713] [047/133] (795s left) syncobj_timeline (wait-all-interrupted) [229.724700] Starting subtest: wait-all-interrupted [229.828868] Subtest wait-all-interrupted: SUCCESS (0.104s) [229.904742] [048/133] (795s left) kms_sequence (queue-busy) [230.013793] Starting subtest: queue-busy [230.015720] Starting dynamic subtest: pipe-A-eDP-1 [231.950893] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s) [231.966322] Starting dynamic subtest: pipe-B-eDP-1 [234.602988] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.651s) [234.613639] Starting dynamic subtest: pipe-C-eDP-1 [237.221606] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.620s) [237.232992] Starting dynamic subtest: pipe-D-eDP-1 [239.842975] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s) [239.845285] Subtest queue-busy: SUCCESS (9.831s) [240.729108] [049/133] (784s left) gem_cs_tlb (engines) [240.776381] Starting subtest: engines [240.778587] Starting dynamic subtest: rcs0 [242.929855] Dynamic subtest rcs0: SUCCESS (2.152s) [242.942233] Starting dynamic subtest: bcs0 [245.083210] Dynamic subtest bcs0: SUCCESS (2.152s) [245.095261] Starting dynamic subtest: vcs0 [247.235635] Dynamic subtest vcs0: SUCCESS (2.152s) [247.246893] Starting dynamic subtest: vcs1 [249.388523] Dynamic subtest vcs1: SUCCESS (2.153s) [249.400166] Starting dynamic subtest: vecs0 [251.543268] Dynamic subtest vecs0: SUCCESS (2.152s) [251.554613] Starting dynamic subtest: ccs0 [253.698265] Dynamic subtest ccs0: SUCCESS (2.154s) [253.700433] Subtest engines: SUCCESS (12.921s) [253.821467] [050/133] (771s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [253.930455] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [253.932853] Starting dynamic subtest: pipe-A-eDP-1 [253.956031] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [253.968524] Starting dynamic subtest: pipe-B-eDP-1 [253.990100] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [253.999326] Starting dynamic subtest: pipe-C-eDP-1 [254.020760] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [254.029883] Starting dynamic subtest: pipe-D-eDP-1 [254.051609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [254.055957] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s) [256.102813] [051/133] (769s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [256.197740] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [256.202100] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [256.293211] [052/133] (768s left) kms_psr (psr-sprite-mmap-gtt) [256.385821] Starting subtest: psr-sprite-mmap-gtt [256.388208] Starting dynamic subtest: eDP-1 [257.818618] Dynamic subtest eDP-1: SKIP (1.430s) [257.823194] Subtest psr-sprite-mmap-gtt: SKIP (1.432s) [257.964573] [053/133] (767s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [258.061962] Starting subtest: 4-tiled-addfb-size-offset-overflow [258.064252] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [258.162077] [054/133] (767s left) gem_exec_fence (nb-await) [258.351477] Starting subtest: nb-await [258.353558] Starting dynamic subtest: rcs0 [258.418649] Dynamic subtest rcs0: SUCCESS (0.070s) [258.431982] Starting dynamic subtest: bcs0 [258.477356] Dynamic subtest bcs0: SUCCESS (0.057s) [258.490163] Starting dynamic subtest: vcs0 [258.536501] Dynamic subtest vcs0: SUCCESS (0.057s) [258.549058] Starting dynamic subtest: vcs1 [258.595159] Dynamic subtest vcs1: SUCCESS (0.057s) [258.610020] Starting dynamic subtest: vecs0 [258.655272] Dynamic subtest vecs0: SUCCESS (0.058s) [258.667187] Starting dynamic subtest: ccs0 [258.713448] Dynamic subtest ccs0: SUCCESS (0.056s) [258.716378] Subtest nb-await: SUCCESS (0.367s) [260.731448] [055/133] (764s left) gem_unfence_active_buffers [260.908260] [056/133] (764s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [261.011871] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [267.703173] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.694s) [267.821341] [057/133] (757s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [267.946015] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [267.948202] Starting dynamic subtest: pipe-A-eDP-1 [268.051788] Dynamic subtest pipe-A-eDP-1: SKIP (0.105s) [268.063630] Starting dynamic subtest: pipe-B-eDP-1 [269.220458] Dynamic subtest pipe-B-eDP-1: SKIP (1.167s) [269.224845] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.276s) [270.424989] [058/133] (755s left) kms_force_connector_basic (prune-stale-modes) [270.512476] Starting subtest: prune-stale-modes [270.946721] Subtest prune-stale-modes: SUCCESS (0.437s) [271.102914] [059/133] (754s left) kms_force_connector_basic (force-edid) [271.175293] Starting subtest: force-edid [271.537491] Subtest force-edid: SUCCESS (0.365s) [271.677226] [060/133] (753s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [271.776059] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [271.779960] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [271.879296] [061/133] (753s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [271.942942] Starting subtest: x-tiled-to-vebox-yf-tiled [271.946366] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [272.129722] [062/133] (753s left) gem_mmap_gtt (basic-small-bo-tiledy) [272.190860] Subtest basic-small-bo-tiledY: SKIP (0.000s) [272.249863] [063/133] (753s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [272.353766] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [272.358155] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [272.485070] [064/133] (753s left) gem_exec_fence (basic-wait-all) [272.557092] Starting subtest: basic-wait-all [272.639915] Subtest basic-wait-all: SUCCESS (0.084s) [274.687909] [065/133] (751s left) gem_softpin (noreloc-interruptible) [274.757423] Starting subtest: noreloc-interruptible [280.169383] Subtest noreloc-interruptible: SUCCESS (5.411s) [280.276790] [066/133] (745s left) syncobj_timeline (invalid-transfer-bad-pad) [280.328737] Starting subtest: invalid-transfer-bad-pad [280.331019] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [280.413850] [067/133] (745s left) gen7_exec_parse (batch-without-end) [280.473615] Subtest batch-without-end: SKIP (0.000s) [280.532286] [068/133] (745s left) gem_softpin (zero) [280.583556] Starting subtest: zero [280.591228] Subtest zero: SUCCESS (0.009s) [280.716510] [069/133] (745s left) dmabuf_sync_file (export-basic) [280.757634] Starting subtest: export-basic [280.759464] Subtest export-basic: SUCCESS (0.001s) [280.825860] [070/133] (745s left) gem_userptr_blits (nohangcheck) [280.894606] Starting subtest: nohangcheck [281.233301] Subtest nohangcheck: SUCCESS (0.337s) [281.348024] [071/133] (744s left) kms_flip (flip-vs-expired-vblank) [281.445533] Starting subtest: flip-vs-expired-vblank [281.447811] Starting dynamic subtest: A-eDP1 [290.114887] Dynamic subtest A-eDP1: SUCCESS (8.673s) [290.130255] Starting dynamic subtest: B-eDP1 [298.806705] Dynamic subtest B-eDP1: SUCCESS (8.690s) [298.821466] Starting dynamic subtest: C-eDP1 [307.495679] Dynamic subtest C-eDP1: SUCCESS (8.689s) [307.508124] Starting dynamic subtest: D-eDP1 [316.193028] Dynamic subtest D-eDP1: SUCCESS (8.697s) [316.195519] Subtest flip-vs-expired-vblank: SUCCESS (34.761s) [317.429459] [072/133] (708s left) kms_atomic_transition (plane-all-transition) [317.523678] Starting subtest: plane-all-transition [317.526005] Starting dynamic subtest: pipe-A-eDP-1 [320.016849] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [320.336484] Starting dynamic subtest: pipe-B-eDP-1 [323.250480] Dynamic subtest pipe-B-eDP-1: FAIL (2.442s) [323.252267] Subtest plane-all-transition: FAIL (5.540s) [323.910368] [073/133] (702s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [324.005622] Starting subtest: psr2-cursor-plane-update-sf [324.007814] Starting dynamic subtest: pipe-A-eDP-1 [324.556440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s) [324.574297] Starting dynamic subtest: pipe-B-eDP-1 [325.862349] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.307s) [325.864757] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.864s) [326.711870] [074/133] (699s left) gem_exec_whisper (basic-queues-forked-all) [326.767853] Starting subtest: basic-queues-forked-all [348.860858] Subtest basic-queues-forked-all: SUCCESS (22.087s) [349.059543] [075/133] (677s left) gem_ctx_persistence (legacy-engines-hang) [349.125258] Starting subtest: legacy-engines-hang [349.127686] Starting dynamic subtest: render [349.249783] Dynamic subtest render: SUCCESS (0.123s) [349.263649] Starting dynamic subtest: bsd1 [349.362006] Dynamic subtest bsd1: SUCCESS (0.110s) [349.378144] Starting dynamic subtest: bsd2 [349.455036] Dynamic subtest bsd2: SUCCESS (0.090s) [349.471881] Starting dynamic subtest: blt [349.555017] Dynamic subtest blt: SUCCESS (0.097s) [349.570832] Starting dynamic subtest: vebox [349.651020] Dynamic subtest vebox: SUCCESS (0.093s) [349.653545] Subtest legacy-engines-hang: SUCCESS (0.527s) [349.735599] [076/133] (676s left) gem_eio (in-flight-internal-immediate) [349.965819] Starting subtest: in-flight-internal-immediate [351.743167] Subtest in-flight-internal-immediate: SUCCESS (1.774s) [351.860838] [077/133] (674s left) gem_mmap_gtt (basic-small-copy-odd) [351.913947] Subtest basic-small-copy-odd: SKIP (0.000s) [351.970451] [078/133] (674s left) gem_exec_params (invalid-bsd-ring) [352.024121] Starting subtest: invalid-bsd-ring [352.026512] Subtest invalid-bsd-ring: SUCCESS (0.000s) [352.126949] [079/133] (674s left) syncobj_eventfd (invalid-bad-pad) [352.186158] Starting subtest: invalid-bad-pad [352.188455] Subtest invalid-bad-pad: SUCCESS (0.000s) [352.289573] [080/133] (674s left) gem_pipe_control_store_loop (fresh-buffer) [352.345912] Starting subtest: fresh-buffer [354.500054] Subtest fresh-buffer: SUCCESS (2.152s) [354.626949] [081/133] (671s left) kms_plane_alpha_blend (constant-alpha-min) [354.712570] Starting subtest: constant-alpha-min [355.001469] Starting dynamic subtest: pipe-A-eDP-1 [355.701036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s) [355.714478] Starting dynamic subtest: pipe-D-eDP-1 [357.149267] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.447s) [357.151914] Subtest constant-alpha-min: SUCCESS (2.439s) [358.013626] [082/133] (668s left) kms_cursor_crc (cursor-random-512x512) [358.308094] Starting subtest: cursor-random-512x512 [358.313300] Subtest cursor-random-512x512: SKIP (0.001s) [358.465094] [083/133] (668s left) gen9_exec_parse (unaligned-jump) [358.518767] Subtest unaligned-jump: SKIP (0.000s) [358.586960] [084/133] (668s left) perf (blocking-parameterized) [358.716915] Starting subtest: blocking-parameterized [378.740957] Subtest blocking-parameterized: SUCCESS (20.019s) [378.791601] [085/133] (647s left) gem_barrier_race (remote-request) [378.846801] Starting subtest: remote-request [378.849053] Starting dynamic subtest: rcs0 [384.018576] Dynamic subtest rcs0: SUCCESS (5.173s) [384.022275] Subtest remote-request: SUCCESS (5.175s) [384.176460] [086/133] (642s left) i915_hangman (gt-error-state-capture) [384.251921] Starting subtest: gt-error-state-capture [384.253542] Starting dynamic subtest: rcs0 [395.589124] Dynamic subtest rcs0: SUCCESS (11.335s) [395.602339] Starting dynamic subtest: bcs0 [407.621792] Dynamic subtest bcs0: SUCCESS (12.029s) [407.635610] Starting dynamic subtest: vcs0 [419.525469] Dynamic subtest vcs0: SUCCESS (11.901s) [419.538934] Starting dynamic subtest: vcs1 [430.532960] Dynamic subtest vcs1: SUCCESS (11.005s) [430.547119] Starting dynamic subtest: vecs0 [441.541882] Dynamic subtest vecs0: SUCCESS (11.007s) [441.556040] Starting dynamic subtest: ccs0 [451.589947] Dynamic subtest ccs0: SUCCESS (10.046s) [451.592747] Subtest gt-error-state-capture: SUCCESS (67.340s) [451.734766] [087/133] (575s left) gem_exec_whisper (basic-contexts-priority) [451.804178] Starting subtest: basic-contexts-priority [475.147007] Subtest basic-contexts-priority: SUCCESS (23.347s) [475.338855] [088/133] (551s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [475.472864] Starting subtest: cursorB-vs-flipA-legacy [475.477436] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s) [475.630575] [089/133] (551s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [475.726564] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [479.336471] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.615s) [480.519262] [090/133] (546s left) kms_properties (crtc-properties-legacy) [480.611651] Starting subtest: crtc-properties-legacy [480.613879] Starting dynamic subtest: pipe-A-eDP-1 [481.047773] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s) [481.058716] Starting dynamic subtest: pipe-B-eDP-1 [482.251515] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.200s) [482.262162] Starting dynamic subtest: pipe-C-eDP-1 [483.452797] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s) [483.463789] Starting dynamic subtest: pipe-D-eDP-1 [484.631552] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.179s) [484.633838] Subtest crtc-properties-legacy: SUCCESS (4.022s) [485.514309] [091/133] (541s left) kms_content_protection (atomic-dpms-hdcp14) [485.665001] Starting subtest: atomic-dpms-hdcp14 [485.669589] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [485.783716] [092/133] (541s left) api_intel_allocator (default-alignment) [485.835180] Starting subtest: default-alignment [485.839899] Subtest default-alignment: SUCCESS (0.003s) [485.957005] [093/133] (541s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [486.013899] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [486.016245] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [486.112926] [094/133] (540s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [486.205258] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [486.210065] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [486.333768] [095/133] (540s left) kms_plane_scaling (2x-scaler-multi-pipe) [486.429575] Starting subtest: 2x-scaler-multi-pipe [486.434158] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [486.520996] [096/133] (540s left) gem_mmap_offset (bad-object) [486.582800] Starting subtest: bad-object [486.585077] Subtest bad-object: SUCCESS (0.001s) [486.699625] [097/133] (540s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [486.792657] Starting subtest: fbc-2p-pri-indfb-multidraw [486.796211] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [486.904902] [098/133] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [486.999273] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [487.008218] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [487.108087] [099/133] (540s left) kms_plane_cursor (primary) [487.211884] Starting subtest: primary [487.215447] Starting dynamic subtest: pipe-A-eDP-1-size-64 [489.856042] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.645s) [489.881996] Starting dynamic subtest: pipe-A-eDP-1-size-128 [492.445838] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.574s) [492.471238] Starting dynamic subtest: pipe-A-eDP-1-size-256 [495.069359] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.605s) [495.386363] Starting dynamic subtest: pipe-B-eDP-1-size-64 [498.714365] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.341s) [498.739948] Starting dynamic subtest: pipe-B-eDP-1-size-128 [501.314604] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s) [501.345014] Starting dynamic subtest: pipe-B-eDP-1-size-256 [503.903988] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.572s) [504.219121] Starting dynamic subtest: pipe-C-eDP-1-size-64 [507.072180] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.866s) [507.099695] Starting dynamic subtest: pipe-C-eDP-1-size-128 [509.327629] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s) [509.354987] Starting dynamic subtest: pipe-C-eDP-1-size-256 [511.560748] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s) [511.881298] Starting dynamic subtest: pipe-D-eDP-1-size-64 [514.791334] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.924s) [514.819913] Starting dynamic subtest: pipe-D-eDP-1-size-128 [516.982456] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.172s) [517.007575] Starting dynamic subtest: pipe-D-eDP-1-size-256 [519.201559] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.203s) [519.510280] Subtest primary: SUCCESS (32.303s) [520.304918] [100/133] (507s left) kms_cursor_legacy (torture-bo) [520.421238] Starting subtest: torture-bo [520.423650] Starting dynamic subtest: pipe-A [526.552682] Dynamic subtest pipe-A: SUCCESS (6.127s) [526.567162] Starting dynamic subtest: pipe-B [535.623893] Dynamic subtest pipe-B: SUCCESS (9.071s) [535.641201] Starting dynamic subtest: pipe-C [542.653180] Dynamic subtest pipe-C: SUCCESS (7.029s) [542.664089] Starting dynamic subtest: pipe-D [550.370228] Dynamic subtest pipe-D: SUCCESS (7.715s) [550.388130] Starting dynamic subtest: all-pipes [556.874478] Dynamic subtest all-pipes: SUCCESS (6.501s) [556.877092] Subtest torture-bo: SUCCESS (36.457s) [557.034300] [101/133] (470s left) perf_pmu (rc6-suspend) [557.085664] Starting subtest: rc6-suspend [579.510057] Subtest rc6-suspend: SUCCESS (7.609s) [580.359455] [102/133] (447s left) syncobj_basic (test-valid-cycle) [580.424681] Starting subtest: test-valid-cycle [580.426883] Subtest test-valid-cycle: SUCCESS (0.000s) [580.514722] [103/133] (446s left) gem_workarounds (suspend-resume-fd) [580.576148] Starting subtest: suspend-resume-fd [596.338043] Subtest suspend-resume-fd: SUCCESS (1.207s) [596.478574] [104/133] (430s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [596.569684] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [596.571963] Starting dynamic subtest: pipe-A-eDP-1 [596.594634] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [596.606816] Starting dynamic subtest: pipe-B-eDP-1 [596.628145] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [596.637651] Starting dynamic subtest: pipe-C-eDP-1 [596.659032] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [596.668375] Starting dynamic subtest: pipe-D-eDP-1 [596.691196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [596.695567] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [598.783133] [105/133] (428s left) kms_async_flips (async-flip-with-page-flip-events-linear) [598.878101] Starting subtest: async-flip-with-page-flip-events-linear [599.253574] Starting dynamic subtest: pipe-A-eDP-1 [602.006367] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.803s) [602.360774] Starting dynamic subtest: pipe-B-eDP-1 [605.148934] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.830s) [605.506774] Starting dynamic subtest: pipe-C-eDP-1 [608.238600] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s) [608.606138] Starting dynamic subtest: pipe-D-eDP-1 [611.396854] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.814s) [611.399394] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.666s) [612.556017] [106/133] (415s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [612.652981] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [612.657531] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [612.750996] [107/133] (414s left) kms_async_flips (test-cursor) [612.845878] Starting subtest: test-cursor [613.227321] Starting dynamic subtest: pipe-A-eDP-1 [613.980418] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.757s) [614.353429] Starting dynamic subtest: pipe-B-eDP-1 [615.094874] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.753s) [615.476646] Starting dynamic subtest: pipe-C-eDP-1 [616.278952] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.813s) [616.644790] Starting dynamic subtest: pipe-D-eDP-1 [617.378211] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.743s) [617.380550] Subtest test-cursor: SUCCESS (4.549s) [618.616968] [108/133] (409s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [618.719506] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [623.944554] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.237s) [625.128170] [109/133] (402s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [625.184670] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [625.187024] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [625.289788] [110/133] (402s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [625.404606] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [632.325368] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.922s) [632.454719] [111/133] (395s left) kms_psr (fbc-psr-sprite-mmap-gtt) [632.542076] Starting subtest: fbc-psr-sprite-mmap-gtt [632.544342] Starting dynamic subtest: eDP-1 [632.548416] Dynamic subtest eDP-1: SKIP (0.000s) [632.552592] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s) [632.618912] [112/133] (395s left) kms_cursor_edge_walk (256x256-left-edge) [632.712217] Starting subtest: 256x256-left-edge [632.714548] Starting dynamic subtest: pipe-A-eDP-1 [636.143438] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.424s) [636.154016] Starting dynamic subtest: pipe-D-eDP-1 [639.334889] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.187s) [639.337252] Subtest 256x256-left-edge: SUCCESS (6.614s) [640.221180] [113/133] (387s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [640.313764] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [640.318089] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [641.406117] [114/133] (386s left) api_intel_bb (full-batch) [641.468235] Starting subtest: full-batch [641.473258] Subtest full-batch: SUCCESS (0.006s) [641.579434] [115/133] (386s left) gem_ringfill (engines-basic) [647.113838] Starting subtest: engines-basic [647.116515] Starting dynamic subtest: rcs0 [647.172469] Dynamic subtest rcs0: SUCCESS (0.058s) [647.185072] Starting dynamic subtest: bcs0 [647.218575] Dynamic subtest bcs0: SUCCESS (0.043s) [647.231382] Starting dynamic subtest: vcs0 [647.262569] Dynamic subtest vcs0: SUCCESS (0.042s) [647.273917] Starting dynamic subtest: vcs1 [647.305505] Dynamic subtest vcs1: SUCCESS (0.041s) [647.316288] Starting dynamic subtest: vecs0 [647.348782] Dynamic subtest vecs0: SUCCESS (0.042s) [647.359700] Starting dynamic subtest: ccs0 [647.395042] Dynamic subtest ccs0: SUCCESS (0.044s) [647.397451] Subtest engines-basic: SUCCESS (0.282s) [647.486522] [116/133] (380s left) i915_query (engine-info-invalid) [647.543702] Starting subtest: engine-info-invalid [647.546003] Subtest engine-info-invalid: SUCCESS (0.000s) [647.652780] [117/133] (380s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [647.755720] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [647.759855] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [647.842290] [118/133] (380s left) kms_cursor_crc (cursor-onscreen-256x256) [648.063497] Starting subtest: cursor-onscreen-256x256 [648.068310] Starting dynamic subtest: pipe-A-eDP-1 [650.185170] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.115s) [650.211851] Starting dynamic subtest: pipe-D-eDP-1 [652.981114] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s) [652.983068] Subtest cursor-onscreen-256x256: SUCCESS (4.913s) [653.815321] [119/133] (374s left) gem_mmap_wc (read-write-distinct) [653.868369] Subtest read-write-distinct: SKIP (0.000s) [653.923676] [120/133] (374s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [654.024367] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [657.947819] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.926s) [659.129340] [121/133] (369s left) kms_atomic_interruptible (universal-setplane-cursor) [659.214832] Starting subtest: universal-setplane-cursor [659.216966] Starting dynamic subtest: pipe-A-eDP-1 [666.587898] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.373s) [666.590194] Subtest universal-setplane-cursor: SUCCESS (7.374s) [667.414042] [122/133] (360s left) kms_color (ctm-0-25) [667.507978] Starting subtest: ctm-0-25 [667.510146] Starting dynamic subtest: pipe-A-eDP-1 [670.956151] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.449s) [670.966952] Starting dynamic subtest: pipe-B-eDP-1 [675.202892] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.247s) [675.213673] Starting dynamic subtest: pipe-C-eDP-1 [679.216654] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.014s) [679.227238] Starting dynamic subtest: pipe-D-eDP-1 [683.324114] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.106s) [683.326384] Subtest ctm-0-25: SUCCESS (15.819s) [684.122003] [123/133] (344s left) kms_chamelium_color (ctm-limited-range) [684.212032] Subtest ctm-limited-range: SKIP (0.000s) [684.261951] [124/133] (344s left) gem_madvise (dontneed-before-exec) [684.298762] Starting subtest: dontneed-before-exec [684.321973] Subtest dontneed-before-exec: SKIP (0.020s) [684.394604] [125/133] (344s left) kms_psr (pr-sprite-plane-move) [684.485685] Starting subtest: pr-sprite-plane-move [684.489910] Subtest pr-sprite-plane-move: SKIP (0.000s) [684.572418] [126/133] (343s left) gem_mmap_gtt (cpuset-basic-small-copy) [684.627570] Subtest cpuset-basic-small-copy: SKIP (0.000s) [684.692961] [127/133] (343s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render) [684.803191] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render [691.698122] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.898s) [691.825267] [128/133] (336s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [691.877003] Starting subtest: etime-multi-wait-for-submit-unsubmitted [691.985455] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s) [692.067916] [129/133] (336s left) sriov_basic (enable-vfs-autoprobe-on) [692.117172] Starting subtest: enable-vfs-autoprobe-on [692.119305] Starting dynamic subtest: numvfs-1 [692.190288] Dynamic subtest numvfs-1: FAIL (0.005s) [692.201529] Starting dynamic subtest: numvfs-2 [692.275160] Dynamic subtest numvfs-2: FAIL (0.004s) [692.286774] Starting dynamic subtest: numvfs-3 [692.359920] Dynamic subtest numvfs-3: FAIL (0.004s) [692.371608] Starting dynamic subtest: numvfs-4 [692.444083] Dynamic subtest numvfs-4: FAIL (0.005s) [692.456755] Starting dynamic subtest: numvfs-5 [692.531473] Dynamic subtest numvfs-5: FAIL (0.006s) [692.543468] Starting dynamic subtest: numvfs-6 [692.617457] Dynamic subtest numvfs-6: FAIL (0.003s) [692.630771] Starting dynamic subtest: numvfs-7 [692.706388] Dynamic subtest numvfs-7: FAIL (0.003s) [692.718908] Starting dynamic subtest: numvfs-random [692.794853] Dynamic subtest numvfs-random: FAIL (0.003s) [692.810333] Starting dynamic subtest: numvfs-all [692.883106] Dynamic subtest numvfs-all: FAIL (0.526s) [692.885140] Subtest enable-vfs-autoprobe-on: FAIL (0.569s) [692.924125] [130/133] (335s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [693.020677] Starting subtest: fbc-rgb565-draw-mmap-cpu [697.015139] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.996s) [698.237043] [131/133] (330s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [698.340372] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [698.344854] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [698.445069] [132/133] (330s left) gem_exec_reloc (basic-gtt-read-noreloc) [698.515684] Subtest basic-gtt-read-noreloc: SKIP (0.000s) [698.598015] [133/133] (330s left) kms_vblank (ts-continuation-modeset) [698.686685] Starting subtest: ts-continuation-modeset [698.688942] Starting dynamic subtest: pipe-A-eDP-1 [700.156115] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.470s) [700.172692] Starting dynamic subtest: pipe-D-eDP-1 [702.348177] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.189s) [702.350590] Subtest ts-continuation-modeset: SUCCESS (3.662s) [703.211854] Closing watchdogs results: parsing output: 0/ for test: kms_addfb_basic results: parsing output: 1/ for test: gem_exec_params results: parsing output: 2/ for test: kms_draw_crc results: parsing output: 3/ for test: gem_exec_reloc results: parsing output: 4/ for test: vgem_basic results: parsing output: 5/ for test: gem_eio results: parsing output: 6/ for test: kms_ccs results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_flip_scaled_crc results: parsing output: 9/ for test: kms_flip results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_plane results: parsing output: 12/ for test: i915_pm_rpm results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_flip_scaled_crc results: parsing output: 16/ for test: kms_flip results: parsing output: 17/ for test: kms_rotation_crc results: parsing output: 18/ for test: gem_exec_params results: parsing output: 19/ for test: gem_ctx_isolation results: parsing output: 20/ for test: gem_exec_reloc results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: kms_plane_scaling results: parsing output: 23/ for test: gem_exec_schedule results: parsing output: 24/ for test: gem_pxp results: parsing output: 25/ for test: syncobj_basic results: parsing output: 26/ for test: gem_set_tiling_vs_gtt results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: kms_lease results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_exec_balancer results: parsing output: 33/ for test: gem_exec_fence results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_rmfb results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: kms_joiner results: parsing output: 38/ for test: kms_chamelium_hpd results: parsing output: 39/ for test: prime_mmap_kms results: parsing output: 40/ for test: kms_pm_rpm results: parsing output: 41/ for test: gem_exec_schedule results: parsing output: 42/ for test: kms_plane_scaling results: parsing output: 43/ for test: gem_exec_async results: parsing output: 44/ for test: kms_pm_rpm results: parsing output: 45/ for test: kms_chamelium_edid results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: kms_sequence results: parsing output: 48/ for test: gem_cs_tlb results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_psr results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: gem_exec_fence results: parsing output: 54/ for test: gem_unfence_active_buffers results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_psr2_sf results: parsing output: 57/ for test: kms_force_connector_basic results: parsing output: 58/ for test: kms_force_connector_basic results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: gem_render_copy results: parsing output: 61/ for test: gem_mmap_gtt results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: gem_exec_fence results: parsing output: 64/ for test: gem_softpin results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: gen7_exec_parse results: parsing output: 67/ for test: gem_softpin results: parsing output: 68/ for test: dmabuf_sync_file results: parsing output: 69/ for test: gem_userptr_blits results: parsing output: 70/ for test: kms_flip results: parsing output: 71/ for test: kms_atomic_transition results: parsing output: 72/ for test: kms_psr2_sf results: parsing output: 73/ for test: gem_exec_whisper results: parsing output: 74/ for test: gem_ctx_persistence results: parsing output: 75/ for test: gem_eio results: parsing output: 76/ for test: gem_mmap_gtt results: parsing output: 77/ for test: gem_exec_params results: parsing output: 78/ for test: syncobj_eventfd results: parsing output: 79/ for test: gem_pipe_control_store_loop results: parsing output: 80/ for test: kms_plane_alpha_blend results: parsing output: 81/ for test: kms_cursor_crc results: parsing output: 82/ for test: gen9_exec_parse results: parsing output: 83/ for test: perf results: parsing output: 84/ for test: gem_barrier_race results: parsing output: 85/ for test: i915_hangman results: parsing output: 86/ for test: gem_exec_whisper results: parsing output: 87/ for test: kms_cursor_legacy results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_properties results: parsing output: 90/ for test: kms_content_protection results: parsing output: 91/ for test: api_intel_allocator results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_plane_scaling results: parsing output: 95/ for test: gem_mmap_offset results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_plane_cursor results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: perf_pmu results: parsing output: 101/ for test: syncobj_basic results: parsing output: 102/ for test: gem_workarounds results: parsing output: 103/ for test: kms_ccs results: parsing output: 104/ for test: kms_async_flips results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_async_flips results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: syncobj_wait results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: kms_cursor_edge_walk results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: api_intel_bb results: parsing output: 114/ for test: gem_ringfill results: parsing output: 115/ for test: i915_query results: parsing output: 116/ for test: kms_psr2_sf results: parsing output: 117/ for test: kms_cursor_crc results: parsing output: 118/ for test: gem_mmap_wc results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_atomic_interruptible results: parsing output: 121/ for test: kms_color results: parsing output: 122/ for test: kms_chamelium_color results: parsing output: 123/ for test: gem_madvise results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: gem_mmap_gtt results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: syncobj_timeline results: parsing output: 128/ for test: sriov_basic results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: gem_exec_reloc results: parsing output: 132/ for test: kms_vblank Done.