[58.606251] Initializing watchdogs [58.606293] /dev/watchdog0 [58.620501] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [58.624339] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.626283] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.629493] [001/132] (960s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [58.697961] Starting subtest: multi-wait-for-submit-submitted-signaled [58.700415] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [58.797944] [002/132] (960s left) kms_psr (pr-dpms) [58.881980] Starting subtest: pr-dpms [58.886618] Subtest pr-dpms: SKIP (0.000s) [58.976477] [003/132] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [59.049787] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [59.054247] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [59.155047] [004/132] (960s left) perf_pmu (busy-hang) [59.196400] Starting subtest: busy-hang [59.198809] Starting dynamic subtest: rcs0 [60.383544] Dynamic subtest rcs0: SUCCESS (1.192s) [60.393251] Starting dynamic subtest: bcs0 [61.546231] Dynamic subtest bcs0: SUCCESS (1.164s) [61.557048] Starting dynamic subtest: vcs0 [63.386495] Dynamic subtest vcs0: SUCCESS (1.847s) [63.396446] Starting dynamic subtest: vcs1 [65.367412] Dynamic subtest vcs1: SUCCESS (1.985s) [65.377848] Starting dynamic subtest: vecs0 [67.483186] Dynamic subtest vecs0: SUCCESS (2.118s) [67.492863] Starting dynamic subtest: ccs0 [68.690406] Dynamic subtest ccs0: SUCCESS (1.205s) [68.692807] Subtest busy-hang: SUCCESS (9.516s) [68.789136] [005/132] (950s left) gen7_exec_parse (basic-allocation) [68.846915] Subtest basic-allocation: SKIP (0.000s) [68.929598] [006/132] (950s left) kms_psr (fbc-psr-primary-blt) [69.003144] Starting subtest: fbc-psr-primary-blt [69.005103] Starting dynamic subtest: eDP-1 [69.009256] Dynamic subtest eDP-1: SKIP (0.000s) [69.013467] Subtest fbc-psr-primary-blt: SKIP (0.000s) [69.073222] [007/132] (950s left) kms_flip (dpms-vs-vblank-race) [69.151264] Starting subtest: dpms-vs-vblank-race [69.153542] Starting dynamic subtest: A-eDP1 [73.059095] Dynamic subtest A-eDP1: SUCCESS (3.911s) [73.068845] Starting dynamic subtest: B-eDP1 [77.674978] Dynamic subtest B-eDP1: SUCCESS (4.617s) [77.683155] Starting dynamic subtest: C-eDP1 [82.288258] Dynamic subtest C-eDP1: SUCCESS (4.612s) [82.296446] Starting dynamic subtest: D-eDP1 [86.933943] Dynamic subtest D-eDP1: SUCCESS (4.644s) [86.936383] Subtest dpms-vs-vblank-race: SUCCESS (17.794s) [87.795223] [008/132] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [87.882056] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [87.886392] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [87.967716] [009/132] (931s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [88.021713] Starting subtest: x-tiled-to-vebox-y-tiled [88.026257] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [88.205211] [010/132] (931s left) prime_vgem (fence-write-hang) [88.318473] Subtest fence-write-hang: SKIP (0.000s) [88.424204] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [88.427533] [011/132] (931s left) kms_big_fb (x-tiled-64bpp-rotate-0) [88.512333] Starting subtest: x-tiled-64bpp-rotate-0 [90.134458] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.623s) [90.297955] [012/132] (929s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [90.384870] Starting subtest: yf-tiled-32bpp-rotate-180 [90.389408] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [90.489202] [013/132] (929s left) kms_flip (plain-flip-ts-check) [90.570147] Starting subtest: plain-flip-ts-check [90.572140] Starting dynamic subtest: A-eDP1 [99.401651] Dynamic subtest A-eDP1: SUCCESS (8.832s) [99.411714] Starting dynamic subtest: B-eDP1 [108.233686] Dynamic subtest B-eDP1: SUCCESS (8.831s) [108.243706] Starting dynamic subtest: C-eDP1 [117.049194] Dynamic subtest C-eDP1: SUCCESS (8.814s) [117.063811] Starting dynamic subtest: D-eDP1 [125.881168] Dynamic subtest D-eDP1: SUCCESS (8.831s) [125.883644] Subtest plain-flip-ts-check: SUCCESS (35.314s) [127.062366] [014/132] (892s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [127.134055] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [127.138546] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [127.209491] [015/132] (892s left) kms_flip (2x-nonexisting-fb-interruptible) [127.278702] Starting subtest: 2x-nonexisting-fb-interruptible [127.286267] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.008s) [127.362783] [016/132] (892s left) i915_pm_rpm (gem-pread) [128.979173] Starting subtest: gem-pread [131.244374] Subtest gem-pread: SUCCESS (2.267s) [131.336180] [017/132] (888s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [131.400735] Starting subtest: yf-tiled-ccs-to-y-tiled [131.405537] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [131.585443] [018/132] (888s left) gem_ctx_persistence (engines-cleanup) [131.646810] Starting subtest: engines-cleanup [131.649146] Starting dynamic subtest: rcs0 [131.714888] Dynamic subtest rcs0: SUCCESS (0.067s) [131.726399] Starting dynamic subtest: bcs0 [131.758576] Dynamic subtest bcs0: SUCCESS (0.043s) [131.769676] Starting dynamic subtest: vcs0 [131.801474] Dynamic subtest vcs0: SUCCESS (0.041s) [131.810561] Starting dynamic subtest: vcs1 [131.841390] Dynamic subtest vcs1: SUCCESS (0.039s) [131.850305] Starting dynamic subtest: vecs0 [131.857323] Dynamic subtest vecs0: SUCCESS (0.015s) [131.866192] Starting dynamic subtest: ccs0 [131.922667] Dynamic subtest ccs0: SUCCESS (0.065s) [131.925240] Subtest engines-cleanup: SUCCESS (0.276s) [132.023980] [019/132] (887s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [132.099587] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [132.101891] Starting dynamic subtest: pipe-A-eDP-1 [132.248831] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s) [132.258785] Starting dynamic subtest: pipe-B-eDP-1 [132.277714] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [132.285496] Starting dynamic subtest: pipe-C-eDP-1 [132.304081] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [132.311723] Starting dynamic subtest: pipe-D-eDP-1 [132.331996] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [132.333900] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.147s) [134.490215] [020/132] (885s left) kms_big_fb (4-tiled-16bpp-rotate-0) [134.581230] Starting subtest: 4-tiled-16bpp-rotate-0 [135.803360] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.223s) [135.926202] [021/132] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [136.015294] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [142.861118] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.849s) [142.981653] [022/132] (876s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [143.097272] Starting subtest: short-busy-flip-before-cursor-toggle [143.101747] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [143.241063] [023/132] (876s left) gem_ctx_engines (independent) [143.303870] Starting subtest: independent [143.306205] Starting dynamic subtest: rcs0 [143.455851] Dynamic subtest rcs0: SUCCESS (0.150s) [143.465123] Starting dynamic subtest: bcs0 [143.606819] Dynamic subtest bcs0: SUCCESS (0.150s) [143.618068] Starting dynamic subtest: vcs0 [143.752704] Dynamic subtest vcs0: SUCCESS (0.145s) [143.761810] Starting dynamic subtest: vcs1 [143.919392] Dynamic subtest vcs1: SUCCESS (0.166s) [143.929835] Starting dynamic subtest: vecs0 [144.082484] Dynamic subtest vecs0: SUCCESS (0.163s) [144.090879] Starting dynamic subtest: ccs0 [144.254396] Dynamic subtest ccs0: SUCCESS (0.172s) [144.265595] Starting dynamic subtest: all-engines [145.103818] Dynamic subtest all-engines: SUCCESS (0.849s) [145.106639] Subtest independent: SUCCESS (1.800s) [146.905489] [024/132] (873s left) gem_exec_balancer (bonded-semaphore) [146.977347] Starting subtest: bonded-semaphore [146.981682] Subtest bonded-semaphore: SKIP (0.000s) [147.270428] [025/132] (872s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [147.353982] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [148.034080] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s) [148.187920] [026/132] (871s left) i915_suspend (forcewake) [148.248716] Starting subtest: forcewake [180.084948] Subtest forcewake: SUCCESS (2.428s) [181.172600] [027/132] (839s left) vgem_basic (bad-pad) [181.231377] Starting subtest: bad-pad [181.233562] Subtest bad-pad: SUCCESS (0.000s) [181.297652] [028/132] (839s left) gem_exec_reloc (basic-scanout) [181.359985] Subtest basic-scanout: SKIP (0.000s) [181.421178] [029/132] (839s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [181.491841] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [181.495919] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s) [181.573396] [030/132] (839s left) kms_vblank (wait-busy) [181.637023] Starting subtest: wait-busy [181.639385] Starting dynamic subtest: pipe-A-eDP-1 [183.496730] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.897s) [183.511081] Starting dynamic subtest: pipe-D-eDP-1 [186.021710] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.565s) [186.024042] Subtest wait-busy: SUCCESS (4.465s) [186.836938] [031/132] (834s left) i915_drm_fdinfo (all-busy-idle-check-all) [186.881013] Starting subtest: all-busy-idle-check-all [186.888544] Subtest all-busy-idle-check-all: SKIP (0.006s) [186.967602] [032/132] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [187.066386] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [187.070434] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [187.173884] [033/132] (834s left) kms_frontbuffer_tracking (psr-suspend) [187.253872] Starting subtest: psr-suspend [225.612961] Subtest psr-suspend: SUCCESS (7.953s) [225.738488] [034/132] (795s left) kms_lease (lease-invalid-connector) [225.834038] Starting subtest: lease-invalid-connector [225.836320] Starting dynamic subtest: pipe-A-eDP-1 [225.838910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [225.847726] Starting dynamic subtest: pipe-B-eDP-1 [225.850234] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [225.861570] Starting dynamic subtest: pipe-C-eDP-1 [225.863700] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [225.872397] Starting dynamic subtest: pipe-D-eDP-1 [225.874598] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [225.876779] Subtest lease-invalid-connector: SUCCESS (0.004s) [225.915573] [035/132] (795s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [225.964615] Starting subtest: multi-wait-for-submit-submitted-signaled [225.969549] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [226.061492] [036/132] (795s left) syncobj_wait (signal) [226.110783] Starting subtest: signal [226.112702] Subtest signal: SUCCESS (0.000s) [226.207350] [037/132] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [226.282596] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [226.287162] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [226.378150] [038/132] (795s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [226.464604] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [226.468766] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [226.556173] [039/132] (795s left) kms_psr (fbc-psr2-no-drrs) [226.619882] Starting subtest: fbc-psr2-no-drrs [226.621785] Starting dynamic subtest: eDP-1 [226.625234] Dynamic subtest eDP-1: SKIP (0.000s) [226.628797] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [226.706598] [040/132] (794s left) gem_ccs (block-multicopy-compressed) [226.762280] Starting subtest: block-multicopy-compressed [226.766070] Subtest block-multicopy-compressed: SKIP (0.000s) [226.856858] [041/132] (794s left) kms_draw_crc (draw-method-mmap-wc) [226.932566] Starting subtest: draw-method-mmap-wc [226.934177] Starting dynamic subtest: xrgb8888-untiled [227.152562] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s) [227.161997] Starting dynamic subtest: rgb565-untiled [227.351722] Dynamic subtest rgb565-untiled: SUCCESS (0.200s) [227.361889] Starting dynamic subtest: xrgb2101010-untiled [227.562141] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s) [227.573148] Starting dynamic subtest: xbgr16161616f-untiled [227.772494] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.209s) [227.787191] Starting dynamic subtest: xrgb8888-xtiled [227.894649] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [227.905943] Starting dynamic subtest: rgb565-xtiled [228.016206] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s) [228.025397] Starting dynamic subtest: xrgb2101010-xtiled [228.126880] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [228.135989] Starting dynamic subtest: xbgr16161616f-xtiled [228.238078] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s) [228.255611] Starting dynamic subtest: xrgb8888-4tiled [228.381587] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.143s) [228.390786] Starting dynamic subtest: rgb565-4tiled [228.516496] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s) [228.525571] Starting dynamic subtest: xrgb2101010-4tiled [228.644700] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [228.653486] Starting dynamic subtest: xbgr16161616f-4tiled [228.817983] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s) [228.819821] Subtest draw-method-mmap-wc: SUCCESS (1.900s) [228.931244] [042/132] (792s left) prime_vgem (basic-fence-read) [229.006031] Starting subtest: basic-fence-read [229.019825] Subtest basic-fence-read: SKIP (0.012s) [229.119858] [043/132] (792s left) kms_cursor_crc (cursor-rapid-movement-256x256) [229.329488] Starting subtest: cursor-rapid-movement-256x256 [229.333544] Starting dynamic subtest: pipe-A-eDP-1 [229.874077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s) [229.904840] Starting dynamic subtest: pipe-D-eDP-1 [231.080298] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.207s) [231.082414] Subtest cursor-rapid-movement-256x256: SUCCESS (1.784s) [231.897428] [044/132] (789s left) kms_color_pipeline (plane-ctm3x4) [231.975902] Starting subtest: plane-ctm3x4 [232.109750] Starting dynamic subtest: pipe-A-plane-0 [232.417386] Dynamic subtest pipe-A-plane-0: FAIL (0.142s) [232.428059] Starting dynamic subtest: pipe-A-plane-1 [232.639673] Dynamic subtest pipe-A-plane-1: FAIL (0.143s) [232.650698] Starting dynamic subtest: pipe-A-plane-2 [232.875087] Dynamic subtest pipe-A-plane-2: FAIL (0.144s) [233.686402] Starting dynamic subtest: pipe-B-plane-0 [234.125812] Dynamic subtest pipe-B-plane-0: FAIL (0.185s) [234.136844] Starting dynamic subtest: pipe-B-plane-1 [234.439882] Dynamic subtest pipe-B-plane-1: FAIL (0.133s) [234.450684] Starting dynamic subtest: pipe-B-plane-2 [234.740008] Dynamic subtest pipe-B-plane-2: FAIL (0.612s) [235.766535] Starting dynamic subtest: pipe-C-plane-0 [236.214933] Dynamic subtest pipe-C-plane-0: FAIL (0.107s) [236.226048] Starting dynamic subtest: pipe-C-plane-1 [236.618916] Dynamic subtest pipe-C-plane-1: FAIL (0.122s) [236.629858] Starting dynamic subtest: pipe-C-plane-2 [236.984302] Dynamic subtest pipe-C-plane-2: FAIL (0.149s) [237.775802] Starting dynamic subtest: pipe-D-plane-0 [238.318912] Dynamic subtest pipe-D-plane-0: FAIL (0.107s) [238.330312] Starting dynamic subtest: pipe-D-plane-1 [238.782651] Dynamic subtest pipe-D-plane-1: FAIL (0.593s) [238.796686] Starting dynamic subtest: pipe-D-plane-2 [239.210345] Dynamic subtest pipe-D-plane-2: FAIL (0.534s) [239.309556] Subtest plane-ctm3x4: FAIL (7.409s) [240.147223] [045/132] (781s left) kms_flip (2x-flip-vs-modeset-vs-hang) [240.226821] Starting subtest: 2x-flip-vs-modeset-vs-hang [240.233946] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.008s) [240.315701] [046/132] (781s left) kms_frontbuffer_tracking (basic) [240.397915] Starting subtest: basic [243.634820] Subtest basic: SUCCESS (3.257s) [243.750666] [047/132] (778s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [243.832725] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [243.834501] Starting dynamic subtest: pipe-A-eDP-1 [243.853060] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [243.862995] Starting dynamic subtest: pipe-B-eDP-1 [243.879866] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [243.888117] Starting dynamic subtest: pipe-C-eDP-1 [243.905577] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [243.913658] Starting dynamic subtest: pipe-D-eDP-1 [243.931160] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [243.934534] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [245.994162] [048/132] (776s left) kms_pm_rpm (drm-resources-equal) [247.912368] Starting subtest: drm-resources-equal [252.877281] Subtest drm-resources-equal: SUCCESS (4.976s) [252.949146] [049/132] (769s left) gem_mmap_offset (partial-mmap) [253.011304] Starting subtest: partial-mmap [253.013851] Starting dynamic subtest: smem0 [253.016376] Dynamic subtest smem0: SUCCESS (0.006s) [253.018942] Subtest partial-mmap: SUCCESS (0.008s) [253.126833] [050/132] (768s left) kms_flip (2x-flip-vs-panning) [253.205653] Starting subtest: 2x-flip-vs-panning [253.212383] Subtest 2x-flip-vs-panning: SKIP (0.008s) [253.324296] [051/132] (768s left) kms_chamelium_edid (dp-edid-change-during-suspend) [253.695602] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [254.523359] [052/132] (767s left) gem_exec_reloc (basic-wc-gtt-active) [254.581483] Subtest basic-wc-gtt-active: SKIP (0.000s) [254.648193] [053/132] (767s left) kms_invalid_mode (overflow-vrefresh) [254.734874] Starting subtest: overflow-vrefresh [254.737162] Starting dynamic subtest: pipe-A-eDP-1 [255.020259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [255.029988] Starting dynamic subtest: pipe-B-eDP-1 [255.031904] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [255.040491] Starting dynamic subtest: pipe-C-eDP-1 [255.042882] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [255.051758] Starting dynamic subtest: pipe-D-eDP-1 [255.053922] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [255.056099] Subtest overflow-vrefresh: SUCCESS (0.291s) [255.875311] [054/132] (766s left) gem_lmem_swapping (heavy-random) [255.923673] Subtest heavy-random: SKIP (0.000s) [255.972573] [055/132] (766s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [256.502437] Starting subtest: syncobj-backward-timeline-chain-engines [256.602308] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.103s) [257.817680] [056/132] (764s left) kms_sequence (get-forked-busy) [257.892829] Starting subtest: get-forked-busy [257.895164] Starting dynamic subtest: pipe-A-eDP-1 [259.821835] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s) [259.832411] Starting dynamic subtest: pipe-B-eDP-1 [262.457263] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.633s) [262.468026] Starting dynamic subtest: pipe-C-eDP-1 [265.061388] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.603s) [265.070940] Starting dynamic subtest: pipe-D-eDP-1 [267.601609] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.538s) [267.604171] Subtest get-forked-busy: SUCCESS (9.710s) [268.404146] [057/132] (753s left) gem_exec_schedule (semaphore-power) [268.595697] Subtest semaphore-power: SKIP (0.000s) [268.773463] [058/132] (753s left) gem_exec_store (cachelines) [268.856356] Starting subtest: cachelines [268.858734] Starting dynamic subtest: rcs0 [268.940323] Dynamic subtest rcs0: SUCCESS (0.083s) [268.952509] Starting dynamic subtest: bcs0 [269.006219] Dynamic subtest bcs0: SUCCESS (0.064s) [269.017543] Starting dynamic subtest: vcs0 [269.074549] Dynamic subtest vcs0: SUCCESS (0.067s) [269.087121] Starting dynamic subtest: vcs1 [269.137048] Dynamic subtest vcs1: SUCCESS (0.060s) [269.148301] Starting dynamic subtest: vecs0 [269.192225] Dynamic subtest vecs0: SUCCESS (0.053s) [269.203605] Starting dynamic subtest: ccs0 [269.241432] Dynamic subtest ccs0: SUCCESS (0.047s) [269.244046] Subtest cachelines: SUCCESS (0.386s) [269.428004] [059/132] (753s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [269.510522] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [269.514997] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [269.612073] [060/132] (752s left) gem_exec_reloc (basic-cpu-wc-noreloc) [269.669252] Subtest basic-cpu-wc-noreloc: SKIP (0.000s) [269.741178] [061/132] (752s left) kms_big_fb (y-tiled-addfb) [269.821574] Starting subtest: y-tiled-addfb [269.825873] Subtest y-tiled-addfb: SKIP (0.000s) [269.917654] [062/132] (752s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [269.995491] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [277.467124] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.473s) [277.584407] [063/132] (745s left) gem_sync (basic-each) [277.663306] Starting subtest: basic-each [279.853017] Subtest basic-each: SUCCESS (2.201s) [280.038257] [064/132] (742s left) syncobj_eventfd (invalid-illegal-handle) [280.097261] Starting subtest: invalid-illegal-handle [280.099667] Subtest invalid-illegal-handle: SUCCESS (0.000s) [280.208819] [065/132] (742s left) kms_psr (fbc-pr-primary-blt) [280.284783] Starting subtest: fbc-pr-primary-blt [280.288811] Subtest fbc-pr-primary-blt: SKIP (0.000s) [280.362280] [066/132] (742s left) gem_exec_flush (basic-uc-prw-default) [280.426747] Starting subtest: basic-uc-prw-default [285.899538] Subtest basic-uc-prw-default: SUCCESS (5.474s) [286.090483] [067/132] (736s left) kms_addfb_basic (too-wide) [286.177884] Starting subtest: too-wide [286.180066] Subtest too-wide: SUCCESS (0.000s) [286.282066] [068/132] (736s left) api_intel_bb (reset-flags) [286.327496] Starting subtest: reset-flags [286.333506] Subtest reset-flags: SUCCESS (0.008s) [286.458538] [069/132] (736s left) gem_mmap (big-bo) [286.507551] Subtest big-bo: SKIP (0.000s) [286.562786] [070/132] (736s left) kms_plane_scaling (invalid-parameters) [286.631483] Starting subtest: invalid-parameters [286.633649] Starting dynamic subtest: less-than-1-height-src [286.643890] Dynamic subtest less-than-1-height-src: SUCCESS (0.012s) [286.653682] Starting dynamic subtest: less-than-1-width-src [286.655904] Dynamic subtest less-than-1-width-src: SUCCESS (0.012s) [286.658038] Subtest invalid-parameters: SUCCESS (0.026s) [286.738213] [071/132] (736s left) kms_plane_multiple (2x-tiling-4) [286.808668] Starting subtest: 2x-tiling-4 [286.812990] Subtest 2x-tiling-4: SKIP (0.000s) [286.886082] [072/132] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [286.966157] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [286.970433] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [287.052557] [073/132] (736s left) perf (missing-sample-flags) [287.187800] Starting subtest: missing-sample-flags [287.189607] Subtest missing-sample-flags: SUCCESS (0.000s) [287.237451] [074/132] (735s left) gem_eio (in-flight-contexts-10ms) [287.470142] Starting subtest: in-flight-contexts-10ms [298.759561] Subtest in-flight-contexts-10ms: SUCCESS (11.291s) [298.929592] [075/132] (724s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [299.288347] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [300.106971] [076/132] (723s left) gen9_exec_parse (bb-large) [300.164062] Subtest bb-large: SKIP (0.000s) [300.237567] [077/132] (722s left) kms_pipe_crc_basic (hang-read-crc) [300.313083] Starting subtest: hang-read-crc [300.315346] Starting dynamic subtest: pipe-A-eDP-1 [302.399653] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.086s) [302.410706] Starting dynamic subtest: pipe-B-eDP-1 [305.072512] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.672s) [305.083349] Starting dynamic subtest: pipe-C-eDP-1 [307.702005] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.630s) [307.716138] Starting dynamic subtest: pipe-D-eDP-1 [310.339736] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.636s) [310.341919] Subtest hang-read-crc: SUCCESS (10.029s) [311.194932] [078/132] (712s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [311.276679] Starting subtest: fbc-2p-primscrn-spr-indfb-move [311.280886] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [311.378037] [079/132] (711s left) gem_ctx_bad_destroy (invalid-pad) [311.429528] Starting subtest: invalid-pad [311.431790] Subtest invalid-pad: SUCCESS (0.001s) [311.502263] [080/132] (711s left) kms_flip (flip-vs-dpms-on-nop) [311.583190] Starting subtest: flip-vs-dpms-on-nop [311.585138] Starting dynamic subtest: A-eDP1 [313.477657] Dynamic subtest A-eDP1: SUCCESS (1.896s) [313.489535] Starting dynamic subtest: B-eDP1 [315.298281] Dynamic subtest B-eDP1: SUCCESS (1.820s) [315.310505] Starting dynamic subtest: C-eDP1 [317.115208] Dynamic subtest C-eDP1: SUCCESS (1.816s) [317.125191] Starting dynamic subtest: D-eDP1 [318.954082] Dynamic subtest D-eDP1: SUCCESS (1.838s) [318.956483] Subtest flip-vs-dpms-on-nop: SUCCESS (7.379s) [320.122653] [081/132] (703s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [320.226272] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [321.192685] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.967s) [322.056145] [082/132] (701s left) kms_content_protection (legacy) [322.182505] Starting subtest: legacy [322.187095] Subtest legacy: SKIP (0.000s) [322.295320] [083/132] (701s left) kms_big_fb (linear-16bpp-rotate-90) [322.388220] Starting subtest: linear-16bpp-rotate-90 [322.407446] Subtest linear-16bpp-rotate-90: SKIP (0.018s) [322.536173] [084/132] (700s left) gem_softpin (allocator-fork) [322.593004] Starting subtest: allocator-fork [324.802946] Subtest allocator-fork: SUCCESS (2.209s) [324.909547] [085/132] (698s left) drm_read (short-buffer-wakeup) [325.035909] Starting subtest: short-buffer-wakeup [357.261581] Subtest short-buffer-wakeup: SUCCESS (32.215s) [357.408366] [086/132] (666s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [357.489287] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [364.177827] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.691s) [364.313868] [087/132] (659s left) kms_fbcon_fbt (psr-suspend) [364.387903] Starting subtest: psr-suspend [414.093936] Subtest psr-suspend: SUCCESS (19.890s) [414.169286] [088/132] (609s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [414.256890] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [414.266284] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.008s) [414.341983] [089/132] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [414.419441] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [414.423769] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [414.537843] [090/132] (609s left) gem_exec_capture (pi) [414.593390] Starting subtest: pi [414.595722] Starting dynamic subtest: rcs0 [418.755013] Dynamic subtest rcs0: SUCCESS (4.217s) [418.767870] Starting dynamic subtest: bcs0 [422.636887] Dynamic subtest bcs0: SUCCESS (3.911s) [422.650792] Starting dynamic subtest: vcs0 [426.517676] Dynamic subtest vcs0: SUCCESS (3.898s) [426.529386] Starting dynamic subtest: vcs1 [430.389544] Dynamic subtest vcs1: SUCCESS (3.882s) [430.400698] Starting dynamic subtest: vecs0 [434.175821] Dynamic subtest vecs0: SUCCESS (3.792s) [434.187662] Starting dynamic subtest: ccs0 [438.047576] Dynamic subtest ccs0: SUCCESS (3.876s) [438.049920] Subtest pi: SUCCESS (23.589s) [438.131122] [091/132] (585s left) kms_plane_scaling (planes-upscale-20x20) [438.257977] Starting subtest: planes-upscale-20x20 [438.260137] Starting dynamic subtest: pipe-A [438.318792] Dynamic subtest pipe-A: SUCCESS (0.063s) [438.330457] Starting dynamic subtest: pipe-B [439.469931] Dynamic subtest pipe-B: SUCCESS (1.151s) [439.480521] Starting dynamic subtest: pipe-C [440.578015] Dynamic subtest pipe-C: SUCCESS (1.108s) [440.587691] Starting dynamic subtest: pipe-D [441.707683] Dynamic subtest pipe-D: SUCCESS (1.130s) [441.709897] Subtest planes-upscale-20x20: SUCCESS (3.456s) [442.875331] [092/132] (580s left) sriov_basic (enable-vfs-bind-unbind-each) [442.929621] Starting subtest: enable-vfs-bind-unbind-each [442.931637] Starting dynamic subtest: numvfs-1 [443.007318] Dynamic subtest numvfs-1: FAIL (0.027s) [443.018520] Starting dynamic subtest: numvfs-2 [443.088147] Dynamic subtest numvfs-2: FAIL (0.003s) [443.100153] Starting dynamic subtest: numvfs-3 [443.169661] Dynamic subtest numvfs-3: FAIL (0.003s) [443.183002] Starting dynamic subtest: numvfs-4 [443.255719] Dynamic subtest numvfs-4: FAIL (0.003s) [443.268457] Starting dynamic subtest: numvfs-5 [443.342466] Dynamic subtest numvfs-5: FAIL (0.004s) [443.352431] Starting dynamic subtest: numvfs-6 [443.426088] Dynamic subtest numvfs-6: FAIL (0.004s) [443.437629] Starting dynamic subtest: numvfs-7 [443.511197] Dynamic subtest numvfs-7: FAIL (0.004s) [443.522493] Starting dynamic subtest: numvfs-random [443.595242] Dynamic subtest numvfs-random: FAIL (0.004s) [443.597548] Subtest enable-vfs-bind-unbind-each: FAIL (0.058s) [443.637074] [093/132] (580s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [443.715658] Starting subtest: psr-rgb101010-draw-pwrite [451.344621] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.630s) [451.461347] [094/132] (572s left) gem_userptr_blits (dmabuf-unsync) [451.525678] Subtest dmabuf-unsync: SKIP (0.000s) [451.641663] [095/132] (572s left) perf (invalid-remove-userspace-config) [451.755010] Starting subtest: invalid-remove-userspace-config [451.765342] Subtest invalid-remove-userspace-config: SUCCESS (0.010s) [451.807239] [096/132] (572s left) gem_exec_await (wide-all) [451.996022] Starting subtest: wide-all [475.428871] Subtest wide-all: SUCCESS (23.429s) [475.625927] [097/132] (548s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [475.746776] Starting subtest: ccs-on-another-bo-y-tiled-ccs [475.749247] Starting dynamic subtest: pipe-A-eDP-1 [475.772261] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [475.786767] Starting dynamic subtest: pipe-B-eDP-1 [475.809092] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [475.819280] Starting dynamic subtest: pipe-C-eDP-1 [475.840330] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [475.850103] Starting dynamic subtest: pipe-D-eDP-1 [475.871473] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [475.875466] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [477.971953] [098/132] (546s left) kms_psr (psr2-primary-mmap-cpu) [478.041493] Starting subtest: psr2-primary-mmap-cpu [478.043715] Starting dynamic subtest: eDP-1 [479.753215] Dynamic subtest eDP-1: SUCCESS (1.712s) [479.755597] Subtest psr2-primary-mmap-cpu: SUCCESS (1.713s) [480.637237] [099/132] (543s left) tools_test (sysfs_l3_parity) [480.697983] Starting subtest: sysfs_l3_parity [480.776435] Subtest sysfs_l3_parity: SKIP (0.091s) [480.831751] [100/132] (543s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [480.906091] Starting subtest: pr-primary-plane-update-sf-dmg-area [480.910383] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [480.977120] [101/132] (543s left) gem_exec_schedule (preempt-other-chain) [481.051121] Starting subtest: preempt-other-chain [481.053002] Starting dynamic subtest: rcs0 [481.130125] Dynamic subtest rcs0: SUCCESS (0.084s) [481.144319] Starting dynamic subtest: bcs0 [481.213046] Dynamic subtest bcs0: SUCCESS (0.081s) [481.226224] Starting dynamic subtest: vcs0 [481.293519] Dynamic subtest vcs0: SUCCESS (0.080s) [481.303724] Starting dynamic subtest: vcs1 [481.373022] Dynamic subtest vcs1: SUCCESS (0.079s) [481.387440] Starting dynamic subtest: vecs0 [481.454616] Dynamic subtest vecs0: SUCCESS (0.081s) [481.465844] Starting dynamic subtest: ccs0 [481.530565] Dynamic subtest ccs0: SUCCESS (0.075s) [481.533223] Subtest preempt-other-chain: SUCCESS (0.485s) [482.848182] [102/132] (541s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [482.928367] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [482.932332] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [483.021962] [103/132] (541s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [483.090188] Starting subtest: invalid-multi-wait-unsubmitted-submitted [483.092060] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [483.197785] [104/132] (541s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [483.268544] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [483.270692] Starting dynamic subtest: pipe-A-eDP-1 [483.982616] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s) [483.994574] Starting dynamic subtest: pipe-B-eDP-1 [485.741696] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.758s) [485.753421] Starting dynamic subtest: pipe-C-eDP-1 [487.558277] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.816s) [487.569531] Starting dynamic subtest: pipe-D-eDP-1 [489.307691] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.748s) [489.309621] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.034s) [490.459027] [105/132] (533s left) kms_cursor_crc (cursor-offscreen-256x85) [490.695052] Starting subtest: cursor-offscreen-256x85 [490.751575] Subtest cursor-offscreen-256x85: SKIP (0.052s) [490.928901] [106/132] (533s left) kms_cursor_crc (cursor-sliding-32x10) [491.075511] Starting subtest: cursor-sliding-32x10 [491.121646] Subtest cursor-sliding-32x10: SKIP (0.041s) [491.379570] [107/132] (533s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [491.463999] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [491.465878] Starting dynamic subtest: pipe-A-eDP-1 [491.929219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s) [491.941543] Starting dynamic subtest: pipe-B-eDP-1 [493.369804] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s) [493.382322] Starting dynamic subtest: pipe-C-eDP-1 [494.761752] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s) [494.773616] Starting dynamic subtest: pipe-D-eDP-1 [496.089182] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s) [496.091141] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.597s) [497.306215] [108/132] (527s left) kms_psr (psr-primary-mmap-cpu) [497.384076] Starting subtest: psr-primary-mmap-cpu [497.386341] Starting dynamic subtest: eDP-1 [499.087879] Dynamic subtest eDP-1: SUCCESS (1.701s) [499.089915] Subtest psr-primary-mmap-cpu: SUCCESS (1.702s) [499.966155] [109/132] (524s left) syncobj_basic (bad-pad-fd-to-handle) [500.029676] Starting subtest: bad-pad-fd-to-handle [500.031836] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [500.119873] [110/132] (524s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [500.207617] Starting subtest: 2x-long-cursor-vs-flip-atomic [500.212148] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [500.366494] [111/132] (524s left) gem_mmap_gtt (big-bo-tiledx) [500.417087] Subtest big-bo-tiledX: SKIP (0.000s) [500.472152] [112/132] (524s left) syncobj_timeline (wait-any-complex) [500.518904] Starting subtest: wait-any-complex [500.579782] Subtest wait-any-complex: SUCCESS (0.061s) [500.654204] [113/132] (524s left) kms_prop_blob (blob-prop-core) [500.706535] Starting subtest: blob-prop-core [500.708669] Subtest blob-prop-core: SUCCESS (0.000s) [500.802624] [114/132] (523s left) gem_exec_params (invalid-bsd-ring) [500.856385] Starting subtest: invalid-bsd-ring [500.858754] Subtest invalid-bsd-ring: SUCCESS (0.000s) [500.953457] [115/132] (523s left) i915_module_load (reload-no-display) [500.988066] Starting subtest: reload-no-display [506.840390] Subtest reload-no-display: SUCCESS (5.855s) [506.872018] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [506.872776] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [506.876351] [116/132] (517s left) gem_ctx_persistence (processes) [508.353616] Starting subtest: processes [509.709472] Subtest processes: SUCCESS (1.359s) [509.750217] [FACT gem_ctx_persistence (processes)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [509.751461] [FACT gem_ctx_persistence (processes)] new: kernel.kmod_is_loaded.i915: true [509.755391] [117/132] (515s left) kms_plane (pixel-format-x-tiled-modifier) [509.843593] Starting subtest: pixel-format-x-tiled-modifier [509.881226] Starting dynamic subtest: pipe-A-plane-0 [510.581245] Dynamic subtest pipe-A-plane-0: SUCCESS (0.700s) [510.593823] Starting dynamic subtest: pipe-A-plane-3 [511.014447] Dynamic subtest pipe-A-plane-3: SUCCESS (0.431s) [511.023439] Starting dynamic subtest: pipe-A-plane-5 [511.027052] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [512.118158] Starting dynamic subtest: pipe-B-plane-0 [512.732688] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s) [512.742196] Starting dynamic subtest: pipe-B-plane-3 [513.154623] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s) [513.165838] Starting dynamic subtest: pipe-B-plane-5 [513.169672] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [513.554040] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.709s) [514.297713] [118/132] (510s left) kms_pm_rpm (pm-caching) [515.923812] Starting subtest: pm-caching [515.928706] Subtest pm-caching: SKIP (0.000s) [516.533753] [119/132] (508s left) kms_addfb_basic (addfb25-bad-modifier) [516.615767] Starting subtest: addfb25-bad-modifier [516.618003] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [516.726658] [120/132] (508s left) perf_pmu (idle) [516.772783] Starting subtest: idle [516.774638] Starting dynamic subtest: rcs0 [517.329330] Dynamic subtest rcs0: SUCCESS (0.556s) [517.341741] Starting dynamic subtest: bcs0 [517.848299] Dynamic subtest bcs0: SUCCESS (0.516s) [517.860135] Starting dynamic subtest: vcs0 [518.375238] Dynamic subtest vcs0: SUCCESS (0.525s) [518.387332] Starting dynamic subtest: vcs1 [518.898706] Dynamic subtest vcs1: SUCCESS (0.520s) [518.910718] Starting dynamic subtest: vecs0 [519.417225] Dynamic subtest vecs0: SUCCESS (0.516s) [519.427824] Starting dynamic subtest: ccs0 [519.933417] Dynamic subtest ccs0: SUCCESS (0.514s) [519.936554] Subtest idle: SUCCESS (3.161s) [520.047909] [121/132] (505s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [520.149050] Starting subtest: basic-busy-flip-before-cursor-legacy [520.153370] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [520.332971] [122/132] (504s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [520.394363] Starting subtest: etime-single-wait-for-submit-submitted [520.502713] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s) [520.582060] [123/132] (504s left) prime_self_import (basic-llseek-size) [520.615674] Starting subtest: basic-llseek-size [520.643356] Subtest basic-llseek-size: SUCCESS (0.027s) [520.745194] [124/132] (504s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [520.831755] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [525.339142] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.510s) [526.537459] [125/132] (498s left) gem_pwrite (basic-random) [526.602638] Subtest basic-random: SKIP (0.000s) [526.653745] [126/132] (498s left) gem_eio (in-flight-1us) [526.853534] Starting subtest: in-flight-1us [535.358462] Subtest in-flight-1us: SUCCESS (8.503s) [535.515915] [127/132] (489s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [535.595915] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [542.471978] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.879s) [542.600647] [128/132] (482s left) gem_lmem_swapping (verify-random) [542.651152] Subtest verify-random: SKIP (0.000s) [542.703008] [129/132] (482s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [542.804003] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [542.808568] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [542.899245] [130/132] (482s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [542.970476] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [542.975082] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [543.065402] [131/132] (482s left) kms_addfb_basic (bad-pitch-1024) [543.128793] Starting subtest: bad-pitch-1024 [543.131060] Subtest bad-pitch-1024: SUCCESS (0.000s) [543.253005] [132/132] (482s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [543.331259] Starting subtest: async-flip-with-page-flip-events-tiled [543.701675] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [546.516990] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.814s) [546.530566] Starting dynamic subtest: pipe-A-eDP-1-4 [548.703053] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s) [548.713634] Starting dynamic subtest: pipe-A-eDP-1-4 [550.713023] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [550.723876] Starting dynamic subtest: pipe-A-eDP-1-x [552.902897] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s) [553.273153] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [556.051895] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.789s) [556.063601] Starting dynamic subtest: pipe-B-eDP-1-4 [558.237480] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [558.247401] Starting dynamic subtest: pipe-B-eDP-1-4 [560.247714] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [560.260604] Starting dynamic subtest: pipe-B-eDP-1-x [562.437865] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s) [562.804847] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [565.576872] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.781s) [565.587586] Starting dynamic subtest: pipe-C-eDP-1-4 [567.751266] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [567.764563] Starting dynamic subtest: pipe-C-eDP-1-4 [569.761063] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [569.774714] Starting dynamic subtest: pipe-C-eDP-1-x [571.939265] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [572.308609] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [575.101064] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.801s) [575.115760] Starting dynamic subtest: pipe-D-eDP-1-4 [577.275253] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [577.285519] Starting dynamic subtest: pipe-D-eDP-1-4 [579.285205] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [579.297445] Starting dynamic subtest: pipe-D-eDP-1-x [581.474974] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s) [581.477567] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.148s) [582.685288] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: perf_pmu results: parsing output: 4/ for test: gen7_exec_parse results: parsing output: 5/ for test: kms_psr results: parsing output: 6/ for test: kms_flip results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_render_copy results: parsing output: 9/ for test: prime_vgem results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_flip_scaled_crc results: parsing output: 14/ for test: kms_flip results: parsing output: 15/ for test: i915_pm_rpm results: parsing output: 16/ for test: gem_render_copy results: parsing output: 17/ for test: gem_ctx_persistence results: parsing output: 18/ for test: kms_ccs results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_cursor_legacy results: parsing output: 22/ for test: gem_ctx_engines results: parsing output: 23/ for test: gem_exec_balancer results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: i915_suspend results: parsing output: 26/ for test: vgem_basic results: parsing output: 27/ for test: gem_exec_reloc results: parsing output: 28/ for test: kms_flip_scaled_crc results: parsing output: 29/ for test: kms_vblank results: parsing output: 30/ for test: i915_drm_fdinfo results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_lease results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: syncobj_wait results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: gem_ccs results: parsing output: 40/ for test: kms_draw_crc results: parsing output: 41/ for test: prime_vgem results: parsing output: 42/ for test: kms_cursor_crc results: parsing output: 43/ for test: kms_color_pipeline results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: kms_pm_rpm results: parsing output: 48/ for test: gem_mmap_offset results: parsing output: 49/ for test: kms_flip results: parsing output: 50/ for test: kms_chamelium_edid results: parsing output: 51/ for test: gem_exec_reloc results: parsing output: 52/ for test: kms_invalid_mode results: parsing output: 53/ for test: gem_lmem_swapping results: parsing output: 54/ for test: gem_exec_fence results: parsing output: 55/ for test: kms_sequence results: parsing output: 56/ for test: gem_exec_schedule results: parsing output: 57/ for test: gem_exec_store results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_exec_reloc results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_sync results: parsing output: 63/ for test: syncobj_eventfd results: parsing output: 64/ for test: kms_psr results: parsing output: 65/ for test: gem_exec_flush results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: api_intel_bb results: parsing output: 68/ for test: gem_mmap results: parsing output: 69/ for test: kms_plane_scaling results: parsing output: 70/ for test: kms_plane_multiple results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: perf results: parsing output: 73/ for test: gem_eio results: parsing output: 74/ for test: kms_chamelium_hpd results: parsing output: 75/ for test: gen9_exec_parse results: parsing output: 76/ for test: kms_pipe_crc_basic results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_ctx_bad_destroy results: parsing output: 79/ for test: kms_flip results: parsing output: 80/ for test: kms_cursor_legacy results: parsing output: 81/ for test: kms_content_protection results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: gem_softpin results: parsing output: 84/ for test: drm_read results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_fbcon_fbt results: parsing output: 87/ for test: kms_flip results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: gem_exec_capture results: parsing output: 90/ for test: kms_plane_scaling results: parsing output: 91/ for test: sriov_basic results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_userptr_blits results: parsing output: 94/ for test: perf results: parsing output: 95/ for test: gem_exec_await results: parsing output: 96/ for test: kms_ccs results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: tools_test results: parsing output: 99/ for test: kms_psr2_sf results: parsing output: 100/ for test: gem_exec_schedule results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: kms_ccs results: parsing output: 104/ for test: kms_cursor_crc results: parsing output: 105/ for test: kms_cursor_crc results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: syncobj_basic results: parsing output: 109/ for test: kms_cursor_legacy results: parsing output: 110/ for test: gem_mmap_gtt results: parsing output: 111/ for test: syncobj_timeline results: parsing output: 112/ for test: kms_prop_blob results: parsing output: 113/ for test: gem_exec_params results: parsing output: 114/ for test: i915_module_load results: parsing output: 115/ for test: gem_ctx_persistence results: parsing output: 116/ for test: kms_plane results: parsing output: 117/ for test: kms_pm_rpm results: parsing output: 118/ for test: kms_addfb_basic results: parsing output: 119/ for test: perf_pmu results: parsing output: 120/ for test: kms_cursor_legacy results: parsing output: 121/ for test: syncobj_timeline results: parsing output: 122/ for test: prime_self_import results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_pwrite results: parsing output: 125/ for test: gem_eio results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_lmem_swapping results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_addfb_basic results: parsing output: 131/ for test: kms_async_flips Done.