[48.324914] Initializing watchdogs [48.325182] /dev/watchdog0 [48.331696] [001/171] (960s left) i915_module_load (load) [48.398877] Starting subtest: load [49.323995] Subtest load: SUCCESS (0.921s) [49.343851] [002/171] (959s left) core_auth (basic-auth) [49.443786] Starting subtest: basic-auth [49.444929] Subtest basic-auth: SUCCESS (0.000s) [49.500447] [003/171] (959s left) debugfs_test (read_all_entries) [49.566835] Starting subtest: read_all_entries [49.603526] Subtest read_all_entries: SUCCESS (0.037s) [49.681802] [004/171] (959s left) debugfs_test (basic-hwmon) [49.745318] Starting subtest: basic-hwmon [49.747343] Subtest basic-hwmon: SKIP (0.000s) [49.815804] [005/171] (959s left) fbdev (eof) [49.887992] Starting subtest: eof [49.889241] Subtest eof: SUCCESS (0.000s) [49.931812] [006/171] (958s left) fbdev (info) [49.996504] Starting subtest: info [49.997573] Subtest info: SUCCESS (0.000s) [50.050089] [007/171] (958s left) fbdev (nullptr) [50.120046] Starting subtest: nullptr [50.121108] Subtest nullptr: SUCCESS (0.000s) [50.164985] [008/171] (958s left) fbdev (read) [50.236545] Starting subtest: read [50.315481] Subtest read: SUCCESS (0.079s) [50.350552] [009/171] (958s left) fbdev (write) [50.420266] Starting subtest: write [50.460383] Subtest write: SUCCESS (0.040s) [50.498727] [010/171] (958s left) gem_basic (bad-close) [50.561354] Starting subtest: bad-close [50.563502] Subtest bad-close: SUCCESS (0.000s) [50.614604] [011/171] (958s left) gem_basic (create-close) [50.676234] Starting subtest: create-close [50.678412] Subtest create-close: SUCCESS (0.000s) [50.749053] [012/171] (958s left) gem_basic (create-fd-close) [50.810724] Starting subtest: create-fd-close [50.812947] Subtest create-fd-close: SUCCESS (0.000s) [50.883341] [013/171] (958s left) gem_busy (busy@all-engines) [50.954194] Starting subtest: busy [50.955365] Starting dynamic subtest: all-engines [50.979310] Dynamic subtest all-engines: SUCCESS (0.025s) [50.980492] Subtest busy: SUCCESS (0.025s) [51.283271] [014/171] (957s left) gem_close_race (basic-process) [51.356985] Starting subtest: basic-process [51.392566] Subtest basic-process: SUCCESS (0.034s) [51.550753] [015/171] (957s left) gem_close_race (basic-threads) [51.623787] Starting subtest: basic-threads [52.777805] Subtest basic-threads: SUCCESS (1.154s) [52.948445] [016/171] (956s left) gem_ctx_create (basic) [53.017174] Starting subtest: basic [53.018306] Subtest basic: SUCCESS (0.000s) [53.181288] [017/171] (955s left) gem_ctx_create (basic-files) [53.247471] Starting subtest: basic-files [55.264239] Subtest basic-files: SUCCESS (2.017s) [55.516550] [018/171] (953s left) gem_ctx_exec (basic) [55.581627] Starting subtest: basic [55.583825] Subtest basic: SUCCESS (0.002s) [55.662223] [019/171] (953s left) gem_exec_basic (basic) [55.730400] Starting subtest: basic [55.731538] Starting dynamic subtest: rcs0-smem [55.732608] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [55.737911] Starting dynamic subtest: bcs0-smem [55.739012] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [55.744925] Starting dynamic subtest: vcs0-smem [55.745931] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [55.751756] Starting dynamic subtest: vecs0-smem [55.752857] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [55.754079] Subtest basic: SUCCESS (0.001s) [55.902110] [020/171] (953s left) gem_exec_create (basic) [55.969627] Starting subtest: basic [55.970774] Starting dynamic subtest: smem [58.012821] Dynamic subtest smem: SUCCESS (2.043s) [58.014252] Subtest basic: SUCCESS (2.043s) [58.180529] [021/171] (950s left) gem_exec_fence (basic-busy) [58.362653] Starting subtest: basic-busy [58.363896] Starting dynamic subtest: rcs0 [58.392429] Dynamic subtest rcs0: SUCCESS (0.030s) [58.398444] Starting dynamic subtest: bcs0 [58.420560] Dynamic subtest bcs0: SUCCESS (0.028s) [58.426393] Starting dynamic subtest: vcs0 [58.451263] Dynamic subtest vcs0: SUCCESS (0.031s) [58.457364] Starting dynamic subtest: vecs0 [58.473244] Dynamic subtest vecs0: SUCCESS (0.022s) [58.474418] Subtest basic-busy: SUCCESS (0.111s) [58.931402] [022/171] (950s left) gem_exec_fence (basic-wait) [59.113630] Starting subtest: basic-wait [59.114847] Starting dynamic subtest: rcs0 [59.140781] Dynamic subtest rcs0: SUCCESS (0.027s) [59.146794] Starting dynamic subtest: bcs0 [59.161619] Dynamic subtest bcs0: SUCCESS (0.021s) [59.168174] Starting dynamic subtest: vcs0 [59.187734] Dynamic subtest vcs0: SUCCESS (0.026s) [59.195197] Starting dynamic subtest: vecs0 [59.206547] Dynamic subtest vecs0: SUCCESS (0.019s) [59.207766] Subtest basic-wait: SUCCESS (0.093s) [59.646675] [023/171] (949s left) gem_exec_fence (basic-await) [59.829104] Starting subtest: basic-await [59.830297] Starting dynamic subtest: rcs0 [59.900403] Dynamic subtest rcs0: SUCCESS (0.071s) [59.905705] Starting dynamic subtest: bcs0 [59.969474] Dynamic subtest bcs0: SUCCESS (0.069s) [59.975578] Starting dynamic subtest: vcs0 [60.039207] Dynamic subtest vcs0: SUCCESS (0.070s) [60.044659] Starting dynamic subtest: vecs0 [60.107932] Dynamic subtest vecs0: SUCCESS (0.069s) [60.109199] Subtest basic-await: SUCCESS (0.278s) [60.534426] [024/171] (948s left) gem_exec_fence (nb-await) [60.715428] Starting subtest: nb-await [60.716536] Starting dynamic subtest: rcs0 [60.769031] Dynamic subtest rcs0: SUCCESS (0.054s) [60.774902] Starting dynamic subtest: bcs0 [60.823641] Dynamic subtest bcs0: SUCCESS (0.054s) [60.828832] Starting dynamic subtest: vcs0 [60.876733] Dynamic subtest vcs0: SUCCESS (0.053s) [60.883652] Starting dynamic subtest: vecs0 [60.931529] Dynamic subtest vecs0: SUCCESS (0.054s) [60.932519] Subtest nb-await: SUCCESS (0.216s) [61.363856] [025/171] (947s left) gem_exec_gttfill (basic) [61.433366] Starting subtest: basic [64.427290] Subtest basic: SUCCESS (2.993s) [64.595852] [026/171] (944s left) gem_exec_parallel (engines) [64.727256] Starting subtest: engines [64.728361] Starting dynamic subtest: basic [66.146773] Dynamic subtest basic: SUCCESS (1.419s) [66.153747] Starting dynamic subtest: contexts [67.699736] Dynamic subtest contexts: SUCCESS (1.553s) [67.705779] Starting dynamic subtest: fds [69.432815] Dynamic subtest fds: SUCCESS (1.733s) [69.439032] Starting dynamic subtest: userptr [70.846030] Dynamic subtest userptr: SUCCESS (1.413s) [70.847372] Subtest engines: SUCCESS (6.118s) [71.013500] [027/171] (938s left) gem_exec_store (basic) [71.083291] Starting subtest: basic [71.121547] Subtest basic: SUCCESS (0.037s) [71.278845] [028/171] (937s left) gem_flink_basic (bad-flink) [71.341207] Starting subtest: bad-flink [71.342300] Subtest bad-flink: SUCCESS (0.000s) [71.396296] [029/171] (937s left) gem_flink_basic (bad-open) [71.458559] Starting subtest: bad-open [71.459665] Subtest bad-open: SUCCESS (0.000s) [71.512157] [030/171] (937s left) gem_flink_basic (basic) [71.575129] Starting subtest: basic [71.576218] Subtest basic: SUCCESS (0.000s) [71.645313] [031/171] (937s left) gem_flink_basic (double-flink) [71.708105] Starting subtest: double-flink [71.709125] Subtest double-flink: SUCCESS (0.000s) [71.777412] [032/171] (937s left) gem_flink_basic (flink-lifetime) [71.838695] Starting subtest: flink-lifetime [71.839833] Subtest flink-lifetime: SUCCESS (0.001s) [71.912552] [033/171] (937s left) gem_huc_copy (huc-copy) [71.979918] Subtest huc-copy: SKIP (0.000s) [72.006871] [034/171] (937s left) gem_linear_blits (basic) [72.149395] Starting subtest: basic [72.156160] Subtest basic: SUCCESS (0.007s) [72.252636] [035/171] (937s left) gem_mmap (basic) [72.385664] Starting subtest: basic [72.390992] Subtest basic: SUCCESS (0.000s) [72.461511] [036/171] (936s left) gem_mmap_gtt (basic) [72.523180] Starting subtest: basic [72.524316] Subtest basic: SUCCESS (0.000s) [72.573710] [037/171] (936s left) gem_render_linear_blits (basic) [72.639527] Starting subtest: basic [72.655583] Subtest basic: SUCCESS (0.016s) [72.690669] [038/171] (936s left) gem_render_tiled_blits (basic) [72.754346] Starting subtest: basic [72.773818] Subtest basic: SUCCESS (0.020s) [72.824423] [039/171] (936s left) gem_ringfill (basic-all) [72.996283] Starting subtest: basic-all [74.102423] Subtest basic-all: SUCCESS (1.107s) [74.178420] [040/171] (935s left) gem_softpin (allocator-basic) [74.244143] Subtest allocator-basic: SKIP (0.000s) [74.293649] [041/171] (935s left) gem_softpin (allocator-basic-reserve) [74.358674] Subtest allocator-basic-reserve: SKIP (0.000s) [74.411474] [042/171] (934s left) gem_softpin (safe-alignment) [74.477305] Starting subtest: safe-alignment [74.485768] Subtest safe-alignment: SUCCESS (0.009s) [74.561028] [043/171] (934s left) gem_sync (basic-all) [74.631884] Starting subtest: basic-all [76.841390] Subtest basic-all: SUCCESS (2.210s) [77.015244] [044/171] (932s left) gem_sync (basic-each) [77.085569] Starting subtest: basic-each [79.177560] Subtest basic-each: SUCCESS (2.091s) [79.344688] [045/171] (930s left) gem_tiled_blits (basic) [79.476119] Starting subtest: basic [79.485989] Subtest basic: SUCCESS (0.010s) [79.586872] [046/171] (929s left) gem_tiled_fence_blits (basic) [79.789842] Starting subtest: basic [79.795760] Subtest basic: SUCCESS (0.006s) [79.899837] [047/171] (929s left) gem_tiled_pread_basic [80.194476] [048/171] (929s left) gem_wait (busy@all-engines) [80.267597] Starting subtest: busy [80.268722] Starting dynamic subtest: all-engines [80.786907] Dynamic subtest all-engines: SUCCESS (0.518s) [80.787990] Subtest busy: SUCCESS (0.519s) [80.959432] [049/171] (928s left) gem_wait (wait@all-engines) [81.030382] Starting subtest: wait [81.031453] Starting dynamic subtest: all-engines [82.049263] Dynamic subtest all-engines: SUCCESS (1.019s) [82.050363] Subtest wait: SUCCESS (1.019s) [82.228930] [050/171] (927s left) i915_getparams_basic (basic-eu-total) [82.292022] Starting subtest: basic-eu-total [82.294246] Subtest basic-eu-total: SUCCESS (0.000s) [82.344033] [051/171] (927s left) i915_getparams_basic (basic-subslice-total) [82.405495] Starting subtest: basic-subslice-total [82.407720] Subtest basic-subslice-total: SUCCESS (0.000s) [82.458706] [052/171] (927s left) i915_hangman (error-state-basic) [82.527442] Starting subtest: error-state-basic [82.531833] Subtest error-state-basic: SUCCESS (0.004s) [82.609485] [053/171] (926s left) i915_pciid [82.725082] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier) [82.790270] Starting subtest: addfb25-bad-modifier [82.791373] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [82.891788] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [82.954641] Starting subtest: addfb25-framebuffer-vs-set-tiling [82.955668] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [83.041716] [056/171] (926s left) kms_addfb_basic (addfb25-modifier-no-flag) [83.104944] Starting subtest: addfb25-modifier-no-flag [83.105975] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [83.192270] [057/171] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy) [83.256422] Starting subtest: addfb25-x-tiled-legacy [83.257498] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [83.342945] [058/171] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [83.405829] Starting subtest: addfb25-x-tiled-mismatch-legacy [83.406905] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [83.491389] [059/171] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [83.575600] Starting subtest: addfb25-yf-tiled-legacy [83.576699] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [83.641160] [060/171] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy) [83.723999] Starting subtest: addfb25-y-tiled-legacy [83.725241] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [83.791792] [061/171] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [83.875040] Starting subtest: addfb25-y-tiled-small-legacy [83.877236] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [83.941463] [062/171] (925s left) kms_addfb_basic (bad-pitch-0) [84.004075] Starting subtest: bad-pitch-0 [84.005150] Subtest bad-pitch-0: SUCCESS (0.000s) [84.091443] [063/171] (925s left) kms_addfb_basic (bad-pitch-1024) [84.152559] Starting subtest: bad-pitch-1024 [84.153765] Subtest bad-pitch-1024: SUCCESS (0.000s) [84.241397] [064/171] (925s left) kms_addfb_basic (bad-pitch-128) [84.303193] Starting subtest: bad-pitch-128 [84.304320] Subtest bad-pitch-128: SUCCESS (0.000s) [84.391419] [065/171] (925s left) kms_addfb_basic (bad-pitch-256) [84.454618] Starting subtest: bad-pitch-256 [84.455689] Subtest bad-pitch-256: SUCCESS (0.000s) [84.541731] [066/171] (925s left) kms_addfb_basic (bad-pitch-32) [84.605211] Starting subtest: bad-pitch-32 [84.606188] Subtest bad-pitch-32: SUCCESS (0.000s) [84.691248] [067/171] (925s left) kms_addfb_basic (bad-pitch-63) [84.752452] Starting subtest: bad-pitch-63 [84.753557] Subtest bad-pitch-63: SUCCESS (0.000s) [84.841207] [068/171] (924s left) kms_addfb_basic (bad-pitch-65536) [84.901889] Starting subtest: bad-pitch-65536 [84.903165] Subtest bad-pitch-65536: SUCCESS (0.000s) [84.991536] [069/171] (924s left) kms_addfb_basic (bad-pitch-999) [85.054215] Starting subtest: bad-pitch-999 [85.055306] Subtest bad-pitch-999: SUCCESS (0.000s) [85.158468] [070/171] (924s left) kms_addfb_basic (basic) [85.221098] Starting subtest: basic [85.222214] Subtest basic: SUCCESS (0.000s) [85.307463] [071/171] (924s left) kms_addfb_basic (basic-x-tiled-legacy) [85.370554] Starting subtest: basic-x-tiled-legacy [85.371582] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [85.457728] [072/171] (924s left) kms_addfb_basic (basic-y-tiled-legacy) [85.521038] Starting subtest: basic-y-tiled-legacy [85.522082] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [85.607789] [073/171] (924s left) kms_addfb_basic (bo-too-small) [85.692460] Starting subtest: bo-too-small [85.693596] Subtest bo-too-small: SUCCESS (0.000s) [85.757394] [074/171] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling) [85.842404] Starting subtest: bo-too-small-due-to-tiling [85.843499] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [85.907353] [075/171] (923s left) kms_addfb_basic (clobberred-modifier) [85.969919] Starting subtest: clobberred-modifier [85.970959] Subtest clobberred-modifier: SUCCESS (0.000s) [86.057710] [076/171] (923s left) kms_addfb_basic (framebuffer-vs-set-tiling) [86.120435] Starting subtest: framebuffer-vs-set-tiling [86.121392] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [86.207282] [077/171] (923s left) kms_addfb_basic (invalid-get-prop) [86.268364] Starting subtest: invalid-get-prop [86.269480] Subtest invalid-get-prop: SUCCESS (0.000s) [86.357514] [078/171] (923s left) kms_addfb_basic (invalid-get-prop-any) [86.420716] Starting subtest: invalid-get-prop-any [86.421759] Subtest invalid-get-prop-any: SUCCESS (0.000s) [86.508461] [079/171] (923s left) kms_addfb_basic (invalid-set-prop) [86.569886] Starting subtest: invalid-set-prop [86.570934] Subtest invalid-set-prop: SUCCESS (0.000s) [86.657508] [080/171] (923s left) kms_addfb_basic (invalid-set-prop-any) [86.718822] Starting subtest: invalid-set-prop-any [86.719910] Subtest invalid-set-prop-any: SUCCESS (0.000s) [86.807227] [081/171] (923s left) kms_addfb_basic (no-handle) [86.868199] Starting subtest: no-handle [86.869247] Subtest no-handle: SUCCESS (0.000s) [86.957837] [082/171] (922s left) kms_addfb_basic (size-max) [87.040337] Starting subtest: size-max [87.041428] Subtest size-max: SUCCESS (0.000s) [87.107123] [083/171] (922s left) kms_addfb_basic (small-bo) [87.190825] Starting subtest: small-bo [87.191932] Subtest small-bo: SUCCESS (0.000s) [87.276182] [084/171] (922s left) kms_addfb_basic (tile-pitch-mismatch) [87.338956] Starting subtest: tile-pitch-mismatch [87.340073] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [87.423375] [085/171] (922s left) kms_addfb_basic (too-high) [87.506473] Starting subtest: too-high [87.507552] Subtest too-high: SUCCESS (0.001s) [87.573535] [086/171] (922s left) kms_addfb_basic (too-wide) [87.664862] Starting subtest: too-wide [87.665909] Subtest too-wide: SUCCESS (0.000s) [87.740699] [087/171] (922s left) kms_addfb_basic (unused-handle) [87.803203] Starting subtest: unused-handle [87.804202] Subtest unused-handle: SUCCESS (0.000s) [87.890512] [088/171] (922s left) kms_addfb_basic (unused-modifier) [87.952497] Starting subtest: unused-modifier [87.953526] Subtest unused-modifier: SUCCESS (0.000s) [88.041134] [089/171] (922s left) kms_addfb_basic (unused-offsets) [88.101850] Starting subtest: unused-offsets [88.102954] Subtest unused-offsets: SUCCESS (0.000s) [88.190544] [090/171] (921s left) kms_addfb_basic (unused-pitches) [88.250402] Starting subtest: unused-pitches [88.251470] Subtest unused-pitches: SUCCESS (0.000s) [88.340504] [091/171] (921s left) kms_busy (basic) [88.429497] Starting subtest: basic [88.430587] Starting dynamic subtest: flip [88.883323] Dynamic subtest flip: SUCCESS (0.453s) [88.889390] Starting dynamic subtest: modeset [89.407700] Dynamic subtest modeset: SUCCESS (0.524s) [89.408719] Subtest basic: SUCCESS (0.979s) [89.537291] [092/171] (920s left) kms_chamelium_hpd (dp-hpd-fast) [89.681946] Subtest dp-hpd-fast: SKIP (0.000s) [89.763388] [093/171] (920s left) kms_chamelium_edid (dp-edid-read) [89.892811] Subtest dp-edid-read: SKIP (0.000s) [89.975406] [094/171] (920s left) kms_chamelium_frames (dp-crc-fast) [90.104932] Subtest dp-crc-fast: SKIP (0.000s) [90.186698] [095/171] (919s left) kms_chamelium_hpd (hdmi-hpd-fast) [90.315960] Subtest hdmi-hpd-fast: SKIP (0.000s) [90.401590] [096/171] (919s left) kms_chamelium_edid (hdmi-edid-read) [90.531663] Subtest hdmi-edid-read: SKIP (0.000s) [90.614432] [097/171] (919s left) kms_chamelium_frames (hdmi-crc-fast) [90.743786] Subtest hdmi-crc-fast: SKIP (0.000s) [90.827362] [098/171] (919s left) kms_chamelium_hpd (vga-hpd-fast) [90.958339] Subtest vga-hpd-fast: SKIP (0.000s) [91.049345] [099/171] (919s left) kms_chamelium_edid (vga-edid-read) [91.180933] Subtest vga-edid-read: SKIP (0.000s) [91.271901] [100/171] (918s left) kms_prop_blob (basic) [91.335136] Starting subtest: basic [91.336166] Subtest basic: SUCCESS (0.000s) [91.391670] [101/171] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [91.478103] Starting subtest: basic-busy-flip-before-cursor-atomic [92.415557] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.938s) [92.548624] [102/171] (917s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [92.636451] Starting subtest: basic-busy-flip-before-cursor-legacy [93.569400] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.934s) [93.697356] [103/171] (916s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [93.780164] Starting subtest: basic-flip-after-cursor-atomic [94.704370] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.924s) [94.832194] [104/171] (915s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [94.917007] Starting subtest: basic-flip-after-cursor-legacy [95.840263] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.923s) [95.970232] [105/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [96.053799] Starting subtest: basic-flip-after-cursor-varying-size [96.977380] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.924s) [97.107462] [106/171] (913s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [97.190845] Starting subtest: basic-flip-before-cursor-atomic [98.114613] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.924s) [98.246624] [107/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [98.330978] Starting subtest: basic-flip-before-cursor-legacy [99.254850] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.924s) [99.387484] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [99.469926] Starting subtest: basic-flip-before-cursor-varying-size [100.392920] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.923s) [100.525821] [109/171] (909s left) kms_flip (basic-flip-vs-dpms) [100.602829] Starting subtest: basic-flip-vs-dpms [100.605198] Starting dynamic subtest: A-VGA1 [101.551972] Dynamic subtest A-VGA1: SUCCESS (0.947s) [101.558531] Starting dynamic subtest: B-VGA1 [102.438745] Dynamic subtest B-VGA1: SUCCESS (0.886s) [102.445315] Starting dynamic subtest: C-VGA1 [103.325673] Dynamic subtest C-VGA1: SUCCESS (0.887s) [103.326682] Subtest basic-flip-vs-dpms: SUCCESS (2.724s) [103.466350] [110/171] (906s left) kms_flip (basic-flip-vs-modeset) [103.541445] Starting subtest: basic-flip-vs-modeset [103.543416] Starting dynamic subtest: A-VGA1 [104.394946] Dynamic subtest A-VGA1: SUCCESS (0.851s) [104.401604] Starting dynamic subtest: B-VGA1 [105.185839] Dynamic subtest B-VGA1: SUCCESS (0.791s) [105.192420] Starting dynamic subtest: C-VGA1 [105.974837] Dynamic subtest C-VGA1: SUCCESS (0.789s) [105.977015] Subtest basic-flip-vs-modeset: SUCCESS (2.435s) [106.110185] [111/171] (904s left) kms_flip (basic-flip-vs-wf_vblank) [106.185595] Starting subtest: basic-flip-vs-wf_vblank [106.187772] Starting dynamic subtest: A-VGA1 [107.335421] Dynamic subtest A-VGA1: SUCCESS (1.148s) [107.341852] Starting dynamic subtest: B-VGA1 [108.456668] Dynamic subtest B-VGA1: SUCCESS (1.121s) [108.463872] Starting dynamic subtest: C-VGA1 [109.580315] Dynamic subtest C-VGA1: SUCCESS (1.123s) [109.581523] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.397s) [109.766984] [112/171] (900s left) kms_flip (basic-plain-flip) [109.839928] Starting subtest: basic-plain-flip [109.842208] Starting dynamic subtest: A-VGA1 [110.691331] Dynamic subtest A-VGA1: SUCCESS (0.850s) [110.698744] Starting dynamic subtest: B-VGA1 [111.529696] Dynamic subtest B-VGA1: SUCCESS (0.838s) [111.536370] Starting dynamic subtest: C-VGA1 [112.369051] Dynamic subtest C-VGA1: SUCCESS (0.838s) [112.371283] Subtest basic-plain-flip: SUCCESS (2.532s) [112.522356] [113/171] (897s left) kms_force_connector_basic (force-connector-state) [112.597305] Starting subtest: force-connector-state [112.732409] Subtest force-connector-state: SUCCESS (0.136s) [112.915456] [114/171] (897s left) kms_force_connector_basic (force-edid) [112.987592] Starting subtest: force-edid [113.007496] Subtest force-edid: SUCCESS (0.020s) [113.098512] [115/171] (897s left) kms_force_connector_basic (force-load-detect) [113.177152] Starting subtest: force-load-detect [113.314984] Subtest force-load-detect: SUCCESS (0.139s) [113.500353] [116/171] (896s left) kms_force_connector_basic (prune-stale-modes) [113.573325] Starting subtest: prune-stale-modes [113.591810] Subtest prune-stale-modes: SUCCESS (0.018s) [113.700143] [117/171] (896s left) kms_frontbuffer_tracking (basic) [113.790746] Starting subtest: basic [115.581792] Subtest basic: SUCCESS (1.794s) [115.662834] [118/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [115.747969] Starting subtest: compare-crc-sanitycheck-xr24 [115.749067] Starting dynamic subtest: pipe-A-VGA-1 [116.020513] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.272s) [116.028654] Starting dynamic subtest: pipe-B-VGA-1 [116.285956] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.264s) [116.293267] Starting dynamic subtest: pipe-C-VGA-1 [116.557143] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.270s) [116.558242] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.809s) [116.687372] [119/171] (893s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [116.771302] Starting subtest: compare-crc-sanitycheck-nv12 [116.772428] Starting dynamic subtest: pipe-A-VGA-1 [116.774623] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s) [116.781170] Starting dynamic subtest: pipe-B-VGA-1 [116.783246] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s) [116.789411] Starting dynamic subtest: pipe-C-VGA-1 [116.791509] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s) [116.793713] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s) [116.837014] [120/171] (893s left) kms_pipe_crc_basic (hang-read-crc) [116.921604] Starting subtest: hang-read-crc [116.922811] Starting dynamic subtest: pipe-A-VGA-1 [117.651456] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.729s) [117.658162] Starting dynamic subtest: pipe-B-VGA-1 [118.373976] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.722s) [118.380615] Starting dynamic subtest: pipe-C-VGA-1 [119.117468] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.741s) [119.118670] Subtest hang-read-crc: SUCCESS (2.195s) [119.232544] [121/171] (891s left) kms_pipe_crc_basic (nonblocking-crc) [119.322309] Starting subtest: nonblocking-crc [119.323382] Starting dynamic subtest: pipe-A-VGA-1 [119.756671] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.433s) [119.763098] Starting dynamic subtest: pipe-B-VGA-1 [120.180995] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.423s) [120.187606] Starting dynamic subtest: pipe-C-VGA-1 [120.618908] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.436s) [120.620247] Subtest nonblocking-crc: SUCCESS (1.296s) [120.733879] [122/171] (889s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [120.821105] Starting subtest: nonblocking-crc-frame-sequence [120.822193] Starting dynamic subtest: pipe-A-VGA-1 [121.258821] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.438s) [121.265429] Starting dynamic subtest: pipe-B-VGA-1 [121.685431] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.425s) [121.693623] Starting dynamic subtest: pipe-C-VGA-1 [122.122431] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.435s) [122.123579] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.301s) [122.236458] [123/171] (888s left) kms_pipe_crc_basic (read-crc) [122.321374] Starting subtest: read-crc [122.322486] Starting dynamic subtest: pipe-A-VGA-1 [122.692915] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.371s) [122.699533] Starting dynamic subtest: pipe-B-VGA-1 [123.052409] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.358s) [123.059193] Starting dynamic subtest: pipe-C-VGA-1 [123.421294] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.368s) [123.422343] Subtest read-crc: SUCCESS (1.100s) [123.535150] [124/171] (887s left) kms_pipe_crc_basic (read-crc-frame-sequence) [123.619488] Starting subtest: read-crc-frame-sequence [123.620705] Starting dynamic subtest: pipe-A-VGA-1 [123.993901] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.373s) [124.000710] Starting dynamic subtest: pipe-B-VGA-1 [124.353034] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.359s) [124.363275] Starting dynamic subtest: pipe-C-VGA-1 [124.725197] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.370s) [124.726313] Subtest read-crc-frame-sequence: SUCCESS (1.105s) [124.838809] [125/171] (885s left) kms_psr (primary_page_flip) [124.903443] Subtest primary_page_flip: SKIP (0.000s) [124.933604] [126/171] (885s left) kms_psr (cursor_plane_move) [124.996365] Subtest cursor_plane_move: SKIP (0.000s) [125.016598] [127/171] (885s left) kms_psr (sprite_plane_onoff) [125.078971] Subtest sprite_plane_onoff: SKIP (0.000s) [125.102845] [128/171] (885s left) kms_psr (primary_mmap_gtt) [125.167438] Subtest primary_mmap_gtt: SKIP (0.000s) [125.185056] [129/171] (885s left) kms_setmode (basic-clone-single-crtc) [125.248286] Starting subtest: basic-clone-single-crtc [125.251538] Subtest basic-clone-single-crtc: SKIP (0.000s) [125.305145] [130/171] (885s left) i915_pm_backlight (basic-brightness) [125.390252] Subtest basic-brightness: SKIP (0.000s) [125.416975] [131/171] (885s left) i915_pm_rpm (basic-pci-d3-state) [126.783131] Starting subtest: basic-pci-d3-state [126.988531] Subtest basic-pci-d3-state: SUCCESS (0.204s) [127.234077] [132/171] (883s left) i915_pm_rpm (basic-rte) [127.295633] Starting subtest: basic-rte [128.793867] Subtest basic-rte: SUCCESS (1.495s) [129.225982] [133/171] (881s left) i915_pm_rps (basic-api) [129.291602] Starting subtest: basic-api [129.293897] Subtest basic-api: SUCCESS (0.002s) [129.360534] [134/171] (881s left) prime_self_import (basic-llseek-bad) [129.421981] Starting subtest: basic-llseek-bad [129.424220] Subtest basic-llseek-bad: SUCCESS (0.001s) [129.492830] [135/171] (881s left) prime_self_import (basic-llseek-size) [129.554111] Starting subtest: basic-llseek-size [129.556140] Subtest basic-llseek-size: SUCCESS (0.002s) [129.625601] [136/171] (881s left) prime_self_import (basic-with_fd_dup) [129.686038] Starting subtest: basic-with_fd_dup [129.688149] Subtest basic-with_fd_dup: SUCCESS (0.002s) [129.761891] [137/171] (881s left) prime_self_import (basic-with_one_bo) [129.824295] Starting subtest: basic-with_one_bo [129.826496] Subtest basic-with_one_bo: SUCCESS (0.003s) [129.886631] [138/171] (880s left) prime_self_import (basic-with_one_bo_two_files) [129.947195] Starting subtest: basic-with_one_bo_two_files [129.949419] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [130.026425] [139/171] (880s left) prime_self_import (basic-with_two_bos) [130.088141] Starting subtest: basic-with_two_bos [130.090188] Subtest basic-with_two_bos: SUCCESS (0.002s) [130.175174] [140/171] (880s left) prime_vgem (basic-fence-flip) [130.248706] Starting subtest: basic-fence-flip [130.578127] Subtest basic-fence-flip: SUCCESS (0.329s) [130.642235] [141/171] (880s left) prime_vgem (basic-fence-mmap) [130.715170] Starting subtest: basic-fence-mmap [130.737233] Subtest basic-fence-mmap: SUCCESS (0.022s) [130.810835] [142/171] (880s left) prime_vgem (basic-fence-read) [130.912284] Starting subtest: basic-fence-read [130.914565] Subtest basic-fence-read: SUCCESS (0.032s) [130.976975] [143/171] (879s left) prime_vgem (basic-gtt) [131.048062] Starting subtest: basic-gtt [131.059231] Subtest basic-gtt: SUCCESS (0.011s) [131.126412] [144/171] (879s left) prime_vgem (basic-read) [131.198970] Starting subtest: basic-read [131.214666] Subtest basic-read: SUCCESS (0.016s) [131.291820] [145/171] (879s left) prime_vgem (basic-write) [131.365421] Starting subtest: basic-write [131.382716] Subtest basic-write: SUCCESS (0.017s) [131.461306] [146/171] (879s left) vgem_basic (setversion) [131.529131] Starting subtest: setversion [131.531211] Subtest setversion: SUCCESS (0.000s) [131.575334] [147/171] (879s left) vgem_basic (create) [131.645514] Starting subtest: create [131.646709] Subtest create: SUCCESS (0.000s) [131.693794] [148/171] (879s left) vgem_basic (debugfs) [131.761789] Starting subtest: debugfs [131.762923] Subtest debugfs: SUCCESS (0.000s) [131.809402] [149/171] (879s left) vgem_basic (dmabuf-export) [131.878644] Starting subtest: dmabuf-export [131.880787] Subtest dmabuf-export: SUCCESS (0.002s) [131.962169] [150/171] (879s left) vgem_basic (dmabuf-fence) [132.028559] Starting subtest: dmabuf-fence [132.029600] Subtest dmabuf-fence: SUCCESS (0.001s) [132.076899] [151/171] (878s left) vgem_basic (dmabuf-fence-before) [132.145426] Starting subtest: dmabuf-fence-before [132.146493] Subtest dmabuf-fence-before: SUCCESS (0.000s) [132.192603] [152/171] (878s left) vgem_basic (dmabuf-mmap) [132.261508] Starting subtest: dmabuf-mmap [132.275939] Subtest dmabuf-mmap: SUCCESS (0.015s) [132.325705] [153/171] (878s left) vgem_basic (mmap) [132.395077] Starting subtest: mmap [132.405542] Subtest mmap: SUCCESS (0.011s) [132.444300] [154/171] (878s left) vgem_basic (second-client) [132.511615] Starting subtest: second-client [132.545361] Subtest second-client: SUCCESS (0.033s) [132.592680] [155/171] (878s left) vgem_basic (sysfs) [132.661856] Starting subtest: sysfs [132.662998] Subtest sysfs: SUCCESS (0.000s) [132.709209] [156/171] (878s left) core_hotunplug (unbind-rebind) [132.812675] Starting subtest: unbind-rebind [133.677025] Subtest unbind-rebind: SUCCESS (0.865s) [133.695622] [157/171] (877s left) vgem_basic (unload) [133.763459] Starting subtest: unload [162.659243] Subtest unload: SUCCESS (28.895s) [162.736293] [158/171] (848s left) i915_module_load (reload) [162.798803] Starting subtest: reload [164.573232] Subtest reload: SUCCESS (1.775s) [164.593904] [159/171] (846s left) gem_lmem_swapping (basic) [164.696935] Subtest basic: SKIP (0.000s) [164.717800] [160/171] (846s left) gem_lmem_swapping (parallel-random-engines) [164.786913] Subtest parallel-random-engines: SKIP (0.000s) [164.817609] [161/171] (846s left) gem_lmem_swapping (random-engines) [164.887491] Subtest random-engines: SKIP (0.000s) [164.915305] [162/171] (846s left) gem_lmem_swapping (verify-random) [164.981996] Subtest verify-random: SKIP (0.000s) [164.999938] [163/171] (846s left) i915_pm_rpm (module-reload) [166.708622] Starting subtest: module-reload [173.297450] Subtest module-reload: SUCCESS (6.589s) [173.312051] [164/171] (837s left) i915_selftest (live) [173.383501] Starting subtest: live [173.384649] Starting dynamic subtest: sanitycheck [173.968434] Dynamic subtest sanitycheck: SUCCESS (0.584s) [173.974739] Starting dynamic subtest: uncore [174.496974] Dynamic subtest uncore: SUCCESS (0.528s) [174.502763] Starting dynamic subtest: workarounds [175.156029] Dynamic subtest workarounds: SUCCESS (0.658s) [175.161562] Starting dynamic subtest: gt_engines [175.688899] Dynamic subtest gt_engines: SUCCESS (0.532s) [175.694192] Starting dynamic subtest: gt_timelines [181.320637] Dynamic subtest gt_timelines: SUCCESS (5.630s) [181.326166] Starting dynamic subtest: gt_contexts [182.007896] Dynamic subtest gt_contexts: SUCCESS (0.685s) [182.014299] Starting dynamic subtest: gt_lrc [182.560663] Dynamic subtest gt_lrc: SUCCESS (0.551s) [182.566767] Starting dynamic subtest: gt_mocs [183.143329] Dynamic subtest gt_mocs: SUCCESS (0.582s) [183.155150] Starting dynamic subtest: gt_pm [193.357590] Dynamic subtest gt_pm: SUCCESS (10.213s) [193.363055] Starting dynamic subtest: gt_heartbeat [194.131017] Dynamic subtest gt_heartbeat: SUCCESS (0.773s) [194.137209] Starting dynamic subtest: gt_tlb [194.667458] Dynamic subtest gt_tlb: SUCCESS (0.535s) [194.674837] Starting dynamic subtest: requests [200.976730] Dynamic subtest requests: SUCCESS (6.309s) [200.982056] Starting dynamic subtest: migrate [201.620044] Dynamic subtest migrate: SUCCESS (0.642s) [201.627170] Starting dynamic subtest: active [202.337849] Dynamic subtest active: SUCCESS (0.716s) [202.344412] Starting dynamic subtest: objects [203.239334] Dynamic subtest objects: SUCCESS (0.900s) [203.244733] Starting dynamic subtest: mman [207.167955] Dynamic subtest mman: SUCCESS (3.928s) [207.173733] Starting dynamic subtest: dmabuf [207.737864] Dynamic subtest dmabuf: SUCCESS (0.570s) [207.743474] Starting dynamic subtest: vma [208.430597] Dynamic subtest vma: SUCCESS (0.691s) [208.436514] Starting dynamic subtest: coherency [209.720297] Dynamic subtest coherency: SUCCESS (1.288s) [209.726499] Starting dynamic subtest: gtt [213.737694] Dynamic subtest gtt: SUCCESS (4.016s) [213.743355] Starting dynamic subtest: gem [214.531469] Dynamic subtest gem: SUCCESS (0.792s) [214.538536] Starting dynamic subtest: evict [215.209074] Dynamic subtest evict: SUCCESS (0.677s) [215.214859] Starting dynamic subtest: hugepages [216.422848] Dynamic subtest hugepages: SUCCESS (1.212s) [216.428588] Starting dynamic subtest: gem_contexts [221.317676] Dynamic subtest gem_contexts: SUCCESS (4.893s) [221.323214] Starting dynamic subtest: client [221.857907] Dynamic subtest client: SUCCESS (0.540s) [221.863146] Starting dynamic subtest: gem_migrate [222.429337] Dynamic subtest gem_migrate: SUCCESS (0.570s) [222.436205] Starting dynamic subtest: reset [224.124411] Dynamic subtest reset: SUCCESS (1.694s) [224.131668] Starting dynamic subtest: memory_region [224.674094] Dynamic subtest memory_region: SUCCESS (0.549s) [224.679811] Starting dynamic subtest: hangcheck [242.086324] Dynamic subtest hangcheck: SUCCESS (17.411s) [242.092408] Starting dynamic subtest: execlists [242.782298] Dynamic subtest execlists: SUCCESS (0.695s) [242.788284] Starting dynamic subtest: ring_submission [243.337332] Dynamic subtest ring_submission: SUCCESS (0.554s) [243.343622] Starting dynamic subtest: perf [244.095714] Dynamic subtest perf: SUCCESS (0.758s) [244.101836] Starting dynamic subtest: slpc [244.602964] Dynamic subtest slpc: SUCCESS (0.506s) [244.608793] Starting dynamic subtest: guc [245.274604] Dynamic subtest guc: SUCCESS (0.670s) [245.284130] Starting dynamic subtest: guc_multi_lrc [245.830075] Dynamic subtest guc_multi_lrc: SUCCESS (0.555s) [245.836816] Starting dynamic subtest: guc_hang [246.363225] Dynamic subtest guc_hang: SUCCESS (0.533s) [246.369301] Starting dynamic subtest: late_gt_pm [246.977119] Dynamic subtest late_gt_pm: SUCCESS (0.613s) [246.978056] Subtest live: SUCCESS (73.593s) [247.164573] [165/171] (764s left) dmabuf (all-tests) [247.232309] Starting subtest: all-tests [247.235838] Starting dynamic subtest: sanitycheck [247.296526] Dynamic subtest sanitycheck: SUCCESS (0.063s) [247.302445] Starting dynamic subtest: dma_fence [247.471482] Dynamic subtest dma_fence: SUCCESS (0.174s) [247.476934] Starting dynamic subtest: dma_fence_chain [259.096694] Dynamic subtest dma_fence_chain: SUCCESS (11.625s) [259.102457] Starting dynamic subtest: dma_fence_unwrap [259.154082] Dynamic subtest dma_fence_unwrap: SUCCESS (0.057s) [259.160168] Starting dynamic subtest: dma_resv [259.210048] Dynamic subtest dma_resv: SUCCESS (0.056s) [259.211175] Subtest all-tests: SUCCESS (11.978s) [259.223960] [166/171] (752s left) i915_suspend (basic-s2idle-without-i915) [259.286871] Starting subtest: basic-s2idle-without-i915 [276.741101] Subtest basic-s2idle-without-i915: SUCCESS (2.019s) [283.890030] [167/171] (749s left) i915_suspend (basic-s3-without-i915) [283.960818] Starting subtest: basic-s3-without-i915 [301.818286] Subtest basic-s3-without-i915: SUCCESS (1.830s) [307.959581] [168/171] (747s left) gem_exec_suspend (basic-s0) [308.039881] Starting subtest: basic-S0 [308.040841] Starting dynamic subtest: smem [324.650595] Dynamic subtest smem: SUCCESS (1.285s) [324.651825] Subtest basic-S0: SUCCESS (1.286s) [330.798659] [169/171] (746s left) gem_exec_suspend (basic-s3) [330.872021] Starting subtest: basic-S3 [330.873028] Starting dynamic subtest: smem [348.665531] Dynamic subtest smem: SUCCESS (1.303s) [348.666602] Subtest basic-S3: SUCCESS (1.304s) [354.812794] [170/171] (744s left) kms_chamelium_hpd (common-hpd-after-suspend) [354.936692] Subtest common-hpd-after-suspend: SKIP (0.000s) [355.023011] [171/171] (744s left) kms_pipe_crc_basic (suspend-read-crc) [355.112083] Starting subtest: suspend-read-crc [355.114571] Starting dynamic subtest: pipe-A-VGA-1 [372.793719] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.449s) [372.801620] Starting dynamic subtest: pipe-B-VGA-1 [390.817520] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.487s) [390.827765] Starting dynamic subtest: pipe-C-VGA-1 [408.820604] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.466s) [408.822027] Subtest suspend-read-crc: SUCCESS (4.408s) [411.911309] Closing watchdogs Done.