[58.161726] Initializing watchdogs
[58.161773]   /dev/watchdog0
[58.176081] [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]
[58.180445] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.182807] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.186239] [001/133] (960s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[58.299823] Starting subtest: fbc-psr2-cursor-mmap-gtt
[58.302072] Starting dynamic subtest: eDP-1
[58.306098] Dynamic subtest eDP-1: SKIP (0.000s)
[58.310311] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[58.380809] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[58.494607] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[58.498869] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[58.601645] [003/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[58.703454] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[58.707977] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[58.798962] [004/133] (959s left) kms_psr (psr2-primary-blt)
[58.890574] Starting subtest: psr2-primary-blt
[58.892798] Starting dynamic subtest: eDP-1
[60.590720] Dynamic subtest eDP-1: SUCCESS (1.696s)
[60.593095] Subtest psr2-primary-blt: SUCCESS (1.696s)
[61.471602] [005/133] (957s left) gem_exec_fence (nb-await)
[61.662384] Starting subtest: nb-await
[61.664685] Starting dynamic subtest: rcs0
[61.731878] Dynamic subtest rcs0: SUCCESS (0.069s)
[61.742529] Starting dynamic subtest: bcs0
[61.790981] Dynamic subtest bcs0: SUCCESS (0.058s)
[61.800690] Starting dynamic subtest: vcs0
[61.851101] Dynamic subtest vcs0: SUCCESS (0.059s)
[61.860757] Starting dynamic subtest: vcs1
[61.909927] Dynamic subtest vcs1: SUCCESS (0.058s)
[61.919919] Starting dynamic subtest: vecs0
[61.971044] Dynamic subtest vecs0: SUCCESS (0.060s)
[61.981043] Starting dynamic subtest: ccs0
[62.029701] Dynamic subtest ccs0: SUCCESS (0.057s)
[62.032227] Subtest nb-await: SUCCESS (0.367s)
[63.952131] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[63.955205] [006/133] (954s left) kms_plane_scaling (invalid-parameters)
[64.047817] Starting subtest: invalid-parameters
[64.050093] Starting dynamic subtest: less-than-1-height-src
[64.060935] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[64.069052] Starting dynamic subtest: less-than-1-width-src
[64.074091] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[64.076221] Subtest invalid-parameters: SUCCESS (0.027s)
[64.177388] [007/133] (954s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[64.287170] Starting subtest: psr2-cursor-plane-update-sf
[64.289524] Starting dynamic subtest: pipe-A-eDP-1
[64.852493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[64.861822] Starting dynamic subtest: pipe-B-eDP-1
[66.156599] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.303s)
[66.158885] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.872s)
[67.080058] [008/133] (951s left) kms_psr (pr-primary-mmap-gtt)
[67.284428] Starting subtest: pr-primary-mmap-gtt
[67.289144] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[67.560866] [009/133] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[67.707100] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[67.711254] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[67.850127] [010/133] (951s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[67.987827] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[68.144520] [011/133] (951s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[68.240191] Starting subtest: yf-tiled-8bpp-rotate-270
[68.244426] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[68.335905] [012/133] (950s left) kms_atomic (atomic-invalid-params)
[68.429039] Starting subtest: atomic-invalid-params
[68.431454] Starting dynamic subtest: pipe-A-eDP-1
[68.843617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[68.845647] Subtest atomic-invalid-params: SUCCESS (0.414s)
[69.665170] [013/133] (949s left) kms_psr (psr-dpms)
[69.764394] Starting subtest: psr-dpms
[69.766711] Starting dynamic subtest: eDP-1
[72.702951] Dynamic subtest eDP-1: SUCCESS (2.937s)
[72.705219] Subtest psr-dpms: SUCCESS (2.938s)
[73.569244] [014/133] (945s left) kms_getfb (getfb-repeated-different-handles)
[73.663749] Starting subtest: getfb-repeated-different-handles
[73.666085] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[73.786624] [015/133] (945s left) gem_vm_create (invalid-create)
[73.857965] Starting subtest: invalid-create
[73.862561] Subtest invalid-create: SUCCESS (0.002s)
[73.971903] [016/133] (945s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[74.085137] Starting subtest: cursorA-vs-flipA-varying-size
[85.226036] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.137s)
[86.097753] [017/133] (933s left) gem_workarounds (suspend-resume)
[86.172177] Starting subtest: suspend-resume
[102.348324] Subtest suspend-resume: SUCCESS (2.101s)
[103.486454] [018/133] (916s left) syncobj_timeline (invalid-query-one-illegal-handle)
[103.557987] Starting subtest: invalid-query-one-illegal-handle
[103.560537] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[103.662982] [019/133] (916s left) kms_vblank (ts-continuation-dpms-suspend)
[103.751009] Starting subtest: ts-continuation-dpms-suspend
[103.753426] Starting dynamic subtest: pipe-A-eDP-1
[120.959286] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.864s)
[120.976318] Starting dynamic subtest: pipe-D-eDP-1
[138.933204] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.483s)
[138.935530] Subtest ts-continuation-dpms-suspend: SUCCESS (4.351s)
[139.751488] [020/133] (880s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[139.863933] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[140.899253] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.023s)
[141.010321] [021/133] (879s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[141.130006] Starting subtest: flip-vs-cursor-toggle
[149.943020] Subtest flip-vs-cursor-toggle: SUCCESS (8.751s)
[150.767732] [022/133] (869s left) syncobj_eventfd (invalid-bad-flags)
[150.829127] Starting subtest: invalid-bad-flags
[150.831508] Subtest invalid-bad-flags: SUCCESS (0.000s)
[150.953052] [023/133] (869s left) gem_exec_reloc (basic-softpin)
[151.022831] Subtest basic-softpin: SKIP (0.000s)
[151.110216] [024/133] (869s left) i915_pm_rpm (system-suspend)
[152.935523] Starting subtest: system-suspend
[171.055290] Subtest system-suspend: SUCCESS (2.766s)
[171.491588] [025/133] (849s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[171.590755] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[171.592984] Starting dynamic subtest: pipe-A-eDP-1
[203.645188] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.887s)
[203.653712] Starting dynamic subtest: pipe-B-eDP-1
[239.557505] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.549s)
[239.567581] Starting dynamic subtest: pipe-C-eDP-1
[272.541556] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.734s)
[272.552092] Starting dynamic subtest: pipe-D-eDP-1
[305.530870] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.654s)
[305.533576] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (16.830s)
[306.797944] [026/133] (714s left) gem_lmem_swapping (parallel-random-verify-ccs)
[306.852379] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[306.899460] [027/133] (713s left) kms_atomic_transition (plane-all-transition-fencing)
[306.997610] Starting subtest: plane-all-transition-fencing
[307.000352] Starting dynamic subtest: pipe-A-eDP-1
[309.520772] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[309.833614] Starting dynamic subtest: pipe-B-eDP-1
[313.079975] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.233s)
[313.381832] Subtest plane-all-transition-fencing: SUCCESS (6.328s)
[314.219015] [028/133] (706s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[314.336183] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[314.341670] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[314.407530] [029/133] (706s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[314.467171] Subtest writes-after-reads-snoop: SKIP (0.000s)
[314.521710] [030/133] (706s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[314.577384] Starting subtest: wait-all-for-submit-delayed-submit
[314.679224] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[314.762082] [031/133] (706s left) gem_busy (extended)
[314.944436] Starting subtest: extended
[314.947599] Starting dynamic subtest: rcs0
[315.022438] Dynamic subtest rcs0: SUCCESS (0.077s)
[315.034114] Starting dynamic subtest: bcs0
[315.065010] Dynamic subtest bcs0: SUCCESS (0.040s)
[315.074933] Starting dynamic subtest: vcs0
[317.059122] Dynamic subtest vcs0: SUCCESS (1.982s)
[317.071070] Starting dynamic subtest: vcs1
[319.043328] Dynamic subtest vcs1: SUCCESS (1.974s)
[319.055968] Starting dynamic subtest: vecs0
[321.027069] Dynamic subtest vecs0: SUCCESS (1.975s)
[321.040363] Starting dynamic subtest: ccs0
[321.073208] Dynamic subtest ccs0: SUCCESS (0.044s)
[321.076031] Subtest extended: SUCCESS (6.109s)
[321.320170] [032/133] (699s left) kms_big_fb (linear-64bpp-rotate-270)
[321.432807] Starting subtest: linear-64bpp-rotate-270
[321.452626] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[321.568201] [033/133] (699s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[321.953647] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[322.762614] [034/133] (698s left) gem_render_copy (yf-tiled-to-vebox-linear)
[322.823599] Starting subtest: yf-tiled-to-vebox-linear
[322.829013] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[323.008767] [035/133] (698s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[323.105460] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[323.108036] Starting dynamic subtest: pipe-A-eDP-1
[323.404215] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.267s)
[323.413688] Starting dynamic subtest: pipe-B-eDP-1
[324.659736] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.246s)
[324.669781] Starting dynamic subtest: pipe-C-eDP-1
[325.854344] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s)
[325.863445] Starting dynamic subtest: pipe-D-eDP-1
[327.099637] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[327.102651] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.954s)
[328.220334] [036/133] (693s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[328.288365] Starting subtest: basic-batch-kernel-default-cmd
[328.294085] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[328.489663] [037/133] (692s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[328.542890] Starting subtest: invalid-multi-wait-unsubmitted
[328.545617] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[328.641040] [038/133] (692s left) gem_ctx_persistence (engines-hostile-preempt)
[328.702980] Starting subtest: engines-hostile-preempt
[328.705699] Starting dynamic subtest: rcs0
[328.785177] Dynamic subtest rcs0: SUCCESS (0.081s)
[328.803261] Starting dynamic subtest: bcs0
[328.827689] Dynamic subtest bcs0: SUCCESS (0.040s)
[328.837800] Starting dynamic subtest: vcs0
[330.048549] Dynamic subtest vcs0: SUCCESS (1.217s)
[330.060456] Starting dynamic subtest: vcs1
[332.025464] Dynamic subtest vcs1: SUCCESS (1.973s)
[332.036760] Starting dynamic subtest: vecs0
[334.015658] Dynamic subtest vecs0: SUCCESS (1.985s)
[334.026446] Starting dynamic subtest: ccs0
[334.059926] Dynamic subtest ccs0: SUCCESS (0.043s)
[334.062736] Subtest engines-hostile-preempt: SUCCESS (5.352s)
[334.145060] [039/133] (687s left) kms_cursor_edge_walk (64x64-right-edge)
[334.249767] Starting subtest: 64x64-right-edge
[334.252164] Starting dynamic subtest: pipe-A-eDP-1
[337.691470] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s)
[337.701542] Starting dynamic subtest: pipe-D-eDP-1
[340.822283] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[340.824567] Subtest 64x64-right-edge: SUCCESS (6.566s)
[341.635466] [040/133] (679s left) core_auth (getclient-simple)
[341.678911] Starting subtest: getclient-simple
[341.695896] Subtest getclient-simple: SUCCESS (0.018s)
[341.785989] [041/133] (679s left) gem_exec_reloc (basic-write-read-noreloc)
[341.844216] Subtest basic-write-read-noreloc: SKIP (0.000s)
[341.901667] [042/133] (679s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[342.011770] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[342.016374] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[342.125306] [043/133] (679s left) kms_color_pipeline (plane-lut1d)
[342.226257] Starting subtest: plane-lut1d
[342.372260] Starting dynamic subtest: pipe-A-plane-0
[342.725094] Dynamic subtest pipe-A-plane-0: FAIL (0.193s)
[342.744660] Starting dynamic subtest: pipe-A-plane-1
[342.951328] Dynamic subtest pipe-A-plane-1: FAIL (0.169s)
[342.960670] Starting dynamic subtest: pipe-A-plane-2
[343.182536] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[344.152094] Starting dynamic subtest: pipe-B-plane-0
[344.633588] Dynamic subtest pipe-B-plane-0: FAIL (0.197s)
[344.642563] Starting dynamic subtest: pipe-B-plane-1
[344.983469] Dynamic subtest pipe-B-plane-1: FAIL (0.165s)
[344.992525] Starting dynamic subtest: pipe-B-plane-2
[345.319376] Dynamic subtest pipe-B-plane-2: FAIL (0.199s)
[345.969070] Starting dynamic subtest: pipe-C-plane-0
[346.502565] Dynamic subtest pipe-C-plane-0: FAIL (0.166s)
[346.512302] Starting dynamic subtest: pipe-C-plane-1
[346.930188] Dynamic subtest pipe-C-plane-1: FAIL (0.139s)
[346.940640] Starting dynamic subtest: pipe-C-plane-2
[347.337412] Dynamic subtest pipe-C-plane-2: FAIL (0.685s)
[348.190516] Starting dynamic subtest: pipe-D-plane-0
[348.843263] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[348.854351] Starting dynamic subtest: pipe-D-plane-1
[349.355915] Dynamic subtest pipe-D-plane-1: FAIL (0.750s)
[349.367467] Starting dynamic subtest: pipe-D-plane-2
[349.884168] Dynamic subtest pipe-D-plane-2: FAIL (0.169s)
[349.886341] Subtest plane-lut1d: FAIL (7.307s)
[350.364029] [044/133] (671s left) kms_universal_plane (universal-plane-pageflip-windowed)
[350.454360] Starting subtest: universal-plane-pageflip-windowed
[350.456823] Starting dynamic subtest: pipe-A-eDP-1
[351.050530] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s)
[351.064400] Starting dynamic subtest: pipe-B-eDP-1
[352.302760] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.248s)
[352.317598] Starting dynamic subtest: pipe-C-eDP-1
[353.501554] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.198s)
[353.512422] Starting dynamic subtest: pipe-D-eDP-1
[354.734567] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[354.737465] Subtest universal-plane-pageflip-windowed: SUCCESS (4.279s)
[355.585946] [045/133] (666s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[355.680430] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[355.683018] Starting dynamic subtest: A-eDP1
[359.313534] Dynamic subtest A-eDP1: SUCCESS (3.628s)
[359.323482] Starting dynamic subtest: B-eDP1
[362.498604] Dynamic subtest B-eDP1: SUCCESS (3.184s)
[362.508468] Starting dynamic subtest: C-eDP1
[365.618204] Dynamic subtest C-eDP1: SUCCESS (3.119s)
[365.627843] Starting dynamic subtest: D-eDP1
[368.745703] Dynamic subtest D-eDP1: SUCCESS (3.122s)
[368.748577] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.061s)
[369.541025] [046/133] (652s left) i915_hangman (gt-error-state-capture)
[369.616050] Starting subtest: gt-error-state-capture
[369.618366] Starting dynamic subtest: rcs0
[381.026165] Dynamic subtest rcs0: SUCCESS (11.404s)
[381.041497] Starting dynamic subtest: bcs0
[392.993176] Dynamic subtest bcs0: SUCCESS (11.958s)
[393.008910] Starting dynamic subtest: vcs0
[404.961034] Dynamic subtest vcs0: SUCCESS (11.966s)
[404.974019] Starting dynamic subtest: vcs1
[416.032730] Dynamic subtest vcs1: SUCCESS (11.075s)
[416.046131] Starting dynamic subtest: vecs0
[427.937116] Dynamic subtest vecs0: SUCCESS (11.905s)
[427.949763] Starting dynamic subtest: ccs0
[439.008245] Dynamic subtest ccs0: SUCCESS (11.069s)
[439.011063] Subtest gt-error-state-capture: SUCCESS (69.393s)
[439.094002] [047/133] (582s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[439.186949] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[439.189413] Starting dynamic subtest: pipe-A-eDP-1
[439.213416] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[439.222934] Starting dynamic subtest: pipe-B-eDP-1
[439.245774] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[439.254469] Starting dynamic subtest: pipe-C-eDP-1
[439.277351] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[439.286553] Starting dynamic subtest: pipe-D-eDP-1
[439.313588] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[439.319187] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[441.504809] [048/133] (580s left) perf_pmu (init-busy)
[441.550814] Starting subtest: init-busy
[441.553593] Starting dynamic subtest: rcs0
[441.556331] Dynamic subtest rcs0: SUCCESS (0.001s)
[441.565915] Starting dynamic subtest: bcs0
[441.568349] Dynamic subtest bcs0: SUCCESS (0.001s)
[441.577309] Starting dynamic subtest: vcs0
[441.579529] Dynamic subtest vcs0: SUCCESS (0.001s)
[441.588162] Starting dynamic subtest: vcs1
[441.590468] Dynamic subtest vcs1: SUCCESS (0.001s)
[441.599385] Starting dynamic subtest: vecs0
[441.602070] Dynamic subtest vecs0: SUCCESS (0.001s)
[441.610919] Starting dynamic subtest: ccs0
[441.613676] Dynamic subtest ccs0: SUCCESS (0.001s)
[441.616083] Subtest init-busy: SUCCESS (0.009s)
[441.661415] [049/133] (580s left) gem_workarounds (basic-read)
[441.732493] Starting subtest: basic-read
[441.749224] Subtest basic-read: SUCCESS (0.017s)
[441.869846] [050/133] (579s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[441.974578] Starting subtest: y-tiled-32bpp-rotate-90
[441.979583] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[442.079474] [051/133] (579s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[442.177744] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[442.182533] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[442.260772] [052/133] (579s left) kms_mmap_write_crc (main)
[442.349490] Starting subtest: main
[442.352208] Starting dynamic subtest: pipe-A-eDP-1
[445.854817] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.502s)
[445.857151] Subtest main: SUCCESS (3.504s)
[446.735774] [053/133] (575s left) api_intel_allocator (fork-simple-stress)
[446.786739] Starting subtest: fork-simple-stress
[452.183617] Subtest fork-simple-stress: SUCCESS (5.397s)
[452.289412] [054/133] (569s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[452.402742] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[453.493414] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.090s)
[453.651815] [055/133] (568s left) kms_joiner (basic-max-non-joiner)
[453.745491] Starting subtest: basic-max-non-joiner
[453.749383] Subtest basic-max-non-joiner: SKIP (0.000s)
[453.814195] [056/133] (568s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[453.928030] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[453.931939] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[453.997976] [057/133] (568s left) kms_content_protection (lic-type-0-hdcp14)
[454.145755] Starting subtest: lic-type-0-hdcp14
[454.149807] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[454.285402] [058/133] (567s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[454.345090] Subtest untiled-to-tiled: SKIP (0.000s)
[454.429886] [059/133] (567s left) core_getversion (all-cards)
[454.470618] Starting subtest: all-cards
[454.478413] Subtest all-cards: SUCCESS (0.012s)
[454.532563] [060/133] (567s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[454.637432] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[454.641393] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[454.747860] [061/133] (567s left) gem_userptr_blits (map-fixed-invalidate)
[454.820770] Starting subtest: map-fixed-invalidate
[454.825349] Subtest map-fixed-invalidate: SKIP (0.000s)
[454.956391] [062/133] (567s left) gen9_exec_parse (basic-rejected)
[455.026210] Subtest basic-rejected: SKIP (0.000s)
[455.095213] [063/133] (567s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[455.196352] Starting subtest: fbcpsr-suspend
[498.004070] Subtest fbcpsr-suspend: SUCCESS (12.587s)
[500.135899] [064/133] (524s left) gem_sync (basic-store-each)
[500.219731] Starting subtest: basic-store-each
[502.506509] Subtest basic-store-each: SUCCESS (2.269s)
[502.697835] [065/133] (521s left) gem_exec_balancer (full)
[502.766503] Starting subtest: full
[507.151943] Subtest full: SUCCESS (4.346s)
[507.477121] [066/133] (517s left) syncobj_wait (wait-any-interrupted)
[507.533331] Starting subtest: wait-any-interrupted
[507.633418] Subtest wait-any-interrupted: SUCCESS (0.102s)
[507.717526] [067/133] (516s left) kms_setmode (invalid-clone-exclusive-crtc)
[507.768506] Starting subtest: invalid-clone-exclusive-crtc
[507.775620] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[507.867317] [068/133] (516s left) kms_vrr (negative-basic)
[507.964258] Starting subtest: negative-basic
[507.972380] Starting dynamic subtest: pipe-A-eDP-1
[513.399369] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.402s)
[513.690448] Subtest negative-basic: SUCCESS (5.702s)
[514.544693] [069/133] (510s left) gem_userptr_blits (stress-mm)
[514.617186] Starting subtest: stress-mm
[519.993756] Subtest stress-mm: SUCCESS (5.369s)
[520.128137] [070/133] (504s left) gem_exec_big (single)
[520.191955] Starting subtest: single
[525.099861] Subtest single: SUCCESS (4.899s)
[525.346174] [071/133] (499s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[525.505264] Starting subtest: psr-modesetfrombusy
[531.637057] Subtest psr-modesetfrombusy: SUCCESS (6.131s)
[531.765740] [072/133] (493s left) kms_chamelium_color (ctm-green-to-red)
[531.857448] Subtest ctm-green-to-red: SKIP (0.000s)
[531.905993] [073/133] (492s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[532.001112] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[532.003287] Starting dynamic subtest: pipe-A-eDP-1
[532.107956] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s)
[532.118801] Starting dynamic subtest: pipe-B-eDP-1
[533.290296] Dynamic subtest pipe-B-eDP-1: SKIP (1.177s)
[533.296250] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.291s)
[534.478291] [074/133] (490s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[534.596784] Starting subtest: 2x-flip-vs-cursor-atomic
[534.601639] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[534.742937] [075/133] (490s left) sysfs_timeslice_duration (timeout)
[534.801495] Starting subtest: timeout
[534.804460] Starting dynamic subtest: vecs0
[544.269292] Dynamic subtest vecs0: SUCCESS (9.465s)
[544.281601] Starting dynamic subtest: ccs0
[545.525909] Dynamic subtest ccs0: SUCCESS (1.252s)
[545.538373] Starting dynamic subtest: vcs0
[555.277274] Dynamic subtest vcs0: SUCCESS (9.750s)
[555.290447] Starting dynamic subtest: bcs0
[555.918605] Dynamic subtest bcs0: SUCCESS (0.640s)
[555.930212] Starting dynamic subtest: rcs0
[557.130113] Dynamic subtest rcs0: SUCCESS (1.210s)
[557.140261] Starting dynamic subtest: vcs1
[566.222244] Dynamic subtest vcs1: SUCCESS (9.087s)
[566.225120] Subtest timeout: SUCCESS (31.415s)
[566.301049] [076/133] (458s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[566.402194] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[573.164288] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.764s)
[573.288877] [077/133] (451s left) kms_cursor_crc (cursor-offscreen-512x512)
[573.600253] Starting subtest: cursor-offscreen-512x512
[573.605033] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[573.746141] [078/133] (451s left) kms_pm_rpm (pm-tiling)
[575.315483] Starting subtest: pm-tiling
[575.321223] Subtest pm-tiling: SKIP (0.000s)
[576.043791] [079/133] (449s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[576.140461] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[576.145302] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[576.225742] [080/133] (448s left) gem_spin_batch (legacy-resubmit)
[576.293853] Starting subtest: legacy-resubmit
[576.296497] Starting dynamic subtest: default
[576.302269] Dynamic subtest default: SUCCESS (0.005s)
[576.313471] Starting dynamic subtest: render
[576.316283] Dynamic subtest render: SUCCESS (0.001s)
[576.326734] Starting dynamic subtest: bsd
[576.329262] Dynamic subtest bsd: SUCCESS (0.002s)
[576.339557] Starting dynamic subtest: bsd1
[576.342277] Dynamic subtest bsd1: SUCCESS (0.001s)
[576.352395] Starting dynamic subtest: bsd2
[576.355259] Dynamic subtest bsd2: SUCCESS (0.005s)
[576.365284] Starting dynamic subtest: blt
[576.368087] Dynamic subtest blt: SUCCESS (0.004s)
[576.378266] Starting dynamic subtest: vebox
[576.381021] Dynamic subtest vebox: SUCCESS (0.003s)
[576.383410] Subtest legacy-resubmit: SUCCESS (0.028s)
[576.522767] [081/133] (448s left) gem_eio (wait-wedge-10ms)
[576.746333] Starting subtest: wait-wedge-10ms
[578.324378] Subtest wait-wedge-10ms: SUCCESS (1.575s)
[578.458899] [082/133] (446s left) gem_exec_params (sol-reset-not-gen7)
[578.511093] Starting subtest: sol-reset-not-gen7
[578.513331] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[578.625249] [083/133] (446s left) gem_ctx_shared (exec-single-timeline)
[578.695332] Starting subtest: exec-single-timeline
[578.698239] Starting dynamic subtest: rcs0
[579.756230] Dynamic subtest rcs0: SUCCESS (1.059s)
[579.768073] Starting dynamic subtest: bcs0
[580.844803] Dynamic subtest bcs0: SUCCESS (1.085s)
[580.857809] Starting dynamic subtest: vcs0
[581.934194] Dynamic subtest vcs0: SUCCESS (1.086s)
[581.948551] Starting dynamic subtest: vcs1
[583.022028] Dynamic subtest vcs1: SUCCESS (1.085s)
[583.036270] Starting dynamic subtest: vecs0
[584.110071] Dynamic subtest vecs0: SUCCESS (1.084s)
[584.122490] Starting dynamic subtest: ccs0
[585.197996] Dynamic subtest ccs0: SUCCESS (1.084s)
[585.201163] Subtest exec-single-timeline: SUCCESS (6.501s)
[585.391767] [084/133] (439s left) gem_exec_params (mmapped)
[585.450218] Starting subtest: mmapped
[585.454483] Subtest mmapped: SUCCESS (0.007s)
[585.570237] [085/133] (439s left) syncobj_timeline (host-signal-ordered)
[585.641439] Starting subtest: host-signal-ordered
[585.644380] Subtest host-signal-ordered: SUCCESS (0.000s)
[585.720983] [086/133] (439s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[585.779460] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[585.782247] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[585.876283] [087/133] (439s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[585.984232] Starting subtest: primary-x-tiled-reflect-x-180
[592.939784] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.955s)
[594.123861] [088/133] (431s left) gem_mmap_offset (partial-unmap)
[594.184749] Starting subtest: partial-unmap
[594.187438] Starting dynamic subtest: smem0
[594.691043] Dynamic subtest smem0: SUCCESS (0.506s)
[594.694032] Subtest partial-unmap: SUCCESS (0.508s)
[594.810682] [089/133] (430s left) tools_test (tools_test)
[594.872067] Starting subtest: tools_test
[594.933118] Subtest tools_test: SUCCESS (0.081s)
[594.996115] [090/133] (430s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[595.099595] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[595.104348] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[595.188769] [091/133] (430s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[595.284169] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[595.310118] Starting dynamic subtest: pipe-A-plane-0
[595.756286] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[595.766142] Starting dynamic subtest: pipe-A-plane-3
[596.043772] Dynamic subtest pipe-A-plane-3: SUCCESS (0.286s)
[597.111430] Starting dynamic subtest: pipe-B-plane-0
[597.558523] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[597.568693] Starting dynamic subtest: pipe-B-plane-3
[597.825293] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s)
[598.137247] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.853s)
[598.975955] [092/133] (426s left) kms_pm_backlight (basic-brightness)
[599.066443] Starting subtest: basic-brightness
[599.115033] Starting dynamic subtest: eDP-1
[599.425327] Dynamic subtest eDP-1: SUCCESS (0.308s)
[599.428450] Subtest basic-brightness: SUCCESS (0.360s)
[600.312154] [093/133] (425s left) i915_pm_rps (thresholds-idle-park)
[600.376861] Starting subtest: thresholds-idle-park
[600.382367] Subtest thresholds-idle-park: SKIP (0.001s)
[600.489045] [094/133] (425s left) gem_exec_whisper (basic-contexts-all)
[600.551692] Starting subtest: basic-contexts-all
[612.210754] Subtest basic-contexts-all: SUCCESS (11.657s)
[612.399975] [095/133] (413s left) gem_mmap_gtt (basic-copy)
[612.454343] Subtest basic-copy: SKIP (0.000s)
[612.517355] [096/133] (413s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[612.909463] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[613.716068] [097/133] (412s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[613.781197] Starting subtest: legacy-engines-hostile-preempt
[613.784184] Starting dynamic subtest: render
[613.850715] Dynamic subtest render: SUCCESS (0.069s)
[613.864365] Starting dynamic subtest: bsd1
[615.240627] Dynamic subtest bsd1: SUCCESS (1.386s)
[615.260615] Starting dynamic subtest: bsd2
[617.226186] Dynamic subtest bsd2: SUCCESS (1.982s)
[617.239761] Starting dynamic subtest: blt
[617.296594] Dynamic subtest blt: SUCCESS (0.069s)
[617.309453] Starting dynamic subtest: vebox
[619.273877] Dynamic subtest vebox: SUCCESS (1.974s)
[619.277005] Subtest legacy-engines-hostile-preempt: SUCCESS (5.493s)
[619.370721] [098/133] (406s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[619.495284] Starting subtest: cursor-vs-flip-varying-size
[650.526009] Subtest cursor-vs-flip-varying-size: SUCCESS (31.027s)
[651.356373] [099/133] (374s left) gem_render_copy (linear-to-vebox-yf-tiled)
[651.419084] Starting subtest: linear-to-vebox-yf-tiled
[651.424473] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[651.612928] [100/133] (374s left) perf (gen8-unprivileged-single-ctx-counters)
[651.757742] Starting subtest: gen8-unprivileged-single-ctx-counters
[651.763041] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[651.803483] [101/133] (374s left) kms_cursor_crc (cursor-random-max-size)
[652.140893] Starting subtest: cursor-random-max-size
[652.147642] Subtest cursor-random-max-size: SKIP (0.000s)
[652.270205] [102/133] (373s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[652.359728] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[652.362346] Starting dynamic subtest: pipe-A-eDP-1
[652.510110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[652.523271] Starting dynamic subtest: pipe-B-eDP-1
[652.546312] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[652.556932] Starting dynamic subtest: pipe-C-eDP-1
[652.577207] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[652.587088] Starting dynamic subtest: pipe-D-eDP-1
[652.607741] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[652.610081] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.150s)
[654.815510] [103/133] (371s left) kms_psr (fbc-psr-no-drrs)
[654.903948] Starting subtest: fbc-psr-no-drrs
[654.906315] Starting dynamic subtest: eDP-1
[654.911349] Dynamic subtest eDP-1: SKIP (0.000s)
[654.916469] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[654.979862] [104/133] (371s left) gem_mmap_wc (bad-size)
[655.034961] Subtest bad-size: SKIP (0.000s)
[655.101711] [105/133] (371s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[655.205390] Starting subtest: fbc-shrfb-scaledprimary
[658.194022] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.992s)
[659.318627] [106/133] (367s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[659.420215] Starting subtest: fbc-farfromfence-mmap-gtt
[659.425205] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[659.520134] [107/133] (366s left) prime_vgem (fence-wait)
[659.596017] Starting subtest: fence-wait
[659.598940] Starting dynamic subtest: rcs0
[660.654146] Dynamic subtest rcs0: SUCCESS (1.057s)
[660.669611] Starting dynamic subtest: bcs0
[661.709074] Dynamic subtest bcs0: SUCCESS (1.054s)
[661.723314] Starting dynamic subtest: vcs0
[662.751550] Dynamic subtest vcs0: SUCCESS (1.041s)
[662.765100] Starting dynamic subtest: vcs1
[663.796821] Dynamic subtest vcs1: SUCCESS (1.044s)
[663.810119] Starting dynamic subtest: vecs0
[664.837499] Dynamic subtest vecs0: SUCCESS (1.039s)
[664.851343] Starting dynamic subtest: ccs0
[665.879925] Dynamic subtest ccs0: SUCCESS (1.040s)
[665.883027] Subtest fence-wait: SUCCESS (6.284s)
[666.003898] [108/133] (360s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[666.141185] Starting subtest: 4-tiled-32bpp-rotate-90
[666.174453] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.029s)
[666.290972] [109/133] (360s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[666.399258] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[666.404393] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[666.489013] [110/133] (360s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[666.553383] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[666.619640] [111/133] (359s left) kms_fbcon_fbt (psr)
[666.677401] Starting subtest: psr
[674.039443] Subtest psr: SUCCESS (7.359s)
[674.120915] [112/133] (352s left) gem_huc_copy (huc-copy)
[674.175386] Starting subtest: huc-copy
[674.180703] Subtest huc-copy: SUCCESS (0.005s)
[674.304537] [113/133] (352s left) gem_exec_reloc (basic-cpu-gtt)
[674.368374] Subtest basic-cpu-gtt: SKIP (0.000s)
[674.457958] [114/133] (352s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[674.561403] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[674.567083] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[674.640128] [115/133] (352s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[674.743067] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[674.748115] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[674.851908] [116/133] (351s left) kms_flip_event_leak (basic)
[674.949221] Starting subtest: basic
[674.951628] Starting dynamic subtest: pipe-A-eDP-1
[675.437431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.485s)
[675.448124] Starting dynamic subtest: pipe-B-eDP-1
[676.582216] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.140s)
[676.592863] Starting dynamic subtest: pipe-C-eDP-1
[677.687240] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[677.698331] Starting dynamic subtest: pipe-D-eDP-1
[678.828450] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[678.831442] Subtest basic: SUCCESS (3.879s)
[679.692018] [117/133] (347s left) gem_close_race (multigpu-basic-process)
[679.760338] Starting subtest: multigpu-basic-process
[679.766111] Subtest multigpu-basic-process: SKIP (0.000s)
[679.992969] [118/133] (346s left) perf (i915-ref-count)
[680.069999] Starting subtest: i915-ref-count
[680.110444] Subtest i915-ref-count: SUCCESS (0.040s)
[680.168897] [119/133] (346s left) gem_eio (in-flight-suspend)
[680.393206] Starting subtest: in-flight-suspend
[723.723038] Subtest in-flight-suspend: SUCCESS (13.959s)
[723.865238] [120/133] (303s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[723.983609] Starting subtest: modeset-atomic-cursor-hotspot
[723.989352] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[724.134979] [121/133] (302s left) kms_draw_crc (draw-method-pwrite)
[724.233722] Starting subtest: draw-method-pwrite
[724.236139] Starting dynamic subtest: xrgb8888-untiled
[724.842742] Dynamic subtest xrgb8888-untiled: SUCCESS (0.600s)
[724.853733] Starting dynamic subtest: rgb565-untiled
[725.338340] Dynamic subtest rgb565-untiled: SUCCESS (0.487s)
[725.349247] Starting dynamic subtest: xrgb2101010-untiled
[725.902534] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[725.913539] Starting dynamic subtest: xbgr16161616f-untiled
[726.690503] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.777s)
[726.701764] Starting dynamic subtest: xrgb8888-xtiled
[728.466410] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.754s)
[728.476986] Starting dynamic subtest: rgb565-xtiled
[729.576629] Dynamic subtest rgb565-xtiled: SUCCESS (1.099s)
[729.587751] Starting dynamic subtest: xrgb2101010-xtiled
[731.368540] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.777s)
[731.379506] Starting dynamic subtest: xbgr16161616f-xtiled
[734.687614] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.299s)
[734.698355] Starting dynamic subtest: xrgb8888-4tiled
[735.792376] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s)
[735.803246] Starting dynamic subtest: rgb565-4tiled
[736.361388] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s)
[736.372409] Starting dynamic subtest: xrgb2101010-4tiled
[737.499165] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.133s)
[737.509897] Starting dynamic subtest: xbgr16161616f-4tiled
[740.519588] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.010s)
[740.522353] Subtest draw-method-pwrite: SUCCESS (16.169s)
[740.613134] [122/133] (286s left) kms_busy (extended-pageflip-hang-oldfb)
[740.718483] Starting subtest: extended-pageflip-hang-oldfb
[740.721139] Starting dynamic subtest: pipe-A
[741.132634] Dynamic subtest pipe-A: SUCCESS (0.414s)
[741.144298] Starting dynamic subtest: pipe-D
[742.265273] Dynamic subtest pipe-D: SUCCESS (1.127s)
[742.267977] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.546s)
[743.130425] [123/133] (283s left) gem_exec_schedule (preempt-queue-contexts)
[743.217461] Subtest preempt-queue-contexts: SKIP (0.000s)
[743.520761] [124/133] (283s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[743.609483] Starting subtest: psr-1p-primscrn-spr-indfb-move
[751.215572] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.598s)
[751.319131] [125/133] (275s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[751.417082] Starting subtest: plane-upscale-20x20-with-pixel-format
[751.419520] Starting dynamic subtest: pipe-A
[752.465466] Dynamic subtest pipe-A: SUCCESS (1.050s)
[752.475470] Starting dynamic subtest: pipe-B
[754.546567] Dynamic subtest pipe-B: SUCCESS (2.079s)
[754.556686] Starting dynamic subtest: pipe-C
[755.741456] Dynamic subtest pipe-C: SUCCESS (1.194s)
[755.752446] Starting dynamic subtest: pipe-D
[756.886298] Dynamic subtest pipe-D: SUCCESS (1.144s)
[756.888746] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.471s)
[758.079086] [126/133] (269s left) gem_exec_schedule (promotion)
[758.155514] Starting subtest: promotion
[758.158349] Starting dynamic subtest: rcs0
[758.261439] Dynamic subtest rcs0: SUCCESS (0.117s)
[758.274596] Starting dynamic subtest: vcs0
[758.354513] Dynamic subtest vcs0: SUCCESS (0.092s)
[758.367696] Starting dynamic subtest: vcs1
[758.450300] Dynamic subtest vcs1: SUCCESS (0.095s)
[758.464031] Starting dynamic subtest: vecs0
[758.534647] Dynamic subtest vecs0: SUCCESS (0.084s)
[758.548152] Starting dynamic subtest: ccs0
[758.641214] Dynamic subtest ccs0: SUCCESS (0.105s)
[758.643945] Subtest promotion: SUCCESS (0.498s)
[759.716593] [127/133] (267s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[759.817180] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[759.822108] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[759.923552] [128/133] (267s left) kms_lease (empty-lease)
[760.016547] Starting subtest: empty-lease
[760.019735] Starting dynamic subtest: pipe-A-eDP-1
[760.022622] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[760.036381] Starting dynamic subtest: pipe-B-eDP-1
[760.038957] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[760.049500] Starting dynamic subtest: pipe-C-eDP-1
[760.052161] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[760.062420] Starting dynamic subtest: pipe-D-eDP-1
[760.065167] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[760.067528] Subtest empty-lease: SUCCESS (0.009s)
[760.128074] [129/133] (267s left) i915_drm_fdinfo (memory-info-purgeable)
[760.175371] Starting subtest: memory-info-purgeable
[760.178003] Starting dynamic subtest: smem0
[763.070084] Dynamic subtest smem0: SUCCESS (2.898s)
[763.072657] Subtest memory-info-purgeable: SUCCESS (2.899s)
[763.148555] [130/133] (264s left) i915_query (query-topology-known-pci-ids)
[763.209514] Starting subtest: query-topology-known-pci-ids
[763.214064] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[763.309769] [131/133] (264s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[763.406415] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[763.410547] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[763.508094] [132/133] (264s left) template (b)
[763.567341] Starting subtest: B
[763.569457] Subtest B: SUCCESS (0.000s)
[763.674632] [133/133] (263s left) kms_flip (2x-plain-flip-fb-recreate)
[763.770288] Starting subtest: 2x-plain-flip-fb-recreate
[763.778888] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[763.863411] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_addfb_basic
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_atomic
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: gem_vm_create
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gem_workarounds
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: syncobj_eventfd
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: i915_pm_rpm
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_lmem_swapping
results: parsing output: 26/ for test: kms_atomic_transition
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_busy
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_flush
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: core_auth
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_color_pipeline
results: parsing output: 43/ for test: kms_universal_plane
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: gem_workarounds
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_mmap_write_crc
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: gem_set_tiling_vs_blt
results: parsing output: 58/ for test: core_getversion
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_sync
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_setmode
results: parsing output: 67/ for test: kms_vrr
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: gem_exec_big
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_chamelium_color
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: sysfs_timeslice_duration
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_spin_batch
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: gem_ctx_shared
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_rotation_crc
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: tools_test
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_pm_backlight
results: parsing output: 92/ for test: i915_pm_rps
results: parsing output: 93/ for test: gem_exec_whisper
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: kms_chamelium_edid
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: prime_vgem
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_fenced_exec_thrash
results: parsing output: 110/ for test: kms_fbcon_fbt
results: parsing output: 111/ for test: gem_huc_copy
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_flip_event_leak
results: parsing output: 116/ for test: gem_close_race
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_draw_crc
results: parsing output: 121/ for test: kms_busy
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_lease
results: parsing output: 128/ for test: i915_drm_fdinfo
results: parsing output: 129/ for test: i915_query
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: template
results: parsing output: 132/ for test: kms_flip
Done.