[59.855944] Initializing watchdogs [59.855989] /dev/watchdog0 [59.870909] [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] [59.875606] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.877854] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.880031] [001/133] (960s left) kms_vblank (wait-forked-busy-hang) [59.977128] Starting subtest: wait-forked-busy-hang [59.978066] Starting dynamic subtest: pipe-A-eDP-1 [86.676437] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.717s) [86.684691] Starting dynamic subtest: pipe-D-eDP-1 [101.728496] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.049s) [101.729531] Subtest wait-forked-busy-hang: SUCCESS (41.770s) [102.533589] [002/133] (917s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [102.636464] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [103.748857] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.113s) [103.863484] [003/133] (916s left) syncobj_timeline (etime-single-wait-all-submitted) [103.907899] Starting subtest: etime-single-wait-all-submitted [104.027063] Subtest etime-single-wait-all-submitted: SUCCESS (0.110s) [104.097636] [004/133] (916s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [104.191873] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [104.192947] Starting dynamic subtest: pipe-A-eDP-1 [104.202152] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [104.208929] Starting dynamic subtest: pipe-B-eDP-1 [104.217574] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [104.223894] Starting dynamic subtest: pipe-C-eDP-1 [104.232260] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [104.237943] Starting dynamic subtest: pipe-D-eDP-1 [104.247666] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [104.249478] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [106.508793] [005/133] (913s left) gen9_exec_parse (bb-start-far) [106.572169] Subtest bb-start-far: SKIP (0.000s) [106.617178] [006/133] (913s left) gem_exec_flush (basic-wb-prw-default) [106.667290] Starting subtest: basic-wb-prw-default [112.128815] Subtest basic-wb-prw-default: SUCCESS (5.461s) [112.301871] [007/133] (908s left) kms_async_flips (basic-modeset-with-all-modifiers-formats) [112.391246] Starting subtest: basic-modeset-with-all-modifiers-formats [112.764604] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888 [113.500387] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.736s) [113.508358] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010 [113.521598] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s) [113.527526] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F [113.543449] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s) [113.550394] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565 [113.699109] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s) [113.708433] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888 [113.721147] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s) [113.727157] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010 [113.743556] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s) [113.751927] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F [113.765767] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s) [113.771843] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV [113.787913] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s) [113.793926] Starting dynamic subtest: pipe-A-eDP-1-4-Y210 [113.810228] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s) [113.816351] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888 [113.832425] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s) [113.838494] Starting dynamic subtest: pipe-A-eDP-1-4-XV30 [113.854586] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s) [113.860855] Starting dynamic subtest: pipe-A-eDP-1-4-XV36 [113.876901] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s) [113.885802] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565 [114.021232] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s) [114.028431] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888 [114.043520] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s) [114.050051] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010 [114.065867] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s) [114.073906] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F [114.088329] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s) [114.096597] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV [114.110116] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s) [114.115972] Starting dynamic subtest: pipe-A-eDP-1-x-Y210 [114.132354] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s) [114.138235] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888 [114.154604] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s) [114.160500] Starting dynamic subtest: pipe-A-eDP-1-x-XV30 [114.177235] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s) [114.188016] Starting dynamic subtest: pipe-A-eDP-1-x-XV36 [114.199333] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s) [114.208286] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565 [114.366115] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.167s) [114.372508] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888 [114.388359] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s) [114.394460] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010 [114.410574] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s) [114.416624] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F [114.432815] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s) [114.441288] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV [114.454927] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s) [114.460800] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210 [114.477189] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s) [114.483105] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888 [114.499680] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s) [114.506680] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30 [114.521701] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s) [114.529070] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36 [114.543910] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s) [114.938881] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.549s) [115.767827] [008/133] (904s left) kms_frontbuffer_tracking (fbc-stridechange) [115.867956] Starting subtest: fbc-stridechange [119.165498] Subtest fbc-stridechange: SUCCESS (3.297s) [120.310863] [009/133] (900s left) gem_userptr_blits (invalid-null-pointer) [120.372358] Starting subtest: invalid-null-pointer [120.373338] Subtest invalid-null-pointer: SUCCESS (0.001s) [120.502148] [010/133] (900s left) i915_drm_fdinfo (memory-info-purgeable) [120.537197] Starting subtest: memory-info-purgeable [120.538208] Starting dynamic subtest: smem0 [123.413884] Dynamic subtest smem0: SUCCESS (2.876s) [123.415060] Subtest memory-info-purgeable: SUCCESS (2.877s) [123.489886] [011/133] (897s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [123.588951] Starting subtest: fbc-dirtyfb-ioctl [123.590042] Starting dynamic subtest: A-eDP-1 [126.155391] Dynamic subtest A-eDP-1: SUCCESS (2.565s) [126.156262] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.566s) [126.967564] [012/133] (893s left) kms_plane_lowres (tiling-yf) [127.062608] Starting subtest: tiling-yf [127.064448] Subtest tiling-yf: SKIP (0.000s) [127.125706] [013/133] (893s left) kms_pm_rpm (basic-pci-d3-state) [129.055060] Starting subtest: basic-pci-d3-state [130.554501] Subtest basic-pci-d3-state: SUCCESS (1.501s) [130.660199] [014/133] (890s left) gem_exec_schedule (pi-ringfull) [130.839099] Starting subtest: pi-ringfull [130.840172] Starting dynamic subtest: rcs0 [130.895852] Dynamic subtest rcs0: SUCCESS (0.058s) [130.907346] Starting dynamic subtest: bcs0 [130.922972] Dynamic subtest bcs0: SUCCESS (0.027s) [130.934191] Starting dynamic subtest: vcs0 [130.949938] Dynamic subtest vcs0: SUCCESS (0.027s) [130.961021] Starting dynamic subtest: vcs1 [130.976248] Dynamic subtest vcs1: SUCCESS (0.026s) [130.982836] Starting dynamic subtest: vecs0 [131.003059] Dynamic subtest vecs0: SUCCESS (0.026s) [131.009553] Starting dynamic subtest: ccs0 [131.029112] Dynamic subtest ccs0: SUCCESS (0.026s) [131.029881] Subtest pi-ringfull: SUCCESS (0.192s) [131.243796] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true [131.245606] [015/133] (889s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [131.343185] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [131.345036] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [131.430495] [016/133] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [131.520737] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [131.522673] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [131.617537] [017/133] (889s left) kms_cursor_crc (cursor-onscreen-max-size) [131.907798] Starting subtest: cursor-onscreen-max-size [131.910681] Subtest cursor-onscreen-max-size: SKIP (0.000s) [132.044500] [018/133] (888s left) kms_cursor_crc (cursor-rapid-movement-32x32) [132.174015] Starting subtest: cursor-rapid-movement-32x32 [132.224801] Subtest cursor-rapid-movement-32x32: SKIP (0.049s) [132.513963] [019/133] (888s left) kms_color_pipeline (plane-ctm3x4-lut1d) [132.603273] Starting subtest: plane-ctm3x4-lut1d [132.750897] Starting dynamic subtest: pipe-A-plane-0 [132.928525] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s) [132.936838] Starting dynamic subtest: pipe-A-plane-1 [133.094992] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [133.101686] Starting dynamic subtest: pipe-A-plane-2 [133.262591] Dynamic subtest pipe-A-plane-2: SUCCESS (0.167s) [134.545748] Starting dynamic subtest: pipe-B-plane-0 [134.733134] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s) [134.740834] Starting dynamic subtest: pipe-B-plane-1 [134.922281] Dynamic subtest pipe-B-plane-1: SUCCESS (0.189s) [134.929995] Starting dynamic subtest: pipe-B-plane-2 [135.088987] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [136.242667] Starting dynamic subtest: pipe-C-plane-0 [136.379906] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [136.387638] Starting dynamic subtest: pipe-C-plane-1 [136.535504] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [136.545271] Starting dynamic subtest: pipe-C-plane-2 [136.690915] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [137.909664] Starting dynamic subtest: pipe-D-plane-0 [138.058710] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s) [138.066977] Starting dynamic subtest: pipe-D-plane-1 [138.225097] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [138.231877] Starting dynamic subtest: pipe-D-plane-2 [138.369704] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [138.658098] Subtest plane-ctm3x4-lut1d: SUCCESS (6.055s) [139.453725] [020/133] (881s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [139.533645] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [143.863296] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.330s) [145.029973] [021/133] (875s left) gem_caching (writes) [145.081068] Subtest writes: SKIP (0.000s) [145.148768] [022/133] (875s left) gem_set_tiling_vs_blt (tiled-to-tiled) [145.209306] Subtest tiled-to-tiled: SKIP (0.000s) [145.274152] [023/133] (875s left) gem_exec_fence (basic-busy) [145.452477] Starting subtest: basic-busy [145.453413] Starting dynamic subtest: rcs0 [145.532398] Dynamic subtest rcs0: SUCCESS (0.085s) [145.542445] Starting dynamic subtest: bcs0 [145.592370] Dynamic subtest bcs0: SUCCESS (0.059s) [145.601557] Starting dynamic subtest: vcs0 [145.652041] Dynamic subtest vcs0: SUCCESS (0.059s) [145.661026] Starting dynamic subtest: vcs1 [145.713364] Dynamic subtest vcs1: SUCCESS (0.060s) [145.729606] Starting dynamic subtest: vecs0 [145.768803] Dynamic subtest vecs0: SUCCESS (0.055s) [145.777857] Starting dynamic subtest: ccs0 [145.824253] Dynamic subtest ccs0: SUCCESS (0.054s) [145.825529] Subtest basic-busy: SUCCESS (0.378s) [148.006671] [024/133] (873s left) prime_vgem (coherency-blt) [148.065415] Starting subtest: coherency-blt [149.981069] Subtest coherency-blt: SUCCESS (1.906s) [150.088020] [025/133] (871s left) gem_mmap_gtt (basic-small-bo-tiledy) [150.152434] Subtest basic-small-bo-tiledY: SKIP (0.000s) [150.214801] [026/133] (870s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [150.326863] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [150.327679] Starting dynamic subtest: pipe-A-eDP-1 [151.200211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.870s) [151.207163] Starting dynamic subtest: pipe-B-eDP-1 [152.869710] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.668s) [152.877086] Starting dynamic subtest: pipe-C-eDP-1 [154.381254] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.511s) [154.388033] Starting dynamic subtest: pipe-D-eDP-1 [155.849543] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.467s) [155.850422] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.520s) [157.037210] [027/133] (864s left) i915_pm_rpm (gem-execbuf-stress-pc8) [159.069333] Starting subtest: gem-execbuf-stress-pc8 [159.106738] Subtest gem-execbuf-stress-pc8: SKIP (0.040s) [159.444705] [028/133] (861s left) gem_ctx_param (invalid-param-set) [159.505555] Starting subtest: invalid-param-set [159.506656] Subtest invalid-param-set: SUCCESS (0.000s) [159.572809] [029/133] (861s left) kms_cursor_legacy (cursor-vs-flip-atomic) [159.688191] Starting subtest: cursor-vs-flip-atomic [189.469690] Subtest cursor-vs-flip-atomic: SUCCESS (29.781s) [190.272799] [030/133] (831s left) gem_exec_nop (basic-parallel) [190.336662] Starting subtest: basic-parallel [206.877621] Subtest basic-parallel: SUCCESS (16.533s) [207.092671] [031/133] (814s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [207.192265] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [207.193138] Starting dynamic subtest: pipe-A [207.257935] Dynamic subtest pipe-A: SUCCESS (0.066s) [207.266847] Starting dynamic subtest: pipe-B [208.409697] Dynamic subtest pipe-B: SUCCESS (1.151s) [208.416648] Starting dynamic subtest: pipe-C [209.525201] Dynamic subtest pipe-C: SUCCESS (1.114s) [209.533191] Starting dynamic subtest: pipe-D [210.639932] Dynamic subtest pipe-D: SUCCESS (1.114s) [210.640865] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.449s) [211.791533] [032/133] (809s left) perf (polling) [211.923398] Starting subtest: polling [211.924327] Starting dynamic subtest: 0-rcs0 [221.951210] Dynamic subtest 0-rcs0: SUCCESS (10.018s) [221.960072] Starting dynamic subtest: 1-vcs0 [232.008245] Dynamic subtest 1-vcs0: SUCCESS (10.019s) [232.009592] Subtest polling: SUCCESS (20.039s) [232.039135] [033/133] (789s left) kms_getfb (getfb-reject-nv12) [232.121990] Starting subtest: getfb-reject-nv12 [232.122754] Subtest getfb-reject-nv12: SUCCESS (0.001s) [232.212538] [034/133] (789s left) gem_render_linear_blits (basic) [232.260149] Starting subtest: basic [232.281833] Subtest basic: SUCCESS (0.023s) [232.361186] [035/133] (789s left) sysfs_timeslice_duration (invalid) [232.420716] Starting subtest: invalid [232.421698] Starting dynamic subtest: vecs0 [232.422612] Dynamic subtest vecs0: SUCCESS (0.000s) [232.430704] Starting dynamic subtest: ccs0 [232.431556] Dynamic subtest ccs0: SUCCESS (0.000s) [232.437952] Starting dynamic subtest: vcs0 [232.439283] Dynamic subtest vcs0: SUCCESS (0.000s) [232.445683] Starting dynamic subtest: bcs0 [232.446578] Dynamic subtest bcs0: SUCCESS (0.000s) [232.452984] Starting dynamic subtest: rcs0 [232.453907] Dynamic subtest rcs0: SUCCESS (0.000s) [232.460249] Starting dynamic subtest: vcs1 [232.461065] Dynamic subtest vcs1: SUCCESS (0.000s) [232.461878] Subtest invalid: SUCCESS (0.005s) [232.537936] [036/133] (789s left) perf (buffer-fill) [232.624438] Starting subtest: buffer-fill [232.625409] Starting dynamic subtest: 0-rcs0 [234.887744] Dynamic subtest 0-rcs0: SUCCESS (2.255s) [234.896487] Starting dynamic subtest: 1-vcs1 [239.324037] Dynamic subtest 1-vcs1: SUCCESS (4.435s) [239.325439] Subtest buffer-fill: SUCCESS (6.692s) [239.354031] [037/133] (782s left) perf_pmu (busy-accuracy-98) [239.389182] Starting subtest: busy-accuracy-98 [239.390047] Starting dynamic subtest: rcs0 [242.439659] Dynamic subtest rcs0: SUCCESS (3.045s) [242.449267] Starting dynamic subtest: bcs0 [245.493368] Dynamic subtest bcs0: SUCCESS (3.052s) [245.502871] Starting dynamic subtest: vcs0 [248.536082] Dynamic subtest vcs0: SUCCESS (3.041s) [248.544548] Starting dynamic subtest: vcs1 [251.578531] Dynamic subtest vcs1: SUCCESS (3.041s) [251.587608] Starting dynamic subtest: vecs0 [254.618268] Dynamic subtest vecs0: SUCCESS (3.037s) [254.627501] Starting dynamic subtest: ccs0 [257.668069] Dynamic subtest ccs0: SUCCESS (3.049s) [257.669073] Subtest busy-accuracy-98: SUCCESS (18.275s) [257.790326] [038/133] (763s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [258.165204] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [258.987827] [039/133] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt) [259.076067] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt [266.141047] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.063s) [266.298402] [040/133] (755s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [266.398816] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [270.591076] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.192s) [271.794123] [041/133] (749s left) gem_lmem_swapping (parallel-random-verify) [271.832816] Subtest parallel-random-verify: SKIP (0.000s) [271.871646] [042/133] (749s left) gem_ctx_persistence (engines-mixed-process) [271.921016] Starting subtest: engines-mixed-process [271.921960] Starting dynamic subtest: rcs0 [273.879572] Dynamic subtest rcs0: SUCCESS (1.958s) [273.889076] Starting dynamic subtest: bcs0 [275.872842] Dynamic subtest bcs0: SUCCESS (1.992s) [275.882493] Starting dynamic subtest: vcs0 [277.892858] Dynamic subtest vcs0: SUCCESS (2.017s) [277.900722] Starting dynamic subtest: vcs1 [279.903453] Dynamic subtest vcs1: SUCCESS (2.011s) [279.914670] Starting dynamic subtest: vecs0 [281.884451] Dynamic subtest vecs0: SUCCESS (1.979s) [281.894346] Starting dynamic subtest: ccs0 [283.941160] Dynamic subtest ccs0: SUCCESS (2.055s) [283.943897] Subtest engines-mixed-process: SUCCESS (12.020s) [284.027608] [043/133] (737s left) gem_exec_suspend (basic-s3) [284.089227] Starting subtest: basic-S3 [284.090265] Starting dynamic subtest: smem [305.287295] Dynamic subtest smem: SUCCESS (6.810s) [305.288471] Subtest basic-S3: SUCCESS (6.812s) [309.514946] [044/133] (716s left) gem_exec_fence (syncobj-wait) [309.997374] Starting subtest: syncobj-wait [311.306772] Subtest syncobj-wait: SUCCESS (1.319s) [311.636664] [045/133] (714s left) gem_flink_basic (basic) [311.705063] Starting subtest: basic [311.705951] Subtest basic: SUCCESS (0.000s) [311.817387] [046/133] (714s left) kms_chamelium_color (ctm-negative) [311.923727] Subtest ctm-negative: SKIP (0.000s) [311.967973] [047/133] (714s left) api_intel_allocator (default-alignment) [312.012759] Starting subtest: default-alignment [312.014155] Subtest default-alignment: SUCCESS (0.003s) [312.134541] [048/133] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [312.224226] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [312.226164] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [312.327808] [049/133] (713s left) kms_psr (pr-cursor-mmap-cpu) [312.417126] Starting subtest: pr-cursor-mmap-cpu [312.418592] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [312.487259] [050/133] (713s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [312.581624] Starting subtest: yf-tiled-8bpp-rotate-180 [312.583340] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [312.679847] [051/133] (713s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [312.774944] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb [312.776580] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [312.843516] [052/133] (713s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [312.957531] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [313.948381] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.002s) [314.056609] [053/133] (712s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [314.161187] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [314.163018] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [314.228536] [054/133] (712s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [314.279926] Starting subtest: legacy-engines-hostile-preempt [314.280946] Starting dynamic subtest: render [314.322446] Dynamic subtest render: SUCCESS (0.042s) [314.333610] Starting dynamic subtest: bsd1 [316.288382] Dynamic subtest bsd1: SUCCESS (1.972s) [316.299517] Starting dynamic subtest: bsd2 [318.271061] Dynamic subtest bsd2: SUCCESS (1.994s) [318.279890] Starting dynamic subtest: blt [318.314444] Dynamic subtest blt: SUCCESS (0.050s) [318.324419] Starting dynamic subtest: vebox [320.253816] Dynamic subtest vebox: SUCCESS (1.937s) [320.255317] Subtest legacy-engines-hostile-preempt: SUCCESS (6.008s) [320.324817] [055/133] (705s left) kms_cursor_crc (cursor-tearing-position-change) [320.435014] Starting subtest: cursor-tearing-position-change [320.435934] Starting dynamic subtest: pipe-A-eDP-1 [321.000051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s) [321.008330] Starting dynamic subtest: pipe-D-eDP-1 [322.205598] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s) [322.206681] Subtest cursor-tearing-position-change: SUCCESS (1.778s) [323.027360] [056/133] (703s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [323.085399] Starting subtest: invalid-multi-wait-unsubmitted [323.086258] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [323.165608] [057/133] (703s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [323.262634] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [329.770371] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.524s) [329.890393] [058/133] (696s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [329.989327] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [336.803443] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.823s) [336.916034] [059/133] (689s left) kms_psr (fbc-psr-cursor-render) [337.011247] Starting subtest: fbc-psr-cursor-render [337.012121] Starting dynamic subtest: eDP-1 [337.013853] Dynamic subtest eDP-1: SKIP (0.000s) [337.015706] Subtest fbc-psr-cursor-render: SKIP (0.001s) [337.084400] [060/133] (689s left) api_intel_bb (lot-of-buffers) [337.144135] Starting subtest: lot-of-buffers [338.285747] Subtest lot-of-buffers: SUCCESS (1.133s) [338.468926] [061/133] (688s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [338.517220] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [338.625070] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s) [338.697552] [062/133] (687s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [338.801620] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [356.278078] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.474s) [357.160831] [063/133] (669s left) gem_mmap_gtt (basic-write-gtt) [357.218180] Subtest basic-write-gtt: SKIP (0.000s) [357.280531] [064/133] (669s left) i915_suspend (forcewake) [357.341151] Starting subtest: forcewake [389.834878] Subtest forcewake: SUCCESS (3.034s) [396.938554] [065/133] (636s left) kms_dsc (dsc-with-formats) [397.036455] Starting subtest: dsc-with-formats [397.050639] Subtest dsc-with-formats: SKIP (0.001s) [397.134521] [066/133] (636s left) kms_psr2_su (page_flip-p010) [397.179038] Subtest page_flip-P010: SKIP (0.000s) [397.229133] [067/133] (636s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [397.323080] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [397.324108] Starting dynamic subtest: pipe-A-eDP-1 [397.333270] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [397.342430] Starting dynamic subtest: pipe-B-eDP-1 [397.351231] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [397.360232] Starting dynamic subtest: pipe-C-eDP-1 [397.368738] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [397.377045] Starting dynamic subtest: pipe-D-eDP-1 [397.385947] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [397.387641] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s) [399.638472] [068/133] (634s left) syncobj_timeline (reset-multiple-signaled) [399.686924] Starting subtest: reset-multiple-signaled [399.687862] Subtest reset-multiple-signaled: SUCCESS (0.001s) [399.777448] [069/133] (634s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [399.872630] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [399.874264] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [399.976986] [070/133] (633s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [400.062957] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [400.064617] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [400.130660] [071/133] (633s left) kms_flip (busy-flip) [400.206854] Starting subtest: busy-flip [400.210295] Starting dynamic subtest: A-eDP1 [401.931970] Dynamic subtest A-eDP1: SUCCESS (1.742s) [401.944019] Starting dynamic subtest: B-eDP1 [403.656828] Dynamic subtest B-eDP1: SUCCESS (1.738s) [403.668289] Starting dynamic subtest: C-eDP1 [405.367231] Dynamic subtest C-eDP1: SUCCESS (1.718s) [405.380048] Starting dynamic subtest: D-eDP1 [406.986707] Dynamic subtest D-eDP1: SUCCESS (1.629s) [406.991130] Subtest busy-flip: SUCCESS (6.841s) [408.148630] [072/133] (625s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [408.242499] Starting subtest: psr-rgb565-draw-mmap-gtt [408.244222] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [408.347742] [073/133] (625s left) kms_lease (lease-invalid-crtc) [408.444915] Starting subtest: lease-invalid-crtc [408.445793] Starting dynamic subtest: pipe-A-eDP-1 [408.446685] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [408.455581] Starting dynamic subtest: pipe-B-eDP-1 [408.456435] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [408.464914] Starting dynamic subtest: pipe-C-eDP-1 [408.466040] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [408.474530] Starting dynamic subtest: pipe-D-eDP-1 [408.475377] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [408.476160] Subtest lease-invalid-crtc: SUCCESS (0.005s) [408.518676] [074/133] (625s left) gem_exec_whisper (basic-forked-all) [408.588871] Starting subtest: basic-forked-all [421.723632] Subtest basic-forked-all: SUCCESS (13.155s) [421.895393] [075/133] (612s left) dumb_buffer (map-uaf) [421.943570] Starting subtest: map-uaf [421.947901] Subtest map-uaf: SUCCESS (0.005s) [422.041069] [076/133] (611s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [422.123272] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [422.124139] Starting dynamic subtest: pipe-A-eDP-1 [422.132349] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [422.141095] Starting dynamic subtest: pipe-B-eDP-1 [422.149372] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [422.157994] Starting dynamic subtest: pipe-C-eDP-1 [422.165997] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [422.174185] Starting dynamic subtest: pipe-D-eDP-1 [422.182513] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [422.184132] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [424.379163] [077/133] (609s left) drm_buddy (drm_buddy) [424.416430] Starting subtest: drm_buddy [424.418238] Subtest drm_buddy: SKIP (0.001s) [424.473461] [078/133] (609s left) syncobj_timeline (wait-all-delayed-signal) [424.528526] Starting subtest: wait-all-delayed-signal [424.631353] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [424.733263] [079/133] (609s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [424.848288] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [424.850033] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [424.999967] [080/133] (609s left) kms_pm_rpm (modeset-lpsp-stress) [426.932561] Starting subtest: modeset-lpsp-stress [443.123596] Subtest modeset-lpsp-stress: SUCCESS (16.191s) [443.221431] [081/133] (591s left) kms_plane_scaling (invalid-num-scalers) [443.317602] Starting subtest: invalid-num-scalers [443.318661] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [443.340073] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.020s) [443.348755] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [443.373127] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s) [443.382775] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [443.408438] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s) [443.416811] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [443.442583] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s) [443.443479] Subtest invalid-num-scalers: SUCCESS (0.125s) [443.548969] [082/133] (590s left) i915_hangman (gt-engine-error) [443.603392] Starting subtest: gt-engine-error [443.604269] Starting dynamic subtest: rcs0 [444.729731] Dynamic subtest rcs0: SUCCESS (1.116s) [444.741875] Starting dynamic subtest: bcs0 [446.713273] Dynamic subtest bcs0: SUCCESS (1.981s) [446.727896] Starting dynamic subtest: vcs0 [448.697583] Dynamic subtest vcs0: SUCCESS (1.981s) [448.709461] Starting dynamic subtest: vcs1 [450.680889] Dynamic subtest vcs1: SUCCESS (1.980s) [450.691983] Starting dynamic subtest: vecs0 [452.728992] Dynamic subtest vecs0: SUCCESS (2.045s) [452.740855] Starting dynamic subtest: ccs0 [454.648822] Dynamic subtest ccs0: SUCCESS (1.917s) [454.649945] Subtest gt-engine-error: SUCCESS (11.037s) [454.756361] [083/133] (579s left) gem_exec_balancer (parallel-balancer) [455.022336] Starting subtest: parallel-balancer [456.011940] Subtest parallel-balancer: SUCCESS (0.990s) [456.109891] [084/133] (578s left) gem_exec_fence (syncobj-timeline-chain-engines) [456.716630] Starting subtest: syncobj-timeline-chain-engines [456.877258] Subtest syncobj-timeline-chain-engines: SUCCESS (0.161s) [457.838286] [085/133] (576s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [457.977116] Starting subtest: cursorB-vs-flipB-toggle [457.978850] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [458.147140] [086/133] (576s left) kms_big_fb (linear-8bpp-rotate-0) [458.242560] Starting subtest: linear-8bpp-rotate-0 [459.500317] Subtest linear-8bpp-rotate-0: SUCCESS (1.258s) [459.619366] [087/133] (574s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [459.713787] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [459.715376] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [459.813310] [088/133] (574s left) gem_exec_reloc (basic-wc-cpu) [459.859177] Subtest basic-wc-cpu: SKIP (0.000s) [459.921665] [089/133] (574s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [460.007829] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [460.009570] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [460.109229] [090/133] (574s left) kms_flip (bo-too-big) [460.197571] Starting subtest: bo-too-big [460.200265] Starting dynamic subtest: A-eDP1 [461.522924] Dynamic subtest A-eDP1: SUCCESS (1.323s) [461.533641] Starting dynamic subtest: B-eDP1 [462.860504] Dynamic subtest B-eDP1: SUCCESS (1.332s) [462.870388] Starting dynamic subtest: C-eDP1 [464.207444] Dynamic subtest C-eDP1: SUCCESS (1.347s) [464.217511] Starting dynamic subtest: D-eDP1 [465.550204] Dynamic subtest D-eDP1: SUCCESS (1.341s) [465.551312] Subtest bo-too-big: SUCCESS (5.352s) [466.742702] [091/133] (567s left) kms_sequence (get-forked-busy) [466.838837] Starting subtest: get-forked-busy [466.839792] Starting dynamic subtest: pipe-A-eDP-1 [468.775145] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s) [468.783699] Starting dynamic subtest: pipe-B-eDP-1 [471.357840] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.582s) [471.366833] Starting dynamic subtest: pipe-C-eDP-1 [473.951927] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.593s) [473.960668] Starting dynamic subtest: pipe-D-eDP-1 [476.591795] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.632s) [476.592939] Subtest get-forked-busy: SUCCESS (9.747s) [477.459902] [092/133] (557s left) gem_userptr_blits (readonly-pwrite-unsync) [477.523642] Subtest readonly-pwrite-unsync: SKIP (0.000s) [477.637655] [093/133] (557s left) kms_rotation_crc (cursor-rotation-180) [477.722619] Starting subtest: cursor-rotation-180 [479.241932] Subtest cursor-rotation-180: SUCCESS (1.520s) [480.445815] [094/133] (554s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [480.530801] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [480.532489] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [480.600875] [095/133] (554s left) syncobj_basic (create-signaled) [480.662068] Starting subtest: create-signaled [480.663050] Subtest create-signaled: SUCCESS (0.000s) [480.761927] [096/133] (554s left) kms_flip (2x-plain-flip-ts-check-interruptible) [480.860353] Starting subtest: 2x-plain-flip-ts-check-interruptible [480.872945] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.013s) [480.944932] [097/133] (553s left) gem_mmap_gtt (basic-read-write-distinct) [480.997468] Subtest basic-read-write-distinct: SKIP (0.000s) [481.052880] [098/133] (553s left) kms_busy (extended-modeset-hang-newfb-with-reset) [481.150624] Starting subtest: extended-modeset-hang-newfb-with-reset [481.151475] Starting dynamic subtest: pipe-A [494.951187] Dynamic subtest pipe-A: SUCCESS (13.802s) [494.960713] Starting dynamic subtest: pipe-D [510.445738] Dynamic subtest pipe-D: SUCCESS (15.496s) [510.446621] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.303s) [511.238845] [099/133] (523s left) kms_pipe_stress (stress-xrgb8888-untiled) [511.334076] Starting subtest: stress-xrgb8888-untiled [517.276713] Subtest stress-xrgb8888-untiled: SUCCESS (5.944s) [517.323142] [100/133] (517s left) gem_lmem_swapping (parallel-multi) [517.362450] Subtest parallel-multi: SKIP (0.000s) [517.397210] [101/133] (517s left) gem_eio (banned) [517.613493] Starting subtest: banned [518.314091] Subtest banned: SUCCESS (0.701s) [518.515557] [102/133] (516s left) gem_ppgtt (flink-and-close-vma-leak) [518.576326] Starting subtest: flink-and-close-vma-leak [518.618686] Subtest flink-and-close-vma-leak: SUCCESS (0.042s) [518.747493] [103/133] (516s left) kms_atomic (atomic-invalid-params) [518.851596] Starting subtest: atomic-invalid-params [518.852564] Starting dynamic subtest: pipe-A-eDP-1 [519.241919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s) [519.242870] Subtest atomic-invalid-params: SUCCESS (0.391s) [520.072823] [104/133] (515s left) gem_mmap_gtt (hang-user) [520.125744] Subtest hang-user: SKIP (0.000s) [520.181662] [105/133] (514s left) gem_ctx_engines (independent) [520.252398] Starting subtest: independent [520.253427] Starting dynamic subtest: rcs0 [520.414174] Dynamic subtest rcs0: SUCCESS (0.151s) [520.426099] Starting dynamic subtest: bcs0 [520.556571] Dynamic subtest bcs0: SUCCESS (0.142s) [520.566598] Starting dynamic subtest: vcs0 [520.706927] Dynamic subtest vcs0: SUCCESS (0.149s) [520.715968] Starting dynamic subtest: vcs1 [520.876434] Dynamic subtest vcs1: SUCCESS (0.171s) [520.887416] Starting dynamic subtest: vecs0 [521.060159] Dynamic subtest vecs0: SUCCESS (0.180s) [521.069801] Starting dynamic subtest: ccs0 [521.241306] Dynamic subtest ccs0: SUCCESS (0.180s) [521.250880] Starting dynamic subtest: all-engines [521.941172] Dynamic subtest all-engines: SUCCESS (0.700s) [521.942296] Subtest independent: SUCCESS (1.682s) [523.819551] [106/133] (511s left) kms_psr (psr2-cursor-mmap-cpu) [523.916636] Starting subtest: psr2-cursor-mmap-cpu [523.917612] Starting dynamic subtest: eDP-1 [525.627282] Dynamic subtest eDP-1: SUCCESS (1.710s) [525.628316] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.711s) [526.420092] [107/133] (508s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [526.514253] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [533.947188] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.436s) [534.115069] [108/133] (501s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [534.213764] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [534.215654] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [534.313595] [109/133] (501s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [534.409480] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [534.411161] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [534.501560] [110/133] (500s left) gem_render_copy (y-tiled-to-vebox-linear) [534.558575] Starting subtest: y-tiled-to-vebox-linear [534.560095] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [534.736506] [111/133] (500s left) gem_pxp (protected-raw-src-copy-not-readible) [534.849197] Starting subtest: protected-raw-src-copy-not-readible [534.908737] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s) [535.047052] [112/133] (500s left) kms_big_fb (4-tiled-32bpp-rotate-180) [535.145312] Starting subtest: 4-tiled-32bpp-rotate-180 [536.546202] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.402s) [536.714300] [113/133] (498s left) gem_exec_reloc (basic-cpu-gtt) [536.771928] Subtest basic-cpu-gtt: SKIP (0.000s) [536.835951] [114/133] (498s left) kms_psr (fbc-pr-sprite-blt) [536.928588] Starting subtest: fbc-pr-sprite-blt [536.930585] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [537.011063] [115/133] (498s left) gem_softpin (evict-single-offset) [537.064812] Starting subtest: evict-single-offset [563.739473] Subtest evict-single-offset: SUCCESS (26.673s) [563.840028] [116/133] (471s left) perf_pmu (idle-no-semaphores) [563.919773] Starting subtest: idle-no-semaphores [563.920648] Starting dynamic subtest: rcs0 [564.471653] Dynamic subtest rcs0: SUCCESS (0.543s) [564.483732] Starting dynamic subtest: bcs0 [564.989206] Dynamic subtest bcs0: SUCCESS (0.514s) [565.000986] Starting dynamic subtest: vcs0 [565.506144] Dynamic subtest vcs0: SUCCESS (0.513s) [565.518071] Starting dynamic subtest: vcs1 [566.023261] Dynamic subtest vcs1: SUCCESS (0.514s) [566.034758] Starting dynamic subtest: vecs0 [566.553297] Dynamic subtest vecs0: SUCCESS (0.527s) [566.564900] Starting dynamic subtest: ccs0 [567.070730] Dynamic subtest ccs0: SUCCESS (0.514s) [567.072496] Subtest idle-no-semaphores: SUCCESS (3.146s) [567.189264] [117/133] (468s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [567.289876] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [567.291495] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [567.378527] [118/133] (468s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping) [567.469905] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping [567.497609] Starting dynamic subtest: pipe-A-plane-0 [567.797197] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s) [567.810636] Starting dynamic subtest: pipe-A-plane-3 [568.030384] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s) [569.107415] Starting dynamic subtest: pipe-B-plane-0 [569.397748] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [569.407093] Starting dynamic subtest: pipe-B-plane-3 [569.631325] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [569.950726] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.482s) [570.775968] [119/133] (464s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [570.866290] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [578.298519] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.436s) [578.443425] [120/133] (457s left) kms_content_protection (dp-mst-type-1) [578.585417] Starting subtest: dp-mst-type-1 [578.587075] Subtest dp-mst-type-1: SKIP (0.000s) [578.711289] [121/133] (457s left) gem_ctx_shared (exec-single-timeline) [578.779072] Starting subtest: exec-single-timeline [578.780165] Starting dynamic subtest: rcs0 [579.832276] Dynamic subtest rcs0: SUCCESS (1.044s) [579.844878] Starting dynamic subtest: bcs0 [580.920289] Dynamic subtest bcs0: SUCCESS (1.085s) [580.932813] Starting dynamic subtest: vcs0 [582.009982] Dynamic subtest vcs0: SUCCESS (1.088s) [582.020839] Starting dynamic subtest: vcs1 [583.097897] Dynamic subtest vcs1: SUCCESS (1.086s) [583.108075] Starting dynamic subtest: vecs0 [584.184973] Dynamic subtest vecs0: SUCCESS (1.085s) [584.198854] Starting dynamic subtest: ccs0 [585.273305] Dynamic subtest ccs0: SUCCESS (1.085s) [585.274694] Subtest exec-single-timeline: SUCCESS (6.489s) [585.450821] [122/133] (450s left) gem_ppgtt (shrink-vs-evict-pinned) [585.522339] Starting subtest: shrink-vs-evict-pinned [590.807077] Subtest shrink-vs-evict-pinned: SUCCESS (5.230s) [590.853408] [123/133] (444s left) gem_ctx_bad_destroy (double-destroy) [590.912973] Starting subtest: double-destroy [590.913950] Subtest double-destroy: SUCCESS (0.000s) [590.990114] [124/133] (444s left) kms_invalid_mode (bad-hsync-end) [591.082638] Starting subtest: bad-hsync-end [591.083511] Starting dynamic subtest: pipe-A-eDP-1 [591.369410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [591.381582] Starting dynamic subtest: pipe-B-eDP-1 [591.382396] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [591.390943] Starting dynamic subtest: pipe-C-eDP-1 [591.391774] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [591.400282] Starting dynamic subtest: pipe-D-eDP-1 [591.401153] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [591.402046] Subtest bad-hsync-end: SUCCESS (0.294s) [592.218433] [125/133] (443s left) gem_exec_schedule (submit-late-slice) [592.292288] Starting subtest: submit-late-slice [592.293166] Starting dynamic subtest: rcs0 [592.333827] Dynamic subtest rcs0: SUCCESS (0.041s) [592.348883] Starting dynamic subtest: bcs0 [592.376058] Dynamic subtest bcs0: SUCCESS (0.041s) [592.386000] Starting dynamic subtest: vcs0 [592.409689] Dynamic subtest vcs0: SUCCESS (0.033s) [592.420196] Starting dynamic subtest: vcs1 [592.448763] Dynamic subtest vcs1: SUCCESS (0.038s) [592.459552] Starting dynamic subtest: vecs0 [592.487392] Dynamic subtest vecs0: SUCCESS (0.038s) [592.496728] Starting dynamic subtest: ccs0 [592.545749] Dynamic subtest ccs0: SUCCESS (0.057s) [592.549330] Subtest submit-late-slice: SUCCESS (0.254s) [593.825524] [126/133] (442s left) gem_userptr_blits (map-fixed-invalidate-overlap) [593.887360] Starting subtest: map-fixed-invalidate-overlap [593.889053] Subtest map-fixed-invalidate-overlap: SKIP (0.000s) [594.000350] [127/133] (441s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [594.084629] Starting subtest: primary-y-tiled-reflect-x-90 [594.086370] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [594.156288] [128/133] (441s left) gem_exec_reloc (basic-write-read-active) [594.206490] Subtest basic-write-read-active: SKIP (0.000s) [594.269394] [129/133] (441s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [594.356470] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [594.358180] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [594.454101] [130/133] (441s left) kms_psr (psr-primary-mmap-cpu) [594.534633] Starting subtest: psr-primary-mmap-cpu [594.535530] Starting dynamic subtest: eDP-1 [596.321286] Dynamic subtest eDP-1: SUCCESS (1.784s) [596.322139] Subtest psr-primary-mmap-cpu: SUCCESS (1.785s) [597.184432] [131/133] (438s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [597.572128] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [598.393792] [132/133] (437s left) gen7_exec_parse (basic-allocation) [598.457514] Subtest basic-allocation: SKIP (0.000s) [598.525836] [133/133] (437s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [598.572046] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [598.573339] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [598.670793] Closing watchdogs results: parsing output: 0/ for test: kms_vblank results: parsing output: 1/ for test: kms_big_fb results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: gen9_exec_parse results: parsing output: 5/ for test: gem_exec_flush results: parsing output: 6/ for test: kms_async_flips results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_userptr_blits results: parsing output: 9/ for test: i915_drm_fdinfo results: parsing output: 10/ for test: kms_dirtyfb results: parsing output: 11/ for test: kms_plane_lowres results: parsing output: 12/ for test: kms_pm_rpm results: parsing output: 13/ for test: gem_exec_schedule results: parsing output: 14/ for test: kms_big_fb results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_cursor_crc results: parsing output: 17/ for test: kms_cursor_crc results: parsing output: 18/ for test: kms_color_pipeline results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: gem_caching results: parsing output: 21/ for test: gem_set_tiling_vs_blt results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: prime_vgem results: parsing output: 24/ for test: gem_mmap_gtt results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: i915_pm_rpm results: parsing output: 27/ for test: gem_ctx_param results: parsing output: 28/ for test: kms_cursor_legacy results: parsing output: 29/ for test: gem_exec_nop results: parsing output: 30/ for test: kms_plane_scaling results: parsing output: 31/ for test: perf results: parsing output: 32/ for test: kms_getfb results: parsing output: 33/ for test: gem_render_linear_blits results: parsing output: 34/ for test: sysfs_timeslice_duration results: parsing output: 35/ for test: perf results: parsing output: 36/ for test: perf_pmu results: parsing output: 37/ for test: kms_chamelium_edid results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_lmem_swapping results: parsing output: 41/ for test: gem_ctx_persistence results: parsing output: 42/ for test: gem_exec_suspend results: parsing output: 43/ for test: gem_exec_fence results: parsing output: 44/ for test: gem_flink_basic results: parsing output: 45/ for test: kms_chamelium_color results: parsing output: 46/ for test: api_intel_allocator results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_psr results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: kms_psr2_sf results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: kms_psr2_sf results: parsing output: 53/ for test: gem_ctx_persistence results: parsing output: 54/ for test: kms_cursor_crc results: parsing output: 55/ for test: syncobj_timeline results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: api_intel_bb results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_cursor_legacy results: parsing output: 62/ for test: gem_mmap_gtt results: parsing output: 63/ for test: i915_suspend results: parsing output: 64/ for test: kms_dsc results: parsing output: 65/ for test: kms_psr2_su results: parsing output: 66/ for test: kms_ccs results: parsing output: 67/ for test: syncobj_timeline results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_flip_scaled_crc results: parsing output: 70/ for test: kms_flip results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_lease results: parsing output: 73/ for test: gem_exec_whisper results: parsing output: 74/ for test: dumb_buffer results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: drm_buddy results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: kms_cursor_legacy results: parsing output: 79/ for test: kms_pm_rpm results: parsing output: 80/ for test: kms_plane_scaling results: parsing output: 81/ for test: i915_hangman results: parsing output: 82/ for test: gem_exec_balancer results: parsing output: 83/ for test: gem_exec_fence results: parsing output: 84/ for test: kms_cursor_legacy results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_exec_reloc results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: gem_userptr_blits results: parsing output: 92/ for test: kms_rotation_crc results: parsing output: 93/ for test: kms_flip_scaled_crc results: parsing output: 94/ for test: syncobj_basic results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: gem_mmap_gtt results: parsing output: 97/ for test: kms_busy results: parsing output: 98/ for test: kms_pipe_stress results: parsing output: 99/ for test: gem_lmem_swapping results: parsing output: 100/ for test: gem_eio results: parsing output: 101/ for test: gem_ppgtt results: parsing output: 102/ for test: kms_atomic results: parsing output: 103/ for test: gem_mmap_gtt results: parsing output: 104/ for test: gem_ctx_engines results: parsing output: 105/ for test: kms_psr results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_render_copy results: parsing output: 110/ for test: gem_pxp results: parsing output: 111/ for test: kms_big_fb results: parsing output: 112/ for test: gem_exec_reloc results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: gem_softpin results: parsing output: 115/ for test: perf_pmu results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_plane results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_content_protection results: parsing output: 120/ for test: gem_ctx_shared results: parsing output: 121/ for test: gem_ppgtt results: parsing output: 122/ for test: gem_ctx_bad_destroy results: parsing output: 123/ for test: kms_invalid_mode results: parsing output: 124/ for test: gem_exec_schedule results: parsing output: 125/ for test: gem_userptr_blits results: parsing output: 126/ for test: kms_rotation_crc results: parsing output: 127/ for test: gem_exec_reloc results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_psr results: parsing output: 130/ for test: kms_chamelium_hpd results: parsing output: 131/ for test: gen7_exec_parse results: parsing output: 132/ for test: syncobj_wait Done.