[61.604104] Initializing watchdogs [61.604173] /dev/watchdog0 [61.619200] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [61.624256] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.627849] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.631736] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [61.761489] Starting subtest: fbcpsr-1p-rte [68.870088] Subtest fbcpsr-1p-rte: SUCCESS (7.084s) [69.014936] [002/133] (953s left) prime_self_import (basic-with_fd_dup) [69.052253] Starting subtest: basic-with_fd_dup [69.069779] Subtest basic-with_fd_dup: SUCCESS (0.020s) [69.178555] [003/133] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [69.275593] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [76.410194] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.127s) [76.499491] [004/133] (945s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [76.589457] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [76.601046] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s) [76.679270] [005/133] (945s left) core_getstats (basic) [76.750536] Starting subtest: basic [76.752679] Subtest basic: SUCCESS (0.000s) [76.835220] [006/133] (945s left) api_intel_allocator (standalone) [76.883855] Starting subtest: standalone [76.899626] Subtest standalone: SUCCESS (0.018s) [77.030218] [007/133] (945s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [77.089562] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [77.194538] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s) [77.283196] [008/133] (945s left) kms_addfb_basic (size-max) [77.371219] Starting subtest: size-max [77.373508] Subtest size-max: SUCCESS (0.000s) [77.475149] [009/133] (944s left) kms_atomic_interruptible (legacy-setmode) [77.575889] Starting subtest: legacy-setmode [77.578284] Starting dynamic subtest: pipe-A-eDP-1 [84.485403] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.904s) [84.487828] Subtest legacy-setmode: SUCCESS (6.905s) [85.349152] [010/133] (937s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [85.449117] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [85.820105] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [88.634297] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.810s) [88.643066] Starting dynamic subtest: pipe-A-eDP-1-4 [90.832806] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.196s) [90.844726] Starting dynamic subtest: pipe-A-eDP-1-4 [92.843546] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [92.851480] Starting dynamic subtest: pipe-A-eDP-1-x [95.046354] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.201s) [95.440928] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [98.177732] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.741s) [98.186037] Starting dynamic subtest: pipe-B-eDP-1-4 [100.364602] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s) [100.373583] Starting dynamic subtest: pipe-B-eDP-1-4 [102.375663] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [102.384762] Starting dynamic subtest: pipe-B-eDP-1-x [104.565728] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s) [104.936120] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [107.717122] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.787s) [107.724660] Starting dynamic subtest: pipe-C-eDP-1-4 [109.891892] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [109.901664] Starting dynamic subtest: pipe-C-eDP-1-4 [111.902945] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s) [111.914341] Starting dynamic subtest: pipe-C-eDP-1-x [114.082482] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [114.455815] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [117.265065] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.812s) [117.275262] Starting dynamic subtest: pipe-D-eDP-1-4 [119.440308] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s) [119.450867] Starting dynamic subtest: pipe-D-eDP-1-4 [121.449924] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [121.457484] Starting dynamic subtest: pipe-D-eDP-1-x [123.629708] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.179s) [123.632216] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.169s) [124.843802] [011/133] (897s left) gem_create (create-clear) [124.904885] Starting subtest: create-clear [124.907172] Starting dynamic subtest: smem0 [157.710699] Dynamic subtest smem0: SUCCESS (32.800s) [157.713138] Subtest create-clear: SUCCESS (32.801s) [157.896151] [012/133] (864s left) i915_hangman (engine-engine-error) [157.971594] Starting subtest: engine-engine-error [157.974702] Starting dynamic subtest: rcs0 [159.861622] Dynamic subtest rcs0: SUCCESS (1.890s) [159.871876] Starting dynamic subtest: bcs0 [161.908229] Dynamic subtest bcs0: SUCCESS (2.045s) [161.918700] Starting dynamic subtest: vcs0 [163.827821] Dynamic subtest vcs0: SUCCESS (1.918s) [163.839250] Starting dynamic subtest: vcs1 [164.852055] Dynamic subtest vcs1: SUCCESS (1.023s) [164.861075] Starting dynamic subtest: vecs0 [166.836201] Dynamic subtest vecs0: SUCCESS (1.983s) [166.845950] Starting dynamic subtest: ccs0 [168.884480] Dynamic subtest ccs0: SUCCESS (2.047s) [168.887281] Subtest engine-engine-error: SUCCESS (10.914s) [168.963453] [013/133] (853s left) gem_ctx_isolation (preservation) [169.023630] Starting subtest: preservation [169.025937] Starting dynamic subtest: rcs0 [169.179415] Dynamic subtest rcs0: SUCCESS (0.155s) [169.187851] Starting dynamic subtest: bcs0 [169.339058] Dynamic subtest bcs0: SUCCESS (0.158s) [169.349865] Starting dynamic subtest: vcs0 [169.492343] Dynamic subtest vcs0: SUCCESS (0.153s) [169.499996] Starting dynamic subtest: vcs1 [171.036956] Dynamic subtest vcs1: SUCCESS (1.543s) [171.047931] Starting dynamic subtest: vecs0 [173.007557] Dynamic subtest vecs0: SUCCESS (1.971s) [173.017779] Starting dynamic subtest: ccs0 [174.995100] Dynamic subtest ccs0: SUCCESS (1.987s) [174.997731] Subtest preservation: SUCCESS (5.971s) [175.218840] [014/133] (847s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [175.338344] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [175.342740] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [175.427541] [015/133] (847s left) gem_exec_reloc (basic-cpu-wc-noreloc) [175.486965] Subtest basic-cpu-wc-noreloc: SKIP (0.000s) [175.560807] [016/133] (847s left) gem_exec_capture (capture-invisible) [175.623164] Starting subtest: capture-invisible [175.625170] Starting dynamic subtest: smem0 [175.629258] Dynamic subtest smem0: SKIP (0.000s) [175.633402] Subtest capture-invisible: SKIP (0.000s) [175.710558] [017/133] (847s left) gem_exec_reloc (basic-write-gtt) [175.776854] Subtest basic-write-gtt: SKIP (0.000s) [175.852763] [018/133] (846s left) gem_exec_params (invalid-fence-in) [175.913469] Starting subtest: invalid-fence-in [175.915813] Subtest invalid-fence-in: SUCCESS (0.000s) [176.031903] [019/133] (846s left) gen9_exec_parse (bb-large) [176.102392] Subtest bb-large: SKIP (0.000s) [176.177174] [020/133] (846s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [176.275673] Starting subtest: primary-4-tiled-reflect-x-0 [183.390759] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.116s) [184.619006] [021/133] (838s left) gem_mmap_gtt (isolation) [184.686432] Subtest isolation: SKIP (0.000s) [184.742862] [022/133] (838s left) kms_addfb_basic (bad-pitch-999) [184.797146] Starting subtest: bad-pitch-999 [184.799115] Subtest bad-pitch-999: SUCCESS (0.000s) [184.924265] [023/133] (838s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [185.042189] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [185.046498] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [185.144269] [024/133] (837s left) kms_async_flips (test-cursor) [185.235572] Starting subtest: test-cursor [185.623832] Starting dynamic subtest: pipe-A-eDP-1 [186.415130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.790s) [186.805776] Starting dynamic subtest: pipe-B-eDP-1 [187.549503] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.751s) [187.945524] Starting dynamic subtest: pipe-C-eDP-1 [188.697066] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s) [189.059601] Starting dynamic subtest: pipe-D-eDP-1 [189.827284] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s) [189.829507] Subtest test-cursor: SUCCESS (4.594s) [190.991044] [025/133] (832s left) gem_userptr_blits (invalid-null-pointer) [191.065225] Starting subtest: invalid-null-pointer [191.067411] Subtest invalid-null-pointer: SUCCESS (0.001s) [191.172949] [026/133] (831s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [191.273292] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [195.022940] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.753s) [196.188827] [027/133] (826s left) kms_big_fb (x-tiled-64bpp-rotate-180) [196.296516] Starting subtest: x-tiled-64bpp-rotate-180 [197.874592] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.579s) [198.051973] [028/133] (825s left) gem_exec_fence (long-history) [198.519982] Starting subtest: long-history [205.651209] Subtest long-history: SUCCESS (7.133s) [206.301753] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true [206.305049] [029/133] (816s left) i915_query (test-query-geometry-subslices) [206.364266] Starting subtest: test-query-geometry-subslices [206.366560] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [206.468749] [030/133] (816s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [206.577049] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [206.589300] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s) [206.668346] [031/133] (816s left) gem_exec_balancer (bonded-true-hang) [206.924473] Starting subtest: bonded-true-hang [206.930110] Subtest bonded-true-hang: SKIP (0.000s) [207.015685] [032/133] (816s left) kms_lease (implicit-plane-lease) [207.116774] Starting subtest: implicit-plane-lease [207.124424] Subtest implicit-plane-lease: SUCCESS (0.006s) [207.228968] [033/133] (816s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [207.327262] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [207.331413] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [207.403921] [034/133] (816s left) gem_render_copy_redux (flink) [207.464776] Starting subtest: flink [208.222427] Subtest flink: SUCCESS (0.758s) [208.343900] [035/133] (815s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [208.400615] Starting subtest: mixed-tiled-to-y-tiled-ccs [208.404220] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [208.627931] [036/133] (814s left) gem_mmap_gtt (basic-small-bo-tiledy) [208.689059] Subtest basic-small-bo-tiledY: SKIP (0.000s) [208.749044] [037/133] (814s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [209.134629] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [210.001275] [038/133] (813s left) kms_big_fb (linear-64bpp-rotate-180) [210.103164] Starting subtest: linear-64bpp-rotate-180 [211.737478] Subtest linear-64bpp-rotate-180: SUCCESS (1.634s) [211.913702] [039/133] (811s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [212.006985] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [216.011985] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.007s) [217.208311] [040/133] (806s left) gem_exec_parallel (basic) [217.278325] Starting subtest: basic [217.280798] Starting dynamic subtest: rcs0 [218.688735] Dynamic subtest rcs0: SUCCESS (1.410s) [218.698910] Starting dynamic subtest: bcs0 [220.167460] Dynamic subtest bcs0: SUCCESS (1.478s) [220.177865] Starting dynamic subtest: vcs0 [221.909363] Dynamic subtest vcs0: SUCCESS (1.739s) [221.917161] Starting dynamic subtest: vcs1 [223.893019] Dynamic subtest vcs1: SUCCESS (1.982s) [223.904369] Starting dynamic subtest: vecs0 [225.877510] Dynamic subtest vecs0: SUCCESS (1.982s) [225.888661] Starting dynamic subtest: ccs0 [227.378219] Dynamic subtest ccs0: SUCCESS (1.500s) [227.381189] Subtest basic: SUCCESS (10.100s) [227.585680] [041/133] (796s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [227.692830] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [234.403893] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.712s) [234.538986] [042/133] (789s left) gem_exec_schedule (smoketest) [234.719021] Starting subtest: smoketest [234.721697] Starting dynamic subtest: rcs0 [240.262150] Dynamic subtest rcs0: SUCCESS (5.493s) [240.271181] Starting dynamic subtest: bcs0 [245.765639] Dynamic subtest bcs0: SUCCESS (5.503s) [245.780288] Starting dynamic subtest: vcs0 [251.262114] Dynamic subtest vcs0: SUCCESS (5.490s) [251.271292] Starting dynamic subtest: vcs1 [256.742579] Dynamic subtest vcs1: SUCCESS (5.481s) [256.757790] Starting dynamic subtest: vecs0 [262.245558] Dynamic subtest vecs0: SUCCESS (5.501s) [262.256038] Starting dynamic subtest: ccs0 [267.748480] Dynamic subtest ccs0: SUCCESS (5.500s) [267.750748] Subtest smoketest: SUCCESS (32.975s) [267.929684] [043/133] (755s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [268.039424] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [268.043563] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [268.118457] [044/133] (755s left) gem_set_tiling_vs_blt (tiled-to-tiled) [268.182295] Subtest tiled-to-tiled: SKIP (0.000s) [268.261271] [045/133] (755s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [268.357455] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [272.783357] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.429s) [273.907198] [046/133] (750s left) syncobj_timeline (invalid-single-wait-unsubmitted) [273.965321] Starting subtest: invalid-single-wait-unsubmitted [273.967682] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [274.051461] [047/133] (749s left) kms_psr (pr-cursor-mmap-gtt) [274.134135] Starting subtest: pr-cursor-mmap-gtt [274.138472] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [274.221374] [048/133] (749s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [274.285791] Starting subtest: yf-tiled-ccs-to-y-tiled [274.289896] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [274.491529] [049/133] (749s left) gem_media_vme [274.614270] [050/133] (749s left) gem_caching (writes) [274.671582] Subtest writes: SKIP (0.000s) [274.748607] [051/133] (749s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [274.852623] Starting subtest: psr-rgb101010-draw-mmap-wc [281.885234] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.036s) [281.985903] [052/133] (742s left) syncobj_timeline (multi-wait-for-submit-signaled) [282.035984] Starting subtest: multi-wait-for-submit-signaled [282.038341] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [282.137126] [053/133] (742s left) perf_pmu (busy-accuracy-50) [282.178830] Starting subtest: busy-accuracy-50 [282.181693] Starting dynamic subtest: rcs0 [283.711157] Dynamic subtest rcs0: SUCCESS (1.532s) [283.721670] Starting dynamic subtest: bcs0 [285.257714] Dynamic subtest bcs0: SUCCESS (1.544s) [285.268341] Starting dynamic subtest: vcs0 [286.799889] Dynamic subtest vcs0: SUCCESS (1.540s) [286.809293] Starting dynamic subtest: vcs1 [288.342084] Dynamic subtest vcs1: SUCCESS (1.540s) [288.352078] Starting dynamic subtest: vecs0 [289.883408] Dynamic subtest vecs0: SUCCESS (1.539s) [289.891847] Starting dynamic subtest: ccs0 [291.454706] Dynamic subtest ccs0: SUCCESS (1.543s) [291.456786] Subtest busy-accuracy-50: SUCCESS (9.250s) [292.000717] [054/133] (732s left) gem_exec_schedule (implicit-boths) [292.071120] Starting subtest: implicit-boths [292.073256] Starting dynamic subtest: rcs0 [292.246987] Dynamic subtest rcs0: SUCCESS (0.182s) [292.258829] Starting dynamic subtest: vcs0 [292.354616] Dynamic subtest vcs0: SUCCESS (0.108s) [292.364874] Starting dynamic subtest: vcs1 [292.486341] Dynamic subtest vcs1: SUCCESS (0.131s) [292.497734] Starting dynamic subtest: vecs0 [292.584994] Dynamic subtest vecs0: SUCCESS (0.098s) [292.596592] Starting dynamic subtest: ccs0 [292.707683] Dynamic subtest ccs0: SUCCESS (0.121s) [292.710778] Subtest implicit-boths: SUCCESS (0.645s) [294.019782] [055/133] (730s left) kms_busy (extended-modeset-hang-oldfb) [294.126873] Starting subtest: extended-modeset-hang-oldfb [294.128799] Starting dynamic subtest: pipe-A [305.609173] Dynamic subtest pipe-A: SUCCESS (11.481s) [305.618112] Starting dynamic subtest: pipe-D [317.893369] Dynamic subtest pipe-D: SUCCESS (12.283s) [317.895767] Subtest extended-modeset-hang-oldfb: SUCCESS (23.769s) [318.689996] [056/133] (705s left) gem_linear_blits (normal) [319.138990] Starting subtest: normal [322.885453] Subtest normal: SUCCESS (3.745s) [323.003452] [057/133] (701s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [323.141628] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [323.145628] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [323.237190] [058/133] (701s left) gem_lmem_evict (dontneed-evict-race) [323.289583] Subtest dontneed-evict-race: SKIP (0.000s) [323.335026] [059/133] (701s left) prime_mmap (test_aperture_limit) [323.387700] Starting subtest: test_aperture_limit [323.389539] Starting dynamic subtest: test_aperture_limit-smem [323.398416] Dynamic subtest test_aperture_limit-smem: SKIP (0.010s) [323.402630] Subtest test_aperture_limit: SKIP (0.011s) [323.470727] [060/133] (701s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [323.524268] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [323.633384] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s) [323.708795] [061/133] (700s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [323.809651] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [330.678603] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.871s) [330.816674] [062/133] (693s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [330.930126] Starting subtest: fbc-1p-primscrn-cur-indfb-move [335.003664] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.076s) [336.222880] [063/133] (688s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [336.325746] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [336.330155] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [336.415059] [064/133] (688s left) gem_vm_create (execbuf) [336.471049] Starting subtest: execbuf [336.479167] Subtest execbuf: SUCCESS (0.008s) [336.594173] [065/133] (688s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [336.689206] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [336.693307] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [336.781077] [066/133] (688s left) gem_exec_reloc (basic-cpu) [336.831970] Subtest basic-cpu: SKIP (0.000s) [336.896127] [067/133] (687s left) kms_cursor_crc (cursor-random-32x32) [337.044604] Starting subtest: cursor-random-32x32 [337.098514] Subtest cursor-random-32x32: SKIP (0.048s) [337.405690] [068/133] (687s left) kms_pm_rpm (dpms-mode-unset-lpsp) [339.050080] Starting subtest: dpms-mode-unset-lpsp [343.116556] Subtest dpms-mode-unset-lpsp: SUCCESS (4.069s) [343.505688] [069/133] (681s left) kms_chamelium_edid (hdmi-mode-timings) [343.896119] Subtest hdmi-mode-timings: SKIP (0.000s) [344.718279] [070/133] (680s left) kms_cursor_crc (cursor-onscreen-64x21) [344.919895] Starting subtest: cursor-onscreen-64x21 [344.968305] Subtest cursor-onscreen-64x21: SKIP (0.045s) [345.215248] [071/133] (679s left) gem_ctx_param (set-priority-invalid-size) [345.279755] Starting subtest: set-priority-invalid-size [345.282187] Subtest set-priority-invalid-size: SUCCESS (0.000s) [345.360821] [072/133] (679s left) kms_psr (fbc-pr-sprite-mmap-gtt) [345.463170] Starting subtest: fbc-pr-sprite-mmap-gtt [345.467566] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [345.540603] [073/133] (679s left) gem_exec_whisper (basic-fds-forked) [345.613730] Starting subtest: basic-fds-forked [369.554314] Subtest basic-fds-forked: SUCCESS (23.935s) [369.738236] [074/133] (655s left) gem_ppgtt (shrink-vs-evict-pinned) [369.797287] Starting subtest: shrink-vs-evict-pinned [375.856528] Subtest shrink-vs-evict-pinned: SUCCESS (6.054s) [375.942787] [075/133] (649s left) kms_chamelium_audio (hdmi-audio) [376.326714] Subtest hdmi-audio: SKIP (0.000s) [377.138356] [076/133] (648s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [377.250672] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [384.399798] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.152s) [384.527121] [077/133] (640s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [384.644872] Starting subtest: cursorA-vs-flipA-toggle [395.784092] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.138s) [396.637832] [078/133] (628s left) kms_content_protection (uevent) [396.788415] Starting subtest: uevent [396.793053] Subtest uevent: SKIP (0.001s) [396.922762] [079/133] (628s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [397.021306] Starting subtest: plane-scaler-with-clipping-clamping-rotation [397.023548] Starting dynamic subtest: pipe-A [397.261588] Dynamic subtest pipe-A: SUCCESS (0.242s) [397.272754] Starting dynamic subtest: pipe-B [398.610144] Dynamic subtest pipe-B: SUCCESS (1.347s) [398.620492] Starting dynamic subtest: pipe-C [399.948452] Dynamic subtest pipe-C: SUCCESS (1.337s) [399.958217] Starting dynamic subtest: pipe-D [401.293958] Dynamic subtest pipe-D: SUCCESS (1.344s) [401.296302] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.275s) [402.489029] [080/133] (622s left) gem_softpin (allocator-evict) [402.552774] Starting subtest: allocator-evict [402.555103] Starting dynamic subtest: rcs0 [425.695496] Dynamic subtest rcs0: SUCCESS (23.140s) [425.707226] Starting dynamic subtest: bcs0 [449.321899] Dynamic subtest bcs0: SUCCESS (23.621s) [449.331579] Starting dynamic subtest: vcs0 [472.977940] Dynamic subtest vcs0: SUCCESS (23.653s) [472.993772] Starting dynamic subtest: vcs1 [496.779843] Dynamic subtest vcs1: SUCCESS (23.797s) [496.789886] Starting dynamic subtest: vecs0 [520.218063] Dynamic subtest vecs0: SUCCESS (23.434s) [520.226859] Starting dynamic subtest: ccs0 [543.844264] Dynamic subtest ccs0: SUCCESS (23.624s) [543.846434] Subtest allocator-evict: SUCCESS (141.282s) [543.926550] [081/133] (481s left) sw_sync (timeline_closed) [544.007828] Starting subtest: timeline_closed [544.010155] Subtest timeline_closed: SUCCESS (0.000s) [544.070811] [082/133] (481s left) prime_mmap (test_refcounting) [544.128671] Starting subtest: test_refcounting [544.130730] Starting dynamic subtest: test_refcounting-smem [544.160296] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s) [544.162808] Subtest test_refcounting: SUCCESS (0.033s) [544.259039] [083/133] (481s left) kms_big_fb (4-tiled-8bpp-rotate-180) [544.370388] Starting subtest: 4-tiled-8bpp-rotate-180 [545.628373] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.258s) [545.763788] [084/133] (479s left) kms_plane_alpha_blend (alpha-transparent-fb) [545.862634] Starting subtest: alpha-transparent-fb [546.152115] Starting dynamic subtest: pipe-A-eDP-1 [546.820296] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.667s) [546.834773] Starting dynamic subtest: pipe-D-eDP-1 [548.230479] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s) [548.232798] Subtest alpha-transparent-fb: SUCCESS (2.368s) [549.035247] [085/133] (476s left) gem_ctx_shared (q-smoketest) [549.105415] Starting subtest: Q-smoketest [549.107919] Starting dynamic subtest: rcs0 [554.672636] Dynamic subtest rcs0: SUCCESS (5.516s) [554.685053] Starting dynamic subtest: bcs0 [560.169330] Dynamic subtest bcs0: SUCCESS (5.494s) [560.182693] Starting dynamic subtest: vcs0 [565.645657] Dynamic subtest vcs0: SUCCESS (5.478s) [565.658272] Starting dynamic subtest: vcs1 [571.132058] Dynamic subtest vcs1: SUCCESS (5.486s) [571.142621] Starting dynamic subtest: vecs0 [576.621953] Dynamic subtest vecs0: SUCCESS (5.489s) [576.634292] Starting dynamic subtest: ccs0 [582.134151] Dynamic subtest ccs0: SUCCESS (5.505s) [582.136511] Subtest Q-smoketest: SUCCESS (32.978s) [582.288716] [086/133] (443s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [582.389226] Starting subtest: yf-tiled-16bpp-rotate-90 [582.393660] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [582.486642] [087/133] (443s left) syncobj_timeline (transfer-timeline-point) [582.550446] Starting subtest: transfer-timeline-point [582.552772] Subtest transfer-timeline-point: SUCCESS (0.000s) [582.652165] [088/133] (443s left) gem_exec_reloc (basic-wc-gtt-active) [582.707702] Subtest basic-wc-gtt-active: SKIP (0.000s) [582.772056] [089/133] (442s left) prime_busy (after-wait) [582.831131] Starting subtest: after-wait [582.836678] Starting dynamic subtest: rcs0 [582.876306] Dynamic subtest rcs0: SUCCESS (0.042s) [582.887151] Starting dynamic subtest: bcs0 [582.933192] Dynamic subtest bcs0: SUCCESS (0.056s) [582.946587] Starting dynamic subtest: vcs0 [582.974868] Dynamic subtest vcs0: SUCCESS (0.040s) [582.984436] Starting dynamic subtest: vcs1 [583.014950] Dynamic subtest vcs1: SUCCESS (0.039s) [583.024248] Starting dynamic subtest: vecs0 [583.056523] Dynamic subtest vecs0: SUCCESS (0.041s) [583.065765] Starting dynamic subtest: ccs0 [583.096933] Dynamic subtest ccs0: SUCCESS (0.040s) [583.207031] Subtest after-wait: SUCCESS (0.374s) [583.281437] [090/133] (442s left) sysfs_timeslice_duration (idempotent) [583.349260] Starting subtest: idempotent [583.351532] Starting dynamic subtest: vecs0 [583.353688] Dynamic subtest vecs0: SUCCESS (0.001s) [583.362893] Starting dynamic subtest: ccs0 [583.365109] Dynamic subtest ccs0: SUCCESS (0.001s) [583.376777] Starting dynamic subtest: vcs0 [583.378979] Dynamic subtest vcs0: SUCCESS (0.001s) [583.387678] Starting dynamic subtest: bcs0 [583.389558] Dynamic subtest bcs0: SUCCESS (0.001s) [583.398434] Starting dynamic subtest: rcs0 [583.400579] Dynamic subtest rcs0: SUCCESS (0.001s) [583.409050] Starting dynamic subtest: vcs1 [583.410928] Dynamic subtest vcs1: SUCCESS (0.001s) [583.412802] Subtest idempotent: SUCCESS (0.021s) [583.450813] [091/133] (442s left) i915_pm_rps (basic-api) [583.516762] Starting subtest: basic-api [583.520963] Subtest basic-api: SKIP (0.000s) [583.615861] [092/133] (442s left) kms_hdmi_inject (inject-audio) [583.973842] Starting subtest: inject-audio [584.255438] Subtest inject-audio: SUCCESS (0.284s) [584.830445] [093/133] (441s left) kms_vblank (ts-continuation-dpms-rpm) [584.926151] Starting subtest: ts-continuation-dpms-rpm [584.928283] Starting dynamic subtest: pipe-A-eDP-1 [587.421531] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s) [587.436628] Starting dynamic subtest: pipe-D-eDP-1 [589.609115] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.185s) [589.611509] Subtest ts-continuation-dpms-rpm: SUCCESS (4.684s) [590.456687] [094/133] (435s left) i915_drm_fdinfo (virtual-busy-hang) [590.508412] Starting subtest: virtual-busy-hang [590.512953] Subtest virtual-busy-hang: SKIP (0.000s) [590.583327] [095/133] (435s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [590.691122] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [590.695271] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [590.798898] [096/133] (435s left) kms_big_fb (y-tiled-32bpp-rotate-270) [590.916999] Starting subtest: y-tiled-32bpp-rotate-270 [590.921360] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [591.021185] [097/133] (435s left) kms_psr2_su (page_flip-xrgb8888) [591.075907] Subtest page_flip-XRGB8888: SKIP (0.000s) [591.138120] [098/133] (435s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [591.228217] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [591.232383] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [591.319396] [099/133] (434s left) kms_plane_scaling (planes-upscale-factor-0-25) [591.419139] Starting subtest: planes-upscale-factor-0-25 [591.421426] Starting dynamic subtest: pipe-A [591.478872] Dynamic subtest pipe-A: SUCCESS (0.063s) [591.487591] Starting dynamic subtest: pipe-B [592.646687] Dynamic subtest pipe-B: SUCCESS (1.166s) [592.662774] Starting dynamic subtest: pipe-C [593.742550] Dynamic subtest pipe-C: SUCCESS (1.094s) [593.758693] Starting dynamic subtest: pipe-D [594.842807] Dynamic subtest pipe-D: SUCCESS (1.099s) [594.845226] Subtest planes-upscale-factor-0-25: SUCCESS (3.429s) [596.059435] [100/133] (430s left) gem_ctx_persistence (legacy-engines-queued) [596.121309] Starting subtest: legacy-engines-queued [596.123643] Starting dynamic subtest: render [596.178470] Dynamic subtest render: SUCCESS (0.057s) [596.193038] Starting dynamic subtest: bsd1 [597.877405] Dynamic subtest bsd1: SUCCESS (1.694s) [597.888831] Starting dynamic subtest: bsd2 [599.859087] Dynamic subtest bsd2: SUCCESS (1.979s) [599.871141] Starting dynamic subtest: blt [599.918118] Dynamic subtest blt: SUCCESS (0.057s) [599.929196] Starting dynamic subtest: vebox [601.908376] Dynamic subtest vebox: SUCCESS (1.986s) [601.911447] Subtest legacy-engines-queued: SUCCESS (5.787s) [602.002790] [101/133] (424s left) gem_exec_gttfill (basic) [602.073393] Starting subtest: basic [605.120373] Subtest basic: SUCCESS (3.046s) [605.311347] [102/133] (421s left) kms_psr (psr2-cursor-render) [605.448898] Starting subtest: psr2-cursor-render [605.451328] Starting dynamic subtest: eDP-1 [607.118386] Dynamic subtest eDP-1: SUCCESS (1.671s) [607.120669] Subtest psr2-cursor-render: SUCCESS (1.672s) [607.949242] [103/133] (418s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [608.055021] Starting subtest: primary-x-tiled-reflect-x-0 [615.020835] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.968s) [616.255743] [104/133] (410s left) kms_setmode (invalid-clone-exclusive-crtc) [616.312025] Starting subtest: invalid-clone-exclusive-crtc [616.318702] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [616.412032] [105/133] (410s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [616.503086] Starting subtest: plane-lut1d-ctm3x4-lut1d [616.649403] Starting dynamic subtest: pipe-A-plane-0 [617.033887] Dynamic subtest pipe-A-plane-0: FAIL (0.215s) [617.045129] Starting dynamic subtest: pipe-A-plane-1 [617.244734] Dynamic subtest pipe-A-plane-1: FAIL (0.159s) [617.253257] Starting dynamic subtest: pipe-A-plane-2 [617.460441] Dynamic subtest pipe-A-plane-2: FAIL (0.166s) [618.429783] Starting dynamic subtest: pipe-B-plane-0 [618.886226] Dynamic subtest pipe-B-plane-0: FAIL (0.174s) [618.895646] Starting dynamic subtest: pipe-B-plane-1 [619.216062] Dynamic subtest pipe-B-plane-1: FAIL (0.166s) [619.226453] Starting dynamic subtest: pipe-B-plane-2 [619.531064] Dynamic subtest pipe-B-plane-2: FAIL (0.628s) [620.617180] Starting dynamic subtest: pipe-C-plane-0 [621.138737] Dynamic subtest pipe-C-plane-0: FAIL (0.152s) [621.148980] Starting dynamic subtest: pipe-C-plane-1 [621.555077] Dynamic subtest pipe-C-plane-1: FAIL (0.637s) [621.565069] Starting dynamic subtest: pipe-C-plane-2 [621.951436] Dynamic subtest pipe-C-plane-2: FAIL (0.184s) [622.817672] Starting dynamic subtest: pipe-D-plane-0 [623.427431] Dynamic subtest pipe-D-plane-0: FAIL (0.140s) [623.437918] Starting dynamic subtest: pipe-D-plane-1 [623.910342] Dynamic subtest pipe-D-plane-1: FAIL (0.615s) [623.920967] Starting dynamic subtest: pipe-D-plane-2 [624.378527] Dynamic subtest pipe-D-plane-2: FAIL (0.549s) [624.416949] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (7.915s) [625.267927] [106/133] (401s left) core_setmaster (master-drop-set-root) [625.347588] Starting subtest: master-drop-set-root [625.360397] Subtest master-drop-set-root: SUCCESS (0.013s) [625.408485] [107/133] (401s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [625.508858] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [625.510687] Starting dynamic subtest: pipe-A-eDP-1 [627.712502] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.204s) [627.721509] Starting dynamic subtest: pipe-B-eDP-1 [630.123679] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.409s) [630.132338] Starting dynamic subtest: pipe-C-eDP-1 [632.255286] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.131s) [632.264079] Starting dynamic subtest: pipe-D-eDP-1 [634.443358] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.187s) [634.445330] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.937s) [635.652428] [108/133] (390s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [635.748421] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [635.773846] Starting dynamic subtest: pipe-A-plane-0 [636.062355] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s) [636.072461] Starting dynamic subtest: pipe-A-plane-3 [636.295714] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s) [637.406373] Starting dynamic subtest: pipe-B-plane-0 [637.697113] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [637.709311] Starting dynamic subtest: pipe-B-plane-3 [637.930206] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s) [638.253216] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.506s) [639.045845] [109/133] (387s left) kms_psr (fbc-psr-cursor-plane-move) [639.142349] Starting subtest: fbc-psr-cursor-plane-move [639.144604] Starting dynamic subtest: eDP-1 [639.148692] Dynamic subtest eDP-1: SKIP (0.000s) [639.152822] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [639.228972] [110/133] (387s left) gem_exec_schedule (preempt-other) [639.310583] Starting subtest: preempt-other [639.312921] Starting dynamic subtest: rcs0 [639.377622] Dynamic subtest rcs0: SUCCESS (0.071s) [639.391066] Starting dynamic subtest: bcs0 [639.445151] Dynamic subtest bcs0: SUCCESS (0.066s) [639.461679] Starting dynamic subtest: vcs0 [639.511408] Dynamic subtest vcs0: SUCCESS (0.066s) [639.521396] Starting dynamic subtest: vcs1 [639.581634] Dynamic subtest vcs1: SUCCESS (0.070s) [639.599177] Starting dynamic subtest: vecs0 [639.647502] Dynamic subtest vecs0: SUCCESS (0.064s) [639.663219] Starting dynamic subtest: ccs0 [639.714035] Dynamic subtest ccs0: SUCCESS (0.066s) [639.716700] Subtest preempt-other: SUCCESS (0.408s) [641.013763] [111/133] (385s left) gem_ccs (ctrl-surf-copy-new-ctx) [641.076626] Starting subtest: ctrl-surf-copy-new-ctx [641.080938] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [641.176117] [112/133] (385s left) kms_flip (2x-absolute-wf_vblank) [641.266849] Starting subtest: 2x-absolute-wf_vblank [641.278519] Subtest 2x-absolute-wf_vblank: SKIP (0.011s) [641.356375] [113/133] (385s left) perf (buffer-fill) [641.483818] Starting subtest: buffer-fill [641.486110] Starting dynamic subtest: 0-rcs0 [643.753861] Dynamic subtest 0-rcs0: SUCCESS (2.270s) [643.764472] Starting dynamic subtest: 1-vcs1 [648.201757] Dynamic subtest 1-vcs1: SUCCESS (4.446s) [648.204455] Subtest buffer-fill: SUCCESS (6.718s) [648.253062] [114/133] (378s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [648.350372] Starting subtest: crc-primary-suspend-y-tiled-ccs [648.352642] Starting dynamic subtest: pipe-A-eDP-1 [648.361698] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [648.373511] Starting dynamic subtest: pipe-B-eDP-1 [648.382707] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [648.393034] Starting dynamic subtest: pipe-C-eDP-1 [648.401434] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [648.409742] Starting dynamic subtest: pipe-D-eDP-1 [648.418160] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [648.422170] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s) [650.558355] [115/133] (376s left) kms_cursor_crc (cursor-tearing-position-change) [650.670760] Starting subtest: cursor-tearing-position-change [650.673055] Starting dynamic subtest: pipe-A-eDP-1 [651.235694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s) [651.245706] Starting dynamic subtest: pipe-D-eDP-1 [652.442589] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.203s) [652.445921] Subtest cursor-tearing-position-change: SUCCESS (1.770s) [653.249945] [116/133] (373s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [655.086476] Starting subtest: modeset-lpsp-stress-no-wait [665.392595] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.309s) [665.467725] [117/133] (361s left) prime_vgem (basic-gtt) [665.556015] Starting subtest: basic-gtt [665.560677] Subtest basic-gtt: SKIP (0.000s) [665.629504] [118/133] (361s left) syncobj_wait (invalid-wait-bad-flags) [665.686327] Starting subtest: invalid-wait-bad-flags [665.688556] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [665.800614] [119/133] (361s left) kms_dsc (dsc-fractional-bpp) [665.897052] Starting subtest: dsc-fractional-bpp [665.910051] Subtest dsc-fractional-bpp: SKIP (0.000s) [665.974951] [120/133] (361s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [666.077627] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [666.081614] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [666.180327] [121/133] (360s left) gem_exec_reloc (basic-cpu-read-noreloc) [666.238021] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [666.306476] [122/133] (360s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [666.402166] Starting subtest: bad-pixel-format-yf-tiled-ccs [666.404092] Starting dynamic subtest: pipe-A-eDP-1 [666.426933] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [666.437273] Starting dynamic subtest: pipe-B-eDP-1 [666.455669] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [666.463604] Starting dynamic subtest: pipe-C-eDP-1 [666.481045] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [666.488835] Starting dynamic subtest: pipe-D-eDP-1 [666.506170] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [666.509597] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.014s) [668.646402] [123/133] (358s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [668.752133] Starting subtest: psr2-cursor-plane-move-continuous-sf [668.754424] Starting dynamic subtest: pipe-A-eDP-1 [679.092996] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.346s) [679.103734] Starting dynamic subtest: pipe-B-eDP-1 [690.176420] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.081s) [690.178601] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.430s) [691.054307] [124/133] (336s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [691.152779] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [691.156990] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [691.248849] [125/133] (336s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [691.348304] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [691.350560] Starting dynamic subtest: pipe-A-eDP-1 [691.820580] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s) [691.831836] Starting dynamic subtest: pipe-B-eDP-1 [693.328603] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.504s) [693.338834] Starting dynamic subtest: pipe-C-eDP-1 [694.717342] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s) [694.726344] Starting dynamic subtest: pipe-D-eDP-1 [696.131137] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.414s) [696.133365] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.758s) [697.264463] [126/133] (330s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [697.357421] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [701.720499] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.367s) [702.865864] [127/133] (324s left) kms_joiner (basic-force-big-joiner) [702.962314] Starting subtest: basic-force-big-joiner [702.966499] Subtest basic-force-big-joiner: SKIP (0.000s) [703.032514] [128/133] (324s left) perf_pmu (event-wait) [703.074831] Starting subtest: event-wait [703.077192] Starting dynamic subtest: rcs0 [703.081629] Dynamic subtest rcs0: SKIP (0.000s) [703.085717] Subtest event-wait: SKIP (0.001s) [703.182194] [129/133] (324s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [703.273151] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [703.275360] Starting dynamic subtest: pipe-A-default-mode [705.907756] Dynamic subtest pipe-A-default-mode: SUCCESS (2.636s) [705.910274] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.638s) [706.745945] [130/133] (320s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [706.796575] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [706.798530] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [706.912297] [131/133] (320s left) kms_cursor_legacy (single-bo) [707.037767] Starting subtest: single-bo [707.039940] Starting dynamic subtest: pipe-A [712.420527] Dynamic subtest pipe-A: SUCCESS (5.380s) [712.431478] Starting dynamic subtest: pipe-B [717.803192] Dynamic subtest pipe-B: SUCCESS (5.380s) [717.814130] Starting dynamic subtest: pipe-C [723.185080] Dynamic subtest pipe-C: SUCCESS (5.379s) [723.195935] Starting dynamic subtest: pipe-D [728.567104] Dynamic subtest pipe-D: SUCCESS (5.379s) [728.578095] Starting dynamic subtest: all-pipes [733.959685] Dynamic subtest all-pipes: SUCCESS (5.389s) [733.962044] Subtest single-bo: SUCCESS (26.920s) [734.100451] [132/133] (293s left) kms_vblank (accuracy-idle) [734.190276] Starting subtest: accuracy-idle [734.192114] Starting dynamic subtest: pipe-A-eDP-1 [735.966922] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.776s) [735.980487] Starting dynamic subtest: pipe-D-eDP-1 [738.455647] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.485s) [738.457935] Subtest accuracy-idle: SUCCESS (4.265s) [739.267156] [133/133] (288s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [739.370597] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [746.091481] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.723s) [746.250329] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: prime_self_import results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_flip results: parsing output: 4/ for test: core_getstats results: parsing output: 5/ for test: api_intel_allocator results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: kms_addfb_basic results: parsing output: 8/ for test: kms_atomic_interruptible results: parsing output: 9/ for test: kms_async_flips results: parsing output: 10/ for test: gem_create results: parsing output: 11/ for test: i915_hangman results: parsing output: 12/ for test: gem_ctx_isolation results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_exec_reloc results: parsing output: 15/ for test: gem_exec_capture results: parsing output: 16/ for test: gem_exec_reloc results: parsing output: 17/ for test: gem_exec_params results: parsing output: 18/ for test: gen9_exec_parse results: parsing output: 19/ for test: kms_rotation_crc results: parsing output: 20/ for test: gem_mmap_gtt results: parsing output: 21/ for test: kms_addfb_basic results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_async_flips results: parsing output: 24/ for test: gem_userptr_blits results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: gem_exec_fence results: parsing output: 28/ for test: i915_query results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: gem_exec_balancer results: parsing output: 31/ for test: kms_lease results: parsing output: 32/ for test: kms_plane results: parsing output: 33/ for test: gem_render_copy_redux results: parsing output: 34/ for test: gem_render_copy results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: kms_chamelium_hpd results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_exec_parallel results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: gem_exec_schedule results: parsing output: 42/ for test: kms_psr2_sf results: parsing output: 43/ for test: gem_set_tiling_vs_blt results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: syncobj_timeline results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: gem_render_copy results: parsing output: 48/ for test: gem_media_vme results: parsing output: 49/ for test: gem_caching results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: perf_pmu results: parsing output: 53/ for test: gem_exec_schedule results: parsing output: 54/ for test: kms_busy results: parsing output: 55/ for test: gem_linear_blits results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_lmem_evict results: parsing output: 58/ for test: prime_mmap results: parsing output: 59/ for test: syncobj_timeline results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: gem_vm_create results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_exec_reloc results: parsing output: 66/ for test: kms_cursor_crc results: parsing output: 67/ for test: kms_pm_rpm results: parsing output: 68/ for test: kms_chamelium_edid results: parsing output: 69/ for test: kms_cursor_crc results: parsing output: 70/ for test: gem_ctx_param results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: gem_exec_whisper results: parsing output: 73/ for test: gem_ppgtt results: parsing output: 74/ for test: kms_chamelium_audio results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: kms_content_protection results: parsing output: 78/ for test: kms_plane_scaling results: parsing output: 79/ for test: gem_softpin results: parsing output: 80/ for test: sw_sync results: parsing output: 81/ for test: prime_mmap results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: kms_plane_alpha_blend results: parsing output: 84/ for test: gem_ctx_shared results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: syncobj_timeline results: parsing output: 87/ for test: gem_exec_reloc results: parsing output: 88/ for test: prime_busy results: parsing output: 89/ for test: sysfs_timeslice_duration results: parsing output: 90/ for test: i915_pm_rps results: parsing output: 91/ for test: kms_hdmi_inject results: parsing output: 92/ for test: kms_vblank results: parsing output: 93/ for test: i915_drm_fdinfo results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: kms_psr2_su results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_plane_scaling results: parsing output: 99/ for test: gem_ctx_persistence results: parsing output: 100/ for test: gem_exec_gttfill results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: kms_rotation_crc results: parsing output: 103/ for test: kms_setmode results: parsing output: 104/ for test: kms_color_pipeline results: parsing output: 105/ for test: core_setmaster results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: kms_plane results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: gem_exec_schedule results: parsing output: 110/ for test: gem_ccs results: parsing output: 111/ for test: kms_flip results: parsing output: 112/ for test: perf results: parsing output: 113/ for test: kms_ccs results: parsing output: 114/ for test: kms_cursor_crc results: parsing output: 115/ for test: kms_pm_rpm results: parsing output: 116/ for test: prime_vgem results: parsing output: 117/ for test: syncobj_wait results: parsing output: 118/ for test: kms_dsc results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_exec_reloc results: parsing output: 121/ for test: kms_ccs results: parsing output: 122/ for test: kms_psr2_sf results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_ccs results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_joiner results: parsing output: 127/ for test: perf_pmu results: parsing output: 128/ for test: kms_flip_scaled_crc results: parsing output: 129/ for test: syncobj_wait results: parsing output: 130/ for test: kms_cursor_legacy results: parsing output: 131/ for test: kms_vblank results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.