[60.855622] Initializing watchdogs [60.855722] /dev/watchdog0 [60.876680] [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] [60.881206] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.885175] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.888689] [001/131] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [61.025888] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [61.030196] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [61.137204] [002/131] (960s left) gem_ctx_persistence (engines-queued) [61.193533] Starting subtest: engines-queued [61.195985] Starting dynamic subtest: rcs0 [61.291763] Dynamic subtest rcs0: SUCCESS (0.097s) [61.300276] Starting dynamic subtest: bcs0 [61.317296] Dynamic subtest bcs0: SUCCESS (0.025s) [61.323613] Starting dynamic subtest: vcs0 [62.901898] Dynamic subtest vcs0: SUCCESS (1.576s) [62.912078] Starting dynamic subtest: vcs1 [64.883849] Dynamic subtest vcs1: SUCCESS (1.974s) [64.893882] Starting dynamic subtest: vecs0 [66.866590] Dynamic subtest vecs0: SUCCESS (1.977s) [66.875996] Starting dynamic subtest: ccs0 [67.292885] Dynamic subtest ccs0: SUCCESS (0.426s) [67.295626] Subtest engines-queued: SUCCESS (6.082s) [67.557209] [003/131] (953s left) i915_hangman (hangcheck-unterminated) [67.717165] Starting subtest: hangcheck-unterminated [78.902058] Subtest hangcheck-unterminated: SUCCESS (11.172s) [79.072818] [004/131] (942s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [79.169440] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [79.171593] Starting dynamic subtest: pipe-A-default-mode [80.312385] Dynamic subtest pipe-A-default-mode: SKIP (1.139s) [80.316762] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.141s) [80.487050] [005/131] (941s left) tools_test (tools_test) [80.539264] Starting subtest: tools_test [80.592877] Subtest tools_test: SUCCESS (0.069s) [80.672891] [006/131] (940s left) perf (invalid-open-flags) [80.805659] Starting subtest: invalid-open-flags [80.807544] Subtest invalid-open-flags: SUCCESS (0.000s) [80.849309] [007/131] (940s left) i915_pm_rpm (debugfs-forcewake-user) [83.109861] Starting subtest: debugfs-forcewake-user [94.509050] Subtest debugfs-forcewake-user: SUCCESS (11.397s) [94.902419] [008/131] (926s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt) [95.022765] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt [99.069258] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.049s) [100.210095] [009/131] (921s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [100.315083] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [100.319188] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [100.442793] [010/131] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [100.540595] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [100.544867] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [100.648519] [011/131] (921s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [100.711239] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [100.817363] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s) [100.917184] [012/131] (920s left) gem_lmem_swapping (verify-random) [100.955077] Subtest verify-random: SKIP (0.000s) [100.999166] [013/131] (920s left) gem_exec_whisper (basic-queues-forked-all) [101.054740] Starting subtest: basic-queues-forked-all [121.212300] Subtest basic-queues-forked-all: SUCCESS (20.154s) [121.415712] [014/131] (900s left) kms_big_fb (x-tiled-32bpp-rotate-90) [121.514628] Starting subtest: x-tiled-32bpp-rotate-90 [121.538202] Subtest x-tiled-32bpp-rotate-90: SKIP (0.021s) [121.702794] [015/131] (900s left) kms_content_protection (lic-type-1) [121.847926] Starting subtest: lic-type-1 [121.852360] Subtest lic-type-1: SKIP (0.000s) [121.980123] [016/131] (899s left) gem_mmap_gtt (big-bo-tiledx) [122.037793] Subtest big-bo-tiledX: SKIP (0.000s) [122.096419] [017/131] (899s left) kms_prime (basic-modeset-hybrid) [122.169436] Subtest basic-modeset-hybrid: SKIP (0.000s) [122.304504] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true [122.307653] [018/131] (899s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [122.362900] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [122.435941] [019/131] (899s left) kms_cursor_crc (cursor-offscreen-256x256) [122.691635] Starting subtest: cursor-offscreen-256x256 [122.695499] Starting dynamic subtest: pipe-A-eDP-1 [124.653805] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.955s) [124.682228] Starting dynamic subtest: pipe-D-eDP-1 [127.305789] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.628s) [127.308419] Subtest cursor-offscreen-256x256: SUCCESS (4.612s) [128.174573] [020/131] (893s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [128.285746] Starting subtest: cursorA-vs-flipA-atomic-transitions [139.439530] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.151s) [140.307690] [021/131] (881s left) gem_eio (create) [140.539211] Starting subtest: create [140.885507] Subtest create: SUCCESS (0.345s) [141.068944] [022/131] (881s left) kms_flip (flip-vs-fences) [141.175166] Starting subtest: flip-vs-fences [141.179139] Subtest flip-vs-fences: SKIP (0.000s) [141.298762] [023/131] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [141.393258] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [141.396613] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [141.542763] [024/131] (880s left) gem_pxp (hw-rejects-pxp-context) [141.678610] Starting subtest: hw-rejects-pxp-context [141.682391] Subtest hw-rejects-pxp-context: SKIP (0.000s) [141.824349] [025/131] (880s left) kms_cursor_crc (cursor-size-hints) [141.939915] Starting subtest: cursor-size-hints [141.941786] Starting dynamic subtest: pipe-A-eDP-1 [142.566145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s) [142.575099] Starting dynamic subtest: pipe-D-eDP-1 [143.849677] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.283s) [143.851815] Subtest cursor-size-hints: SUCCESS (1.910s) [144.666327] [026/131] (877s left) gen9_exec_parse (bb-start-far) [144.732796] Subtest bb-start-far: SKIP (0.000s) [144.794961] [027/131] (877s left) kms_vblank (ts-continuation-dpms-suspend) [144.896190] Starting subtest: ts-continuation-dpms-suspend [144.898722] Starting dynamic subtest: pipe-A-eDP-1 [161.414165] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.591s) [161.429496] Starting dynamic subtest: pipe-D-eDP-1 [179.427033] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.485s) [179.429017] Subtest ts-continuation-dpms-suspend: SUCCESS (8.080s) [180.272484] [028/131] (842s left) syncobj_timeline (etime-multi-wait-submitted) [180.338540] Starting subtest: etime-multi-wait-submitted [180.443957] Subtest etime-multi-wait-submitted: SUCCESS (0.104s) [180.549586] [029/131] (841s left) syncobj_timeline (invalid-wait-illegal-handle) [180.603838] Starting subtest: invalid-wait-illegal-handle [180.606139] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [180.746282] [030/131] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [180.854359] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [180.858868] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [180.998545] [031/131] (841s left) kms_psr (fbc-psr-primary-mmap-cpu) [181.099671] Starting subtest: fbc-psr-primary-mmap-cpu [181.101949] Starting dynamic subtest: eDP-1 [181.106280] Dynamic subtest eDP-1: SKIP (0.000s) [181.110468] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [181.195985] [032/131] (841s left) kms_lease (page-flip-implicit-plane) [181.294008] Starting subtest: page-flip-implicit-plane [181.295967] Starting dynamic subtest: pipe-A-eDP-1 [181.772576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.468s) [181.782484] Starting dynamic subtest: pipe-B-eDP-1 [182.935469] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s) [182.944734] Starting dynamic subtest: pipe-C-eDP-1 [184.063353] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s) [184.075207] Starting dynamic subtest: pipe-D-eDP-1 [185.194732] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.116s) [185.197131] Subtest page-flip-implicit-plane: SUCCESS (3.838s) [186.075714] [033/131] (836s left) gem_exec_create (madvise) [186.145004] Starting subtest: madvise [186.147398] Starting dynamic subtest: smem [207.399065] Dynamic subtest smem: SUCCESS (21.165s) [207.402153] Subtest madvise: SUCCESS (21.166s) [208.398462] [034/131] (814s left) gem_create (create-ext-placement-all) [208.568200] Starting subtest: create-ext-placement-all [208.570809] Subtest create-ext-placement-all: SUCCESS (0.000s) [208.725502] [035/131] (814s left) kms_chamelium_frames (dp-crc-multiple) [209.107117] Subtest dp-crc-multiple: SKIP (0.000s) [209.956480] [036/131] (812s left) kms_big_fb (4-tiled-addfb) [210.059689] Starting subtest: 4-tiled-addfb [210.062063] Subtest 4-tiled-addfb: SUCCESS (0.000s) [210.177964] [037/131] (812s left) perf_pmu (idle) [210.220623] Starting subtest: idle [210.222898] Starting dynamic subtest: rcs0 [210.789190] Dynamic subtest rcs0: SUCCESS (0.568s) [210.801379] Starting dynamic subtest: bcs0 [211.321187] Dynamic subtest bcs0: SUCCESS (0.530s) [211.333662] Starting dynamic subtest: vcs0 [211.853846] Dynamic subtest vcs0: SUCCESS (0.527s) [211.865310] Starting dynamic subtest: vcs1 [212.374601] Dynamic subtest vcs1: SUCCESS (0.522s) [212.386778] Starting dynamic subtest: vecs0 [212.897859] Dynamic subtest vecs0: SUCCESS (0.521s) [212.909953] Starting dynamic subtest: ccs0 [213.423174] Dynamic subtest ccs0: SUCCESS (0.523s) [213.425966] Subtest idle: SUCCESS (3.205s) [213.616539] [038/131] (809s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [214.209390] Starting subtest: syncobj-backward-timeline-chain-engines [214.410113] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.200s) [215.382424] [039/131] (807s left) prime_vgem (fence-read-hang) [215.474783] Subtest fence-read-hang: SKIP (0.000s) [215.633504] [040/131] (807s left) kms_big_fb (y-tiled-addfb-size-overflow) [215.732141] Starting subtest: y-tiled-addfb-size-overflow [215.736205] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [215.865844] [041/131] (807s left) gem_ppgtt (blt-vs-render-ctxn) [215.921588] Starting subtest: blt-vs-render-ctxN [248.901551] Subtest blt-vs-render-ctxN: SUCCESS (32.972s) [249.069510] [042/131] (774s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite) [249.220135] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite [256.000663] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.779s) [256.142031] [043/131] (767s left) kms_dither (fb-8bpc-vs-panel-6bpc) [256.242102] Starting subtest: fb-8bpc-vs-panel-6bpc [256.244516] Starting dynamic subtest: pipe-A-eDP-1 [257.605591] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.365s) [257.607974] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.366s) [258.429146] [044/131] (764s left) gem_pwrite_snooped [258.571783] [045/131] (764s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [258.676187] Starting subtest: extended-modeset-hang-oldfb-with-reset [258.678556] Starting dynamic subtest: pipe-A [270.575532] Dynamic subtest pipe-A: SUCCESS (11.894s) [270.585638] Starting dynamic subtest: pipe-D [282.851113] Dynamic subtest pipe-D: SUCCESS (12.271s) [282.853572] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.170s) [283.660219] [046/131] (739s left) gem_userptr_blits (probe) [283.735533] Starting subtest: probe [283.805141] Subtest probe: SUCCESS (0.069s) [283.964842] [047/131] (739s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [284.063076] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [291.231337] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.172s) [291.358159] [048/131] (731s left) kms_draw_crc (draw-method-render) [291.467374] Starting subtest: draw-method-render [291.469678] Starting dynamic subtest: xrgb8888-untiled [291.684950] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s) [291.695119] Starting dynamic subtest: rgb565-untiled [291.918223] Dynamic subtest rgb565-untiled: SUCCESS (0.232s) [291.928100] Starting dynamic subtest: xrgb2101010-untiled [292.129460] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s) [292.139550] Starting dynamic subtest: xbgr16161616f-untiled [292.340342] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s) [292.352439] Starting dynamic subtest: xrgb8888-xtiled [292.462362] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.120s) [292.472905] Starting dynamic subtest: rgb565-xtiled [292.629054] Dynamic subtest rgb565-xtiled: SUCCESS (0.166s) [292.639020] Starting dynamic subtest: xrgb2101010-xtiled [292.751131] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [292.761516] Starting dynamic subtest: xbgr16161616f-xtiled [292.873742] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s) [292.885645] Starting dynamic subtest: xrgb8888-4tiled [292.995780] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [293.007108] Starting dynamic subtest: rgb565-4tiled [293.128764] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s) [293.138653] Starting dynamic subtest: xrgb2101010-4tiled [293.240139] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s) [293.249743] Starting dynamic subtest: xbgr16161616f-4tiled [293.362488] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s) [293.364442] Subtest draw-method-render: SUCCESS (1.901s) [293.513709] [049/131] (729s left) syncobj_timeline (single-wait-all-for-submit-signaled) [293.572320] Starting subtest: single-wait-all-for-submit-signaled [293.574298] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [293.696459] [050/131] (729s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [293.806036] Starting subtest: fbc-rgb565-draw-mmap-gtt [293.809443] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [293.938854] [051/131] (729s left) kms_psr (fbc-pr-dpms) [294.040368] Starting subtest: fbc-pr-dpms [294.044052] Subtest fbc-pr-dpms: SKIP (0.000s) [294.137840] [052/131] (729s left) syncobj_wait (multi-wait-all-for-submit-signaled) [294.189162] Starting subtest: multi-wait-all-for-submit-signaled [294.191212] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [294.316468] [053/131] (729s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [294.436042] Starting subtest: short-flip-after-cursor-toggle [295.351562] Subtest short-flip-after-cursor-toggle: SUCCESS (0.911s) [296.228960] [054/131] (727s left) perf_pmu (busy-accuracy-98) [296.276771] Starting subtest: busy-accuracy-98 [296.278675] Starting dynamic subtest: rcs0 [299.312346] Dynamic subtest rcs0: SUCCESS (3.034s) [299.324379] Starting dynamic subtest: bcs0 [302.364845] Dynamic subtest bcs0: SUCCESS (3.051s) [302.376207] Starting dynamic subtest: vcs0 [305.411140] Dynamic subtest vcs0: SUCCESS (3.043s) [305.422697] Starting dynamic subtest: vcs1 [308.455229] Dynamic subtest vcs1: SUCCESS (3.042s) [308.464527] Starting dynamic subtest: vecs0 [311.494692] Dynamic subtest vecs0: SUCCESS (3.037s) [311.506477] Starting dynamic subtest: ccs0 [314.549884] Dynamic subtest ccs0: SUCCESS (3.052s) [314.552475] Subtest busy-accuracy-98: SUCCESS (18.273s) [314.692790] [055/131] (708s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [314.802900] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [314.807077] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [314.935722] [056/131] (708s left) gem_exec_parallel (basic) [315.006730] Starting subtest: basic [315.009145] Starting dynamic subtest: rcs0 [316.433454] Dynamic subtest rcs0: SUCCESS (1.426s) [316.444789] Starting dynamic subtest: bcs0 [317.900644] Dynamic subtest bcs0: SUCCESS (1.465s) [317.912709] Starting dynamic subtest: vcs0 [319.304190] Dynamic subtest vcs0: SUCCESS (1.401s) [319.316820] Starting dynamic subtest: vcs1 [321.248042] Dynamic subtest vcs1: SUCCESS (1.941s) [321.258476] Starting dynamic subtest: vecs0 [323.232175] Dynamic subtest vecs0: SUCCESS (1.981s) [323.243196] Starting dynamic subtest: ccs0 [324.709431] Dynamic subtest ccs0: SUCCESS (1.476s) [324.711880] Subtest basic: SUCCESS (9.703s) [324.920472] [057/131] (698s left) i915_drm_fdinfo (memory-info-resident) [324.964676] Starting subtest: memory-info-resident [324.967080] Starting dynamic subtest: smem0 [327.623134] Dynamic subtest smem0: SUCCESS (2.658s) [327.626542] Subtest memory-info-resident: SUCCESS (2.659s) [327.723469] [058/131] (696s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [327.824194] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [327.826165] Starting dynamic subtest: pipe-A-default-mode [328.115480] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [328.120097] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.286s) [328.945996] [059/131] (694s left) gem_basic (multigpu-create-close) [328.997786] Starting subtest: multigpu-create-close [329.001844] Subtest multigpu-create-close: SKIP (0.000s) [329.142051] [060/131] (694s left) kms_vblank (accuracy-idle) [329.232630] Starting subtest: accuracy-idle [329.234832] Starting dynamic subtest: pipe-A-eDP-1 [330.991420] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.759s) [331.005248] Starting dynamic subtest: pipe-D-eDP-1 [333.470758] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.475s) [333.473048] Subtest accuracy-idle: SUCCESS (4.238s) [334.310126] [061/131] (689s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [334.432785] Starting subtest: cursorB-vs-flipA-atomic [334.437524] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [334.603799] [062/131] (689s left) gem_exec_balancer (fairslice) [334.675279] Starting subtest: fairslice [337.532718] Subtest fairslice: SUCCESS (2.855s) [338.333266] [063/131] (685s left) gem_mmap (bad-object) [338.395630] Subtest bad-object: SKIP (0.000s) [338.472376] [064/131] (685s left) i915_selftest (mock) [342.151582] Starting subtest: mock [342.154629] Starting dynamic subtest: sanitycheck [342.942802] Dynamic subtest sanitycheck: SUCCESS (0.791s) [342.953034] Starting dynamic subtest: shmem [343.629707] Dynamic subtest shmem: SUCCESS (0.685s) [343.639698] Starting dynamic subtest: fence [351.434800] Dynamic subtest fence: SUCCESS (7.801s) [351.444540] Starting dynamic subtest: scatterlist [353.165700] Dynamic subtest scatterlist: SUCCESS (1.729s) [353.175662] Starting dynamic subtest: syncmap [356.556945] Dynamic subtest syncmap: SUCCESS (3.388s) [356.572260] Starting dynamic subtest: uncore [357.258809] Dynamic subtest uncore: SUCCESS (0.700s) [357.268690] Starting dynamic subtest: ring [357.939100] Dynamic subtest ring: SUCCESS (0.677s) [357.947705] Starting dynamic subtest: engine [358.712568] Dynamic subtest engine: SUCCESS (0.770s) [358.722399] Starting dynamic subtest: timelines [362.624962] Dynamic subtest timelines: SUCCESS (3.907s) [362.638545] Starting dynamic subtest: requests [366.253976] Dynamic subtest requests: SUCCESS (3.626s) [366.263796] Starting dynamic subtest: objects [367.098518] Dynamic subtest objects: SUCCESS (0.842s) [367.108261] Starting dynamic subtest: phys [368.000311] Dynamic subtest phys: SUCCESS (0.899s) [368.010236] Starting dynamic subtest: dmabuf [368.874921] Dynamic subtest dmabuf: SUCCESS (0.872s) [368.885180] Starting dynamic subtest: vma [374.121938] Dynamic subtest vma: SUCCESS (5.242s) [374.131957] Starting dynamic subtest: evict [375.550645] Dynamic subtest evict: SUCCESS (1.426s) [375.560677] Starting dynamic subtest: gtt [379.274970] Dynamic subtest gtt: SUCCESS (3.721s) [379.284719] Starting dynamic subtest: hugepages [380.237957] Dynamic subtest hugepages: SUCCESS (0.961s) [380.248436] Starting dynamic subtest: memory_region [382.871707] Dynamic subtest memory_region: SUCCESS (2.631s) [382.874419] Subtest mock: SUCCESS (40.711s) [382.905319] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [382.906029] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [382.909121] [065/131] (641s left) kms_pm_rpm (cursor) [386.434362] Starting subtest: cursor [386.439253] Subtest cursor: SKIP (0.000s) [386.873735] [FACT kms_pm_rpm (cursor)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [386.874947] [FACT kms_pm_rpm (cursor)] new: kernel.kmod_is_loaded.i915: true [386.878916] [066/131] (637s left) syncobj_wait (wait-for-submit-snapshot) [386.932667] Starting subtest: wait-for-submit-snapshot [387.011221] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [387.111831] [067/131] (637s left) kms_psr (fbc-psr2-basic) [387.209756] Starting subtest: fbc-psr2-basic [387.211666] Starting dynamic subtest: eDP-1 [387.215700] Dynamic subtest eDP-1: SKIP (0.000s) [387.219674] Subtest fbc-psr2-basic: SKIP (0.001s) [387.304579] [068/131] (636s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [387.365523] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [387.367677] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [387.501295] [069/131] (636s left) gem_gtt_cpu_tlb [387.631887] [070/131] (636s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [387.721685] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [387.723933] Starting dynamic subtest: pipe-A-eDP-1 [387.741678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [387.750176] Starting dynamic subtest: pipe-B-eDP-1 [387.766747] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [387.774549] Starting dynamic subtest: pipe-C-eDP-1 [387.790570] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [387.798207] Starting dynamic subtest: pipe-D-eDP-1 [387.814252] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [387.816093] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s) [389.902808] [071/131] (634s left) sysfs_heartbeat_interval (idempotent) [389.958334] Starting subtest: idempotent [389.960859] Starting dynamic subtest: vecs0 [389.963346] Dynamic subtest vecs0: SUCCESS (0.001s) [389.974153] Starting dynamic subtest: ccs0 [389.976051] Dynamic subtest ccs0: SUCCESS (0.001s) [389.984276] Starting dynamic subtest: vcs0 [389.986498] Dynamic subtest vcs0: SUCCESS (0.000s) [389.994403] Starting dynamic subtest: bcs0 [389.996292] Dynamic subtest bcs0: SUCCESS (0.001s) [390.003911] Starting dynamic subtest: rcs0 [390.005785] Dynamic subtest rcs0: SUCCESS (0.000s) [390.013421] Starting dynamic subtest: vcs1 [390.015552] Dynamic subtest vcs1: SUCCESS (0.000s) [390.017453] Subtest idempotent: SUCCESS (0.008s) [390.062543] [072/131] (634s left) kms_setmode (invalid-clone-single-crtc) [390.122668] Starting subtest: invalid-clone-single-crtc [390.129290] Subtest invalid-clone-single-crtc: SKIP (0.000s) [390.256782] [073/131] (634s left) kms_force_connector_basic (force-edid) [390.343278] Starting subtest: force-edid [390.708806] Subtest force-edid: SUCCESS (0.368s) [390.872455] [074/131] (633s left) gem_exec_schedule (fairslice) [390.946548] Starting subtest: fairslice [390.948289] Starting dynamic subtest: rcs0 [392.968160] Dynamic subtest rcs0: SUCCESS (2.022s) [392.978180] Starting dynamic subtest: bcs0 [394.984497] Dynamic subtest bcs0: SUCCESS (2.017s) [394.994524] Starting dynamic subtest: vcs0 [397.004551] Dynamic subtest vcs0: SUCCESS (2.017s) [397.015144] Starting dynamic subtest: vcs1 [399.020573] Dynamic subtest vcs1: SUCCESS (2.016s) [399.029834] Starting dynamic subtest: vecs0 [401.037502] Dynamic subtest vecs0: SUCCESS (2.015s) [401.047013] Starting dynamic subtest: ccs0 [403.057594] Dynamic subtest ccs0: SUCCESS (2.017s) [403.060224] Subtest fairslice: SUCCESS (12.109s) [403.378628] [075/131] (621s left) syncobj_timeline (reset-unsignaled) [403.450061] Starting subtest: reset-unsignaled [403.452295] Subtest reset-unsignaled: SUCCESS (0.000s) [403.600000] [076/131] (620s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [403.713228] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [410.656685] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.947s) [410.814393] [077/131] (613s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [410.944384] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [411.075579] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.133s) [411.224762] [078/131] (613s left) gem_mmap_wc (read-write) [411.285915] Subtest read-write: SKIP (0.000s) [411.358256] [079/131] (613s left) perf (buffer-fill) [411.497309] Starting subtest: buffer-fill [411.499343] Starting dynamic subtest: 0-rcs0 [413.745688] Dynamic subtest 0-rcs0: SUCCESS (2.249s) [413.757487] Starting dynamic subtest: 1-vcs0 [418.141733] Dynamic subtest 1-vcs0: SUCCESS (4.395s) [418.144688] Subtest buffer-fill: SUCCESS (6.647s) [418.187672] [080/131] (606s left) gem_userptr_blits (stress-mm-invalidate-close) [418.254558] Starting subtest: stress-mm-invalidate-close [420.401244] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [420.569752] [081/131] (604s left) gem_exec_reloc (basic-write-gtt-noreloc) [420.633666] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [420.727357] [082/131] (604s left) gem_exec_store (cachelines) [420.800634] Starting subtest: cachelines [420.802770] Starting dynamic subtest: rcs0 [420.912419] Dynamic subtest rcs0: SUCCESS (0.114s) [420.923526] Starting dynamic subtest: bcs0 [420.972685] Dynamic subtest bcs0: SUCCESS (0.058s) [420.984487] Starting dynamic subtest: vcs0 [421.037182] Dynamic subtest vcs0: SUCCESS (0.062s) [421.048010] Starting dynamic subtest: vcs1 [421.095690] Dynamic subtest vcs1: SUCCESS (0.057s) [421.105983] Starting dynamic subtest: vecs0 [421.155506] Dynamic subtest vecs0: SUCCESS (0.058s) [421.163864] Starting dynamic subtest: ccs0 [421.223727] Dynamic subtest ccs0: SUCCESS (0.066s) [421.226156] Subtest cachelines: SUCCESS (0.426s) [421.434179] [083/131] (603s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [421.540485] Starting subtest: plane-primary-toggle-with-vblank-wait [421.542696] Starting dynamic subtest: pipe-A-eDP-1 [421.712985] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s) [422.030777] Starting dynamic subtest: pipe-B-eDP-1 [422.975602] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.954s) [423.275299] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.735s) [424.122187] [084/131] (600s left) gem_exec_flush (basic-batch-kernel-default-wb) [424.186978] Starting subtest: basic-batch-kernel-default-wb [430.680851] Subtest basic-batch-kernel-default-wb: SUCCESS (6.495s) [430.900513] [085/131] (594s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [431.018254] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [435.434046] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.420s) [436.631235] [086/131] (588s left) kms_cursor_crc (cursor-rapid-movement-256x85) [436.893553] Starting subtest: cursor-rapid-movement-256x85 [436.938521] Subtest cursor-rapid-movement-256x85: SKIP (0.039s) [437.141821] [087/131] (587s left) gem_mmap_gtt (isolation) [437.209888] Subtest isolation: SKIP (0.000s) [437.282714] [088/131] (587s left) kms_psr (psr-cursor-mmap-cpu) [437.378388] Starting subtest: psr-cursor-mmap-cpu [437.380598] Starting dynamic subtest: eDP-1 [439.066053] Dynamic subtest eDP-1: SUCCESS (1.687s) [439.068342] Subtest psr-cursor-mmap-cpu: SUCCESS (1.688s) [439.920969] [089/131] (585s left) kms_atomic_transition (modeset-transition) [440.023664] Starting subtest: modeset-transition [440.026081] Starting dynamic subtest: 1x-outputs [450.870478] Dynamic subtest 1x-outputs: SUCCESS (10.847s) [450.872873] Subtest modeset-transition: SUCCESS (10.849s) [451.716367] [090/131] (573s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [451.799410] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [451.801576] Starting dynamic subtest: pipe-A-eDP-1 [451.937890] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.130s) [451.949251] Starting dynamic subtest: pipe-B-eDP-1 [451.968479] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [451.977417] Starting dynamic subtest: pipe-C-eDP-1 [451.996253] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s) [452.004703] Starting dynamic subtest: pipe-D-eDP-1 [452.023666] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [452.025962] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.142s) [454.305749] [091/131] (570s left) kms_pipe_crc_basic (read-crc) [454.397794] Starting subtest: read-crc [454.400068] Starting dynamic subtest: pipe-A-eDP-1 [455.098023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s) [455.107648] Starting dynamic subtest: pipe-B-eDP-1 [456.445763] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.346s) [456.454997] Starting dynamic subtest: pipe-C-eDP-1 [457.794440] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.348s) [457.804533] Starting dynamic subtest: pipe-D-eDP-1 [459.079651] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.284s) [459.082046] Subtest read-crc: SUCCESS (4.684s) [459.912870] [092/131] (565s left) api_intel_bb (object-noreloc-keep-cache-simple) [459.971310] Starting subtest: object-noreloc-keep-cache-simple [459.973497] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.004s) [460.140521] [093/131] (565s left) gem_exec_schedule (preempt-hang) [460.308906] Starting subtest: preempt-hang [460.310823] Starting dynamic subtest: rcs0 [460.548573] Dynamic subtest rcs0: SUCCESS (0.240s) [460.560795] Starting dynamic subtest: bcs0 [460.786280] Dynamic subtest bcs0: SUCCESS (0.236s) [460.797817] Starting dynamic subtest: vcs0 [461.011568] Dynamic subtest vcs0: SUCCESS (0.224s) [461.022002] Starting dynamic subtest: vcs1 [461.239912] Dynamic subtest vcs1: SUCCESS (0.228s) [461.250968] Starting dynamic subtest: vecs0 [461.467615] Dynamic subtest vecs0: SUCCESS (0.226s) [461.480226] Starting dynamic subtest: ccs0 [461.705187] Dynamic subtest ccs0: SUCCESS (0.236s) [461.707582] Subtest preempt-hang: SUCCESS (1.396s) [462.449662] [094/131] (562s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [462.572417] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [462.577033] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [462.743806] [095/131] (562s left) kms_scaling_modes (scaling-mode-full) [462.837896] Starting subtest: scaling-mode-full [462.840525] Starting dynamic subtest: pipe-A-eDP-1 [462.927056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.091s) [462.940392] Starting dynamic subtest: pipe-B-eDP-1 [464.092824] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s) [464.102523] Starting dynamic subtest: pipe-C-eDP-1 [465.266980] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.172s) [465.276038] Starting dynamic subtest: pipe-D-eDP-1 [466.478082] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s) [466.480376] Subtest scaling-mode-full: SUCCESS (3.643s) [467.712198] [096/131] (557s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [467.804120] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [467.806449] Starting dynamic subtest: pipe-A [467.865825] Dynamic subtest pipe-A: SUCCESS (0.064s) [467.875255] Starting dynamic subtest: pipe-B [468.975232] Dynamic subtest pipe-B: SUCCESS (1.107s) [468.986713] Starting dynamic subtest: pipe-C [470.066534] Dynamic subtest pipe-C: SUCCESS (1.090s) [470.075412] Starting dynamic subtest: pipe-D [471.165561] Dynamic subtest pipe-D: SUCCESS (1.098s) [471.167689] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.364s) [472.422949] [097/131] (553s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [472.519260] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [472.521513] Starting dynamic subtest: pipe-A [472.880151] Dynamic subtest pipe-A: SUCCESS (0.362s) [472.895352] Starting dynamic subtest: pipe-B [474.249833] Dynamic subtest pipe-B: SUCCESS (1.369s) [474.259071] Starting dynamic subtest: pipe-C [475.666194] Dynamic subtest pipe-C: SUCCESS (1.415s) [475.678506] Starting dynamic subtest: pipe-D [477.064011] Dynamic subtest pipe-D: SUCCESS (1.398s) [477.066323] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.547s) [478.314028] [098/131] (547s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [478.426511] Starting subtest: fbcpsr-slowdraw [503.504860] Subtest fbcpsr-slowdraw: SUCCESS (25.079s) [503.692051] [099/131] (521s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [503.778600] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [503.780881] Starting dynamic subtest: pipe-A-eDP-1 [503.789872] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [503.799972] Starting dynamic subtest: pipe-B-eDP-1 [503.809334] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [503.818202] Starting dynamic subtest: pipe-C-eDP-1 [503.826599] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [503.835269] Starting dynamic subtest: pipe-D-eDP-1 [503.843541] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [503.847629] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [506.011468] [100/131] (519s left) kms_addfb_basic (too-high) [506.114872] Starting subtest: too-high [506.117278] Subtest too-high: SUCCESS (0.000s) [506.249198] [101/131] (519s left) prime_vgem (fence-wait) [506.348693] Starting subtest: fence-wait [506.351003] Starting dynamic subtest: rcs0 [507.411329] Dynamic subtest rcs0: SUCCESS (1.061s) [507.422997] Starting dynamic subtest: bcs0 [508.484868] Dynamic subtest bcs0: SUCCESS (1.072s) [508.496331] Starting dynamic subtest: vcs0 [509.531135] Dynamic subtest vcs0: SUCCESS (1.045s) [509.542229] Starting dynamic subtest: vcs1 [510.569637] Dynamic subtest vcs1: SUCCESS (1.036s) [510.580847] Starting dynamic subtest: vecs0 [511.613937] Dynamic subtest vecs0: SUCCESS (1.041s) [511.625007] Starting dynamic subtest: ccs0 [512.657817] Dynamic subtest ccs0: SUCCESS (1.041s) [512.660557] Subtest fence-wait: SUCCESS (6.308s) [512.829548] [102/131] (512s left) kms_invalid_mode (bad-hsync-start) [512.925764] Starting subtest: bad-hsync-start [512.927993] Starting dynamic subtest: pipe-A-eDP-1 [513.209320] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [513.220900] Starting dynamic subtest: pipe-B-eDP-1 [513.223178] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [513.232272] Starting dynamic subtest: pipe-C-eDP-1 [513.234674] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [513.243739] Starting dynamic subtest: pipe-D-eDP-1 [513.246060] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [513.248459] Subtest bad-hsync-start: SUCCESS (0.290s) [514.108192] [103/131] (511s left) kms_big_fb (linear-8bpp-rotate-90) [514.219552] Starting subtest: linear-8bpp-rotate-90 [514.240692] Subtest linear-8bpp-rotate-90: SKIP (0.020s) [514.403977] [104/131] (511s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [519.362019] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area [519.366467] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s) [520.219782] [105/131] (505s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [520.329154] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [526.421163] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.094s) [527.616166] [106/131] (498s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [532.674870] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf [532.677251] Starting dynamic subtest: pipe-A-eDP-1 [544.057564] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.379s) [544.070768] Starting dynamic subtest: pipe-B-eDP-1 [555.463097] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.401s) [555.465496] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.784s) [556.312297] [107/131] (469s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [556.419175] Starting subtest: yf-tiled-32bpp-rotate-0 [556.423564] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [556.541225] [108/131] (469s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [556.645058] Starting subtest: fbcpsr-rgb565-draw-render [563.555655] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.912s) [563.726211] [109/131] (462s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [563.824336] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [563.828718] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [563.957066] [110/131] (462s left) kms_setmode (invalid-clone-single-crtc-stealing) [564.021416] Starting subtest: invalid-clone-single-crtc-stealing [564.027917] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [564.154528] [111/131] (461s left) kms_flip (2x-absolute-wf_vblank-interruptible) [564.253147] Starting subtest: 2x-absolute-wf_vblank-interruptible [564.262234] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s) [564.392156] [112/131] (461s left) gem_exec_params (sol-reset-invalid) [564.451702] Starting subtest: sol-reset-invalid [564.457159] Subtest sol-reset-invalid: SUCCESS (0.003s) [566.426213] [113/131] (459s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [566.526809] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [566.528905] Starting dynamic subtest: pipe-A-eDP-1 [566.548230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s) [566.559187] Starting dynamic subtest: pipe-B-eDP-1 [566.577680] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s) [566.586971] Starting dynamic subtest: pipe-C-eDP-1 [566.606825] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [566.618231] Starting dynamic subtest: pipe-D-eDP-1 [566.645312] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [566.647454] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s) [568.918459] [114/131] (457s left) gem_softpin (allocator-nopin) [568.990984] Starting subtest: allocator-nopin [569.085127] Subtest allocator-nopin: SUCCESS (0.097s) [569.252790] [115/131] (456s left) kms_chamelium_color (ctm-blue-to-red) [569.344845] Subtest ctm-blue-to-red: SKIP (0.000s) [569.390889] [116/131] (456s left) kms_addfb_basic (legacy-format) [569.451635] Starting subtest: legacy-format [569.483395] Subtest legacy-format: SUCCESS (0.030s) [569.651237] [117/131] (456s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [569.749300] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [574.021817] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.275s) [575.231936] [118/131] (451s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [575.312699] Starting subtest: coverage-vs-premult-vs-constant [575.585593] Starting dynamic subtest: pipe-A-eDP-1 [576.168258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.582s) [576.177999] Starting dynamic subtest: pipe-D-eDP-1 [577.472667] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s) [577.474841] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.161s) [578.318712] [119/131] (448s left) gem_exec_fence (basic-await) [578.499124] Starting subtest: basic-await [578.501956] Starting dynamic subtest: rcs0 [578.572292] Dynamic subtest rcs0: SUCCESS (0.073s) [578.585597] Starting dynamic subtest: bcs0 [578.645648] Dynamic subtest bcs0: SUCCESS (0.071s) [578.659656] Starting dynamic subtest: vcs0 [578.717068] Dynamic subtest vcs0: SUCCESS (0.071s) [578.732978] Starting dynamic subtest: vcs1 [578.801601] Dynamic subtest vcs1: SUCCESS (0.083s) [578.818856] Starting dynamic subtest: vecs0 [578.875503] Dynamic subtest vecs0: SUCCESS (0.071s) [578.888643] Starting dynamic subtest: ccs0 [578.947959] Dynamic subtest ccs0: SUCCESS (0.071s) [578.950654] Subtest basic-await: SUCCESS (0.450s) [580.409567] [120/131] (445s left) gem_userptr_blits (forbidden-operations) [580.474048] Starting subtest: forbidden-operations [580.478539] Subtest forbidden-operations: SKIP (0.000s) [580.634701] [121/131] (445s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [580.693690] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [580.698390] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [580.900510] [122/131] (445s left) prime_self_import (basic-with_one_bo_two_files) [580.937792] Starting subtest: basic-with_one_bo_two_files [580.959729] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s) [581.080093] [123/131] (445s left) gem_exec_schedule (reorder-wide) [581.265180] Subtest reorder-wide: SKIP (0.000s) [581.477278] [124/131] (445s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [581.573012] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [581.577450] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [581.695164] [125/131] (444s left) gem_ctx_param (invalid-get-no-zeromap) [581.748570] Starting subtest: invalid-get-no-zeromap [581.750725] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [581.887963] [126/131] (444s left) kms_psr (pr-suspend) [581.993828] Starting subtest: pr-suspend [581.997889] Subtest pr-suspend: SKIP (0.000s) [582.091140] [127/131] (444s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [582.163396] Subtest writes-after-reads-snoop: SKIP (0.000s) [582.246197] [128/131] (444s left) core_setmaster (master-drop-set-root) [582.331232] Starting subtest: master-drop-set-root [582.341125] Subtest master-drop-set-root: SUCCESS (0.010s) [582.391679] [129/131] (444s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [582.445661] Starting subtest: invalid-multi-wait-unsubmitted-signaled [582.447406] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [582.588080] [130/131] (444s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [582.976424] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [583.772926] [131/131] (443s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [583.838567] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [583.904184] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: gem_ctx_persistence results: parsing output: 2/ for test: i915_hangman results: parsing output: 3/ for test: kms_flip_scaled_crc results: parsing output: 4/ for test: tools_test results: parsing output: 5/ for test: perf results: parsing output: 6/ for test: i915_pm_rpm results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: gem_lmem_swapping results: parsing output: 12/ for test: gem_exec_whisper results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_content_protection results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: kms_prime results: parsing output: 17/ for test: gem_mmap_wc results: parsing output: 18/ for test: kms_cursor_crc results: parsing output: 19/ for test: kms_cursor_legacy results: parsing output: 20/ for test: gem_eio results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gem_pxp results: parsing output: 24/ for test: kms_cursor_crc results: parsing output: 25/ for test: gen9_exec_parse results: parsing output: 26/ for test: kms_vblank results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: syncobj_timeline results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_psr results: parsing output: 31/ for test: kms_lease results: parsing output: 32/ for test: gem_exec_create results: parsing output: 33/ for test: gem_create results: parsing output: 34/ for test: kms_chamelium_frames results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: perf_pmu results: parsing output: 37/ for test: gem_exec_fence results: parsing output: 38/ for test: prime_vgem results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: gem_ppgtt results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_dither results: parsing output: 43/ for test: gem_pwrite_snooped results: parsing output: 44/ for test: kms_busy results: parsing output: 45/ for test: gem_userptr_blits results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_draw_crc results: parsing output: 48/ for test: syncobj_timeline results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: syncobj_wait results: parsing output: 52/ for test: kms_cursor_legacy results: parsing output: 53/ for test: perf_pmu results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_exec_parallel results: parsing output: 56/ for test: i915_drm_fdinfo results: parsing output: 57/ for test: kms_flip_scaled_crc results: parsing output: 58/ for test: gem_basic results: parsing output: 59/ for test: kms_vblank results: parsing output: 60/ for test: kms_cursor_legacy results: parsing output: 61/ for test: gem_exec_balancer results: parsing output: 62/ for test: gem_mmap results: parsing output: 63/ for test: i915_selftest results: parsing output: 64/ for test: kms_pm_rpm results: parsing output: 65/ for test: syncobj_wait results: parsing output: 66/ for test: kms_psr results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: gem_gtt_cpu_tlb results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: sysfs_heartbeat_interval results: parsing output: 71/ for test: kms_setmode results: parsing output: 72/ for test: kms_force_connector_basic results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gem_pxp results: parsing output: 77/ for test: gem_mmap_wc results: parsing output: 78/ for test: perf results: parsing output: 79/ for test: gem_userptr_blits results: parsing output: 80/ for test: gem_exec_reloc results: parsing output: 81/ for test: gem_exec_store results: parsing output: 82/ for test: kms_atomic_transition results: parsing output: 83/ for test: gem_exec_flush results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_cursor_crc results: parsing output: 86/ for test: gem_mmap_gtt results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_atomic_transition results: parsing output: 89/ for test: kms_ccs results: parsing output: 90/ for test: kms_pipe_crc_basic results: parsing output: 91/ for test: api_intel_bb results: parsing output: 92/ for test: gem_exec_schedule results: parsing output: 93/ for test: kms_cursor_legacy results: parsing output: 94/ for test: kms_scaling_modes results: parsing output: 95/ for test: kms_plane_scaling results: parsing output: 96/ for test: kms_plane_scaling results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: kms_addfb_basic results: parsing output: 100/ for test: prime_vgem results: parsing output: 101/ for test: kms_invalid_mode results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_psr2_sf results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_psr2_sf results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_setmode results: parsing output: 110/ for test: kms_flip results: parsing output: 111/ for test: gem_exec_params results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: gem_softpin results: parsing output: 114/ for test: kms_chamelium_color results: parsing output: 115/ for test: kms_addfb_basic results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_plane_alpha_blend results: parsing output: 118/ for test: gem_exec_fence results: parsing output: 119/ for test: gem_userptr_blits results: parsing output: 120/ for test: gem_render_copy results: parsing output: 121/ for test: prime_self_import results: parsing output: 122/ for test: gem_exec_schedule results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_ctx_param results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: gem_partial_pwrite_pread results: parsing output: 127/ for test: core_setmaster results: parsing output: 128/ for test: syncobj_wait results: parsing output: 129/ for test: kms_chamelium_hpd results: parsing output: 130/ for test: kms_pipe_b_c_ivb Done.