[55.650926] Initializing watchdogs
[55.650974]   /dev/watchdog0
[55.659438] [001/130] (960s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[55.784694] Starting subtest: cursor-vs-flip-legacy
[85.227389] Subtest cursor-vs-flip-legacy: SUCCESS (29.424s)
[85.991514] [002/130] (930s left) kms_atomic_interruptible (legacy-setmode)
[86.095651] Starting subtest: legacy-setmode
[86.097916] Starting dynamic subtest: pipe-A-eDP-1
[92.948063] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.851s)
[92.950500] Subtest legacy-setmode: SUCCESS (6.852s)
[93.715329] [003/130] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[93.814321] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[93.818527] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[93.904536] [004/130] (922s left) vgem_slow (nohang)
[93.989334] Starting subtest: nohang
[104.069841] Subtest nohang: SUCCESS (10.081s)
[104.114773] [005/130] (912s left) kms_joiner (invalid-modeset-force-big-joiner)
[104.224712] Starting subtest: invalid-modeset-force-big-joiner
[104.227039] Starting dynamic subtest: big_joiner_on_last_pipe
[104.543680] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.327s)
[104.546083] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.327s)
[105.340031] [006/130] (910s left) gem_ctx_param (invalid-ctx-get)
[105.394329] Starting subtest: invalid-ctx-get
[105.396740] Subtest invalid-ctx-get: SUCCESS (0.000s)
[105.441160] [007/130] (910s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[110.409679] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[110.414589] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[111.247375] [008/130] (905s left) i915_query (query-topology-kernel-writes)
[111.315245] Starting subtest: query-topology-kernel-writes
[111.317776] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[111.406337] [009/130] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[111.504067] Starting subtest: fbcpsr-1p-rte
[116.310745] Subtest fbcpsr-1p-rte: SUCCESS (4.810s)
[116.423814] [010/130] (899s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[116.530810] Starting subtest: plane-upscale-20x20-with-pixel-format
[116.533131] Starting dynamic subtest: pipe-A
[117.624641] Dynamic subtest pipe-A: SUCCESS (1.094s)
[117.630305] Starting dynamic subtest: pipe-B
[119.731836] Dynamic subtest pipe-B: SUCCESS (2.107s)
[119.738879] Starting dynamic subtest: pipe-C
[120.875401] Dynamic subtest pipe-C: SUCCESS (1.143s)
[120.882555] Starting dynamic subtest: pipe-D
[122.011086] Dynamic subtest pipe-D: SUCCESS (1.135s)
[122.013378] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.480s)
[123.170671] [011/130] (893s left) kms_color (ctm-blue-to-red)
[123.265063] Starting subtest: ctm-blue-to-red
[123.267270] Starting dynamic subtest: pipe-A-eDP-1
[123.920013] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.654s)
[123.926194] Starting dynamic subtest: pipe-B-eDP-1
[125.231656] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.311s)
[125.239219] Starting dynamic subtest: pipe-C-eDP-1
[126.506312] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.275s)
[126.513105] Starting dynamic subtest: pipe-D-eDP-1
[127.834725] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[127.836607] Subtest ctm-blue-to-red: SUCCESS (4.567s)
[128.675708] [012/130] (887s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[129.056555] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[129.874965] [013/130] (886s left) gem_wait (write-busy)
[129.949853] Starting subtest: write-busy
[129.952247] Starting dynamic subtest: all-engines
[130.523566] Dynamic subtest all-engines: SUCCESS (0.565s)
[130.530785] Starting dynamic subtest: rcs0
[131.064139] Dynamic subtest rcs0: SUCCESS (0.549s)
[131.078058] Starting dynamic subtest: bcs0
[131.617611] Dynamic subtest bcs0: SUCCESS (0.547s)
[131.625276] Starting dynamic subtest: vcs0
[132.904309] Dynamic subtest vcs0: SUCCESS (1.291s)
[132.916860] Starting dynamic subtest: vcs1
[134.952045] Dynamic subtest vcs1: SUCCESS (2.047s)
[134.964750] Starting dynamic subtest: vecs0
[136.936262] Dynamic subtest vecs0: SUCCESS (1.983s)
[136.949024] Starting dynamic subtest: ccs0
[137.484780] Dynamic subtest ccs0: SUCCESS (0.549s)
[137.487620] Subtest write-busy: SUCCESS (7.534s)
[137.664148] [014/130] (878s left) gem_ctx_create (basic)
[137.724672] Starting subtest: basic
[137.727101] Subtest basic: SUCCESS (0.000s)
[137.885313] [015/130] (878s left) kms_psr (psr2-sprite-render)
[137.976060] Starting subtest: psr2-sprite-render
[137.978385] Starting dynamic subtest: eDP-1
[139.705649] Dynamic subtest eDP-1: SUCCESS (1.725s)
[139.708079] Subtest psr2-sprite-render: SUCCESS (1.725s)
[140.545256] [016/130] (875s left) gem_mmap_gtt (basic-small-bo-tiledy)
[140.614427] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[140.649992] [017/130] (875s left) api_intel_bb (object-noreloc-keep-cache-simple)
[140.714527] Starting subtest: object-noreloc-keep-cache-simple
[140.719542] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[140.839048] [018/130] (875s left) perf_pmu (busy-double-start)
[140.881236] Starting subtest: busy-double-start
[140.883579] Starting dynamic subtest: rcs0
[144.521912] Dynamic subtest rcs0: FAIL (3.584s)
[144.530151] Starting dynamic subtest: bcs0
[148.075088] Dynamic subtest bcs0: SUCCESS (3.607s)
[148.084775] Starting dynamic subtest: vcs0
[152.432650] Dynamic subtest vcs0: SUCCESS (4.357s)
[152.442017] Starting dynamic subtest: vcs1
[156.463347] Dynamic subtest vcs1: SUCCESS (4.031s)
[156.472501] Starting dynamic subtest: vecs0
[160.452288] Dynamic subtest vecs0: SUCCESS (3.989s)
[160.462094] Starting dynamic subtest: ccs0
[164.088607] Dynamic subtest ccs0: FAIL (3.566s)
[164.090817] Subtest busy-double-start: FAIL (23.137s)
[164.121093] [019/130] (852s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[164.232305] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[164.236629] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[164.296213] [020/130] (852s left) syncobj_timeline (wait-for-submit-snapshot)
[164.348830] Starting subtest: wait-for-submit-snapshot
[164.429393] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[164.498959] [021/130] (852s left) gem_exec_balancer (nop)
[164.570360] Starting subtest: nop
[211.167927] Subtest nop: SUCCESS (46.596s)
[211.451666] [022/130] (805s left) syncobj_wait (multi-wait-submitted-signaled)
[211.509569] Starting subtest: multi-wait-submitted-signaled
[211.511905] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[211.596514] [023/130] (804s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[211.712470] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[212.302519] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.592s)
[212.464157] [024/130] (804s left) gem_exec_schedule (u-fairslice-all)
[212.531127] Starting subtest: u-fairslice-all
[214.591721] Subtest u-fairslice-all: SUCCESS (2.062s)
[215.929010] [025/130] (800s left) gem_eio (context-create)
[216.180429] Starting subtest: context-create
[216.519527] Subtest context-create: SUCCESS (0.340s)
[216.617680] [026/130] (800s left) gem_exec_schedule (pi-userfault)
[216.804698] Starting subtest: pi-userfault
[216.806541] Starting dynamic subtest: rcs0
[216.813396] Dynamic subtest rcs0: SUCCESS (0.011s)
[216.820411] Starting dynamic subtest: bcs0
[216.822609] Dynamic subtest bcs0: SUCCESS (0.008s)
[216.829848] Starting dynamic subtest: vcs0
[216.832187] Dynamic subtest vcs0: SUCCESS (0.007s)
[216.839083] Starting dynamic subtest: vcs1
[216.840884] Dynamic subtest vcs1: SUCCESS (0.008s)
[216.848605] Starting dynamic subtest: vecs0
[216.850785] Dynamic subtest vecs0: SUCCESS (0.006s)
[216.857688] Starting dynamic subtest: ccs0
[216.859595] Dynamic subtest ccs0: SUCCESS (0.007s)
[216.861461] Subtest pi-userfault: SUCCESS (0.049s)
[217.013837] [027/130] (799s left) gem_pread (self)
[217.065262] Subtest self: SKIP (0.000s)
[217.109524] [028/130] (799s left) gem_ctx_persistence (heartbeat-stop)
[217.159378] Starting subtest: heartbeat-stop
[217.164149] Subtest heartbeat-stop: SKIP (0.000s)
[217.251505] [029/130] (799s left) gem_fence_thrash (bo-write-verify-none)
[217.286112] Starting subtest: bo-write-verify-none
[217.310046] Subtest bo-write-verify-none: SKIP (0.020s)
[217.346479] [030/130] (799s left) gem_eio (in-flight-internal-1us)
[217.567371] Starting subtest: in-flight-internal-1us
[218.995878] Subtest in-flight-internal-1us: SUCCESS (1.427s)
[219.139506] [031/130] (797s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[219.317731] Starting subtest: cursor-rapid-movement-64x21
[219.356563] Subtest cursor-rapid-movement-64x21: SKIP (0.031s)
[219.568025] [032/130] (797s left) kms_chamelium_hpd (hdmi-hpd)
[219.950343] Subtest hdmi-hpd: SKIP (0.000s)
[220.732604] [033/130] (796s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[220.830309] Starting subtest: psr-rgb101010-draw-pwrite
[226.215591] Subtest psr-rgb101010-draw-pwrite: SUCCESS (5.389s)
[226.318998] [034/130] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[226.420192] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[226.424196] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[226.512980] [035/130] (790s left) gem_userptr_blits (huge-split)
[226.582324] Starting subtest: huge-split
[226.590878] Subtest huge-split: SUCCESS (0.008s)
[226.704213] [036/130] (790s left) perf (gen12-unprivileged-single-ctx-counters)
[226.824804] Starting subtest: gen12-unprivileged-single-ctx-counters
[226.827141] Starting dynamic subtest: rcs0
[226.868078] Dynamic subtest rcs0: SUCCESS (0.043s)
[226.870509] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.044s)
[226.894264] [037/130] (789s left) gem_fenced_exec_thrash (no-spare-fences)
[227.001578] Subtest no-spare-fences: SKIP (0.000s)
[227.069641] [038/130] (789s left) gem_render_copy (y-tiled-ccs-to-linear)
[227.136305] Starting subtest: y-tiled-ccs-to-linear
[227.140619] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[227.297848] [039/130] (789s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[227.403376] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[227.407797] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[227.495421] [040/130] (789s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[227.580063] Starting subtest: fbc-psr2-sprite-plane-onoff
[227.582350] Starting dynamic subtest: eDP-1
[227.586445] Dynamic subtest eDP-1: SKIP (0.000s)
[227.590581] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[227.631431] [041/130] (789s left) kms_sequence (get-busy)
[227.732627] Starting subtest: get-busy
[227.735101] Starting dynamic subtest: pipe-A-eDP-1
[229.656378] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.920s)
[229.664146] Starting dynamic subtest: pipe-B-eDP-1
[232.244435] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.588s)
[232.254411] Starting dynamic subtest: pipe-C-eDP-1
[234.848755] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.604s)
[234.857774] Starting dynamic subtest: pipe-D-eDP-1
[237.372942] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[237.375242] Subtest get-busy: SUCCESS (9.639s)
[238.136235] [042/130] (778s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[238.197545] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[238.199600] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[238.290387] [043/130] (778s left) i915_query (query-garbage)
[238.349243] Starting subtest: query-garbage
[238.351189] Subtest query-garbage: SUCCESS (0.000s)
[238.435586] [044/130] (778s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[238.537828] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[238.540078] Starting dynamic subtest: pipe-A-eDP-1
[238.561768] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[238.569548] Starting dynamic subtest: pipe-B-eDP-1
[238.591203] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[238.598703] Starting dynamic subtest: pipe-C-eDP-1
[238.620760] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[238.627813] Starting dynamic subtest: pipe-D-eDP-1
[238.649558] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[238.653950] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[240.694334] [045/130] (776s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[240.785116] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[240.787385] Starting dynamic subtest: pipe-A
[240.796555] Dynamic subtest pipe-A: SKIP (0.004s)
[240.804287] Starting dynamic subtest: pipe-B
[240.813716] Dynamic subtest pipe-B: SKIP (0.014s)
[240.821130] Starting dynamic subtest: pipe-C
[240.830268] Dynamic subtest pipe-C: SKIP (0.019s)
[240.837308] Starting dynamic subtest: pipe-D
[240.846351] Dynamic subtest pipe-D: SKIP (0.014s)
[240.850827] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.053s)
[240.930327] [046/130] (776s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[241.034217] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[241.932084] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.900s)
[242.058980] [047/130] (774s left) gem_userptr_blits (readonly-unsync)
[242.122447] Subtest readonly-unsync: SKIP (0.000s)
[242.233857] [048/130] (774s left) kms_cursor_legacy (torture-move)
[242.349589] Starting subtest: torture-move
[242.351432] Starting dynamic subtest: pipe-A
[248.541644] Dynamic subtest pipe-A: SUCCESS (6.189s)
[248.553604] Starting dynamic subtest: pipe-B
[254.794466] Dynamic subtest pipe-B: SUCCESS (6.251s)
[254.804842] Starting dynamic subtest: pipe-C
[261.010282] Dynamic subtest pipe-C: SUCCESS (6.216s)
[261.018670] Starting dynamic subtest: pipe-D
[267.513370] Dynamic subtest pipe-D: SUCCESS (6.500s)
[267.524125] Starting dynamic subtest: all-pipes
[273.784903] Dynamic subtest all-pipes: SUCCESS (6.269s)
[273.787224] Subtest torture-move: SUCCESS (31.431s)
[273.916683] [049/130] (743s left) gem_exec_balancer (sliced)
[273.984219] Starting subtest: sliced
[273.988615] Subtest sliced: SKIP (0.000s)
[274.268201] [050/130] (742s left) gem_ctx_isolation (preservation)
[274.333119] Starting subtest: preservation
[274.335492] Starting dynamic subtest: rcs0
[274.454725] Dynamic subtest rcs0: SUCCESS (0.120s)
[274.464840] Starting dynamic subtest: bcs0
[274.614710] Dynamic subtest bcs0: SUCCESS (0.159s)
[274.625075] Starting dynamic subtest: vcs0
[274.752099] Dynamic subtest vcs0: SUCCESS (0.138s)
[274.762525] Starting dynamic subtest: vcs1
[276.059375] Dynamic subtest vcs1: SUCCESS (1.307s)
[276.068495] Starting dynamic subtest: vecs0
[278.082498] Dynamic subtest vecs0: SUCCESS (2.021s)
[278.093779] Starting dynamic subtest: ccs0
[280.039354] Dynamic subtest ccs0: SUCCESS (1.956s)
[280.042399] Subtest preservation: SUCCESS (5.705s)
[280.259504] [051/130] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[280.364611] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[280.368621] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[280.447917] [052/130] (736s left) kms_flip (blocking-wf_vblank)
[280.549132] Starting subtest: blocking-wf_vblank
[280.551414] Starting dynamic subtest: A-eDP1
[289.451266] Dynamic subtest A-eDP1: SUCCESS (8.902s)
[289.460291] Starting dynamic subtest: B-eDP1
[298.380882] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[298.389913] Starting dynamic subtest: C-eDP1
[307.290563] Dynamic subtest C-eDP1: SUCCESS (8.907s)
[307.301464] Starting dynamic subtest: D-eDP1
[316.216230] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[316.222155] Subtest blocking-wf_vblank: SUCCESS (35.672s)
[317.415404] [053/130] (699s left) kms_setmode (invalid-clone-single-crtc)
[317.467071] Starting subtest: invalid-clone-single-crtc
[317.473577] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[317.544180] [054/130] (699s left) gem_render_copy_redux (flink)
[317.599574] Starting subtest: flink
[318.487745] Subtest flink: SUCCESS (0.888s)
[318.558860] [055/130] (698s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[318.624286] Starting subtest: y-tiled-to-vebox-y-tiled
[318.628389] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[318.786541] [056/130] (698s left) syncobj_timeline (multi-wait-signaled)
[318.845585] Starting subtest: multi-wait-signaled
[318.848064] Subtest multi-wait-signaled: SUCCESS (0.000s)
[318.931716] [057/130] (698s left) gem_create (create-clear)
[318.993690] Starting subtest: create-clear
[318.995999] Starting dynamic subtest: smem0
[351.797234] Dynamic subtest smem0: SUCCESS (32.800s)
[351.800128] Subtest create-clear: SUCCESS (32.801s)
[351.968989] [058/130] (665s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[352.078745] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[352.081115] Starting dynamic subtest: pipe-A-eDP-1
[352.476256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s)
[352.485197] Starting dynamic subtest: pipe-B-eDP-1
[353.828995] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.353s)
[353.836086] Starting dynamic subtest: pipe-C-eDP-1
[355.225273] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[355.233962] Starting dynamic subtest: pipe-D-eDP-1
[356.547579] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[356.550048] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.439s)
[357.707262] [059/130] (659s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[357.805174] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[357.809650] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[358.934715] [060/130] (658s left) kms_pm_rpm (fences-dpms)
[361.062647] Starting subtest: fences-dpms
[361.067660] Subtest fences-dpms: SKIP (0.000s)
[361.393652] [061/130] (655s left) i915_selftest (live)
[365.726090] Starting subtest: live
[365.728307] Starting dynamic subtest: sanitycheck
[370.157951] Dynamic subtest sanitycheck: SUCCESS (4.432s)
[370.165249] Starting dynamic subtest: uncore
[374.522675] Dynamic subtest uncore: SUCCESS (4.363s)
[374.530878] Starting dynamic subtest: workarounds
[377.716556] Dynamic subtest workarounds: SUCCESS (3.192s)
[377.725743] Starting dynamic subtest: gt_engines
[382.315802] Dynamic subtest gt_engines: SUCCESS (4.597s)
[382.323066] Starting dynamic subtest: gt_timelines
[398.823868] Dynamic subtest gt_timelines: SUCCESS (16.506s)
[398.832284] Starting dynamic subtest: gt_contexts
[403.199404] Dynamic subtest gt_contexts: SUCCESS (4.374s)
[403.209208] Starting dynamic subtest: gt_lrc
[407.598148] Dynamic subtest gt_lrc: SUCCESS (4.397s)
[407.606265] Starting dynamic subtest: gt_mocs
[410.599984] Dynamic subtest gt_mocs: SUCCESS (3.000s)
[410.608685] Starting dynamic subtest: gt_pm
[414.909469] Dynamic subtest gt_pm: SUCCESS (4.307s)
[414.918185] Starting dynamic subtest: gt_heartbeat
[419.335553] Dynamic subtest gt_heartbeat: SUCCESS (4.425s)
[419.346073] Starting dynamic subtest: gt_tlb
[427.504355] Dynamic subtest gt_tlb: SUCCESS (8.167s)
[427.512513] Starting dynamic subtest: requests
[440.926154] Dynamic subtest requests: SUCCESS (13.419s)
[440.934765] Starting dynamic subtest: migrate
[448.911466] Dynamic subtest migrate: SUCCESS (7.983s)
[448.920183] Starting dynamic subtest: active
[453.305366] Dynamic subtest active: SUCCESS (4.393s)
[453.313466] Starting dynamic subtest: objects
[456.530094] Dynamic subtest objects: SUCCESS (3.223s)
[456.538943] Starting dynamic subtest: mman
[461.340370] Dynamic subtest mman: SUCCESS (4.808s)
[461.348934] Starting dynamic subtest: dmabuf
[464.038967] Dynamic subtest dmabuf: SUCCESS (2.698s)
[464.046181] Starting dynamic subtest: vma
[468.424819] Dynamic subtest vma: SUCCESS (4.383s)
[468.433521] Starting dynamic subtest: coherency
[473.819516] Dynamic subtest coherency: SUCCESS (5.394s)
[473.828675] Starting dynamic subtest: gtt
[485.581794] Dynamic subtest gtt: SUCCESS (11.759s)
[485.590647] Starting dynamic subtest: gem
[493.802514] Dynamic subtest gem: SUCCESS (8.220s)
[493.811669] Starting dynamic subtest: evict
[497.552357] Dynamic subtest evict: SUCCESS (3.749s)
[497.560780] Starting dynamic subtest: hugepages
[506.482151] Dynamic subtest hugepages: SUCCESS (8.927s)
[506.491595] Starting dynamic subtest: gem_contexts
[532.118550] Dynamic subtest gem_contexts: SUCCESS (25.634s)
[532.125252] Starting dynamic subtest: client
[536.483952] Dynamic subtest client: SUCCESS (4.365s)
[536.492026] Starting dynamic subtest: gem_migrate
[540.832388] Dynamic subtest gem_migrate: SUCCESS (4.347s)
[540.840065] Starting dynamic subtest: reset
[543.549978] Dynamic subtest reset: SUCCESS (2.715s)
[543.558968] Starting dynamic subtest: memory_region
[547.972122] Dynamic subtest memory_region: SUCCESS (4.421s)
[547.980146] Starting dynamic subtest: hangcheck
[560.861960] Dynamic subtest hangcheck: SUCCESS (12.887s)
[560.870760] Starting dynamic subtest: execlists
[565.251465] Dynamic subtest execlists: SUCCESS (4.387s)
[565.260204] Starting dynamic subtest: ring_submission
[569.570380] Dynamic subtest ring_submission: SUCCESS (4.317s)
[569.578476] Starting dynamic subtest: perf
[573.935079] Dynamic subtest perf: SUCCESS (4.362s)
[573.943441] Starting dynamic subtest: slpc
[588.019896] Dynamic subtest slpc: SUCCESS (14.082s)
[588.027582] Starting dynamic subtest: guc
[591.750373] Dynamic subtest guc: SUCCESS (3.729s)
[591.757914] Starting dynamic subtest: guc_multi_lrc
[596.174528] Dynamic subtest guc_multi_lrc: SUCCESS (4.423s)
[596.183573] Starting dynamic subtest: guc_hang
[601.078290] Dynamic subtest guc_hang: SUCCESS (4.902s)
[601.088550] Starting dynamic subtest: late_gt_pm
[605.461084] Dynamic subtest late_gt_pm: SUCCESS (4.381s)
[605.464181] Subtest live: SUCCESS (239.727s)
[605.733860] [062/130] (411s left) kms_addfb_basic (bad-pitch-256)
[609.130588] Starting subtest: bad-pitch-256
[609.132878] Subtest bad-pitch-256: SUCCESS (0.000s)
[609.238858] [063/130] (408s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[609.348136] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[609.350412] Starting dynamic subtest: pipe-A
[609.367823] Dynamic subtest pipe-A: SKIP (0.013s)
[609.375106] Starting dynamic subtest: pipe-B
[609.394986] Dynamic subtest pipe-B: SKIP (0.026s)
[609.401637] Starting dynamic subtest: pipe-C
[609.421789] Dynamic subtest pipe-C: SKIP (0.026s)
[609.428247] Starting dynamic subtest: pipe-D
[609.447956] Dynamic subtest pipe-D: SKIP (0.026s)
[609.452253] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.094s)
[609.526940] [064/130] (407s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[609.638955] Starting subtest: fbc-2p-pri-indfb-multidraw
[609.643177] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[609.719567] [065/130] (407s left) kms_force_connector_basic (force-connector-state)
[609.809621] Starting subtest: force-connector-state
[610.405364] Subtest force-connector-state: SUCCESS (0.596s)
[611.324025] [066/130] (406s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[611.427371] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[616.249096] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.824s)
[616.338151] [067/130] (401s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[616.446518] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[616.450713] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[616.516573] [068/130] (400s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[616.616326] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[616.620642] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[616.686401] [069/130] (400s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[616.792526] Starting subtest: 4-tiled-64bpp-rotate-180
[618.312308] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.521s)
[618.471851] [070/130] (398s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[623.495843] Starting subtest: pr-plane-move-sf-dmg-area
[623.500641] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s)
[624.307109] [071/130] (393s left) gen9_exec_parse (shadow-peek)
[624.367024] Subtest shadow-peek: SKIP (0.000s)
[624.419558] [072/130] (393s left) gen3_render_tiledx_blits
[624.509397] [073/130] (392s left) kms_plane_multiple (tiling-x)
[624.607251] Starting subtest: tiling-x
[624.609453] Starting dynamic subtest: pipe-A-eDP-1
[628.352572] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.744s)
[628.360427] Starting dynamic subtest: pipe-B-eDP-1
[632.966444] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.609s)
[632.974487] Starting dynamic subtest: pipe-C-eDP-1
[637.536199] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.572s)
[637.544532] Starting dynamic subtest: pipe-D-eDP-1
[641.933191] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.394s)
[641.935617] Subtest tiling-x: SUCCESS (17.324s)
[642.702326] [074/130] (374s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[642.755199] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[642.860384] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[642.914828] [075/130] (374s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[643.021631] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[647.573960] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.554s)
[647.689736] [076/130] (369s left) kms_color (legacy-gamma-reset)
[647.786986] Starting subtest: legacy-gamma-reset
[647.789097] Starting dynamic subtest: pipe-A-eDP-1
[648.162642] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s)
[648.169830] Starting dynamic subtest: pipe-B-eDP-1
[648.174879] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[648.181870] Starting dynamic subtest: pipe-C-eDP-1
[648.184201] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[648.190873] Starting dynamic subtest: pipe-D-eDP-1
[648.195828] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[648.198304] Subtest legacy-gamma-reset: SUCCESS (0.409s)
[649.002769] [077/130] (368s left) api_intel_bb (crc32)
[649.057296] Starting subtest: crc32
[649.059707] Starting dynamic subtest: rcs0-smem0
[649.327276] Dynamic subtest rcs0-smem0: SUCCESS (0.268s)
[649.337309] Starting dynamic subtest: bcs0-smem0
[649.650555] Dynamic subtest bcs0-smem0: SUCCESS (0.321s)
[649.662032] Starting dynamic subtest: vcs0-smem0
[649.948067] Dynamic subtest vcs0-smem0: SUCCESS (0.294s)
[649.958792] Starting dynamic subtest: vcs1-smem0
[650.285888] Dynamic subtest vcs1-smem0: SUCCESS (0.336s)
[650.296853] Starting dynamic subtest: vecs0-smem0
[650.578044] Dynamic subtest vecs0-smem0: SUCCESS (0.290s)
[650.588178] Starting dynamic subtest: ccs0-smem0
[650.896756] Dynamic subtest ccs0-smem0: SUCCESS (0.317s)
[650.899626] Subtest crc32: SUCCESS (1.840s)
[651.021767] [078/130] (366s left) kms_addfb_basic (too-wide)
[651.123315] Starting subtest: too-wide
[651.125634] Subtest too-wide: SUCCESS (0.000s)
[651.205236] [079/130] (366s left) i915_module_load (reload-no-display)
[651.239714] Starting subtest: reload-no-display
[658.548982] Subtest reload-no-display: SUCCESS (7.309s)
[658.565939] [080/130] (359s left) gem_userptr_blits (coherency-unsync)
[660.003849] Subtest coherency-unsync: SKIP (0.000s)
[660.100626] [081/130] (357s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[661.238451] Starting subtest: verify-pxp-stale-buf-optout-execution
[661.298883] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (0.060s)
[661.461929] [082/130] (356s left) gem_lmem_swapping (parallel-random-engines)
[661.504969] Subtest parallel-random-engines: SKIP (0.000s)
[661.522801] [083/130] (356s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[661.567439] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[661.617817] [084/130] (356s left) gem_exec_parallel (userptr)
[661.684228] Starting subtest: userptr
[661.686547] Starting dynamic subtest: rcs0
[663.153442] Dynamic subtest rcs0: SUCCESS (1.469s)
[663.164699] Starting dynamic subtest: bcs0
[664.636385] Dynamic subtest bcs0: SUCCESS (1.481s)
[664.643563] Starting dynamic subtest: vcs0
[667.944720] Dynamic subtest vcs0: SUCCESS (3.304s)
[667.953877] Starting dynamic subtest: vcs1
[669.866771] Dynamic subtest vcs1: SUCCESS (1.920s)
[669.874720] Starting dynamic subtest: vecs0
[671.911377] Dynamic subtest vecs0: SUCCESS (2.043s)
[671.921421] Starting dynamic subtest: ccs0
[673.422546] Dynamic subtest ccs0: SUCCESS (1.510s)
[673.424818] Subtest userptr: SUCCESS (11.738s)
[673.592563] [085/130] (344s left) kms_lease (lease-revoke)
[673.699125] Starting subtest: lease-revoke
[673.701285] Starting dynamic subtest: pipe-A-eDP-1
[673.733662] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.034s)
[673.741321] Starting dynamic subtest: pipe-B-eDP-1
[673.761293] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[673.768878] Starting dynamic subtest: pipe-C-eDP-1
[673.787589] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.025s)
[673.800272] Starting dynamic subtest: pipe-D-eDP-1
[673.816345] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[673.819683] Subtest lease-revoke: SUCCESS (0.117s)
[673.941553] [086/130] (343s left) kms_psr (pr-sprite-plane-move)
[674.045949] Starting subtest: pr-sprite-plane-move
[674.050346] Subtest pr-sprite-plane-move: SKIP (0.000s)
[674.095891] [087/130] (343s left) gem_exec_fence (basic-busy-all)
[674.164209] Starting subtest: basic-busy-all
[674.269830] Subtest basic-busy-all: SUCCESS (0.107s)
[676.032758] [088/130] (341s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[676.151345] Starting subtest: yf-tiled-32bpp-rotate-270
[676.155848] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[676.242345] [089/130] (341s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[676.340089] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[676.342339] Starting dynamic subtest: pipe-A-eDP-1
[676.367545] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[676.376900] Starting dynamic subtest: pipe-B-eDP-1
[676.400796] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[676.408266] Starting dynamic subtest: pipe-C-eDP-1
[676.432592] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[676.440858] Starting dynamic subtest: pipe-D-eDP-1
[676.465198] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[676.469606] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[678.446869] [090/130] (339s left) prime_busy (hang)
[678.515714] Starting subtest: hang
[678.518120] Starting dynamic subtest: rcs0
[704.448883] Dynamic subtest rcs0: SUCCESS (25.927s)
[704.458216] Starting dynamic subtest: bcs0
[711.604769] Dynamic subtest bcs0: SUCCESS (7.156s)
[711.612045] Starting dynamic subtest: vcs0
[718.583707] Dynamic subtest vcs0: SUCCESS (6.978s)
[718.590532] Starting dynamic subtest: vcs1
[725.555669] Dynamic subtest vcs1: SUCCESS (6.971s)
[725.562619] Starting dynamic subtest: vecs0
[732.591816] Dynamic subtest vecs0: SUCCESS (7.038s)
[732.602039] Starting dynamic subtest: ccs0
[746.434086] Dynamic subtest ccs0: SUCCESS (13.838s)
[746.436085] Subtest hang: SUCCESS (67.914s)
[746.551751] [091/130] (271s left) gem_exec_reloc (basic-gtt-read-active)
[746.614266] Subtest basic-gtt-read-active: SKIP (0.000s)
[746.674570] [092/130] (271s left) drm_fdinfo (virtual-busy-idle-all)
[746.715760] Starting subtest: virtual-busy-idle-all
[746.720496] Subtest virtual-busy-idle-all: SKIP (0.000s)
[746.766630] [093/130] (271s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[746.869038] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[746.871356] Starting dynamic subtest: pipe-A-default-mode
[748.012940] Dynamic subtest pipe-A-default-mode: SKIP (1.142s)
[748.024434] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.143s)
[748.156831] [094/130] (269s left) gem_exec_whisper (basic-contexts-forked)
[748.220503] Starting subtest: basic-contexts-forked
[771.454046] Subtest basic-contexts-forked: SUCCESS (23.227s)
[771.617817] [095/130] (246s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[771.732395] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[771.736960] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[771.830670] [096/130] (246s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[771.940693] Starting subtest: 2x-absolute-wf_vblank-interruptible
[771.953507] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[772.007604] [097/130] (245s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[772.101189] Starting subtest: fbc-pr-cursor-mmap-cpu
[772.105569] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[772.155147] [098/130] (245s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[772.256456] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[775.437863] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (3.185s)
[775.574370] [099/130] (242s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[775.682044] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[775.685455] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[775.775587] [100/130] (242s left) kms_flip (flip-vs-suspend)
[775.874494] Starting subtest: flip-vs-suspend
[775.876358] Starting dynamic subtest: A-eDP1
[824.897645] Dynamic subtest A-eDP1: SUCCESS (4.440s)
[824.912925] Starting dynamic subtest: B-eDP1
[873.906585] Dynamic subtest B-eDP1: SUCCESS (4.260s)
[873.920082] Starting dynamic subtest: C-eDP1
[922.891448] Dynamic subtest C-eDP1: SUCCESS (4.307s)
[922.911499] Starting dynamic subtest: D-eDP1
[971.900455] Dynamic subtest D-eDP1: SUCCESS (4.347s)
[971.905623] Subtest flip-vs-suspend: SUCCESS (17.363s)
[973.100082] [101/130] (223s left) kms_atomic (crtc-invalid-params)
[973.196158] Starting subtest: crtc-invalid-params
[973.198608] Starting dynamic subtest: pipe-A-eDP-1
[973.569852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.370s)
[973.572478] Subtest crtc-invalid-params: SUCCESS (0.371s)
[974.338321] [102/130] (222s left) i915_pm_rpm (gem-idle)
[975.865748] Starting subtest: gem-idle
[982.070477] Subtest gem-idle: SUCCESS (6.198s)
[982.371041] [103/130] (214s left) kms_cursor_crc (cursor-random-128x128)
[983.646463] Starting subtest: cursor-random-128x128
[983.649039] Starting dynamic subtest: pipe-A-eDP-1
[986.985155] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.332s)
[987.012225] Starting dynamic subtest: pipe-D-eDP-1
[990.973623] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.967s)
[990.976205] Subtest cursor-random-128x128: SUCCESS (7.321s)
[991.829098] [104/130] (204s left) kms_vblank (wait-forked)
[991.932865] Starting subtest: wait-forked
[991.935477] Starting dynamic subtest: pipe-A-eDP-1
[993.754309] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.818s)
[993.770520] Starting dynamic subtest: pipe-D-eDP-1
[996.240890] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.482s)
[996.243418] Subtest wait-forked: SUCCESS (4.303s)
[997.072041] [105/130] (199s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[997.177482] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[998.378363] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.494s)
[998.395845] [106/130] (198s left) gem_exec_fence (syncobj-invalid-wait)
[998.859601] Starting subtest: syncobj-invalid-wait
[998.862488] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[1000.654225] [107/130] (196s left) syncobj_wait (signal)
[1000.705428] Starting subtest: signal
[1000.708337] Subtest signal: SUCCESS (0.000s)
[1000.793954] [108/130] (196s left) syncobj_eventfd (timeline-wait-before-signal)
[1000.858812] Starting subtest: timeline-wait-before-signal
[1000.889588] Subtest timeline-wait-before-signal: SUCCESS (0.032s)
[1000.945028] [109/130] (195s left) drm_fdinfo (memory-info-active)
[1000.986812] Starting subtest: memory-info-active
[1000.989511] Starting dynamic subtest: smem0
[1003.639087] Dynamic subtest smem0: SUCCESS (2.654s)
[1003.642179] Subtest memory-info-active: SUCCESS (2.655s)
[1003.694517] [110/130] (193s left) gem_ctx_param (invalid-size-set)
[1003.752928] Starting subtest: invalid-size-set
[1003.755372] Subtest invalid-size-set: SUCCESS (0.001s)
[1003.838067] [111/130] (193s left) kms_cursor_edge_walk (128x128-left-edge)
[1003.937095] Starting subtest: 128x128-left-edge
[1003.939365] Starting dynamic subtest: pipe-A-eDP-1
[1007.356712] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.416s)
[1007.366799] Starting dynamic subtest: pipe-D-eDP-1
[1010.481607] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[1010.484485] Subtest 128x128-left-edge: SUCCESS (6.540s)
[1011.267074] [112/130] (185s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[1011.340192] Subtest untiled-to-tiled: SKIP (0.000s)
[1011.373824] [113/130] (185s left) gem_create (busy-create)
[1011.424198] Starting subtest: busy-create
[1011.426857] Starting dynamic subtest: smem0
[1045.593667] Dynamic subtest smem0: SUCCESS (34.150s)
[1045.596439] Subtest busy-create: SUCCESS (34.151s)
[1045.766238] [114/130] (151s left) kms_getfb (getfb-reject-ccs)
[1045.824486] Starting subtest: getfb-reject-ccs
[1045.827487] Subtest getfb-reject-ccs: SUCCESS (0.000s)
[1045.923332] [115/130] (151s left) gem_eio (unwedge-stress)
[1046.165409] Starting subtest: unwedge-stress
[1080.506720] Abort requested by sudo LD_LIBRARY_PATH=/opt/igt/lib:/opt/igt/lib/x86_64-linux-gnu IGT_PING_HOSTNAME=10.211.124.1 IGT_CI_META_TEST=yes IGT [2189] via Terminated, terminating children
[1081.519834] Closing watchdogs
Done.