[40.569167] Initializing watchdogs [40.569263] /dev/watchdog0 [40.583591] [001/160] (960s left) i915_module_load (load) [40.673029] Starting subtest: load [43.900274] Subtest load: SUCCESS (3.233s) [43.928363] [002/160] (957s left) core_auth (basic-auth) [45.652566] Starting subtest: basic-auth [45.659477] Subtest basic-auth: SUCCESS (0.002s) [45.746694] [003/160] (955s left) debugfs_test (read_all_entries) [45.845759] Starting subtest: read_all_entries [46.207249] Subtest read_all_entries: SUCCESS (0.362s) [46.296571] [004/160] (954s left) debugfs_test (basic-hwmon) [46.388583] Starting subtest: basic-hwmon [46.401922] Subtest basic-hwmon: SKIP (0.000s) [46.491198] [005/160] (954s left) fbdev (eof) [46.582209] Starting subtest: eof [46.589077] Subtest eof: SUCCESS (0.000s) [46.641435] [006/160] (954s left) fbdev (info) [46.722437] Starting subtest: info [46.729451] Subtest info: SUCCESS (0.000s) [46.790715] [007/160] (954s left) fbdev (nullptr) [46.880960] Starting subtest: nullptr [46.888061] Subtest nullptr: SUCCESS (0.000s) [46.941053] [008/160] (954s left) fbdev (read) [47.030857] Starting subtest: read [48.107415] Subtest read: SUCCESS (1.067s) [48.167396] [009/160] (953s left) fbdev (write) [48.257070] Starting subtest: write [48.971157] Subtest write: SUCCESS (0.705s) [49.037488] [010/160] (952s left) gem_basic (bad-close) [49.124175] Starting subtest: bad-close [49.137525] Subtest bad-close: SUCCESS (0.000s) [49.212509] [011/160] (952s left) gem_basic (create-close) [49.307033] Starting subtest: create-close [49.321401] Subtest create-close: SUCCESS (0.000s) [49.391877] [012/160] (951s left) gem_basic (create-fd-close) [49.496413] Starting subtest: create-fd-close [49.510815] Subtest create-fd-close: SUCCESS (0.000s) [49.594800] [013/160] (951s left) gem_busy (busy@all-engines) [49.698834] Starting subtest: busy [49.705688] Starting dynamic subtest: all-engines [49.810487] Dynamic subtest all-engines: SUCCESS (0.111s) [49.817597] Subtest busy: SUCCESS (0.111s) [51.742144] [014/160] (949s left) gem_close_race (basic-process) [51.858857] Starting subtest: basic-process [51.899456] Subtest basic-process: SUCCESS (0.041s) [52.094951] [015/160] (949s left) gem_close_race (basic-threads) [52.207113] Starting subtest: basic-threads [53.526835] Subtest basic-threads: SUCCESS (1.320s) [53.725437] [016/160] (947s left) gem_ctx_create (basic) [53.813070] Starting subtest: basic [53.821300] Subtest basic: SUCCESS (0.000s) [54.007507] [017/160] (947s left) gem_ctx_create (basic-files) [54.096402] Starting subtest: basic-files [56.115530] Subtest basic-files: SUCCESS (2.019s) [57.752171] [018/160] (943s left) gem_ctx_exec (basic) [57.850925] Starting subtest: basic [57.865206] Subtest basic: SUCCESS (0.021s) [57.977452] [019/160] (943s left) gem_exec_basic (basic) [58.080658] Starting subtest: basic [58.087483] Starting dynamic subtest: rcs0-smem [58.094156] Dynamic subtest rcs0-smem: SUCCESS (0.011s) [58.107365] Starting dynamic subtest: bcs0-smem [58.113814] Dynamic subtest bcs0-smem: SUCCESS (0.008s) [58.126479] Starting dynamic subtest: vcs0-smem [58.133340] Dynamic subtest vcs0-smem: SUCCESS (0.007s) [58.145920] Starting dynamic subtest: vcs1-smem [58.153623] Dynamic subtest vcs1-smem: SUCCESS (0.008s) [58.166828] Starting dynamic subtest: vecs0-smem [58.174051] Dynamic subtest vecs0-smem: SUCCESS (0.009s) [58.186459] Starting dynamic subtest: ccs0-smem [58.193301] Dynamic subtest ccs0-smem: SUCCESS (0.008s) [58.200257] Subtest basic: SUCCESS (0.051s) [59.731697] [020/160] (941s left) gem_exec_create (basic) [59.830044] Starting subtest: basic [59.836956] Starting dynamic subtest: smem [63.663393] Dynamic subtest smem: SUCCESS (3.824s) [63.670479] Subtest basic: SUCCESS (3.824s) [63.855457] [021/160] (937s left) gem_exec_fence (basic-busy) [64.083096] Starting subtest: basic-busy [64.089661] Starting dynamic subtest: rcs0 [64.160323] Dynamic subtest rcs0: SUCCESS (0.085s) [64.173176] Starting dynamic subtest: bcs0 [64.220689] Dynamic subtest bcs0: SUCCESS (0.061s) [64.233599] Starting dynamic subtest: vcs0 [64.277356] Dynamic subtest vcs0: SUCCESS (0.056s) [64.290390] Starting dynamic subtest: vcs1 [64.333473] Dynamic subtest vcs1: SUCCESS (0.056s) [64.346382] Starting dynamic subtest: vecs0 [64.395474] Dynamic subtest vecs0: SUCCESS (0.062s) [64.408536] Starting dynamic subtest: ccs0 [64.460776] Dynamic subtest ccs0: SUCCESS (0.065s) [64.467511] Subtest basic-busy: SUCCESS (0.386s) [66.801998] [022/160] (934s left) gem_exec_fence (basic-wait) [67.029302] Starting subtest: basic-wait [67.036384] Starting dynamic subtest: rcs0 [67.104527] Dynamic subtest rcs0: SUCCESS (0.084s) [67.117828] Starting dynamic subtest: bcs0 [67.162956] Dynamic subtest bcs0: SUCCESS (0.058s) [67.176330] Starting dynamic subtest: vcs0 [67.220745] Dynamic subtest vcs0: SUCCESS (0.058s) [67.234383] Starting dynamic subtest: vcs1 [67.276773] Dynamic subtest vcs1: SUCCESS (0.056s) [67.289955] Starting dynamic subtest: vecs0 [67.330876] Dynamic subtest vecs0: SUCCESS (0.054s) [67.344266] Starting dynamic subtest: ccs0 [67.388942] Dynamic subtest ccs0: SUCCESS (0.058s) [67.396172] Subtest basic-wait: SUCCESS (0.370s) [68.800364] [023/160] (932s left) gem_exec_fence (basic-await) [69.038261] Starting subtest: basic-await [69.045061] Starting dynamic subtest: rcs0 [69.145138] Dynamic subtest rcs0: SUCCESS (0.116s) [69.159056] Starting dynamic subtest: bcs0 [69.253179] Dynamic subtest bcs0: SUCCESS (0.107s) [69.266842] Starting dynamic subtest: vcs0 [69.356574] Dynamic subtest vcs0: SUCCESS (0.104s) [69.370096] Starting dynamic subtest: vcs1 [69.465859] Dynamic subtest vcs1: SUCCESS (0.109s) [69.479212] Starting dynamic subtest: vecs0 [69.574594] Dynamic subtest vecs0: SUCCESS (0.109s) [69.587930] Starting dynamic subtest: ccs0 [69.684181] Dynamic subtest ccs0: SUCCESS (0.109s) [69.691484] Subtest basic-await: SUCCESS (0.655s) [71.780168] [024/160] (929s left) gem_exec_fence (nb-await) [72.011872] Starting subtest: nb-await [72.018849] Starting dynamic subtest: rcs0 [72.112055] Dynamic subtest rcs0: SUCCESS (0.109s) [72.125222] Starting dynamic subtest: bcs0 [72.184362] Dynamic subtest bcs0: SUCCESS (0.072s) [72.197521] Starting dynamic subtest: vcs0 [72.249513] Dynamic subtest vcs0: SUCCESS (0.065s) [72.262717] Starting dynamic subtest: vcs1 [72.320083] Dynamic subtest vcs1: SUCCESS (0.070s) [72.333541] Starting dynamic subtest: vecs0 [72.390765] Dynamic subtest vecs0: SUCCESS (0.071s) [72.404239] Starting dynamic subtest: ccs0 [72.462248] Dynamic subtest ccs0: SUCCESS (0.071s) [72.469411] Subtest nb-await: SUCCESS (0.459s) [74.751094] [025/160] (927s left) gem_exec_gttfill (basic) [74.863059] Starting subtest: basic [78.554030] Subtest basic: SUCCESS (3.690s) [78.751835] [026/160] (923s left) gem_exec_parallel (engines) [78.900195] Starting subtest: engines [78.907081] Starting dynamic subtest: basic [82.738296] Dynamic subtest basic: SUCCESS (3.828s) [82.752201] Starting dynamic subtest: contexts [89.998235] Dynamic subtest contexts: SUCCESS (7.260s) [90.012167] Starting dynamic subtest: fds [96.147039] Dynamic subtest fds: SUCCESS (6.148s) [96.161551] Starting dynamic subtest: userptr [99.696765] Dynamic subtest userptr: SUCCESS (3.548s) [99.705084] Subtest engines: SUCCESS (20.786s) [99.897146] [027/160] (901s left) gem_exec_store (basic) [100.014717] Starting subtest: basic [100.135749] Subtest basic: SUCCESS (0.132s) [100.331955] [028/160] (901s left) gem_flink_basic (bad-flink) [100.430304] Starting subtest: bad-flink [100.437863] Subtest bad-flink: SUCCESS (0.000s) [100.526443] [029/160] (901s left) gem_flink_basic (bad-open) [100.611318] Starting subtest: bad-open [100.618286] Subtest bad-open: SUCCESS (0.000s) [100.710310] [030/160] (901s left) gem_flink_basic (basic) [100.800396] Starting subtest: basic [100.806896] Subtest basic: SUCCESS (0.000s) [100.901026] [031/160] (901s left) gem_flink_basic (double-flink) [101.000720] Starting subtest: double-flink [101.008063] Subtest double-flink: SUCCESS (0.000s) [101.106281] [032/160] (900s left) gem_flink_basic (flink-lifetime) [101.195149] Starting subtest: flink-lifetime [101.202582] Subtest flink-lifetime: SUCCESS (0.003s) [101.312803] [033/160] (900s left) gem_huc_copy (huc-copy) [101.425385] Starting subtest: huc-copy [101.439130] Subtest huc-copy: SUCCESS (0.010s) [101.553247] [034/160] (900s left) gem_linear_blits (basic) [101.824595] Starting subtest: basic [101.856307] Subtest basic: SUCCESS (0.031s) [101.986462] [035/160] (900s left) gem_mmap (basic) [102.131148] Subtest basic: SKIP (0.000s) [102.180600] [036/160] (899s left) gem_mmap_gtt (basic) [102.276229] Subtest basic: SKIP (0.000s) [102.324657] [037/160] (899s left) gem_render_linear_blits (basic) [102.420288] Starting subtest: basic [102.491129] Subtest basic: SUCCESS (0.072s) [102.577129] [038/160] (899s left) gem_render_tiled_blits (basic) [102.676293] Subtest basic: SKIP (0.000s) [102.712539] [039/160] (899s left) gem_ringfill (basic-all) [108.727227] Starting subtest: basic-all [109.935499] Subtest basic-all: SUCCESS (1.214s) [110.747116] [040/160] (891s left) gem_softpin (allocator-basic) [110.843901] Starting subtest: allocator-basic [110.979094] Subtest allocator-basic: SUCCESS (0.130s) [111.128277] [041/160] (891s left) gem_softpin (allocator-basic-reserve) [111.232977] Starting subtest: allocator-basic-reserve [111.336952] Subtest allocator-basic-reserve: SUCCESS (0.106s) [111.487117] [042/160] (890s left) gem_softpin (safe-alignment) [111.584072] Starting subtest: safe-alignment [111.664481] Subtest safe-alignment: SUCCESS (0.078s) [113.751588] [043/160] (888s left) gem_sync (basic-all) [113.891052] Starting subtest: basic-all [117.680597] Subtest basic-all: SUCCESS (3.818s) [117.867509] [044/160] (884s left) gem_sync (basic-each) [118.010247] Starting subtest: basic-each [120.575500] Subtest basic-each: SUCCESS (2.604s) [120.773676] [045/160] (881s left) gem_tiled_blits (basic) [120.878367] Subtest basic: SKIP (0.000s) [120.937234] [046/160] (881s left) gem_tiled_fence_blits (basic) [121.039129] Subtest basic: SKIP (0.000s) [121.083384] [047/160] (881s left) gem_tiled_pread_basic [121.228350] [048/160] (881s left) gem_wait (busy@all-engines) [121.335616] Starting subtest: busy [121.342725] Starting dynamic subtest: all-engines [122.734279] Dynamic subtest all-engines: SUCCESS (1.390s) [122.741398] Subtest busy: SUCCESS (1.390s) [122.945570] [049/160] (879s left) gem_wait (wait@all-engines) [123.054579] Starting subtest: wait [123.062075] Starting dynamic subtest: all-engines [124.718462] Dynamic subtest all-engines: SUCCESS (1.656s) [124.725797] Subtest wait: SUCCESS (1.656s) [124.927435] [050/160] (877s left) i915_getparams_basic (basic-eu-total) [125.014778] Starting subtest: basic-eu-total [125.029139] Subtest basic-eu-total: SUCCESS (0.000s) [125.109903] [051/160] (877s left) i915_getparams_basic (basic-subslice-total) [125.201528] Starting subtest: basic-subslice-total [125.215215] Subtest basic-subslice-total: SUCCESS (0.000s) [125.301480] [052/160] (877s left) i915_hangman (error-state-basic) [125.417980] Starting subtest: error-state-basic [125.661444] Subtest error-state-basic: SUCCESS (0.249s) [125.756355] [053/160] (876s left) i915_pciid [125.954297] [054/160] (876s left) kms_addfb_basic (addfb25-4-tiled) [126.076459] Starting subtest: addfb25-4-tiled [126.083253] Subtest addfb25-4-tiled: SUCCESS (0.000s) [126.174335] [055/160] (876s left) kms_addfb_basic (addfb25-bad-modifier) [126.263057] Starting subtest: addfb25-bad-modifier [126.269853] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [126.397586] [056/160] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [126.501551] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [126.619699] [057/160] (876s left) kms_addfb_basic (addfb25-modifier-no-flag) [126.721970] Starting subtest: addfb25-modifier-no-flag [126.729849] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [126.829666] [058/160] (876s left) kms_addfb_basic (addfb25-x-tiled-legacy) [126.932273] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [127.057502] [059/160] (875s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [127.158650] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [127.285604] [060/160] (875s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [127.410648] Starting subtest: addfb25-yf-tiled-legacy [127.417217] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [127.507698] [061/160] (875s left) kms_addfb_basic (addfb25-y-tiled-legacy) [127.625572] Starting subtest: addfb25-y-tiled-legacy [127.632120] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [127.717239] [062/160] (875s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [127.844712] Starting subtest: addfb25-y-tiled-small-legacy [127.858860] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [127.954377] [063/160] (875s left) kms_addfb_basic (bad-pitch-0) [128.043241] Starting subtest: bad-pitch-0 [128.050118] Subtest bad-pitch-0: SUCCESS (0.000s) [128.161197] [064/160] (874s left) kms_addfb_basic (bad-pitch-1024) [128.244024] Starting subtest: bad-pitch-1024 [128.251140] Subtest bad-pitch-1024: SUCCESS (0.000s) [128.360576] [065/160] (874s left) kms_addfb_basic (bad-pitch-128) [128.457729] Starting subtest: bad-pitch-128 [128.464621] Subtest bad-pitch-128: SUCCESS (0.000s) [128.573335] [066/160] (874s left) kms_addfb_basic (bad-pitch-256) [128.665353] Starting subtest: bad-pitch-256 [128.673551] Subtest bad-pitch-256: SUCCESS (0.000s) [128.778534] [067/160] (874s left) kms_addfb_basic (bad-pitch-32) [128.867300] Starting subtest: bad-pitch-32 [128.873832] Subtest bad-pitch-32: SUCCESS (0.000s) [128.993961] [068/160] (874s left) kms_addfb_basic (bad-pitch-63) [129.082136] Starting subtest: bad-pitch-63 [129.089052] Subtest bad-pitch-63: SUCCESS (0.000s) [129.206859] [069/160] (874s left) kms_addfb_basic (bad-pitch-65536) [129.295625] Starting subtest: bad-pitch-65536 [129.302142] Subtest bad-pitch-65536: SUCCESS (0.000s) [129.433345] [070/160] (873s left) kms_addfb_basic (bad-pitch-999) [129.523466] Starting subtest: bad-pitch-999 [129.530444] Subtest bad-pitch-999: SUCCESS (0.000s) [129.656888] [071/160] (873s left) kms_addfb_basic (basic) [129.753118] Starting subtest: basic [129.760498] Subtest basic: SUCCESS (0.000s) [129.870895] [072/160] (873s left) kms_addfb_basic (basic-x-tiled-legacy) [129.964112] Starting subtest: basic-x-tiled-legacy [129.978362] Subtest basic-x-tiled-legacy: SKIP (0.000s) [130.089145] [073/160] (873s left) kms_addfb_basic (basic-y-tiled-legacy) [130.185355] Starting subtest: basic-y-tiled-legacy [130.199630] Subtest basic-y-tiled-legacy: SKIP (0.000s) [130.298041] [074/160] (873s left) kms_addfb_basic (bo-too-small) [130.416724] Starting subtest: bo-too-small [130.424127] Subtest bo-too-small: SUCCESS (0.000s) [130.520297] [075/160] (872s left) kms_addfb_basic (bo-too-small-due-to-tiling) [130.646428] Starting subtest: bo-too-small-due-to-tiling [130.660693] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [130.732240] [076/160] (872s left) kms_addfb_basic (clobberred-modifier) [130.819888] Starting subtest: clobberred-modifier [130.833439] Subtest clobberred-modifier: SKIP (0.000s) [130.938747] [077/160] (872s left) kms_addfb_basic (framebuffer-vs-set-tiling) [131.042254] Starting subtest: framebuffer-vs-set-tiling [131.055765] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [131.165380] [078/160] (872s left) kms_addfb_basic (invalid-get-prop) [131.261502] Starting subtest: invalid-get-prop [131.268060] Subtest invalid-get-prop: SUCCESS (0.000s) [131.393929] [079/160] (872s left) kms_addfb_basic (invalid-get-prop-any) [131.490462] Starting subtest: invalid-get-prop-any [131.497367] Subtest invalid-get-prop-any: SUCCESS (0.000s) [131.621565] [080/160] (871s left) kms_addfb_basic (invalid-set-prop) [131.704609] Starting subtest: invalid-set-prop [131.711164] Subtest invalid-set-prop: SUCCESS (0.000s) [131.838445] [081/160] (871s left) kms_addfb_basic (invalid-set-prop-any) [131.935573] Starting subtest: invalid-set-prop-any [131.942428] Subtest invalid-set-prop-any: SUCCESS (0.000s) [132.047536] [082/160] (871s left) kms_addfb_basic (no-handle) [132.144339] Starting subtest: no-handle [132.151344] Subtest no-handle: SUCCESS (0.000s) [132.273633] [083/160] (871s left) kms_addfb_basic (size-max) [132.392223] Starting subtest: size-max [132.399243] Subtest size-max: SUCCESS (0.000s) [132.483242] [084/160] (871s left) kms_addfb_basic (small-bo) [132.597070] Starting subtest: small-bo [132.603611] Subtest small-bo: SUCCESS (0.000s) [132.691380] [085/160] (871s left) kms_addfb_basic (tile-pitch-mismatch) [132.787636] Starting subtest: tile-pitch-mismatch [132.801354] Subtest tile-pitch-mismatch: SKIP (0.000s) [132.896837] [086/160] (870s left) kms_addfb_basic (too-high) [133.014910] Starting subtest: too-high [133.021782] Subtest too-high: SUCCESS (0.001s) [133.106277] [087/160] (870s left) kms_addfb_basic (too-wide) [133.216673] Starting subtest: too-wide [133.223530] Subtest too-wide: SUCCESS (0.000s) [133.318769] [088/160] (870s left) kms_addfb_basic (unused-handle) [133.402350] Starting subtest: unused-handle [133.409169] Subtest unused-handle: SUCCESS (0.000s) [133.537686] [089/160] (870s left) kms_addfb_basic (unused-modifier) [133.624465] Starting subtest: unused-modifier [133.631379] Subtest unused-modifier: SUCCESS (0.000s) [133.758084] [090/160] (870s left) kms_addfb_basic (unused-offsets) [133.849212] Starting subtest: unused-offsets [133.856049] Subtest unused-offsets: SUCCESS (0.000s) [133.974995] [091/160] (869s left) kms_addfb_basic (unused-pitches) [134.073042] Starting subtest: unused-pitches [134.079808] Subtest unused-pitches: SUCCESS (0.000s) [134.193314] [092/160] (869s left) kms_busy (basic) [134.326323] Starting subtest: basic [134.333214] Starting dynamic subtest: flip [135.272756] Dynamic subtest flip: SUCCESS (0.945s) [135.287346] Starting dynamic subtest: modeset [139.352932] Dynamic subtest modeset: SUCCESS (4.080s) [139.360162] Subtest basic: SUCCESS (5.027s) [140.275220] [093/160] (863s left) kms_prop_blob (basic) [140.366095] Starting subtest: basic [140.373088] Subtest basic: SUCCESS (0.000s) [140.455777] [094/160] (863s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [140.609623] Starting subtest: basic-busy-flip-before-cursor-atomic [140.623703] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [140.787026] [095/160] (863s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [140.937516] Starting subtest: basic-busy-flip-before-cursor-legacy [140.951708] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [141.112941] [096/160] (862s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [141.263837] Starting subtest: basic-flip-after-cursor-atomic [142.590509] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.328s) [143.538692] [097/160] (860s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [143.690501] Starting subtest: basic-flip-after-cursor-legacy [145.007183] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.312s) [145.906650] [098/160] (858s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [146.057357] Starting subtest: basic-flip-after-cursor-varying-size [147.388876] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.327s) [148.336387] [099/160] (855s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [148.490453] Starting subtest: basic-flip-before-cursor-atomic [149.775693] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.288s) [150.705924] [100/160] (853s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [150.852733] Starting subtest: basic-flip-before-cursor-legacy [152.160384] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.310s) [153.074393] [101/160] (851s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [153.230141] Starting subtest: basic-flip-before-cursor-varying-size [154.563289] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.333s) [155.505622] [102/160] (848s left) kms_dsc (dsc-basic) [155.620020] Starting subtest: dsc-basic [155.633406] Subtest dsc-basic: SKIP (0.000s) [155.707723] [103/160] (848s left) kms_flip (basic-flip-vs-dpms) [155.828796] Starting subtest: basic-flip-vs-dpms [155.835404] Starting dynamic subtest: A-eDP1 [158.682516] Dynamic subtest A-eDP1: SUCCESS (2.848s) [158.697500] Starting dynamic subtest: B-eDP1 [160.985563] Dynamic subtest B-eDP1: SUCCESS (2.300s) [161.000688] Starting dynamic subtest: C-eDP1 [164.132633] Dynamic subtest C-eDP1: SUCCESS (3.140s) [164.147027] Starting dynamic subtest: D-eDP1 [166.057377] Dynamic subtest D-eDP1: SUCCESS (1.930s) [166.064930] Subtest basic-flip-vs-dpms: SUCCESS (10.233s) [166.954975] [104/160] (837s left) kms_flip (basic-flip-vs-modeset) [167.079019] Starting subtest: basic-flip-vs-modeset [167.085763] Starting dynamic subtest: A-eDP1 [169.945504] Dynamic subtest A-eDP1: SUCCESS (2.859s) [169.960509] Starting dynamic subtest: B-eDP1 [172.249105] Dynamic subtest B-eDP1: SUCCESS (2.303s) [172.263982] Starting dynamic subtest: C-eDP1 [174.554384] Dynamic subtest C-eDP1: SUCCESS (2.304s) [175.404139] Starting dynamic subtest: D-eDP1 [177.305176] Dynamic subtest D-eDP1: SUCCESS (1.915s) [177.311948] Subtest basic-flip-vs-modeset: SUCCESS (10.230s) [178.226719] [105/160] (826s left) kms_flip (basic-flip-vs-wf_vblank) [178.352225] Starting subtest: basic-flip-vs-wf_vblank [178.358714] Starting dynamic subtest: A-eDP1 [180.693389] Dynamic subtest A-eDP1: SUCCESS (2.344s) [180.708703] Starting dynamic subtest: B-eDP1 [182.829921] Dynamic subtest B-eDP1: SUCCESS (2.135s) [182.845333] Starting dynamic subtest: C-eDP1 [184.924762] Dynamic subtest C-eDP1: SUCCESS (2.093s) [184.939895] Starting dynamic subtest: D-eDP1 [187.037075] Dynamic subtest D-eDP1: SUCCESS (2.111s) [187.044022] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.700s) [188.339725] [106/160] (816s left) kms_flip (basic-plain-flip) [188.462355] Starting subtest: basic-plain-flip [188.468949] Starting dynamic subtest: A-eDP1 [190.356448] Dynamic subtest A-eDP1: SUCCESS (1.893s) [190.372129] Starting dynamic subtest: B-eDP1 [192.210841] Dynamic subtest B-eDP1: SUCCESS (1.852s) [192.226069] Starting dynamic subtest: C-eDP1 [194.051215] Dynamic subtest C-eDP1: SUCCESS (1.837s) [194.066158] Starting dynamic subtest: D-eDP1 [195.844815] Dynamic subtest D-eDP1: SUCCESS (1.791s) [195.851548] Subtest basic-plain-flip: SUCCESS (7.392s) [197.171176] [107/160] (807s left) kms_force_connector_basic (force-connector-state) [197.269493] Starting subtest: force-connector-state [197.736075] Subtest force-connector-state: SUCCESS (0.465s) [198.951878] [108/160] (805s left) kms_force_connector_basic (force-edid) [199.046140] Starting subtest: force-edid [199.069019] Subtest force-edid: SUCCESS (0.030s) [199.202836] [109/160] (805s left) kms_force_connector_basic (force-load-detect) [199.301086] Starting subtest: force-load-detect [199.314957] Subtest force-load-detect: SKIP (0.000s) [199.437800] [110/160] (805s left) kms_force_connector_basic (prune-stale-modes) [199.529294] Starting subtest: prune-stale-modes [199.559308] Subtest prune-stale-modes: SUCCESS (0.028s) [199.686916] [111/160] (804s left) kms_frontbuffer_tracking (basic) [199.828507] Starting subtest: basic [203.747773] Subtest basic: SUCCESS (3.924s) [203.869859] [112/160] (800s left) kms_hdmi_inject (inject-audio) [204.281738] Starting subtest: inject-audio [204.429719] Subtest inject-audio: SUCCESS (0.144s) [205.187265] [113/160] (799s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [205.313075] Starting subtest: compare-crc-sanitycheck-xr24 [205.320267] Starting dynamic subtest: pipe-A-eDP-1 [206.067896] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s) [206.083477] Starting dynamic subtest: pipe-B-eDP-1 [207.464422] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s) [207.479594] Starting dynamic subtest: pipe-C-eDP-1 [208.805093] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.339s) [208.820291] Starting dynamic subtest: pipe-D-eDP-1 [210.170530] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.356s) [210.178273] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.852s) [211.123575] [114/160] (793s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [211.245381] Starting subtest: compare-crc-sanitycheck-nv12 [211.252465] Starting dynamic subtest: pipe-A-eDP-1 [212.170018] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.924s) [212.185175] Starting dynamic subtest: pipe-B-eDP-1 [213.564865] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s) [213.580160] Starting dynamic subtest: pipe-C-eDP-1 [214.923680] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.357s) [215.789033] Starting dynamic subtest: pipe-D-eDP-1 [216.798143] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.030s) [216.805508] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.555s) [217.715168] [115/160] (786s left) kms_pipe_crc_basic (hang-read-crc) [217.836921] Starting subtest: hang-read-crc [217.844322] Starting dynamic subtest: pipe-A-eDP-1 [220.275893] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.442s) [220.291064] Starting dynamic subtest: pipe-B-eDP-1 [223.404291] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.116s) [223.419910] Starting dynamic subtest: pipe-C-eDP-1 [226.401051] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.002s) [227.245247] Starting dynamic subtest: pipe-D-eDP-1 [229.761414] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.528s) [229.768265] Subtest hang-read-crc: SUCCESS (11.922s) [230.707760] [116/160] (774s left) kms_pipe_crc_basic (nonblocking-crc) [230.825752] Starting subtest: nonblocking-crc [230.832640] Starting dynamic subtest: pipe-A-eDP-1 [231.738247] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.911s) [231.753435] Starting dynamic subtest: pipe-B-eDP-1 [233.332124] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.591s) [233.347422] Starting dynamic subtest: pipe-C-eDP-1 [234.892140] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.557s) [234.907667] Starting dynamic subtest: pipe-D-eDP-1 [236.462269] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.557s) [236.469183] Subtest nonblocking-crc: SUCCESS (5.629s) [237.377547] [117/160] (767s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [237.513730] Starting subtest: nonblocking-crc-frame-sequence [237.526950] Starting dynamic subtest: pipe-A-eDP-1 [238.428610] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.909s) [238.443717] Starting dynamic subtest: pipe-B-eDP-1 [240.013095] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.589s) [240.029767] Starting dynamic subtest: pipe-C-eDP-1 [241.572734] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.557s) [241.588561] Starting dynamic subtest: pipe-D-eDP-1 [243.133266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.557s) [243.140234] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.624s) [244.084768] [118/160] (760s left) kms_pipe_crc_basic (read-crc) [244.203179] Starting subtest: read-crc [244.209996] Starting dynamic subtest: pipe-A-eDP-1 [245.064195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.861s) [245.079813] Starting dynamic subtest: pipe-B-eDP-1 [246.620031] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.553s) [246.635956] Starting dynamic subtest: pipe-C-eDP-1 [248.130802] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.507s) [248.146860] Starting dynamic subtest: pipe-D-eDP-1 [249.642573] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.509s) [249.650114] Subtest read-crc: SUCCESS (5.443s) [250.546713] [119/160] (754s left) kms_pipe_crc_basic (read-crc-frame-sequence) [250.669502] Starting subtest: read-crc-frame-sequence [250.676496] Starting dynamic subtest: pipe-A-eDP-1 [251.550265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.881s) [251.565860] Starting dynamic subtest: pipe-B-eDP-1 [253.089657] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.537s) [253.104776] Starting dynamic subtest: pipe-C-eDP-1 [254.601637] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.509s) [254.616671] Starting dynamic subtest: pipe-D-eDP-1 [256.113838] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.509s) [256.120734] Subtest read-crc-frame-sequence: SUCCESS (5.448s) [257.074623] [120/160] (747s left) kms_pm_backlight (basic-brightness) [257.197088] Starting subtest: basic-brightness [257.323594] Starting dynamic subtest: eDP-1 [257.851917] Dynamic subtest eDP-1: SUCCESS (0.532s) [257.858961] Subtest basic-brightness: SUCCESS (0.660s) [258.804072] [121/160] (746s left) kms_pm_rpm (basic-pci-d3-state) [260.903535] Starting subtest: basic-pci-d3-state [265.109105] Subtest basic-pci-d3-state: SUCCESS (4.203s) [265.425034] [122/160] (739s left) kms_pm_rpm (basic-rte) [265.508829] Starting subtest: basic-rte [271.637430] Subtest basic-rte: SUCCESS (6.131s) [273.079930] [123/160] (731s left) kms_psr (psr-primary-page-flip) [273.199861] Starting subtest: psr-primary-page-flip [273.206669] Starting dynamic subtest: eDP-1 [275.185683] Dynamic subtest eDP-1: SUCCESS (1.989s) [275.192536] Subtest psr-primary-page-flip: SUCCESS (1.991s) [276.147603] [124/160] (728s left) kms_psr (psr-cursor-plane-move) [276.290035] Starting subtest: psr-cursor-plane-move [276.304325] Starting dynamic subtest: eDP-1 [278.245590] Dynamic subtest eDP-1: SUCCESS (1.962s) [278.252972] Subtest psr-cursor-plane-move: SUCCESS (1.965s) [279.154772] [125/160] (725s left) kms_psr (psr-sprite-plane-onoff) [279.276091] Starting subtest: psr-sprite-plane-onoff [279.283205] Starting dynamic subtest: eDP-1 [281.331900] Dynamic subtest eDP-1: SUCCESS (2.047s) [281.338994] Subtest psr-sprite-plane-onoff: SUCCESS (2.050s) [282.225064] [126/160] (722s left) kms_psr (psr-primary-mmap-gtt) [282.335588] Starting subtest: psr-primary-mmap-gtt [282.342445] Starting dynamic subtest: eDP-1 [284.059412] Dynamic subtest eDP-1: SKIP (1.705s) [284.078805] Subtest psr-primary-mmap-gtt: SKIP (1.707s) [284.234977] [127/160] (720s left) kms_setmode (basic-clone-single-crtc) [284.329257] Starting subtest: basic-clone-single-crtc [284.349915] Subtest basic-clone-single-crtc: SKIP (0.001s) [284.443326] [128/160] (720s left) i915_pm_rps (basic-api) [284.555155] Starting subtest: basic-api [284.570110] Subtest basic-api: SKIP (0.001s) [284.669307] [129/160] (720s left) prime_self_import (basic-llseek-bad) [284.740497] Starting subtest: basic-llseek-bad [284.754297] Subtest basic-llseek-bad: SUCCESS (0.010s) [284.858133] [130/160] (720s left) prime_self_import (basic-llseek-size) [284.939574] Starting subtest: basic-llseek-size [284.953221] Subtest basic-llseek-size: SUCCESS (0.011s) [285.047851] [131/160] (720s left) prime_self_import (basic-with_fd_dup) [285.129148] Starting subtest: basic-with_fd_dup [285.143350] Subtest basic-with_fd_dup: SUCCESS (0.011s) [285.235183] [132/160] (720s left) prime_self_import (basic-with_one_bo) [285.317923] Starting subtest: basic-with_one_bo [285.331808] Subtest basic-with_one_bo: SUCCESS (0.016s) [285.433516] [133/160] (719s left) prime_self_import (basic-with_one_bo_two_files) [285.525821] Starting subtest: basic-with_one_bo_two_files [285.540050] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s) [285.639491] [134/160] (719s left) prime_self_import (basic-with_two_bos) [285.723615] Starting subtest: basic-with_two_bos [285.737617] Subtest basic-with_two_bos: SUCCESS (0.011s) [285.825979] [135/160] (719s left) prime_vgem (basic-fence-flip) [285.937980] Starting subtest: basic-fence-flip [286.395288] Subtest basic-fence-flip: SUCCESS (0.459s) [286.515557] [136/160] (718s left) prime_vgem (basic-fence-mmap) [286.634311] Starting subtest: basic-fence-mmap [286.647635] Subtest basic-fence-mmap: SKIP (0.000s) [286.731860] [137/160] (718s left) prime_vgem (basic-fence-read) [286.830623] Starting subtest: basic-fence-read [286.845655] Subtest basic-fence-read: SKIP (0.008s) [286.948296] [138/160] (718s left) prime_vgem (basic-gtt) [287.057571] Starting subtest: basic-gtt [287.071463] Subtest basic-gtt: SKIP (0.000s) [287.150157] [139/160] (718s left) prime_vgem (basic-read) [287.251946] Starting subtest: basic-read [287.266294] Subtest basic-read: SKIP (0.008s) [287.349898] [140/160] (718s left) prime_vgem (basic-write) [287.448818] Starting subtest: basic-write [287.468910] Subtest basic-write: SKIP (0.008s) [287.564712] [141/160] (718s left) vgem_basic (setversion) [287.671271] Starting subtest: setversion [287.686051] Subtest setversion: SUCCESS (0.000s) [287.730641] [142/160] (717s left) vgem_basic (create) [287.820737] Starting subtest: create [287.827987] Subtest create: SUCCESS (0.000s) [287.883238] [143/160] (717s left) vgem_basic (debugfs) [287.988451] Starting subtest: debugfs [287.995299] Subtest debugfs: SUCCESS (0.000s) [288.048974] [144/160] (717s left) vgem_basic (dmabuf-export) [288.147277] Starting subtest: dmabuf-export [288.161076] Subtest dmabuf-export: SUCCESS (0.026s) [288.270801] [145/160] (717s left) vgem_basic (dmabuf-fence) [288.383977] Starting subtest: dmabuf-fence [288.393967] Subtest dmabuf-fence: SUCCESS (0.001s) [288.447496] [146/160] (717s left) vgem_basic (dmabuf-fence-before) [288.555798] Starting subtest: dmabuf-fence-before [288.565803] Subtest dmabuf-fence-before: SUCCESS (0.000s) [288.619892] [147/160] (717s left) vgem_basic (dmabuf-mmap) [288.733581] Starting subtest: dmabuf-mmap [288.753057] Subtest dmabuf-mmap: SUCCESS (0.017s) [288.816343] [148/160] (717s left) vgem_basic (mmap) [288.929478] Starting subtest: mmap [288.938367] Subtest mmap: SUCCESS (0.011s) [288.993244] [149/160] (716s left) vgem_basic (second-client) [289.097273] Starting subtest: second-client [289.132203] Subtest second-client: SUCCESS (0.034s) [289.191717] [150/160] (716s left) vgem_basic (sysfs) [289.281096] Starting subtest: sysfs [289.288557] Subtest sysfs: SUCCESS (0.001s) [289.340481] [151/160] (716s left) core_hotunplug (unbind-rebind) [289.481886] Starting subtest: unbind-rebind [294.418136] Subtest unbind-rebind: SUCCESS (4.933s) [294.453878] [152/160] (711s left) vgem_basic (unload) [294.544541] Starting subtest: unload [323.505087] Subtest unload: SUCCESS (28.964s) [323.629329] [153/160] (682s left) i915_module_load (reload) [323.707776] Starting subtest: reload [327.001743] Subtest reload: SUCCESS (3.300s) [327.033623] [154/160] (679s left) gem_lmem_swapping (basic) [327.134498] Subtest basic: SKIP (0.000s) [327.169701] [155/160] (678s left) gem_lmem_swapping (parallel-random-engines) [327.272652] Subtest parallel-random-engines: SKIP (0.000s) [327.303833] [156/160] (678s left) gem_lmem_swapping (random-engines) [327.406755] Subtest random-engines: SKIP (0.000s) [327.437757] [157/160] (678s left) gem_lmem_swapping (verify-random) [327.537644] Subtest verify-random: SKIP (0.000s) [327.569114] [158/160] (678s left) i915_pm_rpm (module-reload) [347.075733] Starting subtest: module-reload [394.702049] Subtest module-reload: SUCCESS (47.620s) [394.732683] [159/160] (611s left) i915_selftest (live) [394.817568] Starting subtest: live [394.824804] Starting dynamic subtest: sanitycheck [416.988733] Dynamic subtest sanitycheck: SUCCESS (22.162s) [417.000835] Starting dynamic subtest: uncore [439.136877] Dynamic subtest uncore: SUCCESS (22.148s) [439.148962] Starting dynamic subtest: workarounds [461.314310] Dynamic subtest workarounds: SUCCESS (22.177s) [461.326511] Starting dynamic subtest: gt_engines [483.480168] Dynamic subtest gt_engines: SUCCESS (22.164s) [483.492504] Starting dynamic subtest: gt_timelines [543.000468] Dynamic subtest gt_timelines: SUCCESS (59.519s) [543.011252] Starting dynamic subtest: gt_contexts [565.152445] Dynamic subtest gt_contexts: SUCCESS (22.152s) [565.164872] Starting dynamic subtest: gt_lrc [587.346427] Dynamic subtest gt_lrc: SUCCESS (22.193s) [587.358879] Starting dynamic subtest: gt_mocs [609.496396] Dynamic subtest gt_mocs: SUCCESS (22.148s) [609.508797] Starting dynamic subtest: gt_pm [631.680124] Dynamic subtest gt_pm: SUCCESS (22.184s) [631.692200] Starting dynamic subtest: gt_heartbeat [653.871225] Dynamic subtest gt_heartbeat: SUCCESS (22.190s) [653.883306] Starting dynamic subtest: gt_tlb [675.689567] Dynamic subtest gt_tlb: SUCCESS (21.817s) [675.701891] Starting dynamic subtest: requests [697.998164] Dynamic subtest requests: SUCCESS (22.307s) [698.010426] Starting dynamic subtest: migrate [720.156249] Dynamic subtest migrate: SUCCESS (22.157s) [720.168679] Starting dynamic subtest: active [742.325872] Dynamic subtest active: SUCCESS (22.169s) [742.337947] Starting dynamic subtest: objects [764.436203] Dynamic subtest objects: SUCCESS (22.110s) [764.448295] Starting dynamic subtest: mman [786.637043] Dynamic subtest mman: SUCCESS (22.200s) [786.649159] Starting dynamic subtest: dmabuf [808.826686] Dynamic subtest dmabuf: SUCCESS (22.186s) [808.839324] Starting dynamic subtest: vma [830.991577] Dynamic subtest vma: SUCCESS (22.164s) [831.004060] Starting dynamic subtest: coherency [853.170253] Dynamic subtest coherency: SUCCESS (22.179s) [853.182912] Starting dynamic subtest: gtt [875.354432] Dynamic subtest gtt: SUCCESS (22.184s) [875.366806] Starting dynamic subtest: gem [899.342154] Dynamic subtest gem: SUCCESS (23.986s) [899.354321] Starting dynamic subtest: evict [921.449150] Dynamic subtest evict: SUCCESS (22.107s) [921.461307] Starting dynamic subtest: hugepages [943.632545] Dynamic subtest hugepages: SUCCESS (22.182s) [943.645108] Starting dynamic subtest: gem_contexts [1063.940185] Per-test timeout exceeded. Killing the current test with SIGQUIT. [1067.557318] Overall timeout time exceeded, stopping. [1067.557634] Closing watchdogs Done.