[56.343101] Initializing watchdogs [56.343457] /dev/watchdog0 [56.374780] [001/170] (960s left) i915_module_load (load) [56.746116] Starting subtest: load [60.634481] Subtest load: SUCCESS (3.885s) [60.708324] [002/170] (956s left) core_auth (basic-auth) [61.335171] Starting subtest: basic-auth [61.345707] Subtest basic-auth: SUCCESS (0.015s) [61.525682] [003/170] (955s left) debugfs_test (read_all_entries) [62.270846] Starting subtest: read_all_entries [62.479738] Subtest read_all_entries: SUCCESS (0.208s) [63.098952] [004/170] (954s left) debugfs_test (basic-hwmon) [63.430415] Starting subtest: basic-hwmon [63.433218] Subtest basic-hwmon: SKIP (0.000s) [64.019808] [005/170] (953s left) fbdev (eof) [64.337115] Starting subtest: eof [64.338683] Subtest eof: SUCCESS (0.001s) [64.423346] [006/170] (952s left) fbdev (info) [64.725974] Starting subtest: info [64.729255] Subtest info: SUCCESS (0.000s) [64.817969] [007/170] (952s left) fbdev (nullptr) [65.119759] Starting subtest: nullptr [65.123224] Subtest nullptr: SUCCESS (0.003s) [65.218154] [008/170] (952s left) fbdev (read) [65.519727] Starting subtest: read [67.661402] Subtest read: SUCCESS (2.132s) [67.757299] [009/170] (949s left) fbdev (write) [68.073604] Starting subtest: write [69.144754] Subtest write: SUCCESS (1.064s) [69.234359] [010/170] (948s left) gem_basic (bad-close) [69.551157] Starting subtest: bad-close [69.556999] Subtest bad-close: SUCCESS (0.000s) [69.651730] [011/170] (947s left) gem_basic (create-close) [69.960310] Starting subtest: create-close [69.975892] Subtest create-close: SUCCESS (0.001s) [70.076738] [012/170] (947s left) gem_basic (create-fd-close) [70.395534] Starting subtest: create-fd-close [70.399898] Subtest create-fd-close: SUCCESS (0.000s) [70.503382] [013/170] (947s left) gem_busy (busy@all-engines) [70.854526] Starting subtest: busy [70.856303] Starting dynamic subtest: all-engines [71.002758] Dynamic subtest all-engines: SUCCESS (0.147s) [71.004317] Subtest busy: SUCCESS (0.147s) [71.404737] [014/170] (946s left) gem_close_race (basic-process) [71.765205] Starting subtest: basic-process [71.896397] Subtest basic-process: SUCCESS (0.131s) [72.119423] [015/170] (945s left) gem_close_race (basic-threads) [72.483944] Starting subtest: basic-threads [73.706639] Subtest basic-threads: SUCCESS (1.226s) [73.953276] [016/170] (943s left) gem_ctx_create (basic) [74.307469] Starting subtest: basic [74.310696] Subtest basic: SUCCESS (0.002s) [74.536292] [017/170] (943s left) gem_ctx_create (basic-files) [74.885781] Starting subtest: basic-files [76.941546] Subtest basic-files: SUCCESS (2.060s) [77.174909] [018/170] (940s left) gem_ctx_exec (basic) [77.511498] Starting subtest: basic [77.527824] Subtest basic: SUCCESS (0.013s) [77.646906] [019/170] (940s left) gem_exec_basic (basic) [77.985741] Starting subtest: basic [77.991077] Starting dynamic subtest: rcs0-smem [77.997208] Dynamic subtest rcs0-smem: SUCCESS (0.005s) [78.026797] Starting dynamic subtest: bcs0-smem [78.028299] Dynamic subtest bcs0-smem: SUCCESS (0.010s) [78.045624] Starting dynamic subtest: vcs0-smem [78.047223] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [78.062668] Starting dynamic subtest: vecs0-smem [78.064250] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [78.065675] Subtest basic: SUCCESS (0.032s) [78.256716] [020/170] (939s left) gem_exec_create (basic) [78.602344] Starting subtest: basic [78.605769] Starting dynamic subtest: smem [80.684135] Dynamic subtest smem: SUCCESS (2.078s) [80.685522] Subtest basic: SUCCESS (2.081s) [80.908211] [021/170] (937s left) gem_exec_fence (basic-busy) [81.427026] Starting subtest: basic-busy [81.429835] Starting dynamic subtest: rcs0 [81.449548] Dynamic subtest rcs0: SUCCESS (0.026s) [81.468335] Starting dynamic subtest: bcs0 [81.472784] Dynamic subtest bcs0: SUCCESS (0.021s) [81.491075] Starting dynamic subtest: vcs0 [81.494287] Dynamic subtest vcs0: SUCCESS (0.018s) [81.517396] Starting dynamic subtest: vecs0 [81.519923] Dynamic subtest vecs0: SUCCESS (0.023s) [81.521423] Subtest basic-busy: SUCCESS (0.089s) [82.288131] [022/170] (935s left) gem_exec_fence (basic-wait) [82.802602] Starting subtest: basic-wait [82.804190] Starting dynamic subtest: rcs0 [82.830519] Dynamic subtest rcs0: SUCCESS (0.029s) [82.857643] Starting dynamic subtest: bcs0 [82.860238] Dynamic subtest bcs0: SUCCESS (0.026s) [82.898109] Starting dynamic subtest: vcs0 [82.903257] Dynamic subtest vcs0: SUCCESS (0.024s) [82.920855] Starting dynamic subtest: vecs0 [82.923241] Dynamic subtest vecs0: SUCCESS (0.021s) [82.925517] Subtest basic-wait: SUCCESS (0.103s) [83.557146] [023/170] (934s left) gem_exec_fence (basic-await) [84.074248] Starting subtest: basic-await [84.075760] Starting dynamic subtest: rcs0 [84.254922] Dynamic subtest rcs0: SUCCESS (0.181s) [84.272978] Starting dynamic subtest: bcs0 [84.437902] Dynamic subtest bcs0: SUCCESS (0.180s) [84.456780] Starting dynamic subtest: vcs0 [84.623554] Dynamic subtest vcs0: SUCCESS (0.185s) [84.642415] Starting dynamic subtest: vecs0 [84.794971] Dynamic subtest vecs0: SUCCESS (0.172s) [84.797594] Subtest basic-await: SUCCESS (0.721s) [85.446650] [024/170] (932s left) gem_exec_fence (nb-await) [85.966729] Starting subtest: nb-await [85.968438] Starting dynamic subtest: rcs0 [86.053726] Dynamic subtest rcs0: SUCCESS (0.087s) [86.075726] Starting dynamic subtest: bcs0 [86.141584] Dynamic subtest bcs0: SUCCESS (0.082s) [86.162837] Starting dynamic subtest: vcs0 [86.222713] Dynamic subtest vcs0: SUCCESS (0.074s) [86.241373] Starting dynamic subtest: vecs0 [86.287494] Dynamic subtest vecs0: SUCCESS (0.077s) [86.289672] Subtest nb-await: SUCCESS (0.323s) [86.939891] [025/170] (931s left) gem_exec_gttfill (basic) [87.301077] Starting subtest: basic [89.107626] Subtest basic: SKIP (1.803s) [89.369284] [026/170] (928s left) gem_exec_parallel (engines) [89.899665] Starting subtest: engines [89.903231] Starting dynamic subtest: basic [95.258714] Dynamic subtest basic: SUCCESS (5.351s) [95.286910] Starting dynamic subtest: contexts [101.994992] Dynamic subtest contexts: SUCCESS (6.737s) [102.024275] Starting dynamic subtest: fds [111.671951] Dynamic subtest fds: SUCCESS (9.675s) [111.694385] Starting dynamic subtest: userptr [117.280302] Dynamic subtest userptr: SUCCESS (5.607s) [117.281668] Subtest engines: SUCCESS (27.378s) [117.532185] [027/170] (900s left) gem_exec_store (basic) [117.900223] Starting subtest: basic [117.949659] Subtest basic: SUCCESS (0.046s) [118.194737] [028/170] (900s left) gem_flink_basic (bad-flink) [118.510951] Starting subtest: bad-flink [118.513219] Subtest bad-flink: SUCCESS (0.000s) [118.622656] [029/170] (899s left) gem_flink_basic (bad-open) [118.944336] Starting subtest: bad-open [118.947543] Subtest bad-open: SUCCESS (0.002s) [119.072807] [030/170] (899s left) gem_flink_basic (basic) [119.384199] Starting subtest: basic [119.386114] Subtest basic: SUCCESS (0.000s) [119.488183] [031/170] (898s left) gem_flink_basic (double-flink) [119.791481] Starting subtest: double-flink [119.793245] Subtest double-flink: SUCCESS (0.001s) [119.912324] [032/170] (898s left) gem_flink_basic (flink-lifetime) [120.220927] Starting subtest: flink-lifetime [120.225317] Subtest flink-lifetime: SUCCESS (0.005s) [120.322913] [033/170] (898s left) gem_huc_copy (huc-copy) [120.640922] Subtest huc-copy: SKIP (0.000s) [120.714096] [034/170] (897s left) gem_linear_blits (basic) [121.356927] Subtest basic: SKIP (0.000s) [121.500517] [035/170] (897s left) gem_mmap (basic) [121.987985] Starting subtest: basic [121.996220] Subtest basic: SUCCESS (0.003s) [122.094342] [036/170] (896s left) gem_mmap_gtt (basic) [122.400946] Starting subtest: basic [122.403920] Subtest basic: SUCCESS (0.003s) [122.497546] [037/170] (896s left) gem_render_linear_blits (basic) [122.819552] Starting subtest: basic [122.933942] Subtest basic: SUCCESS (0.112s) [123.017531] [038/170] (895s left) gem_render_tiled_blits (basic) [123.335246] Starting subtest: basic [123.461460] Subtest basic: SUCCESS (0.121s) [123.546235] [039/170] (895s left) gem_ringfill (basic-all) [124.045856] Starting subtest: basic-all [125.327307] Subtest basic-all: SUCCESS (1.281s) [125.445940] [040/170] (893s left) gem_softpin (allocator-basic) [125.768755] Starting subtest: allocator-basic [126.053808] Subtest allocator-basic: SUCCESS (0.281s) [126.205921] [041/170] (892s left) gem_softpin (allocator-basic-reserve) [126.539888] Starting subtest: allocator-basic-reserve [126.908328] Subtest allocator-basic-reserve: SUCCESS (0.366s) [127.080300] [042/170] (891s left) gem_softpin (safe-alignment) [127.407233] Starting subtest: safe-alignment [127.454706] Subtest safe-alignment: SUCCESS (0.046s) [127.572723] [043/170] (891s left) gem_sync (basic-all) [127.938201] Starting subtest: basic-all [130.521692] Subtest basic-all: SUCCESS (2.580s) [130.767085] [044/170] (888s left) gem_sync (basic-each) [131.123559] Starting subtest: basic-each [133.608640] Subtest basic-each: SUCCESS (2.486s) [133.864902] [045/170] (885s left) gem_tiled_blits (basic) [134.486485] Subtest basic: SKIP (0.000s) [134.586093] [046/170] (884s left) gem_tiled_fence_blits (basic) [135.372492] Starting subtest: basic [135.421634] Subtest basic: SUCCESS (0.055s) [135.581916] [047/170] (883s left) gem_tiled_pread_basic [137.026369] [048/170] (882s left) gem_wait (busy@all-engines) [137.399609] Starting subtest: busy [137.400991] Starting dynamic subtest: all-engines [137.924919] Dynamic subtest all-engines: SUCCESS (0.528s) [137.926404] Subtest busy: SUCCESS (0.528s) [138.229276] [049/170] (881s left) gem_wait (wait@all-engines) [138.607205] Starting subtest: wait [138.608928] Starting dynamic subtest: all-engines [139.653145] Dynamic subtest all-engines: SUCCESS (1.046s) [139.654834] Subtest wait: SUCCESS (1.046s) [139.980593] [050/170] (879s left) i915_getparams_basic (basic-eu-total) [140.286925] Starting subtest: basic-eu-total [140.289829] Subtest basic-eu-total: SUCCESS (0.000s) [140.393268] [051/170] (879s left) i915_getparams_basic (basic-subslice-total) [140.702081] Starting subtest: basic-subslice-total [140.706798] Subtest basic-subslice-total: SUCCESS (0.002s) [140.824716] [052/170] (878s left) i915_hangman (error-state-basic) [141.166857] Starting subtest: error-state-basic [141.194416] Subtest error-state-basic: SUCCESS (0.020s) [141.311069] [053/170] (878s left) i915_pciid [141.720839] [054/170] (877s left) kms_addfb_basic (addfb25-bad-modifier) [142.040410] Starting subtest: addfb25-bad-modifier [142.041911] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [142.641092] [055/170] (877s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [142.952228] Starting subtest: addfb25-framebuffer-vs-set-tiling [142.956071] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.002s) [143.424743] [056/170] (876s left) kms_addfb_basic (addfb25-modifier-no-flag) [143.731702] Starting subtest: addfb25-modifier-no-flag [143.733359] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [144.289392] [057/170] (875s left) kms_addfb_basic (addfb25-x-tiled-legacy) [144.612261] Starting subtest: addfb25-x-tiled-legacy [144.617118] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [145.273113] [058/170] (874s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [145.602336] Starting subtest: addfb25-x-tiled-mismatch-legacy [145.610256] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [146.323940] [059/170] (873s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [147.209572] Starting subtest: addfb25-yf-tiled-legacy [147.211203] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [147.343563] [060/170] (872s left) kms_addfb_basic (addfb25-y-tiled-legacy) [148.212697] Starting subtest: addfb25-y-tiled-legacy [148.214595] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [148.340612] [061/170] (871s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [149.200643] Starting subtest: addfb25-y-tiled-small-legacy [149.203858] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [149.323568] [062/170] (870s left) kms_addfb_basic (bad-pitch-0) [149.631838] Starting subtest: bad-pitch-0 [149.635362] Subtest bad-pitch-0: SUCCESS (0.000s) [150.307749] [063/170] (869s left) kms_addfb_basic (bad-pitch-1024) [150.614485] Starting subtest: bad-pitch-1024 [150.617842] Subtest bad-pitch-1024: SUCCESS (0.000s) [151.308093] [064/170] (868s left) kms_addfb_basic (bad-pitch-128) [151.617626] Starting subtest: bad-pitch-128 [151.620994] Subtest bad-pitch-128: SUCCESS (0.001s) [152.291289] [065/170] (867s left) kms_addfb_basic (bad-pitch-256) [152.599599] Starting subtest: bad-pitch-256 [152.603386] Subtest bad-pitch-256: SUCCESS (0.000s) [153.290525] [066/170] (867s left) kms_addfb_basic (bad-pitch-32) [153.596523] Starting subtest: bad-pitch-32 [153.600159] Subtest bad-pitch-32: SUCCESS (0.000s) [154.123536] [067/170] (866s left) kms_addfb_basic (bad-pitch-63) [154.432996] Starting subtest: bad-pitch-63 [154.436612] Subtest bad-pitch-63: SUCCESS (0.000s) [155.123409] [068/170] (865s left) kms_addfb_basic (bad-pitch-65536) [155.430188] Starting subtest: bad-pitch-65536 [155.433333] Subtest bad-pitch-65536: SUCCESS (0.001s) [156.122898] [069/170] (864s left) kms_addfb_basic (bad-pitch-999) [156.429712] Starting subtest: bad-pitch-999 [156.433418] Subtest bad-pitch-999: SUCCESS (0.000s) [157.123084] [070/170] (863s left) kms_addfb_basic (basic) [157.426473] Starting subtest: basic [157.429869] Subtest basic: SUCCESS (0.000s) [158.110610] [071/170] (862s left) kms_addfb_basic (basic-x-tiled-legacy) [158.420802] Starting subtest: basic-x-tiled-legacy [158.424420] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [159.088951] [072/170] (861s left) kms_addfb_basic (basic-y-tiled-legacy) [159.401909] Starting subtest: basic-y-tiled-legacy [159.406361] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [160.074116] [073/170] (860s left) kms_addfb_basic (bo-too-small) [160.942888] Starting subtest: bo-too-small [160.949153] Subtest bo-too-small: SUCCESS (0.008s) [161.074797] [074/170] (859s left) kms_addfb_basic (bo-too-small-due-to-tiling) [161.946623] Starting subtest: bo-too-small-due-to-tiling [161.951070] Subtest bo-too-small-due-to-tiling: SUCCESS (0.005s) [162.073642] [075/170] (858s left) kms_addfb_basic (clobberred-modifier) [162.382296] Starting subtest: clobberred-modifier [162.384550] Subtest clobberred-modifier: SUCCESS (0.000s) [163.055776] [076/170] (857s left) kms_addfb_basic (framebuffer-vs-set-tiling) [163.363591] Starting subtest: framebuffer-vs-set-tiling [163.367553] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [164.007326] [077/170] (856s left) kms_addfb_basic (invalid-get-prop) [164.318176] Starting subtest: invalid-get-prop [164.321635] Subtest invalid-get-prop: SUCCESS (0.000s) [164.991033] [078/170] (855s left) kms_addfb_basic (invalid-get-prop-any) [165.302787] Starting subtest: invalid-get-prop-any [165.306191] Subtest invalid-get-prop-any: SUCCESS (0.000s) [165.991759] [079/170] (854s left) kms_addfb_basic (invalid-set-prop) [166.370906] Starting subtest: invalid-set-prop [166.374250] Subtest invalid-set-prop: SUCCESS (0.000s) [166.959618] [080/170] (854s left) kms_addfb_basic (invalid-set-prop-any) [167.271269] Starting subtest: invalid-set-prop-any [167.272813] Subtest invalid-set-prop-any: SUCCESS (0.000s) [167.923193] [081/170] (853s left) kms_addfb_basic (no-handle) [168.236546] Starting subtest: no-handle [168.240540] Subtest no-handle: SUCCESS (0.002s) [168.890173] [082/170] (852s left) kms_addfb_basic (size-max) [169.774983] Starting subtest: size-max [169.776857] Subtest size-max: SUCCESS (0.001s) [169.874210] [083/170] (851s left) kms_addfb_basic (small-bo) [170.704794] Starting subtest: small-bo [170.706290] Subtest small-bo: SUCCESS (0.000s) [170.807840] [084/170] (850s left) kms_addfb_basic (tile-pitch-mismatch) [171.132574] Starting subtest: tile-pitch-mismatch [171.137449] Subtest tile-pitch-mismatch: SUCCESS (0.003s) [171.840082] [085/170] (849s left) kms_addfb_basic (too-high) [172.658434] Starting subtest: too-high [172.660054] Subtest too-high: SUCCESS (0.003s) [172.774760] [086/170] (848s left) kms_addfb_basic (too-wide) [173.644903] Starting subtest: too-wide [173.648202] Subtest too-wide: SUCCESS (0.000s) [173.755389] [087/170] (847s left) kms_addfb_basic (unused-handle) [174.066766] Starting subtest: unused-handle [174.070737] Subtest unused-handle: SUCCESS (0.001s) [174.789938] [088/170] (846s left) kms_addfb_basic (unused-modifier) [175.103413] Starting subtest: unused-modifier [175.107286] Subtest unused-modifier: SUCCESS (0.000s) [175.806240] [089/170] (845s left) kms_addfb_basic (unused-offsets) [176.111726] Starting subtest: unused-offsets [176.115874] Subtest unused-offsets: SUCCESS (0.000s) [176.806719] [090/170] (844s left) kms_addfb_basic (unused-pitches) [177.114394] Starting subtest: unused-pitches [177.117973] Subtest unused-pitches: SUCCESS (0.000s) [177.791234] [091/170] (843s left) kms_busy (basic) [178.699512] Starting subtest: basic [178.705400] Starting dynamic subtest: flip [179.920393] Dynamic subtest flip: SUCCESS (1.200s) [179.961593] Starting dynamic subtest: modeset [182.320691] Dynamic subtest modeset: SUCCESS (2.364s) [182.326107] Subtest basic: SUCCESS (3.621s) [182.928987] [092/170] (838s left) kms_chamelium_hpd (dp-hpd-fast) [184.046908] Subtest dp-hpd-fast: SKIP (0.000s) [184.457159] [093/170] (837s left) kms_chamelium_edid (dp-edid-read) [185.638231] Subtest dp-edid-read: SKIP (0.000s) [186.036787] [094/170] (835s left) kms_chamelium_frames (dp-crc-fast) [187.219397] Subtest dp-crc-fast: SKIP (0.000s) [187.455179] [095/170] (834s left) kms_chamelium_hpd (hdmi-hpd-fast) [188.522976] Subtest hdmi-hpd-fast: SKIP (0.000s) [188.860378] [096/170] (833s left) kms_chamelium_edid (hdmi-edid-read) [189.992817] Subtest hdmi-edid-read: SKIP (0.000s) [190.413968] [097/170] (831s left) kms_chamelium_frames (hdmi-crc-fast) [191.549887] Subtest hdmi-crc-fast: SKIP (0.000s) [191.964838] [098/170] (830s left) kms_chamelium_hpd (vga-hpd-fast) [193.164406] Subtest vga-hpd-fast: SKIP (0.000s) [193.613779] [099/170] (828s left) kms_chamelium_edid (vga-edid-read) [194.794524] Subtest vga-edid-read: SKIP (0.000s) [195.122205] [100/170] (827s left) kms_prop_blob (basic) [195.499243] Starting subtest: basic [195.503204] Subtest basic: SUCCESS (0.000s) [195.618231] [101/170] (827s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [196.554625] Starting subtest: basic-busy-flip-before-cursor-atomic [197.855478] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.301s) [198.341618] [102/170] (824s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [199.207925] Starting subtest: basic-busy-flip-before-cursor-legacy [200.596090] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.392s) [201.088985] [103/170] (821s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [201.821730] Starting subtest: basic-flip-after-cursor-atomic [203.087363] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.279s) [203.608547] [104/170] (819s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [204.368037] Starting subtest: basic-flip-after-cursor-legacy [205.593060] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.221s) [206.139987] [105/170] (816s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [206.999879] Starting subtest: basic-flip-after-cursor-varying-size [208.239723] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.243s) [208.772493] [106/170] (814s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [209.643858] Starting subtest: basic-flip-before-cursor-atomic [210.870955] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.229s) [211.308922] [107/170] (811s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [211.986942] Starting subtest: basic-flip-before-cursor-legacy [213.292526] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.308s) [213.864195] [108/170] (809s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [214.554587] Starting subtest: basic-flip-before-cursor-varying-size [215.736633] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.187s) [216.148051] [109/170] (807s left) kms_flip (basic-flip-vs-dpms) [216.739386] Starting subtest: basic-flip-vs-dpms [216.755495] Starting dynamic subtest: C-HDMI-A2 [219.749942] Dynamic subtest C-HDMI-A2: SUCCESS (2.975s) [219.752185] Subtest basic-flip-vs-dpms: SUCCESS (3.001s) [220.234624] [110/170] (802s left) kms_flip (basic-flip-vs-modeset) [220.782209] Starting subtest: basic-flip-vs-modeset [220.795495] Starting dynamic subtest: C-HDMI-A2 [223.559051] Dynamic subtest C-HDMI-A2: SUCCESS (2.761s) [223.560445] Subtest basic-flip-vs-modeset: SUCCESS (2.785s) [224.112295] [111/170] (799s left) kms_flip (basic-flip-vs-wf_vblank) [224.618447] Starting subtest: basic-flip-vs-wf_vblank [224.649135] Starting dynamic subtest: C-HDMI-A2 [227.601927] Dynamic subtest C-HDMI-A2: SUCCESS (2.922s) [227.604098] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.955s) [227.783647] [112/170] (795s left) kms_flip (basic-plain-flip) [228.296268] Starting subtest: basic-plain-flip [228.320561] Starting dynamic subtest: C-HDMI-A2 [230.955851] Dynamic subtest C-HDMI-A2: SUCCESS (2.634s) [230.957205] Subtest basic-plain-flip: SUCCESS (2.667s) [231.148372] [113/170] (792s left) kms_force_connector_basic (force-connector-state) [231.581949] Starting subtest: force-connector-state [232.541910] Subtest force-connector-state: SUCCESS (0.964s) [233.791603] [114/170] (789s left) kms_force_connector_basic (force-edid) [234.241785] Starting subtest: force-edid [234.427877] Subtest force-edid: SUCCESS (0.182s) [235.119419] [115/170] (788s left) kms_force_connector_basic (force-load-detect) [235.634124] Starting subtest: force-load-detect [235.638323] Subtest force-load-detect: SKIP (0.000s) [236.139314] [116/170] (787s left) kms_force_connector_basic (prune-stale-modes) [236.602607] Starting subtest: prune-stale-modes [236.749442] Subtest prune-stale-modes: SUCCESS (0.144s) [237.591474] [117/170] (785s left) kms_frontbuffer_tracking (basic) [238.368723] Starting subtest: basic [242.586939] Subtest basic: SUCCESS (4.219s) [242.743202] [118/170] (780s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [243.462329] Starting subtest: compare-crc-sanitycheck [243.464879] Starting dynamic subtest: pipe-C-HDMI-A-2 [244.016209] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.549s) [244.017783] Subtest compare-crc-sanitycheck: SUCCESS (0.555s) [244.420092] [119/170] (779s left) kms_pipe_crc_basic (hang-read-crc) [245.113489] Starting subtest: hang-read-crc [245.114986] Starting dynamic subtest: pipe-C-HDMI-A-2 [246.949929] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.834s) [246.953058] Subtest hang-read-crc: SUCCESS (1.845s) [247.370819] [120/170] (776s left) kms_pipe_crc_basic (nonblocking-crc) [248.181071] Starting subtest: nonblocking-crc [248.195072] Starting dynamic subtest: pipe-C-HDMI-A-2 [248.971336] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.773s) [248.972742] Subtest nonblocking-crc: SUCCESS (0.788s) [249.482093] [121/170] (774s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [250.227913] Starting subtest: nonblocking-crc-frame-sequence [250.234844] Starting dynamic subtest: pipe-C-HDMI-A-2 [250.982697] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.743s) [250.984435] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.755s) [251.479302] [122/170] (772s left) kms_pipe_crc_basic (read-crc) [252.276591] Starting subtest: read-crc [252.278267] Starting dynamic subtest: pipe-C-HDMI-A-2 [252.950938] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.673s) [252.952868] Subtest read-crc: SUCCESS (0.681s) [253.407220] [123/170] (770s left) kms_pipe_crc_basic (read-crc-frame-sequence) [254.119838] Starting subtest: read-crc-frame-sequence [254.121360] Starting dynamic subtest: pipe-C-HDMI-A-2 [254.783309] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.672s) [254.784832] Subtest read-crc-frame-sequence: SUCCESS (0.678s) [255.245602] [124/170] (768s left) kms_psr (primary_page_flip) [255.571550] Subtest primary_page_flip: SKIP (0.000s) [255.669653] [125/170] (768s left) kms_psr (cursor_plane_move) [255.988922] Subtest cursor_plane_move: SKIP (0.000s) [256.084837] [126/170] (767s left) kms_psr (sprite_plane_onoff) [256.402683] Subtest sprite_plane_onoff: SKIP (0.000s) [256.501472] [127/170] (767s left) kms_psr (primary_mmap_gtt) [256.808519] Subtest primary_mmap_gtt: SKIP (0.000s) [256.885758] [128/170] (767s left) kms_setmode (basic-clone-single-crtc) [257.195656] Starting subtest: basic-clone-single-crtc [257.200369] Subtest basic-clone-single-crtc: SKIP (0.001s) [257.311443] [129/170] (766s left) i915_pm_backlight (basic-brightness) [258.095186] Subtest basic-brightness: SKIP (0.000s) [258.183956] [130/170] (766s left) i915_pm_rpm (basic-pci-d3-state) [260.565677] Starting subtest: basic-pci-d3-state [261.109914] Subtest basic-pci-d3-state: SUCCESS (0.537s) [261.506270] [131/170] (762s left) i915_pm_rpm (basic-rte) [261.814932] Starting subtest: basic-rte [264.324767] Subtest basic-rte: SUCCESS (2.506s) [265.530971] [132/170] (758s left) i915_pm_rps (basic-api) [265.858820] Starting subtest: basic-api [265.873059] Subtest basic-api: SUCCESS (0.014s) [265.981440] [133/170] (758s left) prime_self_import (basic-llseek-bad) [266.288614] Starting subtest: basic-llseek-bad [266.300712] Subtest basic-llseek-bad: SUCCESS (0.013s) [266.412930] [134/170] (758s left) prime_self_import (basic-llseek-size) [266.716714] Starting subtest: basic-llseek-size [266.735774] Subtest basic-llseek-size: SUCCESS (0.019s) [266.862362] [135/170] (757s left) prime_self_import (basic-with_fd_dup) [267.169711] Starting subtest: basic-with_fd_dup [267.192494] Subtest basic-with_fd_dup: SUCCESS (0.023s) [267.312163] [136/170] (757s left) prime_self_import (basic-with_one_bo) [267.617690] Starting subtest: basic-with_one_bo [267.638756] Subtest basic-with_one_bo: SUCCESS (0.021s) [267.752715] [137/170] (756s left) prime_self_import (basic-with_one_bo_two_files) [268.057970] Starting subtest: basic-with_one_bo_two_files [268.078682] Subtest basic-with_one_bo_two_files: SUCCESS (0.020s) [268.195916] [138/170] (756s left) prime_self_import (basic-with_two_bos) [268.500389] Starting subtest: basic-with_two_bos [268.519694] Subtest basic-with_two_bos: SUCCESS (0.019s) [268.642414] [139/170] (756s left) prime_vgem (basic-fence-flip) [269.009616] Starting subtest: basic-fence-flip [269.734933] Subtest basic-fence-flip: SKIP (0.715s) [269.896950] [140/170] (754s left) prime_vgem (basic-fence-mmap) [270.260092] Starting subtest: basic-fence-mmap [270.367977] Subtest basic-fence-mmap: SUCCESS (0.107s) [270.477855] [141/170] (754s left) prime_vgem (basic-fence-read) [270.833732] Starting subtest: basic-fence-read [271.012574] Subtest basic-fence-read: SUCCESS (0.175s) [271.129289] [142/170] (753s left) prime_vgem (basic-gtt) [271.474683] Starting subtest: basic-gtt [271.526204] Subtest basic-gtt: SUCCESS (0.051s) [271.643793] [143/170] (753s left) prime_vgem (basic-read) [271.982057] Starting subtest: basic-read [272.070438] Subtest basic-read: SUCCESS (0.080s) [272.194937] [144/170] (752s left) prime_vgem (basic-write) [272.550562] Starting subtest: basic-write [272.641953] Subtest basic-write: SUCCESS (0.090s) [272.761070] [145/170] (752s left) vgem_basic (setversion) [273.088061] Starting subtest: setversion [273.091121] Subtest setversion: SUCCESS (0.000s) [273.179054] [146/170] (752s left) vgem_basic (create) [273.504549] Starting subtest: create [273.506208] Subtest create: SUCCESS (0.001s) [273.612496] [147/170] (751s left) vgem_basic (debugfs) [273.921426] Starting subtest: debugfs [273.922832] Subtest debugfs: SUCCESS (0.002s) [274.011647] [148/170] (751s left) vgem_basic (dmabuf-export) [274.320613] Starting subtest: dmabuf-export [274.335618] Subtest dmabuf-export: SUCCESS (0.014s) [274.447820] [149/170] (750s left) vgem_basic (dmabuf-fence) [274.772339] Starting subtest: dmabuf-fence [274.777545] Subtest dmabuf-fence: SUCCESS (0.005s) [274.877757] [150/170] (750s left) vgem_basic (dmabuf-fence-before) [275.205591] Starting subtest: dmabuf-fence-before [275.210437] Subtest dmabuf-fence-before: SUCCESS (0.004s) [275.312578] [151/170] (750s left) vgem_basic (dmabuf-mmap) [275.641407] Starting subtest: dmabuf-mmap [275.686265] Subtest dmabuf-mmap: SUCCESS (0.046s) [275.777912] [152/170] (749s left) vgem_basic (mmap) [276.088177] Starting subtest: mmap [276.117242] Subtest mmap: SUCCESS (0.029s) [276.213177] [153/170] (749s left) vgem_basic (second-client) [276.538418] Starting subtest: second-client [276.585523] Subtest second-client: SUCCESS (0.046s) [276.676239] [154/170] (748s left) vgem_basic (sysfs) [276.986521] Starting subtest: sysfs [276.991872] Subtest sysfs: SUCCESS (0.005s) [277.094617] [155/170] (748s left) core_hotunplug (unbind-rebind) [277.504186] Starting subtest: unbind-rebind [280.821877] Subtest unbind-rebind: SUCCESS (3.317s) [280.984110] [156/170] (744s left) vgem_basic (unload) [281.601757] Starting subtest: unload [310.857880] Subtest unload: SUCCESS (29.252s) [311.101432] [157/170] (714s left) i915_module_load (reload) [311.407714] Starting subtest: reload [316.390079] Subtest reload: SUCCESS (4.959s) [316.507988] [158/170] (709s left) gem_lmem_swapping (basic) [317.215677] Subtest basic: SKIP (0.000s) [317.318218] [159/170] (708s left) gem_lmem_swapping (parallel-random-engines) [317.645434] Subtest parallel-random-engines: SKIP (0.000s) [317.744063] [160/170] (708s left) gem_lmem_swapping (random-engines) [318.083151] Subtest random-engines: SKIP (0.000s) [318.167318] [161/170] (708s left) gem_lmem_swapping (verify-random) [318.501201] Subtest verify-random: SKIP (0.000s) [318.583767] [162/170] (707s left) i915_pm_rpm (module-reload) [321.625275] Starting subtest: module-reload [337.038774] Subtest module-reload: SUCCESS (15.433s) [337.089207] [163/170] (689s left) i915_selftest (live) [337.458598] Starting subtest: live [337.460256] Starting dynamic subtest: sanitycheck [339.429347] Dynamic subtest sanitycheck: SUCCESS (1.969s) [339.458127] Starting dynamic subtest: uncore [341.279626] Dynamic subtest uncore: SUCCESS (1.848s) [341.311118] Starting dynamic subtest: workarounds [343.305631] Dynamic subtest workarounds: SUCCESS (2.022s) [343.336962] Starting dynamic subtest: gt_engines [345.739438] Dynamic subtest gt_engines: SUCCESS (2.431s) [345.772162] Starting dynamic subtest: gt_timelines [375.288974] Dynamic subtest gt_timelines: SUCCESS (29.546s) [375.321093] Starting dynamic subtest: gt_contexts [377.311469] Dynamic subtest gt_contexts: SUCCESS (2.020s) [377.344235] Starting dynamic subtest: gt_lrc [382.545782] Dynamic subtest gt_lrc: SUCCESS (5.232s) [382.579095] Starting dynamic subtest: gt_mocs [384.451528] Dynamic subtest gt_mocs: SUCCESS (1.902s) [384.483140] Starting dynamic subtest: gt_pm [387.455864] Dynamic subtest gt_pm: SUCCESS (3.001s) [387.487113] Starting dynamic subtest: gt_heartbeat [389.515430] Dynamic subtest gt_heartbeat: SUCCESS (2.057s) [389.549146] Starting dynamic subtest: gt_tlb [391.803437] Dynamic subtest gt_tlb: SUCCESS (2.285s) [391.838104] Starting dynamic subtest: requests [400.423787] Dynamic subtest requests: SUCCESS (8.617s) [400.457153] Starting dynamic subtest: migrate [405.926149] Dynamic subtest migrate: SUCCESS (5.496s) [405.943850] Starting dynamic subtest: active [407.810363] Dynamic subtest active: SUCCESS (1.885s) [407.842081] Starting dynamic subtest: objects [411.531154] Dynamic subtest objects: SUCCESS (3.716s) [411.551065] Starting dynamic subtest: mman [421.516246] Dynamic subtest mman: SUCCESS (9.982s) [421.534558] Starting dynamic subtest: dmabuf [423.586964] Dynamic subtest dmabuf: SUCCESS (2.070s) [423.620109] Starting dynamic subtest: vma [425.503773] Dynamic subtest vma: SUCCESS (1.915s) [425.534095] Starting dynamic subtest: coherency [432.758825] Dynamic subtest coherency: SUCCESS (7.250s) [432.777539] Starting dynamic subtest: gtt [442.047490] Dynamic subtest gtt: SUCCESS (9.288s) [442.068972] Starting dynamic subtest: gem [444.844530] Dynamic subtest gem: SUCCESS (2.795s) [444.874992] Starting dynamic subtest: evict [453.119982] Dynamic subtest evict: SUCCESS (8.268s) [453.138399] Starting dynamic subtest: hugepages [455.550589] Dynamic subtest hugepages: SUCCESS (2.431s) [455.582939] Starting dynamic subtest: gem_contexts [480.320682] Dynamic subtest gem_contexts: SUCCESS (24.763s) [480.339056] Starting dynamic subtest: client [482.358384] Dynamic subtest client: SUCCESS (2.039s) [482.391157] Starting dynamic subtest: gem_migrate [484.125152] Dynamic subtest gem_migrate: SUCCESS (1.762s) [484.191558] Starting dynamic subtest: reset [494.015697] Dynamic subtest reset: SUCCESS (9.866s) [494.037712] Starting dynamic subtest: memory_region [495.798705] Dynamic subtest memory_region: SUCCESS (1.775s) [495.838090] Starting dynamic subtest: hangcheck [521.041901] Dynamic subtest hangcheck: SUCCESS (25.240s) [521.063699] Starting dynamic subtest: execlists [532.435488] Dynamic subtest execlists: SUCCESS (11.389s) [532.453904] Starting dynamic subtest: ring_submission [534.288965] Dynamic subtest ring_submission: SUCCESS (1.850s) [534.319548] Starting dynamic subtest: perf [536.454651] Dynamic subtest perf: SUCCESS (2.161s) [536.485983] Starting dynamic subtest: slpc [538.199042] Dynamic subtest slpc: SUCCESS (1.745s) [538.270327] Starting dynamic subtest: guc [539.871717] Dynamic subtest guc: SUCCESS (1.668s) [539.931093] Starting dynamic subtest: guc_multi_lrc [541.706464] Dynamic subtest guc_multi_lrc: SUCCESS (1.817s) [541.740108] Starting dynamic subtest: guc_hang [543.592404] Dynamic subtest guc_hang: SUCCESS (1.882s) [543.623998] Starting dynamic subtest: late_gt_pm [545.555432] Dynamic subtest late_gt_pm: SUCCESS (1.962s) [545.556841] Subtest live: SUCCESS (208.098s) [545.774298] [164/170] (480s left) dmabuf (all-tests) [546.095827] Starting subtest: all-tests [546.102651] Starting dynamic subtest: sanitycheck [546.178150] Dynamic subtest sanitycheck: SUCCESS (0.072s) [546.214595] Starting dynamic subtest: dma_fence [546.414638] Dynamic subtest dma_fence: SUCCESS (0.222s) [546.452626] Starting dynamic subtest: dma_fence_chain [576.931601] Dynamic subtest dma_fence_chain: SUCCESS (30.506s) [576.979106] Starting dynamic subtest: dma_fence_unwrap [577.023379] Dynamic subtest dma_fence_unwrap: SUCCESS (0.076s) [577.066298] Starting dynamic subtest: dma_resv [577.103059] Dynamic subtest dma_resv: SUCCESS (0.069s) [577.104893] Subtest all-tests: SUCCESS (30.996s) [577.156507] [165/170] (449s left) i915_suspend (basic-s2idle-without-i915) [577.463290] Starting subtest: basic-s2idle-without-i915 [600.531200] Subtest basic-s2idle-without-i915: SUCCESS (8.634s) [602.357635] [166/170] (439s left) i915_suspend (basic-s3-without-i915) [602.673715] Starting subtest: basic-s3-without-i915 [625.314304] Subtest basic-s3-without-i915: SUCCESS (7.214s) [627.038983] [167/170] (431s left) gem_exec_suspend (basic-s0) [627.457799] Starting subtest: basic-S0 [627.459928] Starting dynamic subtest: smem [653.684752] Dynamic subtest smem: SUCCESS (11.095s) [653.686189] Subtest basic-S0: SUCCESS (11.098s) [656.901488] [168/170] (419s left) gem_exec_suspend (basic-s3) [657.254415] Starting subtest: basic-S3 [657.255848] Starting dynamic subtest: smem [682.038088] Dynamic subtest smem: SUCCESS (9.417s) [682.039734] Subtest basic-S3: SUCCESS (9.419s) [682.448388] [169/170] (409s left) kms_chamelium_hpd (common-hpd-after-suspend) [683.481669] Subtest common-hpd-after-suspend: SKIP (0.000s) [683.854663] [170/170] (408s left) kms_pipe_crc_basic (suspend-read-crc) [684.672019] Starting subtest: suspend-read-crc [684.673405] Starting dynamic subtest: pipe-C-HDMI-A-2 [705.943688] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.668s) [705.945038] Subtest suspend-read-crc: SUCCESS (5.676s) [708.293609] Closing watchdogs Done.