[88.917574] Initializing watchdogs [88.917767] /dev/watchdog0 [88.979056] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [88.993953] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [89.001144] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [89.006176] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [89.228990] Starting subtest: fbcpsr-1p-rte [89.234686] Subtest fbcpsr-1p-rte: SKIP (0.000s) [89.379546] [002/133] (960s left) prime_self_import (basic-with_fd_dup) [89.480919] Starting subtest: basic-with_fd_dup [89.489315] Subtest basic-with_fd_dup: SUCCESS (0.010s) [89.633462] [003/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [89.832227] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [89.835163] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s) [89.964434] [004/133] (959s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [90.153020] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [90.158110] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [101.264509] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.090s) [101.282313] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [112.299966] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.030s) [112.317263] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [123.275192] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.964s) [123.276696] Subtest 2x-plain-flip-fb-recreate-interruptible: SUCCESS (33.097s) [123.867528] [005/133] (925s left) core_getstats (basic) [123.970435] Starting subtest: basic [123.971497] Subtest basic: SUCCESS (0.000s) [124.128067] [006/133] (925s left) api_intel_allocator (standalone) [124.227595] Starting subtest: standalone [124.276203] Subtest standalone: SUCCESS (0.049s) [124.401361] [007/133] (925s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [124.507957] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [124.619550] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s) [124.748837] [008/133] (925s left) kms_addfb_basic (size-max) [124.921077] Starting subtest: size-max [124.922383] Subtest size-max: SUCCESS (0.000s) [125.103483] [009/133] (925s left) kms_atomic_interruptible (legacy-setmode) [125.278742] Starting subtest: legacy-setmode [125.280060] Starting dynamic subtest: pipe-A-HDMI-A-1 [132.090170] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.807s) [132.094164] Subtest legacy-setmode: SUCCESS (6.813s) [132.396465] [010/133] (917s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [132.587330] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [133.211472] Starting dynamic subtest: pipe-A-HDMI-A-1-yf [135.613811] Dynamic subtest pipe-A-HDMI-A-1-yf: SUCCESS (2.401s) [135.629841] Starting dynamic subtest: pipe-A-HDMI-A-1-yf [137.643060] Dynamic subtest pipe-A-HDMI-A-1-yf: SUCCESS (2.029s) [137.660151] Starting dynamic subtest: pipe-A-HDMI-A-1-yf [139.678175] Dynamic subtest pipe-A-HDMI-A-1-yf: SUCCESS (2.031s) [139.700865] Starting dynamic subtest: pipe-A-HDMI-A-1-x [141.775639] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.098s) [142.149898] Starting dynamic subtest: pipe-A-HDMI-A-2-yf [144.481854] Dynamic subtest pipe-A-HDMI-A-2-yf: SUCCESS (2.355s) [144.497794] Starting dynamic subtest: pipe-A-HDMI-A-2-yf [146.511394] Dynamic subtest pipe-A-HDMI-A-2-yf: SUCCESS (2.028s) [146.527329] Starting dynamic subtest: pipe-A-HDMI-A-2-yf [148.545043] Dynamic subtest pipe-A-HDMI-A-2-yf: SUCCESS (2.033s) [148.565729] Starting dynamic subtest: pipe-A-HDMI-A-2-x [150.643221] Dynamic subtest pipe-A-HDMI-A-2-x: SUCCESS (2.098s) [151.014958] Starting dynamic subtest: pipe-B-HDMI-A-1-yf [153.389645] Dynamic subtest pipe-B-HDMI-A-1-yf: SUCCESS (2.392s) [153.405534] Starting dynamic subtest: pipe-B-HDMI-A-1-yf [155.418872] Dynamic subtest pipe-B-HDMI-A-1-yf: SUCCESS (2.028s) [155.434957] Starting dynamic subtest: pipe-B-HDMI-A-1-yf [157.451128] Dynamic subtest pipe-B-HDMI-A-1-yf: SUCCESS (2.031s) [157.471022] Starting dynamic subtest: pipe-B-HDMI-A-1-x [159.533289] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.082s) [159.874348] Starting dynamic subtest: pipe-B-HDMI-A-2-yf [162.215126] Dynamic subtest pipe-B-HDMI-A-2-yf: SUCCESS (2.361s) [162.231405] Starting dynamic subtest: pipe-B-HDMI-A-2-yf [164.245676] Dynamic subtest pipe-B-HDMI-A-2-yf: SUCCESS (2.027s) [164.261314] Starting dynamic subtest: pipe-B-HDMI-A-2-yf [166.275247] Dynamic subtest pipe-B-HDMI-A-2-yf: SUCCESS (2.033s) [166.296788] Starting dynamic subtest: pipe-B-HDMI-A-2-x [168.358495] Dynamic subtest pipe-B-HDMI-A-2-x: SUCCESS (2.082s) [168.718400] Starting dynamic subtest: pipe-C-HDMI-A-1-yf [171.089462] Dynamic subtest pipe-C-HDMI-A-1-yf: SUCCESS (2.390s) [171.105940] Starting dynamic subtest: pipe-C-HDMI-A-1-y [173.386972] Dynamic subtest pipe-C-HDMI-A-1-y: SUCCESS (2.296s) [173.404255] Starting dynamic subtest: pipe-C-HDMI-A-1-x [175.469857] Dynamic subtest pipe-C-HDMI-A-1-x: SUCCESS (2.082s) [175.820050] Starting dynamic subtest: pipe-C-HDMI-A-2-yf [178.185475] Dynamic subtest pipe-C-HDMI-A-2-yf: SUCCESS (2.388s) [178.203977] Starting dynamic subtest: pipe-C-HDMI-A-2-y [180.482072] Dynamic subtest pipe-C-HDMI-A-2-y: SUCCESS (2.295s) [180.503555] Starting dynamic subtest: pipe-C-HDMI-A-2-x [182.568157] Dynamic subtest pipe-C-HDMI-A-2-x: SUCCESS (2.083s) [182.569767] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (49.978s) [183.156854] [011/133] (867s left) gem_create (create-clear) [183.261056] Starting subtest: create-clear [183.266093] Starting dynamic subtest: smem0 [215.916296] Dynamic subtest smem0: SUCCESS (32.632s) [215.918656] Subtest create-clear: SUCCESS (32.633s) [216.143582] [012/133] (834s left) i915_hangman (engine-engine-error) [216.278256] Starting subtest: engine-engine-error [216.280346] Starting dynamic subtest: rcs0 [216.362675] Dynamic subtest rcs0: SUCCESS (0.086s) [216.382881] Starting dynamic subtest: bcs0 [216.386319] Dynamic subtest bcs0: SKIP (0.004s) [216.407405] Starting dynamic subtest: vcs0 [216.451259] Dynamic subtest vcs0: SUCCESS (0.074s) [216.468214] Starting dynamic subtest: vecs0 [216.524371] Dynamic subtest vecs0: SUCCESS (0.074s) [216.525626] Subtest engine-engine-error: SUCCESS (0.249s) [216.708303] [013/133] (833s left) gem_ctx_isolation (preservation) [216.827109] Starting subtest: preservation [216.829668] Starting dynamic subtest: rcs0 [217.211452] Dynamic subtest rcs0: SUCCESS (0.385s) [217.228363] Starting dynamic subtest: bcs0 [217.869921] Dynamic subtest bcs0: SUCCESS (0.658s) [217.893840] Starting dynamic subtest: vcs0 [218.273325] Dynamic subtest vcs0: SUCCESS (0.402s) [218.291859] Starting dynamic subtest: vecs0 [218.672897] Dynamic subtest vecs0: SUCCESS (0.399s) [218.676101] Subtest preservation: SUCCESS (1.848s) [218.927250] [014/133] (831s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [219.116429] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [219.120245] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [219.254876] [015/133] (831s left) gem_exec_reloc (basic-cpu-wc-noreloc) [219.369187] Starting subtest: basic-cpu-wc-noreloc [219.380735] Subtest basic-cpu-wc-noreloc: SUCCESS (0.009s) [219.574309] [016/133] (831s left) gem_exec_capture (capture-invisible) [219.684477] Starting subtest: capture-invisible [219.685484] Starting dynamic subtest: smem0 [219.689164] Dynamic subtest smem0: SKIP (0.000s) [219.691160] Subtest capture-invisible: SKIP (0.001s) [219.824385] [017/133] (830s left) gem_exec_reloc (basic-write-gtt) [219.935093] Starting subtest: basic-write-gtt [219.954936] Subtest basic-write-gtt: SUCCESS (0.018s) [220.158485] [018/133] (830s left) gem_exec_params (invalid-fence-in) [220.275512] Starting subtest: invalid-fence-in [220.277228] Subtest invalid-fence-in: SUCCESS (0.003s) [220.423211] [019/133] (830s left) gen9_exec_parse (bb-large) [220.550212] Starting subtest: bb-large [266.080674] Subtest bb-large: SUCCESS (45.528s) [266.347803] [020/133] (784s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [266.653147] Starting subtest: primary-4-tiled-reflect-x-0 [266.655436] Subtest primary-4-tiled-reflect-x-0: SKIP (0.003s) [266.781402] [021/133] (784s left) gem_mmap_gtt (isolation) [266.888135] Starting subtest: isolation [266.894885] Subtest isolation: SUCCESS (0.008s) [267.061176] [022/133] (784s left) kms_addfb_basic (bad-pitch-999) [267.164368] Starting subtest: bad-pitch-999 [267.165955] Subtest bad-pitch-999: SUCCESS (0.000s) [267.381399] [023/133] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [267.586306] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [270.518829] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SUCCESS (2.933s) [270.715394] [024/133] (780s left) kms_async_flips (test-cursor) [270.902494] Starting subtest: test-cursor [271.511172] Starting dynamic subtest: pipe-A-HDMI-A-1 [271.666949] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.155s) [272.035953] Starting dynamic subtest: pipe-A-HDMI-A-2 [272.167388] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.154s) [272.537277] Starting dynamic subtest: pipe-B-HDMI-A-1 [272.694121] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.175s) [273.037706] Starting dynamic subtest: pipe-B-HDMI-A-2 [273.171718] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.155s) [273.518224] Starting dynamic subtest: pipe-C-HDMI-A-1 [273.666033] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.163s) [274.040887] Starting dynamic subtest: pipe-C-HDMI-A-2 [274.166429] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.160s) [274.170938] Subtest test-cursor: SUCCESS (3.268s) [274.814081] [025/133] (776s left) gem_userptr_blits (invalid-null-pointer) [274.941511] Starting subtest: invalid-null-pointer [274.944199] Subtest invalid-null-pointer: SUCCESS (0.006s) [275.132401] [026/133] (776s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [275.335147] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [277.899923] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.565s) [278.213457] [027/133] (773s left) kms_big_fb (x-tiled-64bpp-rotate-180) [278.425429] Starting subtest: x-tiled-64bpp-rotate-180 [283.350733] Subtest x-tiled-64bpp-rotate-180: SUCCESS (4.924s) [283.852742] [028/133] (767s left) gem_exec_fence (long-history) [284.482320] Starting subtest: long-history [290.246883] Subtest long-history: SUCCESS (5.752s) [290.937305] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true [290.941535] [029/133] (760s left) i915_query (test-query-geometry-subslices) [291.042747] Starting subtest: test-query-geometry-subslices [291.048112] Subtest test-query-geometry-subslices: SKIP (0.000s) [291.176478] [030/133] (760s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [291.379104] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [291.385240] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [293.136348] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.748s) [293.157859] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [294.799453] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.661s) [294.824952] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [296.417953] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.613s) [296.421066] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SUCCESS (5.040s) [297.041063] [031/133] (754s left) gem_exec_balancer (bonded-true-hang) [297.287941] Starting subtest: bonded-true-hang [301.481831] Subtest bonded-true-hang: SUCCESS (4.197s) [301.636706] [032/133] (750s left) kms_lease (implicit-plane-lease) [301.820092] Starting subtest: implicit-plane-lease [301.839082] Subtest implicit-plane-lease: SUCCESS (0.005s) [301.988909] [033/133] (750s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [302.162164] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [302.166630] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [302.331879] [034/133] (749s left) gem_render_copy_redux (flink) [302.451353] Starting subtest: flink [305.329904] Subtest flink: SUCCESS (2.878s) [305.488185] [035/133] (746s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [305.611218] Starting subtest: mixed-tiled-to-y-tiled-ccs [305.613080] Starting dynamic subtest: smem [305.841063] Dynamic subtest smem: SUCCESS (0.230s) [305.842143] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.233s) [306.117667] [036/133] (746s left) gem_mmap_gtt (basic-small-bo-tiledy) [306.213221] Starting subtest: basic-small-bo-tiledY [306.454234] Subtest basic-small-bo-tiledY: SUCCESS (0.237s) [306.670876] [037/133] (745s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [307.497046] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [307.786138] [038/133] (744s left) kms_big_fb (linear-64bpp-rotate-180) [308.015067] Starting subtest: linear-64bpp-rotate-180 [313.630740] Subtest linear-64bpp-rotate-180: SUCCESS (5.616s) [314.160139] [039/133] (738s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [314.351082] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [316.748929] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (2.398s) [317.026965] [040/133] (735s left) gem_exec_parallel (basic) [317.158255] Starting subtest: basic [317.160522] Starting dynamic subtest: rcs0 [320.322393] Dynamic subtest rcs0: SUCCESS (3.163s) [320.345308] Starting dynamic subtest: bcs0 [323.574938] Dynamic subtest bcs0: SUCCESS (3.253s) [323.605132] Starting dynamic subtest: vcs0 [326.681368] Dynamic subtest vcs0: SUCCESS (3.100s) [326.707180] Starting dynamic subtest: vecs0 [330.670222] Dynamic subtest vecs0: SUCCESS (3.989s) [330.671373] Subtest basic: SUCCESS (13.514s) [330.925973] [041/133] (721s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [331.114786] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [331.117239] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [331.269777] [042/133] (721s left) gem_exec_schedule (smoketest) [331.546199] Starting subtest: smoketest [331.547210] Starting dynamic subtest: rcs0 [336.963199] Dynamic subtest rcs0: SUCCESS (5.413s) [336.985072] Starting dynamic subtest: bcs0 [342.390206] Dynamic subtest bcs0: SUCCESS (5.428s) [342.415264] Starting dynamic subtest: vcs0 [347.811919] Dynamic subtest vcs0: SUCCESS (5.420s) [347.837094] Starting dynamic subtest: vecs0 [353.243884] Dynamic subtest vecs0: SUCCESS (5.428s) [353.244852] Subtest smoketest: SUCCESS (21.702s) [353.539310] [043/133] (699s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [353.721364] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [353.851711] [044/133] (699s left) gem_set_tiling_vs_blt (tiled-to-tiled) [353.966982] Starting subtest: tiled-to-tiled [354.088318] Subtest tiled-to-tiled: SUCCESS (0.120s) [354.243733] [045/133] (699s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [354.448250] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [357.434921] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.982s) [357.736778] [046/133] (695s left) syncobj_timeline (invalid-single-wait-unsubmitted) [357.840757] Starting subtest: invalid-single-wait-unsubmitted [357.844912] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.001s) [357.989376] [047/133] (695s left) kms_psr (pr-cursor-mmap-gtt) [358.168945] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [358.278696] [048/133] (695s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [358.405093] Starting subtest: yf-tiled-ccs-to-y-tiled [358.407250] Starting dynamic subtest: smem [358.657428] Dynamic subtest smem: SUCCESS (0.252s) [358.658644] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.256s) [358.923091] [049/133] (694s left) gem_media_vme [359.146600] [050/133] (694s left) gem_caching (writes) [359.258382] Starting subtest: writes [373.539742] Subtest writes: SUCCESS (14.284s) [373.707353] [051/133] (680s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [373.918449] Starting subtest: psr-rgb101010-draw-mmap-wc [373.922109] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s) [374.072890] [052/133] (679s left) syncobj_timeline (multi-wait-for-submit-signaled) [374.176150] Starting subtest: multi-wait-for-submit-signaled [374.181718] Subtest multi-wait-for-submit-signaled: SUCCESS (0.003s) [374.340739] [053/133] (679s left) perf_pmu (busy-accuracy-50) [374.452422] Starting subtest: busy-accuracy-50 [374.454096] Starting dynamic subtest: rcs0 [376.007795] Dynamic subtest rcs0: SUCCESS (1.552s) [376.031841] Starting dynamic subtest: bcs0 [377.567199] Dynamic subtest bcs0: SUCCESS (1.555s) [377.590037] Starting dynamic subtest: vcs0 [379.123214] Dynamic subtest vcs0: SUCCESS (1.552s) [379.145707] Starting dynamic subtest: vecs0 [380.671217] Dynamic subtest vecs0: SUCCESS (1.550s) [380.672304] Subtest busy-accuracy-50: SUCCESS (6.218s) [380.810518] [054/133] (673s left) gem_exec_schedule (implicit-boths) [380.942277] Starting subtest: implicit-boths [380.944567] Starting dynamic subtest: rcs0 [381.066604] Dynamic subtest rcs0: SUCCESS (0.119s) [381.097117] Starting dynamic subtest: bcs0 [381.197224] Dynamic subtest bcs0: SUCCESS (0.130s) [381.232406] Starting dynamic subtest: vcs0 [381.322972] Dynamic subtest vcs0: SUCCESS (0.121s) [381.358695] Starting dynamic subtest: vecs0 [381.441308] Dynamic subtest vecs0: SUCCESS (0.116s) [381.442599] Subtest implicit-boths: SUCCESS (0.497s) [381.843588] [055/133] (672s left) kms_busy (extended-modeset-hang-oldfb) [382.044271] Starting subtest: extended-modeset-hang-oldfb [382.046170] Starting dynamic subtest: pipe-A [386.338394] Dynamic subtest pipe-A: SUCCESS (4.292s) [386.390993] Starting dynamic subtest: pipe-C [391.151177] Dynamic subtest pipe-C: SUCCESS (4.801s) [391.156826] Subtest extended-modeset-hang-oldfb: SUCCESS (9.118s) [391.509725] [056/133] (662s left) gem_linear_blits (normal) [391.849182] Starting subtest: normal [406.462883] Subtest normal: SUCCESS (14.618s) [406.620490] [057/133] (647s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [406.950322] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [406.955237] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [407.110242] [058/133] (647s left) gem_lmem_evict (dontneed-evict-race) [407.235870] Subtest dontneed-evict-race: SKIP (0.000s) [407.350878] [059/133] (647s left) prime_mmap (test_aperture_limit) [407.459642] Starting subtest: test_aperture_limit [407.461570] Starting dynamic subtest: test_aperture_limit-smem [407.484570] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.026s) [407.491823] Subtest test_aperture_limit: SUCCESS (0.030s) [407.626810] [060/133] (647s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [407.733068] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [407.842000] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s) [408.011670] [061/133] (646s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [408.208346] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [408.213102] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [408.361514] [062/133] (646s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [408.565134] Starting subtest: fbc-1p-primscrn-cur-indfb-move [411.530759] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.967s) [411.850754] [063/133] (643s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [412.040417] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [414.167618] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SUCCESS (2.126s) [414.376311] [064/133] (640s left) gem_vm_create (execbuf) [414.493631] Starting subtest: execbuf [414.501851] Subtest execbuf: SUCCESS (0.010s) [414.660119] [065/133] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [414.865175] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [417.383502] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.518s) [417.576386] [066/133] (637s left) gem_exec_reloc (basic-cpu) [417.689959] Starting subtest: basic-cpu [417.709343] Subtest basic-cpu: SUCCESS (0.019s) [417.925282] [067/133] (637s left) kms_cursor_crc (cursor-random-32x32) [418.121183] Starting subtest: cursor-random-32x32 [418.290142] Subtest cursor-random-32x32: SKIP (0.163s) [418.488301] [068/133] (636s left) kms_pm_rpm (dpms-mode-unset-lpsp) [420.573344] Starting subtest: dpms-mode-unset-lpsp [420.934198] Subtest dpms-mode-unset-lpsp: SKIP (0.359s) [421.709102] [069/133] (633s left) kms_chamelium_edid (hdmi-mode-timings) [422.321420] Subtest hdmi-mode-timings: SKIP (0.000s) [422.716871] [070/133] (633s left) kms_cursor_crc (cursor-onscreen-64x21) [422.912123] Starting subtest: cursor-onscreen-64x21 [422.958736] Starting dynamic subtest: pipe-A-HDMI-A-1 [425.714380] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.756s) [425.821823] Starting dynamic subtest: pipe-C-HDMI-A-1 [428.217858] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.417s) [428.219845] Subtest cursor-onscreen-64x21: SUCCESS (5.306s) [428.620174] [071/133] (627s left) gem_ctx_param (set-priority-invalid-size) [428.730329] Starting subtest: set-priority-invalid-size [428.734120] Subtest set-priority-invalid-size: SUCCESS (0.000s) [428.893580] [072/133] (627s left) kms_psr (fbc-pr-sprite-mmap-gtt) [429.078094] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [429.190894] [073/133] (626s left) gem_exec_whisper (basic-fds-forked) [429.324888] Starting subtest: basic-fds-forked [438.813970] Subtest basic-fds-forked: SUCCESS (9.487s) [439.088603] [074/133] (617s left) gem_ppgtt (shrink-vs-evict-pinned) [439.204248] Starting subtest: shrink-vs-evict-pinned [444.260295] Subtest shrink-vs-evict-pinned: SUCCESS (5.054s) [444.389421] [075/133] (611s left) kms_chamelium_audio (hdmi-audio) [445.042238] Subtest hdmi-audio: SKIP (0.000s) [445.399067] [076/133] (610s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [445.619608] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [445.624265] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [445.763258] [077/133] (610s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [445.944092] Starting subtest: cursorA-vs-flipA-toggle [457.256287] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.308s) [457.542136] [078/133] (599s left) kms_content_protection (uevent) [457.772203] Starting subtest: uevent [457.806584] Subtest uevent: SKIP (0.034s) [457.941842] [079/133] (598s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [458.122981] Starting subtest: plane-scaler-with-clipping-clamping-rotation [458.124157] Starting dynamic subtest: pipe-A [463.215876] Dynamic subtest pipe-A: SKIP (5.087s) [463.267229] Starting dynamic subtest: pipe-B [469.286057] Dynamic subtest pipe-B: SKIP (6.068s) [469.336111] Starting dynamic subtest: pipe-C [473.897501] Dynamic subtest pipe-C: SKIP (4.601s) [473.905252] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (15.767s) [474.377711] [080/133] (582s left) gem_softpin (allocator-evict) [474.554309] Starting subtest: allocator-evict [474.557070] Starting dynamic subtest: rcs0 [502.325727] Dynamic subtest rcs0: SUCCESS (27.766s) [502.349970] Starting dynamic subtest: bcs0 [528.816580] Dynamic subtest bcs0: SUCCESS (26.485s) [528.846074] Starting dynamic subtest: vcs0 [554.969424] Dynamic subtest vcs0: SUCCESS (26.148s) [554.998186] Starting dynamic subtest: vecs0 [581.235430] Dynamic subtest vecs0: SUCCESS (26.258s) [581.236675] Subtest allocator-evict: SUCCESS (106.681s) [581.392461] [081/133] (475s left) sw_sync (timeline_closed) [581.609948] Starting subtest: timeline_closed [581.613196] Subtest timeline_closed: SUCCESS (0.001s) [581.736249] [082/133] (475s left) prime_mmap (test_refcounting) [581.841235] Starting subtest: test_refcounting [581.842292] Starting dynamic subtest: test_refcounting-smem [581.849179] Dynamic subtest test_refcounting-smem: SUCCESS (0.009s) [581.850720] Subtest test_refcounting: SUCCESS (0.011s) [582.002475] [083/133] (475s left) kms_big_fb (4-tiled-8bpp-rotate-180) [582.222072] Starting subtest: 4-tiled-8bpp-rotate-180 [582.224325] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s) [582.379608] [084/133] (474s left) kms_plane_alpha_blend (alpha-transparent-fb) [582.580243] Starting subtest: alpha-transparent-fb [582.760653] Starting dynamic subtest: pipe-A-HDMI-A-1 [583.516913] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.494s) [583.545661] Starting dynamic subtest: pipe-C-HDMI-A-1 [584.062508] Dynamic subtest pipe-C-HDMI-A-1: FAIL (0.482s) [584.065215] Subtest alpha-transparent-fb: FAIL (1.168s) [584.322863] [085/133] (472s left) gem_ctx_shared (q-smoketest) [584.456818] Starting subtest: Q-smoketest [584.459273] Starting dynamic subtest: rcs0 [589.890860] Dynamic subtest rcs0: SUCCESS (5.432s) [589.917549] Starting dynamic subtest: bcs0 [595.320852] Dynamic subtest bcs0: SUCCESS (5.427s) [595.351253] Starting dynamic subtest: vcs0 [600.748652] Dynamic subtest vcs0: SUCCESS (5.421s) [600.771688] Starting dynamic subtest: vecs0 [606.181430] Dynamic subtest vecs0: SUCCESS (5.427s) [606.182481] Subtest Q-smoketest: SUCCESS (21.725s) [606.444481] [086/133] (450s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [606.665075] Starting subtest: yf-tiled-16bpp-rotate-90 [607.069900] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.404s) [607.342611] [087/133] (450s left) syncobj_timeline (transfer-timeline-point) [607.456251] Starting subtest: transfer-timeline-point [607.458555] Subtest transfer-timeline-point: SUCCESS (0.001s) [607.607385] [088/133] (449s left) gem_exec_reloc (basic-wc-gtt-active) [607.722188] Starting subtest: basic-wc-gtt-active [607.859513] Subtest basic-wc-gtt-active: SUCCESS (0.137s) [608.105743] [089/133] (449s left) prime_busy (after-wait) [608.219052] Starting subtest: after-wait [608.235080] Starting dynamic subtest: rcs0 [608.242679] Dynamic subtest rcs0: SUCCESS (0.011s) [608.282463] Starting dynamic subtest: bcs0 [608.287073] Dynamic subtest bcs0: SUCCESS (0.011s) [608.311780] Starting dynamic subtest: vcs0 [608.313097] Dynamic subtest vcs0: SUCCESS (0.016s) [608.335727] Starting dynamic subtest: vecs0 [608.336855] Dynamic subtest vecs0: SUCCESS (0.008s) [608.404296] Subtest after-wait: SUCCESS (0.186s) [608.559166] [090/133] (449s left) sysfs_timeslice_duration (idempotent) [608.674878] Starting subtest: idempotent [608.676419] Starting dynamic subtest: vecs0 [608.677352] Dynamic subtest vecs0: SUCCESS (0.002s) [608.710084] Starting dynamic subtest: vcs0 [608.711893] Dynamic subtest vcs0: SUCCESS (0.002s) [608.735091] Starting dynamic subtest: bcs0 [608.736309] Dynamic subtest bcs0: SUCCESS (0.002s) [608.759288] Starting dynamic subtest: rcs0 [608.760180] Dynamic subtest rcs0: SUCCESS (0.002s) [608.761042] Subtest idempotent: SUCCESS (0.023s) [608.846622] [091/133] (448s left) i915_pm_rps (basic-api) [608.963513] Starting subtest: basic-api [608.973747] Subtest basic-api: SUCCESS (0.011s) [609.126233] [092/133] (448s left) kms_hdmi_inject (inject-audio) [609.651836] Starting subtest: inject-audio [609.917862] Subtest inject-audio: SUCCESS (0.262s) [610.404101] [093/133] (447s left) kms_vblank (ts-continuation-dpms-rpm) [610.601904] Starting subtest: ts-continuation-dpms-rpm [610.607292] Starting dynamic subtest: pipe-A-HDMI-A-1 [612.953093] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.343s) [613.003646] Starting dynamic subtest: pipe-A-HDMI-A-2 [613.995747] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.034s) [614.035305] Starting dynamic subtest: pipe-C-HDMI-A-1 [615.148359] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.136s) [615.206191] Starting dynamic subtest: pipe-C-HDMI-A-2 [616.022411] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.863s) [616.024128] Subtest ts-continuation-dpms-rpm: SUCCESS (5.423s) [616.359848] [094/133] (441s left) i915_drm_fdinfo (virtual-busy-hang) [616.479213] Starting subtest: virtual-busy-hang [620.694773] Subtest virtual-busy-hang: SUCCESS (4.216s) [620.851843] [095/133] (437s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [621.059996] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [621.065961] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s) [621.257504] [096/133] (437s left) kms_big_fb (y-tiled-32bpp-rotate-270) [621.474121] Starting subtest: y-tiled-32bpp-rotate-270 [626.317889] Subtest y-tiled-32bpp-rotate-270: SUCCESS (4.849s) [626.761590] [097/133] (431s left) kms_psr2_su (page_flip-xrgb8888) [626.865783] Subtest page_flip-XRGB8888: SKIP (0.000s) [626.991227] [098/133] (431s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [627.190234] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [628.468618] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.284s) [628.800365] [099/133] (429s left) kms_plane_scaling (planes-upscale-factor-0-25) [629.000781] Starting subtest: planes-upscale-factor-0-25 [629.002863] Starting dynamic subtest: pipe-A [629.369077] Dynamic subtest pipe-A: SUCCESS (0.372s) [629.398360] Starting dynamic subtest: pipe-B [629.781384] Dynamic subtest pipe-B: SUCCESS (0.409s) [629.811673] Starting dynamic subtest: pipe-C [629.890103] Dynamic subtest pipe-C: SUCCESS (0.101s) [629.893281] Subtest planes-upscale-factor-0-25: SUCCESS (0.895s) [630.421403] [100/133] (428s left) gem_ctx_persistence (legacy-engines-queued) [630.542099] Starting subtest: legacy-engines-queued [630.546060] Starting dynamic subtest: render [630.581268] Dynamic subtest render: SUCCESS (0.042s) [630.619551] Starting dynamic subtest: bsd [630.628883] Dynamic subtest bsd: SUCCESS (0.043s) [630.659381] Starting dynamic subtest: blt [630.760562] Dynamic subtest blt: SUCCESS (0.125s) [630.793574] Starting dynamic subtest: vebox [630.809123] Dynamic subtest vebox: SUCCESS (0.041s) [630.810688] Subtest legacy-engines-queued: SUCCESS (0.273s) [630.972491] [101/133] (427s left) gem_exec_gttfill (basic) [631.101115] Starting subtest: basic [640.956988] Subtest basic: SUCCESS (9.857s) [641.247864] [102/133] (417s left) kms_psr (psr2-cursor-render) [641.548623] Subtest psr2-cursor-render: SKIP (0.000s) [641.669168] [103/133] (417s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [641.872991] Starting subtest: primary-x-tiled-reflect-x-0 [641.876339] Subtest primary-x-tiled-reflect-x-0: SKIP (0.004s) [642.023364] [104/133] (417s left) kms_setmode (invalid-clone-exclusive-crtc) [642.126707] Starting subtest: invalid-clone-exclusive-crtc [642.740252] Subtest invalid-clone-exclusive-crtc: SKIP (0.610s) [643.074274] [105/133] (416s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [643.261064] Starting subtest: plane-lut1d-ctm3x4-lut1d [644.845276] Subtest plane-lut1d-ctm3x4-lut1d: SKIP (1.581s) [645.194531] [106/133] (414s left) core_setmaster (master-drop-set-root) [645.372993] Starting subtest: master-drop-set-root [645.386087] Subtest master-drop-set-root: SUCCESS (0.013s) [645.496221] [107/133] (413s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [645.687308] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [645.688411] Starting dynamic subtest: pipe-A-HDMI-A-1 [645.705740] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s) [645.753900] Starting dynamic subtest: pipe-A-HDMI-A-2 [645.803316] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s) [645.832054] Starting dynamic subtest: pipe-B-HDMI-A-1 [645.862312] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.005s) [645.901968] Starting dynamic subtest: pipe-B-HDMI-A-2 [645.910957] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.004s) [645.934993] Starting dynamic subtest: pipe-C-HDMI-A-1 [645.945973] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.004s) [645.970682] Starting dynamic subtest: pipe-C-HDMI-A-2 [645.979305] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s) [645.980925] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.074s) [646.826102] [108/133] (412s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [647.023140] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [647.027251] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s) [647.166557] [109/133] (412s left) kms_psr (fbc-psr-cursor-plane-move) [647.361309] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s) [647.474307] [110/133] (412s left) gem_exec_schedule (preempt-other) [647.617107] Starting subtest: preempt-other [647.618399] Starting dynamic subtest: rcs0 [647.677690] Dynamic subtest rcs0: SUCCESS (0.060s) [647.707424] Starting dynamic subtest: bcs0 [647.746889] Dynamic subtest bcs0: SUCCESS (0.068s) [647.779090] Starting dynamic subtest: vcs0 [647.811788] Dynamic subtest vcs0: SUCCESS (0.061s) [647.841300] Starting dynamic subtest: vecs0 [647.883841] Dynamic subtest vecs0: SUCCESS (0.062s) [647.884907] Subtest preempt-other: SUCCESS (0.270s) [648.284338] [111/133] (411s left) gem_ccs (ctrl-surf-copy-new-ctx) [648.401259] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [648.507892] [112/133] (411s left) kms_flip (2x-absolute-wf_vblank) [648.690260] Starting subtest: 2x-absolute-wf_vblank [648.692090] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [659.530608] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.841s) [659.559637] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [670.380861] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.845s) [670.408031] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [681.106809] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.717s) [681.108416] Subtest 2x-absolute-wf_vblank: SUCCESS (32.425s) [681.833103] [113/133] (378s left) perf (buffer-fill) [682.099141] Starting subtest: buffer-fill [682.101757] Starting dynamic subtest: 0-rcs0 [685.169851] Dynamic subtest 0-rcs0: SUCCESS (3.068s) [685.171245] Subtest buffer-fill: SUCCESS (3.072s) [685.285424] [114/133] (374s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [685.469639] Starting subtest: crc-primary-suspend-y-tiled-ccs [685.472268] Starting dynamic subtest: pipe-A-HDMI-A-1 [703.164222] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.536s) [703.281820] Starting dynamic subtest: pipe-A-HDMI-A-2