[39.161030] Initializing watchdogs
[39.161058]   /dev/watchdog0
[39.168076] [001/130] (960s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[39.367800] Starting subtest: cursor-rapid-movement-256x256
[39.376832] Starting dynamic subtest: pipe-A-eDP-1
[39.927982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[39.947223] Starting dynamic subtest: pipe-D-eDP-1
[41.223541] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.280s)
[41.226347] Subtest cursor-rapid-movement-256x256: SUCCESS (1.855s)
[42.093280] [002/130] (957s left) kms_flip (flip-vs-absolute-wf_vblank)
[42.184031] Starting subtest: flip-vs-absolute-wf_vblank
[42.186715] Starting dynamic subtest: A-eDP1
[49.793152] Dynamic subtest A-eDP1: FAIL (7.191s)
[49.803069] Starting dynamic subtest: B-eDP1
[57.894837] Dynamic subtest B-eDP1: FAIL (7.960s)
[57.901596] Starting dynamic subtest: C-eDP1
[70.133241] Dynamic subtest C-eDP1: FAIL (12.455s)
[70.140574] Starting dynamic subtest: D-eDP1
[78.976758] Dynamic subtest D-eDP1: SUCCESS (9.010s)
[78.981884] Subtest flip-vs-absolute-wf_vblank: FAIL (36.624s)
[80.204557] [003/130] (919s left) gem_ctx_freq (sysfs)
[80.258596] Starting subtest: sysfs
[80.261126] Starting dynamic subtest: gt0
[85.781875] Dynamic subtest gt0: SUCCESS (5.521s)
[85.789651] Starting dynamic subtest: gt1
[127.398813] Dynamic subtest gt1: SUCCESS (41.611s)
[127.401594] Subtest sysfs: SUCCESS (47.132s)
[127.450428] [004/130] (872s left) sw_sync (alloc_timeline)
[127.477989] Starting subtest: alloc_timeline
[127.480398] Subtest alloc_timeline: SUCCESS (0.000s)
[127.501964] [005/130] (872s left) drm_read (empty-block)
[127.642212] Starting subtest: empty-block
[128.647720] Subtest empty-block: SUCCESS (1.000s)
[128.763355] [006/130] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[128.855806] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[128.860188] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[128.925699] [007/130] (871s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[129.010099] Starting subtest: fbcpsr-tiling-linear
[133.435048] Subtest fbcpsr-tiling-linear: SUCCESS (4.427s)
[133.531025] [008/130] (866s left) kms_cursor_edge_walk (64x64-left-edge)
[133.620711] Starting subtest: 64x64-left-edge
[133.623088] Starting dynamic subtest: pipe-A-eDP-1
[137.134417] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.510s)
[137.141033] Starting dynamic subtest: pipe-D-eDP-1
[140.324083] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.189s)
[140.326553] Subtest 64x64-left-edge: SUCCESS (6.701s)
[141.193443] [009/130] (858s left) gem_exec_schedule (preemptive-hang)
[141.353206] Starting subtest: preemptive-hang
[141.355990] Starting dynamic subtest: rcs0
[150.475593] Dynamic subtest rcs0: SUCCESS (9.121s)
[150.483289] Starting dynamic subtest: bcs0
[159.496503] Dynamic subtest bcs0: SUCCESS (9.020s)
[159.505557] Starting dynamic subtest: vcs0
[168.526672] Dynamic subtest vcs0: SUCCESS (9.030s)
[168.534913] Starting dynamic subtest: vcs1
[177.544659] Dynamic subtest vcs1: SUCCESS (9.017s)
[177.552829] Starting dynamic subtest: vecs0
[186.510995] Dynamic subtest vecs0: SUCCESS (8.964s)
[186.518144] Starting dynamic subtest: ccs0
[195.530350] Dynamic subtest ccs0: SUCCESS (9.021s)
[195.532731] Subtest preemptive-hang: SUCCESS (54.175s)
[195.751648] [010/130] (804s left) gem_exec_schedule (deep)
[195.918640] Starting subtest: deep
[195.922561] Starting dynamic subtest: rcs0
[200.346989] Dynamic subtest rcs0: SKIP (4.427s)
[200.354741] Starting dynamic subtest: vcs0
[208.901876] Dynamic subtest vcs0: SUCCESS (8.556s)
[208.911080] Starting dynamic subtest: vcs1
[217.982749] Dynamic subtest vcs1: SUCCESS (9.081s)
[217.992232] Starting dynamic subtest: vecs0
[227.169886] Dynamic subtest vecs0: SUCCESS (9.186s)
[227.178150] Starting dynamic subtest: ccs0
[236.969668] Dynamic subtest ccs0: SUCCESS (9.799s)
[236.972511] Subtest deep: SUCCESS (41.049s)
[237.861029] [011/130] (762s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[237.961853] Starting subtest: y-tiled-32bpp-rotate-0
[237.966393] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[238.024059] [012/130] (761s left) gem_eio (context-create)
[238.236720] Starting subtest: context-create
[238.547087] Subtest context-create: SUCCESS (0.312s)
[238.638108] [013/130] (761s left) kms_flip (busy-flip)
[238.734253] Starting subtest: busy-flip
[238.736603] Starting dynamic subtest: A-eDP1
[240.516371] Dynamic subtest A-eDP1: SUCCESS (1.781s)
[240.524594] Starting dynamic subtest: B-eDP1
[242.245423] Dynamic subtest B-eDP1: SUCCESS (1.729s)
[242.253521] Starting dynamic subtest: C-eDP1
[244.025176] Dynamic subtest C-eDP1: SUCCESS (1.780s)
[244.033461] Starting dynamic subtest: D-eDP1
[245.752084] Dynamic subtest D-eDP1: SUCCESS (1.725s)
[245.757850] Subtest busy-flip: SUCCESS (7.024s)
[246.983572] [014/130] (753s left) kms_properties (plane-properties-legacy)
[247.069284] Starting subtest: plane-properties-legacy
[247.071779] Starting dynamic subtest: pipe-A-eDP-1
[247.619035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[247.625292] Starting dynamic subtest: pipe-B-eDP-1
[248.977396] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.357s)
[248.983365] Starting dynamic subtest: pipe-C-eDP-1
[250.314542] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.334s)
[250.321269] Starting dynamic subtest: pipe-D-eDP-1
[251.667062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[251.669657] Subtest plane-properties-legacy: SUCCESS (4.596s)
[252.555325] [015/130] (747s left) perf_pmu (gt-awake)
[252.599564] Starting subtest: gt-awake
[261.352517] Subtest gt-awake: SUCCESS (8.753s)
[261.431153] [016/130] (738s left) kms_flip (flip-vs-wf_vblank-interruptible)
[261.520435] Starting subtest: flip-vs-wf_vblank-interruptible
[261.522986] Starting dynamic subtest: A-eDP1
[263.468893] Dynamic subtest A-eDP1: SUCCESS (1.946s)
[263.477292] Starting dynamic subtest: B-eDP1
[265.453669] Dynamic subtest B-eDP1: SUCCESS (1.984s)
[265.462365] Starting dynamic subtest: C-eDP1
[267.426343] Dynamic subtest C-eDP1: SUCCESS (1.973s)
[267.434180] Starting dynamic subtest: D-eDP1
[269.347968] Dynamic subtest D-eDP1: SUCCESS (1.920s)
[269.354707] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.833s)
[270.602731] [017/130] (729s left) kms_psr (pr-sprite-mmap-cpu)
[270.695861] Starting subtest: pr-sprite-mmap-cpu
[270.700499] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[270.746022] [018/130] (729s left) i915_suspend (sysfs-reader)
[270.802224] Starting subtest: sysfs-reader
[288.811560] Subtest sysfs-reader: SUCCESS (3.004s)
[288.849202] [019/130] (726s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[288.948603] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[288.952618] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[289.020103] [020/130] (726s left) kms_pm_rpm (pm-tiling)
[290.551284] Starting subtest: pm-tiling
[290.557083] Subtest pm-tiling: SKIP (0.000s)
[290.878137] [021/130] (724s left) gem_exec_reloc (basic-cpu-read)
[290.928441] Subtest basic-cpu-read: SKIP (0.000s)
[290.975339] [022/130] (724s left) i915_pm_sseu (full-enable)
[291.029054] Subtest full-enable: SKIP (0.000s)
[291.113378] [023/130] (724s left) gem_ctx_bad_destroy (invalid-default-ctx)
[291.160226] Starting subtest: invalid-default-ctx
[291.162549] Subtest invalid-default-ctx: SUCCESS (0.000s)
[291.212495] [024/130] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[291.310880] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[294.252484] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.905s)
[294.356390] [025/130] (720s left) gem_readwrite (beyond-eob)
[294.406085] Subtest beyond-EOB: SKIP (0.000s)
[294.442621] [026/130] (720s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[294.661039] Starting subtest: cursor-rapid-movement-512x512
[294.665098] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[294.787801] [027/130] (720s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[294.887373] Starting subtest: fbcpsr-rgb565-draw-pwrite
[299.611760] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (4.690s)
[299.712207] [028/130] (715s left) kms_invalid_mode (bad-vtotal)
[299.795179] Starting subtest: bad-vtotal
[299.797539] Starting dynamic subtest: pipe-A-eDP-1
[300.075590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s)
[300.082526] Starting dynamic subtest: pipe-B-eDP-1
[300.084750] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[300.091255] Starting dynamic subtest: pipe-C-eDP-1
[300.093524] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[300.100197] Starting dynamic subtest: pipe-D-eDP-1
[300.102626] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[300.105034] Subtest bad-vtotal: SUCCESS (0.284s)
[300.961816] [029/130] (714s left) kms_atomic (plane-overlay-legacy)
[301.045862] Starting subtest: plane-overlay-legacy
[301.048241] Starting dynamic subtest: pipe-A-eDP-1
[301.454142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.404s)
[301.456541] Subtest plane-overlay-legacy: SUCCESS (0.405s)
[302.366812] [030/130] (713s left) gem_mmap_wc (copy)
[302.421893] Subtest copy: SKIP (0.000s)
[302.457348] [031/130] (712s left) gen9_exec_parse (secure-batches)
[302.509357] Subtest secure-batches: SKIP (0.000s)
[302.547701] [032/130] (712s left) core_auth (basic-auth)
[302.590826] Starting subtest: basic-auth
[302.593346] Subtest basic-auth: SUCCESS (0.002s)
[302.673235] [033/130] (712s left) kms_hdmi_inject (inject-audio)
[303.004847] Starting subtest: inject-audio
[303.009527] Subtest inject-audio: SKIP (0.000s)
[303.899992] [034/130] (711s left) kms_content_protection (type1)
[304.030159] Starting subtest: type1
[307.525985] Subtest type1: SKIP (3.484s)
[308.770364] [035/130] (706s left) dumb_buffer (map-invalid-size)
[308.822443] Starting subtest: map-invalid-size
[308.824367] Subtest map-invalid-size: SUCCESS (0.000s)
[308.890802] [036/130] (706s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[308.973876] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[308.976171] Starting dynamic subtest: pipe-A-eDP-1
[308.997904] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[309.004811] Starting dynamic subtest: pipe-B-eDP-1
[309.026223] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[309.032262] Starting dynamic subtest: pipe-C-eDP-1
[309.053914] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[309.060096] Starting dynamic subtest: pipe-D-eDP-1
[309.082455] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[309.086890] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.002s)
[311.326385] [037/130] (704s left) gem_fence_thrash (bo-copy)
[311.351938] Starting subtest: bo-copy
[311.382840] Subtest bo-copy: SKIP (0.025s)
[311.417839] [038/130] (704s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[311.503003] Starting subtest: fbc-psr2-primary-mmap-gtt
[311.505382] Starting dynamic subtest: eDP-1
[311.509631] Dynamic subtest eDP-1: SKIP (0.000s)
[311.513893] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[311.551399] [039/130] (704s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[311.642951] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[311.647101] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[311.727951] [040/130] (703s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[311.824785] Starting subtest: psr-2p-primscrn-cur-indfb-move
[311.829280] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[311.890211] [041/130] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[311.990843] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[311.995318] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[312.057216] [042/130] (703s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[312.158787] Starting subtest: x-tiled-16bpp-rotate-180
[313.291678] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.132s)
[313.402520] [043/130] (702s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[313.487390] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[317.805859] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.317s)
[317.918565] [044/130] (697s left) drm_read (fault-buffer)
[318.047865] Starting subtest: fault-buffer
[318.050362] Subtest fault-buffer: SUCCESS (0.000s)
[318.164487] [045/130] (697s left) kms_flip (nonexisting-fb)
[318.250412] Starting subtest: nonexisting-fb
[318.252667] Starting dynamic subtest: A-eDP1
[319.500716] Dynamic subtest A-eDP1: SUCCESS (1.249s)
[319.509581] Starting dynamic subtest: B-eDP1
[320.717334] Dynamic subtest B-eDP1: SUCCESS (1.216s)
[320.726118] Starting dynamic subtest: C-eDP1
[321.933446] Dynamic subtest C-eDP1: SUCCESS (1.216s)
[321.942758] Starting dynamic subtest: D-eDP1
[323.149226] Dynamic subtest D-eDP1: SUCCESS (1.215s)
[323.154572] Subtest nonexisting-fb: SUCCESS (4.906s)
[324.382303] [046/130] (691s left) gem_pxp (reject-modify-context-protection-off-3)
[326.965701] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[327.014400] [047/130] (688s left) kms_color (ctm-max)
[327.107760] Starting subtest: ctm-max
[327.109964] Starting dynamic subtest: pipe-A-eDP-1
[327.760537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.652s)
[327.769487] Starting dynamic subtest: pipe-B-eDP-1
[329.215595] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.452s)
[329.224229] Starting dynamic subtest: pipe-C-eDP-1
[330.568475] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[330.577861] Starting dynamic subtest: pipe-D-eDP-1
[331.987671] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.419s)
[331.990323] Subtest ctm-max: SUCCESS (4.878s)
[332.894617] [048/130] (682s left) prime_busy (hang-wait)
[332.933207] Starting subtest: hang-wait
[332.935408] Starting dynamic subtest: rcs0
[358.865316] Dynamic subtest rcs0: SUCCESS (25.924s)
[358.876488] Starting dynamic subtest: bcs0
[365.962842] Dynamic subtest bcs0: SUCCESS (7.091s)
[365.970862] Starting dynamic subtest: vcs0
[372.998237] Dynamic subtest vcs0: SUCCESS (7.032s)
[373.005339] Starting dynamic subtest: vcs1
[379.972894] Dynamic subtest vcs1: SUCCESS (6.975s)
[379.979926] Starting dynamic subtest: vecs0
[387.015295] Dynamic subtest vecs0: SUCCESS (7.039s)
[387.022487] Starting dynamic subtest: ccs0
[400.846256] Dynamic subtest ccs0: SUCCESS (13.834s)
[400.849265] Subtest hang-wait: SUCCESS (67.900s)
[400.959142] [049/130] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[401.056878] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[401.061093] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[401.141966] [050/130] (614s left) kms_selftest (drm_damage_helper)
[401.179125] Starting subtest: drm_damage_helper
[401.191016] Starting dynamic subtest: drm_test_damage_iter_no_damage
[401.286150] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.096s)
[401.298162] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[401.379053] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.092s)
[401.390493] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[401.483020] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.103s)
[401.491694] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[401.581732] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.098s)
[401.590323] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[401.679538] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.097s)
[401.689167] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[401.772331] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.092s)
[401.779100] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[401.869413] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.098s)
[401.876926] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[401.970798] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.100s)
[401.982391] Starting dynamic subtest: drm_test_damage_iter_single_damage
[402.041093] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.070s)
[402.048399] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[402.124739] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.084s)
[402.135450] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[402.217181] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.091s)
[402.226297] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[402.301389] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.083s)
[402.307786] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[402.397140] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.096s)
[402.403833] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[402.505422] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.107s)
[402.511882] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[402.600153] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.093s)
[402.608379] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[402.663952] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.064s)
[402.672190] Starting dynamic subtest: drm_test_damage_iter_damage
[402.764332] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.099s)
[402.773211] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[402.862423] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.098s)
[402.871274] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[402.943227] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.080s)
[402.949376] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[403.018208] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.075s)
[403.026720] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[403.118888] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.099s)
[403.120850] Subtest drm_damage_helper: SUCCESS (1.940s)
[403.273975] [051/130] (612s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[403.387114] Starting subtest: cursorA-vs-flipA-atomic
[414.511888] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.125s)
[415.391693] [052/130] (600s left) gem_softpin (allocator-fork)
[415.447995] Starting subtest: allocator-fork
[417.635438] Subtest allocator-fork: SUCCESS (2.186s)
[417.734528] [053/130] (598s left) gem_eio (in-flight-internal-10ms)
[417.914301] Starting subtest: in-flight-internal-10ms
[419.454051] Subtest in-flight-internal-10ms: SUCCESS (1.539s)
[419.569962] [054/130] (596s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[424.667307] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[424.671781] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[425.568507] [055/130] (590s left) gem_vm_create (invalid-destroy)
[425.629772] Starting subtest: invalid-destroy
[425.632086] Subtest invalid-destroy: SUCCESS (0.001s)
[425.721850] [056/130] (590s left) i915_pm_rpm (gem-pread)
[427.535109] Starting subtest: gem-pread
[429.230988] Subtest gem-pread: SUCCESS (1.694s)
[429.330515] [057/130] (586s left) kms_lease (lease-uevent)
[429.418251] Starting subtest: lease-uevent
[430.437410] Subtest lease-uevent: SUCCESS (1.019s)
[430.494440] [058/130] (585s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[430.873890] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[431.757996] [059/130] (584s left) gem_basic (bad-close)
[431.804814] Starting subtest: bad-close
[431.809626] Subtest bad-close: SUCCESS (0.000s)
[431.864421] [060/130] (584s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[431.952934] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[431.955285] Starting dynamic subtest: pipe-A-eDP-1
[431.978297] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[431.986965] Starting dynamic subtest: pipe-B-eDP-1
[432.008854] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[432.016219] Starting dynamic subtest: pipe-C-eDP-1
[432.038328] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[432.045399] Starting dynamic subtest: pipe-D-eDP-1
[432.067918] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[432.072073] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[434.268222] [061/130] (581s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[434.330175] Starting subtest: yf-tiled-to-vebox-yf-tiled
[434.334322] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[434.486378] [062/130] (581s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[434.533261] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[434.535321] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[434.603031] [063/130] (581s left) api_intel_bb (object-noreloc-keep-cache-simple)
[434.649040] Starting subtest: object-noreloc-keep-cache-simple
[434.651259] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[434.754072] [064/130] (581s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[434.847236] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[434.851273] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[434.931988] [065/130] (581s left) gem_exec_fence (syncobj-import)
[435.327641] Starting subtest: syncobj-import
[435.332982] Subtest syncobj-import: SUCCESS (0.004s)
[436.411617] [066/130] (579s left) gem_ccs (suspend-resume)
[436.462339] Starting subtest: suspend-resume
[436.467570] Subtest suspend-resume: SKIP (0.000s)
[436.532922] [067/130] (579s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[436.586616] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[436.616816] [068/130] (579s left) kms_psr (fbc-pr-basic)
[436.709947] Starting subtest: fbc-pr-basic
[436.714427] Subtest fbc-pr-basic: SKIP (0.000s)
[436.760442] [069/130] (579s left) gem_lmem_evict (dontneed-evict-race)
[436.794763] Subtest dontneed-evict-race: SKIP (0.000s)
[436.815126] [070/130] (579s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[437.180574] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[438.030617] [071/130] (578s left) gem_ctx_isolation (preservation-reset)
[438.196788] Starting subtest: preservation-reset
[438.199255] Starting dynamic subtest: rcs0
[438.421323] Dynamic subtest rcs0: SUCCESS (0.225s)
[438.430122] Starting dynamic subtest: bcs0
[438.705009] Dynamic subtest bcs0: SUCCESS (0.283s)
[438.712142] Starting dynamic subtest: vcs0
[438.990319] Dynamic subtest vcs0: SUCCESS (0.285s)
[438.998734] Starting dynamic subtest: vcs1
[440.583448] Dynamic subtest vcs1: SUCCESS (1.593s)
[440.591355] Starting dynamic subtest: vecs0
[442.636947] Dynamic subtest vecs0: SUCCESS (2.052s)
[442.650631] Starting dynamic subtest: ccs0
[444.629017] Dynamic subtest ccs0: SUCCESS (1.991s)
[444.632242] Subtest preservation-reset: SUCCESS (6.432s)
[444.735235] [072/130] (571s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[444.832098] Starting subtest: yf-tiled-64bpp-rotate-0
[444.836324] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[444.898197] [073/130] (571s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[444.992256] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[448.157924] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.170s)
[448.259501] [074/130] (567s left) syncobj_wait (wait-any-interrupted)
[448.295491] Starting subtest: wait-any-interrupted
[448.398586] Subtest wait-any-interrupted: SUCCESS (0.102s)
[448.451085] [075/130] (567s left) kms_busy (extended-modeset-hang-newfb)
[448.542951] Starting subtest: extended-modeset-hang-newfb
[448.545363] Starting dynamic subtest: pipe-A
[484.040695] Dynamic subtest pipe-A: SUCCESS (35.486s)
[484.051653] Starting dynamic subtest: pipe-D
[507.203809] Dynamic subtest pipe-D: SUCCESS (23.153s)
[507.206989] Subtest extended-modeset-hang-newfb: SUCCESS (58.643s)
[508.125302] [076/130] (508s left) gem_exec_balancer (parallel-contexts)
[508.340116] Starting subtest: parallel-contexts
[510.478315] Subtest parallel-contexts: SUCCESS (2.137s)
[510.617319] [077/130] (505s left) syncobj_timeline (single-wait-signaled)
[510.669589] Starting subtest: single-wait-signaled
[510.671722] Subtest single-wait-signaled: SUCCESS (0.000s)
[510.730665] [078/130] (505s left) kms_psr (psr-primary-mmap-cpu)
[510.811929] Starting subtest: psr-primary-mmap-cpu
[510.814234] Starting dynamic subtest: eDP-1
[512.577684] Dynamic subtest eDP-1: SUCCESS (1.763s)
[512.580395] Subtest psr-primary-mmap-cpu: SUCCESS (1.763s)
[513.440010] [079/130] (502s left) kms_plane_scaling (2x-scaler-multi-pipe)
[513.524169] Starting subtest: 2x-scaler-multi-pipe
[513.529203] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[513.593160] [080/130] (502s left) gem_lmem_swapping (parallel-multi)
[513.636273] Subtest parallel-multi: SKIP (0.000s)
[513.653594] [081/130] (502s left) kms_vblank (invalid)
[513.743037] Starting subtest: invalid
[513.745432] Starting dynamic subtest: pipe-A-eDP-1
[514.131943] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.386s)
[514.134267] Subtest invalid: SUCCESS (0.387s)
[515.040772] [082/130] (501s left) gem_mmap_offset (partial-mmap)
[515.087946] Starting subtest: partial-mmap
[515.089920] Starting dynamic subtest: smem0
[515.092214] Dynamic subtest smem0: SUCCESS (0.005s)
[515.094349] Subtest partial-mmap: SUCCESS (0.005s)
[515.159169] [083/130] (501s left) gem_close (basic)
[515.208437] Starting subtest: basic
[515.211153] Subtest basic: SUCCESS (0.000s)
[515.277838] [084/130] (501s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[515.325145] Starting subtest: etime-single-wait-all-for-submit-submitted
[515.431371] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[515.488283] [085/130] (500s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[515.576879] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[515.579365] Starting dynamic subtest: pipe-A-default-mode
[515.881862] Dynamic subtest pipe-A-default-mode: SKIP (0.302s)
[515.886722] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.303s)
[516.769351] [086/130] (499s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[516.851942] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[517.671979] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.821s)
[517.774121] [087/130] (498s left) gem_mmap_wc (write-gtt-read-wc)
[517.825102] Subtest write-gtt-read-wc: SKIP (0.000s)
[517.865534] [088/130] (498s left) gem_exec_schedule (u-semaphore-noskip)
[517.927260] Starting subtest: u-semaphore-noskip
[518.310703] Subtest u-semaphore-noskip: SUCCESS (0.394s)
[518.623898] [089/130] (497s left) gen9_exec_parse (bb-start-cmd)
[518.674951] Subtest bb-start-cmd: SKIP (0.000s)
[518.706337] [090/130] (497s left) gem_userptr_blits (map-fixed-invalidate)
[518.764114] Starting subtest: map-fixed-invalidate
[518.768201] Subtest map-fixed-invalidate: SKIP (0.000s)
[518.869427] [091/130] (497s left) gem_mmap_gtt (hang-busy)
[518.917317] Subtest hang-busy: SKIP (0.000s)
[518.956786] [092/130] (497s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[519.040922] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[519.043253] Starting dynamic subtest: pipe-A-eDP-1
[519.071024] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[519.078188] Starting dynamic subtest: pipe-B-eDP-1
[519.102395] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[519.110523] Starting dynamic subtest: pipe-C-eDP-1
[519.135417] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[519.145823] Starting dynamic subtest: pipe-D-eDP-1
[519.170648] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[519.174852] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[521.373828] [093/130] (495s left) gem_partial_pwrite_pread (writes-after-reads-display)
[521.430999] Subtest writes-after-reads-display: SKIP (0.000s)
[521.475243] [094/130] (495s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[526.581675] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[526.587205] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[527.452180] [095/130] (489s left) kms_pm_backlight (brightness-with-dpms)
[527.545105] Starting subtest: brightness-with-dpms
[527.593101] Starting dynamic subtest: eDP-1
[530.105140] Dynamic subtest eDP-1: SUCCESS (2.509s)
[530.108090] Subtest brightness-with-dpms: SUCCESS (2.557s)
[530.974495] [096/130] (485s left) gem_exec_suspend (basic)
[531.027931] Starting subtest: basic
[531.030619] Starting dynamic subtest: smem
[532.347528] Dynamic subtest smem: SUCCESS (1.318s)
[532.350447] Subtest basic: SUCCESS (1.319s)
[532.506561] [097/130] (484s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[532.593178] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[532.595432] Starting dynamic subtest: pipe-A-default-mode
[532.881114] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[532.886117] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.285s)
[533.791229] [098/130] (482s left) kms_getfb (getfb-addfb-different-handles)
[533.846855] Starting subtest: getfb-addfb-different-handles
[533.849376] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[533.941096] [099/130] (482s left) kms_pm_rpm (basic-pci-d3-state)
[535.561522] Starting subtest: basic-pci-d3-state
[537.025920] Subtest basic-pci-d3-state: SUCCESS (1.465s)
[537.092617] [100/130] (479s left) gem_exec_big (single)
[537.144455] Starting subtest: single
[539.085192] Subtest single: SUCCESS (1.939s)
[539.273429] [101/130] (477s left) gem_ppgtt (blt-vs-render-ctx0)
[539.365029] Starting subtest: blt-vs-render-ctx0
[572.050595] Subtest blt-vs-render-ctx0: SUCCESS (32.684s)
[572.143504] [102/130] (444s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[572.270104] Starting subtest: plane-primary-toggle-with-vblank-wait
[572.272433] Starting dynamic subtest: pipe-A-eDP-1
[572.445879] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.173s)
[572.755745] Starting dynamic subtest: pipe-B-eDP-1
[573.756130] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.006s)
[574.045338] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.771s)
[574.947788] [103/130] (441s left) sysfs_preempt_timeout (idempotent)
[574.998545] Starting subtest: idempotent
[575.000954] Starting dynamic subtest: vecs0
[575.003250] Dynamic subtest vecs0: SUCCESS (0.000s)
[575.011224] Starting dynamic subtest: ccs0
[575.013147] Dynamic subtest ccs0: SUCCESS (0.000s)
[575.020198] Starting dynamic subtest: vcs0
[575.022217] Dynamic subtest vcs0: SUCCESS (0.000s)
[575.029580] Starting dynamic subtest: bcs0
[575.031909] Dynamic subtest bcs0: SUCCESS (0.000s)
[575.039677] Starting dynamic subtest: rcs0
[575.041601] Dynamic subtest rcs0: SUCCESS (0.000s)
[575.048537] Starting dynamic subtest: vcs1
[575.050640] Dynamic subtest vcs1: SUCCESS (0.000s)
[575.052764] Subtest idempotent: SUCCESS (0.003s)
[575.067702] [104/130] (441s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[575.167656] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[579.927221] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.762s)
[580.003994] [105/130] (436s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[580.106139] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[584.386493] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.286s)
[584.489044] [106/130] (432s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[584.549152] Starting subtest: legacy-engines-hostile-preempt
[584.551413] Starting dynamic subtest: render
[584.627124] Dynamic subtest render: SUCCESS (0.078s)
[584.635356] Starting dynamic subtest: bsd1
[586.346703] Dynamic subtest bsd1: SUCCESS (1.718s)
[586.354962] Starting dynamic subtest: bsd2
[588.357708] Dynamic subtest bsd2: SUCCESS (2.009s)
[588.368353] Starting dynamic subtest: blt
[588.419951] Dynamic subtest blt: SUCCESS (0.062s)
[588.429510] Starting dynamic subtest: vebox
[590.401363] Dynamic subtest vebox: SUCCESS (1.978s)
[590.404461] Subtest legacy-engines-hostile-preempt: SUCCESS (5.852s)
[590.457903] [107/130] (426s left) kms_dsc (dsc-with-formats)
[590.549047] Starting subtest: dsc-with-formats
[590.553659] Subtest dsc-with-formats: SKIP (0.001s)
[590.600213] [108/130] (426s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[590.682837] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[590.685142] Starting dynamic subtest: pipe-A
[591.890599] Dynamic subtest pipe-A: SUCCESS (1.207s)
[591.900890] Starting dynamic subtest: pipe-B
[594.235802] Dynamic subtest pipe-B: SUCCESS (2.345s)
[594.244584] Starting dynamic subtest: pipe-C
[595.484097] Dynamic subtest pipe-C: SUCCESS (1.247s)
[595.491748] Starting dynamic subtest: pipe-D
[596.763182] Dynamic subtest pipe-D: SUCCESS (1.278s)
[596.765813] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.079s)
[597.981656] [109/130] (418s left) kms_vrr (max-min)
[598.083128] Starting subtest: max-min
[598.090100] Subtest max-min: SKIP (0.000s)
[598.133936] [110/130] (418s left) kms_fbcon_fbt (psr)
[598.191010] Starting subtest: psr
[603.661549] Subtest psr: SUCCESS (5.467s)
[603.711699] [111/130] (413s left) gem_mmap_gtt (basic-read-write-distinct)
[603.766997] Subtest basic-read-write-distinct: SKIP (0.000s)
[603.814084] [112/130] (412s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[603.906629] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[603.910698] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[603.973930] [113/130] (412s left) kms_legacy_colorkey (invalid-plane)
[604.059874] Starting subtest: invalid-plane
[604.062100] Starting dynamic subtest: zero-id
[604.063967] Dynamic subtest zero-id: SUCCESS (0.000s)
[604.071309] Starting dynamic subtest: outrange-id
[604.073129] Dynamic subtest outrange-id: SUCCESS (0.000s)
[604.075374] Subtest invalid-plane: SUCCESS (0.000s)
[604.112447] [114/130] (412s left) gem_exec_gttfill (all-engines)
[604.159153] Starting subtest: all-engines
[626.587379] Subtest all-engines: SUCCESS (22.425s)
[626.748685] [115/130] (390s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[626.892564] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[626.896894] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[626.959259] [116/130] (389s left) api_intel_allocator (reserve-simple)
[627.003943] Starting subtest: reserve-simple
[627.008972] Subtest reserve-simple: SUCCESS (0.004s)
[627.091403] [117/130] (389s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[627.185493] Starting subtest: x-tiled-8bpp-rotate-0
[628.197438] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.012s)
[628.296289] [118/130] (388s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[628.392104] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[631.589941] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (3.201s)
[631.705921] [119/130] (385s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[631.786990] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[631.789045] Starting dynamic subtest: pipe-A-eDP-1
[631.843559] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[631.852542] Starting dynamic subtest: pipe-B-eDP-1
[631.899854] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[631.908712] Starting dynamic subtest: pipe-C-eDP-1
[631.958773] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[631.967642] Starting dynamic subtest: pipe-D-eDP-1
[632.015948] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[632.019516] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[634.140929] [120/130] (382s left) gem_readwrite (new-obj)
[634.202735] Subtest new-obj: SKIP (0.000s)
[634.242616] [121/130] (382s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[634.301157] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[634.303792] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[634.374720] [122/130] (382s left) kms_flip (dpms-vs-vblank-race-interruptible)
[634.468224] Starting subtest: dpms-vs-vblank-race-interruptible
[634.470798] Starting dynamic subtest: A-eDP1
[638.517636] Dynamic subtest A-eDP1: SUCCESS (4.045s)
[638.526844] Starting dynamic subtest: B-eDP1
[642.165857] Dynamic subtest B-eDP1: SUCCESS (3.647s)
[642.174513] Starting dynamic subtest: C-eDP1
[644.435386] Abort requested by /sbin/init [1] via Terminated, terminating children
[644.435654] Abort requested by /sbin/init [1] via Hangup, terminating children
[644.435710] Exiting gracefully, currently running test will have a 'notrun' result
[644.439003] 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 [1320] via Hangup, terminating children
[644.439118] Exiting gracefully, currently running test will have a 'notrun' result
[646.663365] Closing watchdogs
Done.