[40.823611] Initializing watchdogs [40.823671] /dev/watchdog0 [40.830085] [001/171] (960s left) i915_module_load (load) [40.884831] Starting subtest: load [41.803725] Subtest load: SUCCESS (0.919s) [41.818903] [002/171] (959s left) core_auth (basic-auth) [41.911158] Starting subtest: basic-auth [41.912661] Subtest basic-auth: SUCCESS (0.001s) [41.965646] [003/171] (959s left) debugfs_test (read_all_entries) [42.022602] Starting subtest: read_all_entries [42.070670] Subtest read_all_entries: SUCCESS (0.048s) [42.181282] [004/171] (959s left) debugfs_test (basic-hwmon) [42.236205] Starting subtest: basic-hwmon [42.239129] Subtest basic-hwmon: SKIP (0.000s) [42.332254] [005/171] (959s left) fbdev (eof) [42.387147] Starting subtest: eof [42.388842] Subtest eof: SUCCESS (0.000s) [42.435936] [006/171] (958s left) fbdev (info) [42.507579] Starting subtest: info [42.509246] Subtest info: SUCCESS (0.000s) [42.574563] [007/171] (958s left) fbdev (nullptr) [42.636965] Starting subtest: nullptr [42.638817] Subtest nullptr: SUCCESS (0.000s) [42.681914] [008/171] (958s left) fbdev (read) [42.753647] Starting subtest: read [42.973139] Subtest read: SUCCESS (0.219s) [43.014829] [009/171] (958s left) fbdev (write) [43.070237] Starting subtest: write [43.181773] Subtest write: SUCCESS (0.111s) [43.215113] [010/171] (958s left) gem_basic (bad-close) [43.268508] Starting subtest: bad-close [43.271863] Subtest bad-close: SUCCESS (0.000s) [43.314998] [011/171] (958s left) gem_basic (create-close) [43.370148] Starting subtest: create-close [43.373581] Subtest create-close: SUCCESS (0.000s) [43.438356] [012/171] (958s left) gem_basic (create-fd-close) [43.528228] Starting subtest: create-fd-close [43.531675] Subtest create-fd-close: SUCCESS (0.000s) [43.603356] [013/171] (957s left) gem_busy (busy@all-engines) [43.693019] Starting subtest: busy [43.694600] Starting dynamic subtest: all-engines [43.715196] Dynamic subtest all-engines: SUCCESS (0.022s) [43.716798] Subtest busy: SUCCESS (0.022s) [44.061283] [014/171] (957s left) gem_close_race (basic-process) [44.122532] Starting subtest: basic-process [44.169931] Subtest basic-process: SUCCESS (0.047s) [44.348666] [015/171] (957s left) gem_close_race (basic-threads) [44.467423] Starting subtest: basic-threads [45.705158] Subtest basic-threads: SUCCESS (1.238s) [45.918648] [016/171] (955s left) gem_ctx_create (basic) [45.976153] Starting subtest: basic [45.977589] Subtest basic: SUCCESS (0.000s) [46.181330] [017/171] (955s left) gem_ctx_create (basic-files) [46.286894] Starting subtest: basic-files [48.297148] Subtest basic-files: SUCCESS (2.010s) [48.524213] [018/171] (953s left) gem_ctx_exec (basic) [48.620692] Starting subtest: basic [48.624533] Subtest basic: SUCCESS (0.004s) [48.756132] [019/171] (952s left) gem_exec_basic (basic) [48.829072] Starting subtest: basic [48.830569] Starting dynamic subtest: rcs0-smem [48.832096] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [48.837205] Starting dynamic subtest: bcs0-smem [48.838816] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [48.843878] Starting dynamic subtest: vcs0-smem [48.845445] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [48.850260] Starting dynamic subtest: vecs0-smem [48.851866] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [48.853439] Subtest basic: SUCCESS (0.002s) [49.050652] [020/171] (952s left) gem_exec_create (basic) [49.122019] Starting subtest: basic [49.124074] Starting dynamic subtest: smem [51.167894] Dynamic subtest smem: SUCCESS (2.046s) [51.169621] Subtest basic: SUCCESS (2.046s) [51.334025] [021/171] (950s left) gem_exec_fence (basic-busy) [51.513828] Starting subtest: basic-busy [51.515577] Starting dynamic subtest: rcs0 [51.543702] Dynamic subtest rcs0: SUCCESS (0.030s) [51.551474] Starting dynamic subtest: bcs0 [51.575841] Dynamic subtest bcs0: SUCCESS (0.032s) [51.582791] Starting dynamic subtest: vcs0 [51.597050] Dynamic subtest vcs0: SUCCESS (0.021s) [51.608968] Starting dynamic subtest: vecs0 [51.629448] Dynamic subtest vecs0: SUCCESS (0.032s) [51.631964] Subtest basic-busy: SUCCESS (0.115s) [52.192311] [022/171] (949s left) gem_exec_fence (basic-wait) [52.392713] Starting subtest: basic-wait [52.395310] Starting dynamic subtest: rcs0 [52.419755] Dynamic subtest rcs0: SUCCESS (0.028s) [52.425180] Starting dynamic subtest: bcs0 [52.448856] Dynamic subtest bcs0: SUCCESS (0.029s) [52.455996] Starting dynamic subtest: vcs0 [52.475092] Dynamic subtest vcs0: SUCCESS (0.026s) [52.490054] Starting dynamic subtest: vecs0 [52.511919] Dynamic subtest vecs0: SUCCESS (0.036s) [52.514535] Subtest basic-wait: SUCCESS (0.119s) [53.033207] [023/171] (948s left) gem_exec_fence (basic-await) [53.257153] Starting subtest: basic-await [53.259815] Starting dynamic subtest: rcs0 [53.345440] Dynamic subtest rcs0: SUCCESS (0.089s) [53.352674] Starting dynamic subtest: bcs0 [53.421532] Dynamic subtest bcs0: SUCCESS (0.075s) [53.443618] Starting dynamic subtest: vcs0 [53.521101] Dynamic subtest vcs0: SUCCESS (0.100s) [53.528564] Starting dynamic subtest: vecs0 [53.597160] Dynamic subtest vecs0: SUCCESS (0.075s) [53.599489] Subtest basic-await: SUCCESS (0.340s) [54.125957] [024/171] (947s left) gem_exec_fence (nb-await) [54.315105] Starting subtest: nb-await [54.316541] Starting dynamic subtest: rcs0 [54.375497] Dynamic subtest rcs0: SUCCESS (0.059s) [54.384552] Starting dynamic subtest: bcs0 [54.434927] Dynamic subtest bcs0: SUCCESS (0.060s) [54.445776] Starting dynamic subtest: vcs0 [54.496852] Dynamic subtest vcs0: SUCCESS (0.061s) [54.518964] Starting dynamic subtest: vecs0 [54.569884] Dynamic subtest vecs0: SUCCESS (0.073s) [54.572601] Subtest nb-await: SUCCESS (0.254s) [55.075315] [025/171] (946s left) gem_exec_gttfill (basic) [55.134288] Starting subtest: basic [59.845896] Subtest basic: SUCCESS (4.711s) [59.998477] [026/171] (941s left) gem_exec_parallel (engines) [60.104680] Starting subtest: engines [60.106375] Starting dynamic subtest: basic [61.526899] Dynamic subtest basic: SUCCESS (1.422s) [61.532873] Starting dynamic subtest: contexts [64.060053] Dynamic subtest contexts: SUCCESS (2.533s) [64.066165] Starting dynamic subtest: fds [66.382822] Dynamic subtest fds: SUCCESS (2.323s) [66.388758] Starting dynamic subtest: userptr [68.055968] Dynamic subtest userptr: SUCCESS (1.673s) [68.057708] Subtest engines: SUCCESS (7.952s) [68.272491] [027/171] (933s left) gem_exec_store (basic) [68.368610] Starting subtest: basic [68.416844] Subtest basic: SUCCESS (0.049s) [68.607107] [028/171] (933s left) gem_flink_basic (bad-flink) [68.675471] Starting subtest: bad-flink [68.677165] Subtest bad-flink: SUCCESS (0.000s) [68.735833] [029/171] (933s left) gem_flink_basic (bad-open) [68.792973] Starting subtest: bad-open [68.794690] Subtest bad-open: SUCCESS (0.000s) [68.852940] [030/171] (933s left) gem_flink_basic (basic) [68.925188] Starting subtest: basic [68.926900] Subtest basic: SUCCESS (0.000s) [68.984922] [031/171] (932s left) gem_flink_basic (double-flink) [69.040131] Starting subtest: double-flink [69.041664] Subtest double-flink: SUCCESS (0.000s) [69.127641] [032/171] (932s left) gem_flink_basic (flink-lifetime) [69.211820] Starting subtest: flink-lifetime [69.213390] Subtest flink-lifetime: SUCCESS (0.001s) [69.287760] [033/171] (932s left) gem_huc_copy (huc-copy) [69.348522] Starting subtest: huc-copy [69.351260] Subtest huc-copy: SKIP (0.000s) [69.475690] [034/171] (932s left) gem_linear_blits (basic) [69.653255] Starting subtest: basic [69.657488] Subtest basic: SUCCESS (0.004s) [69.803878] [035/171] (932s left) gem_mmap (basic) [69.919680] Starting subtest: basic [69.928469] Subtest basic: SUCCESS (0.000s) [70.035146] [036/171] (932s left) gem_mmap_gtt (basic) [70.091698] Starting subtest: basic [70.093242] Subtest basic: SUCCESS (0.000s) [70.144463] [037/171] (932s left) gem_render_linear_blits (basic) [70.200357] Starting subtest: basic [70.218261] Subtest basic: SUCCESS (0.018s) [70.261261] [038/171] (931s left) gem_render_tiled_blits (basic) [70.319269] Starting subtest: basic [70.346903] Subtest basic: SUCCESS (0.028s) [70.396539] [039/171] (931s left) gem_ringfill (basic-all) [70.645345] Starting subtest: basic-all [71.792634] Subtest basic-all: SUCCESS (1.148s) [71.928618] [040/171] (930s left) gem_softpin (allocator-basic) [72.034592] Starting subtest: allocator-basic [72.095825] Subtest allocator-basic: SUCCESS (0.062s) [72.224364] [041/171] (930s left) gem_softpin (allocator-basic-reserve) [72.291981] Starting subtest: allocator-basic-reserve [72.350465] Subtest allocator-basic-reserve: SUCCESS (0.060s) [72.459127] [042/171] (929s left) gem_softpin (safe-alignment) [72.529089] Starting subtest: safe-alignment [72.536015] Subtest safe-alignment: SUCCESS (0.007s) [72.657935] [043/171] (929s left) gem_sync (basic-all) [72.722647] Starting subtest: basic-all [74.790710] Subtest basic-all: SUCCESS (2.074s) [74.949120] [044/171] (927s left) gem_sync (basic-each) [75.015625] Starting subtest: basic-each [77.068128] Subtest basic-each: SUCCESS (2.059s) [77.278965] [045/171] (925s left) gem_tiled_blits (basic) [77.453121] Starting subtest: basic [77.465544] Subtest basic: SUCCESS (0.012s) [77.595878] [046/171] (924s left) gem_tiled_fence_blits (basic) [77.760423] Starting subtest: basic [77.768646] Subtest basic: SUCCESS (0.008s) [77.890181] [047/171] (924s left) gem_tiled_pread_basic [78.159958] [048/171] (924s left) gem_wait (busy@all-engines) [78.257181] Starting subtest: busy [78.258776] Starting dynamic subtest: all-engines [78.775794] Dynamic subtest all-engines: SUCCESS (0.519s) [78.777382] Subtest busy: SUCCESS (0.519s) [78.951950] [049/171] (923s left) gem_wait (wait@all-engines) [79.012911] Starting subtest: wait [79.014770] Starting dynamic subtest: all-engines [80.046812] Dynamic subtest all-engines: SUCCESS (1.033s) [80.049464] Subtest wait: SUCCESS (1.034s) [80.277875] [050/171] (922s left) i915_getparams_basic (basic-eu-total) [80.339442] Starting subtest: basic-eu-total [80.342813] Subtest basic-eu-total: SUCCESS (0.000s) [80.431393] [051/171] (922s left) i915_getparams_basic (basic-subslice-total) [80.493202] Starting subtest: basic-subslice-total [80.496320] Subtest basic-subslice-total: SUCCESS (0.000s) [80.552541] [052/171] (922s left) i915_hangman (error-state-basic) [80.628953] Starting subtest: error-state-basic [80.634988] Subtest error-state-basic: SUCCESS (0.004s) [80.709151] [053/171] (921s left) i915_pciid [80.849666] [054/171] (921s left) kms_addfb_basic (addfb25-bad-modifier) [80.946039] Starting subtest: addfb25-bad-modifier [80.947495] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [81.082314] [055/171] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [81.135411] Starting subtest: addfb25-framebuffer-vs-set-tiling [81.137310] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [81.249271] [056/171] (921s left) kms_addfb_basic (addfb25-modifier-no-flag) [81.302867] Starting subtest: addfb25-modifier-no-flag [81.304468] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [81.432699] [057/171] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy) [81.493645] Starting subtest: addfb25-x-tiled-legacy [81.495398] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [81.615578] [058/171] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [81.672084] Starting subtest: addfb25-x-tiled-mismatch-legacy [81.673639] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [81.798978] [059/171] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [81.898491] Starting subtest: addfb25-yf-tiled-legacy [81.900027] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [81.982386] [060/171] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy) [82.092245] Starting subtest: addfb25-y-tiled-legacy [82.093747] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [82.165968] [061/171] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [82.269126] Starting subtest: addfb25-y-tiled-small-legacy [82.270632] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [82.332286] [062/171] (920s left) kms_addfb_basic (bad-pitch-0) [82.384731] Starting subtest: bad-pitch-0 [82.386316] Subtest bad-pitch-0: SUCCESS (0.000s) [82.516039] [063/171] (920s left) kms_addfb_basic (bad-pitch-1024) [82.569094] Starting subtest: bad-pitch-1024 [82.570842] Subtest bad-pitch-1024: SUCCESS (0.000s) [82.682599] [064/171] (920s left) kms_addfb_basic (bad-pitch-128) [82.735364] Starting subtest: bad-pitch-128 [82.736901] Subtest bad-pitch-128: SUCCESS (0.000s) [82.877939] [065/171] (919s left) kms_addfb_basic (bad-pitch-256) [82.937828] Starting subtest: bad-pitch-256 [82.939583] Subtest bad-pitch-256: SUCCESS (0.000s) [83.058118] [066/171] (919s left) kms_addfb_basic (bad-pitch-32) [83.114782] Starting subtest: bad-pitch-32 [83.116371] Subtest bad-pitch-32: SUCCESS (0.000s) [83.232518] [067/171] (919s left) kms_addfb_basic (bad-pitch-63) [83.286618] Starting subtest: bad-pitch-63 [83.288345] Subtest bad-pitch-63: SUCCESS (0.000s) [83.403299] [068/171] (919s left) kms_addfb_basic (bad-pitch-65536) [83.456787] Starting subtest: bad-pitch-65536 [83.458287] Subtest bad-pitch-65536: SUCCESS (0.000s) [83.565968] [069/171] (919s left) kms_addfb_basic (bad-pitch-999) [83.618856] Starting subtest: bad-pitch-999 [83.620571] Subtest bad-pitch-999: SUCCESS (0.000s) [83.732153] [070/171] (919s left) kms_addfb_basic (basic) [83.784377] Starting subtest: basic [83.785929] Subtest basic: SUCCESS (0.000s) [83.898994] [071/171] (918s left) kms_addfb_basic (basic-x-tiled-legacy) [83.951787] Starting subtest: basic-x-tiled-legacy [83.953346] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [84.065996] [072/171] (918s left) kms_addfb_basic (basic-y-tiled-legacy) [84.118841] Starting subtest: basic-y-tiled-legacy [84.120351] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [84.249308] [073/171] (918s left) kms_addfb_basic (bo-too-small) [84.350376] Starting subtest: bo-too-small [84.351893] Subtest bo-too-small: SUCCESS (0.000s) [84.432379] [074/171] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling) [84.533272] Starting subtest: bo-too-small-due-to-tiling [84.534790] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [84.599295] [075/171] (918s left) kms_addfb_basic (clobberred-modifier) [84.653035] Starting subtest: clobberred-modifier [84.654589] Subtest clobberred-modifier: SUCCESS (0.000s) [84.765995] [076/171] (918s left) kms_addfb_basic (framebuffer-vs-set-tiling) [84.819372] Starting subtest: framebuffer-vs-set-tiling [84.820832] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [84.977231] [077/171] (917s left) kms_addfb_basic (invalid-get-prop) [85.041179] Starting subtest: invalid-get-prop [85.042749] Subtest invalid-get-prop: SUCCESS (0.000s) [85.165906] [078/171] (917s left) kms_addfb_basic (invalid-get-prop-any) [85.218507] Starting subtest: invalid-get-prop-any [85.220068] Subtest invalid-get-prop-any: SUCCESS (0.000s) [85.332330] [079/171] (917s left) kms_addfb_basic (invalid-set-prop) [85.384231] Starting subtest: invalid-set-prop [85.385687] Subtest invalid-set-prop: SUCCESS (0.000s) [85.498995] [080/171] (917s left) kms_addfb_basic (invalid-set-prop-any) [85.551708] Starting subtest: invalid-set-prop-any [85.553295] Subtest invalid-set-prop-any: SUCCESS (0.000s) [85.682608] [081/171] (917s left) kms_addfb_basic (no-handle) [85.735202] Starting subtest: no-handle [85.736810] Subtest no-handle: SUCCESS (0.000s) [85.849112] [082/171] (917s left) kms_addfb_basic (size-max) [85.951133] Starting subtest: size-max [85.952553] Subtest size-max: SUCCESS (0.000s) [86.032348] [083/171] (917s left) kms_addfb_basic (small-bo) [86.138826] Starting subtest: small-bo [86.140389] Subtest small-bo: SUCCESS (0.000s) [86.199321] [084/171] (916s left) kms_addfb_basic (tile-pitch-mismatch) [86.252219] Starting subtest: tile-pitch-mismatch [86.253759] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [86.382494] [085/171] (916s left) kms_addfb_basic (too-high) [86.491152] Starting subtest: too-high [86.492699] Subtest too-high: SUCCESS (0.000s) [86.550303] [086/171] (916s left) kms_addfb_basic (too-wide) [86.654475] Starting subtest: too-wide [86.655976] Subtest too-wide: SUCCESS (0.000s) [86.732440] [087/171] (916s left) kms_addfb_basic (unused-handle) [86.785617] Starting subtest: unused-handle [86.787422] Subtest unused-handle: SUCCESS (0.000s) [86.916368] [088/171] (916s left) kms_addfb_basic (unused-modifier) [86.969146] Starting subtest: unused-modifier [86.970773] Subtest unused-modifier: SUCCESS (0.000s) [87.082278] [089/171] (916s left) kms_addfb_basic (unused-offsets) [87.138885] Starting subtest: unused-offsets [87.140474] Subtest unused-offsets: SUCCESS (0.000s) [87.249256] [090/171] (915s left) kms_addfb_basic (unused-pitches) [87.301984] Starting subtest: unused-pitches [87.303567] Subtest unused-pitches: SUCCESS (0.000s) [87.416007] [091/171] (915s left) kms_busy (basic) [87.518165] Starting subtest: basic [87.519709] Starting dynamic subtest: flip [88.091009] Dynamic subtest flip: SUCCESS (0.572s) [88.099218] Starting dynamic subtest: modeset [88.479712] Dynamic subtest modeset: SUCCESS (0.388s) [88.481090] Subtest basic: SUCCESS (0.961s) [88.598477] [092/171] (914s left) kms_chamelium_hpd (dp-hpd-fast) [88.725552] Subtest dp-hpd-fast: SKIP (0.000s) [88.772269] [093/171] (914s left) kms_chamelium_edid (dp-edid-read) [88.902539] Subtest dp-edid-read: SKIP (0.000s) [88.948976] [094/171] (914s left) kms_chamelium_frames (dp-crc-fast) [89.079425] Subtest dp-crc-fast: SKIP (0.000s) [89.127644] [095/171] (914s left) kms_chamelium_hpd (hdmi-hpd-fast) [89.257523] Subtest hdmi-hpd-fast: SKIP (0.000s) [89.305139] [096/171] (913s left) kms_chamelium_edid (hdmi-edid-read) [89.436121] Subtest hdmi-edid-read: SKIP (0.000s) [89.483770] [097/171] (913s left) kms_chamelium_frames (hdmi-crc-fast) [89.613687] Subtest hdmi-crc-fast: SKIP (0.000s) [89.661469] [098/171] (913s left) kms_chamelium_hpd (vga-hpd-fast) [89.792565] Subtest vga-hpd-fast: SKIP (0.000s) [89.839495] [099/171] (913s left) kms_chamelium_edid (vga-edid-read) [89.968740] Subtest vga-edid-read: SKIP (0.000s) [90.017318] [100/171] (913s left) kms_prop_blob (basic) [90.070809] Starting subtest: basic [90.072327] Subtest basic: SUCCESS (0.000s) [90.119709] [101/171] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [90.223212] Starting subtest: basic-busy-flip-before-cursor-atomic [90.226172] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [90.286317] [102/171] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [90.387378] Starting subtest: basic-busy-flip-before-cursor-legacy [90.390438] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [90.437438] [103/171] (912s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [90.537992] Starting subtest: basic-flip-after-cursor-atomic [91.444317] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.905s) [91.547868] [104/171] (911s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [91.650019] Starting subtest: basic-flip-after-cursor-legacy [92.554486] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.903s) [92.659914] [105/171] (910s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [92.763805] Starting subtest: basic-flip-after-cursor-varying-size [93.685717] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.921s) [93.783294] [106/171] (909s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [93.883248] Starting subtest: basic-flip-before-cursor-atomic [94.790667] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.906s) [94.899323] [107/171] (908s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [95.002221] Starting subtest: basic-flip-before-cursor-legacy [95.923380] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.922s) [96.018448] [108/171] (907s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [96.121051] Starting subtest: basic-flip-before-cursor-varying-size [97.025834] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.904s) [97.128845] [109/171] (906s left) kms_flip (basic-flip-vs-dpms) [97.218809] Starting subtest: basic-flip-vs-dpms [97.220196] Starting dynamic subtest: A-HDMI-A1 [98.087758] Dynamic subtest A-HDMI-A1: SUCCESS (0.868s) [98.094022] Starting dynamic subtest: B-HDMI-A1 [98.912024] Dynamic subtest B-HDMI-A1: SUCCESS (0.822s) [98.918318] Starting dynamic subtest: C-HDMI-A1 [99.742956] Dynamic subtest C-HDMI-A1: SUCCESS (0.830s) [99.744499] Subtest basic-flip-vs-dpms: SUCCESS (2.526s) [99.841372] [110/171] (903s left) kms_flip (basic-flip-vs-modeset) [99.935621] Starting subtest: basic-flip-vs-modeset [99.937088] Starting dynamic subtest: A-HDMI-A1 [100.765541] Dynamic subtest A-HDMI-A1: SUCCESS (0.829s) [100.771914] Starting dynamic subtest: B-HDMI-A1 [101.563275] Dynamic subtest B-HDMI-A1: SUCCESS (0.797s) [101.569614] Starting dynamic subtest: C-HDMI-A1 [102.345786] Dynamic subtest C-HDMI-A1: SUCCESS (0.781s) [102.347311] Subtest basic-flip-vs-modeset: SUCCESS (2.412s) [102.442431] [111/171] (900s left) kms_flip (basic-flip-vs-wf_vblank) [102.536854] Starting subtest: basic-flip-vs-wf_vblank [102.538250] Starting dynamic subtest: A-HDMI-A1 [103.634803] Dynamic subtest A-HDMI-A1: SUCCESS (1.097s) [103.640949] Starting dynamic subtest: B-HDMI-A1 [104.707657] Dynamic subtest B-HDMI-A1: SUCCESS (1.072s) [104.714209] Starting dynamic subtest: C-HDMI-A1 [105.780855] Dynamic subtest C-HDMI-A1: SUCCESS (1.072s) [105.784178] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.247s) [105.915574] [112/171] (897s left) kms_flip (basic-plain-flip) [106.007596] Starting subtest: basic-plain-flip [106.008939] Starting dynamic subtest: A-HDMI-A1 [106.825679] Dynamic subtest A-HDMI-A1: SUCCESS (0.817s) [106.832212] Starting dynamic subtest: B-HDMI-A1 [107.616210] Dynamic subtest B-HDMI-A1: SUCCESS (0.790s) [107.622495] Starting dynamic subtest: C-HDMI-A1 [108.406831] Dynamic subtest C-HDMI-A1: SUCCESS (0.789s) [108.412429] Subtest basic-plain-flip: SUCCESS (2.405s) [108.541776] [113/171] (894s left) kms_force_connector_basic (force-connector-state) [108.695623] Starting subtest: force-connector-state [109.048256] Subtest force-connector-state: SUCCESS (0.352s) [109.468945] [114/171] (894s left) kms_force_connector_basic (force-edid) [109.620555] Starting subtest: force-edid [109.757531] Subtest force-edid: SUCCESS (0.137s) [109.952214] [115/171] (893s left) kms_force_connector_basic (force-load-detect) [110.101688] Starting subtest: force-load-detect [110.104765] Subtest force-load-detect: SKIP (0.000s) [110.302323] [116/171] (893s left) kms_force_connector_basic (prune-stale-modes) [110.453582] Starting subtest: prune-stale-modes [110.588072] Subtest prune-stale-modes: SUCCESS (0.135s) [110.785559] [117/171] (892s left) kms_frontbuffer_tracking (basic) [110.895051] Starting subtest: basic [113.271413] Subtest basic: SUCCESS (2.381s) [113.372074] [118/171] (890s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [113.477180] Starting subtest: compare-crc-sanitycheck-xr24 [113.478725] Starting dynamic subtest: pipe-A-HDMI-A-1 [113.828487] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.351s) [113.837451] Starting dynamic subtest: pipe-B-HDMI-A-1 [114.181931] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.352s) [114.191190] Starting dynamic subtest: pipe-C-HDMI-A-1 [114.538800] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.354s) [114.540334] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.061s) [114.642581] [119/171] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [114.746331] Starting subtest: compare-crc-sanitycheck-nv12 [114.748097] Starting dynamic subtest: pipe-A-HDMI-A-1 [115.121820] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.374s) [115.131234] Starting dynamic subtest: pipe-B-HDMI-A-1 [115.510809] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.387s) [115.518950] Starting dynamic subtest: pipe-C-HDMI-A-1 [115.521939] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [115.523426] Subtest compare-crc-sanitycheck-nv12: SUCCESS (0.766s) [115.615436] [120/171] (887s left) kms_pipe_crc_basic (hang-read-crc) [115.718486] Starting subtest: hang-read-crc [115.720049] Starting dynamic subtest: pipe-A-HDMI-A-1 [116.527700] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.808s) [116.535775] Starting dynamic subtest: pipe-B-HDMI-A-1 [117.363473] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.835s) [117.370501] Starting dynamic subtest: pipe-C-HDMI-A-1 [118.260732] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.896s) [118.262269] Subtest hang-read-crc: SUCCESS (2.543s) [118.341540] [121/171] (885s left) kms_pipe_crc_basic (nonblocking-crc) [118.445571] Starting subtest: nonblocking-crc [118.446931] Starting dynamic subtest: pipe-A-HDMI-A-1 [118.930656] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.485s) [118.937058] Starting dynamic subtest: pipe-B-HDMI-A-1 [119.410394] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.476s) [119.421450] Starting dynamic subtest: pipe-C-HDMI-A-1 [119.927359] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.516s) [119.928920] Subtest nonblocking-crc: SUCCESS (1.481s) [120.007909] [122/171] (883s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [120.110348] Starting subtest: nonblocking-crc-frame-sequence [120.111734] Starting dynamic subtest: pipe-A-HDMI-A-1 [120.599484] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.488s) [120.606091] Starting dynamic subtest: pipe-B-HDMI-A-1 [121.077035] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.477s) [121.083595] Starting dynamic subtest: pipe-C-HDMI-A-1 [121.590933] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.512s) [121.592577] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.480s) [121.672301] [123/171] (881s left) kms_pipe_crc_basic (read-crc) [121.778562] Starting subtest: read-crc [121.780138] Starting dynamic subtest: pipe-A-HDMI-A-1 [122.196807] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.417s) [122.203676] Starting dynamic subtest: pipe-B-HDMI-A-1 [122.609820] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.413s) [122.618654] Starting dynamic subtest: pipe-C-HDMI-A-1 [123.060971] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.449s) [123.062452] Subtest read-crc: SUCCESS (1.284s) [123.142889] [124/171] (880s left) kms_pipe_crc_basic (read-crc-frame-sequence) [123.248696] Starting subtest: read-crc-frame-sequence [123.250208] Starting dynamic subtest: pipe-A-HDMI-A-1 [123.667450] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.418s) [123.676441] Starting dynamic subtest: pipe-B-HDMI-A-1 [124.081449] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.411s) [124.092427] Starting dynamic subtest: pipe-C-HDMI-A-1 [124.531409] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.448s) [124.533105] Subtest read-crc-frame-sequence: SUCCESS (1.283s) [124.612176] [125/171] (879s left) kms_psr (primary_page_flip) [124.667613] Subtest primary_page_flip: SKIP (0.000s) [124.689836] [126/171] (878s left) kms_psr (cursor_plane_move) [124.744440] Subtest cursor_plane_move: SKIP (0.000s) [124.771989] [127/171] (878s left) kms_psr (sprite_plane_onoff) [124.831095] Subtest sprite_plane_onoff: SKIP (0.000s) [124.855539] [128/171] (878s left) kms_psr (primary_mmap_gtt) [124.911184] Subtest primary_mmap_gtt: SKIP (0.000s) [124.938756] [129/171] (878s left) kms_setmode (basic-clone-single-crtc) [124.993549] Starting subtest: basic-clone-single-crtc [124.998181] Subtest basic-clone-single-crtc: SKIP (0.000s) [125.046524] [130/171] (878s left) i915_pm_backlight (basic-brightness) [125.153873] Subtest basic-brightness: SKIP (0.000s) [125.173899] [131/171] (878s left) i915_pm_rpm (basic-pci-d3-state) [126.575679] Starting subtest: basic-pci-d3-state [137.369364] Subtest basic-pci-d3-state: FAIL (10.765s) [137.631511] [132/171] (866s left) i915_pm_rpm (basic-rte) [137.685189] Starting subtest: basic-rte [149.938703] Subtest basic-rte: FAIL (12.135s) [152.430725] [133/171] (851s left) i915_pm_rps (basic-api) [152.498222] Starting subtest: basic-api [152.502597] Subtest basic-api: SUCCESS (0.004s) [152.576702] [134/171] (851s left) prime_self_import (basic-llseek-bad) [152.635388] Starting subtest: basic-llseek-bad [152.638206] Subtest basic-llseek-bad: SUCCESS (0.001s) [152.724326] [135/171] (851s left) prime_self_import (basic-llseek-size) [152.783827] Starting subtest: basic-llseek-size [152.786909] Subtest basic-llseek-size: SUCCESS (0.001s) [152.856162] [136/171] (850s left) prime_self_import (basic-with_fd_dup) [152.913738] Starting subtest: basic-with_fd_dup [152.916858] Subtest basic-with_fd_dup: SUCCESS (0.002s) [153.018785] [137/171] (850s left) prime_self_import (basic-with_one_bo) [153.081041] Starting subtest: basic-with_one_bo [153.084022] Subtest basic-with_one_bo: SUCCESS (0.002s) [153.146354] [138/171] (850s left) prime_self_import (basic-with_one_bo_two_files) [153.225228] Starting subtest: basic-with_one_bo_two_files [153.228113] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [153.302731] [139/171] (850s left) prime_self_import (basic-with_two_bos) [153.385392] Starting subtest: basic-with_two_bos [153.388227] Subtest basic-with_two_bos: SUCCESS (0.002s) [153.467992] [140/171] (850s left) prime_vgem (basic-fence-flip) [153.541801] Starting subtest: basic-fence-flip [153.949200] Subtest basic-fence-flip: SUCCESS (0.407s) [154.037523] [141/171] (849s left) prime_vgem (basic-fence-mmap) [154.104225] Starting subtest: basic-fence-mmap [154.120064] Subtest basic-fence-mmap: SUCCESS (0.017s) [154.219500] [142/171] (849s left) prime_vgem (basic-fence-read) [154.320365] Starting subtest: basic-fence-read [154.343868] Subtest basic-fence-read: SUCCESS (0.024s) [154.479623] [143/171] (849s left) prime_vgem (basic-gtt) [154.570780] Starting subtest: basic-gtt [154.576221] Subtest basic-gtt: SUCCESS (0.007s) [154.692212] [144/171] (849s left) prime_vgem (basic-read) [154.789710] Starting subtest: basic-read [154.800641] Subtest basic-read: SUCCESS (0.011s) [154.907678] [145/171] (849s left) prime_vgem (basic-write) [155.000058] Starting subtest: basic-write [155.016239] Subtest basic-write: SUCCESS (0.016s) [155.095347] [146/171] (849s left) vgem_basic (setversion) [155.167715] Starting subtest: setversion [155.170899] Subtest setversion: SUCCESS (0.000s) [155.216469] [147/171] (848s left) vgem_basic (create) [155.300831] Starting subtest: create [155.302523] Subtest create: SUCCESS (0.000s) [155.361788] [148/171] (848s left) vgem_basic (debugfs) [155.467879] Starting subtest: debugfs [155.469879] Subtest debugfs: SUCCESS (0.000s) [155.516494] [149/171] (848s left) vgem_basic (dmabuf-export) [155.584154] Starting subtest: dmabuf-export [155.587206] Subtest dmabuf-export: SUCCESS (0.001s) [155.688431] [150/171] (848s left) vgem_basic (dmabuf-fence) [155.784204] Starting subtest: dmabuf-fence [155.785826] Subtest dmabuf-fence: SUCCESS (0.000s) [155.828949] [151/171] (848s left) vgem_basic (dmabuf-fence-before) [155.900791] Starting subtest: dmabuf-fence-before [155.902436] Subtest dmabuf-fence-before: SUCCESS (0.000s) [155.948339] [152/171] (848s left) vgem_basic (dmabuf-mmap) [156.017913] Starting subtest: dmabuf-mmap [156.025068] Subtest dmabuf-mmap: SUCCESS (0.009s) [156.063400] [153/171] (848s left) vgem_basic (mmap) [156.134023] Starting subtest: mmap [156.138905] Subtest mmap: SUCCESS (0.006s) [156.179309] [154/171] (848s left) vgem_basic (second-client) [156.250761] Starting subtest: second-client [156.284160] Subtest second-client: SUCCESS (0.033s) [156.374975] [155/171] (847s left) vgem_basic (sysfs) [156.467235] Starting subtest: sysfs [156.468905] Subtest sysfs: SUCCESS (0.000s) [156.514671] [156/171] (847s left) core_hotunplug (unbind-rebind) [156.616105] Starting subtest: unbind-rebind [157.546727] Subtest unbind-rebind: SUCCESS (0.930s) [157.579697] [157/171] (846s left) vgem_basic (unload) [157.637411] Starting subtest: unload [186.537868] Subtest unload: SUCCESS (28.901s) [186.638747] [158/171] (817s left) i915_module_load (reload) [186.688501] Starting subtest: reload [188.559715] Subtest reload: SUCCESS (1.872s) [188.578671] [159/171] (815s left) gem_lmem_swapping (basic) [188.651362] Subtest basic: SKIP (0.000s) [188.669628] [160/171] (815s left) gem_lmem_swapping (parallel-random-engines) [188.731973] Subtest parallel-random-engines: SKIP (0.000s) [188.753228] [161/171] (815s left) gem_lmem_swapping (random-engines) [188.810249] Subtest random-engines: SKIP (0.000s) [188.834177] [162/171] (815s left) gem_lmem_swapping (verify-random) [188.894479] Subtest verify-random: SKIP (0.000s) [188.916978] [163/171] (815s left) i915_pm_rpm (module-reload) [190.584497] Starting subtest: module-reload [210.392629] Subtest module-reload: FAIL (19.606s) [210.499167] [164/171] (793s left) i915_selftest (live) [211.379154] Starting subtest: live [211.381991] Starting dynamic subtest: sanitycheck [211.927164] Dynamic subtest sanitycheck: SUCCESS (0.547s) [211.933137] Starting dynamic subtest: uncore [212.421172] Dynamic subtest uncore: SUCCESS (0.493s) [212.427432] Starting dynamic subtest: workarounds [213.120073] Dynamic subtest workarounds: SUCCESS (0.698s) [213.126613] Starting dynamic subtest: gt_engines [214.102994] Dynamic subtest gt_engines: SUCCESS (0.982s) [214.108597] Starting dynamic subtest: gt_timelines [219.985184] Dynamic subtest gt_timelines: SUCCESS (5.881s) [219.990364] Starting dynamic subtest: gt_contexts [220.594952] Dynamic subtest gt_contexts: SUCCESS (0.609s) [220.600275] Starting dynamic subtest: gt_lrc [223.323166] Dynamic subtest gt_lrc: SUCCESS (2.727s) [223.329458] Starting dynamic subtest: gt_mocs [223.892116] Dynamic subtest gt_mocs: SUCCESS (0.568s) [223.897742] Starting dynamic subtest: gt_pm [226.327039] Dynamic subtest gt_pm: SUCCESS (2.434s) [226.332224] Starting dynamic subtest: gt_heartbeat [226.959878] Dynamic subtest gt_heartbeat: SUCCESS (0.632s) [226.965343] Starting dynamic subtest: gt_tlb [228.330119] Dynamic subtest gt_tlb: SUCCESS (1.369s) [228.335694] Starting dynamic subtest: requests [235.175201] Dynamic subtest requests: SUCCESS (6.844s) [235.180778] Starting dynamic subtest: migrate [238.539976] Dynamic subtest migrate: SUCCESS (3.364s) [238.545579] Starting dynamic subtest: active [239.056069] Dynamic subtest active: SUCCESS (0.515s) [239.062811] Starting dynamic subtest: objects [240.133105] Dynamic subtest objects: SUCCESS (1.076s) [240.139886] Starting dynamic subtest: mman [243.953197] Dynamic subtest mman: SUCCESS (3.819s) [243.958735] Starting dynamic subtest: dmabuf [244.488223] Dynamic subtest dmabuf: SUCCESS (0.534s) [244.493425] Starting dynamic subtest: vma [244.957227] Dynamic subtest vma: SUCCESS (0.468s) [244.963630] Starting dynamic subtest: coherency [246.011150] Dynamic subtest coherency: SUCCESS (1.053s) [246.016729] Starting dynamic subtest: gtt [254.032153] Dynamic subtest gtt: SUCCESS (8.020s) [254.039555] Starting dynamic subtest: gem [254.607184] Dynamic subtest gem: SUCCESS (0.574s) [254.613096] Starting dynamic subtest: evict [255.839167] Dynamic subtest evict: SUCCESS (1.231s) [255.844765] Starting dynamic subtest: hugepages [262.320132] Dynamic subtest hugepages: SUCCESS (6.480s) [262.325743] Starting dynamic subtest: gem_contexts [274.476329] Dynamic subtest gem_contexts: SUCCESS (12.155s) [274.482224] Starting dynamic subtest: client [275.008131] Dynamic subtest client: SUCCESS (0.531s) [275.013546] Starting dynamic subtest: gem_migrate [275.507158] Dynamic subtest gem_migrate: SUCCESS (0.498s) [275.512843] Starting dynamic subtest: reset [276.319168] Dynamic subtest reset: SUCCESS (0.811s) [276.324904] Starting dynamic subtest: memory_region [276.800452] Dynamic subtest memory_region: SUCCESS (0.480s) [276.807702] Starting dynamic subtest: hangcheck [300.322129] Dynamic subtest hangcheck: SUCCESS (23.521s) [300.327451] Starting dynamic subtest: execlists [308.466160] Dynamic subtest execlists: SUCCESS (8.143s) [308.473513] Starting dynamic subtest: ring_submission [308.958208] Dynamic subtest ring_submission: SUCCESS (0.491s) [308.964072] Starting dynamic subtest: perf [309.566344] Dynamic subtest perf: SUCCESS (0.607s) [309.571948] Starting dynamic subtest: slpc [310.034067] Dynamic subtest slpc: SUCCESS (0.467s) [310.039695] Starting dynamic subtest: guc [310.520148] Dynamic subtest guc: SUCCESS (0.485s) [310.525911] Starting dynamic subtest: guc_multi_lrc [311.028118] Dynamic subtest guc_multi_lrc: SUCCESS (0.507s) [311.033914] Starting dynamic subtest: guc_hang [311.508088] Dynamic subtest guc_hang: SUCCESS (0.479s) [311.514013] Starting dynamic subtest: late_gt_pm [312.010123] Dynamic subtest late_gt_pm: SUCCESS (0.501s) [312.011588] Subtest live: SUCCESS (100.633s) [312.231766] [165/171] (692s left) dmabuf (all-tests) [312.319981] Starting subtest: all-tests [312.322012] Starting dynamic subtest: sanitycheck [312.404784] Dynamic subtest sanitycheck: SUCCESS (0.085s) [312.410593] Starting dynamic subtest: dma_fence [312.578254] Dynamic subtest dma_fence: SUCCESS (0.172s) [312.585108] Starting dynamic subtest: dma_fence_chain [322.724718] Dynamic subtest dma_fence_chain: SUCCESS (10.146s) [322.730138] Starting dynamic subtest: dma_fence_unwrap [322.786448] Dynamic subtest dma_fence_unwrap: SUCCESS (0.060s) [322.794593] Starting dynamic subtest: dma_resv [322.852847] Dynamic subtest dma_resv: SUCCESS (0.064s) [322.855147] Subtest all-tests: SUCCESS (10.533s) [322.867079] [166/171] (681s left) i915_suspend (basic-s2idle-without-i915) [322.937537] Starting subtest: basic-s2idle-without-i915 [339.669584] Subtest basic-s2idle-without-i915: SUCCESS (1.920s) [345.814373] [167/171] (679s left) i915_suspend (basic-s3-without-i915) [345.875974] Starting subtest: basic-s3-without-i915 [363.726055] Subtest basic-s3-without-i915: SUCCESS (1.906s) [369.869195] [168/171] (677s left) gem_exec_suspend (basic-s0) [369.943750] Starting subtest: basic-S0 [369.945559] Starting dynamic subtest: smem [386.716425] Dynamic subtest smem: SUCCESS (1.707s) [386.718787] Subtest basic-S0: SUCCESS (1.708s) [392.556524] [169/171] (675s left) gem_exec_suspend (basic-s3) [392.618708] Starting subtest: basic-S3 [392.620698] Starting dynamic subtest: smem [410.753890] Dynamic subtest smem: SUCCESS (1.814s) [410.755696] Subtest basic-S3: SUCCESS (1.815s) [415.948808] [170/171] (673s left) kms_chamelium_hpd (common-hpd-after-suspend) [416.071633] Subtest common-hpd-after-suspend: SKIP (0.000s) [416.120124] [171/171] (673s left) kms_pipe_crc_basic (suspend-read-crc) [416.224529] Starting subtest: suspend-read-crc [416.226183] Starting dynamic subtest: pipe-A-HDMI-A-1 [433.776843] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.581s) [433.784961] Starting dynamic subtest: pipe-B-HDMI-A-1 [451.851163] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.640s) [451.860153] Starting dynamic subtest: pipe-C-HDMI-A-1 [469.882013] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.714s) [469.883774] Subtest suspend-read-crc: SUCCESS (4.938s) [474.933379] Closing watchdogs Done.