builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1501756316.91 results: success (0) revision: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.912269) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.913117) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.913419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:57.065045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:57.065371) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-03 03:31:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.4M=0s 2017-08-03 03:31:57 (36.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:57.249196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:57.249649) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015723 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:57.303714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 mins, 11 secs) (at 2017-08-03 03:31:57.304092) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-03 03:31:57,611 truncating revision to first 12 chars 2017-08-03 03:31:57,611 Setting DEBUG logging. 2017-08-03 03:31:57,611 attempt 1/10 2017-08-03 03:31:57,611 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/63e261ce8cb0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-03 03:31:58,001 attempt 1/10 2017-08-03 03:31:58,981 current task status: no status available at this point. state: PENDING 2017-08-03 03:31:58,982 sleeping for 9.00s (attempt 1/10) 2017-08-03 03:32:07,991 attempt 2/10 2017-08-03 03:32:08,556 current task status: no status available at this point. state: PENDING 2017-08-03 03:32:08,556 sleeping for 13.50s (attempt 2/10) 2017-08-03 03:32:22,070 attempt 3/10 2017-08-03 03:32:22,613 current task status: no status available at this point. state: PENDING 2017-08-03 03:32:22,613 sleeping for 21.25s (attempt 3/10) 2017-08-03 03:32:43,885 attempt 4/10 2017-08-03 03:32:44,441 current task status: no status available at this point. state: PENDING 2017-08-03 03:32:44,441 sleeping for 32.88s (attempt 4/10) 2017-08-03 03:33:17,349 attempt 5/10 2017-08-03 03:33:17,871 current task status: no status available at this point. state: PENDING 2017-08-03 03:33:17,871 sleeping for 50.31s (attempt 5/10) 2017-08-03 03:34:08,234 attempt 6/10 2017-08-03 03:34:08,536 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-03 03:34:08,751 unpacking tar archive at: mozilla-central-63e261ce8cb0/testing/mozharness/ program finished with exit code 0 elapsedTime=131.526727 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 mins, 11 secs) (at 2017-08-03 03:34:08.874982) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:08.875322) ========= script_repo_revision: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:08.875730) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:08.876006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:08.888999) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-03 03:34:08.889402) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:09 INFO - MultiFileLogger online at 20170803 03:34:09 in /builds/slave/test 03:34:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:34:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:09 INFO - {'append_to_log': False, 03:34:09 INFO - 'base_work_dir': '/builds/slave/test', 03:34:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:34:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:09 INFO - 'branch': 'Firefox-Non-PGO', 03:34:09 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:09 INFO - 'code_coverage': False, 03:34:09 INFO - 'config_files': ('talos/linux_config.py',), 03:34:09 INFO - 'default_actions': ('clobber', 03:34:09 INFO - 'read-buildbot-config', 03:34:09 INFO - 'download-and-extract', 03:34:09 INFO - 'populate-webroot', 03:34:09 INFO - 'create-virtualenv', 03:34:09 INFO - 'install', 03:34:09 INFO - 'setup-mitmproxy', 03:34:09 INFO - 'run-tests'), 03:34:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:09 INFO - 'disable_ccov_upload': False, 03:34:09 INFO - 'download_minidump_stackwalk': True, 03:34:09 INFO - 'download_symbols': 'ondemand', 03:34:09 INFO - 'enable_stylo': False, 03:34:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:09 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:09 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:09 INFO - 'gecko_profile': False, 03:34:09 INFO - 'gecko_profile_interval': 0, 03:34:09 INFO - 'installer_path': 'installer.exe', 03:34:09 INFO - 'log_level': 'info', 03:34:09 INFO - 'log_name': 'talos', 03:34:09 INFO - 'log_to_console': True, 03:34:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:09 INFO - 'opt_config_files': (), 03:34:09 INFO - 'pip_index': False, 03:34:09 INFO - 'suite': 'dromaeojs-e10s', 03:34:09 INFO - 'system_bits': '32', 03:34:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:09 INFO - 'title': 'talos-linux64-ix-035', 03:34:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:09 INFO - 'use_talos_json': True, 03:34:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:09 INFO - 'work_dir': 'build'} 03:34:09 INFO - [mozharness: 2017-08-03 10:34:09.270275Z] Running clobber step. 03:34:09 INFO - Running pre-action listener: _resource_record_pre_action 03:34:09 INFO - Running main action method: clobber 03:34:09 INFO - rmtree: /builds/slave/test/build 03:34:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:10 INFO - Running post-action listener: _resource_record_post_action 03:34:10 INFO - [mozharness: 2017-08-03 10:34:10.808527Z] Finished clobber step (success) 03:34:10 INFO - [mozharness: 2017-08-03 10:34:10.808629Z] Running read-buildbot-config step. 03:34:10 INFO - Running pre-action listener: _resource_record_pre_action 03:34:10 INFO - Running main action method: read_buildbot_config 03:34:10 INFO - Using buildbot properties: 03:34:10 INFO - { 03:34:10 INFO - "project": "", 03:34:10 INFO - "product": "firefox", 03:34:10 INFO - "who": "archaeopteryx@coole-files.de", 03:34:10 INFO - "installer_path": "public/build/target.tar.bz2", 03:34:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:34:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:34:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:34:10 INFO - "stage_platform": "linux64", 03:34:10 INFO - "basedir": "/builds/slave/test", 03:34:10 INFO - "buildnumber": 755, 03:34:10 INFO - "platform": "ubuntu64_hw", 03:34:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:34:10 INFO - "slavebuilddir": "test", 03:34:10 INFO - "taskId": "FISBoSXXSd-vZWe1yoN-_w", 03:34:10 INFO - "branch": "mozilla-central", 03:34:10 INFO - "script_repo_revision": "production", 03:34:10 INFO - "revision": "63e261ce8cb04c913d2e6b19ea451b7078d24dc1", 03:34:10 INFO - "slavename": "talos-linux64-ix-035", 03:34:10 INFO - "repo_path": "mozilla-central" 03:34:10 INFO - } 03:34:10 INFO - Finding installer, test and symbols from parent task. 03:34:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FISBoSXXSd-vZWe1yoN-_w'}, attempt #1 03:34:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FISBoSXXSd-vZWe1yoN-_w'}, attempt #1 03:34:11 INFO - Task dependencies: L44bNG-6R8C_EpcBDQJUNA 03:34:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA'}, attempt #1 03:34:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:34:12 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json 03:34:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip 03:34:12 INFO - Running post-action listener: _resource_record_post_action 03:34:12 INFO - [mozharness: 2017-08-03 10:34:12.172852Z] Finished read-buildbot-config step (success) 03:34:12 INFO - [mozharness: 2017-08-03 10:34:12.173116Z] Running download-and-extract step. 03:34:12 INFO - Running pre-action listener: _resource_record_pre_action 03:34:12 INFO - Running main action method: download_and_extract 03:34:12 INFO - mkdir: /builds/slave/test/build/tests 03:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:12 INFO - trying https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json 03:34:12 INFO - Downloading https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:34:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:34:12 INFO - Downloaded 989 bytes. 03:34:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:34:12 INFO - Using the following test package requirements: 03:34:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:34:12 INFO - u'common': [u'target.common.tests.zip'], 03:34:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:34:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:34:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:34:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:34:12 INFO - u'mozbase': [u'target.common.tests.zip'], 03:34:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:34:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:34:12 INFO - u'web-platform': [u'target.common.tests.zip', 03:34:12 INFO - u'target.web-platform.tests.tar.gz'], 03:34:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:34:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:34:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip 03:34:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:12 INFO - Fetch https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip into memory 03:34:13 INFO - Content-Length response header: 54278281 03:34:13 INFO - Bytes received: 54278281 03:34:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:34:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip 03:34:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:24 INFO - Fetch https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip into memory 03:34:25 INFO - Content-Length response header: 54278281 03:34:25 INFO - Bytes received: 54278281 03:34:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.talos.tests.zip 03:34:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:34:37 INFO - Fetch https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.talos.tests.zip into memory 03:34:38 INFO - Content-Length response header: 14496464 03:34:38 INFO - Bytes received: 14496464 03:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:38 INFO - trying https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:34:38 INFO - Downloading https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:34:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:34:39 INFO - Downloaded 62211648 bytes. 03:34:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:34:39 INFO - mkdir: /builds/slave/test/properties 03:34:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:39 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:39 INFO - Contents: 03:34:39 INFO - build_url:https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:34:39 INFO - Running post-action listener: _resource_record_post_action 03:34:39 INFO - Running post-action listener: set_extra_try_arguments 03:34:39 INFO - [mozharness: 2017-08-03 10:34:39.915313Z] Finished download-and-extract step (success) 03:34:39 INFO - [mozharness: 2017-08-03 10:34:39.915411Z] Running populate-webroot step. 03:34:39 INFO - Running pre-action listener: _resource_record_pre_action 03:34:39 INFO - Running main action method: populate_webroot 03:34:39 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:34:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:34:39 INFO - 'tests': ['damp', 'tps']}, 03:34:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:34:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:34:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:34:39 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:39 INFO - 'ts_paint', 03:34:39 INFO - 'tpaint', 03:34:39 INFO - 'sessionrestore', 03:34:39 INFO - 'sessionrestore_many_windows', 03:34:39 INFO - 'sessionrestore_no_auto_restore', 03:34:39 INFO - 'tabpaint']}, 03:34:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:34:39 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:34:39 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:39 INFO - 'talos_options': ['--mitmproxy', 03:34:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:39 INFO - '--firstNonBlankPaint'], 03:34:39 INFO - 'tests': ['quantum_pageload_google', 03:34:39 INFO - 'quantum_pageload_youtube', 03:34:39 INFO - 'quantum_pageload_amazon', 03:34:39 INFO - 'quantum_pageload_facebook']}, 03:34:39 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:39 INFO - 'talos_options': ['--stylo', 03:34:39 INFO - '--mitmproxy', 03:34:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:39 INFO - '--firstNonBlankPaint'], 03:34:39 INFO - 'tests': ['quantum_pageload_google', 03:34:39 INFO - 'quantum_pageload_youtube', 03:34:39 INFO - 'quantum_pageload_amazon', 03:34:39 INFO - 'quantum_pageload_facebook']}, 03:34:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:39 INFO - 'tsvgr_opacity', 03:34:39 INFO - 'tart', 03:34:39 INFO - 'tscrollx', 03:34:39 INFO - 'cart', 03:34:39 INFO - 'tsvg_static']}, 03:34:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:34:39 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:39 INFO - 'talos_options': ['--stylo', 03:34:39 INFO - '--stylo-threads=1', 03:34:39 INFO - '--mitmproxy', 03:34:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:39 INFO - '--firstNonBlankPaint'], 03:34:39 INFO - 'tests': ['tp6_google', 03:34:39 INFO - 'tp6_youtube', 03:34:39 INFO - 'tp6_amazon', 03:34:39 INFO - 'tp6_facebook']}, 03:34:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:34:39 INFO - 'talos_options': ['--xperf_path', 03:34:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:39 INFO - 'tests': ['tp5n']}}} 03:34:39 INFO - Running post-action listener: _resource_record_post_action 03:34:39 INFO - [mozharness: 2017-08-03 10:34:39.924017Z] Finished populate-webroot step (success) 03:34:39 INFO - [mozharness: 2017-08-03 10:34:39.924108Z] Running create-virtualenv step. 03:34:39 INFO - Running pre-action listener: _resource_record_pre_action 03:34:39 INFO - Running main action method: create_virtualenv 03:34:39 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:34:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:39 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:34:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:40 INFO - Using real prefix '/usr' 03:34:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:40 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:42 INFO - Installing pip.................done. 03:34:42 INFO - Return code: 0 03:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:34:42 INFO - Reading from file tmpfile_stdout 03:34:42 INFO - Output received: 03:34:42 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:34:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ceb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:34:42 INFO - Using env: {'DISPLAY': ':0', 03:34:42 INFO - 'HOME': '/home/cltbld', 03:34:42 INFO - 'LANG': 'en_US.UTF-8', 03:34:42 INFO - 'LANGUAGE': 'en_US:en', 03:34:42 INFO - 'LOGNAME': 'cltbld', 03:34:42 INFO - 'MAIL': '/var/mail/cltbld', 03:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:42 INFO - 'MOZ_NO_REMOTE': '1', 03:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:42 INFO - 'NO_EM_RESTART': '1', 03:34:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:42 INFO - 'PWD': '/builds/slave/test', 03:34:42 INFO - 'SHELL': '/bin/bash', 03:34:42 INFO - 'SHLVL': '1', 03:34:42 INFO - 'TERM': 'linux', 03:34:42 INFO - 'TMOUT': '86400', 03:34:42 INFO - 'USER': 'cltbld', 03:34:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 03:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:42 INFO - '_': '/tools/buildbot/bin/python'} 03:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:34:42 INFO - Cleaning up... 03:34:42 INFO - Return code: 0 03:34:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ceb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:42 INFO - Using env: {'DISPLAY': ':0', 03:34:42 INFO - 'HOME': '/home/cltbld', 03:34:42 INFO - 'LANG': 'en_US.UTF-8', 03:34:42 INFO - 'LANGUAGE': 'en_US:en', 03:34:42 INFO - 'LOGNAME': 'cltbld', 03:34:42 INFO - 'MAIL': '/var/mail/cltbld', 03:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:42 INFO - 'MOZ_NO_REMOTE': '1', 03:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:42 INFO - 'NO_EM_RESTART': '1', 03:34:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:42 INFO - 'PWD': '/builds/slave/test', 03:34:42 INFO - 'SHELL': '/bin/bash', 03:34:42 INFO - 'SHLVL': '1', 03:34:42 INFO - 'TERM': 'linux', 03:34:42 INFO - 'TMOUT': '86400', 03:34:42 INFO - 'USER': 'cltbld', 03:34:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 03:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:42 INFO - '_': '/tools/buildbot/bin/python'} 03:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:43 INFO - Downloading/unpacking psutil>=3.1.1 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:44 INFO - Installing collected packages: psutil 03:34:44 INFO - Running setup.py install for psutil 03:34:44 INFO - building 'psutil._psutil_linux' extension 03:34:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:34:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:34:44 INFO - building 'psutil._psutil_posix' extension 03:34:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:34:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:34:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:44 INFO - Successfully installed psutil 03:34:44 INFO - Cleaning up... 03:34:44 INFO - Return code: 0 03:34:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ceb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:34:44 INFO - Using env: {'DISPLAY': ':0', 03:34:44 INFO - 'HOME': '/home/cltbld', 03:34:44 INFO - 'LANG': 'en_US.UTF-8', 03:34:44 INFO - 'LANGUAGE': 'en_US:en', 03:34:44 INFO - 'LOGNAME': 'cltbld', 03:34:44 INFO - 'MAIL': '/var/mail/cltbld', 03:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:44 INFO - 'MOZ_NO_REMOTE': '1', 03:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:44 INFO - 'NO_EM_RESTART': '1', 03:34:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:44 INFO - 'PWD': '/builds/slave/test', 03:34:44 INFO - 'SHELL': '/bin/bash', 03:34:44 INFO - 'SHLVL': '1', 03:34:44 INFO - 'TERM': 'linux', 03:34:44 INFO - 'TMOUT': '86400', 03:34:44 INFO - 'USER': 'cltbld', 03:34:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 03:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:44 INFO - '_': '/tools/buildbot/bin/python'} 03:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:46 INFO - Installing collected packages: mozsystemmonitor 03:34:46 INFO - Running setup.py install for mozsystemmonitor 03:34:46 INFO - Successfully installed mozsystemmonitor 03:34:46 INFO - Cleaning up... 03:34:46 INFO - Return code: 0 03:34:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ceb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:34:46 INFO - Using env: {'DISPLAY': ':0', 03:34:46 INFO - 'HOME': '/home/cltbld', 03:34:46 INFO - 'LANG': 'en_US.UTF-8', 03:34:46 INFO - 'LANGUAGE': 'en_US:en', 03:34:46 INFO - 'LOGNAME': 'cltbld', 03:34:46 INFO - 'MAIL': '/var/mail/cltbld', 03:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:46 INFO - 'MOZ_NO_REMOTE': '1', 03:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:46 INFO - 'NO_EM_RESTART': '1', 03:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:46 INFO - 'PWD': '/builds/slave/test', 03:34:46 INFO - 'SHELL': '/bin/bash', 03:34:46 INFO - 'SHLVL': '1', 03:34:46 INFO - 'TERM': 'linux', 03:34:46 INFO - 'TMOUT': '86400', 03:34:46 INFO - 'USER': 'cltbld', 03:34:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 03:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:46 INFO - '_': '/tools/buildbot/bin/python'} 03:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:46 INFO - Downloading/unpacking jsonschema==2.5.1 03:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:47 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:47 INFO - warning: no files found matching '*.txt' 03:34:47 INFO - no previously-included directories found matching 'build' 03:34:47 INFO - no previously-included directories found matching 'dist' 03:34:47 INFO - no previously-included directories found matching '.git*' 03:34:47 INFO - Installing collected packages: jsonschema, functools32 03:34:47 INFO - Running setup.py install for functools32 03:34:47 INFO - warning: no files found matching '*.txt' 03:34:47 INFO - no previously-included directories found matching 'build' 03:34:47 INFO - no previously-included directories found matching 'dist' 03:34:47 INFO - no previously-included directories found matching '.git*' 03:34:47 INFO - Successfully installed jsonschema functools32 03:34:47 INFO - Cleaning up... 03:34:48 INFO - Return code: 0 03:34:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ceb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:34:48 INFO - Using env: {'DISPLAY': ':0', 03:34:48 INFO - 'HOME': '/home/cltbld', 03:34:48 INFO - 'LANG': 'en_US.UTF-8', 03:34:48 INFO - 'LANGUAGE': 'en_US:en', 03:34:48 INFO - 'LOGNAME': 'cltbld', 03:34:48 INFO - 'MAIL': '/var/mail/cltbld', 03:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:48 INFO - 'MOZ_NO_REMOTE': '1', 03:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:48 INFO - 'NO_EM_RESTART': '1', 03:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:48 INFO - 'PWD': '/builds/slave/test', 03:34:48 INFO - 'SHELL': '/bin/bash', 03:34:48 INFO - 'SHLVL': '1', 03:34:48 INFO - 'TERM': 'linux', 03:34:48 INFO - 'TMOUT': '86400', 03:34:48 INFO - 'USER': 'cltbld', 03:34:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 03:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:48 INFO - '_': '/tools/buildbot/bin/python'} 03:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:34:48 INFO - Cleaning up... 03:34:48 INFO - Return code: 0 03:34:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ceb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:34:48 INFO - Using env: {'DISPLAY': ':0', 03:34:48 INFO - 'HOME': '/home/cltbld', 03:34:48 INFO - 'LANG': 'en_US.UTF-8', 03:34:48 INFO - 'LANGUAGE': 'en_US:en', 03:34:48 INFO - 'LOGNAME': 'cltbld', 03:34:48 INFO - 'MAIL': '/var/mail/cltbld', 03:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:48 INFO - 'MOZ_NO_REMOTE': '1', 03:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:48 INFO - 'NO_EM_RESTART': '1', 03:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:48 INFO - 'PWD': '/builds/slave/test', 03:34:48 INFO - 'SHELL': '/bin/bash', 03:34:48 INFO - 'SHLVL': '1', 03:34:48 INFO - 'TERM': 'linux', 03:34:48 INFO - 'TMOUT': '86400', 03:34:48 INFO - 'USER': 'cltbld', 03:34:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 03:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:48 INFO - '_': '/tools/buildbot/bin/python'} 03:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:48 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:50 INFO - Downloading docopt-0.6.1.tar.gz 03:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:50 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:50 INFO - Running setup.py install for blobuploader 03:34:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:50 INFO - Running setup.py install for requests 03:34:50 INFO - Running setup.py install for docopt 03:34:50 INFO - Successfully installed blobuploader requests docopt 03:34:50 INFO - Cleaning up... 03:34:50 INFO - Return code: 0 03:34:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ceb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:50 INFO - Using env: {'DISPLAY': ':0', 03:34:50 INFO - 'HOME': '/home/cltbld', 03:34:50 INFO - 'LANG': 'en_US.UTF-8', 03:34:50 INFO - 'LANGUAGE': 'en_US:en', 03:34:50 INFO - 'LOGNAME': 'cltbld', 03:34:50 INFO - 'MAIL': '/var/mail/cltbld', 03:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:50 INFO - 'MOZ_NO_REMOTE': '1', 03:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:50 INFO - 'NO_EM_RESTART': '1', 03:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:50 INFO - 'PWD': '/builds/slave/test', 03:34:50 INFO - 'SHELL': '/bin/bash', 03:34:50 INFO - 'SHLVL': '1', 03:34:50 INFO - 'TERM': 'linux', 03:34:50 INFO - 'TMOUT': '86400', 03:34:50 INFO - 'USER': 'cltbld', 03:34:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 03:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:50 INFO - '_': '/tools/buildbot/bin/python'} 03:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:50 INFO - Running setup.py (path:/tmp/pip-QkLqWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:51 INFO - Running setup.py (path:/tmp/pip-FtZ8OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:51 INFO - Running setup.py (path:/tmp/pip-rYvX34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:51 INFO - Running setup.py (path:/tmp/pip-aFrDPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:51 INFO - Running setup.py (path:/tmp/pip-zdD8qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:51 INFO - Running setup.py (path:/tmp/pip-wNCcoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:51 INFO - Running setup.py (path:/tmp/pip-gWz0fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:51 INFO - Running setup.py (path:/tmp/pip-cI4lUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:51 INFO - Running setup.py (path:/tmp/pip-_wdpDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:51 INFO - Running setup.py (path:/tmp/pip-OhNkqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:51 INFO - Running setup.py (path:/tmp/pip-5BI1AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:51 INFO - Running setup.py (path:/tmp/pip-EX_4ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:51 INFO - Running setup.py (path:/tmp/pip-eFvgQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:51 INFO - Running setup.py (path:/tmp/pip-6gD971-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:51 INFO - Running setup.py (path:/tmp/pip-YKz9H9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:52 INFO - Running setup.py (path:/tmp/pip-Wf6D4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:52 INFO - Running setup.py (path:/tmp/pip-JAECSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:52 INFO - Running setup.py install for manifestparser 03:34:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:52 INFO - Running setup.py install for mozcrash 03:34:52 INFO - Running setup.py install for mozdebug 03:34:52 INFO - Running setup.py install for mozdevice 03:34:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:52 INFO - Running setup.py install for mozfile 03:34:52 INFO - Running setup.py install for mozhttpd 03:34:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:52 INFO - Running setup.py install for mozinfo 03:34:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:52 INFO - Running setup.py install for mozInstall 03:34:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:52 INFO - Running setup.py install for mozleak 03:34:53 INFO - Running setup.py install for mozlog 03:34:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:53 INFO - Running setup.py install for moznetwork 03:34:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:53 INFO - Running setup.py install for mozprocess 03:34:53 INFO - Running setup.py install for mozprofile 03:34:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:53 INFO - Running setup.py install for mozrunner 03:34:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:53 INFO - Running setup.py install for mozscreenshot 03:34:53 INFO - Running setup.py install for moztest 03:34:53 INFO - Running setup.py install for mozversion 03:34:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:53 INFO - Cleaning up... 03:34:53 INFO - Return code: 0 03:34:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ceb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:53 INFO - Using env: {'DISPLAY': ':0', 03:34:53 INFO - 'HOME': '/home/cltbld', 03:34:53 INFO - 'LANG': 'en_US.UTF-8', 03:34:53 INFO - 'LANGUAGE': 'en_US:en', 03:34:53 INFO - 'LOGNAME': 'cltbld', 03:34:53 INFO - 'MAIL': '/var/mail/cltbld', 03:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:53 INFO - 'MOZ_NO_REMOTE': '1', 03:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:53 INFO - 'NO_EM_RESTART': '1', 03:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:53 INFO - 'PWD': '/builds/slave/test', 03:34:53 INFO - 'SHELL': '/bin/bash', 03:34:53 INFO - 'SHLVL': '1', 03:34:53 INFO - 'TERM': 'linux', 03:34:53 INFO - 'TMOUT': '86400', 03:34:53 INFO - 'USER': 'cltbld', 03:34:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 03:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:53 INFO - '_': '/tools/buildbot/bin/python'} 03:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:54 INFO - Running setup.py (path:/tmp/pip-B5ahEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:54 INFO - Running setup.py (path:/tmp/pip-pn9A42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:54 INFO - Running setup.py (path:/tmp/pip-3afY_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:54 INFO - Running setup.py (path:/tmp/pip-gNlbUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:54 INFO - Running setup.py (path:/tmp/pip-_UW7ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:54 INFO - Running setup.py (path:/tmp/pip-bHbCGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:54 INFO - Running setup.py (path:/tmp/pip-RZHILa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:54 INFO - Running setup.py (path:/tmp/pip-WyRBYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:54 INFO - Running setup.py (path:/tmp/pip-4IQauc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:54 INFO - Running setup.py (path:/tmp/pip-cHcWWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:54 INFO - Running setup.py (path:/tmp/pip-HV0ZXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:54 INFO - Running setup.py (path:/tmp/pip-C5kg3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:55 INFO - Running setup.py (path:/tmp/pip-OfiLyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:55 INFO - Running setup.py (path:/tmp/pip-fYcMMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:55 INFO - Running setup.py (path:/tmp/pip-T9s205-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:55 INFO - Running setup.py (path:/tmp/pip-zH9XTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:55 INFO - Running setup.py (path:/tmp/pip-Gb98hR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:34:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:56 INFO - Downloading blessings-1.6.tar.gz 03:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:56 INFO - Installing collected packages: blessings 03:34:56 INFO - Running setup.py install for blessings 03:34:56 INFO - Successfully installed blessings 03:34:56 INFO - Cleaning up... 03:34:56 INFO - Return code: 0 03:34:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:56 INFO - Reading from file tmpfile_stdout 03:34:56 INFO - Current package versions: 03:34:56 INFO - argparse == 1.2.1 03:34:56 INFO - blessings == 1.6 03:34:56 INFO - blobuploader == 1.2.4 03:34:56 INFO - docopt == 0.6.1 03:34:56 INFO - functools32 == 3.2.3-2 03:34:56 INFO - jsonschema == 2.5.1 03:34:56 INFO - manifestparser == 1.1 03:34:56 INFO - mozInstall == 1.13 03:34:56 INFO - mozcrash == 1.0 03:34:56 INFO - mozdebug == 0.1 03:34:56 INFO - mozdevice == 0.51 03:34:56 INFO - mozfile == 1.2 03:34:56 INFO - mozhttpd == 0.7 03:34:56 INFO - mozinfo == 0.10 03:34:56 INFO - mozleak == 0.1 03:34:56 INFO - mozlog == 3.5 03:34:56 INFO - moznetwork == 0.27 03:34:56 INFO - mozprocess == 0.25 03:34:56 INFO - mozprofile == 0.28 03:34:56 INFO - mozrunner == 6.13 03:34:56 INFO - mozscreenshot == 0.1 03:34:56 INFO - mozsystemmonitor == 0.3 03:34:56 INFO - moztest == 0.8 03:34:56 INFO - mozversion == 1.4 03:34:56 INFO - psutil == 3.1.1 03:34:56 INFO - requests == 1.2.3 03:34:56 INFO - wsgiref == 0.1.2 03:34:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ceb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:56 INFO - Using env: {'DISPLAY': ':0', 03:34:56 INFO - 'HOME': '/home/cltbld', 03:34:56 INFO - 'LANG': 'en_US.UTF-8', 03:34:56 INFO - 'LANGUAGE': 'en_US:en', 03:34:56 INFO - 'LOGNAME': 'cltbld', 03:34:56 INFO - 'MAIL': '/var/mail/cltbld', 03:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:56 INFO - 'MOZ_NO_REMOTE': '1', 03:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:56 INFO - 'NO_EM_RESTART': '1', 03:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:56 INFO - 'PWD': '/builds/slave/test', 03:34:56 INFO - 'SHELL': '/bin/bash', 03:34:56 INFO - 'SHLVL': '1', 03:34:56 INFO - 'TERM': 'linux', 03:34:56 INFO - 'TMOUT': '86400', 03:34:56 INFO - 'USER': 'cltbld', 03:34:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 03:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:56 INFO - '_': '/tools/buildbot/bin/python'} 03:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:34:57 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:58 INFO - Installing collected packages: simplejson 03:34:58 INFO - Running setup.py install for simplejson 03:34:58 INFO - building 'simplejson._speedups' extension 03:34:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:34:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:34:59 INFO - Successfully installed simplejson 03:34:59 INFO - Cleaning up... 03:34:59 INFO - Return code: 0 03:34:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ceb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:34:59 INFO - Using env: {'DISPLAY': ':0', 03:34:59 INFO - 'HOME': '/home/cltbld', 03:34:59 INFO - 'LANG': 'en_US.UTF-8', 03:34:59 INFO - 'LANGUAGE': 'en_US:en', 03:34:59 INFO - 'LOGNAME': 'cltbld', 03:34:59 INFO - 'MAIL': '/var/mail/cltbld', 03:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:59 INFO - 'MOZ_NO_REMOTE': '1', 03:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:59 INFO - 'NO_EM_RESTART': '1', 03:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:59 INFO - 'PWD': '/builds/slave/test', 03:34:59 INFO - 'SHELL': '/bin/bash', 03:34:59 INFO - 'SHLVL': '1', 03:34:59 INFO - 'TERM': 'linux', 03:34:59 INFO - 'TMOUT': '86400', 03:34:59 INFO - 'USER': 'cltbld', 03:34:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 03:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:59 INFO - '_': '/tools/buildbot/bin/python'} 03:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:59 INFO - Cleaning up... 03:34:59 INFO - Return code: 0 03:34:59 INFO - Running post-action listener: _resource_record_post_action 03:34:59 INFO - Running post-action listener: _start_resource_monitoring 03:34:59 INFO - Starting resource monitoring. 03:34:59 INFO - [mozharness: 2017-08-03 10:34:59.657889Z] Finished create-virtualenv step (success) 03:34:59 INFO - [mozharness: 2017-08-03 10:34:59.658413Z] Running install step. 03:34:59 INFO - Running pre-action listener: _resource_record_pre_action 03:34:59 INFO - Running main action method: install 03:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:59 INFO - Reading from file tmpfile_stdout 03:34:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:00 INFO - Reading from file tmpfile_stdout 03:35:00 INFO - Output received: 03:35:00 INFO - Usage: mozinstall [options] installer 03:35:00 INFO - Options: 03:35:00 INFO - -h, --help show this help message and exit 03:35:00 INFO - -d DEST, --destination=DEST 03:35:00 INFO - Directory to install application into. [default: 03:35:00 INFO - "/builds/slave/test"] 03:35:00 INFO - --app=APP Application being installed. [default: firefox] 03:35:00 INFO - mkdir: /builds/slave/test/build/application 03:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:35:17 INFO - Reading from file tmpfile_stdout 03:35:17 INFO - Output received: 03:35:17 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:17 INFO - Running post-action listener: _resource_record_post_action 03:35:17 INFO - [mozharness: 2017-08-03 10:35:17.995481Z] Finished install step (success) 03:35:17 INFO - [mozharness: 2017-08-03 10:35:17.995629Z] Running setup-mitmproxy step. 03:35:17 INFO - Running pre-action listener: _resource_record_pre_action 03:35:17 INFO - Running main action method: setup_mitmproxy 03:35:17 INFO - Skipping: mitmproxy is not required 03:35:17 INFO - Running post-action listener: _resource_record_post_action 03:35:17 INFO - [mozharness: 2017-08-03 10:35:17.996156Z] Finished setup-mitmproxy step (success) 03:35:17 INFO - [mozharness: 2017-08-03 10:35:17.996258Z] Running run-tests step. 03:35:17 INFO - Running pre-action listener: _resource_record_pre_action 03:35:17 INFO - Running pre-action listener: _set_gcov_prefix 03:35:17 INFO - Running main action method: run_tests 03:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:18 INFO - Python 2.7.3 03:35:18 INFO - Return code: 0 03:35:18 INFO - grabbing minidump binary from tooltool 03:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ceb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:35:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:35:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:35:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:18 INFO - Return code: 0 03:35:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:18 INFO - ENV: RUST_BACKTRACE is now 1 03:35:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:35:18 INFO - Using env: {'DISPLAY': ':0', 03:35:18 INFO - 'HOME': '/home/cltbld', 03:35:18 INFO - 'LANG': 'en_US.UTF-8', 03:35:18 INFO - 'LANGUAGE': 'en_US:en', 03:35:18 INFO - 'LOGNAME': 'cltbld', 03:35:18 INFO - 'MAIL': '/var/mail/cltbld', 03:35:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:18 INFO - 'MOZ_NO_REMOTE': '1', 03:35:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:18 INFO - 'NO_EM_RESTART': '1', 03:35:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:18 INFO - 'PWD': '/builds/slave/test', 03:35:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:18 INFO - 'RUST_BACKTRACE': '1', 03:35:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:35:18 INFO - 'SHELL': '/bin/bash', 03:35:18 INFO - 'SHLVL': '1', 03:35:18 INFO - 'TERM': 'linux', 03:35:18 INFO - 'TMOUT': '86400', 03:35:18 INFO - 'USER': 'cltbld', 03:35:18 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970', 03:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:18 INFO - '_': '/tools/buildbot/bin/python'} 03:35:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:35:18 INFO - mozversion application_buildid: 20170803094619 03:35:18 INFO - mozversion application_changeset: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 03:35:18 INFO - mozversion application_display_name: Nightly 03:35:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:18 INFO - mozversion application_name: Firefox 03:35:18 INFO - mozversion application_remotingname: firefox 03:35:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:35:18 INFO - mozversion application_vendor: Mozilla 03:35:18 INFO - mozversion application_version: 57.0a1 03:35:18 INFO - mozversion platform_buildid: 20170803094619 03:35:18 INFO - mozversion platform_changeset: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 03:35:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:35:18 INFO - mozversion platform_version: 57.0a1 03:35:18 INFO - using testdate: 1501756518 03:35:18 INFO - actual date: 1501756518 03:35:18 INFO - starting webserver on 'localhost:37210' 03:35:18 INFO - SUITE-START | Running 2 tests 03:35:18 INFO - TEST-START | dromaeo_css 03:35:18 INFO - Initialising browser for dromaeo_css test... 03:35:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37210/getInfo.html -profile /tmp/tmpEmpEZT/profile 03:35:18 INFO - TEST-INFO | started process 25854 (/builds/slave/test/build/application/firefox/firefox http://localhost:37210/getInfo.html) 03:35:24 INFO - TEST-INFO | 25854: exit 0 03:35:24 INFO - Browser initialized. 03:35:24 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:24 INFO - TEST-INFO | started process 26062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEmpEZT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:25 INFO - PID 26062 | 03:35:25 INFO - PID 26062 | (/builds/slave/test/build/application/firefox/firefox:26110): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:35:25 INFO - PID 26062 | 03:35:35 INFO - PID 26062 | RSS: Main: 171159552 03:35:35 INFO - PID 26062 | 03:38:35 INFO - PID 26062 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37210/tests/dromaeo/cssquery-ext.html) 03:38:36 INFO - PID 26062 | RSS: Main: 170737664 03:38:36 INFO - PID 26062 | 03:41:38 INFO - PID 26062 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-ext.html (next: http://localhost:37210/tests/dromaeo/cssquery-jquery.html) 03:41:38 INFO - PID 26062 | RSS: Main: 171016192 03:41:38 INFO - PID 26062 | 03:44:40 INFO - PID 26062 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37210/tests/dromaeo/cssquery-mootools.html) 03:44:41 INFO - PID 26062 | RSS: Main: 172613632 03:44:41 INFO - PID 26062 | 03:47:42 INFO - PID 26062 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37210/tests/dromaeo/cssquery-prototype.html) 03:47:43 INFO - PID 26062 | RSS: Main: 171360256 03:47:43 INFO - PID 26062 | 03:50:47 INFO - PID 26062 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37210/tests/dromaeo/cssquery-yui.html) 03:50:47 INFO - PID 26062 | RSS: Main: 174825472 03:50:47 INFO - PID 26062 | 03:53:49 INFO - PID 26062 | Cycle 1(1): loaded http://localhost:37210/tests/dromaeo/cssquery-yui.html (next: http://localhost:37210/tests/dromaeo/cssquery-dojo.html) 03:53:49 INFO - PID 26062 | RSS: Main: 175349760 03:53:49 INFO - PID 26062 | 03:53:49 INFO - PID 26062 | __start_tp_report 03:53:49 INFO - PID 26062 | _x_x_mozilla_page_load 03:53:49 INFO - PID 26062 | _x_x_mozilla_page_load_details 03:53:49 INFO - PID 26062 | |i|pagename|runs| 03:53:49 INFO - PID 26062 | |0;dojo.html;3134.639516455607;3148.5119806430002;3151.5272709093647;3163.493840985442;3212.1969507623094;6092.208012958315;6149.508039356852;6152.292486364069;6153.630782153068;6195.597286176396;6278.529110316733;6345.587536810104;6348.269948955872;6369.840753981152;6371.9681401592925;5701.57238207134;5739.339975902762;5765.942340576604;5770.567207459447;5807.39022402648;5582.7766889324375;5671.149327600872;5740.339860916007;5759.82720518383;5854.297484301868;5630.40880707526;5631.18347839563;5726.141078838186;5755.453231942959;5763.625364351304;5679.119736440858;5747.137929310595;5765.798197063083;5766;5775.826725198251;5602.1596760485845;5648.350439699446;5673.574481913873;5733.827985160452;5734.340550836624;6074.726637301332;6130.785422510236;6140.508759299245;6159.353267906895;6176.505879529627;6714.6306953117555;6784.35548622885;6806.353396427331;6808.659567021629;6810.012548180486;6785.1518560179975;6794.218664853555;6865.382115609619;6870.106886104824;6870.31296870314;6155.784547540859;6237.189165408558;6238.469730072995;6243.937560624381;6249.343818898996;6767.864642707217;6774.187097548326;6777.830554236085;6780.016897549827;6802.115724955823;6389.297177310492;6465.870682586322;6535;6660.367265109807;6679.632620205935;6648.4681225501845;6696.698648560827;6763.797086087426;6802.489813264025;6807.65961701913;6697.531172817953;6711.899321510181;6749.0551322814845;6787.423069039089;6795.694193761293;6528.477721782341;6649.401553860079;6652.467802575782;6653.700583473756;6660.167479065117;5363.383210930715;5375.220593013991;5378.381486129145;5379.596530260246;5380.085385484477;4688.226442636927;4690.038542098861;4696.060787842377;4707.223308154116;4708.4820669726305;5813.767449302065;5817.912731309034;5870.0607902735355;5902.675352855634;5903.940960590425;6563.1796025496815;6707.6981535831;6719.092922455504;6806.8298292542095;6812.557183783138;5811.79658711943;5842.503387212135;5879.588428810028;5904.380040095814;5916.822495325061;5880.176775251382;5950.19672344228;5955.970220148872;5963.522918166536;5973.641581505123;6491.091247225392;6501.252355979028;6581.605103693793;6584.604923704497;6620.205575330991;6587.538872278895;6732.562383445061;6753.932460675331;6854;6858.074159988338;6426.260979987362;6494.512911531559;6504.902426463512;6507.772227971998;6523.054157147282;6555.737770489318;6638.17022872141;6649.966750166218;6670.899936500859;6676.6661666917435;6756.391924726601;6786.830329241809;6792.388685018372;6797.354251346114;6806.829829254309;6493.22081350241;6518.217813862367;6530.314316996647;6530.8040758777315;6542.771003014872;6438.420542151229;6474.384933431316;6557.180352455943;6557.803265902031;6573.079768832272;6293.087502312231;6377.96811015942;6381.840453988688;6487.253965793994;6497.415232629086;6443.065755465337;6469.450096741642;6481.643509607017;6527.249366322743;6591.736330546724;6192.721327540362;6291.685415729286;6292.716827742671;6394.776182833579;6440.871182576416 03:53:49 INFO - PID 26062 | |1;ext.html;814.6374863185881;842.7092653034708;858.4076986879054;888.2006194425021;889.2707979456844;41017.384739228895;41831.95420114499;41833.58166418335;42199.78900105499;42212.36681449781;37662;37949.81025094871;38150;38249;38264;6913.170419549649;6980.406665433445;6987.545809522365;6989;7010.088688470491;6836.9316306837045;6930.5148639595245;6942.652867356637;6965.6517174141345;6967.79096627102;6903.033575299462;7569.924300756977;7727.265909738566;7767.844643107134;7773.300402963732;7667.846643067135;7729.536227826348;7738.7678369649;7739.961300193463;7741.922580774205;7395.260473952616;7576.052993375828;7580.54516728998;7663.27198916102;7667.1949445308;38379.808100959315;38848;38917;38990.610093898984;39007.41488877669;3512.929741405183;3562.9109272268142;3563.501109844624;3564.198055437532;3566.3045706087323;32280.677193228003;32298;32366.514502282484;32402.18994525132;32406.837965810257;4900.607951363882;4910.361652985089;4922.0402021605805;4951.059298733265;4952.356193694833;200547;201114;203244;209454;214105;50564.49435505598;51055.48944510581;51094;51119;51127;52254;52334.476655233724;52435.80513558983;52447;52819;16674.83325166757;16751;16752.581185470463;16812.739044571463;16859.325626975027;13940.442382304595;13952.511662091982;13996.30018499071;13999.090059146123;14011.369488373048;14599.85400145985;14676.55970320892;14732.116073035651;14805.925970370079;14951.626209344853;5654.830355089354;5701.971490142606;5722.542196624343;5786.566007549451;5944.613600115978;982.916452101565;992.3450522655013;996.2528103922059;1015.2334987084852;1030.525958059286;22804.885975570018;22991.7700822993;23086.19198328084;23153;23488.412789680395;1105.5135740274413;1110.4891749795024;1127.4362818590705;1128.700894263021;1130.8925652063042;12120.575779847662;16248.350065997463;16347.44699253569;16646.16769161537;16799.41202057922;242116;244000;244730;244732;245119;58289;58535;58837.41162588405;58916.41083589109;59256.70371648114;1417.1638733147493;1453.9563813085624;1467.4203689542785;1475.2771142140275;1480.6890552983778;25961.870190648926;27652;27831.30421739473;27836.16491505258;28121.296967575156;52785.20822187593;53059;53074.2038869425;53165;53182.46817531775;214973;216235;216929;217357;217707;36361.818190908874;36484.45273320849;38247.42628860514;38305.23389532138;38340.80829595834;46352.768236158605;46966.76516617395;47540.52459475361;47668.284975724695;48006;34377.828110859286;34617.82691086528;34813.65186348104;34921.47617785684;35224;33729.15677108092;34147.65852341445;34162.14594635154;34329.31341373209;34931.301373972885;37508.43737343887;37515.249695006496;37542;37821.43267851039;37967.810160950125;33288.667113328556;33544;33644.32711345809;33686;33795.15512112217;23213.651795223424;24934.625980609944;24986.75013249844;25556.488870222864;25608.359791005372 03:53:49 INFO - PID 26062 | |2;jquery.html;579.4987335954401;589.6595784878663;590.2592246730355;594.7858770842496;606.9817905462836;22664.77335226647;23244.3026709199;23442.88278558607;23475.530489390203;23478;27398.315042123955;28096.578551321745;28139.718602813966;28180.15459536212;28246.293842653944;6461.127747754052;6619.404253617197;6663.566868153554;6668.76659316924;6675.098861653688;5843;6351.555391122623;6371.299157092716;6386.872262554746;6504.284528701839;6333.841653958665;6359.777407790728;6360.650164240965;6365.236171659384;6378.712957916905;6328.620282783025;6353.396427339396;6354.078658594501;6364.268109167436;6383.170187875547;5915.260592425947;5935.080062590306;5944.494717948979;5968.522518198533;5979.790707325223;27154.45691086167;30837.383252335054;31656;31715.36569268625;31732.206694832585;1934.9032548372525;1981.504623844039;1981.8414526837819;1982.6530357187435;1989.8607097503182;18716.157772900253;18784.530386740305;19705.31031413908;19726.901365493082;19838.50403739918;2349.8237632177484;2350.82368822339;2399.5200959808108;2409.662647229389;2430.307362401707;148204;150323;152043;152615;161153.99999999884;15302;15317.770233446507;15773;15817.683646327008;15978.440754573534;24667.753322466906;24698.259052228463;24707.382315441897;24713.629295560582;24739.134130305352;10407.375557466425;10453.372797632166;10769.407682577377;10796.406197659047;10906.781864362669;8889.511076890703;10071.798564028679;10089.697309080739;10116.949415252877;10141.847872281922;8715.818726164904;11600.477978490988;11661.24201926889;11951.88048119525;12084.456199471046;3735.402335626287;3893.7274390792372;4068.694847886361;4292.313229883203;4309.491677912705;961.8653388525612;965.4931161140457;978.4422878958925;988.9109980101681;994.3487016004528;19983;20104.39686809398;20329;20486.095511927782;20621.58756824855;1031.257494603884;1051.4637534857277;1054.5570860238718;1056.2447849787438;1058.957641694339;11052.723681908017;11056.613018544313;11097;11198.608048718255;11217.32696038224;461678;471872;473869;476571;477766;115554;118955;121243.39378303052;122270;122359;1201.4953719437858;1235.71578536937;1256.9685757856128;1265.0828149591473;1268.2580690296095;17680.29278828884;17935.641287174443;17995.10024498796;18118;18449.907750461163;56827.71586142043;57215.713921431794;57388;57575;58515;69835;70124;70182;71141;71599.64200178966;20327.8983605081;20532.79467205309;20602.896985514977;20673.58652826965;20716.171353145706;23253.41866453352;23799.881000594887;23837.165699200446;23841.52316953686;24308.027678892646;17470.30118795285;18407.815921841146;18669.066546672882;18673.90663046676;18788.436346909613;15961.281742321855;16515.33938642441;16834.494965151065;17321.13394330253;17459.47621571355;17319.393821216196;18253.726194107363;18445;18576.349827755963;19005;20125.49686257855;20146.39560813178;20365.083571239033;20397.286094986604;20507.28224512135;18174.36389726353;18401.355952542133;18448.723269151244;18524.444266671482;18537.0731463429 03:53:49 INFO - PID 26062 | |3;mootools.html;1328.1632571479965;1369.1853347258382;1379.131406674118;1384.321682375635;1393.3172745354773;13607.591772246837;14051.437942482315;14162.575122746308;14197.64505887352;14261.429542818289;14093.78859317111;14517.854821451783;14990.700185996273;15044.924775376108;15075.170865602387;2669.0925085470885;2745.5195340815376;2748.9141788993334;2751.1608959267414;2754.848483333416;2559.3857474206243;2584.1343150044663;2587.3402282417956;2596.3379338268714;2600.947981040378;2640.6303117563557;2679.758821706046;2684.4899469100906;2740.2464322311325;2744.4922689302443;2547.7070136934212;2593.222033389985;2602.349412646838;2603.440260344016;2607.8174527783062;2534.7845433138204;2546.7707906288338;2560.193539035198;2566.230130960704;2566.7946564275;13364.13133146352;13595.932020339935;13612.523561675393;13629.659258518517;13632.591022269347;7389.704411823521;7621.161672216052;7658.8468230635635;7659.578723170223;7685.154632990367;5065.949340506621;5237.633365664405;5346.572274218092;5352.759125839308;5391.083515802284;1751.8510926571257;1780.305680784495;1781.4477511971202;1816.6548355812354;1817.2917457589824;23115.190968316198;23534.058637654474;23536.058557657674;23545.529089418116;23553.41116472085;6675.632840193836;6862.862742745117;6999.650017499104;7050.894236586455;7054.541454805421;18520;18551.81448185501;18574;18586.81413185878;18588.25646974133;7730.342920851791;7832.882506762403;7918.208179182036;7922.0889597697005;7925.445218834741;5731.971340143356;6149.938500614937;6274.2784579773;6994;7175.425965922714;5474.452554744494;5568.331800184003;5603.915941260884;5703.885922281531;5726.141078838207;1748.5541186997234;1758.2527425843964;1761.806201317854;1782.97325540117;1790.5613124784252;900.5272232078212;917.660465627722;924.8196601662746;929.8233335666201;939.8214339275515;7491.400687944952;7527.698892044257;7537.434692398092;7537.623118844036;7542.698292068366;727.8471520980547;728.5300980867311;742.4023660952985;745.2324106170653;755.8677231484468;5063.924041139386;5260.947390526046;5276.5251127398715;5409.43200963901;5481.561475081984;18630.81369186318;19697.704534431996;19703.507412314808;19709;19722.802771972383;18234.179461924246;19150.425487235407;19171.137298821588;19329.4201173965;19384.321548746007;10970.725731856768;10983.61557345489;11179.441027948733;11182.273152245241;11183.832242516206;8315.708950186714;8360.372972027;8561.400701950804;8603.483790972561;8703.825923481621;16732.749008764637;17158.142092895057;17200.65598687994;17486.47540573785;17548.64902701913;13741.725165496833;16647.667046658757;17381.739273911153;17694.469165925042;17941.730874037163;10923.399213043042;11075.169362297698;11180.888191117985;11188.496517656562;11190.496427660937;13048.673783155118;13066.54267100647;13181.868181318065;13213.867861321263;13229.735405292033;10476.319039262424;10558.894411056099;10584.947075264574;10592.735181620521;10726.785464290826;10076.143527800219;10170.491475426346;10209.132223760766;10263.332883362558;10326.638567650096;9085.454872707658;9236.769080772765;9243.075692430702;9248;9258.629654813732;7127;7163.2478589747325;7189.712411503481;7208.423326133792;7236;7175.784726458214;7223.494355395282;7256.891146632699;7300.379467745302;7375.483716140034 03:53:49 INFO - PID 26062 | |4;prototype.html;500.44450659767654;502.38959664008223;527.8733104055028;535.6866233253546;541.7210136779556;6200.379962003797;6213.254409470864;6236.25164980203;6270.247570291565;6309.1482649842255;5975.193348897908;6156.1996940397685;6158.445739883409;6181.75272989081;6197.5041996640275;5024.246363045536;5029.9748501257445;5042.268871013701;5071.416787069479;5073.416557095944;4944.554990050895;4963.875903102416;4970.900581988358;4991.675541089836;5005.724685142334;4793.4487533933525;4856.927146092811;4941.678790878582;4948.257761335793;4966.404031516223;4963.656800299737;4970.229614409773;4986;4993.126202914512;4997.100521906055;4401.845935392246;4472.709273897219;4486.663500237462;4490.034642551835;4531.592156705912;5947.256592925884;5981.371955944606;5987.700614969278;6078.875408049481;6089.269287685462;5738.540916726652;5742.588112992553;5757.222774925415;5782.219400380936;5794.797182098607;6475.255345635265;6532.967335163294;6560.573562718456;6569.343065693441;6571.572847764928;4794.640401969867;4825.227963525819;4878.634102442331;4878.804847806084;4928.433230178503;6830.419414349786;6999.650017499155;7004.544704594185;7009.264027277113;7027.402670772991;5057.747112644353;5087.643864929493;5104.4895510449405;5107.693538387709;5114.820981265638;5051.772670229849;5055;5102.974485127551;5107.770150343244;5148.613853960968;5664.490195882308;5732.684702341411;5739.196512488255;5774.971125144431;5792.9710351447975;6626.304238055031;6631.966840165865;6696.229933557704;6707.5304728668525;6727.697253623501;1676.5976165720383;1729.8962062276303;1775.973360399595;1793.32750218668;1797.5685835399672;1176.823176823177;1217.3852204636778;1235.4872727818035;1242.1801610936739;1268.492602958824;5650.208970744099;5699.971500142473;5701.942980570224;5715.5427565794635;5785.739641716133;6409.865636664325;6630.834229144213;6646.83382915431;6684.63234522106;6714.462842972551;5727.871177839672;5775.209684997664;5779;5785.971070144707;5837.445442682938;3588.9102772430897;3595.658412450813;3652.7625704329134;3652.945205821915;3670.834812433447;6536.444402225769;6605.273419923805;6609.339066093448;6626.966865165643;6650.534462587572;7001.719931202695;7014.719411223596;7027.89458158128;7034.366906978396;7036.120484939383;6429.549931504844;6510.995737621329;6523.412892839668;6563.967180164069;6617.272100068989;6710.108137280268;6720.395164435225;6720.495962802712;6833.829154271183;6858.114018644913;6548.443382312556;6645.767398141042;6649.905279836836;6736.730530778714;6792.286809885089;6507.479401647762;6516.446102081376;6530.183727034121;6576.638284894377;6617.536772425884;4995.525425084611;5039.496050394931;5064.696118232918;5078.9238161426865;5082.567981721595;6662.83342916431;6777.23791814122;6778.288279730755;6840;6872.62200578953;6524.478041756743;6540.149780528501;6566.770163044271;6580.868382632416;6616.4045235929;6212.409821066992;6452.677366131581;6459.450946669585;6513.674316284261;6556.213254409501;5861.296644402529;6208.627482351073;6209.720562574605;6313.842153946188;6388.329225431448;6396.552241343062;6405.3594640535575;6420.55056146084;6472.385123413268;6491.48068154537;6192.566520343713;6208.192934918612;6297.181366422519;6298.118263443213;6340.1440805490665 03:53:49 INFO - PID 26062 | |5;yui.html;922.8846394200725;923.2291036984122;934.5841100710182;940.3887473142456;941.1764705882352;18360;18988.240470381203;19045.619087618255;19126;21038.684419733716;20794.688079678817;21228.469288267763;21383.14467421305;21576.89211553944;21619.70281783094;1038.226521241676;1066.163061996333;1073.1522097542932;1073.667163179413;1073.9838902416432;757.7234309477057;787.401574803148;1068.0761141612488;1071.3518321415547;1071.9678409647684;1080.8486811846349;1127.577158565538;1132.5752842683994;1133.557912414159;1133.9603113891014;1102.73534351755;1111.7832022755565;1112.0880877680306;1112.5494174859155;1116.207492680194;818.2390376949435;818.4884447220487;820.3519219816397;820.7989042684521;823.4112609484188;18898.52753681155;18919.24323027077;19135.425937221906;19224.71162932557;19530.121144548386;20802.687959680617;20894.268700595407;21071.473213169793;21555.67666485004;21557;15862.206889655472;16144.515664529965;16268.837311626969;16308;16550.089745064015;3548.3435564420665;3562.0560551453887;3565.9108522286892;3584.7490675652716;3586.336527742376;118491;120627.79372206253;123693;124351;125459;16424.096674683005;16515.17424128789;16532;16886.40897568579;16900.746488802677;30017.699823001927;30894.69105308918;31159.84420077885;31172.53241201384;31194.844025779727;7617.69529218825;7988.16124306951;8001.8399632008195;8669.133086691407;8711.215990560753;4065.7763822989427;4224.556421575752;4227.915441691149;4230.238557059759;4248.256555102845;5014.573761230264;5057.671251368649;5093.490650934951;5135.281060651511;5136.5890728741615;1044.4360045575456;1065.5098654618807;1067.5622994572188;1076.9407682577532;1081.734974931147;676.4453148418348;716.1120210938399;717.9425645948312;724.0478770416885;735.055453741939;11821.645350639494;12250.693732656577;12308.876911230773;12653.74692506163;12698.936505317415;683.135833171039;686.3994005245411;687.8624275144991;707.2185235315005;707.2255879811598;5144.331236939174;5241.371035475768;5291.100512912814;5312.123499622519;5367.892642147213;108475.45762271296;111602;112695;114052;117700.41149794367;91502;94223.52888235515;95374.52312738531;99476.50261748645;99601.50199248958;82431;83424;83462.58268708739;83477.58261208776;83739.58130209432;11630.941845291058;12616.684582885502;12923;12961.481540738265;12998.870011300145;35773.821130894175;35963.64036359603;36731.44902826513;36961.26077478489;39635.60364396319;45266.32100518561;47722.28416573824;58047;69990.30009699838;73176.90234646379;18679.719804202676;19558.315458958867;19840.503987399854;19872.70190947108;19929.800701992794;18231.726524102414;19821.900890495453;20552.58894822065;20804.167833286498;21092.68360974556;18257.178426971084;18798.812011879705;18891.05544722786;18909.338173163873;19149.425517234504;17710;17768.644627107125;17826.91086544559;18048.729269060714;18718.812811872252;18369.081545922916;18672.25310987545;18799.90600046991;19010.904945475184;19044.619107618048;14225.928870355581;14291.928540357232;14367.712645747235;14370.712585748017;14532.418703251751;13544.525941591997;13715.725685486434;13790;13859.792103118663;14621.561353159423 03:53:49 INFO - PID 26062 | __end_tp_report 03:53:49 INFO - PID 26062 | __start_cc_report 03:53:49 INFO - PID 26062 | _x_x_mozilla_cycle_collect,391 03:53:49 INFO - PID 26062 | __end_cc_report 03:53:49 INFO - PID 26062 | __startTimestamp1501757629968__endTimestamp 03:53:49 INFO - PID 26062 | 03:53:49 INFO - PID 26062 | ------- Summary: start ------- 03:53:49 INFO - PID 26062 | Number of tests: 6 03:53:49 INFO - PID 26062 | 03:53:49 INFO - PID 26062 | [#0] dojo.html Cycles:165 Average:6171.77 Median:6394.78 stddev:727.75 (11.4%) stddev-sans-first:689.88 03:53:49 INFO - PID 26062 | Values: 3134.6 3148.5 3151.5 3163.5 3212.2 6092.2 6149.5 6152.3 6153.6 6195.6 6278.5 6345.6 6348.3 6369.8 6372.0 5701.6 5739.3 5765.9 5770.6 5807.4 5582.8 5671.1 5740.3 5759.8 5854.3 5630.4 5631.2 5726.1 5755.5 5763.6 5679.1 5747.1 5765.8 5766.0 5775.8 5602.2 5648.4 5673.6 5733.8 5734.3 6074.7 6130.8 6140.5 6159.4 6176.5 6714.6 6784.4 6806.4 6808.7 6810.0 6785.2 6794.2 6865.4 6870.1 6870.3 6155.8 6237.2 6238.5 6243.9 6249.3 6767.9 6774.2 6777.8 6780.0 6802.1 6389.3 6465.9 6535.0 6660.4 6679.6 6648.5 6696.7 6763.8 6802.5 6807.7 6697.5 6711.9 6749.1 6787.4 6795.7 6528.5 6649.4 6652.5 6653.7 6660.2 5363.4 5375.2 5378.4 5379.6 5380.1 4688.2 4690.0 4696.1 4707.2 4708.5 5813.8 5817.9 5870.1 5902.7 5903.9 6563.2 6707.7 6719.1 6806.8 6812.6 5811.8 5842.5 5879.6 5904.4 5916.8 5880.2 5950.2 5956.0 5963.5 5973.6 6491.1 6501.3 6581.6 6584.6 6620.2 6587.5 6732.6 6753.9 6854.0 6858.1 6426.3 6494.5 6504.9 6507.8 6523.1 6555.7 6638.2 6650.0 6670.9 6676.7 6756.4 6786.8 6792.4 6797.4 6806.8 6493.2 6518.2 6530.3 6530.8 6542.8 6438.4 6474.4 6557.2 6557.8 6573.1 6293.1 6378.0 6381.8 6487.3 6497.4 6443.1 6469.5 6481.6 6527.2 6591.7 6192.7 6291.7 6292.7 6394.8 6440.9 03:53:49 INFO - PID 26062 | 03:53:49 INFO - PID 26062 | [#1] ext.html Cycles:180 Average:40277.31 Median:37528.62 stddev:57805.33 (154.0%) stddev-sans-first:57891.55 03:53:49 INFO - PID 26062 | Values: 814.6 842.7 858.4 888.2 889.3 41017.4 41832.0 41833.6 42199.8 42212.4 37662.0 37949.8 38150.0 38249.0 38264.0 6913.2 6980.4 6987.5 6989.0 7010.1 6836.9 6930.5 6942.7 6965.7 6967.8 6903.0 7569.9 7727.3 7767.8 7773.3 7667.8 7729.5 7738.8 7740.0 7741.9 7395.3 7576.1 7580.5 7663.3 7667.2 38379.8 38848.0 38917.0 38990.6 39007.4 3512.9 3562.9 3563.5 3564.2 3566.3 32280.7 32298.0 32366.5 32402.2 32406.8 4900.6 4910.4 4922.0 4951.1 4952.4 200547.0 201114.0 203244.0 209454.0 214105.0 50564.5 51055.5 51094.0 51119.0 51127.0 52254.0 52334.5 52435.8 52447.0 52819.0 16674.8 16751.0 16752.6 16812.7 16859.3 13940.4 13952.5 13996.3 13999.1 14011.4 14599.9 14676.6 14732.1 14805.9 14951.6 5654.8 5702.0 5722.5 5786.6 5944.6 982.9 992.3 996.3 1015.2 1030.5 22804.9 22991.8 23086.2 23153.0 23488.4 1105.5 1110.5 1127.4 1128.7 1130.9 12120.6 16248.4 16347.4 16646.2 16799.4 242116.0 244000.0 244730.0 244732.0 245119.0 58289.0 58535.0 58837.4 58916.4 59256.7 1417.2 1454.0 1467.4 1475.3 1480.7 25961.9 27652.0 27831.3 27836.2 28121.3 52785.2 53059.0 53074.2 53165.0 53182.5 214973.0 216235.0 216929.0 217357.0 217707.0 36361.8 36484.5 38247.4 38305.2 38340.8 46352.8 46966.8 47540.5 47668.3 48006.0 34377.8 34617.8 34813.7 34921.5 35224.0 33729.2 34147.7 34162.1 34329.3 34931.3 37508.4 37515.2 37542.0 37821.4 37967.8 33288.7 33544.0 33644.3 33686.0 33795.2 23213.7 24934.6 24986.8 25556.5 25608.4 03:53:49 INFO - PID 26062 | 03:53:49 INFO - PID 26062 | [#2] jquery.html Cycles:180 Average:35463.01 Median:20647.59 stddev:80431.99 (389.5%) stddev-sans-first:80614.98 03:53:49 INFO - PID 26062 | Values: 579.5 589.7 590.3 594.8 607.0 22664.8 23244.3 23442.9 23475.5 23478.0 27398.3 28096.6 28139.7 28180.2 28246.3 6461.1 6619.4 6663.6 6668.8 6675.1 5843.0 6351.6 6371.3 6386.9 6504.3 6333.8 6359.8 6360.7 6365.2 6378.7 6328.6 6353.4 6354.1 6364.3 6383.2 5915.3 5935.1 5944.5 5968.5 5979.8 27154.5 30837.4 31656.0 31715.4 31732.2 1934.9 1981.5 1981.8 1982.7 1989.9 18716.2 18784.5 19705.3 19726.9 19838.5 2349.8 2350.8 2399.5 2409.7 2430.3 148204.0 150323.0 152043.0 152615.0 161154.0 15302.0 15317.8 15773.0 15817.7 15978.4 24667.8 24698.3 24707.4 24713.6 24739.1 10407.4 10453.4 10769.4 10796.4 10906.8 8889.5 10071.8 10089.7 10116.9 10141.8 8715.8 11600.5 11661.2 11951.9 12084.5 3735.4 3893.7 4068.7 4292.3 4309.5 961.9 965.5 978.4 988.9 994.3 19983.0 20104.4 20329.0 20486.1 20621.6 1031.3 1051.5 1054.6 1056.2 1059.0 11052.7 11056.6 11097.0 11198.6 11217.3 461678.0 471872.0 473869.0 476571.0 477766.0 115554.0 118955.0 121243.4 122270.0 122359.0 1201.5 1235.7 1257.0 1265.1 1268.3 17680.3 17935.6 17995.1 18118.0 18449.9 56827.7 57215.7 57388.0 57575.0 58515.0 69835.0 70124.0 70182.0 71141.0 71599.6 20327.9 20532.8 20602.9 20673.6 20716.2 23253.4 23799.9 23837.2 23841.5 24308.0 17470.3 18407.8 18669.1 18673.9 18788.4 15961.3 16515.3 16834.5 17321.1 17459.5 17319.4 18253.7 18445.0 18576.3 19005.0 20125.5 20146.4 20365.1 20397.3 20507.3 18174.4 18401.4 18448.7 18524.4 18537.1 03:53:49 INFO - PID 26062 | 03:53:49 INFO - PID 26062 | [#3] mootools.html Cycles:180 Average:8819.74 Median:2566.51 stddev:6050.37 (235.7%) stddev-sans-first:6041.16 03:53:49 INFO - PID 26062 | Values: 1328.2 1369.2 1379.1 1384.3 1393.3 13607.6 14051.4 14162.6 14197.6 14261.4 14093.8 14517.9 14990.7 15044.9 15075.2 2669.1 2745.5 2748.9 2751.2 2754.8 2559.4 2584.1 2587.3 2596.3 2600.9 2640.6 2679.8 2684.5 2740.2 2744.5 2547.7 2593.2 2602.3 2603.4 2607.8 2534.8 2546.8 2560.2 2566.2 2566.8 13364.1 13595.9 13612.5 13629.7 13632.6 7389.7 7621.2 7658.8 7659.6 7685.2 5065.9 5237.6 5346.6 5352.8 5391.1 1751.9 1780.3 1781.4 1816.7 1817.3 23115.2 23534.1 23536.1 23545.5 23553.4 6675.6 6862.9 6999.7 7050.9 7054.5 18520.0 18551.8 18574.0 18586.8 18588.3 7730.3 7832.9 7918.2 7922.1 7925.4 5732.0 6149.9 6274.3 6994.0 7175.4 5474.5 5568.3 5603.9 5703.9 5726.1 1748.6 1758.3 1761.8 1783.0 1790.6 900.5 917.7 924.8 929.8 939.8 7491.4 7527.7 7537.4 7537.6 7542.7 727.8 728.5 742.4 745.2 755.9 5063.9 5260.9 5276.5 5409.4 5481.6 18630.8 19697.7 19703.5 19709.0 19722.8 18234.2 19150.4 19171.1 19329.4 19384.3 10970.7 10983.6 11179.4 11182.3 11183.8 8315.7 8360.4 8561.4 8603.5 8703.8 16732.7 17158.1 17200.7 17486.5 17548.6 13741.7 16647.7 17381.7 17694.5 17941.7 10923.4 11075.2 11180.9 11188.5 11190.5 13048.7 13066.5 13181.9 13213.9 13229.7 10476.3 10558.9 10584.9 10592.7 10726.8 10076.1 10170.5 10209.1 10263.3 10326.6 9085.5 9236.8 9243.1 9248.0 9258.6 7127.0 7163.2 7189.7 7208.4 7236.0 7175.8 7223.5 7256.9 7300.4 7375.5 03:53:49 INFO - PID 26062 | 03:53:49 INFO - PID 26062 | [#4] prototype.html Cycles:180 Average:5518.54 Median:6084.07 stddev:1544.90 (25.4%) stddev-sans-first:1502.62 03:53:49 INFO - PID 26062 | Values: 500.4 502.4 527.9 535.7 541.7 6200.4 6213.3 6236.3 6270.2 6309.1 5975.2 6156.2 6158.4 6181.8 6197.5 5024.2 5030.0 5042.3 5071.4 5073.4 4944.6 4963.9 4970.9 4991.7 5005.7 4793.4 4856.9 4941.7 4948.3 4966.4 4963.7 4970.2 4986.0 4993.1 4997.1 4401.8 4472.7 4486.7 4490.0 4531.6 5947.3 5981.4 5987.7 6078.9 6089.3 5738.5 5742.6 5757.2 5782.2 5794.8 6475.3 6533.0 6560.6 6569.3 6571.6 4794.6 4825.2 4878.6 4878.8 4928.4 6830.4 6999.7 7004.5 7009.3 7027.4 5057.7 5087.6 5104.5 5107.7 5114.8 5051.8 5055.0 5103.0 5107.8 5148.6 5664.5 5732.7 5739.2 5775.0 5793.0 6626.3 6632.0 6696.2 6707.5 6727.7 1676.6 1729.9 1776.0 1793.3 1797.6 1176.8 1217.4 1235.5 1242.2 1268.5 5650.2 5700.0 5701.9 5715.5 5785.7 6409.9 6630.8 6646.8 6684.6 6714.5 5727.9 5775.2 5779.0 5786.0 5837.4 3588.9 3595.7 3652.8 3652.9 3670.8 6536.4 6605.3 6609.3 6627.0 6650.5 7001.7 7014.7 7027.9 7034.4 7036.1 6429.5 6511.0 6523.4 6564.0 6617.3 6710.1 6720.4 6720.5 6833.8 6858.1 6548.4 6645.8 6649.9 6736.7 6792.3 6507.5 6516.4 6530.2 6576.6 6617.5 4995.5 5039.5 5064.7 5078.9 5082.6 6662.8 6777.2 6778.3 6840.0 6872.6 6524.5 6540.1 6566.8 6580.9 6616.4 6212.4 6452.7 6459.5 6513.7 6556.2 5861.3 6208.6 6209.7 6313.8 6388.3 6396.6 6405.4 6420.6 6472.4 6491.5 6192.6 6208.2 6297.2 6298.1 6340.1 03:53:49 INFO - PID 26062 | 03:53:49 INFO - PID 26062 | [#5] yui.html Cycles:180 Average:23295.94 Median:19831.20 stddev:31357.71 (158.1%) stddev-sans-first:31400.67 03:53:49 INFO - PID 26062 | Values: 922.9 923.2 934.6 940.4 941.2 18360.0 18988.2 19045.6 19126.0 21038.7 20794.7 21228.5 21383.1 21576.9 21619.7 1038.2 1066.2 1073.2 1073.7 1074.0 757.7 787.4 1068.1 1071.4 1072.0 1080.8 1127.6 1132.6 1133.6 1134.0 1102.7 1111.8 1112.1 1112.5 1116.2 818.2 818.5 820.4 820.8 823.4 18898.5 18919.2 19135.4 19224.7 19530.1 20802.7 20894.3 21071.5 21555.7 21557.0 15862.2 16144.5 16268.8 16308.0 16550.1 3548.3 3562.1 3565.9 3584.7 3586.3 118491.0 120627.8 123693.0 124351.0 125459.0 16424.1 16515.2 16532.0 16886.4 16900.7 30017.7 30894.7 31159.8 31172.5 31194.8 7617.7 7988.2 8001.8 8669.1 8711.2 4065.8 4224.6 4227.9 4230.2 4248.3 5014.6 5057.7 5093.5 5135.3 5136.6 1044.4 1065.5 1067.6 1076.9 1081.7 676.4 716.1 717.9 724.0 735.1 11821.6 12250.7 12308.9 12653.7 12698.9 683.1 686.4 687.9 707.2 707.2 5144.3 5241.4 5291.1 5312.1 5367.9 108475.5 111602.0 112695.0 114052.0 117700.4 91502.0 94223.5 95374.5 99476.5 99601.5 82431.0 83424.0 83462.6 83477.6 83739.6 11630.9 12616.7 12923.0 12961.5 12998.9 35773.8 35963.6 36731.4 36961.3 39635.6 45266.3 47722.3 58047.0 69990.3 73176.9 18679.7 19558.3 19840.5 19872.7 19929.8 18231.7 19821.9 20552.6 20804.2 21092.7 18257.2 18798.8 18891.1 18909.3 19149.4 17710.0 17768.6 17826.9 18048.7 18718.8 18369.1 18672.3 18799.9 19010.9 19044.6 14225.9 14291.9 14367.7 14370.7 14532.4 13544.5 13715.7 13790.0 13859.8 14621.6 03:53:49 INFO - PID 26062 | -------- Summary: end -------- 03:53:49 INFO - PID 26062 | 03:53:50 INFO - TEST-INFO | 26062: exit 0 03:53:50 INFO - TEST-OK | dromaeo_css | took 1112285ms 03:53:50 INFO - TEST-START | kraken 03:53:50 INFO - Initialising browser for kraken test... 03:53:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37210/getInfo.html -profile /tmp/tmpC2xcox/profile 03:53:50 INFO - TEST-INFO | started process 26419 (/builds/slave/test/build/application/firefox/firefox http://localhost:37210/getInfo.html) 03:53:56 INFO - TEST-INFO | 26419: exit 0 03:53:56 INFO - Browser initialized. 03:53:56 INFO - Running cycle 1/1 for kraken test... 03:53:56 INFO - TEST-INFO | started process 26628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC2xcox/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:57 INFO - PID 26628 | 03:53:57 INFO - PID 26628 | (/builds/slave/test/build/application/firefox/firefox:26676): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:53:57 INFO - PID 26628 | 03:54:07 INFO - PID 26628 | RSS: Main: 171589632 03:54:07 INFO - PID 26628 | 03:54:10 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37210/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:11 INFO - PID 26628 | RSS: Main: 176943104 03:54:11 INFO - PID 26628 | 03:54:13 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37210/tests/kraken/driver.html?testName=audio-dft) 03:54:14 INFO - PID 26628 | RSS: Main: 177586176 03:54:14 INFO - PID 26628 | 03:54:17 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37210/tests/kraken/driver.html?testName=audio-fft) 03:54:18 INFO - PID 26628 | RSS: Main: 171945984 03:54:18 INFO - PID 26628 | 03:54:20 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37210/tests/kraken/driver.html?testName=audio-oscillator) 03:54:20 INFO - PID 26628 | RSS: Main: 172548096 03:54:20 INFO - PID 26628 | 03:54:23 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:23 INFO - PID 26628 | RSS: Main: 173596672 03:54:23 INFO - PID 26628 | 03:54:26 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37210/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:27 INFO - PID 26628 | RSS: Main: 175276032 03:54:27 INFO - PID 26628 | 03:54:30 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37210/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:31 INFO - PID 26628 | RSS: Main: 175398912 03:54:31 INFO - PID 26628 | 03:54:34 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37210/tests/kraken/driver.html?testName=json-parse-financial) 03:54:35 INFO - PID 26628 | RSS: Main: 175366144 03:54:35 INFO - PID 26628 | 03:54:36 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:37 INFO - PID 26628 | RSS: Main: 175636480 03:54:37 INFO - PID 26628 | 03:54:39 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:39 INFO - PID 26628 | RSS: Main: 175828992 03:54:39 INFO - PID 26628 | 03:54:41 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:42 INFO - PID 26628 | RSS: Main: 172740608 03:54:42 INFO - PID 26628 | 03:54:45 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:45 INFO - PID 26628 | RSS: Main: 173662208 03:54:45 INFO - PID 26628 | 03:54:48 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:49 INFO - PID 26628 | RSS: Main: 173346816 03:54:49 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | Cycle 1(1): loaded http://localhost:37210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37210/tests/kraken/driver.html?testName=ai-astar) 03:54:51 INFO - PID 26628 | RSS: Main: 174899200 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | __start_tp_report 03:54:51 INFO - PID 26628 | _x_x_mozilla_page_load 03:54:51 INFO - PID 26628 | _x_x_mozilla_page_load_details 03:54:51 INFO - PID 26628 | |i|pagename|runs| 03:54:51 INFO - PID 26628 | |0;ai-astar;99;108;101;107;107;110;110;101;109;110 03:54:51 INFO - PID 26628 | |1;audio-beat-detection;158;119;145;186;124;146;146;118;176;118 03:54:51 INFO - PID 26628 | |2;audio-dft;163;163;163;162;162;162;161;169;171;163 03:54:51 INFO - PID 26628 | |3;audio-fft;74;75;76;182;78;76;75;85;151;76 03:54:51 INFO - PID 26628 | |4;audio-oscillator;78;78;133;79;79;78;133;79;78;126 03:54:51 INFO - PID 26628 | |5;imaging-gaussian-blur;115;114;114;114;115;113;113;114;114;115 03:54:51 INFO - PID 26628 | |6;imaging-darkroom;151;152;150;152;150;152;150;151;154;151 03:54:51 INFO - PID 26628 | |7;imaging-desaturate;94;94;93;93;95;93;93;94;95;94 03:54:51 INFO - PID 26628 | |8;json-parse-financial;56;56;56;55;57;55;57;55;55;56 03:54:51 INFO - PID 26628 | |9;json-stringify-tinderbox;54;53;54;53;53;54;53;54;54;61 03:54:51 INFO - PID 26628 | |10;stanford-crypto-aes;78;87;78;78;80;78;87;87;86;78 03:54:51 INFO - PID 26628 | |11;stanford-crypto-ccm;131;132;143;136;125;125;132;127;125;161 03:54:51 INFO - PID 26628 | |12;stanford-crypto-pbkdf2;177;178;179;186;176;177;180;175;175;174 03:54:51 INFO - PID 26628 | |13;stanford-crypto-sha256-iterative;75;66;67;65;67;67;67;68;66;65 03:54:51 INFO - PID 26628 | __end_tp_report 03:54:51 INFO - PID 26628 | __start_cc_report 03:54:51 INFO - PID 26628 | _x_x_mozilla_cycle_collect,993 03:54:51 INFO - PID 26628 | __end_cc_report 03:54:51 INFO - PID 26628 | __startTimestamp1501757691584__endTimestamp 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | ------- Summary: start ------- 03:54:51 INFO - PID 26628 | Number of tests: 14 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#0] ai-astar Cycles:10 Average:106.20 Median:109.50 stddev:4.24 (3.9%) stddev-sans-first:3.61 03:54:51 INFO - PID 26628 | Values: 99.0 108.0 101.0 107.0 107.0 110.0 110.0 101.0 109.0 110.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:146.00 stddev:24.42 (16.7%) stddev-sans-first:25.34 03:54:51 INFO - PID 26628 | Values: 158.0 119.0 145.0 186.0 124.0 146.0 146.0 118.0 176.0 118.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.31 (2.0%) stddev-sans-first:3.50 03:54:51 INFO - PID 26628 | Values: 163.0 163.0 163.0 162.0 162.0 162.0 161.0 169.0 171.0 163.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:38.61 (50.8%) stddev-sans-first:40.21 03:54:51 INFO - PID 26628 | Values: 74.0 75.0 76.0 182.0 78.0 76.0 75.0 85.0 151.0 76.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:78.00 stddev:25.31 (32.4%) stddev-sans-first:26.17 03:54:51 INFO - PID 26628 | Values: 78.0 78.0 133.0 79.0 79.0 78.0 133.0 79.0 78.0 126.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 03:54:51 INFO - PID 26628 | Values: 115.0 114.0 114.0 114.0 115.0 113.0 113.0 114.0 114.0 115.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 03:54:51 INFO - PID 26628 | Values: 151.0 152.0 150.0 152.0 150.0 152.0 150.0 151.0 154.0 151.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 03:54:51 INFO - PID 26628 | Values: 94.0 94.0 93.0 93.0 95.0 93.0 93.0 94.0 95.0 94.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 03:54:51 INFO - PID 26628 | Values: 56.0 56.0 56.0 55.0 57.0 55.0 57.0 55.0 55.0 56.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:2.41 (4.5%) stddev-sans-first:2.55 03:54:51 INFO - PID 26628 | Values: 54.0 53.0 54.0 53.0 53.0 54.0 53.0 54.0 54.0 61.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:83.00 stddev:4.40 (5.3%) stddev-sans-first:4.46 03:54:51 INFO - PID 26628 | Values: 78.0 87.0 78.0 78.0 80.0 78.0 87.0 87.0 86.0 78.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:132.00 stddev:11.17 (8.5%) stddev-sans-first:11.80 03:54:51 INFO - PID 26628 | Values: 131.0 132.0 143.0 136.0 125.0 125.0 132.0 127.0 125.0 161.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:177.50 stddev:3.47 (2.0%) stddev-sans-first:3.67 03:54:51 INFO - PID 26628 | Values: 177.0 178.0 179.0 186.0 176.0 177.0 180.0 175.0 175.0 174.0 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.87 (4.3%) stddev-sans-first:1.01 03:54:51 INFO - PID 26628 | Values: 75.0 66.0 67.0 65.0 67.0 67.0 67.0 68.0 66.0 65.0 03:54:51 INFO - PID 26628 | -------- Summary: end -------- 03:54:51 INFO - PID 26628 | 03:54:51 INFO - PID 26628 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:54:52 INFO - TEST-INFO | 26628: exit 0 03:54:52 INFO - TEST-OK | kraken | took 61613ms 03:54:52 INFO - SUITE-END | took 1173s 03:54:52 INFO - Completed test suite (00:19:34) 03:54:52 INFO - javascript benchmark 03:54:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8619.37395744739, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.639516455607, 3148.5119806430002, 3151.5272709093647, 3163.493840985442, 3212.1969507623094, 6092.208012958315, 6149.508039356852, 6152.292486364069, 6153.630782153068, 6195.597286176396, 6278.529110316733, 6345.587536810104, 6348.269948955872, 6369.840753981152, 6371.9681401592925, 5701.57238207134, 5739.339975902762, 5765.942340576604, 5770.567207459447, 5807.39022402648, 5582.7766889324375, 5671.149327600872, 5740.339860916007, 5759.82720518383, 5854.297484301868, 5630.40880707526, 5631.18347839563, 5726.141078838186, 5755.453231942959, 5763.625364351304, 5679.119736440858, 5747.137929310595, 5765.798197063083, 5766.0, 5775.826725198251, 5602.1596760485845, 5648.350439699446, 5673.574481913873, 5733.827985160452, 5734.340550836624, 6074.726637301332, 6130.785422510236, 6140.508759299245, 6159.353267906895, 6176.505879529627, 6714.6306953117555, 6784.35548622885, 6806.353396427331, 6808.659567021629, 6810.012548180486, 6785.1518560179975, 6794.218664853555, 6865.382115609619, 6870.106886104824, 6870.31296870314, 6155.784547540859, 6237.189165408558, 6238.469730072995, 6243.937560624381, 6249.343818898996, 6767.864642707217, 6774.187097548326, 6777.830554236085, 6780.016897549827, 6802.115724955823, 6389.297177310492, 6465.870682586322, 6535.0, 6660.367265109807, 6679.632620205935, 6648.4681225501845, 6696.698648560827, 6763.797086087426, 6802.489813264025, 6807.65961701913, 6697.531172817953, 6711.899321510181, 6749.0551322814845, 6787.423069039089, 6795.694193761293, 6528.477721782341, 6649.401553860079, 6652.467802575782, 6653.700583473756, 6660.167479065117, 5363.383210930715, 5375.220593013991, 5378.381486129145, 5379.596530260246, 5380.085385484477, 4688.226442636927, 4690.038542098861, 4696.060787842377, 4707.223308154116, 4708.4820669726305, 5813.767449302065, 5817.912731309034, 5870.0607902735355, 5902.675352855634, 5903.940960590425, 6563.1796025496815, 6707.6981535831, 6719.092922455504, 6806.8298292542095, 6812.557183783138, 5811.79658711943, 5842.503387212135, 5879.588428810028, 5904.380040095814, 5916.822495325061, 5880.176775251382, 5950.19672344228, 5955.970220148872, 5963.522918166536, 5973.641581505123, 6491.091247225392, 6501.252355979028, 6581.605103693793, 6584.604923704497, 6620.205575330991, 6587.538872278895, 6732.562383445061, 6753.932460675331, 6854.0, 6858.074159988338, 6426.260979987362, 6494.512911531559, 6504.902426463512, 6507.772227971998, 6523.054157147282, 6555.737770489318, 6638.17022872141, 6649.966750166218, 6670.899936500859, 6676.6661666917435, 6756.391924726601, 6786.830329241809, 6792.388685018372, 6797.354251346114, 6806.829829254309, 6493.22081350241, 6518.217813862367, 6530.314316996647, 6530.8040758777315, 6542.771003014872, 6438.420542151229, 6474.384933431316, 6557.180352455943, 6557.803265902031, 6573.079768832272, 6293.087502312231, 6377.96811015942, 6381.840453988688, 6487.253965793994, 6497.415232629086, 6443.065755465337, 6469.450096741642, 6481.643509607017, 6527.249366322743, 6591.736330546724, 6192.721327540362, 6291.685415729286, 6292.716827742671, 6394.776182833579, 6440.871182576416], "value": 6117.188979126231, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.6374863185881, 842.7092653034708, 858.4076986879054, 888.2006194425021, 889.2707979456844, 41017.384739228895, 41831.95420114499, 41833.58166418335, 42199.78900105499, 42212.36681449781, 37662.0, 37949.81025094871, 38150.0, 38249.0, 38264.0, 6913.170419549649, 6980.406665433445, 6987.545809522365, 6989.0, 7010.088688470491, 6836.9316306837045, 6930.5148639595245, 6942.652867356637, 6965.6517174141345, 6967.79096627102, 6903.033575299462, 7569.924300756977, 7727.265909738566, 7767.844643107134, 7773.300402963732, 7667.846643067135, 7729.536227826348, 7738.7678369649, 7739.961300193463, 7741.922580774205, 7395.260473952616, 7576.052993375828, 7580.54516728998, 7663.27198916102, 7667.1949445308, 38379.808100959315, 38848.0, 38917.0, 38990.610093898984, 39007.41488877669, 3512.929741405183, 3562.9109272268142, 3563.501109844624, 3564.198055437532, 3566.3045706087323, 32280.677193228003, 32298.0, 32366.514502282484, 32402.18994525132, 32406.837965810257, 4900.607951363882, 4910.361652985089, 4922.0402021605805, 4951.059298733265, 4952.356193694833, 200547.0, 201114.0, 203244.0, 209454.0, 214105.0, 50564.49435505598, 51055.48944510581, 51094.0, 51119.0, 51127.0, 52254.0, 52334.476655233724, 52435.80513558983, 52447.0, 52819.0, 16674.83325166757, 16751.0, 16752.581185470463, 16812.739044571463, 16859.325626975027, 13940.442382304595, 13952.511662091982, 13996.30018499071, 13999.090059146123, 14011.369488373048, 14599.85400145985, 14676.55970320892, 14732.116073035651, 14805.925970370079, 14951.626209344853, 5654.830355089354, 5701.971490142606, 5722.542196624343, 5786.566007549451, 5944.613600115978, 982.916452101565, 992.3450522655013, 996.2528103922059, 1015.2334987084852, 1030.525958059286, 22804.885975570018, 22991.7700822993, 23086.19198328084, 23153.0, 23488.412789680395, 1105.5135740274413, 1110.4891749795024, 1127.4362818590705, 1128.700894263021, 1130.8925652063042, 12120.575779847662, 16248.350065997463, 16347.44699253569, 16646.16769161537, 16799.41202057922, 242116.0, 244000.0, 244730.0, 244732.0, 245119.0, 58289.0, 58535.0, 58837.41162588405, 58916.41083589109, 59256.70371648114, 1417.1638733147493, 1453.9563813085624, 1467.4203689542785, 1475.2771142140275, 1480.6890552983778, 25961.870190648926, 27652.0, 27831.30421739473, 27836.16491505258, 28121.296967575156, 52785.20822187593, 53059.0, 53074.2038869425, 53165.0, 53182.46817531775, 214973.0, 216235.0, 216929.0, 217357.0, 217707.0, 36361.818190908874, 36484.45273320849, 38247.42628860514, 38305.23389532138, 38340.80829595834, 46352.768236158605, 46966.76516617395, 47540.52459475361, 47668.284975724695, 48006.0, 34377.828110859286, 34617.82691086528, 34813.65186348104, 34921.47617785684, 35224.0, 33729.15677108092, 34147.65852341445, 34162.14594635154, 34329.31341373209, 34931.301373972885, 37508.43737343887, 37515.249695006496, 37542.0, 37821.43267851039, 37967.810160950125, 33288.667113328556, 33544.0, 33644.32711345809, 33686.0, 33795.15512112217, 23213.651795223424, 24934.625980609944, 24986.75013249844, 25556.488870222864, 25608.359791005372], "value": 17898.61690733416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.4987335954401, 589.6595784878663, 590.2592246730355, 594.7858770842496, 606.9817905462836, 22664.77335226647, 23244.3026709199, 23442.88278558607, 23475.530489390203, 23478.0, 27398.315042123955, 28096.578551321745, 28139.718602813966, 28180.15459536212, 28246.293842653944, 6461.127747754052, 6619.404253617197, 6663.566868153554, 6668.76659316924, 6675.098861653688, 5843.0, 6351.555391122623, 6371.299157092716, 6386.872262554746, 6504.284528701839, 6333.841653958665, 6359.777407790728, 6360.650164240965, 6365.236171659384, 6378.712957916905, 6328.620282783025, 6353.396427339396, 6354.078658594501, 6364.268109167436, 6383.170187875547, 5915.260592425947, 5935.080062590306, 5944.494717948979, 5968.522518198533, 5979.790707325223, 27154.45691086167, 30837.383252335054, 31656.0, 31715.36569268625, 31732.206694832585, 1934.9032548372525, 1981.504623844039, 1981.8414526837819, 1982.6530357187435, 1989.8607097503182, 18716.157772900253, 18784.530386740305, 19705.31031413908, 19726.901365493082, 19838.50403739918, 2349.8237632177484, 2350.82368822339, 2399.5200959808108, 2409.662647229389, 2430.307362401707, 148204.0, 150323.0, 152043.0, 152615.0, 161153.99999999884, 15302.0, 15317.770233446507, 15773.0, 15817.683646327008, 15978.440754573534, 24667.753322466906, 24698.259052228463, 24707.382315441897, 24713.629295560582, 24739.134130305352, 10407.375557466425, 10453.372797632166, 10769.407682577377, 10796.406197659047, 10906.781864362669, 8889.511076890703, 10071.798564028679, 10089.697309080739, 10116.949415252877, 10141.847872281922, 8715.818726164904, 11600.477978490988, 11661.24201926889, 11951.88048119525, 12084.456199471046, 3735.402335626287, 3893.7274390792372, 4068.694847886361, 4292.313229883203, 4309.491677912705, 961.8653388525612, 965.4931161140457, 978.4422878958925, 988.9109980101681, 994.3487016004528, 19983.0, 20104.39686809398, 20329.0, 20486.095511927782, 20621.58756824855, 1031.257494603884, 1051.4637534857277, 1054.5570860238718, 1056.2447849787438, 1058.957641694339, 11052.723681908017, 11056.613018544313, 11097.0, 11198.608048718255, 11217.32696038224, 461678.0, 471872.0, 473869.0, 476571.0, 477766.0, 115554.0, 118955.0, 121243.39378303052, 122270.0, 122359.0, 1201.4953719437858, 1235.71578536937, 1256.9685757856128, 1265.0828149591473, 1268.2580690296095, 17680.29278828884, 17935.641287174443, 17995.10024498796, 18118.0, 18449.907750461163, 56827.71586142043, 57215.713921431794, 57388.0, 57575.0, 58515.0, 69835.0, 70124.0, 70182.0, 71141.0, 71599.64200178966, 20327.8983605081, 20532.79467205309, 20602.896985514977, 20673.58652826965, 20716.171353145706, 23253.41866453352, 23799.881000594887, 23837.165699200446, 23841.52316953686, 24308.027678892646, 17470.30118795285, 18407.815921841146, 18669.066546672882, 18673.90663046676, 18788.436346909613, 15961.281742321855, 16515.33938642441, 16834.494965151065, 17321.13394330253, 17459.47621571355, 17319.393821216196, 18253.726194107363, 18445.0, 18576.349827755963, 19005.0, 20125.49686257855, 20146.39560813178, 20365.083571239033, 20397.286094986604, 20507.28224512135, 18174.36389726353, 18401.355952542133, 18448.723269151244, 18524.444266671482, 18537.0731463429], "value": 12574.67642754965, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.1632571479965, 1369.1853347258382, 1379.131406674118, 1384.321682375635, 1393.3172745354773, 13607.591772246837, 14051.437942482315, 14162.575122746308, 14197.64505887352, 14261.429542818289, 14093.78859317111, 14517.854821451783, 14990.700185996273, 15044.924775376108, 15075.170865602387, 2669.0925085470885, 2745.5195340815376, 2748.9141788993334, 2751.1608959267414, 2754.848483333416, 2559.3857474206243, 2584.1343150044663, 2587.3402282417956, 2596.3379338268714, 2600.947981040378, 2640.6303117563557, 2679.758821706046, 2684.4899469100906, 2740.2464322311325, 2744.4922689302443, 2547.7070136934212, 2593.222033389985, 2602.349412646838, 2603.440260344016, 2607.8174527783062, 2534.7845433138204, 2546.7707906288338, 2560.193539035198, 2566.230130960704, 2566.7946564275, 13364.13133146352, 13595.932020339935, 13612.523561675393, 13629.659258518517, 13632.591022269347, 7389.704411823521, 7621.161672216052, 7658.8468230635635, 7659.578723170223, 7685.154632990367, 5065.949340506621, 5237.633365664405, 5346.572274218092, 5352.759125839308, 5391.083515802284, 1751.8510926571257, 1780.305680784495, 1781.4477511971202, 1816.6548355812354, 1817.2917457589824, 23115.190968316198, 23534.058637654474, 23536.058557657674, 23545.529089418116, 23553.41116472085, 6675.632840193836, 6862.862742745117, 6999.650017499104, 7050.894236586455, 7054.541454805421, 18520.0, 18551.81448185501, 18574.0, 18586.81413185878, 18588.25646974133, 7730.342920851791, 7832.882506762403, 7918.208179182036, 7922.0889597697005, 7925.445218834741, 5731.971340143356, 6149.938500614937, 6274.2784579773, 6994.0, 7175.425965922714, 5474.452554744494, 5568.331800184003, 5603.915941260884, 5703.885922281531, 5726.141078838207, 1748.5541186997234, 1758.2527425843964, 1761.806201317854, 1782.97325540117, 1790.5613124784252, 900.5272232078212, 917.660465627722, 924.8196601662746, 929.8233335666201, 939.8214339275515, 7491.400687944952, 7527.698892044257, 7537.434692398092, 7537.623118844036, 7542.698292068366, 727.8471520980547, 728.5300980867311, 742.4023660952985, 745.2324106170653, 755.8677231484468, 5063.924041139386, 5260.947390526046, 5276.5251127398715, 5409.43200963901, 5481.561475081984, 18630.81369186318, 19697.704534431996, 19703.507412314808, 19709.0, 19722.802771972383, 18234.179461924246, 19150.425487235407, 19171.137298821588, 19329.4201173965, 19384.321548746007, 10970.725731856768, 10983.61557345489, 11179.441027948733, 11182.273152245241, 11183.832242516206, 8315.708950186714, 8360.372972027, 8561.400701950804, 8603.483790972561, 8703.825923481621, 16732.749008764637, 17158.142092895057, 17200.65598687994, 17486.47540573785, 17548.64902701913, 13741.725165496833, 16647.667046658757, 17381.739273911153, 17694.469165925042, 17941.730874037163, 10923.399213043042, 11075.169362297698, 11180.888191117985, 11188.496517656562, 11190.496427660937, 13048.673783155118, 13066.54267100647, 13181.868181318065, 13213.867861321263, 13229.735405292033, 10476.319039262424, 10558.894411056099, 10584.947075264574, 10592.735181620521, 10726.785464290826, 10076.143527800219, 10170.491475426346, 10209.132223760766, 10263.332883362558, 10326.638567650096, 9085.454872707658, 9236.769080772765, 9243.075692430702, 9248.0, 9258.629654813732, 7127.0, 7163.2478589747325, 7189.712411503481, 7208.423326133792, 7236.0, 7175.784726458214, 7223.494355395282, 7256.891146632699, 7300.379467745302, 7375.483716140034], "value": 6409.979416798094, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.44450659767654, 502.38959664008223, 527.8733104055028, 535.6866233253546, 541.7210136779556, 6200.379962003797, 6213.254409470864, 6236.25164980203, 6270.247570291565, 6309.1482649842255, 5975.193348897908, 6156.1996940397685, 6158.445739883409, 6181.75272989081, 6197.5041996640275, 5024.246363045536, 5029.9748501257445, 5042.268871013701, 5071.416787069479, 5073.416557095944, 4944.554990050895, 4963.875903102416, 4970.900581988358, 4991.675541089836, 5005.724685142334, 4793.4487533933525, 4856.927146092811, 4941.678790878582, 4948.257761335793, 4966.404031516223, 4963.656800299737, 4970.229614409773, 4986.0, 4993.126202914512, 4997.100521906055, 4401.845935392246, 4472.709273897219, 4486.663500237462, 4490.034642551835, 4531.592156705912, 5947.256592925884, 5981.371955944606, 5987.700614969278, 6078.875408049481, 6089.269287685462, 5738.540916726652, 5742.588112992553, 5757.222774925415, 5782.219400380936, 5794.797182098607, 6475.255345635265, 6532.967335163294, 6560.573562718456, 6569.343065693441, 6571.572847764928, 4794.640401969867, 4825.227963525819, 4878.634102442331, 4878.804847806084, 4928.433230178503, 6830.419414349786, 6999.650017499155, 7004.544704594185, 7009.264027277113, 7027.402670772991, 5057.747112644353, 5087.643864929493, 5104.4895510449405, 5107.693538387709, 5114.820981265638, 5051.772670229849, 5055.0, 5102.974485127551, 5107.770150343244, 5148.613853960968, 5664.490195882308, 5732.684702341411, 5739.196512488255, 5774.971125144431, 5792.9710351447975, 6626.304238055031, 6631.966840165865, 6696.229933557704, 6707.5304728668525, 6727.697253623501, 1676.5976165720383, 1729.8962062276303, 1775.973360399595, 1793.32750218668, 1797.5685835399672, 1176.823176823177, 1217.3852204636778, 1235.4872727818035, 1242.1801610936739, 1268.492602958824, 5650.208970744099, 5699.971500142473, 5701.942980570224, 5715.5427565794635, 5785.739641716133, 6409.865636664325, 6630.834229144213, 6646.83382915431, 6684.63234522106, 6714.462842972551, 5727.871177839672, 5775.209684997664, 5779.0, 5785.971070144707, 5837.445442682938, 3588.9102772430897, 3595.658412450813, 3652.7625704329134, 3652.945205821915, 3670.834812433447, 6536.444402225769, 6605.273419923805, 6609.339066093448, 6626.966865165643, 6650.534462587572, 7001.719931202695, 7014.719411223596, 7027.89458158128, 7034.366906978396, 7036.120484939383, 6429.549931504844, 6510.995737621329, 6523.412892839668, 6563.967180164069, 6617.272100068989, 6710.108137280268, 6720.395164435225, 6720.495962802712, 6833.829154271183, 6858.114018644913, 6548.443382312556, 6645.767398141042, 6649.905279836836, 6736.730530778714, 6792.286809885089, 6507.479401647762, 6516.446102081376, 6530.183727034121, 6576.638284894377, 6617.536772425884, 4995.525425084611, 5039.496050394931, 5064.696118232918, 5078.9238161426865, 5082.567981721595, 6662.83342916431, 6777.23791814122, 6778.288279730755, 6840.0, 6872.62200578953, 6524.478041756743, 6540.149780528501, 6566.770163044271, 6580.868382632416, 6616.4045235929, 6212.409821066992, 6452.677366131581, 6459.450946669585, 6513.674316284261, 6556.213254409501, 5861.296644402529, 6208.627482351073, 6209.720562574605, 6313.842153946188, 6388.329225431448, 6396.552241343062, 6405.3594640535575, 6420.55056146084, 6472.385123413268, 6491.48068154537, 6192.566520343713, 6208.192934918612, 6297.181366422519, 6298.118263443213, 6340.1440805490665], "value": 5066.129525917361, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [922.8846394200725, 923.2291036984122, 934.5841100710182, 940.3887473142456, 941.1764705882352, 18360.0, 18988.240470381203, 19045.619087618255, 19126.0, 21038.684419733716, 20794.688079678817, 21228.469288267763, 21383.14467421305, 21576.89211553944, 21619.70281783094, 1038.226521241676, 1066.163061996333, 1073.1522097542932, 1073.667163179413, 1073.9838902416432, 757.7234309477057, 787.401574803148, 1068.0761141612488, 1071.3518321415547, 1071.9678409647684, 1080.8486811846349, 1127.577158565538, 1132.5752842683994, 1133.557912414159, 1133.9603113891014, 1102.73534351755, 1111.7832022755565, 1112.0880877680306, 1112.5494174859155, 1116.207492680194, 818.2390376949435, 818.4884447220487, 820.3519219816397, 820.7989042684521, 823.4112609484188, 18898.52753681155, 18919.24323027077, 19135.425937221906, 19224.71162932557, 19530.121144548386, 20802.687959680617, 20894.268700595407, 21071.473213169793, 21555.67666485004, 21557.0, 15862.206889655472, 16144.515664529965, 16268.837311626969, 16308.0, 16550.089745064015, 3548.3435564420665, 3562.0560551453887, 3565.9108522286892, 3584.7490675652716, 3586.336527742376, 118491.0, 120627.79372206253, 123693.0, 124351.0, 125459.0, 16424.096674683005, 16515.17424128789, 16532.0, 16886.40897568579, 16900.746488802677, 30017.699823001927, 30894.69105308918, 31159.84420077885, 31172.53241201384, 31194.844025779727, 7617.69529218825, 7988.16124306951, 8001.8399632008195, 8669.133086691407, 8711.215990560753, 4065.7763822989427, 4224.556421575752, 4227.915441691149, 4230.238557059759, 4248.256555102845, 5014.573761230264, 5057.671251368649, 5093.490650934951, 5135.281060651511, 5136.5890728741615, 1044.4360045575456, 1065.5098654618807, 1067.5622994572188, 1076.9407682577532, 1081.734974931147, 676.4453148418348, 716.1120210938399, 717.9425645948312, 724.0478770416885, 735.055453741939, 11821.645350639494, 12250.693732656577, 12308.876911230773, 12653.74692506163, 12698.936505317415, 683.135833171039, 686.3994005245411, 687.8624275144991, 707.2185235315005, 707.2255879811598, 5144.331236939174, 5241.371035475768, 5291.100512912814, 5312.123499622519, 5367.892642147213, 108475.45762271296, 111602.0, 112695.0, 114052.0, 117700.41149794367, 91502.0, 94223.52888235515, 95374.52312738531, 99476.50261748645, 99601.50199248958, 82431.0, 83424.0, 83462.58268708739, 83477.58261208776, 83739.58130209432, 11630.941845291058, 12616.684582885502, 12923.0, 12961.481540738265, 12998.870011300145, 35773.821130894175, 35963.64036359603, 36731.44902826513, 36961.26077478489, 39635.60364396319, 45266.32100518561, 47722.28416573824, 58047.0, 69990.30009699838, 73176.90234646379, 18679.719804202676, 19558.315458958867, 19840.503987399854, 19872.70190947108, 19929.800701992794, 18231.726524102414, 19821.900890495453, 20552.58894822065, 20804.167833286498, 21092.68360974556, 18257.178426971084, 18798.812011879705, 18891.05544722786, 18909.338173163873, 19149.425517234504, 17710.0, 17768.644627107125, 17826.91086544559, 18048.729269060714, 18718.812811872252, 18369.081545922916, 18672.25310987545, 18799.90600046991, 19010.904945475184, 19044.619107618048, 14225.928870355581, 14291.928540357232, 14367.712645747235, 14370.712585748017, 14532.418703251751, 13544.525941591997, 13715.725685486434, 13790.0, 13859.792103118663, 14621.561353159423], "value": 9171.17370409531, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 101.0, 107.0, 107.0, 110.0, 110.0, 101.0, 109.0, 110.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 119.0, 145.0, 186.0, 124.0, 146.0, 146.0, 118.0, 176.0, 118.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 162.0, 162.0, 161.0, 169.0, 171.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 182.0, 78.0, 76.0, 75.0, 85.0, 151.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 133.0, 79.0, 79.0, 78.0, 133.0, 79.0, 78.0, 126.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 115.0, 113.0, 113.0, 114.0, 114.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 150.0, 152.0, 150.0, 152.0, 150.0, 151.0, 154.0, 151.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 95.0, 93.0, 93.0, 94.0, 95.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 57.0, 55.0, 57.0, 55.0, 55.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 53.0, 54.0, 53.0, 54.0, 54.0, 61.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 87.0, 78.0, 78.0, 80.0, 78.0, 87.0, 87.0, 86.0, 78.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 143.0, 136.0, 125.0, 125.0, 132.0, 127.0, 125.0, 161.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 178.0, 179.0, 186.0, 176.0, 177.0, 180.0, 175.0, 175.0, 174.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 66.0, 67.0, 65.0, 67.0, 67.0, 67.0, 68.0, 66.0, 65.0], "value": 67.3, "unit": "score"}]}]} 03:54:52 INFO - Return code: 0 03:54:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:52 INFO - # TBPL SUCCESS # 03:54:52 INFO - Running post-action listener: _package_coverage_data 03:54:52 INFO - Running post-action listener: _resource_record_post_action 03:54:52 INFO - [mozharness: 2017-08-03 10:54:52.865558Z] Finished run-tests step (success) 03:54:52 INFO - Running post-run listener: _resource_record_post_run 03:54:52 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 430764032; Read time: 8; Write time: 255316 03:54:52 INFO - TinderboxPrint: CPU usage
13.1% 03:54:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:54:52 INFO - TinderboxPrint: I/O write bytes / time
430,764,032 / 255,316 03:54:52 INFO - TinderboxPrint: CPU idle
8,262.1 (86.9%) 03:54:52 INFO - TinderboxPrint: CPU user
1,201.8 (12.6%) 03:54:52 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106606592; Read time: 0; Write time: 69756 03:54:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:54:52 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 324157440; Read time: 0; Write time: 185560 03:54:53 INFO - Running post-run listener: _upload_blobber_files 03:54:53 INFO - Blob upload gear active. 03:54:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:54:53 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:54:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:54:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:54 INFO - (blobuploader) - INFO - Done attempting. 03:54:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:01 INFO - (blobuploader) - INFO - Done attempting. 03:55:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:55:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:55:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:01 INFO - (blobuploader) - INFO - Done attempting. 03:55:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:55:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:55:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:02 INFO - (blobuploader) - INFO - Done attempting. 03:55:02 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:02 INFO - Return code: 0 03:55:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bec433c075377cbeb0389c050e7da99b44b0cfc3a443576de3efcc612e957996341ff1c81fa8cdf977fb78a369401d839000b686853f7d898ddf847e817352f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb47a193da1e2f72c16937a061c8c407a65de47b7b9a72f0d0f71595d9d80a5d07a2d0610f1a025c64a768aaee0748a9783defab4032414f88dcca757fb0828a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73787959b102a535eb7c15483764ac1ac13bc448b7fc7694fc54fec4683f0a94b8499c3aa9324a2ab37b378855d5af16bfc1e375ef8de0abdb74b9d321b53419", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a1fa0d2e4ecb16d10aae36a956148b3a5b3a88261aa53990a07cf1c1d2aa31895116fbc91ddf0d4c36e2d193b4333e09129a6936c516d7f2ec85dc47ddbe958"} 03:55:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:02 INFO - Contents: 03:55:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bec433c075377cbeb0389c050e7da99b44b0cfc3a443576de3efcc612e957996341ff1c81fa8cdf977fb78a369401d839000b686853f7d898ddf847e817352f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb47a193da1e2f72c16937a061c8c407a65de47b7b9a72f0d0f71595d9d80a5d07a2d0610f1a025c64a768aaee0748a9783defab4032414f88dcca757fb0828a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73787959b102a535eb7c15483764ac1ac13bc448b7fc7694fc54fec4683f0a94b8499c3aa9324a2ab37b378855d5af16bfc1e375ef8de0abdb74b9d321b53419", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a1fa0d2e4ecb16d10aae36a956148b3a5b3a88261aa53990a07cf1c1d2aa31895116fbc91ddf0d4c36e2d193b4333e09129a6936c516d7f2ec85dc47ddbe958"} 03:55:02 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:02 INFO - Copying logs to upload dir... 03:55:02 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.740161 ========= master_lag: 0.35 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-03 03:55:02.979925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:02.984016) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bec433c075377cbeb0389c050e7da99b44b0cfc3a443576de3efcc612e957996341ff1c81fa8cdf977fb78a369401d839000b686853f7d898ddf847e817352f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb47a193da1e2f72c16937a061c8c407a65de47b7b9a72f0d0f71595d9d80a5d07a2d0610f1a025c64a768aaee0748a9783defab4032414f88dcca757fb0828a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73787959b102a535eb7c15483764ac1ac13bc448b7fc7694fc54fec4683f0a94b8499c3aa9324a2ab37b378855d5af16bfc1e375ef8de0abdb74b9d321b53419", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a1fa0d2e4ecb16d10aae36a956148b3a5b3a88261aa53990a07cf1c1d2aa31895116fbc91ddf0d4c36e2d193b4333e09129a6936c516d7f2ec85dc47ddbe958"} build_url:https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bec433c075377cbeb0389c050e7da99b44b0cfc3a443576de3efcc612e957996341ff1c81fa8cdf977fb78a369401d839000b686853f7d898ddf847e817352f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb47a193da1e2f72c16937a061c8c407a65de47b7b9a72f0d0f71595d9d80a5d07a2d0610f1a025c64a768aaee0748a9783defab4032414f88dcca757fb0828a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73787959b102a535eb7c15483764ac1ac13bc448b7fc7694fc54fec4683f0a94b8499c3aa9324a2ab37b378855d5af16bfc1e375ef8de0abdb74b9d321b53419", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a1fa0d2e4ecb16d10aae36a956148b3a5b3a88261aa53990a07cf1c1d2aa31895116fbc91ddf0d4c36e2d193b4333e09129a6936c516d7f2ec85dc47ddbe958"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:03.016210) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:03.016555) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1501755964.548920-1186991970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:03.100517) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 03:55:03.100999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 03:55:03.101285) ========= ========= Total master_lag: 0.56 =========