[59.591872] Initializing watchdogs
[59.591922]   /dev/watchdog0
[59.607433] [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.611935] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.614799] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.618204] [001/135] (960s left) gem_userptr_blits (coherency-sync)
[59.719275] Starting subtest: coherency-sync
[60.029178] Subtest coherency-sync: SKIP (0.271s)
[60.123738] [002/135] (960s left) kms_psr (psr-primary-render)
[60.266609] Starting subtest: psr-primary-render
[60.268831] Starting dynamic subtest: eDP-1
[61.998574] Dynamic subtest eDP-1: SUCCESS (1.722s)
[62.000563] Subtest psr-primary-render: SUCCESS (1.723s)
[62.867198] [003/135] (957s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[62.993841] Starting subtest: basic-flip-before-cursor-varying-size
[63.959364] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.961s)
[64.798279] [004/135] (955s left) kms_chamelium_hpd (vga-hpd-fast)
[65.184777] Subtest vga-hpd-fast: SKIP (0.000s)
[66.012039] [005/135] (954s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[66.112543] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[66.115196] Starting dynamic subtest: pipe-A-eDP-1
[66.139324] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.149852] Starting dynamic subtest: pipe-B-eDP-1
[66.172471] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.180370] Starting dynamic subtest: pipe-C-eDP-1
[66.202212] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.211193] Starting dynamic subtest: pipe-D-eDP-1
[66.233367] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.237498] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[68.412372] [006/135] (951s left) perf (stress-open-close)
[68.571132] Starting subtest: stress-open-close
[68.573066] Starting dynamic subtest: 0-rcs0
[70.738059] Dynamic subtest 0-rcs0: SUCCESS (2.167s)
[70.745833] Starting dynamic subtest: 1-vcs1
[72.904592] Dynamic subtest 1-vcs1: SUCCESS (2.164s)
[72.907717] Subtest stress-open-close: SUCCESS (4.331s)
[72.958074] [007/135] (947s left) prime_mmap (test_map_unmap)
[73.086023] Starting subtest: test_map_unmap
[73.088073] Starting dynamic subtest: test_map_unmap-smem
[73.131680] Dynamic subtest test_map_unmap-smem: SUCCESS (0.046s)
[73.133867] Subtest test_map_unmap: SUCCESS (0.046s)
[73.268742] [008/135] (947s left) kms_colorspace (colorspace-connector-type)
[73.382127] Starting subtest: colorspace-connector-type
[73.385865] Subtest colorspace-connector-type: SUCCESS (0.000s)
[73.449764] [009/135] (946s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[73.549808] Starting subtest: multiplane-rotation-cropping-bottom
[91.054507] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.505s)
[91.159245] [010/135] (929s left) gem_exec_schedule (implicit-read-write)
[91.234165] Starting subtest: implicit-read-write
[91.236030] Starting dynamic subtest: rcs0
[91.345634] Dynamic subtest rcs0: SUCCESS (0.118s)
[91.355813] Starting dynamic subtest: vcs0
[91.434871] Dynamic subtest vcs0: SUCCESS (0.089s)
[91.446630] Starting dynamic subtest: vcs1
[91.515088] Dynamic subtest vcs1: SUCCESS (0.080s)
[91.525933] Starting dynamic subtest: vecs0
[91.596188] Dynamic subtest vecs0: SUCCESS (0.081s)
[91.606701] Starting dynamic subtest: ccs0
[91.685868] Dynamic subtest ccs0: SUCCESS (0.088s)
[91.688359] Subtest implicit-read-write: SUCCESS (0.458s)
[93.408934] [011/135] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[93.506697] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[93.511197] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[93.596433] [012/135] (926s left) gem_softpin (allocator-basic)
[93.661094] Starting subtest: allocator-basic
[93.733495] Subtest allocator-basic: SUCCESS (0.075s)
[93.866988] [013/135] (926s left) kms_colorspace (colorspace-set-dci-p3_rgb_theater)
[93.965447] Starting subtest: colorspace-set-DCI-P3_RGB_Theater
[93.971813] Subtest colorspace-set-DCI-P3_RGB_Theater: SKIP (0.000s)
[94.036498] [014/135] (926s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[94.090076] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[94.160037] [015/135] (926s left) kms_lease (lease-again)
[94.247248] Starting subtest: lease-again
[94.249605] Starting dynamic subtest: pipe-A-eDP-1
[94.251963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[94.261998] Starting dynamic subtest: pipe-B-eDP-1
[94.263905] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[94.272049] Starting dynamic subtest: pipe-C-eDP-1
[94.273995] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[94.281883] Starting dynamic subtest: pipe-D-eDP-1
[94.283795] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[94.285744] Subtest lease-again: SUCCESS (0.012s)
[94.369331] [016/135] (926s left) gem_exec_balancer (nohangcheck)
[94.629094] Starting subtest: nohangcheck
[95.589473] Subtest nohangcheck: SUCCESS (0.960s)
[95.701427] [017/135] (925s left) kms_addfb_basic (invalid-get-prop-any)
[95.762489] Starting subtest: invalid-get-prop-any
[95.764761] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[95.896852] [018/135] (924s left) kms_psr (pr-cursor-plane-move)
[95.985964] Starting subtest: pr-cursor-plane-move
[95.990087] Subtest pr-cursor-plane-move: SKIP (0.000s)
[96.055847] [019/135] (924s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[96.164272] Starting subtest: 4-tiled-64bpp-rotate-0
[97.803587] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.640s)
[97.971645] [020/135] (922s left) kms_psr (fbc-psr-cursor-plane-onoff)
[98.064520] Starting subtest: fbc-psr-cursor-plane-onoff
[98.066387] Starting dynamic subtest: eDP-1
[98.069802] Dynamic subtest eDP-1: SKIP (0.000s)
[98.073192] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[98.138956] [021/135] (922s left) syncobj_wait (multi-wait-for-submit-signaled)
[98.204454] Starting subtest: multi-wait-for-submit-signaled
[98.206476] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[98.293393] [022/135] (922s left) syncobj_timeline (wait-all-interrupted)
[98.347511] Starting subtest: wait-all-interrupted
[98.458640] Subtest wait-all-interrupted: SUCCESS (0.110s)
[98.529968] [023/135] (922s left) kms_plane_multiple (tiling-x)
[98.625228] Starting subtest: tiling-x
[98.627121] Starting dynamic subtest: pipe-A-eDP-1
[102.355496] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.731s)
[102.365266] Starting dynamic subtest: pipe-B-eDP-1
[106.888503] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.530s)
[106.897770] Starting dynamic subtest: pipe-C-eDP-1
[111.236412] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.349s)
[111.245832] Starting dynamic subtest: pipe-D-eDP-1
[115.670501] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.433s)
[115.672694] Subtest tiling-x: SUCCESS (17.048s)
[116.469933] [024/135] (904s left) kms_cursor_crc (cursor-sliding-128x42)
[116.692851] Starting subtest: cursor-sliding-128x42
[116.742817] Subtest cursor-sliding-128x42: SKIP (0.047s)
[116.932432] [025/135] (904s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[117.019593] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[117.021743] Starting dynamic subtest: pipe-A-eDP-1
[150.415945] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.831s)
[150.425530] Starting dynamic subtest: pipe-B-eDP-1
[183.318531] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.622s)
[183.333717] Starting dynamic subtest: pipe-C-eDP-1
[216.314506] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.646s)
[216.327182] Starting dynamic subtest: pipe-D-eDP-1
[249.318889] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.658s)
[249.321259] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.765s)
[250.566205] [026/135] (770s left) core_getclient (basic)
[250.629408] Starting subtest: basic
[250.631656] Subtest basic: SUCCESS (0.000s)
[250.739328] [027/135] (770s left) kms_atomic_transition (modeset-transition-nonblocking)
[250.834169] Starting subtest: modeset-transition-nonblocking
[250.836245] Starting dynamic subtest: 1x-outputs
[261.907561] Dynamic subtest 1x-outputs: SUCCESS (11.004s)
[261.909927] Subtest modeset-transition-nonblocking: SUCCESS (11.006s)
[262.759200] [028/135] (758s left) sriov_basic (enable-vfs-bind-unbind-each)
[262.819178] Starting subtest: enable-vfs-bind-unbind-each
[262.821673] Starting dynamic subtest: numvfs-1
[262.903704] Dynamic subtest numvfs-1: FAIL (0.030s)
[262.913339] Starting dynamic subtest: numvfs-2
[262.987579] Dynamic subtest numvfs-2: FAIL (0.004s)
[262.999714] Starting dynamic subtest: numvfs-3
[263.074194] Dynamic subtest numvfs-3: FAIL (0.004s)
[263.084305] Starting dynamic subtest: numvfs-4
[263.157129] Dynamic subtest numvfs-4: FAIL (0.004s)
[263.167110] Starting dynamic subtest: numvfs-5
[263.240510] Dynamic subtest numvfs-5: FAIL (0.004s)
[263.251962] Starting dynamic subtest: numvfs-6
[263.325992] Dynamic subtest numvfs-6: FAIL (0.004s)
[263.336269] Starting dynamic subtest: numvfs-7
[263.410115] Dynamic subtest numvfs-7: FAIL (0.004s)
[263.421598] Starting dynamic subtest: numvfs-random
[263.495234] Dynamic subtest numvfs-random: FAIL (0.004s)
[263.497080] Subtest enable-vfs-bind-unbind-each: FAIL (0.062s)
[263.541902] [029/135] (757s left) gem_exec_reloc (basic-cpu-active)
[263.605784] Subtest basic-cpu-active: SKIP (0.000s)
[263.680761] [030/135] (757s left) gem_ctx_isolation (dirty-switch)
[263.747372] Starting subtest: dirty-switch
[263.749247] Starting dynamic subtest: rcs0
[263.957802] Dynamic subtest rcs0: SUCCESS (0.212s)
[263.968749] Starting dynamic subtest: bcs0
[264.174151] Dynamic subtest bcs0: SUCCESS (0.215s)
[264.184007] Starting dynamic subtest: vcs0
[264.384025] Dynamic subtest vcs0: SUCCESS (0.208s)
[264.395598] Starting dynamic subtest: vcs1
[265.875517] Dynamic subtest vcs1: SUCCESS (1.487s)
[265.887440] Starting dynamic subtest: vecs0
[267.864087] Dynamic subtest vecs0: SUCCESS (1.984s)
[267.873263] Starting dynamic subtest: ccs0
[269.916136] Dynamic subtest ccs0: SUCCESS (2.049s)
[269.918357] Subtest dirty-switch: SUCCESS (6.160s)
[270.191919] [031/135] (751s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[270.240789] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[270.243744] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[270.342767] [032/135] (751s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[270.438567] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[275.135314] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.694s)
[276.280410] [033/135] (745s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[276.384047] Starting subtest: y-tiled-32bpp-rotate-0
[276.388328] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[276.485398] [034/135] (744s left) gem_eio (wait-wedge-10ms)
[276.716309] Starting subtest: wait-wedge-10ms
[277.782797] Subtest wait-wedge-10ms: SUCCESS (1.065s)
[277.943411] [035/135] (743s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[278.032911] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[278.035105] Starting dynamic subtest: pipe-A
[278.058205] Dynamic subtest pipe-A: SKIP (0.020s)
[278.068278] Starting dynamic subtest: pipe-B
[278.093821] Dynamic subtest pipe-B: SKIP (0.035s)
[278.103632] Starting dynamic subtest: pipe-C
[278.126411] Dynamic subtest pipe-C: SKIP (0.035s)
[278.136089] Starting dynamic subtest: pipe-D
[278.162126] Dynamic subtest pipe-D: SKIP (0.034s)
[278.166158] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.126s)
[278.244546] [036/135] (743s left) kms_vblank (query-forked-busy)
[278.339029] Starting subtest: query-forked-busy
[278.341306] Starting dynamic subtest: pipe-A-eDP-1
[280.230286] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s)
[280.245004] Starting dynamic subtest: pipe-D-eDP-1
[282.852222] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.617s)
[282.854056] Subtest query-forked-busy: SUCCESS (4.510s)
[283.666967] [037/135] (737s left) gem_mmap_gtt (zero-extend)
[283.725810] Subtest zero-extend: SKIP (0.000s)
[283.788496] [038/135] (737s left) kms_flip (flip-vs-dpms-on-nop)
[283.881158] Starting subtest: flip-vs-dpms-on-nop
[283.883424] Starting dynamic subtest: A-eDP1
[285.753784] Dynamic subtest A-eDP1: SUCCESS (1.873s)
[285.766814] Starting dynamic subtest: B-eDP1
[287.586060] Dynamic subtest B-eDP1: SUCCESS (1.830s)
[287.596333] Starting dynamic subtest: C-eDP1
[289.417719] Dynamic subtest C-eDP1: SUCCESS (1.829s)
[289.427435] Starting dynamic subtest: D-eDP1
[291.247158] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[291.252240] Subtest flip-vs-dpms-on-nop: SUCCESS (7.371s)
[292.421578] [039/135] (729s left) gem_ctx_persistence (legacy-engines-cleanup)
[292.478493] Starting subtest: legacy-engines-cleanup
[292.480780] Starting dynamic subtest: render
[292.569713] Dynamic subtest render: SUCCESS (0.090s)
[292.585697] Starting dynamic subtest: bsd1
[292.596657] Dynamic subtest bsd1: SUCCESS (0.024s)
[292.606241] Starting dynamic subtest: bsd2
[292.662475] Dynamic subtest bsd2: SUCCESS (0.064s)
[292.673750] Starting dynamic subtest: blt
[292.698426] Dynamic subtest blt: SUCCESS (0.034s)
[292.711500] Starting dynamic subtest: vebox
[292.746475] Dynamic subtest vebox: SUCCESS (0.045s)
[292.748896] Subtest legacy-engines-cleanup: SUCCESS (0.269s)
[292.838188] [040/135] (728s left) gem_ppgtt (shrink-vs-evict-pinned)
[292.902033] Starting subtest: shrink-vs-evict-pinned
[298.659932] Subtest shrink-vs-evict-pinned: SUCCESS (5.756s)
[298.733416] [041/135] (723s left) kms_getfb (getfb-addfb-different-handles)
[298.831738] Starting subtest: getfb-addfb-different-handles
[298.833884] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[298.928698] [042/135] (722s left) kms_vrr (negative-basic)
[299.017745] Starting subtest: negative-basic
[299.024240] Starting dynamic subtest: pipe-A-eDP-1
[304.938999] Dynamic subtest pipe-A-eDP-1: FAIL (5.409s)
[304.940867] Subtest negative-basic: FAIL (5.698s)
[305.558572] [043/135] (716s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[305.656309] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[305.660610] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[305.768055] [044/135] (716s left) kms_plane_scaling (invalid-num-scalers)
[305.858188] Starting subtest: invalid-num-scalers
[305.860671] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[305.878732] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.022s)
[305.888653] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[305.916693] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.035s)
[305.926849] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[305.952714] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.036s)
[305.962442] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[305.990201] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.035s)
[305.992497] Subtest invalid-num-scalers: SUCCESS (0.133s)
[306.082348] [045/135] (715s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[306.203411] Starting subtest: 2x-long-cursor-vs-flip-atomic
[306.207795] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[306.359496] [046/135] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[306.467536] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[313.886190] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.418s)
[314.020457] [047/135] (707s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[314.111110] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[314.113375] Starting dynamic subtest: pipe-A-default-mode
[315.259360] Dynamic subtest pipe-A-default-mode: SKIP (1.144s)
[315.263791] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.146s)
[315.415458] [048/135] (706s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[315.504222] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[315.508088] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[315.604485] [049/135] (706s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[315.704760] Starting subtest: bad-rotation-90-y-tiled-ccs
[315.707042] Starting dynamic subtest: pipe-A-eDP-1
[315.731995] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[315.743283] Starting dynamic subtest: pipe-B-eDP-1
[315.765073] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[315.774346] Starting dynamic subtest: pipe-C-eDP-1
[315.796084] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[315.805133] Starting dynamic subtest: pipe-D-eDP-1
[315.827586] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[315.832047] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.006s)
[317.965691] [050/135] (704s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[318.073197] Starting subtest: psr2-overlay-plane-update-continuous-sf
[318.075484] Starting dynamic subtest: pipe-A-eDP-1
[319.202972] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.132s)
[319.215779] Starting dynamic subtest: pipe-B-eDP-1
[320.923233] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.719s)
[320.925496] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.855s)
[321.732051] [051/135] (700s left) kms_psr (pr-sprite-mmap-gtt)
[321.817805] Starting subtest: pr-sprite-mmap-gtt
[321.822090] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[321.891545] [052/135] (700s left) kms_lease (setcrtc-implicit-plane)
[321.977411] Starting subtest: setcrtc-implicit-plane
[321.979373] Starting dynamic subtest: pipe-A-eDP-1
[322.456947] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[322.467397] Starting dynamic subtest: pipe-B-eDP-1
[323.569710] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.112s)
[323.581042] Starting dynamic subtest: pipe-C-eDP-1
[324.698674] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[324.709600] Starting dynamic subtest: pipe-D-eDP-1
[325.826563] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[325.829182] Subtest setcrtc-implicit-plane: SUCCESS (3.849s)
[326.670478] [053/135] (695s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[326.773152] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[326.777189] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[326.869622] [054/135] (695s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[326.963530] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[326.967961] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[327.061458] [055/135] (695s left) gem_userptr_blits (sync-unmap-cycles)
[327.141341] Starting subtest: sync-unmap-cycles
[332.515094] Subtest sync-unmap-cycles: SUCCESS (5.371s)
[332.641123] [056/135] (689s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[332.751201] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[332.754734] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[332.848887] [057/135] (689s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[332.960479] Starting subtest: basic-flip-before-cursor-atomic
[333.883849] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.921s)
[334.696404] [058/135] (687s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[334.812526] Starting subtest: verify-pxp-key-change-after-suspend-resume
[342.012968] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.200s)
[342.149805] [059/135] (680s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[342.249223] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[342.251428] Starting dynamic subtest: pipe-A-eDP-1
[342.310342] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[342.320356] Starting dynamic subtest: pipe-B-eDP-1
[342.377334] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[342.388424] Starting dynamic subtest: pipe-C-eDP-1
[342.445434] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[342.456315] Starting dynamic subtest: pipe-D-eDP-1
[342.514172] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[342.518669] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[344.552236] [060/135] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[344.645145] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[344.649163] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[344.766241] [061/135] (677s left) kms_pm_rpm (modeset-lpsp-stress)
[346.893462] Starting subtest: modeset-lpsp-stress
[362.177998] Subtest modeset-lpsp-stress: SUCCESS (15.295s)
[362.279767] [062/135] (660s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[362.384451] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[362.388677] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[362.452325] [063/135] (660s left) gem_basic (multigpu-create-close)
[362.499632] Starting subtest: multigpu-create-close
[362.503508] Subtest multigpu-create-close: SKIP (0.000s)
[362.592353] [064/135] (660s left) gem_lmem_swapping (parallel-random-verify)
[362.633279] Subtest parallel-random-verify: SKIP (0.000s)
[362.678354] [065/135] (660s left) gem_unref_active_buffers
[362.875194] [066/135] (659s left) kms_colorspace (colorspace-crc-smpte_170m_ycc)
[362.963178] Starting subtest: colorspace-crc-SMPTE_170M_YCC
[362.969447] Subtest colorspace-crc-SMPTE_170M_YCC: SKIP (0.000s)
[363.046389] [067/135] (659s left) syncobj_timeline (reset-multiple-signaled)
[363.106744] Starting subtest: reset-multiple-signaled
[363.109044] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[363.224693] [068/135] (659s left) kms_busy (basic-hang)
[363.314919] Starting subtest: basic-hang
[363.316837] Starting dynamic subtest: flip-pipe-A
[363.940589] Dynamic subtest flip-pipe-A: SUCCESS (0.622s)
[363.951552] Starting dynamic subtest: modeset-pipe-A
[367.364419] Dynamic subtest modeset-pipe-A: SUCCESS (3.425s)
[367.377880] Starting dynamic subtest: flip-pipe-D
[368.566868] Dynamic subtest flip-pipe-D: SUCCESS (1.201s)
[368.579936] Starting dynamic subtest: modeset-pipe-D
[371.990265] Dynamic subtest modeset-pipe-D: SUCCESS (3.423s)
[371.992526] Subtest basic-hang: SUCCESS (8.678s)
[372.791815] [069/135] (650s left) gem_exec_suspend (basic-s0)
[372.858190] Starting subtest: basic-S0
[372.860405] Starting dynamic subtest: smem
[393.016561] Dynamic subtest smem: SUCCESS (6.777s)
[393.019848] Subtest basic-S0: SUCCESS (6.780s)
[393.212052] [070/135] (629s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[393.275944] Starting subtest: multi-wait-all-for-submit-unsubmitted
[393.378236] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[393.459123] [071/135] (629s left) kms_flip (flip-vs-panning)
[393.547509] Starting subtest: flip-vs-panning
[393.550128] Starting dynamic subtest: A-eDP1
[402.274185] Dynamic subtest A-eDP1: SUCCESS (8.657s)
[402.285208] Starting dynamic subtest: B-eDP1
[410.953587] Dynamic subtest B-eDP1: SUCCESS (8.652s)
[410.967052] Starting dynamic subtest: C-eDP1
[419.705192] Dynamic subtest C-eDP1: SUCCESS (8.738s)
[419.716206] Starting dynamic subtest: D-eDP1
[428.424693] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[428.429564] Subtest flip-vs-panning: SUCCESS (34.778s)
[429.583625] [072/135] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[429.682361] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[429.687085] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[429.763320] [073/135] (593s left) i915_pm_rps (waitboost)
[429.823732] Starting subtest: waitboost
[436.168979] Subtest waitboost: SUCCESS (6.349s)
[436.246550] [074/135] (586s left) gem_softpin (evict-prime-sanity-check)
[436.309595] Starting subtest: evict-prime-sanity-check
[436.311689] Starting dynamic subtest: rcs0
[437.450135] Dynamic subtest rcs0: SUCCESS (1.144s)
[437.461742] Starting dynamic subtest: bcs0
[438.576192] Dynamic subtest bcs0: SUCCESS (1.124s)
[438.589303] Starting dynamic subtest: vcs0
[440.051556] Dynamic subtest vcs0: SUCCESS (1.473s)
[440.066272] Starting dynamic subtest: vcs1
[442.014521] Dynamic subtest vcs1: SUCCESS (1.960s)
[442.028040] Starting dynamic subtest: vecs0
[444.014018] Dynamic subtest vecs0: SUCCESS (1.997s)
[444.028855] Starting dynamic subtest: ccs0
[445.136666] Dynamic subtest ccs0: SUCCESS (1.122s)
[445.147513] Starting dynamic subtest: all
[446.256061] Dynamic subtest all: SUCCESS (1.118s)
[446.258802] Subtest evict-prime-sanity-check: SUCCESS (9.954s)
[446.334556] [075/135] (576s left) kms_addfb_basic (legacy-format)
[446.386657] Starting subtest: legacy-format
[446.415722] Subtest legacy-format: SUCCESS (0.029s)
[446.573145] [076/135] (576s left) kms_chamelium_color (ctm-negative)
[446.665636] Subtest ctm-negative: SKIP (0.000s)
[446.717679] [077/135] (576s left) kms_cursor_legacy (single-move)
[446.835192] Starting subtest: single-move
[446.837709] Starting dynamic subtest: pipe-A
[452.218190] Dynamic subtest pipe-A: SUCCESS (5.380s)
[452.231512] Starting dynamic subtest: pipe-B
[457.600691] Dynamic subtest pipe-B: SUCCESS (5.380s)
[457.613710] Starting dynamic subtest: pipe-C
[462.983408] Dynamic subtest pipe-C: SUCCESS (5.380s)
[462.995208] Starting dynamic subtest: pipe-D
[468.365979] Dynamic subtest pipe-D: SUCCESS (5.379s)
[468.377668] Starting dynamic subtest: all-pipes
[473.759125] Dynamic subtest all-pipes: SUCCESS (5.389s)
[473.761462] Subtest single-move: SUCCESS (26.921s)
[473.901613] [078/135] (549s left) kms_psr2_su (page_flip-xrgb8888)
[473.969610] Subtest page_flip-XRGB8888: SKIP (0.000s)
[474.021645] [079/135] (549s left) kms_cursor_crc (cursor-random-512x512)
[474.299258] Starting subtest: cursor-random-512x512
[474.304540] Subtest cursor-random-512x512: SKIP (0.001s)
[474.457015] [080/135] (548s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[474.559253] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[475.383675] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[475.536324] [081/135] (547s left) gem_exec_parallel (fds)
[475.595927] Starting subtest: fds
[475.598680] Starting dynamic subtest: rcs0
[479.447844] Dynamic subtest rcs0: SUCCESS (3.849s)
[479.461507] Starting dynamic subtest: bcs0
[484.057471] Dynamic subtest bcs0: SUCCESS (4.606s)
[484.069742] Starting dynamic subtest: vcs0
[488.301712] Dynamic subtest vcs0: SUCCESS (4.240s)
[488.312643] Starting dynamic subtest: vcs1
[492.328643] Dynamic subtest vcs1: SUCCESS (4.026s)
[492.341507] Starting dynamic subtest: vecs0
[496.347680] Dynamic subtest vecs0: SUCCESS (4.018s)
[496.360548] Starting dynamic subtest: ccs0
[500.914494] Dynamic subtest ccs0: SUCCESS (4.566s)
[500.917799] Subtest fds: SUCCESS (25.315s)
[501.116296] [082/135] (522s left) kms_rmfb (rmfb-ioctl)
[501.217522] Starting subtest: rmfb-ioctl
[501.220146] Starting dynamic subtest: pipe-A-eDP-1
[501.326698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.111s)
[501.337013] Starting dynamic subtest: pipe-B-eDP-1
[502.533044] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.205s)
[502.546299] Starting dynamic subtest: pipe-C-eDP-1
[503.667489] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[503.678453] Starting dynamic subtest: pipe-D-eDP-1
[504.792660] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[504.795567] Subtest rmfb-ioctl: SUCCESS (3.577s)
[505.933956] [083/135] (517s left) sysfs_preempt_timeout (invalid)
[506.000716] Starting subtest: invalid
[506.003338] Starting dynamic subtest: vecs0
[506.005935] Dynamic subtest vecs0: SUCCESS (0.000s)
[506.016633] Starting dynamic subtest: ccs0
[506.019620] Dynamic subtest ccs0: SUCCESS (0.000s)
[506.030097] Starting dynamic subtest: vcs0
[506.032675] Dynamic subtest vcs0: SUCCESS (0.000s)
[506.042959] Starting dynamic subtest: bcs0
[506.045959] Dynamic subtest bcs0: SUCCESS (0.000s)
[506.059629] Starting dynamic subtest: rcs0
[506.062571] Dynamic subtest rcs0: SUCCESS (0.000s)
[506.072727] Starting dynamic subtest: vcs1
[506.075580] Dynamic subtest vcs1: SUCCESS (0.000s)
[506.078290] Subtest invalid: SUCCESS (0.005s)
[506.120015] [084/135] (517s left) kms_hdr (invalid-hdr)
[506.212224] Starting subtest: invalid-hdr
[508.346682] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[511.245654] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (2.898s)
[512.366809] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[515.367202] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (3.009s)
[515.370163] Subtest invalid-hdr: SUCCESS (9.156s)
[515.485435] [085/135] (508s left) gem_userptr_blits (access-control)
[515.562501] Starting subtest: access-control
[515.567203] Subtest access-control: SKIP (0.000s)
[515.676006] [086/135] (507s left) gem_userptr_blits (create-destroy-sync)
[515.740426] Starting subtest: create-destroy-sync
[520.747979] Subtest create-destroy-sync: SUCCESS (5.007s)
[520.859755] [087/135] (502s left) prime_self_import (basic-with_fd_dup)
[520.894628] Starting subtest: basic-with_fd_dup
[520.922153] Subtest basic-with_fd_dup: SUCCESS (0.024s)
[521.017469] [088/135] (502s left) gem_pipe_control_store_loop (fresh-buffer)
[521.076609] Starting subtest: fresh-buffer
[523.232960] Subtest fresh-buffer: SUCCESS (2.155s)
[523.334135] [089/135] (500s left) kms_addfb_basic (bad-pitch-1024)
[523.390533] Starting subtest: bad-pitch-1024
[523.393423] Subtest bad-pitch-1024: SUCCESS (0.000s)
[523.539236] [090/135] (500s left) kms_plane_cursor (overlay)
[523.627448] Starting subtest: overlay
[523.632543] Starting dynamic subtest: pipe-A-eDP-1-size-64
[527.370594] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (3.743s)
[527.430812] Starting dynamic subtest: pipe-A-eDP-1-size-128
[530.062388] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.640s)
[530.126887] Starting dynamic subtest: pipe-A-eDP-1-size-256
[532.762486] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.649s)
[533.129140] Starting dynamic subtest: pipe-B-eDP-1-size-64
[536.481186] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.364s)
[536.541551] Starting dynamic subtest: pipe-B-eDP-1-size-128
[539.161280] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.627s)
[539.222203] Starting dynamic subtest: pipe-B-eDP-1-size-256
[541.874542] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.659s)
[542.237516] Starting dynamic subtest: pipe-C-eDP-1-size-64
[545.288564] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.061s)
[545.325649] Starting dynamic subtest: pipe-C-eDP-1-size-128
[547.666521] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.347s)
[547.705207] Starting dynamic subtest: pipe-C-eDP-1-size-256
[549.988826] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.292s)
[550.327577] Starting dynamic subtest: pipe-D-eDP-1-size-64
[553.329119] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.015s)
[553.372379] Starting dynamic subtest: pipe-D-eDP-1-size-128
[555.696545] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.336s)
[555.735979] Starting dynamic subtest: pipe-D-eDP-1-size-256
[558.007197] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.280s)
[558.327316] Subtest overlay: SUCCESS (34.694s)
[559.177501] [091/135] (464s left) gem_exec_fence (syncobj-timeline-export)
[559.797239] Starting subtest: syncobj-timeline-export
[559.807343] Subtest syncobj-timeline-export: SUCCESS (0.011s)
[561.073653] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[561.077529] [092/135] (462s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[561.129727] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[561.235786] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[561.321599] [093/135] (462s left) i915_pm_freq_api (freq-reset)
[561.381927] Starting subtest: freq-reset
[561.384736] Starting dynamic subtest: gt0
[561.569081] Dynamic subtest gt0: SUCCESS (0.186s)
[561.580827] Starting dynamic subtest: gt1
[561.740148] Dynamic subtest gt1: SUCCESS (0.169s)
[561.742811] Subtest freq-reset: SUCCESS (0.358s)
[561.838359] [094/135] (462s left) gem_ctx_shared (disjoint-timelines)
[561.902372] Starting subtest: disjoint-timelines
[561.932216] Subtest disjoint-timelines: SUCCESS (0.029s)
[562.166764] [095/135] (461s left) perf_pmu (busy-accuracy-98)
[562.205637] Starting subtest: busy-accuracy-98
[562.208407] Starting dynamic subtest: rcs0
[565.259699] Dynamic subtest rcs0: SUCCESS (3.050s)
[565.279534] Starting dynamic subtest: bcs0
[568.314746] Dynamic subtest bcs0: SUCCESS (3.051s)
[568.326346] Starting dynamic subtest: vcs0
[571.357456] Dynamic subtest vcs0: SUCCESS (3.040s)
[571.368678] Starting dynamic subtest: vcs1
[574.398483] Dynamic subtest vcs1: SUCCESS (3.037s)
[574.410398] Starting dynamic subtest: vecs0
[577.439107] Dynamic subtest vecs0: SUCCESS (3.038s)
[577.450597] Starting dynamic subtest: ccs0
[580.494297] Dynamic subtest ccs0: SUCCESS (3.051s)
[580.497119] Subtest busy-accuracy-98: SUCCESS (18.282s)
[580.611137] [096/135] (443s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[580.718647] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[580.723644] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[580.827563] [097/135] (443s left) gem_watchdog (default-virtual)
[580.892576] Starting subtest: default-virtual
[587.172277] Subtest default-virtual: SUCCESS (6.287s)
[587.272147] [098/135] (436s left) kms_setmode (invalid-clone-single-crtc)
[587.327769] Starting subtest: invalid-clone-single-crtc
[587.335772] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[587.437033] [099/135] (436s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[587.530253] Starting subtest: fbc-rgb565-draw-render
[591.709360] Subtest fbc-rgb565-draw-render: SUCCESS (4.182s)
[592.909299] [100/135] (431s left) i915_drm_fdinfo (memory-info-purgeable)
[592.950784] Starting subtest: memory-info-purgeable
[592.953556] Starting dynamic subtest: smem0
[595.661319] Dynamic subtest smem0: SUCCESS (2.710s)
[595.663798] Subtest memory-info-purgeable: SUCCESS (2.712s)
[595.740441] [101/135] (428s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[595.837190] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[595.841658] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[595.943419] [102/135] (428s left) kms_big_fb (linear-16bpp-rotate-0)
[596.031660] Starting subtest: linear-16bpp-rotate-0
[597.535091] Subtest linear-16bpp-rotate-0: SUCCESS (1.503s)
[597.659324] [103/135] (426s left) gen9_exec_parse (cmd-crossing-page)
[597.728819] Subtest cmd-crossing-page: SKIP (0.000s)
[597.802170] [104/135] (426s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[597.901229] Starting subtest: fbc-farfromfence-mmap-gtt
[597.905414] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[598.034064] [105/135] (426s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[598.143404] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[598.147584] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[598.241078] [106/135] (426s left) gem_exec_schedule (preemptive-hang)
[598.416610] Starting subtest: preemptive-hang
[598.419696] Starting dynamic subtest: rcs0
[607.145643] Dynamic subtest rcs0: SUCCESS (8.725s)
[607.156948] Starting dynamic subtest: bcs0
[616.163511] Dynamic subtest bcs0: SUCCESS (9.016s)
[616.176772] Starting dynamic subtest: vcs0
[625.185247] Dynamic subtest vcs0: SUCCESS (9.020s)
[625.198561] Starting dynamic subtest: vcs1
[634.146816] Dynamic subtest vcs1: SUCCESS (8.963s)
[634.160500] Starting dynamic subtest: vecs0
[643.167897] Dynamic subtest vecs0: SUCCESS (9.021s)
[643.180614] Starting dynamic subtest: ccs0
[652.127647] Dynamic subtest ccs0: SUCCESS (8.962s)
[652.130377] Subtest preemptive-hang: SUCCESS (53.713s)
[652.388570] [107/135] (372s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[652.448681] Starting subtest: invalid-single-wait-all-unsubmitted
[652.451603] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[652.550821] [108/135] (372s left) i915_pm_rps (fence-order)
[652.605028] Starting subtest: fence-order
[655.588065] Subtest fence-order: SUCCESS (2.982s)
[655.700555] [109/135] (368s left) kms_chamelium_edid (dp-edid-read)
[656.089231] Subtest dp-edid-read: SKIP (0.000s)
[656.897119] [110/135] (367s left) gem_ccs (suspend-resume)
[656.962372] Starting subtest: suspend-resume
[656.967545] Subtest suspend-resume: SKIP (0.000s)
[657.062316] [111/135] (367s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[657.111192] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[657.113801] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[657.208023] [112/135] (367s left) gem_eio (in-flight-contexts-10ms)
[657.389636] Starting subtest: in-flight-contexts-10ms
[669.060174] Subtest in-flight-contexts-10ms: SUCCESS (11.667s)
[669.185187] [113/135] (355s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[669.273562] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[669.276037] Starting dynamic subtest: pipe-A-default-mode
[672.042399] Dynamic subtest pipe-A-default-mode: SUCCESS (2.768s)
[672.044913] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.769s)
[672.907556] [114/135] (351s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[673.003415] Starting subtest: x-tiled-16bpp-rotate-270
[673.023169] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[673.142693] [115/135] (351s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[673.239644] Starting subtest: psr-rgb101010-draw-render
[680.550798] Subtest psr-rgb101010-draw-render: SUCCESS (7.313s)
[680.691172] [116/135] (344s left) gem_mmap_gtt (cpuset-big-copy-xy)
[680.747728] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[680.815169] [117/135] (344s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[680.908598] Starting subtest: plane-all-modeset-transition-fencing
[680.913618] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[680.999078] [118/135] (344s left) gem_exec_schedule (smoketest)
[681.176945] Starting subtest: smoketest
[681.179835] Starting dynamic subtest: rcs0
[686.753709] Dynamic subtest rcs0: SUCCESS (5.516s)
[686.770661] Starting dynamic subtest: bcs0
[692.304394] Dynamic subtest bcs0: SUCCESS (5.542s)
[692.317778] Starting dynamic subtest: vcs0
[697.826397] Dynamic subtest vcs0: SUCCESS (5.512s)
[697.839992] Starting dynamic subtest: vcs1
[703.342157] Dynamic subtest vcs1: SUCCESS (5.519s)
[703.357623] Starting dynamic subtest: vecs0
[708.856662] Dynamic subtest vecs0: SUCCESS (5.512s)
[708.874031] Starting dynamic subtest: ccs0
[714.381559] Dynamic subtest ccs0: SUCCESS (5.527s)
[714.388746] Subtest smoketest: SUCCESS (33.140s)
[714.565205] [119/135] (310s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[714.670663] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[714.675517] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[714.775531] [120/135] (310s left) kms_content_protection (mei-interface)
[714.906222] Starting subtest: mei-interface
[714.910532] Subtest mei-interface: SKIP (0.001s)
[715.016193] [121/135] (310s left) prime_mmap (test_forked_cpu_write)
[715.063975] Starting subtest: test_forked_cpu_write
[715.066408] Starting dynamic subtest: test_forked_cpu_write-smem
[715.070998] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[715.073408] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[715.168340] [122/135] (310s left) perf (polling)
[715.268419] Starting subtest: polling
[715.270778] Starting dynamic subtest: 0-rcs0
[725.274193] Dynamic subtest 0-rcs0: SUCCESS (10.007s)
[725.290311] Starting dynamic subtest: 1-vcs1
[735.297694] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[735.300435] Subtest polling: SUCCESS (20.031s)
[735.351722] [123/135] (289s left) sw_sync (sync_multi_consumer)
[735.393370] Starting subtest: sync_multi_consumer
[735.924730] Subtest sync_multi_consumer: SUCCESS (0.532s)
[735.991591] [124/135] (289s left) gem_partial_pwrite_pread (reads-display)
[736.046335] Subtest reads-display: SKIP (0.000s)
[736.122131] [125/135] (289s left) api_intel_allocator (open-vm)
[736.183093] Starting subtest: open-vm
[736.185526] Subtest open-vm: SUCCESS (0.005s)
[736.288294] [126/135] (289s left) kms_prop_blob (basic)
[736.335350] Starting subtest: basic
[736.337645] Subtest basic: SUCCESS (0.000s)
[736.438024] [127/135] (289s left) syncobj_basic (bad-create-flags)
[736.496736] Starting subtest: bad-create-flags
[736.499633] Subtest bad-create-flags: SUCCESS (0.000s)
[736.608397] [128/135] (288s left) vgem_basic (dmabuf-fence-before)
[736.658351] Starting subtest: dmabuf-fence-before
[736.660608] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[736.716784] [129/135] (288s left) gem_mmap (short-mmap)
[736.767445] Subtest short-mmap: SKIP (0.000s)
[736.831732] [130/135] (288s left) kms_frontbuffer_tracking (fbc-tiling-y)
[736.940513] Starting subtest: fbc-tiling-y
[736.944613] Subtest fbc-tiling-y: SKIP (0.000s)
[737.021206] [131/135] (288s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[737.118569] Starting subtest: primary-y-tiled-reflect-x-180
[737.178160] Subtest primary-y-tiled-reflect-x-180: SKIP (0.060s)
[737.290223] [132/135] (288s left) kms_draw_crc (draw-method-render)
[737.379346] Starting subtest: draw-method-render
[737.381408] Starting dynamic subtest: xrgb8888-untiled
[737.634351] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[737.646092] Starting dynamic subtest: rgb565-untiled
[737.867413] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[737.878669] Starting dynamic subtest: xrgb2101010-untiled
[738.112395] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.243s)
[738.123502] Starting dynamic subtest: xbgr16161616f-untiled
[738.356340] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[738.368502] Starting dynamic subtest: xrgb8888-xtiled
[738.489349] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[738.500537] Starting dynamic subtest: rgb565-xtiled
[738.611712] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[738.623311] Starting dynamic subtest: xrgb2101010-xtiled
[738.733606] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[738.745303] Starting dynamic subtest: xbgr16161616f-xtiled
[738.868371] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[738.880226] Starting dynamic subtest: xrgb8888-4tiled
[739.002313] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[739.014314] Starting dynamic subtest: rgb565-4tiled
[739.122842] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[739.134567] Starting dynamic subtest: xrgb2101010-4tiled
[739.244635] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[739.256141] Starting dynamic subtest: xbgr16161616f-4tiled
[739.379546] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[739.382380] Subtest draw-method-render: SUCCESS (2.001s)
[739.485712] [133/135] (286s left) drm_mm (drm_mm)
[739.523264] Starting subtest: drm_mm
[739.576405] Starting dynamic subtest: drm_test_mm_init
[739.665961] Dynamic subtest drm_test_mm_init: SUCCESS (0.089s)
[739.677118] Starting dynamic subtest: drm_test_mm_debug
[739.762628] Dynamic subtest drm_test_mm_debug: SUCCESS (0.094s)
[739.773534] Starting dynamic subtest: drm_test_mm_align32
[739.847304] Dynamic subtest drm_test_mm_align32: SUCCESS (0.085s)
[739.860946] Starting dynamic subtest: drm_test_mm_align64
[739.935391] Dynamic subtest drm_test_mm_align64: SUCCESS (0.085s)
[739.946676] Starting dynamic subtest: drm_test_mm_lowest
[740.015487] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.082s)
[740.026484] Starting dynamic subtest: drm_test_mm_highest
[740.105541] Dynamic subtest drm_test_mm_highest: SUCCESS (0.090s)
[740.108047] Subtest drm_mm: SUCCESS (0.584s)
[740.253404] [134/135] (285s left) gem_exec_balancer (parallel-ordering)
[740.506823] Starting subtest: parallel-ordering
[741.506469] Subtest parallel-ordering: SUCCESS (1.000s)
[741.625297] [135/135] (284s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[741.721399] Starting subtest: plane-upscale-20x20-with-rotation
[741.723822] Starting dynamic subtest: pipe-A
[741.946300] Dynamic subtest pipe-A: SUCCESS (0.227s)
[741.957731] Starting dynamic subtest: pipe-B
[743.229535] Dynamic subtest pipe-B: SUCCESS (1.282s)
[743.241644] Starting dynamic subtest: pipe-C
[744.561217] Dynamic subtest pipe-C: SUCCESS (1.331s)
[744.572582] Starting dynamic subtest: pipe-D
[745.884641] Dynamic subtest pipe-D: SUCCESS (1.322s)
[745.887633] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.165s)
[747.070081] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: prime_mmap
results: parsing output: 7/ for test: kms_colorspace
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_softpin
results: parsing output: 12/ for test: kms_colorspace
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_lease
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_plane_multiple
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: core_getclient
results: parsing output: 26/ for test: kms_atomic_transition
results: parsing output: 27/ for test: sriov_basic
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_ctx_isolation
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_vblank
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: gem_ppgtt
results: parsing output: 40/ for test: kms_getfb
results: parsing output: 41/ for test: kms_vrr
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: gem_pxp
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_pm_rpm
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: gem_basic
results: parsing output: 63/ for test: gem_lmem_swapping
results: parsing output: 64/ for test: gem_unref_active_buffers
results: parsing output: 65/ for test: kms_colorspace
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_busy
results: parsing output: 68/ for test: gem_exec_suspend
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_pm_rps
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: kms_chamelium_color
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_psr2_su
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_exec_parallel
results: parsing output: 81/ for test: kms_rmfb
results: parsing output: 82/ for test: sysfs_preempt_timeout
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: prime_self_import
results: parsing output: 87/ for test: gem_pipe_control_store_loop
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: kms_plane_cursor
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: i915_pm_freq_api
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_watchdog
results: parsing output: 97/ for test: kms_setmode
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gen9_exec_parse
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: i915_pm_rps
results: parsing output: 108/ for test: kms_chamelium_edid
results: parsing output: 109/ for test: gem_ccs
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: kms_atomic_transition
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: prime_mmap
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: gem_partial_pwrite_pread
results: parsing output: 124/ for test: api_intel_allocator
results: parsing output: 125/ for test: kms_prop_blob
results: parsing output: 126/ for test: syncobj_basic
results: parsing output: 127/ for test: vgem_basic
results: parsing output: 128/ for test: gem_mmap
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_rotation_crc
results: parsing output: 131/ for test: kms_draw_crc
results: parsing output: 132/ for test: drm_mm
results: parsing output: 133/ for test: gem_exec_balancer
results: parsing output: 134/ for test: kms_plane_scaling
Done.