[57.401942] Initializing watchdogs [57.402016] /dev/watchdog0 [57.415382] [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] [57.419745] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.421836] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.424884] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [57.566068] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [57.570577] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [57.688154] [002/131] (960s left) gem_exec_fence (submit3) [57.868490] Starting subtest: submit3 [57.872772] Subtest submit3: SKIP (0.000s) [60.051175] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [60.054617] [003/131] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [60.163311] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [60.167721] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [60.292958] [004/131] (957s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [60.398452] Starting subtest: fbc-rgb101010-draw-mmap-wc [64.932236] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.558s) [66.078273] [005/131] (951s left) gem_exec_balancer (noheartbeat) [66.334707] Starting subtest: noheartbeat [66.339828] Subtest noheartbeat: SKIP (0.001s) [66.460250] [006/131] (951s left) kms_chamelium_color (ctm-blue-to-red) [66.559339] Subtest ctm-blue-to-red: SKIP (0.000s) [66.602110] [007/131] (951s left) gem_workarounds (suspend-resume) [66.668470] Starting subtest: suspend-resume [83.201539] Subtest suspend-resume: SUCCESS (5.464s) [83.375931] [008/131] (934s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [83.490827] Starting subtest: planes-downscale-factor-0-75-unity-scaling [83.493149] Starting dynamic subtest: pipe-A [83.554971] Dynamic subtest pipe-A: SUCCESS (0.066s) [83.568038] Starting dynamic subtest: pipe-B [84.662771] Dynamic subtest pipe-B: SUCCESS (1.148s) [84.673208] Starting dynamic subtest: pipe-C [85.747811] Dynamic subtest pipe-C: SUCCESS (1.122s) [85.757098] Starting dynamic subtest: pipe-D [86.841678] Dynamic subtest pipe-D: SUCCESS (1.126s) [86.844015] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.464s) [87.991167] [009/131] (930s left) gem_pxp (create-regular-buffer) [88.111074] Starting subtest: create-regular-buffer [88.113421] Subtest create-regular-buffer: SUCCESS (0.000s) [88.237925] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5) [88.309713] Starting subtest: rel-constants-invalid-rel-gen5 [88.312048] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [88.449434] [011/131] (929s left) gem_exec_nop (basic-series) [88.535869] Starting subtest: basic-series [104.994628] Subtest basic-series: SUCCESS (16.616s) [105.247462] [012/131] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [105.367321] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [105.371886] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [105.548053] [013/131] (912s left) kms_psr (fbc-psr-primary-page-flip) [105.652968] Starting subtest: fbc-psr-primary-page-flip [105.655100] Starting dynamic subtest: eDP-1 [105.659071] Dynamic subtest eDP-1: SKIP (0.000s) [105.663049] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [105.749366] [014/131] (912s left) i915_pm_rps (engine-order) [105.807581] Starting subtest: engine-order [110.871716] Subtest engine-order: SUCCESS (5.072s) [111.036882] [015/131] (907s left) gem_softpin (evict-active) [111.107372] Starting subtest: evict-active [111.116292] Subtest evict-active: SUCCESS (0.009s) [111.278555] [016/131] (907s left) syncobj_timeline (wait-delayed-signal) [111.335074] Starting subtest: wait-delayed-signal [111.437736] Subtest wait-delayed-signal: SUCCESS (0.103s) [111.540881] [017/131] (907s left) kms_panel_fitting (atomic-fastset) [111.638338] Starting subtest: atomic-fastset [111.640777] Starting dynamic subtest: pipe-A-eDP-1 [111.789095] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.153s) [111.799738] Starting dynamic subtest: pipe-B-eDP-1 [113.045396] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s) [113.056892] Starting dynamic subtest: pipe-C-eDP-1 [114.231353] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.185s) [114.241885] Starting dynamic subtest: pipe-D-eDP-1 [115.368299] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s) [115.370792] Subtest atomic-fastset: SUCCESS (3.733s) [116.632119] [018/131] (902s left) kms_big_fb (x-tiled-16bpp-rotate-270) [116.740950] Starting subtest: x-tiled-16bpp-rotate-270 [116.759818] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [116.932711] [019/131] (901s left) api_intel_bb (render-ccs) [116.999149] Starting subtest: render-ccs [117.350946] Subtest render-ccs: SUCCESS (0.351s) [117.487084] [020/131] (901s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [117.583191] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [117.585481] Starting dynamic subtest: pipe-A-eDP-1 [117.608193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [117.618177] Starting dynamic subtest: pipe-B-eDP-1 [117.639073] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [117.647551] Starting dynamic subtest: pipe-C-eDP-1 [117.668745] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [117.678480] Starting dynamic subtest: pipe-D-eDP-1 [117.700211] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [117.704818] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [119.898134] [021/131] (898s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [119.956302] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [120.064971] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s) [120.164777] [022/131] (898s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [120.273001] Starting subtest: psr-2p-primscrn-cur-indfb-move [120.277454] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [120.415801] [023/131] (898s left) gem_lmem_swapping (heavy-multi) [120.460944] Subtest heavy-multi: SKIP (0.000s) [120.509275] [024/131] (898s left) kms_async_flips (test-cursor) [120.604063] Starting subtest: test-cursor [120.608436] Subtest test-cursor: SKIP (0.000s) [121.832587] [025/131] (897s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [126.871079] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [126.873469] Starting dynamic subtest: pipe-A-eDP-1 [127.675358] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s) [127.686072] Starting dynamic subtest: pipe-B-eDP-1 [128.805831] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s) [128.810359] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.934s) [130.017457] [026/131] (888s left) kms_plane_multiple (2x-tiling-4) [130.117310] Starting subtest: 2x-tiling-4 [130.121581] Subtest 2x-tiling-4: SKIP (0.000s) [130.210459] [027/131] (888s left) gem_ctx_param (invalid-param-set) [130.269197] Starting subtest: invalid-param-set [130.271569] Subtest invalid-param-set: SUCCESS (0.000s) [130.366026] [028/131] (888s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [130.458221] Starting subtest: bad-pixel-format-y-tiled-ccs [130.460567] Starting dynamic subtest: pipe-A-eDP-1 [130.482209] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [130.491477] Starting dynamic subtest: pipe-B-eDP-1 [130.512967] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [130.521186] Starting dynamic subtest: pipe-C-eDP-1 [130.543070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [130.551176] Starting dynamic subtest: pipe-D-eDP-1 [130.573479] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [130.577906] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [132.688433] [029/131] (886s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [132.793572] Starting subtest: plane-downscale-factor-0-5-with-modifiers [132.795705] Starting dynamic subtest: pipe-A [132.812764] Dynamic subtest pipe-A: SKIP (0.016s) [132.822871] Starting dynamic subtest: pipe-B [132.843469] Dynamic subtest pipe-B: SKIP (0.029s) [132.852127] Starting dynamic subtest: pipe-C [132.872110] Dynamic subtest pipe-C: SKIP (0.029s) [132.880641] Starting dynamic subtest: pipe-D [132.900430] Dynamic subtest pipe-D: SKIP (0.029s) [132.904720] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.104s) [133.041251] [030/131] (886s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [133.096450] Starting subtest: multi-wait-all-available-submitted-signaled [133.098842] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s) [133.225007] [031/131] (885s left) perf (missing-sample-flags) [133.374407] Starting subtest: missing-sample-flags [133.376668] Subtest missing-sample-flags: SUCCESS (0.000s) [133.417666] [032/131] (885s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [133.513503] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [139.572407] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.062s) [140.802097] [033/131] (878s left) kms_pm_rpm (system-suspend-idle) [142.355110] Starting subtest: system-suspend-idle [162.855702] Subtest system-suspend-idle: SUCCESS (4.821s) [163.249899] [034/131] (856s left) kms_vblank (wait-forked) [163.358065] Starting subtest: wait-forked [163.360705] Starting dynamic subtest: pipe-A-eDP-1 [165.129044] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.814s) [165.144353] Starting dynamic subtest: pipe-D-eDP-1 [167.605632] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s) [167.608211] Subtest wait-forked: SUCCESS (4.342s) [168.490497] [035/131] (850s left) kms_big_fb (y-tiled-32bpp-rotate-0) [168.592150] Starting subtest: y-tiled-32bpp-rotate-0 [168.597381] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [168.721303] [036/131] (850s left) kms_pipe_crc_basic (read-crc) [168.811298] Starting subtest: read-crc [168.814139] Starting dynamic subtest: pipe-A-eDP-1 [169.508351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s) [169.518753] Starting dynamic subtest: pipe-B-eDP-1 [170.905627] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.411s) [170.916420] Starting dynamic subtest: pipe-C-eDP-1 [172.207672] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.315s) [172.221254] Starting dynamic subtest: pipe-D-eDP-1 [173.518288] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s) [173.521189] Subtest read-crc: SUCCESS (4.754s) [174.368719] [037/131] (845s left) kms_cursor_legacy (single-move) [174.515701] Starting subtest: single-move [174.518345] Starting dynamic subtest: pipe-A [179.870935] Dynamic subtest pipe-A: SUCCESS (5.380s) [179.881575] Starting dynamic subtest: pipe-B [185.238458] Dynamic subtest pipe-B: SUCCESS (5.380s) [185.248944] Starting dynamic subtest: pipe-C [190.611409] Dynamic subtest pipe-C: SUCCESS (5.380s) [190.622627] Starting dynamic subtest: pipe-D [195.993709] Dynamic subtest pipe-D: SUCCESS (5.380s) [196.004789] Starting dynamic subtest: all-pipes [201.385362] Dynamic subtest all-pipes: SUCCESS (5.388s) [201.388108] Subtest single-move: SUCCESS (26.917s) [201.553259] [038/131] (817s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [206.585378] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [206.591006] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [207.461602] [039/131] (812s left) gem_unref_active_buffers [207.703471] [040/131] (811s left) kms_psr (fbc-psr2-primary-mmap-gtt) [207.796871] Starting subtest: fbc-psr2-primary-mmap-gtt [207.799268] Starting dynamic subtest: eDP-1 [207.804631] Dynamic subtest eDP-1: SKIP (0.000s) [207.809369] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [207.893946] [041/131] (811s left) syncobj_wait (invalid-signal-zero-handles) [207.952010] Starting subtest: invalid-signal-zero-handles [207.954629] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [208.079370] [042/131] (811s left) gen9_exec_parse (bb-oversize) [208.142741] Subtest bb-oversize: SKIP (0.000s) [208.233481] [043/131] (811s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [208.291877] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [208.395549] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s) [208.494631] [044/131] (811s left) gem_exec_reloc (basic-write-cpu-noreloc) [208.566874] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [208.656659] [045/131] (811s left) gem_mmap_offset (bad-flags) [208.721624] Starting subtest: bad-flags [208.724169] Subtest bad-flags: SUCCESS (0.000s) [208.860218] [046/131] (810s left) kms_cursor_legacy (cursor-vs-flip-legacy) [208.977838] Starting subtest: cursor-vs-flip-legacy [238.233598] Subtest cursor-vs-flip-legacy: SUCCESS (29.259s) [239.094722] [047/131] (780s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [239.189272] Starting subtest: sprite-rotation-90-pos-100-0 [239.194609] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [239.284614] [048/131] (780s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [239.388140] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [240.499815] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.112s) [240.699650] [049/131] (779s left) gem_create (busy-create) [240.753038] Starting subtest: busy-create [240.754998] Starting dynamic subtest: smem0 [274.759184] Dynamic subtest smem0: SUCCESS (34.006s) [274.762401] Subtest busy-create: SUCCESS (34.008s) [274.974995] [050/131] (744s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [275.085973] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [279.251357] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.168s) [280.383674] [051/131] (739s left) perf (invalid-open-flags) [280.505553] Starting subtest: invalid-open-flags [280.508522] Subtest invalid-open-flags: SUCCESS (0.000s) [280.548950] [052/131] (739s left) perf (oa-formats) [280.645897] Starting subtest: oa-formats [280.648488] Starting dynamic subtest: 0-rcs0 [280.660025] Dynamic subtest 0-rcs0: SUCCESS (0.015s) [280.669827] Starting dynamic subtest: 1-vcs1 [280.688227] Dynamic subtest 1-vcs1: SUCCESS (0.027s) [280.691241] Subtest oa-formats: SUCCESS (0.043s) [280.737600] [053/131] (739s left) kms_big_fb (4-tiled-8bpp-rotate-270) [280.839019] Starting subtest: 4-tiled-8bpp-rotate-270 [280.859847] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [281.031306] [054/131] (739s left) kms_cursor_crc (cursor-onscreen-64x21) [281.213861] Starting subtest: cursor-onscreen-64x21 [281.260390] Subtest cursor-onscreen-64x21: SKIP (0.040s) [281.511458] [055/131] (738s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [281.600385] Starting subtest: primary-4-tiled-reflect-x-180 [289.074049] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.475s) [290.334389] [056/131] (729s left) kms_cursor_crc (cursor-onscreen-256x256) [290.568964] Starting subtest: cursor-onscreen-256x256 [290.571347] Starting dynamic subtest: pipe-A-eDP-1 [292.668650] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.097s) [292.698148] Starting dynamic subtest: pipe-D-eDP-1 [295.487863] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.796s) [295.489891] Subtest cursor-onscreen-256x256: SUCCESS (4.917s) [296.308683] [057/131] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [296.422190] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [303.738934] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.321s) [303.933585] [058/131] (716s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [304.033875] Starting subtest: async-flip-with-page-flip-events-tiled [304.405057] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [307.163934] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.759s) [307.174526] Starting dynamic subtest: pipe-A-eDP-1-4 [309.361790] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.197s) [309.371812] Starting dynamic subtest: pipe-A-eDP-1-4 [311.370618] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s) [311.382139] Starting dynamic subtest: pipe-A-eDP-1-x [313.571615] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s) [313.946032] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [316.694520] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.757s) [316.704556] Starting dynamic subtest: pipe-B-eDP-1-4 [318.891694] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s) [318.903084] Starting dynamic subtest: pipe-B-eDP-1-4 [320.901363] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [320.914079] Starting dynamic subtest: pipe-B-eDP-1-x [323.101567] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s) [323.469646] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [326.214537] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.753s) [326.227611] Starting dynamic subtest: pipe-C-eDP-1-4 [328.389304] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [328.401413] Starting dynamic subtest: pipe-C-eDP-1-4 [330.398917] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [330.409620] Starting dynamic subtest: pipe-C-eDP-1-x [332.577156] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [332.940206] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [335.734362] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.802s) [335.745429] Starting dynamic subtest: pipe-D-eDP-1-4 [337.919385] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s) [337.929300] Starting dynamic subtest: pipe-D-eDP-1-4 [339.929157] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [339.941396] Starting dynamic subtest: pipe-D-eDP-1-x [342.107879] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [342.110967] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.083s) [343.344888] [059/131] (677s left) perf (polling) [343.462012] Starting subtest: polling [343.464404] Starting dynamic subtest: 0-rcs0 [353.492613] Dynamic subtest 0-rcs0: SUCCESS (10.032s) [353.501542] Starting dynamic subtest: 1-vcs0 [363.515465] Dynamic subtest 1-vcs0: SUCCESS (10.023s) [363.518219] Subtest polling: SUCCESS (20.058s) [363.565998] [060/131] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [363.675091] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [363.680157] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [363.810587] [061/131] (656s left) syncobj_timeline (reset-signaled) [363.875243] Starting subtest: reset-signaled [363.878163] Subtest reset-signaled: SUCCESS (0.000s) [364.006013] [062/131] (656s left) kms_rmfb (rmfb-ioctl) [364.100812] Starting subtest: rmfb-ioctl [364.103606] Starting dynamic subtest: pipe-A-eDP-1 [364.204413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [364.216175] Starting dynamic subtest: pipe-B-eDP-1 [365.366625] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.161s) [365.378055] Starting dynamic subtest: pipe-C-eDP-1 [366.490237] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s) [366.503730] Starting dynamic subtest: pipe-D-eDP-1 [367.618701] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s) [367.621656] Subtest rmfb-ioctl: SUCCESS (3.523s) [368.872163] [063/131] (651s left) gem_userptr_blits (create-destroy-sync) [368.941998] Starting subtest: create-destroy-sync [373.970413] Subtest create-destroy-sync: SUCCESS (5.011s) [374.117398] [064/131] (646s left) gem_exec_reloc (basic-gtt-cpu-active) [374.174673] Subtest basic-gtt-cpu-active: SKIP (0.000s) [374.251641] [065/131] (646s left) api_intel_allocator (execbuf-with-allocator) [374.315243] Starting subtest: execbuf-with-allocator [374.327197] Subtest execbuf-with-allocator: SUCCESS (0.013s) [374.498745] [066/131] (646s left) kms_lease (cursor-implicit-plane) [374.598778] Starting subtest: cursor-implicit-plane [374.601263] Starting dynamic subtest: pipe-A-eDP-1 [375.046214] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s) [375.056208] Starting dynamic subtest: pipe-B-eDP-1 [376.156374] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.112s) [376.167288] Starting dynamic subtest: pipe-C-eDP-1 [377.258987] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.101s) [377.272198] Starting dynamic subtest: pipe-D-eDP-1 [378.406345] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s) [378.409184] Subtest cursor-implicit-plane: SUCCESS (3.810s) [379.288172] [067/131] (641s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [379.409679] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [379.414235] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [379.580619] [068/131] (641s left) syncobj_wait (invalid-signal-illegal-handle) [379.647356] Starting subtest: invalid-signal-illegal-handle [379.649835] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [379.776689] [069/131] (641s left) kms_psr (psr-primary-blt) [379.864517] Starting subtest: psr-primary-blt [379.866771] Starting dynamic subtest: eDP-1 [381.567481] Dynamic subtest eDP-1: SUCCESS (1.704s) [381.570468] Subtest psr-primary-blt: SUCCESS (1.705s) [382.453773] [070/131] (638s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [382.560878] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [382.563239] Starting dynamic subtest: pipe-A-eDP-1 [382.630063] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [382.640350] Starting dynamic subtest: pipe-B-eDP-1 [382.699842] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [382.708722] Starting dynamic subtest: pipe-C-eDP-1 [382.769098] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [382.777893] Starting dynamic subtest: pipe-D-eDP-1 [382.839369] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [382.844895] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [384.744010] [071/131] (636s left) kms_psr (pr-primary-blt) [384.833962] Starting subtest: pr-primary-blt [384.839081] Subtest pr-primary-blt: SKIP (0.000s) [384.929971] [072/131] (635s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [385.034576] Starting subtest: psr-2p-primscrn-spr-indfb-move [385.039276] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [385.146762] [073/131] (635s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [385.241828] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [385.244001] Starting dynamic subtest: pipe-A-default-mode [386.374948] Dynamic subtest pipe-A-default-mode: SKIP (1.130s) [386.380001] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.132s) [386.566873] [074/131] (634s left) gem_exec_schedule (u-semaphore-noskip) [386.636164] Starting subtest: u-semaphore-noskip [387.036040] Subtest u-semaphore-noskip: SUCCESS (0.407s) [387.428427] [075/131] (633s left) i915_drm_fdinfo (memory-info-idle) [387.471451] Starting subtest: memory-info-idle [387.474367] Starting dynamic subtest: smem0 [387.543521] Dynamic subtest smem0: SUCCESS (0.076s) [387.546366] Subtest memory-info-idle: SUCCESS (0.076s) [387.642328] [076/131] (633s left) i915_selftest (live) [389.664338] Starting subtest: live [389.667119] Starting dynamic subtest: sanitycheck [393.761071] Dynamic subtest sanitycheck: SUCCESS (4.094s) [393.771655] Starting dynamic subtest: uncore [397.847292] Dynamic subtest uncore: SUCCESS (4.082s) [397.857760] Starting dynamic subtest: workarounds [402.446662] Dynamic subtest workarounds: SUCCESS (4.595s) [402.456386] Starting dynamic subtest: gt_engines [408.404352] Dynamic subtest gt_engines: SUCCESS (5.953s) [408.413887] Starting dynamic subtest: gt_timelines [425.546730] Dynamic subtest gt_timelines: SUCCESS (17.136s) [425.556815] Starting dynamic subtest: gt_contexts [431.309880] Dynamic subtest gt_contexts: SUCCESS (5.759s) [431.320305] Starting dynamic subtest: gt_lrc [437.076897] Dynamic subtest gt_lrc: SUCCESS (5.764s) [437.092288] Starting dynamic subtest: gt_mocs [441.599978] Dynamic subtest gt_mocs: SUCCESS (4.520s) [441.609813] Starting dynamic subtest: gt_pm [447.858821] Dynamic subtest gt_pm: SUCCESS (6.255s) [447.868470] Starting dynamic subtest: gt_heartbeat [451.963092] Dynamic subtest gt_heartbeat: SUCCESS (4.098s) [451.972869] Starting dynamic subtest: gt_tlb [462.673360] Dynamic subtest gt_tlb: SUCCESS (10.711s) [462.683602] Starting dynamic subtest: requests [475.672790] Dynamic subtest requests: SUCCESS (12.998s) [475.683303] Starting dynamic subtest: migrate [483.138940] Dynamic subtest migrate: SUCCESS (7.464s) [483.149202] Starting dynamic subtest: active [487.299431] Dynamic subtest active: SUCCESS (4.159s) [487.309228] Starting dynamic subtest: objects [492.006768] Dynamic subtest objects: SUCCESS (4.705s) [492.017197] Starting dynamic subtest: mman [496.774593] Dynamic subtest mman: SUCCESS (4.766s) [496.784134] Starting dynamic subtest: dmabuf [501.012056] Dynamic subtest dmabuf: SUCCESS (4.236s) [501.022130] Starting dynamic subtest: vma [506.714117] Dynamic subtest vma: SUCCESS (5.700s) [506.723922] Starting dynamic subtest: coherency [513.081812] Dynamic subtest coherency: SUCCESS (6.366s) [513.091524] Starting dynamic subtest: gtt [524.705339] Dynamic subtest gtt: SUCCESS (11.623s) [524.715344] Starting dynamic subtest: gem [531.625465] Dynamic subtest gem: SUCCESS (6.918s) [531.633965] Starting dynamic subtest: evict [538.576773] Dynamic subtest evict: SUCCESS (6.950s) [538.586831] Starting dynamic subtest: hugepages [548.907682] Dynamic subtest hugepages: SUCCESS (10.331s) [548.917188] Starting dynamic subtest: gem_contexts [577.141179] Dynamic subtest gem_contexts: SUCCESS (28.235s) [577.151291] Starting dynamic subtest: client [581.341593] Dynamic subtest client: SUCCESS (4.200s) [581.351646] Starting dynamic subtest: gem_migrate [585.436379] Dynamic subtest gem_migrate: SUCCESS (4.094s) [585.446299] Starting dynamic subtest: reset [589.615034] Dynamic subtest reset: SUCCESS (4.177s) [589.625483] Starting dynamic subtest: memory_region [593.800027] Dynamic subtest memory_region: SUCCESS (4.184s) [593.810375] Starting dynamic subtest: hangcheck [608.131353] Dynamic subtest hangcheck: SUCCESS (14.333s) [608.142037] Starting dynamic subtest: execlists [612.274152] Dynamic subtest execlists: SUCCESS (4.140s) [612.284279] Starting dynamic subtest: ring_submission [616.430610] Dynamic subtest ring_submission: SUCCESS (4.157s) [616.447006] Starting dynamic subtest: perf [620.720609] Dynamic subtest perf: SUCCESS (4.288s) [620.736693] Starting dynamic subtest: slpc [634.249839] Dynamic subtest slpc: SUCCESS (13.529s) [634.260190] Starting dynamic subtest: guc [639.601481] Dynamic subtest guc: SUCCESS (5.351s) [639.611782] Starting dynamic subtest: guc_multi_lrc [643.693624] Dynamic subtest guc_multi_lrc: SUCCESS (4.089s) [643.703432] Starting dynamic subtest: guc_hang [648.597785] Dynamic subtest guc_hang: SUCCESS (4.898s) [648.607991] Starting dynamic subtest: late_gt_pm [652.831945] Dynamic subtest late_gt_pm: SUCCESS (4.228s) [652.835150] Subtest live: SUCCESS (263.160s) [652.867938] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [652.868641] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [652.871818] [077/131] (368s left) gem_userptr_blits (nohangcheck) [655.815242] Starting subtest: nohangcheck [656.053343] Subtest nohangcheck: SUCCESS (0.234s) [656.167718] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [656.168857] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [656.173410] [078/131] (364s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [656.277210] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [656.280003] Starting dynamic subtest: pipe-A-eDP-1 [657.101903] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s) [657.110378] Starting dynamic subtest: pipe-B-eDP-1 [658.692747] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.586s) [658.701957] Starting dynamic subtest: pipe-C-eDP-1 [660.275097] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.578s) [660.284353] Starting dynamic subtest: pipe-D-eDP-1 [661.782044] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.504s) [661.784598] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.493s) [662.980831] [079/131] (358s left) gem_softpin (allocator-nopin) [663.042358] Starting subtest: allocator-nopin [663.129269] Subtest allocator-nopin: SUCCESS (0.087s) [663.296370] [080/131] (357s left) kms_draw_crc (draw-method-pwrite) [663.401125] Starting subtest: draw-method-pwrite [663.403707] Starting dynamic subtest: xrgb8888-untiled [663.943098] Dynamic subtest xrgb8888-untiled: SUCCESS (0.545s) [663.951832] Starting dynamic subtest: rgb565-untiled [664.388040] Dynamic subtest rgb565-untiled: SUCCESS (0.444s) [664.397504] Starting dynamic subtest: xrgb2101010-untiled [664.898967] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.510s) [664.909046] Starting dynamic subtest: xbgr16161616f-untiled [665.633281] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.733s) [665.642780] Starting dynamic subtest: xrgb8888-xtiled [667.334032] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.700s) [667.342530] Starting dynamic subtest: rgb565-xtiled [668.367824] Dynamic subtest rgb565-xtiled: SUCCESS (1.032s) [668.377385] Starting dynamic subtest: xrgb2101010-xtiled [670.057893] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.688s) [670.067422] Starting dynamic subtest: xbgr16161616f-xtiled [673.248258] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.188s) [673.257395] Starting dynamic subtest: xrgb8888-4tiled [674.306220] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.055s) [674.315475] Starting dynamic subtest: rgb565-4tiled [674.860155] Dynamic subtest rgb565-4tiled: SUCCESS (0.553s) [674.869399] Starting dynamic subtest: xrgb2101010-4tiled [675.894030] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.033s) [675.907058] Starting dynamic subtest: xbgr16161616f-4tiled [678.750874] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.854s) [678.753461] Subtest draw-method-pwrite: SUCCESS (15.345s) [678.880229] [081/131] (342s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [678.987004] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [678.991997] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [679.120097] [082/131] (342s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [679.227661] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [679.232599] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [679.350031] [083/131] (342s left) syncobj_timeline (host-signal-points) [679.411080] Starting subtest: host-signal-points [679.413753] Subtest host-signal-points: SUCCESS (0.004s) [679.541700] [084/131] (341s left) gem_mmap_gtt (basic-small-bo) [679.604224] Subtest basic-small-bo: SKIP (0.000s) [679.667732] [085/131] (341s left) perf_pmu (semaphore-wait-idle) [679.708095] Starting subtest: semaphore-wait-idle [679.709784] Starting dynamic subtest: rcs0 [680.222386] Dynamic subtest rcs0: SUCCESS (0.513s) [680.235463] Starting dynamic subtest: bcs0 [680.735408] Dynamic subtest bcs0: SUCCESS (0.510s) [680.747662] Starting dynamic subtest: vcs0 [681.248400] Dynamic subtest vcs0: SUCCESS (0.510s) [681.261144] Starting dynamic subtest: vcs1 [681.760178] Dynamic subtest vcs1: SUCCESS (0.510s) [681.771378] Starting dynamic subtest: vecs0 [682.273664] Dynamic subtest vecs0: SUCCESS (0.510s) [682.286210] Starting dynamic subtest: ccs0 [682.789377] Dynamic subtest ccs0: SUCCESS (0.512s) [682.792379] Subtest semaphore-wait-idle: SUCCESS (3.081s) [682.953981] [086/131] (338s left) kms_addfb_basic (no-handle) [683.019938] Starting subtest: no-handle [683.022520] Subtest no-handle: SUCCESS (0.000s) [683.188509] [087/131] (338s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [683.280980] Starting subtest: fbcpsr-rgb101010-draw-pwrite [690.222683] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.943s) [690.375451] [088/131] (331s left) gem_render_copy (yf-tiled-ccs-to-linear) [690.440752] Starting subtest: yf-tiled-ccs-to-linear [690.446353] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [690.649504] [089/131] (330s left) kms_flip (wf_vblank-ts-check) [690.740138] Starting subtest: wf_vblank-ts-check [690.742898] Starting dynamic subtest: A-eDP1 [699.685650] Dynamic subtest A-eDP1: SUCCESS (8.945s) [699.698870] Starting dynamic subtest: B-eDP1 [708.623357] Dynamic subtest B-eDP1: SUCCESS (8.934s) [708.634206] Starting dynamic subtest: C-eDP1 [717.549249] Dynamic subtest C-eDP1: SUCCESS (8.920s) [717.558635] Starting dynamic subtest: D-eDP1 [726.473379] Dynamic subtest D-eDP1: SUCCESS (8.923s) [726.480340] Subtest wf_vblank-ts-check: SUCCESS (35.734s) [727.724963] [090/131] (293s left) gem_exec_schedule (deep) [727.906019] Starting subtest: deep [727.908826] Starting dynamic subtest: rcs0 [732.548275] Dynamic subtest rcs0: SKIP (4.640s) [732.558422] Starting dynamic subtest: vcs0 [742.986289] Dynamic subtest vcs0: SUCCESS (10.437s) [742.998022] Starting dynamic subtest: vcs1 [754.352005] Dynamic subtest vcs1: SUCCESS (11.364s) [754.361207] Starting dynamic subtest: vecs0 [765.847254] Dynamic subtest vecs0: SUCCESS (11.492s) [765.859601] Starting dynamic subtest: ccs0 [777.754479] Dynamic subtest ccs0: SUCCESS (11.905s) [777.758088] Subtest deep: SUCCESS (49.843s) [778.735477] [091/131] (242s left) kms_sequence (queue-idle) [778.831260] Starting subtest: queue-idle [778.833737] Starting dynamic subtest: pipe-A-eDP-1 [780.646533] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s) [780.658004] Starting dynamic subtest: pipe-B-eDP-1 [783.088346] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.440s) [783.099419] Starting dynamic subtest: pipe-C-eDP-1 [785.512182] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.423s) [785.522706] Starting dynamic subtest: pipe-D-eDP-1 [787.947220] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.433s) [787.950387] Subtest queue-idle: SUCCESS (9.117s) [788.774842] [092/131] (232s left) gem_gtt_cpu_tlb [788.914942] [093/131] (232s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [789.016203] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [795.624386] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.611s) [795.772177] [094/131] (226s left) gem_eio (create-ext) [796.004957] Starting subtest: create-ext [796.314232] Subtest create-ext: SUCCESS (0.310s) [796.456671] [095/131] (225s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [796.528657] Subtest writes-after-reads-uncached: SKIP (0.000s) [796.608959] [096/131] (225s left) sysfs_preempt_timeout (idempotent) [796.679359] Starting subtest: idempotent [796.681935] Starting dynamic subtest: vecs0 [796.684524] Dynamic subtest vecs0: SUCCESS (0.001s) [796.701106] Starting dynamic subtest: ccs0 [796.703436] Dynamic subtest ccs0: SUCCESS (0.001s) [796.714209] Starting dynamic subtest: vcs0 [796.716664] Dynamic subtest vcs0: SUCCESS (0.000s) [796.725908] Starting dynamic subtest: bcs0 [796.728055] Dynamic subtest bcs0: SUCCESS (0.000s) [796.737375] Starting dynamic subtest: rcs0 [796.739884] Dynamic subtest rcs0: SUCCESS (0.000s) [796.749075] Starting dynamic subtest: vcs1 [796.751362] Dynamic subtest vcs1: SUCCESS (0.000s) [796.753835] Subtest idempotent: SUCCESS (0.010s) [796.853813] [097/131] (225s left) gem_busy (semaphore) [797.052331] Subtest semaphore: SKIP (0.000s) [797.324442] [098/131] (224s left) sriov_basic (enable-vfs-bind-unbind-each) [797.394231] Starting subtest: enable-vfs-bind-unbind-each [797.397281] Starting dynamic subtest: numvfs-1 [797.490169] Dynamic subtest numvfs-1: FAIL (0.031s) [797.501206] Starting dynamic subtest: numvfs-2 [797.593226] Dynamic subtest numvfs-2: FAIL (0.003s) [797.604521] Starting dynamic subtest: numvfs-3 [797.693178] Dynamic subtest numvfs-3: FAIL (0.003s) [797.703194] Starting dynamic subtest: numvfs-4 [797.789352] Dynamic subtest numvfs-4: FAIL (0.003s) [797.799972] Starting dynamic subtest: numvfs-5 [797.887005] Dynamic subtest numvfs-5: FAIL (0.003s) [797.897114] Starting dynamic subtest: numvfs-6 [797.984820] Dynamic subtest numvfs-6: FAIL (0.003s) [797.995349] Starting dynamic subtest: numvfs-7 [798.080488] Dynamic subtest numvfs-7: FAIL (0.003s) [798.091399] Starting dynamic subtest: numvfs-random [798.179166] Dynamic subtest numvfs-random: FAIL (0.003s) [798.181374] Subtest enable-vfs-bind-unbind-each: FAIL (0.060s) [798.220292] [099/131] (223s left) kms_pm_lpsp (screens-disabled) [799.323526] Starting subtest: screens-disabled [799.328366] Subtest screens-disabled: SKIP (0.000s) [799.420771] [100/131] (222s left) gem_exec_capture (capture-invisible) [799.501362] Starting subtest: capture-invisible [799.504308] Starting dynamic subtest: smem0 [799.509351] Dynamic subtest smem0: SKIP (0.000s) [799.514558] Subtest capture-invisible: SKIP (0.001s) [799.641771] [101/131] (222s left) gem_lmem_swapping (verify-ccs) [799.685374] Subtest verify-ccs: SKIP (0.000s) [799.734706] [102/131] (222s left) kms_joiner (basic-force-ultra-joiner) [799.842371] Starting subtest: basic-force-ultra-joiner [799.847630] Subtest basic-force-ultra-joiner: SKIP (0.000s) [799.975268] [103/131] (222s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [800.071620] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [806.622357] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.553s) [806.759969] [104/131] (215s left) kms_color (legacy-gamma) [806.861245] Starting subtest: legacy-gamma [806.863548] Starting dynamic subtest: pipe-A-eDP-1 [807.602048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s) [807.614878] Starting dynamic subtest: pipe-B-eDP-1 [809.032513] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.427s) [809.043545] Starting dynamic subtest: pipe-C-eDP-1 [810.398774] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s) [810.409952] Starting dynamic subtest: pipe-D-eDP-1 [811.731128] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [811.734150] Subtest legacy-gamma: SUCCESS (4.872s) [812.571695] [105/131] (209s left) gem_exec_schedule (wide) [812.760860] Starting subtest: wide [812.762991] Starting dynamic subtest: rcs0 [823.636163] Dynamic subtest rcs0: SUCCESS (10.874s) [823.649694] Starting dynamic subtest: vcs0 [835.333926] Dynamic subtest vcs0: SUCCESS (11.697s) [835.345402] Starting dynamic subtest: vcs1 [847.733720] Dynamic subtest vcs1: SUCCESS (12.399s) [847.745579] Starting dynamic subtest: vecs0 [859.374107] Dynamic subtest vecs0: SUCCESS (11.640s) [859.387046] Starting dynamic subtest: ccs0 [872.810056] Dynamic subtest ccs0: SUCCESS (13.436s) [872.812294] Subtest wide: SUCCESS (60.051s) [873.996714] [106/131] (148s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [874.094087] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [874.096808] Starting dynamic subtest: pipe-A-default-mode [874.396249] Dynamic subtest pipe-A-default-mode: SKIP (0.297s) [874.401812] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.299s) [875.226593] [107/131] (147s left) kms_big_fb (linear-64bpp-rotate-180) [875.329402] Starting subtest: linear-64bpp-rotate-180 [877.064203] Subtest linear-64bpp-rotate-180: SUCCESS (1.734s) [877.264939] [108/131] (145s left) gem_ppgtt (blt-vs-render-ctxn) [877.337990] Starting subtest: blt-vs-render-ctxN [910.499413] Subtest blt-vs-render-ctxN: SUCCESS (33.158s) [910.679717] [109/131] (111s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [910.828354] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [910.833244] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [910.954564] [110/131] (111s left) kms_chamelium_frames (dp-frame-dump) [911.343816] Subtest dp-frame-dump: SKIP (0.000s) [912.137842] [111/131] (110s left) kms_psr2_su (page_flip-nv12) [912.201157] Subtest page_flip-NV12: SKIP (0.000s) [912.270222] [112/131] (110s left) gem_tiling_max_stride [912.406717] [113/131] (110s left) perf_pmu (busy-idle) [912.450619] Starting subtest: busy-idle [912.453419] Starting dynamic subtest: rcs0 [913.172399] Dynamic subtest rcs0: SUCCESS (0.722s) [913.185961] Starting dynamic subtest: bcs0 [913.843158] Dynamic subtest bcs0: SUCCESS (0.668s) [913.858092] Starting dynamic subtest: vcs0 [915.759633] Dynamic subtest vcs0: SUCCESS (1.912s) [915.773391] Starting dynamic subtest: vcs1 [917.742899] Dynamic subtest vcs1: SUCCESS (1.980s) [917.756748] Starting dynamic subtest: vecs0 [919.727119] Dynamic subtest vecs0: SUCCESS (1.981s) [919.739449] Starting dynamic subtest: ccs0 [920.404280] Dynamic subtest ccs0: SUCCESS (0.676s) [920.407334] Subtest busy-idle: SUCCESS (7.954s) [920.532137] [114/131] (102s left) dmabuf_sync_file (export-before-signal) [920.591270] Starting subtest: export-before-signal [920.594163] Subtest export-before-signal: SUCCESS (0.001s) [920.674288] [115/131] (102s left) gem_exec_reloc (basic-cpu-read) [920.742143] Subtest basic-cpu-read: SKIP (0.000s) [920.830130] [116/131] (102s left) kms_hdr (bpc-switch) [920.930102] Starting subtest: bpc-switch [922.016146] Starting dynamic subtest: pipe-A-eDP-1 [925.512211] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s) [925.515203] Subtest bpc-switch: SUCCESS (4.582s) [925.663678] [117/131] ( 97s left) perf (i915-ref-count) [925.778338] Starting subtest: i915-ref-count [925.849280] Subtest i915-ref-count: SUCCESS (0.068s) [925.910200] [118/131] ( 97s left) gem_ctx_isolation (nonpriv) [925.980277] Starting subtest: nonpriv [925.982895] Starting dynamic subtest: rcs0 [926.238773] Dynamic subtest rcs0: SUCCESS (0.258s) [926.251881] Starting dynamic subtest: bcs0 [926.532125] Dynamic subtest bcs0: SUCCESS (0.292s) [926.544657] Starting dynamic subtest: vcs0 [926.827368] Dynamic subtest vcs0: SUCCESS (0.294s) [926.839145] Starting dynamic subtest: vcs1 [927.954129] Dynamic subtest vcs1: SUCCESS (1.125s) [927.966688] Starting dynamic subtest: vecs0 [930.083358] Dynamic subtest vecs0: SUCCESS (2.128s) [930.096148] Starting dynamic subtest: ccs0 [932.049705] Dynamic subtest ccs0: SUCCESS (1.965s) [932.052710] Subtest nonpriv: SUCCESS (6.068s) [932.327720] [119/131] ( 90s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [932.386371] Starting subtest: y-tiled-to-vebox-x-tiled [932.391972] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [932.597961] [120/131] ( 90s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [932.690921] Starting subtest: plane-use-after-nonblocking-unbind [932.693078] Starting dynamic subtest: pipe-A-eDP-1 [932.758993] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [933.054792] Starting dynamic subtest: pipe-B-eDP-1 [933.873970] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.826s) [934.186495] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.495s) [935.086603] [121/131] ( 88s left) i915_hangman (engine-error-state-capture) [935.156609] Starting subtest: engine-error-state-capture [935.159014] Starting dynamic subtest: rcs0 [938.700978] Dynamic subtest rcs0: SUCCESS (3.545s) [938.714940] Starting dynamic subtest: bcs0 [944.717719] Dynamic subtest bcs0: SUCCESS (6.012s) [944.732121] Starting dynamic subtest: vcs0 [950.734240] Dynamic subtest vcs0: SUCCESS (6.013s) [950.746425] Starting dynamic subtest: vcs1 [956.748482] Dynamic subtest vcs1: SUCCESS (6.011s) [956.763081] Starting dynamic subtest: vecs0 [962.638154] Dynamic subtest vecs0: SUCCESS (5.886s) [962.652110] Starting dynamic subtest: ccs0 [967.693976] Dynamic subtest ccs0: SUCCESS (5.052s) [967.697154] Subtest engine-error-state-capture: SUCCESS (32.536s) [967.801140] [122/131] ( 55s left) gem_exec_schedule (pi-shared-iova) [967.993426] Starting subtest: pi-shared-iova [967.995950] Starting dynamic subtest: rcs0 [968.127900] Dynamic subtest rcs0: SUCCESS (0.137s) [968.142091] Starting dynamic subtest: vcs0 [968.218353] Dynamic subtest vcs0: SUCCESS (0.090s) [968.230085] Starting dynamic subtest: vcs1 [968.322075] Dynamic subtest vcs1: SUCCESS (0.103s) [968.333397] Starting dynamic subtest: vecs0 [968.408693] Dynamic subtest vecs0: SUCCESS (0.085s) [968.421410] Starting dynamic subtest: ccs0 [968.531822] Dynamic subtest ccs0: SUCCESS (0.122s) [968.534653] Subtest pi-shared-iova: SUCCESS (0.541s) [969.920785] [123/131] ( 53s left) syncobj_wait (invalid-reset-illegal-handle) [969.978034] Starting subtest: invalid-reset-illegal-handle [969.981226] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [970.095009] [124/131] ( 53s left) syncobj_wait (single-wait-all-for-submit-signaled) [970.157181] Starting subtest: single-wait-all-for-submit-signaled [970.159942] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [970.278774] [125/131] ( 52s left) kms_cursor_crc (cursor-sliding-512x170) [970.588365] Starting subtest: cursor-sliding-512x170 [970.593606] Subtest cursor-sliding-512x170: SKIP (0.001s) [970.786613] [126/131] ( 52s left) kms_chamelium_hpd (hdmi-hpd-fast) [971.165655] Subtest hdmi-hpd-fast: SKIP (0.000s) [971.956627] [127/131] ( 51s left) gem_ctx_persistence (hostile) [972.013689] Starting subtest: hostile [982.166152] Subtest hostile: SUCCESS (10.147s) [982.326307] [128/131] ( 41s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [982.448730] Starting subtest: fbc-rgb565-draw-blt [986.687365] Subtest fbc-rgb565-draw-blt: SUCCESS (4.242s) [987.904715] [129/131] ( 35s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [988.008890] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [997.113379] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.107s) [997.288622] [130/131] ( 26s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [997.399966] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [997.405053] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [997.513009] [131/131] ( 26s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [997.618895] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [997.623938] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [997.749743] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: gem_exec_fence results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: kms_chamelium_color results: parsing output: 6/ for test: gem_workarounds results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: gem_pxp results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: i915_pm_rps results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_panel_fitting results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: kms_async_flips results: parsing output: 24/ for test: kms_psr2_sf results: parsing output: 25/ for test: kms_plane_multiple results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_pm_rpm results: parsing output: 33/ for test: kms_vblank results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_pipe_crc_basic results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_unref_active_buffers results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: gem_mmap_offset results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_rmfb results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: api_intel_allocator results: parsing output: 65/ for test: kms_lease results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: i915_selftest results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: gem_gtt_cpu_tlb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: gem_partial_pwrite_pread results: parsing output: 95/ for test: sysfs_preempt_timeout results: parsing output: 96/ for test: gem_busy results: parsing output: 97/ for test: sriov_basic results: parsing output: 98/ for test: kms_pm_lpsp results: parsing output: 99/ for test: gem_exec_capture results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_joiner results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_color results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_flip_scaled_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ppgtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_chamelium_frames results: parsing output: 110/ for test: kms_psr2_su results: parsing output: 111/ for test: gem_tiling_max_stride results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: dmabuf_sync_file results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_hdr results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: gem_ctx_isolation results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_atomic_transition results: parsing output: 120/ for test: i915_hangman results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.