[75.323408] Initializing watchdogs [75.323533] /dev/watchdog0 [75.343970] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300) [75.351831] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [75.355615] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [75.358823] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85) [75.905899] Starting subtest: cursor-offscreen-256x85 [75.994322] Subtest cursor-offscreen-256x85: SKIP (0.087s) [76.605868] [002/134] (959s left) gem_mmap_gtt (cpuset-big-copy-odd) [76.667587] Starting subtest: cpuset-big-copy-odd [80.230101] Subtest cpuset-big-copy-odd: SUCCESS (3.564s) [80.419608] [003/134] (955s left) gem_ctx_engines (execute-allforone) [80.594783] Starting subtest: execute-allforone [80.597333] Subtest execute-allforone: SUCCESS (0.003s) [80.861636] [004/134] (955s left) perf_pmu (busy-idle) [80.917880] Starting subtest: busy-idle [80.918947] Starting dynamic subtest: rcs0 [81.557420] Dynamic subtest rcs0: SUCCESS (0.640s) [81.575945] Starting dynamic subtest: bcs0 [82.196242] Dynamic subtest bcs0: SUCCESS (0.638s) [82.216567] Starting dynamic subtest: vcs0 [83.347679] Dynamic subtest vcs0: SUCCESS (1.150s) [83.349203] Subtest busy-idle: SUCCESS (2.431s) [83.452075] [005/134] (952s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [83.977721] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [83.980983] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.001s) [84.583253] [006/134] (951s left) api_intel_bb (lot-of-buffers) [84.644113] Starting subtest: lot-of-buffers [85.372788] Subtest lot-of-buffers: SUCCESS (0.728s) [85.714526] [007/134] (950s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [85.786533] Starting subtest: yf-tiled-to-vebox-x-tiled [85.788645] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [86.016960] [008/134] (950s left) kms_plane (plane-panning-top-left) [86.510116] Starting subtest: plane-panning-top-left [86.511300] Starting dynamic subtest: pipe-A [87.275855] Dynamic subtest pipe-A: SUCCESS (0.765s) [87.286691] Starting dynamic subtest: pipe-B [87.871131] Dynamic subtest pipe-B: SUCCESS (0.594s) [87.871972] Subtest plane-panning-top-left: SUCCESS (1.362s) [88.568619] [009/134] (947s left) kms_psr (fbc-psr-cursor-plane-onoff) [89.062865] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [89.358725] [010/134] (946s left) kms_cursor_crc (cursor-tearing-position-change) [89.854914] Starting subtest: cursor-tearing-position-change [89.855856] Starting dynamic subtest: pipe-A-HDMI-A-1 [90.251430] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.394s) [90.263903] Starting dynamic subtest: pipe-B-HDMI-A-1 [90.613055] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.361s) [90.613804] Subtest cursor-tearing-position-change: SUCCESS (0.758s) [91.339806] [011/134] (944s left) kms_frontbuffer_tracking (basic) [91.846784] Starting subtest: basic [94.254292] Subtest basic: SUCCESS (2.407s) [94.886606] [012/134] (941s left) gem_spin_batch (spin-each) [94.956809] Starting subtest: spin-each [98.291374] Subtest spin-each: SUCCESS (3.335s) [98.572770] [013/134] (937s left) gem_exec_reloc (basic-gtt-cpu) [98.632408] Starting subtest: basic-gtt-cpu [98.636274] Subtest basic-gtt-cpu: SUCCESS (0.004s) [99.673309] [014/134] (936s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier) [100.167290] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier [100.208668] Starting dynamic subtest: pipe-A-plane-0 [100.210875] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [100.223695] Starting dynamic subtest: pipe-A-plane-1 [100.225388] Dynamic subtest pipe-A-plane-1: SKIP (0.000s) [100.236751] Starting dynamic subtest: pipe-A-plane-2 [100.238505] Dynamic subtest pipe-A-plane-2: SKIP (0.000s) [100.448544] Starting dynamic subtest: pipe-B-plane-0 [100.449818] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [100.460820] Starting dynamic subtest: pipe-B-plane-1 [100.462469] Dynamic subtest pipe-B-plane-1: SKIP (0.000s) [100.472764] Starting dynamic subtest: pipe-B-plane-2 [100.474269] Dynamic subtest pipe-B-plane-2: SKIP (0.000s) [100.519196] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.352s) [101.227294] [015/134] (935s left) gem_render_copy (y-tiled-ccs-to-linear) [101.294121] Starting subtest: y-tiled-ccs-to-linear [101.294904] Starting dynamic subtest: smem [101.297049] Dynamic subtest smem: SKIP (0.000s) [101.299039] Subtest y-tiled-ccs-to-linear: SKIP (0.001s) [101.528104] [016/134] (935s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [102.024012] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [102.025543] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [102.639149] [017/134] (933s left) kms_psr (pr-sprite-render) [103.140908] Subtest pr-sprite-render: SKIP (0.000s) [103.433781] [018/134] (933s left) gen9_exec_parse (shadow-peek) [103.493936] Subtest shadow-peek: SKIP (0.000s) [103.550360] [019/134] (933s left) perf (invalid-remove-userspace-config) [103.752266] Subtest invalid-remove-userspace-config: SKIP (0.000s) [103.798675] [020/134] (932s left) gem_ctx_param (invalid-size-set) [103.852083] Starting subtest: invalid-size-set [103.852811] Subtest invalid-size-set: SUCCESS (0.000s) [103.969167] [021/134] (932s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [104.024906] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [104.084318] [022/134] (932s left) gem_exec_params (invalid-bsd2-flag-on-blt) [104.144400] Starting subtest: invalid-bsd2-flag-on-blt [104.145074] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [104.290032] [023/134] (932s left) gem_render_copy (yf-tiled-ccs-to-linear) [104.349319] Starting subtest: yf-tiled-ccs-to-linear [104.350309] Starting dynamic subtest: smem [104.352113] Dynamic subtest smem: SKIP (0.000s) [104.354404] Subtest yf-tiled-ccs-to-linear: SKIP (0.001s) [104.572562] [024/134] (932s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [104.628529] Starting subtest: etime-multi-wait-for-submit-unsubmitted [104.730118] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s) [104.851269] [025/134] (932s left) gem_exec_fence (invalid-timeline-fence-array) [105.202194] Starting subtest: invalid-timeline-fence-array [105.206067] Subtest invalid-timeline-fence-array: SUCCESS (0.004s) [105.468640] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [105.470948] [026/134] (931s left) kms_chamelium_edid (dp-edid-read) [106.040688] Subtest dp-edid-read: SKIP (0.000s) [106.447418] [027/134] (930s left) gem_exec_params (invalid-bsd1-flag-on-render) [106.505419] Starting subtest: invalid-bsd1-flag-on-render [106.506304] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s) [106.633635] [028/134] (930s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [107.134306] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [107.135794] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [107.749617] [029/134] (929s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [107.811787] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s) [107.876364] [030/134] (929s left) gem_eio (kms) [108.379657] Starting subtest: kms [113.316665] Subtest kms: SUCCESS (4.916s) [113.927111] [031/134] (923s left) kms_cursor_legacy (torture-move) [114.419632] Starting subtest: torture-move [114.420566] Starting dynamic subtest: pipe-A [119.974265] Dynamic subtest pipe-A: SUCCESS (5.551s) [119.986305] Starting dynamic subtest: pipe-B [125.612014] Dynamic subtest pipe-B: SUCCESS (5.639s) [125.624243] Starting dynamic subtest: all-pipes [131.193485] Dynamic subtest all-pipes: SUCCESS (5.580s) [131.194182] Subtest torture-move: SUCCESS (16.774s) [131.800647] [032/134] (905s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [131.859024] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.000s) [131.912637] [033/134] (905s left) gem_exec_capture (pi) [131.972075] Subtest pi: SKIP (0.000s) [132.062634] [034/134] (905s left) syncobj_timeline (wait-all-snapshot) [132.118079] Starting subtest: wait-all-snapshot [132.201409] Subtest wait-all-snapshot: SUCCESS (0.082s) [132.338581] [035/134] (905s left) kms_async_flips (test-cursor-atomic) [132.825926] Starting subtest: test-cursor-atomic [132.969085] Starting dynamic subtest: pipe-A-HDMI-A-1 [133.111145] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.142s) [133.269485] Starting dynamic subtest: pipe-B-HDMI-A-1 [133.362923] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.104s) [133.363784] Subtest test-cursor-atomic: SUCCESS (0.538s) [134.231521] [036/134] (903s left) kms_big_fb (x-tiled-32bpp-rotate-180) [134.728834] Starting subtest: x-tiled-32bpp-rotate-180 [136.170829] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.441s) [136.804047] [037/134] (900s left) i915_pm_freq_api (freq-reset) [136.864914] Subtest freq-reset: SKIP (0.000s) [136.927930] [038/134] (900s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [137.417163] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [139.247473] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.830s) [139.896654] [039/134] (897s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [139.950381] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [140.008570] [040/134] (897s left) gem_mmap (short-mmap) [140.062990] Starting subtest: short-mmap [140.063720] Subtest short-mmap: SUCCESS (0.000s) [140.210628] [041/134] (897s left) vgem_basic (dmabuf-export) [140.279598] Starting subtest: dmabuf-export [140.282058] Subtest dmabuf-export: SUCCESS (0.003s) [140.428649] [042/134] (897s left) gem_render_copy (y-tiled) [140.488705] Starting subtest: y-tiled [140.489377] Starting dynamic subtest: smem [140.552990] Dynamic subtest smem: SUCCESS (0.064s) [140.553943] Subtest y-tiled: SUCCESS (0.065s) [140.777091] [043/134] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [141.271956] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [141.273338] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [141.873716] [044/134] (896s left) gem_exec_schedule (implicit-write-read) [141.946830] Starting subtest: implicit-write-read [141.947510] Starting dynamic subtest: rcs0 [141.979813] Dynamic subtest rcs0: SUCCESS (0.032s) [141.993439] Starting dynamic subtest: bcs0 [142.010354] Dynamic subtest bcs0: SUCCESS (0.030s) [142.011191] Subtest implicit-write-read: SUCCESS (0.064s) [142.277310] [045/134] (895s left) kms_big_fb (4-tiled-64bpp-rotate-90) [142.780032] Starting subtest: 4-tiled-64bpp-rotate-90 [142.781620] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s) [143.390191] [046/134] (894s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [143.884158] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [143.885842] Starting dynamic subtest: A-VGA1 [151.909043] Dynamic subtest A-VGA1: SUCCESS (8.022s) [151.922705] Starting dynamic subtest: B-VGA1 [159.883579] Dynamic subtest B-VGA1: SUCCESS (7.971s) [159.897115] Starting dynamic subtest: A-HDMI-A1 [168.042148] Dynamic subtest A-HDMI-A1: SUCCESS (8.156s) [168.056033] Starting dynamic subtest: B-HDMI-A1 [176.234157] Dynamic subtest B-HDMI-A1: SUCCESS (8.187s) [176.238537] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.346s) [177.037233] [047/134] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [177.537772] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [177.538929] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [178.131593] [048/134] (860s left) kms_color_pipeline (plane-lut1d) [178.624182] Starting subtest: plane-lut1d [178.893890] Subtest plane-lut1d: SKIP (0.270s) [179.611566] [049/134] (858s left) i915_pm_rc6_residency (rc6-accuracy) [179.671146] Starting subtest: rc6-accuracy [179.671912] Starting dynamic subtest: gt0 [182.841984] Dynamic subtest gt0: SUCCESS (3.168s) [182.842871] Subtest rc6-accuracy: SUCCESS (3.170s) [182.977381] [050/134] (855s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [183.469699] Starting subtest: basic-flip-before-cursor-atomic [184.453241] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.980s) [185.163104] [051/134] (853s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [185.659238] Starting subtest: psr-2p-primscrn-spr-indfb-move [185.660720] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [186.272908] [052/134] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [186.769396] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [186.770700] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [187.383177] [053/134] (851s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [187.877181] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [188.177210] [054/134] (850s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [188.235894] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [188.338195] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.101s) [188.471546] [055/134] (850s left) gem_mmap_wc (bad-size) [188.532472] Starting subtest: bad-size [188.533141] Subtest bad-size: SUCCESS (0.001s) [188.668739] [056/134] (849s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [189.164680] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [189.166186] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [189.767957] [057/134] (848s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [190.258699] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [190.262923] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [190.866580] [058/134] (847s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [191.358088] Starting subtest: cursorA-vs-flipB-atomic [191.360048] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [191.959679] [059/134] (846s left) sysfs_heartbeat_interval (nopreempt) [192.020666] Starting subtest: nopreempt [192.022831] Starting dynamic subtest: vcs0 [192.024841] Dynamic subtest vcs0: SKIP (0.000s) [192.042051] Starting dynamic subtest: bcs0 [192.044369] Dynamic subtest bcs0: SKIP (0.000s) [192.069277] Starting dynamic subtest: rcs0 [192.071700] Dynamic subtest rcs0: SKIP (0.000s) [192.073809] Subtest nopreempt: SKIP (0.006s) [192.179325] [060/134] (846s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [192.674231] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [192.675709] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [193.296175] [061/134] (845s left) gem_wait (busy) [193.366973] Starting subtest: busy [193.367885] Starting dynamic subtest: all-engines [193.887545] Dynamic subtest all-engines: SUCCESS (0.520s) [193.901458] Starting dynamic subtest: rcs0 [194.403545] Dynamic subtest rcs0: SUCCESS (0.513s) [194.416903] Starting dynamic subtest: bcs0 [194.919445] Dynamic subtest bcs0: SUCCESS (0.514s) [194.933461] Starting dynamic subtest: vcs0 [195.447590] Dynamic subtest vcs0: SUCCESS (0.526s) [195.449104] Subtest busy: SUCCESS (2.082s) [195.689440] [062/134] (843s left) kms_setmode (clone-exclusive-crtc) [195.747989] Starting subtest: clone-exclusive-crtc [195.749985] Subtest clone-exclusive-crtc: SKIP (0.000s) [195.871232] [063/134] (843s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf) [196.357954] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [196.680341] [064/134] (842s left) sw_sync (sync_merge_same) [196.736687] Starting subtest: sync_merge_same [196.737475] Subtest sync_merge_same: SUCCESS (0.000s) [196.852141] [065/134] (842s left) kms_hdr (static-toggle) [197.337701] Starting subtest: static-toggle [197.339630] Subtest static-toggle: SKIP (0.000s) [197.960148] [066/134] (841s left) gem_exec_await (wide-contexts) [198.048391] Starting subtest: wide-contexts [219.805196] Subtest wide-contexts: SUCCESS (21.756s) [220.034541] [067/134] (819s left) kms_invalid_mode (uint-max-clock) [220.635979] Starting subtest: uint-max-clock [220.637163] Starting dynamic subtest: pipe-A-HDMI-A-1 [220.702884] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.067s) [220.719712] Starting dynamic subtest: pipe-B-HDMI-A-1 [220.720523] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [220.721311] Subtest uint-max-clock: SUCCESS (0.072s) [221.187509] [068/134] (818s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [221.684419] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [223.608886] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (1.924s) [224.241986] [069/134] (815s left) kms_pm_rpm (modeset-non-lpsp) [236.109603] Subtest modeset-non-lpsp: SKIP (0.000s) [236.414365] [070/134] (802s left) kms_psr (fbc-pr-cursor-mmap-cpu) [236.901199] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s) [237.213457] [071/134] (802s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [237.709161] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [239.163838] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (1.454s) [239.791432] [072/134] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [240.287219] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [240.288606] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [240.893796] [073/134] (798s left) i915_pm_rps (thresholds-idle) [240.959677] Starting subtest: thresholds-idle [240.960532] Starting dynamic subtest: gt0 [251.303204] Dynamic subtest gt0: SUCCESS (10.342s) [251.306197] Subtest thresholds-idle: SUCCESS (10.345s) [251.436678] [074/134] (788s left) kms_vblank (query-idle-hang) [251.919817] Starting subtest: query-idle-hang [251.921691] Starting dynamic subtest: pipe-A-HDMI-A-1 [257.922011] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.999s) [257.935726] Starting dynamic subtest: pipe-B-HDMI-A-1 [263.938820] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.015s) [263.940979] Subtest query-idle-hang: SUCCESS (12.022s) [264.659489] [075/134] (774s left) perf_pmu (most-busy-idle-check-all) [264.723456] Starting subtest: most-busy-idle-check-all [264.724340] Starting dynamic subtest: rcs0 [265.343571] Dynamic subtest rcs0: SUCCESS (0.619s) [265.359248] Starting dynamic subtest: bcs0 [265.965568] Dynamic subtest bcs0: SUCCESS (0.619s) [265.980682] Starting dynamic subtest: vcs0 [266.590352] Dynamic subtest vcs0: SUCCESS (0.622s) [266.593641] Subtest most-busy-idle-check-all: SUCCESS (1.868s) [266.720885] [076/134] (772s left) kms_atomic_interruptible (universal-setplane-cursor) [267.216396] Starting subtest: universal-setplane-cursor [267.218645] Starting dynamic subtest: pipe-A-HDMI-A-1 [273.532535] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.314s) [273.533470] Subtest universal-setplane-cursor: SUCCESS (6.317s) [274.247714] [077/134] (765s left) gem_userptr_blits (process-exit-busy) [274.324349] Starting subtest: process-exit-busy [274.346706] Subtest process-exit-busy: SUCCESS (0.022s) [274.509876] [078/134] (765s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [274.990094] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [274.991312] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [275.593636] [079/134] (764s left) gem_lmem_swapping (heavy-verify-multi) [275.653928] Subtest heavy-verify-multi: SKIP (0.000s) [275.721335] [080/134] (764s left) gen9_exec_parse (bb-start-cmd) [275.780138] Subtest bb-start-cmd: SKIP (0.000s) [275.837774] [081/134] (764s left) fbdev (unaligned-read) [275.910238] Starting subtest: unaligned-read [275.919937] Subtest unaligned-read: SUCCESS (0.011s) [276.045483] [082/134] (763s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [276.604514] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [277.012204] [083/134] (763s left) gem_ppgtt (blt-vs-render-ctx0) [277.073738] Starting subtest: blt-vs-render-ctx0 [309.628145] Subtest blt-vs-render-ctx0: SUCCESS (32.554s) [309.791038] [084/134] (730s left) core_setmaster_vs_auth [310.101066] [085/134] (730s left) prime_busy (hang) [310.159430] Starting subtest: hang [310.162192] Starting dynamic subtest: rcs0 [315.891719] Dynamic subtest rcs0: SUCCESS (5.730s) [315.905931] Starting dynamic subtest: bcs0 [321.902953] Dynamic subtest bcs0: SUCCESS (6.009s) [321.917476] Starting dynamic subtest: vcs0 [327.860768] Dynamic subtest vcs0: SUCCESS (5.955s) [327.861394] Subtest hang: SUCCESS (17.702s) [328.030334] [086/134] (712s left) gem_eio (unwedge-stress) [328.110520] Starting subtest: unwedge-stress [328.111514] Starting dynamic subtest: render [329.757260] Dynamic subtest render: SUCCESS (1.646s) [329.771425] Starting dynamic subtest: bsd [330.963632] Dynamic subtest bsd: FAIL (1.176s) [330.964357] Subtest unwedge-stress: FAIL (2.826s) [332.060279] [087/134] (708s left) kms_cursor_crc (cursor-random-256x256) [332.567872] Starting subtest: cursor-random-256x256 [332.570531] Starting dynamic subtest: pipe-A-HDMI-A-1 [336.298724] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.728s) [336.339776] Starting dynamic subtest: pipe-B-HDMI-A-1 [340.023232] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.691s) [340.023936] Subtest cursor-random-256x256: SUCCESS (7.452s) [340.742074] [088/134] (699s left) syncobj_timeline (multi-wait-submitted-signaled) [340.811845] Starting subtest: multi-wait-submitted-signaled [340.813903] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [340.939666] [089/134] (699s left) kms_dsc (dsc-with-formats) [341.429075] Subtest dsc-with-formats: SKIP (0.000s) [341.731886] [090/134] (698s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [342.220187] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [342.222702] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [342.825971] [091/134] (697s left) api_intel_allocator (reopen-fork) [342.885356] Starting subtest: reopen-fork [346.279643] Subtest reopen-fork: SUCCESS (3.394s) [346.398244] [092/134] (694s left) gem_exec_whisper (basic-fds-priority-all) [346.463071] Starting subtest: basic-fds-priority-all [346.464715] Subtest basic-fds-priority-all: SKIP (0.001s) [346.697483] [093/134] (693s left) gem_exec_fence (basic-wait-all) [346.762142] Starting subtest: basic-wait-all [346.806787] Subtest basic-wait-all: SUCCESS (0.044s) [347.309598] [094/134] (693s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [347.368602] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [347.427126] [095/134] (693s left) kms_psr (fbc-psr2-no-drrs) [347.908559] Subtest fbc-psr2-no-drrs: SKIP (0.000s) [348.210514] [096/134] (692s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [348.697888] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [348.699340] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [349.306988] [097/134] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [349.802124] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [349.803487] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [350.406777] [098/134] (690s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [350.895147] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [352.831607] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.936s) [353.490231] [099/134] (687s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [353.980855] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [353.982931] Starting dynamic subtest: pipe-A [353.984794] Dynamic subtest pipe-A: SKIP (0.001s) [353.998930] Starting dynamic subtest: pipe-B [354.001088] Dynamic subtest pipe-B: SKIP (0.001s) [354.002764] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.006s) [354.577510] [100/134] (686s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [354.638893] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s) [354.710939] [101/134] (686s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [355.196091] Starting subtest: flip-vs-cursor-busy-crc-atomic [355.760126] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.562s) [356.475348] [102/134] (684s left) core_getstats (basic) [356.532847] Starting subtest: basic [356.533786] Subtest basic: SUCCESS (0.000s) [356.657761] [103/134] (684s left) gem_mmap_gtt (hang-busy) [356.714736] Starting subtest: hang-busy [362.865599] Subtest hang-busy: SUCCESS (6.151s) [363.039033] [104/134] (678s left) kms_flip (flip-vs-expired-vblank-interruptible) [363.537242] Starting subtest: flip-vs-expired-vblank-interruptible [363.538047] Starting dynamic subtest: A-VGA1 [371.258393] Dynamic subtest A-VGA1: SUCCESS (7.720s) [371.273863] Starting dynamic subtest: B-VGA1 [378.947695] Dynamic subtest B-VGA1: SUCCESS (7.686s) [378.964017] Starting dynamic subtest: A-HDMI-A1 [386.663380] Dynamic subtest A-HDMI-A1: SUCCESS (7.712s) [386.679037] Starting dynamic subtest: B-HDMI-A1 [394.416457] Dynamic subtest B-HDMI-A1: SUCCESS (7.749s) [394.419559] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.882s) [395.217129] [105/134] (646s left) gem_exec_schedule (preempt-queue-contexts) [395.287923] Subtest preempt-queue-contexts: SKIP (0.000s) [395.522842] [106/134] (645s left) perf (oa-formats) [395.728779] Subtest oa-formats: SKIP (0.000s) [395.781440] [107/134] (645s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [396.271704] Starting subtest: fbcpsr-modesetfrombusy [396.273226] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s) [396.874123] [108/134] (644s left) kms_flip (2x-dpms-vs-vblank-race) [397.371824] Starting subtest: 2x-dpms-vs-vblank-race [397.372651] Starting dynamic subtest: AB-VGA1-HDMI-A1 [408.046544] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.673s) [408.047378] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.677s) [408.795746] [109/134] (632s left) gem_exec_params (readonly) [408.888674] Starting subtest: readonly [408.889559] Subtest readonly: SUCCESS (0.001s) [409.047017] [110/134] (632s left) kms_vblank (invalid) [409.537152] Starting subtest: invalid [409.538182] Starting dynamic subtest: pipe-A-HDMI-A-1 [409.723907] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.184s) [409.724791] Subtest invalid: SUCCESS (0.187s) [410.420710] [111/134] (631s left) gem_exec_reloc (basic-cpu-read-noreloc) [410.482885] Starting subtest: basic-cpu-read-noreloc [410.484952] Subtest basic-cpu-read-noreloc: SUCCESS (0.002s) [411.518829] [112/134] (630s left) gem_ctx_persistence (engines-hostile) [411.581947] Subtest engines-hostile: SKIP (0.000s) [411.649748] [113/134] (630s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [412.134169] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [414.043335] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.909s) [414.692821] [114/134] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [415.181413] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [415.182942] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [415.790777] [115/134] (626s left) gem_caching (writes) [415.853863] Starting subtest: writes [418.795515] Subtest writes: SUCCESS (2.942s) [418.953816] [116/134] (622s left) kms_pm_backlight (fade-with-suspend) [419.432910] Subtest fade-with-suspend: SKIP (0.000s) [419.729776] [117/134] (622s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [420.213613] Starting subtest: coverage-vs-premult-vs-constant [420.368959] Subtest coverage-vs-premult-vs-constant: SKIP (0.156s) [421.165600] [118/134] (620s left) kms_lease (master-vs-lease) [421.651461] Starting subtest: master-vs-lease [421.652418] Subtest master-vs-lease: SUCCESS (0.001s) [422.263670] [119/134] (619s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [422.758526] Starting subtest: psr-rgb565-draw-mmap-wc [422.759988] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s) [423.362821] [120/134] (618s left) kms_addfb_basic (addfb25-4-tiled) [423.847960] Starting subtest: addfb25-4-tiled [423.848768] Subtest addfb25-4-tiled: SUCCESS (0.000s) [424.441842] [121/134] (617s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [424.498857] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s) [424.568837] [122/134] (617s left) kms_plane_multiple (2x-tiling-x) [425.054608] Starting subtest: 2x-tiling-x [425.056088] Subtest 2x-tiling-x: SKIP (0.000s) [425.672584] [123/134] (616s left) kms_psr (psr2-primary-render) [426.156811] Subtest psr2-primary-render: SKIP (0.000s) [426.466537] [124/134] (615s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [426.523014] Starting subtest: multi-wait-all-for-submit-submitted-signaled [426.626206] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s) [426.752378] [125/134] (615s left) gem_exec_balancer (full) [426.809880] Subtest full: SKIP (0.000s) [426.925437] [126/134] (615s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render) [427.408079] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render [427.409289] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [428.017242] [127/134] (614s left) gem_mmap_wc (write-read) [428.076099] Starting subtest: write-read [428.090333] Subtest write-read: SUCCESS (0.015s) [428.231429] [128/134] (614s left) gem_ctx_persistence (process) [428.287421] Subtest process: SKIP (0.000s) [428.344727] [129/134] (614s left) gem_ctx_param (non-root-set) [428.403498] Starting subtest: non-root-set [428.426585] Subtest non-root-set: SUCCESS (0.023s) [428.565326] [130/134] (614s left) sw_sync (timeline_closed) [428.622031] Starting subtest: timeline_closed [428.622757] Subtest timeline_closed: SUCCESS (0.000s) [428.732297] [131/134] (613s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [429.219536] Starting subtest: primary-4-tiled-reflect-x-180 [429.221225] Subtest primary-4-tiled-reflect-x-180: SKIP (0.001s) [429.829212] [132/134] (612s left) gem_exec_parallel (basic) [429.894820] Starting subtest: basic [429.895642] Starting dynamic subtest: rcs0 [431.625136] Dynamic subtest rcs0: SUCCESS (1.729s) [431.642684] Starting dynamic subtest: bcs0 [433.328380] Dynamic subtest bcs0: SUCCESS (1.701s) [433.332358] Subtest basic: SUCCESS (3.435s) [433.570768] [133/134] (609s left) kms_content_protection (uevent-hdcp14) [434.072608] Starting subtest: uevent-hdcp14 [434.074494] Subtest uevent-hdcp14: SKIP (0.001s) [434.684480] [134/134] (608s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [434.749322] Starting subtest: multi-wait-all-for-submit-available-signaled [434.751381] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s) [434.885998] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: gem_mmap_gtt results: parsing output: 2/ for test: gem_ctx_engines results: parsing output: 3/ for test: perf_pmu results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: api_intel_bb results: parsing output: 6/ for test: gem_render_copy results: parsing output: 7/ for test: kms_plane results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: kms_cursor_crc results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_spin_batch results: parsing output: 12/ for test: gem_exec_reloc results: parsing output: 13/ for test: kms_plane results: parsing output: 14/ for test: gem_render_copy results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: gen9_exec_parse results: parsing output: 18/ for test: perf results: parsing output: 19/ for test: gem_ctx_param results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: gem_exec_params results: parsing output: 22/ for test: gem_render_copy results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: gem_exec_fence results: parsing output: 25/ for test: kms_chamelium_edid results: parsing output: 26/ for test: gem_exec_params results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: kms_ccs results: parsing output: 29/ for test: gem_eio results: parsing output: 30/ for test: kms_cursor_legacy results: parsing output: 31/ for test: kms_ccs results: parsing output: 32/ for test: gem_exec_capture results: parsing output: 33/ for test: syncobj_timeline results: parsing output: 34/ for test: kms_async_flips results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: i915_pm_freq_api results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_ccs results: parsing output: 39/ for test: gem_mmap results: parsing output: 40/ for test: vgem_basic results: parsing output: 41/ for test: gem_render_copy results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_exec_schedule results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: kms_flip results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_color_pipeline results: parsing output: 48/ for test: i915_pm_rc6_residency results: parsing output: 49/ for test: kms_cursor_legacy results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_psr2_sf results: parsing output: 53/ for test: syncobj_timeline results: parsing output: 54/ for test: gem_mmap_wc results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_cursor_legacy results: parsing output: 58/ for test: sysfs_heartbeat_interval results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: gem_wait results: parsing output: 61/ for test: kms_setmode results: parsing output: 62/ for test: kms_psr2_sf results: parsing output: 63/ for test: sw_sync results: parsing output: 64/ for test: kms_hdr results: parsing output: 65/ for test: gem_exec_await results: parsing output: 66/ for test: kms_invalid_mode results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_pm_rpm results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: i915_pm_rps results: parsing output: 73/ for test: kms_vblank results: parsing output: 74/ for test: perf_pmu results: parsing output: 75/ for test: kms_atomic_interruptible results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_lmem_swapping results: parsing output: 79/ for test: gen9_exec_parse results: parsing output: 80/ for test: fbdev results: parsing output: 81/ for test: kms_chamelium_hpd results: parsing output: 82/ for test: gem_ppgtt results: parsing output: 83/ for test: core_setmaster_vs_auth results: parsing output: 84/ for test: prime_busy results: parsing output: 85/ for test: gem_eio results: parsing output: 86/ for test: kms_cursor_crc results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: kms_dsc results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: api_intel_allocator results: parsing output: 91/ for test: gem_exec_whisper results: parsing output: 92/ for test: gem_exec_fence results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: kms_psr results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_plane_scaling results: parsing output: 99/ for test: kms_flip_scaled_crc results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: core_getstats results: parsing output: 102/ for test: gem_mmap_gtt results: parsing output: 103/ for test: kms_flip results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: perf results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: gem_exec_params results: parsing output: 109/ for test: kms_vblank results: parsing output: 110/ for test: gem_exec_reloc results: parsing output: 111/ for test: gem_ctx_persistence results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_caching results: parsing output: 115/ for test: kms_pm_backlight results: parsing output: 116/ for test: kms_plane_alpha_blend results: parsing output: 117/ for test: kms_lease results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_addfb_basic results: parsing output: 120/ for test: kms_flip_scaled_crc results: parsing output: 121/ for test: kms_plane_multiple results: parsing output: 122/ for test: kms_psr results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: gem_exec_balancer results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_mmap_wc results: parsing output: 127/ for test: gem_ctx_persistence results: parsing output: 128/ for test: gem_ctx_param results: parsing output: 129/ for test: sw_sync results: parsing output: 130/ for test: kms_rotation_crc results: parsing output: 131/ for test: gem_exec_parallel results: parsing output: 132/ for test: kms_content_protection results: parsing output: 133/ for test: syncobj_timeline Done.