[63.210135] Initializing watchdogs [63.210183] /dev/watchdog0 [63.224987] [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] [63.229833] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [63.232404] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.234195] [001/133] (960s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [65.084036] Starting subtest: modeset-lpsp-stress-no-wait [74.871126] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.810s) [74.938874] [002/133] (948s left) kms_properties (connector-properties-legacy) [75.032798] Starting subtest: connector-properties-legacy [75.033856] Starting dynamic subtest: pipe-A-eDP-1 [82.911924] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.883s) [82.918182] Starting dynamic subtest: pipe-None-DP-1 [82.919894] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [82.927144] Starting dynamic subtest: pipe-None-HDMI-A-1 [82.928869] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [82.933958] Starting dynamic subtest: pipe-None-DP-2 [82.935750] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [82.941136] Starting dynamic subtest: pipe-None-HDMI-A-2 [82.942852] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [82.948046] Starting dynamic subtest: pipe-None-DP-3 [82.949792] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [82.955061] Starting dynamic subtest: pipe-None-DP-4 [82.957324] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [82.958162] Subtest connector-properties-legacy: SUCCESS (7.892s) [83.774113] [003/133] (940s left) gem_exec_params (invalid-bsd1-flag-on-blt) [83.829450] Starting subtest: invalid-bsd1-flag-on-blt [83.830424] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [83.916966] [004/133] (939s left) kms_psr (fbc-psr-cursor-blt) [84.012511] Starting subtest: fbc-psr-cursor-blt [84.013516] Starting dynamic subtest: eDP-1 [84.015265] Dynamic subtest eDP-1: SKIP (0.000s) [84.016978] Subtest fbc-psr-cursor-blt: SKIP (0.000s) [84.093464] [005/133] (939s left) syncobj_timeline (single-wait-for-submit-available-signaled) [84.143368] Starting subtest: single-wait-for-submit-available-signaled [84.144451] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [84.228328] [006/133] (939s left) gem_softpin (full) [84.293984] Starting subtest: full [84.301691] Subtest full: SUCCESS (0.009s) [84.422843] [007/133] (939s left) syncobj_timeline (multi-wait-available-submitted-signaled) [84.465901] Starting subtest: multi-wait-available-submitted-signaled [84.466741] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [84.570839] [008/133] (939s left) gem_exec_whisper (basic-queues) [84.635322] Starting subtest: basic-queues [90.249996] Subtest basic-queues: SUCCESS (5.614s) [90.427373] [009/133] (933s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [90.538180] Starting subtest: plane-downscale-factor-0-75-with-modifiers [90.539178] Starting dynamic subtest: pipe-A [90.879234] Dynamic subtest pipe-A: SUCCESS (0.342s) [90.886838] Starting dynamic subtest: pipe-B [92.288699] Dynamic subtest pipe-B: SUCCESS (1.409s) [92.295552] Starting dynamic subtest: pipe-C [93.695549] Dynamic subtest pipe-C: SUCCESS (1.407s) [93.703484] Starting dynamic subtest: pipe-D [95.128105] Dynamic subtest pipe-D: SUCCESS (1.432s) [95.129055] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.591s) [96.296531] [010/133] (927s left) gem_eio (hibernate) [96.555408] Starting subtest: hibernate [112.082823] Subtest hibernate: SUCCESS (15.528s) [120.243009] [011/133] (911s left) gem_pxp (create-valid-protected-context) [120.379720] Starting subtest: create-valid-protected-context [120.381247] Subtest create-valid-protected-context: SUCCESS (0.002s) [120.487755] [012/133] (911s left) gem_mmap_offset (blt-coherency) [120.534273] Starting subtest: blt-coherency [120.544990] Subtest blt-coherency: SUCCESS (0.011s) [120.665206] [013/133] (911s left) kms_flip (2x-plain-flip-interruptible) [120.779357] Starting subtest: 2x-plain-flip-interruptible [120.804765] Subtest 2x-plain-flip-interruptible: SKIP (0.025s) [120.876961] [014/133] (911s left) gem_exec_fence (nb-await) [121.046550] Starting subtest: nb-await [121.047743] Starting dynamic subtest: rcs0 [121.106567] Dynamic subtest rcs0: SUCCESS (0.066s) [121.117369] Starting dynamic subtest: bcs0 [121.165982] Dynamic subtest bcs0: SUCCESS (0.058s) [121.176522] Starting dynamic subtest: vcs0 [121.226775] Dynamic subtest vcs0: SUCCESS (0.059s) [121.237838] Starting dynamic subtest: vcs1 [121.285794] Dynamic subtest vcs1: SUCCESS (0.058s) [121.296700] Starting dynamic subtest: vecs0 [121.346573] Dynamic subtest vecs0: SUCCESS (0.059s) [121.357504] Starting dynamic subtest: ccs0 [121.404157] Dynamic subtest ccs0: SUCCESS (0.057s) [121.405311] Subtest nb-await: SUCCESS (0.365s) [122.911296] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true [122.913263] [015/133] (909s left) kms_psr (fbc-pr-primary-mmap-cpu) [123.020337] Starting subtest: fbc-pr-primary-mmap-cpu [123.022115] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [123.088975] [016/133] (909s left) syncobj_wait (invalid-signal-illegal-handle) [123.138620] Starting subtest: invalid-signal-illegal-handle [123.139536] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [123.248546] [017/133] (909s left) gem_close_race (basic-process) [123.309741] Starting subtest: basic-process [123.352530] Subtest basic-process: SUCCESS (0.043s) [123.530621] [018/133] (908s left) vgem_basic (setversion) [123.564798] Starting subtest: setversion [123.566507] Subtest setversion: SUCCESS (0.000s) [123.618250] [019/133] (908s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [123.706581] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [123.707406] Starting dynamic subtest: pipe-A-eDP-1 [123.795949] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s) [123.805108] Starting dynamic subtest: pipe-B-eDP-1 [124.943349] Dynamic subtest pipe-B-eDP-1: SKIP (1.146s) [124.945122] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.238s) [126.117410] [020/133] (906s left) gem_exec_schedule (semaphore-codependency) [126.171409] Starting subtest: semaphore-codependency [126.185869] Subtest semaphore-codependency: SUCCESS (0.015s) [126.518543] [021/133] (905s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [126.598768] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [126.599681] Starting dynamic subtest: pipe-A-eDP-1 [127.480549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.880s) [127.489131] Starting dynamic subtest: pipe-B-eDP-1 [129.166657] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.685s) [129.174725] Starting dynamic subtest: pipe-C-eDP-1 [130.663686] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.497s) [130.671432] Starting dynamic subtest: pipe-D-eDP-1 [132.181677] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.516s) [132.182501] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.582s) [133.340644] [022/133] (899s left) api_intel_bb (render) [133.387100] Starting subtest: render [133.387927] Starting dynamic subtest: render-none-512 [133.491039] Dynamic subtest render-none-512: SUCCESS (0.103s) [133.501548] Starting dynamic subtest: render-none-1024 [133.895019] Dynamic subtest render-none-1024: SUCCESS (0.394s) [133.905237] Starting dynamic subtest: render-x-512 [133.973638] Dynamic subtest render-x-512: SUCCESS (0.088s) [133.981243] Starting dynamic subtest: render-x-1024 [134.333716] Dynamic subtest render-x-1024: SUCCESS (0.350s) [134.343968] Starting dynamic subtest: render-y-512 [134.411672] Dynamic subtest render-y-512: SUCCESS (0.087s) [134.421267] Starting dynamic subtest: render-y-1024 [134.778436] Dynamic subtest render-y-1024: SUCCESS (0.357s) [134.779547] Subtest render: SUCCESS (1.382s) [134.869527] [023/133] (897s left) kms_big_fb (4-tiled-64bpp-rotate-180) [134.970196] Starting subtest: 4-tiled-64bpp-rotate-180 [136.495399] Subtest 4-tiled-64bpp-rotate-180: FAIL (1.300s) [136.542166] [024/133] (895s left) kms_vrr (max-min) [136.646113] Starting subtest: max-min [136.648887] Subtest max-min: SKIP (0.000s) [136.716826] [025/133] (895s left) syncobj_basic (bad-handle-to-fd) [136.779866] Starting subtest: bad-handle-to-fd [136.780866] Subtest bad-handle-to-fd: SUCCESS (0.000s) [136.874277] [026/133] (895s left) kms_async_flips (basic-modeset-with-all-modifiers-formats) [136.967834] Starting subtest: basic-modeset-with-all-modifiers-formats [137.348809] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888 [138.127990] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.779s) [138.139147] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010 [138.149824] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s) [138.157447] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F [138.172211] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s) [138.182232] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565 [138.316271] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s) [138.325344] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888 [138.338513] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s) [138.346358] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010 [138.360693] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s) [138.368456] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F [138.382913] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s) [138.390910] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV [138.405204] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s) [138.413083] Starting dynamic subtest: pipe-A-eDP-1-4-Y210 [138.428800] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.023s) [138.438026] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888 [138.449670] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.019s) [138.457847] Starting dynamic subtest: pipe-A-eDP-1-4-XV30 [138.471852] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s) [138.480054] Starting dynamic subtest: pipe-A-eDP-1-4-XV36 [138.493983] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s) [138.502073] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565 [138.650542] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.156s) [138.661756] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888 [138.671886] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s) [138.681057] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010 [138.694072] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s) [138.703169] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F [138.716313] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s) [138.724037] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV [138.738527] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s) [138.746179] Starting dynamic subtest: pipe-A-eDP-1-x-Y210 [138.760714] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s) [138.768441] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888 [138.782930] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s) [138.791515] Starting dynamic subtest: pipe-A-eDP-1-x-XV30 [138.805059] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s) [138.814748] Starting dynamic subtest: pipe-A-eDP-1-x-XV36 [138.827414] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s) [138.837258] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565 [138.983751] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s) [138.993565] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888 [139.005607] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s) [139.015569] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010 [139.027803] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s) [139.036565] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F [139.050323] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s) [139.064214] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV [139.072388] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s) [139.082692] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210 [139.094553] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s) [139.102055] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888 [139.116731] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s) [139.124455] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30 [139.138932] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s) [139.146649] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36 [139.161057] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s) [139.547370] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.584s) [140.310820] [027/133] (892s left) kms_psr (psr2-sprite-plane-onoff) [140.397281] Starting subtest: psr2-sprite-plane-onoff [140.398135] Starting dynamic subtest: eDP-1 [142.120509] Dynamic subtest eDP-1: SUCCESS (1.724s) [142.121434] Subtest psr2-sprite-plane-onoff: SUCCESS (1.724s) [142.975204] [028/133] (889s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [143.065177] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [143.066878] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [143.154282] [029/133] (889s left) kms_big_fb (x-tiled-32bpp-rotate-180) [143.244883] Starting subtest: x-tiled-32bpp-rotate-180 [144.672057] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.427s) [144.802806] [030/133] (887s left) perf_pmu (semaphore-wait) [144.846273] Starting subtest: semaphore-wait [144.847149] Starting dynamic subtest: rcs0 [145.371098] Dynamic subtest rcs0: SUCCESS (0.514s) [145.384072] Starting dynamic subtest: bcs0 [145.888523] Dynamic subtest bcs0: SUCCESS (0.514s) [145.903560] Starting dynamic subtest: vcs0 [146.402034] Dynamic subtest vcs0: SUCCESS (0.511s) [146.412067] Starting dynamic subtest: vcs1 [146.913877] Dynamic subtest vcs1: SUCCESS (0.509s) [146.923894] Starting dynamic subtest: vecs0 [147.424283] Dynamic subtest vecs0: SUCCESS (0.509s) [147.434450] Starting dynamic subtest: ccs0 [147.938810] Dynamic subtest ccs0: SUCCESS (0.512s) [147.940032] Subtest semaphore-wait: SUCCESS (3.084s) [148.044653] [031/133] (884s left) gem_request_retire (retire-vma-not-inactive) [148.090578] Starting subtest: retire-vma-not-inactive [148.147894] Subtest retire-vma-not-inactive: SUCCESS (0.057s) [148.250383] [032/133] (884s left) kms_flip (2x-flip-vs-panning) [148.343867] Starting subtest: 2x-flip-vs-panning [148.358378] Subtest 2x-flip-vs-panning: SKIP (0.014s) [148.446581] [033/133] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [148.530299] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [156.014585] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.485s) [156.135898] [034/133] (876s left) i915_pm_sseu (full-enable) [156.189676] Subtest full-enable: SKIP (0.000s) [156.277305] [035/133] (876s left) syncobj_wait (wait-all-for-submit-complex) [156.324037] Starting subtest: wait-all-for-submit-complex [156.546552] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [156.607396] [036/133] (876s left) kms_plane_multiple (tiling-4) [156.697426] Starting subtest: tiling-4 [156.698618] Starting dynamic subtest: pipe-A-eDP-1 [160.433936] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.738s) [160.443155] Starting dynamic subtest: pipe-B-eDP-1 [164.871216] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.436s) [164.880051] Starting dynamic subtest: pipe-C-eDP-1 [169.271051] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.398s) [169.279302] Starting dynamic subtest: pipe-D-eDP-1 [173.598619] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.326s) [173.599460] Subtest tiling-4: SUCCESS (16.902s) [174.411714] [037/133] (858s left) gem_exec_params (invalid-ring2) [174.466626] Starting subtest: invalid-ring2 [174.467616] Subtest invalid-ring2: SUCCESS (0.000s) [174.556830] [038/133] (858s left) gem_exec_create (legacy) [174.614287] Starting subtest: legacy [174.615293] Starting dynamic subtest: smem [177.888759] Dynamic subtest smem: SUCCESS (3.263s) [177.890333] Subtest legacy: SUCCESS (3.265s) [178.074533] [039/133] (854s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [178.175176] Starting subtest: flip-vs-dpms-on-nop-interruptible [178.177556] Starting dynamic subtest: A-eDP1 [180.001115] Dynamic subtest A-eDP1: SUCCESS (1.823s) [180.011148] Starting dynamic subtest: B-eDP1 [181.829385] Dynamic subtest B-eDP1: SUCCESS (1.825s) [181.843756] Starting dynamic subtest: C-eDP1 [183.648406] Dynamic subtest C-eDP1: SUCCESS (1.817s) [183.661610] Starting dynamic subtest: D-eDP1 [185.496683] Dynamic subtest D-eDP1: SUCCESS (1.846s) [185.501340] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.326s) [186.656983] [040/133] (846s left) dumb_buffer (map-valid) [186.709332] Starting subtest: map-valid [186.710332] Subtest map-valid: SUCCESS (0.000s) [186.824413] [041/133] (846s left) kms_draw_crc (draw-method-pwrite) [186.905343] Starting subtest: draw-method-pwrite [186.906280] Starting dynamic subtest: xrgb8888-untiled [187.516887] Dynamic subtest xrgb8888-untiled: SUCCESS (0.611s) [187.525027] Starting dynamic subtest: rgb565-untiled [187.983344] Dynamic subtest rgb565-untiled: SUCCESS (0.466s) [187.999823] Starting dynamic subtest: xrgb2101010-untiled [188.561120] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.577s) [188.569734] Starting dynamic subtest: xbgr16161616f-untiled [189.383389] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.821s) [189.394498] Starting dynamic subtest: xrgb8888-xtiled [191.305685] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.921s) [191.313812] Starting dynamic subtest: rgb565-xtiled [192.472076] Dynamic subtest rgb565-xtiled: SUCCESS (1.166s) [192.482534] Starting dynamic subtest: xrgb2101010-xtiled [194.405651] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.931s) [194.414123] Starting dynamic subtest: xbgr16161616f-xtiled [197.961077] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.555s) [197.969456] Starting dynamic subtest: xrgb8888-4tiled [199.161105] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.199s) [199.171946] Starting dynamic subtest: rgb565-4tiled [199.761239] Dynamic subtest rgb565-4tiled: SUCCESS (0.599s) [199.772115] Starting dynamic subtest: xrgb2101010-4tiled [200.938822] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.175s) [200.947168] Starting dynamic subtest: xbgr16161616f-4tiled [204.161292] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.221s) [204.162162] Subtest draw-method-pwrite: SUCCESS (17.256s) [204.240218] [042/133] (828s left) kms_flip (dpms-off-confusion-interruptible) [204.337549] Starting subtest: dpms-off-confusion-interruptible [204.339919] Starting dynamic subtest: A-eDP1 [213.000966] Dynamic subtest A-eDP1: SUCCESS (8.634s) [213.011561] Starting dynamic subtest: B-eDP1 [221.629933] Dynamic subtest B-eDP1: SUCCESS (8.627s) [221.640905] Starting dynamic subtest: C-eDP1 [230.254722] Dynamic subtest C-eDP1: SUCCESS (8.612s) [230.265431] Starting dynamic subtest: D-eDP1 [238.884351] Dynamic subtest D-eDP1: SUCCESS (8.626s) [238.885657] Subtest dpms-off-confusion-interruptible: SUCCESS (34.510s) [240.018795] [043/133] (793s left) kms_lease (multimaster-lease) [240.118783] Starting subtest: multimaster-lease [240.125898] Subtest multimaster-lease: SUCCESS (0.008s) [240.250518] [044/133] (792s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [240.355888] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [240.357769] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [240.450589] [045/133] (792s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled) [240.507183] Starting subtest: invalid-multi-wait-unsubmitted-signaled [240.508190] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [240.612464] [046/133] (792s left) syncobj_timeline (32bits-limit) [240.657633] Starting subtest: 32bits-limit [240.658671] Subtest 32bits-limit: SUCCESS (0.001s) [240.756617] [047/133] (792s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [240.844690] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [240.846276] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [240.933747] [048/133] (792s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [241.024857] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [247.757205] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.733s) [247.880315] [049/133] (785s left) kms_vblank (query-forked) [247.992932] Starting subtest: query-forked [247.993856] Starting dynamic subtest: pipe-A-eDP-1 [249.797639] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.814s) [249.808638] Starting dynamic subtest: pipe-D-eDP-1 [252.377367] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.577s) [252.378236] Subtest query-forked: SUCCESS (4.394s) [253.208611] [050/133] (780s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [253.321596] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [254.310401] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.988s) [255.153690] [051/133] (778s left) i915_query (query-topology-unsupported) [255.206325] Starting subtest: query-topology-unsupported [255.207866] Subtest query-topology-unsupported: SKIP (0.000s) [255.291703] [052/133] (778s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [255.380383] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [256.038808] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s) [256.199192] [053/133] (777s left) kms_pipe_stress (stress-xrgb8888-4tiled) [256.294176] Starting subtest: stress-xrgb8888-4tiled [262.194163] Subtest stress-xrgb8888-4tiled: SUCCESS (5.900s) [262.241775] [054/133] (771s left) gem_eio (wait-wedge-immediate) [262.486543] Starting subtest: wait-wedge-immediate [263.978416] Subtest wait-wedge-immediate: SUCCESS (1.491s) [264.099842] [055/133] (769s left) kms_color (ctm-signed) [264.183430] Starting subtest: ctm-signed [264.184372] Starting dynamic subtest: pipe-A-eDP-1 [266.233529] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.051s) [266.241940] Starting dynamic subtest: pipe-B-eDP-1 [269.002159] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s) [269.010179] Starting dynamic subtest: pipe-C-eDP-1 [271.643054] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.641s) [271.651225] Starting dynamic subtest: pipe-D-eDP-1 [274.295622] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.652s) [274.296578] Subtest ctm-signed: SUCCESS (10.113s) [275.140912] [056/133] (758s left) i915_query (query-garbage) [275.196105] Starting subtest: query-garbage [275.196919] Subtest query-garbage: SUCCESS (0.000s) [275.295441] [057/133] (758s left) syncobj_timeline (wait-for-submit-delayed-submit) [275.346087] Starting subtest: wait-for-submit-delayed-submit [275.450067] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [275.533079] [058/133] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [275.625411] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [279.678203] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.053s) [280.834339] [059/133] (752s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [280.949901] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [280.951766] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [281.092202] [060/133] (752s left) kms_rotation_crc (primary-rotation-270) [281.172548] Starting subtest: primary-rotation-270 [281.174333] Subtest primary-rotation-270: SKIP (0.001s) [281.256299] [061/133] (752s left) gem_mmap_gtt (cpuset-big-copy) [281.301572] Subtest cpuset-big-copy: SKIP (0.000s) [281.354461] [062/133] (752s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [281.448263] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [281.449907] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [281.538139] [063/133] (752s left) gem_ctx_param (non-root-set) [281.592732] Starting subtest: non-root-set [281.609808] Subtest non-root-set: SUCCESS (0.017s) [281.700378] [064/133] (752s left) gem_mmap (short-mmap) [281.755332] Subtest short-mmap: SKIP (0.000s) [281.806184] [065/133] (752s left) gem_exec_schedule (noreorder) [281.994549] Starting subtest: noreorder [281.995398] Starting dynamic subtest: rcs0 [282.058258] Dynamic subtest rcs0: SUCCESS (0.069s) [282.070454] Starting dynamic subtest: vcs0 [283.931497] Dynamic subtest vcs0: SUCCESS (1.862s) [283.942651] Starting dynamic subtest: vcs1 [285.914797] Dynamic subtest vcs1: SUCCESS (1.980s) [285.928306] Starting dynamic subtest: vecs0 [287.880731] Dynamic subtest vecs0: SUCCESS (1.963s) [287.891277] Starting dynamic subtest: ccs0 [287.948683] Dynamic subtest ccs0: SUCCESS (0.075s) [287.949868] Subtest noreorder: SUCCESS (5.961s) [288.153641] [066/133] (745s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf) [288.247444] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf [288.249264] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [288.315843] [067/133] (745s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [288.407883] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [289.211846] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.804s) [289.406935] [068/133] (744s left) gem_exec_reloc (basic-wc-cpu-active) [289.465364] Subtest basic-wc-cpu-active: SKIP (0.000s) [289.541287] [069/133] (744s left) kms_busy (extended-pageflip-hang-oldfb) [289.632089] Starting subtest: extended-pageflip-hang-oldfb [289.632892] Starting dynamic subtest: pipe-A [290.038669] Dynamic subtest pipe-A: SUCCESS (0.404s) [290.048821] Starting dynamic subtest: pipe-D [291.148272] Dynamic subtest pipe-D: SUCCESS (1.109s) [291.149108] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.517s) [291.990944] [070/133] (742s left) kms_hdr (invalid-metadata-sizes) [292.080255] Starting subtest: invalid-metadata-sizes [292.082845] Subtest invalid-metadata-sizes: SKIP (0.000s) [292.148967] [071/133] (742s left) kms_pm_lpsp (screens-disabled) [293.240085] Starting subtest: screens-disabled [293.241843] Subtest screens-disabled: SKIP (0.000s) [293.307946] [072/133] (740s left) i915_hangman (gt-error-state-capture) [293.367951] Starting subtest: gt-error-state-capture [293.368891] Starting dynamic subtest: rcs0 [303.869308] Dynamic subtest rcs0: SUCCESS (10.492s) [303.880758] Starting dynamic subtest: bcs0 [314.876809] Dynamic subtest bcs0: SUCCESS (11.005s) [314.887512] Starting dynamic subtest: vcs0 [325.884949] Dynamic subtest vcs0: SUCCESS (11.006s) [325.895690] Starting dynamic subtest: vcs1 [336.892856] Dynamic subtest vcs1: SUCCESS (11.005s) [336.908952] Starting dynamic subtest: vecs0 [348.861488] Dynamic subtest vecs0: SUCCESS (11.965s) [348.873882] Starting dynamic subtest: ccs0 [359.869395] Dynamic subtest ccs0: SUCCESS (11.005s) [359.870874] Subtest gt-error-state-capture: SUCCESS (66.494s) [359.981377] [073/133] (674s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [360.081833] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [360.084291] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [360.158435] [074/133] (674s left) kms_content_protection (uevent) [360.281829] Starting subtest: uevent [360.283935] Subtest uevent: SKIP (0.000s) [360.402569] [075/133] (673s left) gem_exec_balancer (indices) [360.455504] Starting subtest: indices [362.876497] Subtest indices: SUCCESS (2.412s) [363.168258] [076/133] (671s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [363.261734] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [363.263378] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [363.345239] [077/133] (671s left) kms_cursor_crc (cursor-sliding-128x128) [363.575825] Starting subtest: cursor-sliding-128x128 [363.578899] Starting dynamic subtest: pipe-A-eDP-1 [366.786902] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.207s) [366.817996] Starting dynamic subtest: pipe-D-eDP-1 [370.683651] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.873s) [370.684652] Subtest cursor-sliding-128x128: SUCCESS (7.107s) [371.538767] [078/133] (662s left) kms_chamelium_hpd (hdmi-hpd-fast) [371.927837] Subtest hdmi-hpd-fast: SKIP (0.000s) [372.747009] [079/133] (661s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [372.838291] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [372.839866] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [372.979319] [080/133] (661s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [373.072496] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [373.074468] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [374.218159] [081/133] (660s left) kms_joiner (basic-ultra-joiner) [374.304734] Starting subtest: basic-ultra-joiner [374.306513] Subtest basic-ultra-joiner: SKIP (0.000s) [374.372903] [082/133] (660s left) kms_psr (fbc-psr2-cursor-render) [374.462407] Starting subtest: fbc-psr2-cursor-render [374.463293] Starting dynamic subtest: eDP-1 [374.465045] Dynamic subtest eDP-1: SKIP (0.000s) [374.466733] Subtest fbc-psr2-cursor-render: SKIP (0.001s) [374.535430] [083/133] (660s left) i915_drm_fdinfo (all-busy-check-all) [374.568760] Starting subtest: all-busy-check-all [374.573384] Subtest all-busy-check-all: SKIP (0.004s) [374.630552] [084/133] (660s left) perf_pmu (init-wait) [374.664129] Starting subtest: init-wait [374.665020] Starting dynamic subtest: rcs0 [374.665888] Dynamic subtest rcs0: SUCCESS (0.001s) [374.681712] Starting dynamic subtest: bcs0 [374.682552] Dynamic subtest bcs0: SUCCESS (0.000s) [374.694924] Starting dynamic subtest: vcs0 [374.695895] Dynamic subtest vcs0: SUCCESS (0.000s) [374.703808] Starting dynamic subtest: vcs1 [374.704697] Dynamic subtest vcs1: SUCCESS (0.000s) [374.712699] Starting dynamic subtest: vecs0 [374.713755] Dynamic subtest vecs0: SUCCESS (0.000s) [374.724393] Starting dynamic subtest: ccs0 [374.725372] Dynamic subtest ccs0: SUCCESS (0.000s) [374.726161] Subtest init-wait: SUCCESS (0.006s) [374.806308] [085/133] (659s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [374.893352] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [374.895104] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [374.991427] [086/133] (659s left) kms_addfb_basic (invalid-set-prop) [375.049321] Starting subtest: invalid-set-prop [375.050215] Subtest invalid-set-prop: SUCCESS (0.000s) [375.178794] [087/133] (659s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [375.277260] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [375.279058] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [375.370803] [088/133] (659s left) device_reset (cold-reset-bound) [375.418962] Starting subtest: cold-reset-bound [375.420859] Subtest cold-reset-bound: SKIP (0.000s) [375.476167] [089/133] (659s left) gem_pxp (hw-rejects-pxp-context) [375.531986] Starting subtest: hw-rejects-pxp-context [375.533790] Subtest hw-rejects-pxp-context: SKIP (0.000s) [375.645475] [090/133] (659s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [375.734510] Starting subtest: fbc-rgb101010-draw-mmap-cpu [380.275445] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.542s) [381.388502] [091/133] (653s left) gem_exec_gttfill (multigpu-basic) [381.566326] Starting subtest: multigpu-basic [393.999022] Subtest multigpu-basic: SUCCESS (12.433s) [394.043020] [092/133] (640s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [394.186084] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [394.186896] Starting dynamic subtest: pipe-A-eDP-1 [394.195147] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [394.204253] Starting dynamic subtest: pipe-B-eDP-1 [394.212654] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [394.221610] Starting dynamic subtest: pipe-C-eDP-1 [394.229824] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [394.238484] Starting dynamic subtest: pipe-D-eDP-1 [394.246816] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [394.248414] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s) [396.429570] [093/133] (638s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [396.522201] Starting subtest: planes-downscale-factor-0-5-unity-scaling [396.523154] Starting dynamic subtest: pipe-A [396.541913] Dynamic subtest pipe-A: SKIP (0.018s) [396.550578] Starting dynamic subtest: pipe-B [396.574836] Dynamic subtest pipe-B: SKIP (0.032s) [396.585103] Starting dynamic subtest: pipe-C [396.607756] Dynamic subtest pipe-C: SKIP (0.032s) [396.616749] Starting dynamic subtest: pipe-D [396.639241] Dynamic subtest pipe-D: SKIP (0.032s) [396.640980] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.117s) [396.747951] [094/133] (638s left) gem_ctx_isolation (dirty-switch) [396.803969] Starting subtest: dirty-switch [396.804992] Starting dynamic subtest: rcs0 [396.988977] Dynamic subtest rcs0: SUCCESS (0.185s) [397.000842] Starting dynamic subtest: bcs0 [397.188073] Dynamic subtest bcs0: SUCCESS (0.198s) [397.200579] Starting dynamic subtest: vcs0 [397.385855] Dynamic subtest vcs0: SUCCESS (0.195s) [397.395757] Starting dynamic subtest: vcs1 [399.127821] Dynamic subtest vcs1: SUCCESS (1.741s) [399.138551] Starting dynamic subtest: vecs0 [401.132845] Dynamic subtest vecs0: SUCCESS (2.004s) [401.143475] Starting dynamic subtest: ccs0 [403.129348] Dynamic subtest ccs0: SUCCESS (1.996s) [403.130356] Subtest dirty-switch: SUCCESS (6.326s) [403.365583] [095/133] (631s left) kms_frontbuffer_tracking (fbc-tiling-linear) [403.485023] Starting subtest: fbc-tiling-linear [407.299259] Subtest fbc-tiling-linear: SUCCESS (3.813s) [408.458044] [096/133] (626s left) kms_chamelium_frames (dp-crc-fast) [408.848210] Subtest dp-crc-fast: SKIP (0.000s) [409.652221] [097/133] (625s left) gem_ctx_persistence (legacy-engines-queued) [409.715563] Starting subtest: legacy-engines-queued [409.716473] Starting dynamic subtest: render [409.799625] Dynamic subtest render: SUCCESS (0.084s) [409.812548] Starting dynamic subtest: bsd1 [410.877930] Dynamic subtest bsd1: SUCCESS (1.065s) [410.887420] Starting dynamic subtest: bsd2 [412.861504] Dynamic subtest bsd2: SUCCESS (1.981s) [412.870606] Starting dynamic subtest: blt [412.880038] Dynamic subtest blt: SUCCESS (0.027s) [412.888502] Starting dynamic subtest: vebox [414.910053] Dynamic subtest vebox: SUCCESS (2.018s) [414.911351] Subtest legacy-engines-queued: SUCCESS (5.187s) [415.021537] [098/133] (620s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs) [415.106329] Starting subtest: random-ccs-data-4-tiled-bmg-ccs [415.108243] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s) [416.200760] [099/133] (618s left) perf (blocking) [416.338211] Starting subtest: blocking [416.338954] Starting dynamic subtest: 0-rcs0 [426.411980] Dynamic subtest 0-rcs0: SUCCESS (10.026s) [426.423755] Starting dynamic subtest: 1-vcs1 [436.433652] Dynamic subtest 1-vcs1: SUCCESS (10.020s) [436.434895] Subtest blocking: SUCCESS (20.050s) [436.469629] [100/133] (598s left) gen9_exec_parse (bb-start-far) [436.518896] Subtest bb-start-far: SKIP (0.000s) [436.582494] [101/133] (598s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [436.685602] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [436.687265] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [436.816594] [102/133] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [436.908366] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [436.909956] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [437.001481] [103/133] (598s left) kms_cursor_crc (cursor-onscreen-32x10) [437.164343] Starting subtest: cursor-onscreen-32x10 [437.209357] Subtest cursor-onscreen-32x10: SKIP (0.042s) [437.494654] [104/133] (597s left) kms_async_flips (test-time-stamp-atomic) [437.589362] Starting subtest: test-time-stamp-atomic [437.974743] Starting dynamic subtest: pipe-A-eDP-1 [438.817872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.842s) [439.201324] Starting dynamic subtest: pipe-B-eDP-1 [439.956524] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s) [440.321935] Starting dynamic subtest: pipe-C-eDP-1 [441.085856] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.771s) [441.450635] Starting dynamic subtest: pipe-D-eDP-1 [442.207062] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.763s) [442.208067] Subtest test-time-stamp-atomic: SUCCESS (4.618s) [443.361503] [105/133] (592s left) kms_chamelium_color (ctm-0-25) [443.443290] Subtest ctm-0-25: SKIP (0.000s) [443.503347] [106/133] (591s left) api_intel_allocator (default-alignment) [443.546216] Starting subtest: default-alignment [443.547668] Subtest default-alignment: SUCCESS (0.003s) [443.666098] [107/133] (591s left) gem_ctx_shared (q-independent) [443.721038] Starting subtest: Q-independent [443.722124] Starting dynamic subtest: rcs0 [443.790685] Dynamic subtest rcs0: SUCCESS (0.069s) [443.803303] Starting dynamic subtest: vcs0 [443.832377] Dynamic subtest vcs0: SUCCESS (0.041s) [443.842284] Starting dynamic subtest: vcs1 [443.880956] Dynamic subtest vcs1: SUCCESS (0.048s) [443.891514] Starting dynamic subtest: vecs0 [443.927686] Dynamic subtest vecs0: SUCCESS (0.046s) [443.938319] Starting dynamic subtest: ccs0 [443.984743] Dynamic subtest ccs0: SUCCESS (0.056s) [443.986419] Subtest Q-independent: SUCCESS (0.264s) [444.976496] [108/133] (590s left) gem_ccs (large-ctrl-surf-copy) [445.034585] Starting subtest: large-ctrl-surf-copy [445.036582] Subtest large-ctrl-surf-copy: SKIP (0.000s) [445.146471] [109/133] (590s left) kms_flip (plain-flip-fb-recreate-interruptible) [445.242916] Starting subtest: plain-flip-fb-recreate-interruptible [445.244427] Starting dynamic subtest: A-eDP1 [454.173393] Dynamic subtest A-eDP1: SUCCESS (8.929s) [454.185049] Starting dynamic subtest: B-eDP1 [462.994828] Dynamic subtest B-eDP1: SUCCESS (8.819s) [463.005089] Starting dynamic subtest: C-eDP1 [471.813782] Dynamic subtest C-eDP1: SUCCESS (8.817s) [471.831744] Starting dynamic subtest: D-eDP1 [480.641208] Dynamic subtest D-eDP1: SUCCESS (8.826s) [480.645884] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.404s) [481.818478] [110/133] (553s left) gem_lmem_swapping (massive) [481.856217] Subtest massive: SKIP (0.000s) [481.894413] [111/133] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [481.994234] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [481.995882] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [482.095553] [112/133] (553s left) i915_pm_rc6_residency (rc6-idle) [482.154565] Starting subtest: rc6-idle [482.177476] Starting dynamic subtest: gt0-rcs0 [506.464313] Dynamic subtest gt0-rcs0: SUCCESS (24.286s) [506.475544] Starting dynamic subtest: gt0-bcs0 [530.754384] Dynamic subtest gt0-bcs0: SUCCESS (24.288s) [530.767609] Starting dynamic subtest: gt0-ccs0 [555.046566] Dynamic subtest gt0-ccs0: SUCCESS (24.290s) [555.060498] Starting dynamic subtest: gt1-vcs0 [561.266352] Dynamic subtest gt1-vcs0: SUCCESS (6.170s) [561.278668] Starting dynamic subtest: gt1-vecs0 [567.437598] Dynamic subtest gt1-vecs0: SUCCESS (6.169s) [567.438718] Subtest rc6-idle: SUCCESS (85.242s) [567.471771] [113/133] (468s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [567.568894] Starting subtest: fbcpsr-stridechange [573.906163] Subtest fbcpsr-stridechange: SUCCESS (6.338s) [574.038846] [114/133] (461s left) kms_addfb_basic (clobberred-modifier) [574.092711] Starting subtest: clobberred-modifier [574.094375] Subtest clobberred-modifier: SKIP (0.000s) [574.235462] [115/133] (461s left) kms_frontbuffer_tracking (psr-suspend) [574.324681] Starting subtest: psr-suspend [613.232117] Subtest psr-suspend: SUCCESS (8.779s) [619.374117] [116/133] (422s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [619.492079] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [619.493744] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [619.581491] [117/133] (422s left) kms_vblank (ts-continuation-modeset-rpm) [619.666952] Starting subtest: ts-continuation-modeset-rpm [619.667783] Starting dynamic subtest: pipe-A-eDP-1 [622.142152] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.557s) [622.159497] Starting dynamic subtest: pipe-D-eDP-1 [624.335054] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.247s) [624.335868] Subtest ts-continuation-modeset-rpm: SUCCESS (4.808s) [625.200711] [118/133] (416s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [625.255768] Starting subtest: yf-tiled-to-vebox-yf-tiled [625.257637] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [625.445180] [119/133] (416s left) gem_vm_create (create-ext) [625.495454] Starting subtest: create-ext [625.500472] Subtest create-ext: SUCCESS (0.005s) [625.628886] [120/133] (416s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [625.683245] Starting subtest: etime-single-wait-all-for-submit-submitted [625.789349] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s) [625.860543] [121/133] (416s left) kms_psr (pr-sprite-plane-onoff) [625.953441] Starting subtest: pr-sprite-plane-onoff [625.955447] Subtest pr-sprite-plane-onoff: SKIP (0.000s) [626.030468] [122/133] (416s left) gem_workarounds (reset-context) [626.105919] Starting subtest: reset-context [626.285109] Subtest reset-context: SUCCESS (0.184s) [626.414108] [123/133] (415s left) kms_flip (2x-flip-vs-modeset-vs-hang) [626.497628] Starting subtest: 2x-flip-vs-modeset-vs-hang [626.509047] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s) [626.584413] [124/133] (415s left) gem_eio (in-flight-1us) [626.808888] Starting subtest: in-flight-1us [635.038103] Subtest in-flight-1us: SUCCESS (8.308s) [635.170750] [125/133] (407s left) kms_rotation_crc (exhaust-fences) [635.255294] Starting subtest: exhaust-fences [635.257070] Subtest exhaust-fences: SKIP (0.000s) [635.327387] [126/133] (406s left) gem_exec_flush (basic-uc-ro-default) [635.395048] Starting subtest: basic-uc-ro-default [640.827192] Subtest basic-uc-ro-default: SUCCESS (5.454s) [641.009464] [127/133] (401s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [641.110862] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [641.136518] Starting dynamic subtest: pipe-A-plane-0 [641.557051] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s) [641.567862] Starting dynamic subtest: pipe-A-plane-3 [641.823031] Dynamic subtest pipe-A-plane-3: SUCCESS (0.264s) [641.832400] Starting dynamic subtest: pipe-A-plane-5 [641.834116] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [642.944822] Starting dynamic subtest: pipe-B-plane-0 [643.379106] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s) [643.390054] Starting dynamic subtest: pipe-B-plane-3 [643.656463] Dynamic subtest pipe-B-plane-3: SUCCESS (0.277s) [643.667753] Starting dynamic subtest: pipe-B-plane-5 [643.669551] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [643.975668] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.873s) [644.810329] [128/133] (397s left) gem_ctx_create (basic) [644.866642] Starting subtest: basic [644.867547] Subtest basic: SUCCESS (0.000s) [645.076823] [129/133] (397s left) kms_scaling_modes (scaling-mode-center) [645.165298] Starting subtest: scaling-mode-center [645.166385] Starting dynamic subtest: pipe-A-eDP-1 [645.259543] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s) [645.270382] Starting dynamic subtest: pipe-B-eDP-1 [646.427704] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s) [646.440588] Starting dynamic subtest: pipe-C-eDP-1 [647.533832] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s) [647.544262] Starting dynamic subtest: pipe-D-eDP-1 [648.665353] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s) [648.666407] Subtest scaling-mode-center: SUCCESS (3.507s) [649.823123] [130/133] (392s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [649.904880] Starting subtest: psr-2p-primscrn-spr-indfb-move [649.906764] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [649.997093] [131/133] (392s left) kms_cursor_crc (cursor-sliding-64x21) [650.188846] Starting subtest: cursor-sliding-64x21 [650.234351] Subtest cursor-sliding-64x21: SKIP (0.043s) [650.468541] [132/133] (391s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [650.553649] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [650.555869] Starting dynamic subtest: A-eDP1 [654.159326] Dynamic subtest A-eDP1: SUCCESS (3.603s) [654.168518] Starting dynamic subtest: B-eDP1 [657.360186] Dynamic subtest B-eDP1: SUCCESS (3.198s) [657.371637] Starting dynamic subtest: C-eDP1 [660.461284] Dynamic subtest C-eDP1: SUCCESS (3.100s) [660.471380] Starting dynamic subtest: D-eDP1 [663.572701] Dynamic subtest D-eDP1: SUCCESS (3.110s) [663.574660] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.019s) [664.358255] [133/133] (378s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [664.454038] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [664.464398] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s) [664.540564] Closing watchdogs results: parsing output: 0/ for test: kms_pm_rpm results: parsing output: 1/ for test: kms_properties results: parsing output: 2/ for test: gem_exec_params results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: gem_softpin results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: gem_exec_whisper results: parsing output: 8/ for test: kms_plane_scaling results: parsing output: 9/ for test: gem_eio results: parsing output: 10/ for test: gem_pxp results: parsing output: 11/ for test: gem_mmap_offset results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: gem_exec_fence results: parsing output: 14/ for test: kms_psr results: parsing output: 15/ for test: syncobj_wait results: parsing output: 16/ for test: gem_close_race results: parsing output: 17/ for test: vgem_basic results: parsing output: 18/ for test: kms_psr2_sf results: parsing output: 19/ for test: gem_exec_schedule results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: api_intel_bb results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: kms_vrr results: parsing output: 24/ for test: syncobj_basic results: parsing output: 25/ for test: kms_async_flips results: parsing output: 26/ for test: kms_psr results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: perf_pmu results: parsing output: 30/ for test: gem_request_retire results: parsing output: 31/ for test: kms_flip results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: i915_pm_sseu results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: kms_plane_multiple results: parsing output: 36/ for test: gem_exec_params results: parsing output: 37/ for test: gem_exec_create results: parsing output: 38/ for test: kms_flip results: parsing output: 39/ for test: dumb_buffer results: parsing output: 40/ for test: kms_draw_crc results: parsing output: 41/ for test: kms_flip results: parsing output: 42/ for test: kms_lease results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: syncobj_timeline results: parsing output: 45/ for test: syncobj_timeline results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_vblank results: parsing output: 49/ for test: kms_cursor_legacy results: parsing output: 50/ for test: i915_query results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: kms_pipe_stress results: parsing output: 53/ for test: gem_eio results: parsing output: 54/ for test: kms_color results: parsing output: 55/ for test: i915_query results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_cursor_legacy results: parsing output: 59/ for test: kms_rotation_crc results: parsing output: 60/ for test: gem_mmap_gtt results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_ctx_param results: parsing output: 63/ for test: gem_mmap results: parsing output: 64/ for test: gem_exec_schedule results: parsing output: 65/ for test: kms_psr2_sf results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: gem_exec_reloc results: parsing output: 68/ for test: kms_busy results: parsing output: 69/ for test: kms_hdr results: parsing output: 70/ for test: kms_pm_lpsp results: parsing output: 71/ for test: i915_hangman results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: kms_content_protection results: parsing output: 74/ for test: gem_exec_balancer results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_cursor_crc results: parsing output: 77/ for test: kms_chamelium_hpd results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: kms_joiner results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: i915_drm_fdinfo results: parsing output: 83/ for test: perf_pmu results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: device_reset results: parsing output: 88/ for test: gem_pxp results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_exec_gttfill results: parsing output: 91/ for test: kms_ccs results: parsing output: 92/ for test: kms_plane_scaling results: parsing output: 93/ for test: gem_ctx_isolation results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_chamelium_frames results: parsing output: 96/ for test: gem_ctx_persistence results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: perf results: parsing output: 99/ for test: gen9_exec_parse results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_cursor_crc results: parsing output: 103/ for test: kms_async_flips results: parsing output: 104/ for test: kms_chamelium_color results: parsing output: 105/ for test: api_intel_allocator results: parsing output: 106/ for test: gem_ctx_shared results: parsing output: 107/ for test: gem_ccs results: parsing output: 108/ for test: kms_flip results: parsing output: 109/ for test: gem_lmem_swapping results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: i915_pm_rc6_residency results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_addfb_basic results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_vblank results: parsing output: 117/ for test: gem_render_copy results: parsing output: 118/ for test: gem_vm_create results: parsing output: 119/ for test: syncobj_timeline results: parsing output: 120/ for test: kms_psr results: parsing output: 121/ for test: gem_workarounds results: parsing output: 122/ for test: kms_flip results: parsing output: 123/ for test: gem_eio results: parsing output: 124/ for test: kms_rotation_crc results: parsing output: 125/ for test: gem_exec_flush results: parsing output: 126/ for test: kms_plane results: parsing output: 127/ for test: gem_ctx_create results: parsing output: 128/ for test: kms_scaling_modes results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_cursor_crc results: parsing output: 131/ for test: kms_flip results: parsing output: 132/ for test: kms_flip Done.