builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1464388269.84 results: success (0) buildid: 20160527141751 builduid: e129a3a408ea48afb749986c78feb4e9 revision: 33c4562b47ce2cc5e2988d756c76fa79a36c469a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:09.837242) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:09.837724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:09.838026) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:09.889133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:09.889541) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 15:31:10-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.3M=0s 2016-05-27 15:31:10 (24.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:09.987791) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:09.988101) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020436 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:10.037869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 15:31:10.038214) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 33c4562b47ce2cc5e2988d756c76fa79a36c469a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 33c4562b47ce2cc5e2988d756c76fa79a36c469a --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=e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 15:31:10,734 truncating revision to first 12 chars 2016-05-27 15:31:10,734 Setting DEBUG logging. 2016-05-27 15:31:10,734 attempt 1/10 2016-05-27 15:31:10,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/33c4562b47ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 15:31:11,858 unpacking tar archive at: mozilla-central-33c4562b47ce/testing/mozharness/ program finished with exit code 0 elapsedTime=1.447891 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 15:31:11.498819) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:11.499184) ========= script_repo_revision: 33c4562b47ce2cc5e2988d756c76fa79a36c469a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:11.499603) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:11.499892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 15:31:11.508193) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-27 15:31:11.508605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:31:12 INFO - MultiFileLogger online at 20160527 15:31:12 in /builds/slave/test 15:31:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 15:31:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:31:12 INFO - {'append_to_log': False, 15:31:12 INFO - 'base_work_dir': '/builds/slave/test', 15:31:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:31:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:31:12 INFO - 'branch': 'Firefox-Non-PGO', 15:31:12 INFO - 'buildbot_json_path': 'buildprops.json', 15:31:12 INFO - 'config_files': ('talos/linux_config.py',), 15:31:12 INFO - 'default_actions': ('clobber', 15:31:12 INFO - 'read-buildbot-config', 15:31:12 INFO - 'download-and-extract', 15:31:12 INFO - 'populate-webroot', 15:31:12 INFO - 'create-virtualenv', 15:31:12 INFO - 'install', 15:31:12 INFO - 'run-tests'), 15:31:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:31:12 INFO - 'download_minidump_stackwalk': True, 15:31:12 INFO - 'download_symbols': 'ondemand', 15:31:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:31:12 INFO - 'tooltool.py': '/tools/tooltool.py', 15:31:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:31:12 INFO - '/tools/misc-python/virtualenv.py')}, 15:31:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:31:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:31:12 INFO - 'installer_path': 'installer.exe', 15:31:12 INFO - 'log_level': 'info', 15:31:12 INFO - 'log_name': 'talos', 15:31:12 INFO - 'log_to_console': True, 15:31:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:31:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:31:12 INFO - 'opt_config_files': (), 15:31:12 INFO - 'pip_index': False, 15:31:12 INFO - 'sps_profile': False, 15:31:12 INFO - 'sps_profile_interval': 0, 15:31:12 INFO - 'suite': 'dromaeojs', 15:31:12 INFO - 'system_bits': '32', 15:31:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:31:12 INFO - 'title': 'talos-linux64-ix-067', 15:31:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:31:12 INFO - 'use_talos_json': True, 15:31:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:31:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:31:12 INFO - 'work_dir': 'build'} 15:31:12 INFO - ##### 15:31:12 INFO - ##### Running clobber step. 15:31:12 INFO - ##### 15:31:12 INFO - Running pre-action listener: _resource_record_pre_action 15:31:12 INFO - Running main action method: clobber 15:31:12 INFO - rmtree: /builds/slave/test/build 15:31:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:31:13 INFO - Running post-action listener: _resource_record_post_action 15:31:13 INFO - ##### 15:31:13 INFO - ##### Finished clobber step (success) 15:31:13 INFO - ##### 15:31:13 INFO - ##### 15:31:13 INFO - ##### Running read-buildbot-config step. 15:31:13 INFO - ##### 15:31:13 INFO - Running pre-action listener: _resource_record_pre_action 15:31:13 INFO - Running main action method: read_buildbot_config 15:31:13 INFO - Using buildbot properties: 15:31:13 INFO - { 15:31:13 INFO - "project": "", 15:31:13 INFO - "product": "firefox", 15:31:13 INFO - "script_repo_revision": "production", 15:31:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:31:13 INFO - "repository": "", 15:31:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:31:13 INFO - "buildid": "20160527141751", 15:31:13 INFO - "pgo_build": "False", 15:31:13 INFO - "basedir": "/builds/slave/test", 15:31:13 INFO - "buildnumber": 598, 15:31:13 INFO - "slavename": "talos-linux64-ix-067", 15:31:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:31:13 INFO - "platform": "ubuntu64_hw", 15:31:13 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:31:13 INFO - "branch": "mozilla-central", 15:31:13 INFO - "repo_path": "mozilla-central", 15:31:13 INFO - "revision": "33c4562b47ce2cc5e2988d756c76fa79a36c469a", 15:31:13 INFO - "stage_platform": "linux64", 15:31:13 INFO - "builduid": "e129a3a408ea48afb749986c78feb4e9", 15:31:13 INFO - "slavebuilddir": "test" 15:31:13 INFO - } 15:31:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:31:13 INFO - Running post-action listener: _resource_record_post_action 15:31:13 INFO - ##### 15:31:13 INFO - ##### Finished read-buildbot-config step (success) 15:31:13 INFO - ##### 15:31:13 INFO - ##### 15:31:13 INFO - ##### Running download-and-extract step. 15:31:13 INFO - ##### 15:31:13 INFO - Running pre-action listener: _resource_record_pre_action 15:31:13 INFO - Running main action method: download_and_extract 15:31:13 INFO - mkdir: /builds/slave/test/build/tests 15:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:13 INFO - https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:31:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:31:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:31:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:31:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:31:14 INFO - Downloaded 1361 bytes. 15:31:14 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:31:14 INFO - Using the following test package requirements: 15:31:14 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:31:14 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:31:14 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:31:14 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:14 INFO - u'jsshell-linux-x86_64.zip'], 15:31:14 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:31:14 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:31:14 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:31:14 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:31:14 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:31:14 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:31:14 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:14 INFO - https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:31:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:31:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:31:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:31:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:31:15 INFO - Downloaded 22837929 bytes. 15:31:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:31:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:31:16 INFO - Return code: 0 15:31:16 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:16 INFO - https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:31:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:31:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:31:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:31:18 INFO - Downloaded 22837929 bytes. 15:31:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:31:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:31:19 INFO - Return code: 0 15:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:19 INFO - https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:31:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:31:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:31:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:31:20 INFO - Downloaded 10834034 bytes. 15:31:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:31:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:31:20 INFO - Return code: 0 15:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:20 INFO - https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:31:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:31:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:31:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:31:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:31:22 INFO - Downloaded 54830977 bytes. 15:31:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:31:22 INFO - mkdir: /builds/slave/test/properties 15:31:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:31:22 INFO - Writing to file /builds/slave/test/properties/build_url 15:31:22 INFO - Contents: 15:31:22 INFO - build_url:https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:31:23 INFO - Running post-action listener: _resource_record_post_action 15:31:23 INFO - Running post-action listener: set_extra_try_arguments 15:31:23 INFO - ##### 15:31:23 INFO - ##### Finished download-and-extract step (success) 15:31:23 INFO - ##### 15:31:23 INFO - ##### 15:31:23 INFO - ##### Running populate-webroot step. 15:31:23 INFO - ##### 15:31:23 INFO - Running pre-action listener: _resource_record_pre_action 15:31:23 INFO - Running main action method: populate_webroot 15:31:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:31:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:31:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:31:24 INFO - '--tppagecycles', 15:31:24 INFO - '7'], 15:31:24 INFO - 'tests': ['tsvgm']}}, 15:31:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:31:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:31:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:31:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:31:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:31:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:31:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:24 INFO - 'talos_options': ['--disable-e10s'], 15:31:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:24 INFO - 'talos_options': ['--disable-e10s'], 15:31:24 INFO - 'tests': ['damp', 'tps']}, 15:31:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:24 INFO - 'tests': ['damp', 'tps']}, 15:31:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:31:24 INFO - 'tests': ['dromaeo_dom']}, 15:31:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:31:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:31:24 INFO - 'tests': ['a11yr', 15:31:24 INFO - 'ts_paint', 15:31:24 INFO - 'tpaint', 15:31:24 INFO - 'sessionrestore', 15:31:24 INFO - 'sessionrestore_no_auto_restore', 15:31:24 INFO - 'tabpaint']}, 15:31:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:31:24 INFO - 'ts_paint', 15:31:24 INFO - 'tpaint', 15:31:24 INFO - 'sessionrestore', 15:31:24 INFO - 'sessionrestore_no_auto_restore', 15:31:24 INFO - 'tabpaint']}, 15:31:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:31:24 INFO - 'ts_paint', 15:31:24 INFO - 'tpaint', 15:31:24 INFO - 'sessionrestore', 15:31:24 INFO - 'sessionrestore_no_auto_restore', 15:31:24 INFO - 'tabpaint']}, 15:31:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:31:24 INFO - 'ts_paint', 15:31:24 INFO - 'tpaint', 15:31:24 INFO - 'sessionrestore', 15:31:24 INFO - 'sessionrestore_no_auto_restore', 15:31:24 INFO - 'tabpaint']}, 15:31:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:31:24 INFO - 'tests': ['a11yr', 15:31:24 INFO - 'ts_paint', 15:31:24 INFO - 'tpaint', 15:31:24 INFO - 'sessionrestore', 15:31:24 INFO - 'sessionrestore_no_auto_restore', 15:31:24 INFO - 'tabpaint']}, 15:31:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:31:24 INFO - 'tests': ['a11yr', 15:31:24 INFO - 'ts_paint', 15:31:24 INFO - 'tpaint', 15:31:24 INFO - 'sessionrestore', 15:31:24 INFO - 'sessionrestore_no_auto_restore', 15:31:24 INFO - 'tabpaint']}, 15:31:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:31:24 INFO - 'tests': ['tsvgx', 15:31:24 INFO - 'tsvgr_opacity', 15:31:24 INFO - 'tart', 15:31:24 INFO - 'tscrollx', 15:31:24 INFO - 'cart']}, 15:31:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:31:24 INFO - 'tsvgr_opacity', 15:31:24 INFO - 'tart', 15:31:24 INFO - 'tscrollx', 15:31:24 INFO - 'cart']}, 15:31:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:24 INFO - 'talos_options': ['--disable-e10s'], 15:31:24 INFO - 'tests': ['tp5o']}, 15:31:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:24 INFO - 'tests': ['tp5o']}, 15:31:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:24 INFO - 'talos_options': ['--disable-e10s', 15:31:24 INFO - '--xperf_path', 15:31:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:24 INFO - 'tests': ['tp5n']}, 15:31:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:24 INFO - 'talos_options': ['--xperf_path', 15:31:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:24 INFO - 'tests': ['tp5n']}}, 15:31:24 INFO - 'talos.zip': {'path': '', 15:31:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:31:24 INFO - Running post-action listener: _resource_record_post_action 15:31:24 INFO - ##### 15:31:24 INFO - ##### Finished populate-webroot step (success) 15:31:24 INFO - ##### 15:31:24 INFO - ##### 15:31:24 INFO - ##### Running create-virtualenv step. 15:31:24 INFO - ##### 15:31:24 INFO - Running pre-action listener: _resource_record_pre_action 15:31:24 INFO - Running main action method: create_virtualenv 15:31:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:31:24 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 15:31:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:31:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:31:24 INFO - Using real prefix '/usr' 15:31:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:31:24 INFO - Installing distribute.............................................................................................................................................................................................done. 15:31:26 INFO - Installing pip.................done. 15:31:26 INFO - Return code: 0 15:31:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f4f7cf66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137e9c0>, '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 0x137f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137fd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', '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 15:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:31:26 INFO - Using env: {'DISPLAY': ':0', 15:31:26 INFO - 'HOME': '/home/cltbld', 15:31:26 INFO - 'LANG': 'en_US.UTF-8', 15:31:26 INFO - 'LANGUAGE': 'en_US:en', 15:31:26 INFO - 'LOGNAME': 'cltbld', 15:31:26 INFO - 'MAIL': '/var/mail/cltbld', 15:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:26 INFO - 'MOZ_NO_REMOTE': '1', 15:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:26 INFO - 'NO_EM_RESTART': '1', 15:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:26 INFO - 'PWD': '/builds/slave/test', 15:31:26 INFO - 'SHELL': '/bin/bash', 15:31:26 INFO - 'SHLVL': '1', 15:31:26 INFO - 'TERM': 'linux', 15:31:26 INFO - 'TMOUT': '86400', 15:31:26 INFO - 'USER': 'cltbld', 15:31:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', 15:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:26 INFO - '_': '/tools/buildbot/bin/python'} 15:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:26 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 15:31:26 INFO - Cleaning up... 15:31:26 INFO - Return code: 0 15:31:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f4f7cf66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137e9c0>, '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 0x137f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137fd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', '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 15:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:31:26 INFO - Using env: {'DISPLAY': ':0', 15:31:26 INFO - 'HOME': '/home/cltbld', 15:31:26 INFO - 'LANG': 'en_US.UTF-8', 15:31:26 INFO - 'LANGUAGE': 'en_US:en', 15:31:26 INFO - 'LOGNAME': 'cltbld', 15:31:26 INFO - 'MAIL': '/var/mail/cltbld', 15:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:26 INFO - 'MOZ_NO_REMOTE': '1', 15:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:26 INFO - 'NO_EM_RESTART': '1', 15:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:26 INFO - 'PWD': '/builds/slave/test', 15:31:26 INFO - 'SHELL': '/bin/bash', 15:31:26 INFO - 'SHLVL': '1', 15:31:26 INFO - 'TERM': 'linux', 15:31:26 INFO - 'TMOUT': '86400', 15:31:26 INFO - 'USER': 'cltbld', 15:31:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', 15:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:26 INFO - '_': '/tools/buildbot/bin/python'} 15:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:27 INFO - Downloading/unpacking psutil>=3.1.1 15:31:27 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 15:31:27 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 15:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:27 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 15:31:27 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 15:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:31:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:29 INFO - Installing collected packages: psutil 15:31:29 INFO - Running setup.py install for psutil 15:31:29 INFO - building 'psutil._psutil_linux' extension 15:31:29 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 15:31:29 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 15:31:29 INFO - building 'psutil._psutil_posix' extension 15:31:29 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 15:31:29 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 15:31:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:29 INFO - Successfully installed psutil 15:31:29 INFO - Cleaning up... 15:31:29 INFO - Return code: 0 15:31:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:29 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f4f7cf66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137e9c0>, '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 0x137f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137fd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', '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 15:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:31:29 INFO - Using env: {'DISPLAY': ':0', 15:31:29 INFO - 'HOME': '/home/cltbld', 15:31:29 INFO - 'LANG': 'en_US.UTF-8', 15:31:29 INFO - 'LANGUAGE': 'en_US:en', 15:31:29 INFO - 'LOGNAME': 'cltbld', 15:31:29 INFO - 'MAIL': '/var/mail/cltbld', 15:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:29 INFO - 'MOZ_NO_REMOTE': '1', 15:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:29 INFO - 'NO_EM_RESTART': '1', 15:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:29 INFO - 'PWD': '/builds/slave/test', 15:31:29 INFO - 'SHELL': '/bin/bash', 15:31:29 INFO - 'SHLVL': '1', 15:31:29 INFO - 'TERM': 'linux', 15:31:29 INFO - 'TMOUT': '86400', 15:31:29 INFO - 'USER': 'cltbld', 15:31:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', 15:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:29 INFO - '_': '/tools/buildbot/bin/python'} 15:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:31:29 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 15:31:29 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 15:31:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:29 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 15:31:29 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 15:31:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:31:32 INFO - Installing collected packages: mozsystemmonitor 15:31:32 INFO - Running setup.py install for mozsystemmonitor 15:31:32 INFO - Successfully installed mozsystemmonitor 15:31:32 INFO - Cleaning up... 15:31:32 INFO - Return code: 0 15:31:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f4f7cf66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137e9c0>, '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 0x137f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137fd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', '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 15:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:31:32 INFO - Using env: {'DISPLAY': ':0', 15:31:32 INFO - 'HOME': '/home/cltbld', 15:31:32 INFO - 'LANG': 'en_US.UTF-8', 15:31:32 INFO - 'LANGUAGE': 'en_US:en', 15:31:32 INFO - 'LOGNAME': 'cltbld', 15:31:32 INFO - 'MAIL': '/var/mail/cltbld', 15:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:32 INFO - 'MOZ_NO_REMOTE': '1', 15:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:32 INFO - 'NO_EM_RESTART': '1', 15:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:32 INFO - 'PWD': '/builds/slave/test', 15:31:32 INFO - 'SHELL': '/bin/bash', 15:31:32 INFO - 'SHLVL': '1', 15:31:32 INFO - 'TERM': 'linux', 15:31:32 INFO - 'TMOUT': '86400', 15:31:32 INFO - 'USER': 'cltbld', 15:31:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', 15:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:32 INFO - '_': '/tools/buildbot/bin/python'} 15:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:32 INFO - Downloading/unpacking blobuploader==1.2.4 15:31:32 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 15:31:32 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 15:31:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:32 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 15:31:32 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 15:31:34 INFO - Downloading blobuploader-1.2.4.tar.gz 15:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:31:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:31:34 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 15:31:34 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 15:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:34 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 15:31:34 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 15:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:31:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:31:35 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 15:31:35 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 15:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:35 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 15:31:35 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 15:31:35 INFO - Downloading docopt-0.6.1.tar.gz 15:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:31:35 INFO - Installing collected packages: blobuploader, requests, docopt 15:31:35 INFO - Running setup.py install for blobuploader 15:31:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:31:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:31:35 INFO - Running setup.py install for requests 15:31:35 INFO - Running setup.py install for docopt 15:31:36 INFO - Successfully installed blobuploader requests docopt 15:31:36 INFO - Cleaning up... 15:31:36 INFO - Return code: 0 15:31:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:36 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f4f7cf66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137e9c0>, '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 0x137f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137fd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', '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 15:31:36 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:31:36 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:31:36 INFO - Using env: {'DISPLAY': ':0', 15:31:36 INFO - 'HOME': '/home/cltbld', 15:31:36 INFO - 'LANG': 'en_US.UTF-8', 15:31:36 INFO - 'LANGUAGE': 'en_US:en', 15:31:36 INFO - 'LOGNAME': 'cltbld', 15:31:36 INFO - 'MAIL': '/var/mail/cltbld', 15:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:36 INFO - 'MOZ_NO_REMOTE': '1', 15:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:36 INFO - 'NO_EM_RESTART': '1', 15:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:36 INFO - 'PWD': '/builds/slave/test', 15:31:36 INFO - 'SHELL': '/bin/bash', 15:31:36 INFO - 'SHLVL': '1', 15:31:36 INFO - 'TERM': 'linux', 15:31:36 INFO - 'TMOUT': '86400', 15:31:36 INFO - 'USER': 'cltbld', 15:31:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', 15:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:36 INFO - '_': '/tools/buildbot/bin/python'} 15:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:36 INFO - Running setup.py (path:/tmp/pip-b3sk6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:36 INFO - Running setup.py (path:/tmp/pip-XKj2A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:36 INFO - Running setup.py (path:/tmp/pip-yQKz9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:36 INFO - Running setup.py (path:/tmp/pip-RshKvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:36 INFO - Running setup.py (path:/tmp/pip-XSHkS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:36 INFO - Running setup.py (path:/tmp/pip-N2lVc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:36 INFO - Running setup.py (path:/tmp/pip-JbHNZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:36 INFO - Running setup.py (path:/tmp/pip-kKS8gN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:36 INFO - Running setup.py (path:/tmp/pip-nmozvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:36 INFO - Running setup.py (path:/tmp/pip-Kj4p02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:37 INFO - Running setup.py (path:/tmp/pip-cA6TDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:37 INFO - Running setup.py (path:/tmp/pip-fIFqgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:37 INFO - Running setup.py (path:/tmp/pip-mh_QZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:37 INFO - Running setup.py (path:/tmp/pip-91zA55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:37 INFO - Running setup.py (path:/tmp/pip-1CUIvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:37 INFO - Running setup.py (path:/tmp/pip-wZKBDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:37 INFO - Running setup.py (path:/tmp/pip-lf4Ybv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:31:37 INFO - Running setup.py install for manifestparser 15:31:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:31:37 INFO - Running setup.py install for mozcrash 15:31:37 INFO - Running setup.py install for mozdebug 15:31:37 INFO - Running setup.py install for mozdevice 15:31:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:31:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:31:37 INFO - Running setup.py install for mozfile 15:31:38 INFO - Running setup.py install for mozhttpd 15:31:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:31:38 INFO - Running setup.py install for mozinfo 15:31:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:31:38 INFO - Running setup.py install for mozInstall 15:31:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:31:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:31:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:31:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:31:38 INFO - Running setup.py install for mozleak 15:31:38 INFO - Running setup.py install for mozlog 15:31:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:31:38 INFO - Running setup.py install for moznetwork 15:31:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:31:38 INFO - Running setup.py install for mozprocess 15:31:38 INFO - Running setup.py install for mozprofile 15:31:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:31:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:31:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:31:38 INFO - Running setup.py install for mozrunner 15:31:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:31:39 INFO - Running setup.py install for mozscreenshot 15:31:39 INFO - Running setup.py install for moztest 15:31:39 INFO - Running setup.py install for mozversion 15:31:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:31:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:39 INFO - Cleaning up... 15:31:39 INFO - Return code: 0 15:31:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f4f7cf66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137e9c0>, '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 0x137f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137fd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', '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 15:31:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:31:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:31:39 INFO - Using env: {'DISPLAY': ':0', 15:31:39 INFO - 'HOME': '/home/cltbld', 15:31:39 INFO - 'LANG': 'en_US.UTF-8', 15:31:39 INFO - 'LANGUAGE': 'en_US:en', 15:31:39 INFO - 'LOGNAME': 'cltbld', 15:31:39 INFO - 'MAIL': '/var/mail/cltbld', 15:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:39 INFO - 'MOZ_NO_REMOTE': '1', 15:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:39 INFO - 'NO_EM_RESTART': '1', 15:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:39 INFO - 'PWD': '/builds/slave/test', 15:31:39 INFO - 'SHELL': '/bin/bash', 15:31:39 INFO - 'SHLVL': '1', 15:31:39 INFO - 'TERM': 'linux', 15:31:39 INFO - 'TMOUT': '86400', 15:31:39 INFO - 'USER': 'cltbld', 15:31:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', 15:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:39 INFO - '_': '/tools/buildbot/bin/python'} 15:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:39 INFO - Running setup.py (path:/tmp/pip-9znunD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:39 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)) 15:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:39 INFO - Running setup.py (path:/tmp/pip-G3twXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 15:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:39 INFO - Running setup.py (path:/tmp/pip-I0bsVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:39 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)) 15:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:39 INFO - Running setup.py (path:/tmp/pip-piRHUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 15:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:39 INFO - Running setup.py (path:/tmp/pip-po_OIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:39 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)) 15:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:39 INFO - Running setup.py (path:/tmp/pip-DKfruM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:40 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)) 15:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:40 INFO - Running setup.py (path:/tmp/pip-tVP9vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 15:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:40 INFO - Running setup.py (path:/tmp/pip-PitTFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 15:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:40 INFO - Running setup.py (path:/tmp/pip-pSOpaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:40 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)) 15:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:40 INFO - Running setup.py (path:/tmp/pip-9SUMGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 15:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:40 INFO - Running setup.py (path:/tmp/pip-Nh4bmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:40 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)) 15:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:40 INFO - Running setup.py (path:/tmp/pip-6oAOBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 15:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:40 INFO - Running setup.py (path:/tmp/pip-Vcf6V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:40 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)) 15:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:40 INFO - Running setup.py (path:/tmp/pip-SjrCjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 15:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:40 INFO - Running setup.py (path:/tmp/pip-iYUnas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:40 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)) 15:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:40 INFO - Running setup.py (path:/tmp/pip-5x_DnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 15:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:40 INFO - Running setup.py (path:/tmp/pip-R6wzI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:40 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)) 15:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:31:40 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)) 15:31:40 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:31:40 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:31:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31:40 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 15:31:40 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 15:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:40 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 15:31:40 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 15:31:42 INFO - Downloading blessings-1.6.tar.gz 15:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:42 INFO - Installing collected packages: blessings 15:31:42 INFO - Running setup.py install for blessings 15:31:42 INFO - Successfully installed blessings 15:31:42 INFO - Cleaning up... 15:31:43 INFO - Return code: 0 15:31:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:43 INFO - Reading from file tmpfile_stdout 15:31:43 INFO - Current package versions: 15:31:43 INFO - argparse == 1.2.1 15:31:43 INFO - blessings == 1.6 15:31:43 INFO - blobuploader == 1.2.4 15:31:43 INFO - docopt == 0.6.1 15:31:43 INFO - manifestparser == 1.1 15:31:43 INFO - mozInstall == 1.12 15:31:43 INFO - mozcrash == 0.17 15:31:43 INFO - mozdebug == 0.1 15:31:43 INFO - mozdevice == 0.48 15:31:43 INFO - mozfile == 1.2 15:31:43 INFO - mozhttpd == 0.7 15:31:43 INFO - mozinfo == 0.9 15:31:43 INFO - mozleak == 0.1 15:31:43 INFO - mozlog == 3.2 15:31:43 INFO - moznetwork == 0.27 15:31:43 INFO - mozprocess == 0.22 15:31:43 INFO - mozprofile == 0.28 15:31:43 INFO - mozrunner == 6.11 15:31:43 INFO - mozscreenshot == 0.1 15:31:43 INFO - mozsystemmonitor == 0.3 15:31:43 INFO - moztest == 0.7 15:31:43 INFO - mozversion == 1.4 15:31:43 INFO - psutil == 3.1.1 15:31:43 INFO - requests == 1.2.3 15:31:43 INFO - wsgiref == 0.1.2 15:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f4f7cf66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137e9c0>, '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 0x137f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137fd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', '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 15:31:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:31:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:31:43 INFO - Using env: {'DISPLAY': ':0', 15:31:43 INFO - 'HOME': '/home/cltbld', 15:31:43 INFO - 'LANG': 'en_US.UTF-8', 15:31:43 INFO - 'LANGUAGE': 'en_US:en', 15:31:43 INFO - 'LOGNAME': 'cltbld', 15:31:43 INFO - 'MAIL': '/var/mail/cltbld', 15:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:43 INFO - 'MOZ_NO_REMOTE': '1', 15:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:43 INFO - 'NO_EM_RESTART': '1', 15:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:43 INFO - 'PWD': '/builds/slave/test', 15:31:43 INFO - 'SHELL': '/bin/bash', 15:31:43 INFO - 'SHLVL': '1', 15:31:43 INFO - 'TERM': 'linux', 15:31:43 INFO - 'TMOUT': '86400', 15:31:43 INFO - 'USER': 'cltbld', 15:31:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', 15:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:43 INFO - '_': '/tools/buildbot/bin/python'} 15:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:43 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)) 15:31:43 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)) 15:31:43 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)) 15:31:43 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)) 15:31:43 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)) 15:31:43 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)) 15:31:43 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)) 15:31:43 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)) 15:31:43 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)) 15:31:43 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)) 15:31:43 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)) 15:31:43 INFO - Cleaning up... 15:31:43 INFO - Return code: 0 15:31:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f4f7cf66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137e9c0>, '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 0x137f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137fd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', '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 15:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:31:43 INFO - Using env: {'DISPLAY': ':0', 15:31:43 INFO - 'HOME': '/home/cltbld', 15:31:43 INFO - 'LANG': 'en_US.UTF-8', 15:31:43 INFO - 'LANGUAGE': 'en_US:en', 15:31:43 INFO - 'LOGNAME': 'cltbld', 15:31:43 INFO - 'MAIL': '/var/mail/cltbld', 15:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:43 INFO - 'MOZ_NO_REMOTE': '1', 15:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:43 INFO - 'NO_EM_RESTART': '1', 15:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:43 INFO - 'PWD': '/builds/slave/test', 15:31:43 INFO - 'SHELL': '/bin/bash', 15:31:43 INFO - 'SHLVL': '1', 15:31:43 INFO - 'TERM': 'linux', 15:31:43 INFO - 'TMOUT': '86400', 15:31:43 INFO - 'USER': 'cltbld', 15:31:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', 15:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:43 INFO - '_': '/tools/buildbot/bin/python'} 15:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:43 INFO - Downloading/unpacking jsonschema 15:31: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 15:31: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 15:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31: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 15:31: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 15:31:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:31:45 INFO - Downloading/unpacking functools32 (from jsonschema) 15:31: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 15:31: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 15:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31: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 15:31: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 15:31:45 INFO - Downloading functools32-3.2.3-2.tar.gz 15:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:31:45 INFO - warning: no files found matching '*.txt' 15:31:45 INFO - no previously-included directories found matching 'build' 15:31:45 INFO - no previously-included directories found matching 'dist' 15:31:45 INFO - no previously-included directories found matching '.git*' 15:31:45 INFO - Installing collected packages: jsonschema, functools32 15:31:45 INFO - Running setup.py install for functools32 15:31:45 INFO - warning: no files found matching '*.txt' 15:31:45 INFO - no previously-included directories found matching 'build' 15:31:45 INFO - no previously-included directories found matching 'dist' 15:31:45 INFO - no previously-included directories found matching '.git*' 15:31:45 INFO - Successfully installed jsonschema functools32 15:31:45 INFO - Cleaning up... 15:31:46 INFO - Return code: 0 15:31:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f7cf66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ef770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137e9c0>, '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 0x137f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137fd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', '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 15:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:31:46 INFO - Using env: {'DISPLAY': ':0', 15:31:46 INFO - 'HOME': '/home/cltbld', 15:31:46 INFO - 'LANG': 'en_US.UTF-8', 15:31:46 INFO - 'LANGUAGE': 'en_US:en', 15:31:46 INFO - 'LOGNAME': 'cltbld', 15:31:46 INFO - 'MAIL': '/var/mail/cltbld', 15:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:46 INFO - 'MOZ_NO_REMOTE': '1', 15:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:46 INFO - 'NO_EM_RESTART': '1', 15:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:46 INFO - 'PWD': '/builds/slave/test', 15:31:46 INFO - 'SHELL': '/bin/bash', 15:31:46 INFO - 'SHLVL': '1', 15:31:46 INFO - 'TERM': 'linux', 15:31:46 INFO - 'TMOUT': '86400', 15:31:46 INFO - 'USER': 'cltbld', 15:31:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', 15:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:46 INFO - '_': '/tools/buildbot/bin/python'} 15:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:46 INFO - Downloading/unpacking flake8 15:31: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 15:31: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 15:31:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31: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 15:31: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 15:31:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:31:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:31: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 15:31: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 15:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31: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 15:31: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 15:31:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:31:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:31: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 15:31: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 15:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31: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 15:31: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 15:31:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:31: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 15:31: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 15:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31: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 15:31: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 15:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:31:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:31:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:31:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:31:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:31:48 INFO - no previously-included directories found matching 'docs/_build' 15:31:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:31:48 INFO - Running setup.py install for pep8 15:31:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:31:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:31:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:31:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:31:49 INFO - no previously-included directories found matching 'docs/_build' 15:31:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:31:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:31:49 INFO - Cleaning up... 15:31:49 INFO - Return code: 0 15:31:49 INFO - Running post-action listener: _resource_record_post_action 15:31:49 INFO - Running post-action listener: _start_resource_monitoring 15:31:49 INFO - Starting resource monitoring. 15:31:49 INFO - ##### 15:31:49 INFO - ##### Finished create-virtualenv step (success) 15:31:49 INFO - ##### 15:31:49 INFO - ##### 15:31:49 INFO - ##### Running install step. 15:31:49 INFO - ##### 15:31:49 INFO - Running pre-action listener: _resource_record_pre_action 15:31:49 INFO - Running main action method: install 15:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:49 INFO - Reading from file tmpfile_stdout 15:31:49 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:49 INFO - Reading from file tmpfile_stdout 15:31:49 INFO - Output received: 15:31:49 INFO - Usage: mozinstall [options] installer 15:31:49 INFO - Options: 15:31:49 INFO - -h, --help show this help message and exit 15:31:49 INFO - -d DEST, --destination=DEST 15:31:49 INFO - Directory to install application into. [default: 15:31:49 INFO - "/builds/slave/test"] 15:31:49 INFO - --app=APP Application being installed. [default: firefox] 15:31:49 INFO - mkdir: /builds/slave/test/build/application 15:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:32:05 INFO - Reading from file tmpfile_stdout 15:32:05 INFO - Output received: 15:32:05 INFO - /builds/slave/test/build/application/firefox/firefox 15:32:05 INFO - Running post-action listener: _resource_record_post_action 15:32:05 INFO - ##### 15:32:05 INFO - ##### Finished install step (success) 15:32:05 INFO - ##### 15:32:05 INFO - ##### 15:32:05 INFO - ##### Running run-tests step. 15:32:05 INFO - ##### 15:32:05 INFO - Running pre-action listener: _resource_record_pre_action 15:32:05 INFO - Running main action method: run_tests 15:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:32:05 INFO - Python 2.7.3 15:32:05 INFO - Return code: 0 15:32:05 INFO - grabbing minidump binary from tooltool 15:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:05 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 0x137e9c0>, '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 0x137f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:32:05 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 15:32:05 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 15:32:05 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 15:32:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:32:05 INFO - Return code: 0 15:32:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:32:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:32:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:32:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:32:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:32:06 INFO - Return code: 0 15:32:06 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:32:06 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:32:06 INFO - Using env: {'DISPLAY': ':0', 15:32:06 INFO - 'HOME': '/home/cltbld', 15:32:06 INFO - 'LANG': 'en_US.UTF-8', 15:32:06 INFO - 'LANGUAGE': 'en_US:en', 15:32:06 INFO - 'LOGNAME': 'cltbld', 15:32:06 INFO - 'MAIL': '/var/mail/cltbld', 15:32:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:32:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:06 INFO - 'MOZ_NO_REMOTE': '1', 15:32:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:06 INFO - 'NO_EM_RESTART': '1', 15:32:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:06 INFO - 'PWD': '/builds/slave/test', 15:32:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:32:06 INFO - 'SHELL': '/bin/bash', 15:32:06 INFO - 'SHLVL': '1', 15:32:06 INFO - 'TERM': 'linux', 15:32:06 INFO - 'TMOUT': '86400', 15:32:06 INFO - 'USER': 'cltbld', 15:32:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664', 15:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:06 INFO - '_': '/tools/buildbot/bin/python'} 15:32:06 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:32:06 INFO - mozversion application_buildid: 20160527141751 15:32:06 INFO - mozversion application_changeset: 33c4562b47ce2cc5e2988d756c76fa79a36c469a 15:32:06 INFO - mozversion application_display_name: Nightly 15:32:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:32:06 INFO - mozversion application_name: Firefox 15:32:06 INFO - mozversion application_remotingname: firefox 15:32:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:32:06 INFO - mozversion application_vendor: Mozilla 15:32:06 INFO - mozversion application_version: 49.0a1 15:32:06 INFO - mozversion platform_buildid: 20160527141751 15:32:06 INFO - mozversion platform_changeset: 33c4562b47ce2cc5e2988d756c76fa79a36c469a 15:32:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:32:06 INFO - mozversion platform_version: 49.0a1 15:32:06 INFO - using testdate: 1464388326 15:32:06 INFO - actual date: 1464388326 15:32:06 INFO - starting webserver on 'localhost:34321' 15:32:06 INFO - SUITE-START | Running 2 tests 15:32:06 INFO - TEST-START | dromaeo_css 15:32:06 INFO - operating with platform_type : linux_ 15:32:06 INFO - Initialising browser for dromaeo_css test... 15:32:06 INFO - TEST-INFO | started process 20264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKxqVy/profile http://localhost:34321/getInfo.html) 15:32:10 INFO - PROCESS | 20264 | __metrics Screen width/height:1600/1200 15:32:10 INFO - PROCESS | 20264 | colorDepth:24 15:32:10 INFO - PROCESS | 20264 | Browser inner width/height: 1024/697 15:32:10 INFO - PROCESS | 20264 | __metrics 15:32:10 ERROR - PROCESS | 20264 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:32:11 INFO - TEST-INFO | 20264: exit 0 15:32:11 INFO - Browser initialized. 15:32:11 INFO - Running cycle 1/1 for dromaeo_css test... 15:32:11 INFO - TEST-INFO | started process 20346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKxqVy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:23 INFO - PROCESS | 20346 | RSS: Main: 157417472 15:32:23 INFO - PROCESS | 20346 | 15:33:15 INFO - PROCESS | 20346 | 1464388395417 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:35:26 INFO - PROCESS | 20346 | Cycle 1(1): loaded http://localhost:34321/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34321/tests/dromaeo/cssquery-ext.html) 15:35:28 INFO - PROCESS | 20346 | RSS: Main: 278253568 15:35:28 INFO - PROCESS | 20346 | 15:38:30 INFO - PROCESS | 20346 | Cycle 1(1): loaded http://localhost:34321/tests/dromaeo/cssquery-ext.html (next: http://localhost:34321/tests/dromaeo/cssquery-jquery.html) 15:38:31 INFO - PROCESS | 20346 | RSS: Main: 244555776 15:38:31 INFO - PROCESS | 20346 | 15:41:33 INFO - PROCESS | 20346 | Cycle 1(1): loaded http://localhost:34321/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34321/tests/dromaeo/cssquery-mootools.html) 15:41:34 INFO - PROCESS | 20346 | RSS: Main: 250290176 15:41:34 INFO - PROCESS | 20346 | 15:44:36 INFO - PROCESS | 20346 | Cycle 1(1): loaded http://localhost:34321/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34321/tests/dromaeo/cssquery-prototype.html) 15:44:37 INFO - PROCESS | 20346 | RSS: Main: 243064832 15:44:37 INFO - PROCESS | 20346 | 15:47:39 INFO - PROCESS | 20346 | Cycle 1(1): loaded http://localhost:34321/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34321/tests/dromaeo/cssquery-yui.html) 15:47:40 INFO - PROCESS | 20346 | RSS: Main: 222605312 15:47:40 INFO - PROCESS | 20346 | 15:50:43 INFO - PROCESS | 20346 | Cycle 1(1): loaded http://localhost:34321/tests/dromaeo/cssquery-yui.html (next: http://localhost:34321/tests/dromaeo/cssquery-dojo.html) 15:50:43 INFO - PROCESS | 20346 | RSS: Main: 310263808 15:50:43 INFO - PROCESS | 20346 | 15:50:43 INFO - PROCESS | 20346 | __start_tp_report 15:50:43 INFO - PROCESS | 20346 | _x_x_mozilla_page_load 15:50:43 INFO - PROCESS | 20346 | _x_x_mozilla_page_load_details 15:50:43 INFO - PROCESS | 20346 | |i|pagename|runs| 15:50:43 INFO - PROCESS | 20346 | |0;dojo.html;2697.298702337392;2702.6488151611516;2712.918612441625;2742.355546446586;2766.7233276672337;4622.445306563209;4717.4574923883765;4774.641901857357;4817.662763606545;4854.393200849894;4734.147853386389;4770.7376094314795;4771.665983381165;4786.162421576219;4791.952080479195;4180.352045432963;4343.435353404053;4423;4453.487848897385;4559.110973360196;4457.041736026754;4500.099980003996;4514.571115743999;4520.028193938303;4549.1129229800035;4316.899190706381;4319.524852266248;4351.390805287262;4358;4379.8467053653285;4352.825886964518;4369.12617476506;4372.038151606642;4422.027154026141;4449.621782148522;4399.934000989988;4413.646908247365;4432.047109871361;4456.064226512436;4469.217886869785;4633.351330813689;4633.652476064309;4655.045715628322;4679.64902632304;4687.671862969593;5179.145441002268;5181.792728290864;5199.454057324002;5202.635815492917;5203.4796520348045;5194.402643695986;5200.24596433515;5217.060929032773;5231.581473482112;5234.581233501311;4613.215753321943;4755.358026666425;4804.5195480451675;4806.399200099988;4863.708177509361;5327.786888524415;5329.067413202674;5331.920021199685;5352.6253162279045;5358.089124848785;5099.69401835891;5104.5150710683165;5120.539151476385;5128.25640282157;5131.179011358165;5056.292119103328;5121.4622464641425;5188.403333616607;5188.403333616682;5212.947870521246;5145.228215767665;5149.124648809711;5149.9742501287255;5152.4847515248175;5190.92213616796;4999.65002449825;5137.794488220504;5147.845564633067;5149.330587023663;5150.48495150482;4272.5727427257025;4293.892652683646;4305.763183024964;4342.869713908588;4352.368906508538;3758.229562939591;3769.189624230749;3771.2268984858038;3801.239752049601;3816.0459885028745;4398.846040388571;4400.581944715247;4401.977990110093;4444.6666500012625;4450.132224216311;4973.8010479581135;5063.645544811828;5108.897822043613;5126.6923984561045;5147.0735267651435;4391.077873646506;4394.538573449806;4402.823887044482;4406.801693923781;4451.421315229064;4480.126375356839;4589.518100599389;4595.425571803525;4599.149157405891;4643.512431194744;4775.092732380836;4783.6651434399255;4820.542048505386;4826.541478559531;4826.903461930812;5105.5149760772665;5135.38375394955;5139.665921715076;5140.537351638371;5194.844154675366;4662.696924699883;4776.116418462596;4786.688865223749;4813.518648135158;4875.561199492063;5009.173486374707;5042.621803364689;5068.670536415121;5069.493050694901;5112.105381558287;5131.640785145153;5132.050570644443;5134.640575159703;5148.510891465305;5188.403333616682;4858.975705121452;4865.9270110947655;4899.804007839646;4971.055499455092;5001.374828146481;4916.631252655993;4929.088118698052;4929.457759646508;4934.8766280843265;4965.1311020571975;4853.150698627796;4858.611311095033;4894.902101958012;4915.459299476983;4946.975265123651;4843.515648435128;4961.355023846877;4985.601151907911;5031.195008798721;5039.697618142924;4900.240462728283;4908.852734417973;4943.2585112233455;4978.8257410990445;4982.227754698028 15:50:43 INFO - PROCESS | 20346 | |1;ext.html;541.6804085589501;599.2688919518187;601.9668918209499;603.9969800150999;611.1566038866365;27070.864645676767;27512.587311190324;29184.416311673755;29291.56062659059;29314.267143321427;29528.704712952866;41265.38101928474;42090;42267.154656906845;45475.31787023197;7864.646090925908;8004.279614834663;8010.67957281708;8020.037595488549;8022.1175670676175;7774.067111946574;7898.605069746518;7902.051753789553;7903;7903.960480197591;7933.16701746317;7979.082405523381;7983.920160798376;7985.4010949178755;7989.6005199740075;7863.095743989428;7921.841563168704;7926.841463170762;7926.881096783524;7928.524288542648;7865.2134786521465;7942.245486678757;7944.682212711485;7950.642221100006;7952.403569732235;38249.235015299535;38733.80633096817;38793;38801.805990969864;38848.22303553941;3040.787144899858;3274.115988683066;3415.9146021349416;3452.879149229765;3608.9639103608893;29236;29620.555691664642;29922.85038574815;30233.848830755705;30955.380892382025;3038.103759390985;3078.7998780079447;3107.4717298059386;3124.4844600640868;3177.5551422800827;247982;248422;248803;249655;249695;53651;53711;54116;54118;54186.72906635442;33428.1642958928;34444;34461.65538344585;35935.64064359323;35965;13767.105138165987;13886.166829990232;13953.790693139612;13957.58127256184;13986.860131398556;10845.83731244032;10951.616693415852;10965.56137754497;10972.945135274273;10973.177011724152;19189.136488858036;19251.22995080209;19276.710849337273;19315.227390904205;19340.806591934183;6724.798256052326;6955.339242771928;6994.860102797916;7145.749898753519;7265.564066156047;790.9367250619937;892.9732108036769;894.8568229083315;930.06993006993;959.1511512311655;28583.71416285852;28706.856465717956;28773.856130719632;29351.85324073366;29489.705102948697;739.2570466680951;985.3053597213947;988.2439933450916;995.2833959549113;1048.0672201740458;14831.629209269855;15205.847941520444;15391.307391167424;15439.691206175814;15585.610359741097;377601;377723;380049;380252;381373;48759;48984;49070.75464622725;49236.75381623141;49306.50693493091;1084.6203828660064;1195.0738177912187;1216.7019080325376;1220.5239956417004;1221.084186859873;28077.438451231268;29074;29097.709022910345;29238.41523169482;29678.554821678124;42414.1517169661;43059.138817224106;43078;43112.35331470093;43146.56853431551;285265;288760;288923;289311;289563;22451.21420750266;23102.884485577466;23139;24334.878325608257;24350;41955.58044419517;43453.34819977766;44686.3297050538;46706.53293467158;47454.28818567655;37782.81108594439;37828.43257351087;38023.239535209694;38056;38539;35664.880857188175;36635.81682091572;36969.63030369662;37248.62751372452;37282.62717372792;35739.64260357363;36270;36316.27367452583;36506;36867.81566092152;32734;32997;33199.502007469426;33966.32067358688;33985.15037124092;25063.373415664755;25301.62047569325;25315.87342063278;25584.360390990376;25605.487890242464 15:50:43 INFO - PROCESS | 20346 | |2;jquery.html;374.998125009375;375.61874697182355;389.1322351156922;398.83647704441165;399.40289267545023;15933;16649.1675416229;17386.82613173868;17491.12544372781;17527.298908043664;14073.859261407382;16269.349226030974;16762.58093547662;16795.32818687251;16807.579810504714;4523.705959112664;4732.2428411454;4771.165046116933;4775.952240477603;4781.330613714083;3426.8629254829902;5283.260343551906;5566.2207290979295;5584.664920104807;5586.664800111986;5508.256385387981;5561.833145005636;5564.165375193713;5580.414056524068;5590.385057643676;6121.632702037892;6136.723847426876;6176.042713379434;6221.222347206599;6235.376462353751;3403.23427228874;3585.4442561403025;3588.946165807515;3615.9638403616154;5049.394072711299;11892.929636332685;12155.513779448811;12514.81227781584;12551.748965020648;12653;1811.5018369948239;1857.6749068912886;1914.301280032792;1996.3112726109468;2327.592671282519;8774.298056155556;9450.149486546175;9454.33819632626;9573.090556397132;9732.026797320212;1510.8715759160484;1695.7795486586788;1748.4754573627988;1800.79290881549;1803.3958623861022;65909;66292.6685366575;67291;68658.65670671665;70960.29039709589;9805.558749856273;9928.453935033642;10134.189264858793;10476.371417714961;11039.613613523488;14278.714425711636;14327.212003339708;14381.712365752835;14392.640183995274;14393.42426302957;7115.857682846417;7289.890651640229;7303.415726741848;7321.597312147883;7344.306905068218;6590.505712071518;6637.103990961158;6746.392824645805;6842.418394436529;6869.587824730532;4197.454330936958;4204.26425375558;4250.257394468254;4291.098869237495;4472.239719247736;1636.8526832585123;1739.4520725971279;1771.1498480729065;1778.5642517583276;1867.1784414857418;775.5463054113294;884.3102380143498;915.8717779510873;978.2320878110792;979.8775153105862;16129;16470;16654.83345166557;16800.915995419946;17218.913905430392;845.0830848529414;868.700298397052;889.7908991387019;891.7101941868918;916.6058594804298;9144.679936202201;9146.588403521857;9505.429674219431;9511.476868772284;9649.372790768577;366354;379127;384589;385747;387217;75384;75880.62059689667;76120;76269;76590;882.1487264789381;884.7390019944132;904.6878826804742;912.8174365127002;914.6524320758069;14750.262486875828;14867.702645947236;14881.851181488046;15023.6995260092;15145.242737863284;32889.67110328866;33667.32665346728;34963;35119.29761404809;35939;46867.296990544484;47024.76487617677;49071.50928490812;49142.262866057754;49559;7391;7506.662200200894;7513.962430187814;7520.8871866920945;7544.8491030180185;9421.246300295823;9549.522523873917;10109.64616238428;11416.429178541206;11685.415729213675;8683.480390931689;9177.908220917705;9320.72037838866;9346.252299816135;9573.760655983377;10086.546105425126;10204.2346823987;10236.48817559134;10246.180305575386;10374.325668831501;8785.824283514421;9082.636694532144;9308.534573271445;9557.426554406758;9659.227261819178;7522.623868806429;7583;7663.31030207284;7706.190849960673;7794.337481314152;8739.475631462132;9388.718338449857;9414.67048653294;9432;9457.668981585612 15:50:43 INFO - PROCESS | 20346 | |3;mootools.html;1217.689489180259;1392.805007298978;1465.7215129125466;1551.852574005469;1760.7358896165574;6671;7510.023696919399;7751.069871615407;7754.767356979286;7951.244631759973;7664;7873;7893.526388416699;7894.250046245612;7896.486728362653;1910.751602291707;2147.5060736030723;2202.218212534551;2227.209340684058;2239.0931672672514;2266.546690661866;2296.4258935266184;2296.540691861626;2297.058206135485;2297.9655305170436;2224.3882932193696;2231.1187081102953;2259.4916143867663;2261.7738226177335;2264.4565304326925;1844.0871768474624;2059.3513043391285;2097.465146387669;2146.205903815598;2146.720926279589;2165.155589320166;2169.9783002169934;2182.432567532437;2182.847200695936;2189.627763280246;7833.686652533892;7914;7919.128895821455;7919.485233459806;7927.8810817837775;4682.906341873144;4817.301491283744;4820.590249828769;4820.6143508519235;4821.132196204681;2822.0969289827262;2936.4861149298786;2977.776666749981;2986.238509180167;2990.3271763853177;898.3486971945352;900.9504477253748;905.6558507767072;917.2982668258787;918.912703293186;10711.357318560833;10711.571537138505;10738.677839664744;10738.731531711692;10739.40933248671;4157.168566286755;4278.764667943231;4351.782410879443;4369.257226271541;4372.081862808782;9165.17513423795;9210.078992100736;9222.907770922338;9234.907650923406;9237.676681316121;4802.687825291415;4803.879903002383;4805.471398146201;4807.014562014779;4816.060868130681;3794.2601192767147;4094.3653733671326;4203.180379825904;4212.410262563182;4284.764337961442;3587.874424395186;3660.743747937619;3664.358737220976;3689.870854520079;3772.2832661794173;1142.5886680794906;1182.8876256755595;1205.0781152418408;1206.6681662542871;1225.3138242584182;788.1487992967582;801.7234054251275;879.8856148700628;895.0780695883251;916.7249825052457;5272.314599102092;5419.214213938957;5423.945760542423;5430.864228394322;5679.488846003879;832.9167083291622;854.6837670062117;866.1511718515764;867.5618812499647;916.0610374366328;3608.440691692792;3623.6376362363553;3739.5325584301963;3742.5696044954634;3768.246350729865;9428.669996550088;9792.804143917081;9831.80336393268;9834.262430317754;9871.75320616976;9442.339036267533;9643.27675424346;9716.465594392235;9730.513474326255;9752.951235243778;7055.611941343275;7073;7150.356467917808;7156.821079473055;7171.856562868714;5050;5155.2782610435315;5230.607704422259;5241.44964778708;5288.206768984529;8751.912480875364;8767.29861611057;8792.516411597424;8877.378583499092;8886.955565222133;8588.65645374178;8980.820383592421;8989.595468203815;8990.640374384951;8998.685046023358;5681.4034526374135;6249.875002500015;6407.359264073555;6486.1243732097455;6496.610203387811;7549.6225188739245;7571.583562904093;7615.885761713468;7635;7644.503107298008;6723.562968407038;6851.725930962705;6877.071595334566;6923.515353925177;7016;6736.5958042517605;6751.966240168767;6773.322667733384;6810;6950.409215216763;6458.967705161632;6511.088447617432;6531.052997315458;6573.375529324707;6582.539222254396;4731.124741922756;4794.4486384064885;4803.663743537919;4835.758212089452;4870.829520966749;4681.953180468288;4688.5545873142;4748.643851711066;4763.73799441034;4782.52174782519 15:50:43 INFO - PROCESS | 20346 | |4;prototype.html;294.88352100920133;296.3923955890424;300.98194108353493;301.3520930000499;302.18862354577976;4809.374781278438;4811.25425559038;4811.302361157635;4839.225723884179;4868.586170175535;4735.834245801398;4776.355192049073;4781.569658730714;4802.279658051294;4825.90348193036;3554.2891421715694;3656.8720094796686;3658.609728303241;3752.380857158579;3769.2838360711376;3681.3005528949548;3721.5348081489815;3728.8881333559902;3746.2132952080096;3762.7930463824478;3491.1970246843243;3710.05050984468;3721.218544105741;3730.552333719944;3733.1973625670475;3559.2703495783303;3697.371446854041;3697.9091168105338;3704.907377315562;3707.1658876752786;3281.146901805524;3288.145082278601;3289.6216935052535;3295.3574053059665;3318.6847249511497;4484.663650226246;4513.1650644630845;4522.977385113053;4531.456225252958;4544.613707834838;4001.9599804001878;4221.430106935555;4236.9152616947795;4310.698251122422;4323.502797178333;4978.6763860348965;4993.90012199754;4994.450610432849;5008.7996480140755;5017.122003649383;3476.0962149841225;3493.179102910814;3493.8951831444842;3511.7015053720465;3524.8413821377844;5130.53825155734;5222.399424066243;5249.186376111708;5264.92102618461;5298.417174110845;3570.3394871948253;3592;3595.7123430125525;3598.1904071583685;3604.819759012039;3631.928581068591;3632.455131730209;3637.4543818427446;3641.7632853864416;3646.58064322601;4197.790110494463;4206.621404073648;4209.873703788891;4221.092465120014;4225.57744225575;4932.926006109911;4970.552650261494;4987.451380348159;5010.770207257809;5063.139266324733;1249.9187552809037;1254.6298841841678;1264.3299051502718;1271.205496564647;1276.3554405025402;788.9625142937019;807.3944541593804;830.0620299062022;835.3400813357501;845.7018476638331;4377.649788016951;4394.428724265825;4406.317020861771;4408.603225709701;4409.757463339547;5084.77118529667;5086.567641750418;5098.133317335987;5141.871453213699;5171.276021357013;4174.165166966558;4343.7176583522605;4348.739075655408;4355.15074560464;4426.645868330525;2706.553418685934;2719.3201699575106;2721.2788611018095;2724.850133242651;2727.154582079562;4823.155947709137;4837.2260438329695;4840.177169881058;4840.515948405131;4862.197737373364;4990;5171.301874247004;5211.8012857043095;5252.973735131376;5261.342332208474;4810.254410566367;4815.6147508199965;4816.4220293564995;4818.614510839125;4832.323474713543;5059.229269755556;5096.770645321044;5097.700086477925;5128.79484820603;5139.460356662496;4753.336332283673;4972.328735620645;4990.575801056951;5005.949940500548;5015.623828212972;4765.404324459442;4779;4790.233562630102;4821.566059054702;4833.468318484894;3603.2613314271034;3612.9638703612627;3614.7831130132276;3624.746267761337;3649.37960546713;4860.8298709545;5029.572486338702;5097.719625420637;5122.667026643257;5130.153524668537;4856.150173719514;4875.829345972874;4898.926516102332;4901.754912254444;4906.754662266943;4872.317875497504;4895.388076490439;4913.828016019422;4937.802487900443;4938.358013458227;4618.468876079294;4827.637927155548;4843.903121937612;4848.539388758062;4862.610991120631;4915.361003069578;4945.357103576512;4956.925646115384;4968.826091086795;4973.502649734997;4846.61227101824;4864.318995340726;4866.343043689057;4890.339804126397;4893 15:50:43 INFO - PROCESS | 20346 | |5;yui.html;624.7188765055724;668.8762578922899;744.3970383988967;769.1308821032233;788.3299195683666;11902.34537100459;12325.938370308158;12351.629451116469;12369.319687417188;12482.625521234377;12470.56353027642;12709;12744.745105097893;12753.681157971056;12753.808692869614;636.9936300637004;774.7211004038542;788.9881651775228;801.2788490358665;806.8951036365264;803.9718609848657;806.899137607799;809.1827254472995;815.6655771133836;816.6937398475571;846.5555583318776;847.6058632735777;848.2874385516166;848.4654667559429;849.9235068843802;491.040016767221;501.9749012549358;504.7451037226214;507.7994192294023;843.4096132707099;596.8269201931435;612.1980205930201;612.4120843989775;613.0742578706186;615.5229696984873;12041.578544750979;12064.819027714591;12068.517259309618;12084.758304833855;12103.636890893287;11682.29906205622;11907.761844763143;11963.461644225943;12067.758644827141;12475.875241247562;10975.890241097566;11085.33487990715;11113.72215694606;11121;11204;3984.9402258965847;4047.7166598338126;4100.17996400718;4175.102352994121;4194.140201258735;44621.88445288894;44804.55195448036;44814;44985.325220121726;45188.77405612951;9883.604655813831;9991.800163996824;10189.133923616575;10240.948795256125;10429.634962776267;17957;17993.910030450024;17997.370092046716;18009.639807204043;18011.369602063864;6629.86740265192;6731.360520750521;6742.056112144303;6843.349881761224;6850.828729281808;3502.754807163474;3532.275883443888;3596.118950857057;3642.8724994625063;3649.489071529988;2756.9172924812287;2811.5782632605274;2822.054611705061;2823.294176455886;2848.7863410244313;496.2308421945969;500.5570070487645;515.6313236036252;516.5996352826514;517.8265281130788;496.83852747857094;504.32924210799547;508.79648140744;524.0985504931512;525.1151809201508;7465.477416580896;7541.622918854036;7586.203448637924;7780.2219778021745;7853.489523180975;507.7106049551794;520.3027942556992;522.4514260026956;528.6563733573208;532.9573634109339;3494.3186078714407;3573.4997100405963;3597.5143355647174;3621.3662609043313;3622.040159357772;53252;53292.73353633207;53993.460065398845;54158;54320.45679543233;46920.29619555709;48158.518414816106;48673.513264866895;48689.26966095511;49035.5096449031;43771.34342984858;43858.780706096266;44088;44211.33682994822;44462.33306500405;6781.525293229427;6977.33715297046;6994.370506654425;7045.612491312822;7109.502334836512;30008.24979375533;30057;30774.69225307808;30824.69175308308;30903;36967.26065478729;37466.62533374631;38309;40775.79612101921;40990.385144222266;9888.110070093726;10114.747131321776;10192;10559;10774.622888198875;11725.355105469282;12073.396330183632;12088.637340879788;12287.508499659914;12507.249565026128;10794.352338859693;11041.33751974884;11055.391953442639;11444.94277528607;11459.885401145882;10793.946030270112;11019.063379612502;11182.105431565293;11183.384913829817;11408.885911140782;11158.330500170016;11434.256773309708;11455.854414558478;11478.540858365572;11707.239029463057;8722.956385218287;8966.282697384324;8987.281017518451;9051.683191088281;9319.487428191514;8345.83308333842;8848.247898928663;8878.467291962503;8925.196732294125;9416.62333506652 15:50:43 INFO - PROCESS | 20346 | __end_tp_report 15:50:43 INFO - PROCESS | 20346 | __start_cc_report 15:50:43 INFO - PROCESS | 20346 | _x_x_mozilla_cycle_collect,1120 15:50:43 INFO - PROCESS | 20346 | __end_cc_report 15:50:43 INFO - PROCESS | 20346 | __startTimestamp1464389443463__endTimestamp 15:50:43 INFO - PROCESS | 20346 | 15:50:43 INFO - PROCESS | 20346 | ------- Summary: start ------- 15:50:43 INFO - PROCESS | 20346 | Number of tests: 6 15:50:43 INFO - PROCESS | 20346 | 15:50:43 INFO - PROCESS | 20346 | [#0] dojo.html Cycles:165 Average:4734.53 Median:4843.52 stddev:499.57 (10.3%) stddev-sans-first:474.85 15:50:43 INFO - PROCESS | 20346 | Values: 2697.3 2702.6 2712.9 2742.4 2766.7 4622.4 4717.5 4774.6 4817.7 4854.4 4734.1 4770.7 4771.7 4786.2 4792.0 4180.4 4343.4 4423.0 4453.5 4559.1 4457.0 4500.1 4514.6 4520.0 4549.1 4316.9 4319.5 4351.4 4358.0 4379.8 4352.8 4369.1 4372.0 4422.0 4449.6 4399.9 4413.6 4432.0 4456.1 4469.2 4633.4 4633.7 4655.0 4679.6 4687.7 5179.1 5181.8 5199.5 5202.6 5203.5 5194.4 5200.2 5217.1 5231.6 5234.6 4613.2 4755.4 4804.5 4806.4 4863.7 5327.8 5329.1 5331.9 5352.6 5358.1 5099.7 5104.5 5120.5 5128.3 5131.2 5056.3 5121.5 5188.4 5188.4 5212.9 5145.2 5149.1 5150.0 5152.5 5190.9 4999.7 5137.8 5147.8 5149.3 5150.5 4272.6 4293.9 4305.8 4342.9 4352.4 3758.2 3769.2 3771.2 3801.2 3816.0 4398.8 4400.6 4402.0 4444.7 4450.1 4973.8 5063.6 5108.9 5126.7 5147.1 4391.1 4394.5 4402.8 4406.8 4451.4 4480.1 4589.5 4595.4 4599.1 4643.5 4775.1 4783.7 4820.5 4826.5 4826.9 5105.5 5135.4 5139.7 5140.5 5194.8 4662.7 4776.1 4786.7 4813.5 4875.6 5009.2 5042.6 5068.7 5069.5 5112.1 5131.6 5132.1 5134.6 5148.5 5188.4 4859.0 4865.9 4899.8 4971.1 5001.4 4916.6 4929.1 4929.5 4934.9 4965.1 4853.2 4858.6 4894.9 4915.5 4947.0 4843.5 4961.4 4985.6 5031.2 5039.7 4900.2 4908.9 4943.3 4978.8 4982.2 15:50:43 INFO - PROCESS | 20346 | 15:50:43 INFO - PROCESS | 20346 | [#1] ext.html Cycles:180 Average:45756.42 Median:36411.14 stddev:81596.10 (224.1%) stddev-sans-first:81754.38 15:50:43 INFO - PROCESS | 20346 | Values: 541.7 599.3 602.0 604.0 611.2 27070.9 27512.6 29184.4 29291.6 29314.3 29528.7 41265.4 42090.0 42267.2 45475.3 7864.6 8004.3 8010.7 8020.0 8022.1 7774.1 7898.6 7902.1 7903.0 7904.0 7933.2 7979.1 7983.9 7985.4 7989.6 7863.1 7921.8 7926.8 7926.9 7928.5 7865.2 7942.2 7944.7 7950.6 7952.4 38249.2 38733.8 38793.0 38801.8 38848.2 3040.8 3274.1 3415.9 3452.9 3609.0 29236.0 29620.6 29922.9 30233.8 30955.4 3038.1 3078.8 3107.5 3124.5 3177.6 247982.0 248422.0 248803.0 249655.0 249695.0 53651.0 53711.0 54116.0 54118.0 54186.7 33428.2 34444.0 34461.7 35935.6 35965.0 13767.1 13886.2 13953.8 13957.6 13986.9 10845.8 10951.6 10965.6 10972.9 10973.2 19189.1 19251.2 19276.7 19315.2 19340.8 6724.8 6955.3 6994.9 7145.7 7265.6 790.9 893.0 894.9 930.1 959.2 28583.7 28706.9 28773.9 29351.9 29489.7 739.3 985.3 988.2 995.3 1048.1 14831.6 15205.8 15391.3 15439.7 15585.6 377601.0 377723.0 380049.0 380252.0 381373.0 48759.0 48984.0 49070.8 49236.8 49306.5 1084.6 1195.1 1216.7 1220.5 1221.1 28077.4 29074.0 29097.7 29238.4 29678.6 42414.2 43059.1 43078.0 43112.4 43146.6 285265.0 288760.0 288923.0 289311.0 289563.0 22451.2 23102.9 23139.0 24334.9 24350.0 41955.6 43453.3 44686.3 46706.5 47454.3 37782.8 37828.4 38023.2 38056.0 38539.0 35664.9 36635.8 36969.6 37248.6 37282.6 35739.6 36270.0 36316.3 36506.0 36867.8 32734.0 32997.0 33199.5 33966.3 33985.2 25063.4 25301.6 25315.9 25584.4 25605.5 15:50:43 INFO - PROCESS | 20346 | 15:50:43 INFO - PROCESS | 20346 | [#2] jquery.html Cycles:180 Average:23434.63 Median:27304.20 stddev:62893.00 (230.3%) stddev-sans-first:63045.60 15:50:43 INFO - PROCESS | 20346 | Values: 375.0 375.6 389.1 398.8 399.4 15933.0 16649.2 17386.8 17491.1 17527.3 14073.9 16269.3 16762.6 16795.3 16807.6 4523.7 4732.2 4771.2 4776.0 4781.3 3426.9 5283.3 5566.2 5584.7 5586.7 5508.3 5561.8 5564.2 5580.4 5590.4 6121.6 6136.7 6176.0 6221.2 6235.4 3403.2 3585.4 3588.9 3616.0 5049.4 11892.9 12155.5 12514.8 12551.7 12653.0 1811.5 1857.7 1914.3 1996.3 2327.6 8774.3 9450.1 9454.3 9573.1 9732.0 1510.9 1695.8 1748.5 1800.8 1803.4 65909.0 66292.7 67291.0 68658.7 70960.3 9805.6 9928.5 10134.2 10476.4 11039.6 14278.7 14327.2 14381.7 14392.6 14393.4 7115.9 7289.9 7303.4 7321.6 7344.3 6590.5 6637.1 6746.4 6842.4 6869.6 4197.5 4204.3 4250.3 4291.1 4472.2 1636.9 1739.5 1771.1 1778.6 1867.2 775.5 884.3 915.9 978.2 979.9 16129.0 16470.0 16654.8 16800.9 17218.9 845.1 868.7 889.8 891.7 916.6 9144.7 9146.6 9505.4 9511.5 9649.4 366354.0 379127.0 384589.0 385747.0 387217.0 75384.0 75880.6 76120.0 76269.0 76590.0 882.1 884.7 904.7 912.8 914.7 14750.3 14867.7 14881.9 15023.7 15145.2 32889.7 33667.3 34963.0 35119.3 35939.0 46867.3 47024.8 49071.5 49142.3 49559.0 7391.0 7506.7 7514.0 7520.9 7544.8 9421.2 9549.5 10109.6 11416.4 11685.4 8683.5 9177.9 9320.7 9346.3 9573.8 10086.5 10204.2 10236.5 10246.2 10374.3 8785.8 9082.6 9308.5 9557.4 9659.2 7522.6 7583.0 7663.3 7706.2 7794.3 8739.5 9388.7 9414.7 9432.0 9457.7 15:50:43 INFO - PROCESS | 20346 | 15:50:43 INFO - PROCESS | 20346 | [#3] mootools.html Cycles:180 Average:5174.82 Median:5353.71 stddev:2875.29 (53.7%) stddev-sans-first:2867.98 15:50:43 INFO - PROCESS | 20346 | Values: 1217.7 1392.8 1465.7 1551.9 1760.7 6671.0 7510.0 7751.1 7754.8 7951.2 7664.0 7873.0 7893.5 7894.3 7896.5 1910.8 2147.5 2202.2 2227.2 2239.1 2266.5 2296.4 2296.5 2297.1 2298.0 2224.4 2231.1 2259.5 2261.8 2264.5 1844.1 2059.4 2097.5 2146.2 2146.7 2165.2 2170.0 2182.4 2182.8 2189.6 7833.7 7914.0 7919.1 7919.5 7927.9 4682.9 4817.3 4820.6 4820.6 4821.1 2822.1 2936.5 2977.8 2986.2 2990.3 898.3 901.0 905.7 917.3 918.9 10711.4 10711.6 10738.7 10738.7 10739.4 4157.2 4278.8 4351.8 4369.3 4372.1 9165.2 9210.1 9222.9 9234.9 9237.7 4802.7 4803.9 4805.5 4807.0 4816.1 3794.3 4094.4 4203.2 4212.4 4284.8 3587.9 3660.7 3664.4 3689.9 3772.3 1142.6 1182.9 1205.1 1206.7 1225.3 788.1 801.7 879.9 895.1 916.7 5272.3 5419.2 5423.9 5430.9 5679.5 832.9 854.7 866.2 867.6 916.1 3608.4 3623.6 3739.5 3742.6 3768.2 9428.7 9792.8 9831.8 9834.3 9871.8 9442.3 9643.3 9716.5 9730.5 9753.0 7055.6 7073.0 7150.4 7156.8 7171.9 5050.0 5155.3 5230.6 5241.4 5288.2 8751.9 8767.3 8792.5 8877.4 8887.0 8588.7 8980.8 8989.6 8990.6 8998.7 5681.4 6249.9 6407.4 6486.1 6496.6 7549.6 7571.6 7615.9 7635.0 7644.5 6723.6 6851.7 6877.1 6923.5 7016.0 6736.6 6752.0 6773.3 6810.0 6950.4 6459.0 6511.1 6531.1 6573.4 6582.5 4731.1 4794.4 4803.7 4835.8 4870.8 4682.0 4688.6 4748.6 4763.7 4782.5 15:50:43 INFO - PROCESS | 20346 | 15:50:43 INFO - PROCESS | 20346 | [#4] prototype.html Cycles:180 Average:4119.40 Median:4780.28 stddev:1197.14 (25.0%) stddev-sans-first:1165.57 15:50:43 INFO - PROCESS | 20346 | Values: 294.9 296.4 301.0 301.4 302.2 4809.4 4811.3 4811.3 4839.2 4868.6 4735.8 4776.4 4781.6 4802.3 4825.9 3554.3 3656.9 3658.6 3752.4 3769.3 3681.3 3721.5 3728.9 3746.2 3762.8 3491.2 3710.1 3721.2 3730.6 3733.2 3559.3 3697.4 3697.9 3704.9 3707.2 3281.1 3288.1 3289.6 3295.4 3318.7 4484.7 4513.2 4523.0 4531.5 4544.6 4002.0 4221.4 4236.9 4310.7 4323.5 4978.7 4993.9 4994.5 5008.8 5017.1 3476.1 3493.2 3493.9 3511.7 3524.8 5130.5 5222.4 5249.2 5264.9 5298.4 3570.3 3592.0 3595.7 3598.2 3604.8 3631.9 3632.5 3637.5 3641.8 3646.6 4197.8 4206.6 4209.9 4221.1 4225.6 4932.9 4970.6 4987.5 5010.8 5063.1 1249.9 1254.6 1264.3 1271.2 1276.4 789.0 807.4 830.1 835.3 845.7 4377.6 4394.4 4406.3 4408.6 4409.8 5084.8 5086.6 5098.1 5141.9 5171.3 4174.2 4343.7 4348.7 4355.2 4426.6 2706.6 2719.3 2721.3 2724.9 2727.2 4823.2 4837.2 4840.2 4840.5 4862.2 4990.0 5171.3 5211.8 5253.0 5261.3 4810.3 4815.6 4816.4 4818.6 4832.3 5059.2 5096.8 5097.7 5128.8 5139.5 4753.3 4972.3 4990.6 5005.9 5015.6 4765.4 4779.0 4790.2 4821.6 4833.5 3603.3 3613.0 3614.8 3624.7 3649.4 4860.8 5029.6 5097.7 5122.7 5130.2 4856.2 4875.8 4898.9 4901.8 4906.8 4872.3 4895.4 4913.8 4937.8 4938.4 4618.5 4827.6 4843.9 4848.5 4862.6 4915.4 4945.4 4956.9 4968.8 4973.5 4846.6 4864.3 4866.3 4890.3 4893.0 15:50:43 INFO - PROCESS | 20346 | 15:50:43 INFO - PROCESS | 20346 | [#5] yui.html Cycles:180 Average:12893.56 Median:44336.83 stddev:14761.45 (33.3%) stddev-sans-first:14774.11 15:50:43 INFO - PROCESS | 20346 | Values: 624.7 668.9 744.4 769.1 788.3 11902.3 12325.9 12351.6 12369.3 12482.6 12470.6 12709.0 12744.7 12753.7 12753.8 637.0 774.7 789.0 801.3 806.9 804.0 806.9 809.2 815.7 816.7 846.6 847.6 848.3 848.5 849.9 491.0 502.0 504.7 507.8 843.4 596.8 612.2 612.4 613.1 615.5 12041.6 12064.8 12068.5 12084.8 12103.6 11682.3 11907.8 11963.5 12067.8 12475.9 10975.9 11085.3 11113.7 11121.0 11204.0 3984.9 4047.7 4100.2 4175.1 4194.1 44621.9 44804.6 44814.0 44985.3 45188.8 9883.6 9991.8 10189.1 10240.9 10429.6 17957.0 17993.9 17997.4 18009.6 18011.4 6629.9 6731.4 6742.1 6843.3 6850.8 3502.8 3532.3 3596.1 3642.9 3649.5 2756.9 2811.6 2822.1 2823.3 2848.8 496.2 500.6 515.6 516.6 517.8 496.8 504.3 508.8 524.1 525.1 7465.5 7541.6 7586.2 7780.2 7853.5 507.7 520.3 522.5 528.7 533.0 3494.3 3573.5 3597.5 3621.4 3622.0 53252.0 53292.7 53993.5 54158.0 54320.5 46920.3 48158.5 48673.5 48689.3 49035.5 43771.3 43858.8 44088.0 44211.3 44462.3 6781.5 6977.3 6994.4 7045.6 7109.5 30008.2 30057.0 30774.7 30824.7 30903.0 36967.3 37466.6 38309.0 40775.8 40990.4 9888.1 10114.7 10192.0 10559.0 10774.6 11725.4 12073.4 12088.6 12287.5 12507.2 10794.4 11041.3 11055.4 11444.9 11459.9 10793.9 11019.1 11182.1 11183.4 11408.9 11158.3 11434.3 11455.9 11478.5 11707.2 8723.0 8966.3 8987.3 9051.7 9319.5 8345.8 8848.2 8878.5 8925.2 9416.6 15:50:43 INFO - PROCESS | 20346 | -------- Summary: end -------- 15:50:43 INFO - PROCESS | 20346 | 15:50:44 INFO - TEST-INFO | 20346: exit 0 15:50:44 INFO - TEST-OK | dromaeo_css | took 1117841ms 15:50:44 INFO - TEST-START | kraken 15:50:44 INFO - operating with platform_type : linux_ 15:50:44 INFO - Initialising browser for kraken test... 15:50:44 INFO - TEST-INFO | started process 20524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgnGq_e/profile http://localhost:34321/getInfo.html) 15:50:47 INFO - PROCESS | 20524 | __metrics Screen width/height:1600/1200 15:50:47 INFO - PROCESS | 20524 | colorDepth:24 15:50:47 INFO - PROCESS | 20524 | Browser inner width/height: 1024/697 15:50:47 INFO - PROCESS | 20524 | __metrics 15:50:48 ERROR - PROCESS | 20524 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:50:49 INFO - TEST-INFO | 20524: exit 0 15:50:49 INFO - Browser initialized. 15:50:49 INFO - Running cycle 1/1 for kraken test... 15:50:49 INFO - TEST-INFO | started process 20606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgnGq_e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:01 INFO - PROCESS | 20606 | RSS: Main: 157343744 15:51:01 INFO - PROCESS | 20606 | 15:51:04 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34321/tests/kraken/driver.html?testName=audio-beat-detection) 15:51:05 INFO - PROCESS | 20606 | RSS: Main: 214884352 15:51:05 INFO - PROCESS | 20606 | 15:51:07 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34321/tests/kraken/driver.html?testName=audio-dft) 15:51:08 INFO - PROCESS | 20606 | RSS: Main: 203542528 15:51:08 INFO - PROCESS | 20606 | 15:51:11 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34321/tests/kraken/driver.html?testName=audio-fft) 15:51:12 INFO - PROCESS | 20606 | RSS: Main: 270671872 15:51:12 INFO - PROCESS | 20606 | 15:51:14 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34321/tests/kraken/driver.html?testName=audio-oscillator) 15:51:15 INFO - PROCESS | 20606 | RSS: Main: 180637696 15:51:15 INFO - PROCESS | 20606 | 15:51:17 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34321/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:51:18 INFO - PROCESS | 20606 | RSS: Main: 183894016 15:51:18 INFO - PROCESS | 20606 | 15:51:21 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34321/tests/kraken/driver.html?testName=imaging-darkroom) 15:51:21 INFO - PROCESS | 20606 | RSS: Main: 220737536 15:51:21 INFO - PROCESS | 20606 | 15:51:25 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34321/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:25 INFO - PROCESS | 20606 | RSS: Main: 221216768 15:51:25 INFO - PROCESS | 20606 | 15:51:28 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34321/tests/kraken/driver.html?testName=json-parse-financial) 15:51:29 INFO - PROCESS | 20606 | RSS: Main: 220868608 15:51:29 INFO - PROCESS | 20606 | 15:51:31 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34321/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:51:31 INFO - PROCESS | 20606 | RSS: Main: 206012416 15:51:31 INFO - PROCESS | 20606 | 15:51:33 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34321/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:51:34 INFO - PROCESS | 20606 | RSS: Main: 210104320 15:51:34 INFO - PROCESS | 20606 | 15:51:36 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34321/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:51:37 INFO - PROCESS | 20606 | RSS: Main: 216940544 15:51:37 INFO - PROCESS | 20606 | 15:51:39 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:51:40 INFO - PROCESS | 20606 | RSS: Main: 222777344 15:51:40 INFO - PROCESS | 20606 | 15:51:43 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:51:44 INFO - PROCESS | 20606 | RSS: Main: 222109696 15:51:44 INFO - PROCESS | 20606 | 15:51:45 INFO - PROCESS | 20606 | Cycle 1(1): loaded http://localhost:34321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34321/tests/kraken/driver.html?testName=ai-astar) 15:51:46 INFO - PROCESS | 20606 | RSS: Main: 264261632 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | __start_tp_report 15:51:46 INFO - PROCESS | 20606 | _x_x_mozilla_page_load 15:51:46 INFO - PROCESS | 20606 | _x_x_mozilla_page_load_details 15:51:46 INFO - PROCESS | 20606 | |i|pagename|runs| 15:51:46 INFO - PROCESS | 20606 | |0;ai-astar;115;108;114;117;114;113;114;114;115;115 15:51:46 INFO - PROCESS | 20606 | |1;audio-beat-detection;157;129;131;164;135;162;156;131;195;129 15:51:46 INFO - PROCESS | 20606 | |2;audio-dft;160;162;160;161;161;161;162;161;162;161 15:51:46 INFO - PROCESS | 20606 | |3;audio-fft;75;76;75;116;77;77;76;77;107;76 15:51:46 INFO - PROCESS | 20606 | |4;audio-oscillator;85;85;126;84;86;84;122;85;85;134 15:51:46 INFO - PROCESS | 20606 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;116;118;117 15:51:46 INFO - PROCESS | 20606 | |6;imaging-darkroom;146;147;146;147;146;146;150;145;146;145 15:51:46 INFO - PROCESS | 20606 | |7;imaging-desaturate;95;95;95;95;95;95;94;94;95;94 15:51:46 INFO - PROCESS | 20606 | |8;json-parse-financial;64;64;65;64;65;64;63;64;63;64 15:51:46 INFO - PROCESS | 20606 | |9;json-stringify-tinderbox;65;65;65;65;66;64;65;67;65;64 15:51:46 INFO - PROCESS | 20606 | |10;stanford-crypto-aes;83;83;83;83;85;84;84;84;115;83 15:51:46 INFO - PROCESS | 20606 | |11;stanford-crypto-ccm;153;131;145;138;135;136;131;139;134;132 15:51:46 INFO - PROCESS | 20606 | |12;stanford-crypto-pbkdf2;173;174;172;175;172;170;171;175;169;169 15:51:46 INFO - PROCESS | 20606 | |13;stanford-crypto-sha256-iterative;67;67;68;66;77;67;73;71;69;66 15:51:46 INFO - PROCESS | 20606 | __end_tp_report 15:51:46 INFO - PROCESS | 20606 | __start_cc_report 15:51:46 INFO - PROCESS | 20606 | _x_x_mozilla_cycle_collect,1869 15:51:46 INFO - PROCESS | 20606 | __end_cc_report 15:51:46 INFO - PROCESS | 20606 | __startTimestamp1464389506013__endTimestamp 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | ------- Summary: start ------- 15:51:46 INFO - PROCESS | 20606 | Number of tests: 14 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:2.33 (2.0%) stddev-sans-first:2.44 15:51:46 INFO - PROCESS | 20606 | Values: 115.0 108.0 114.0 117.0 114.0 113.0 114.0 114.0 115.0 115.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:156.50 stddev:21.77 (13.9%) stddev-sans-first:22.90 15:51:46 INFO - PROCESS | 20606 | Values: 157.0 129.0 131.0 164.0 135.0 162.0 156.0 131.0 195.0 129.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 15:51:46 INFO - PROCESS | 20606 | Values: 160.0 162.0 160.0 161.0 161.0 161.0 162.0 161.0 162.0 161.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:15.08 (19.8%) stddev-sans-first:15.70 15:51:46 INFO - PROCESS | 20606 | Values: 75.0 76.0 75.0 116.0 77.0 77.0 76.0 77.0 107.0 76.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:85.00 stddev:20.73 (24.4%) stddev-sans-first:21.48 15:51:46 INFO - PROCESS | 20606 | Values: 85.0 85.0 126.0 84.0 86.0 84.0 122.0 85.0 85.0 134.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 15:51:46 INFO - PROCESS | 20606 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.43 (1.0%) stddev-sans-first:1.51 15:51:46 INFO - PROCESS | 20606 | Values: 146.0 147.0 146.0 147.0 146.0 146.0 150.0 145.0 146.0 145.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:51:46 INFO - PROCESS | 20606 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 15:51:46 INFO - PROCESS | 20606 | Values: 64.0 64.0 65.0 64.0 65.0 64.0 63.0 64.0 63.0 64.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 15:51:46 INFO - PROCESS | 20606 | Values: 65.0 65.0 65.0 65.0 66.0 64.0 65.0 67.0 65.0 64.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:83.50 stddev:9.97 (11.9%) stddev-sans-first:10.48 15:51:46 INFO - PROCESS | 20606 | Values: 83.0 83.0 83.0 83.0 85.0 84.0 84.0 84.0 115.0 83.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:137.00 stddev:6.95 (5.1%) stddev-sans-first:4.53 15:51:46 INFO - PROCESS | 20606 | Values: 153.0 131.0 145.0 138.0 135.0 136.0 131.0 139.0 134.0 132.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.50 stddev:2.26 (1.3%) stddev-sans-first:2.37 15:51:46 INFO - PROCESS | 20606 | Values: 173.0 174.0 172.0 175.0 172.0 170.0 171.0 175.0 169.0 169.0 15:51:46 INFO - PROCESS | 20606 | 15:51:46 INFO - PROCESS | 20606 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:68.50 stddev:3.57 (5.2%) stddev-sans-first:3.71 15:51:46 INFO - PROCESS | 20606 | Values: 67.0 67.0 68.0 66.0 77.0 67.0 73.0 71.0 69.0 66.0 15:51:46 INFO - PROCESS | 20606 | -------- Summary: end -------- 15:51:46 INFO - PROCESS | 20606 | 15:51:47 INFO - TEST-INFO | 20606: exit 0 15:51:47 INFO - TEST-OK | kraken | took 62830ms 15:51:47 INFO - SUITE-END | took 1180s 15:51:47 INFO - Completed test suite (00:19:40) 15:51:47 INFO - javascript benchmark 15:51:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.298702337392, 2702.6488151611516, 2712.918612441625, 2742.355546446586, 2766.7233276672337, 4622.445306563209, 4717.4574923883765, 4774.641901857357, 4817.662763606545, 4854.393200849894, 4734.147853386389, 4770.7376094314795, 4771.665983381165, 4786.162421576219, 4791.952080479195, 4180.352045432963, 4343.435353404053, 4423.0, 4453.487848897385, 4559.110973360196, 4457.041736026754, 4500.099980003996, 4514.571115743999, 4520.028193938303, 4549.1129229800035, 4316.899190706381, 4319.524852266248, 4351.390805287262, 4358.0, 4379.8467053653285, 4352.825886964518, 4369.12617476506, 4372.038151606642, 4422.027154026141, 4449.621782148522, 4399.934000989988, 4413.646908247365, 4432.047109871361, 4456.064226512436, 4469.217886869785, 4633.351330813689, 4633.652476064309, 4655.045715628322, 4679.64902632304, 4687.671862969593, 5179.145441002268, 5181.792728290864, 5199.454057324002, 5202.635815492917, 5203.4796520348045, 5194.402643695986, 5200.24596433515, 5217.060929032773, 5231.581473482112, 5234.581233501311, 4613.215753321943, 4755.358026666425, 4804.5195480451675, 4806.399200099988, 4863.708177509361, 5327.786888524415, 5329.067413202674, 5331.920021199685, 5352.6253162279045, 5358.089124848785, 5099.69401835891, 5104.5150710683165, 5120.539151476385, 5128.25640282157, 5131.179011358165, 5056.292119103328, 5121.4622464641425, 5188.403333616607, 5188.403333616682, 5212.947870521246, 5145.228215767665, 5149.124648809711, 5149.9742501287255, 5152.4847515248175, 5190.92213616796, 4999.65002449825, 5137.794488220504, 5147.845564633067, 5149.330587023663, 5150.48495150482, 4272.5727427257025, 4293.892652683646, 4305.763183024964, 4342.869713908588, 4352.368906508538, 3758.229562939591, 3769.189624230749, 3771.2268984858038, 3801.239752049601, 3816.0459885028745, 4398.846040388571, 4400.581944715247, 4401.977990110093, 4444.6666500012625, 4450.132224216311, 4973.8010479581135, 5063.645544811828, 5108.897822043613, 5126.6923984561045, 5147.0735267651435, 4391.077873646506, 4394.538573449806, 4402.823887044482, 4406.801693923781, 4451.421315229064, 4480.126375356839, 4589.518100599389, 4595.425571803525, 4599.149157405891, 4643.512431194744, 4775.092732380836, 4783.6651434399255, 4820.542048505386, 4826.541478559531, 4826.903461930812, 5105.5149760772665, 5135.38375394955, 5139.665921715076, 5140.537351638371, 5194.844154675366, 4662.696924699883, 4776.116418462596, 4786.688865223749, 4813.518648135158, 4875.561199492063, 5009.173486374707, 5042.621803364689, 5068.670536415121, 5069.493050694901, 5112.105381558287, 5131.640785145153, 5132.050570644443, 5134.640575159703, 5148.510891465305, 5188.403333616682, 4858.975705121452, 4865.9270110947655, 4899.804007839646, 4971.055499455092, 5001.374828146481, 4916.631252655993, 4929.088118698052, 4929.457759646508, 4934.8766280843265, 4965.1311020571975, 4853.150698627796, 4858.611311095033, 4894.902101958012, 4915.459299476983, 4946.975265123651, 4843.515648435128, 4961.355023846877, 4985.601151907911, 5031.195008798721, 5039.697618142924, 4900.240462728283, 4908.852734417973, 4943.2585112233455, 4978.8257410990445, 4982.227754698028], "value": 4703.017293609946, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.6804085589501, 599.2688919518187, 601.9668918209499, 603.9969800150999, 611.1566038866365, 27070.864645676767, 27512.587311190324, 29184.416311673755, 29291.56062659059, 29314.267143321427, 29528.704712952866, 41265.38101928474, 42090.0, 42267.154656906845, 45475.31787023197, 7864.646090925908, 8004.279614834663, 8010.67957281708, 8020.037595488549, 8022.1175670676175, 7774.067111946574, 7898.605069746518, 7902.051753789553, 7903.0, 7903.960480197591, 7933.16701746317, 7979.082405523381, 7983.920160798376, 7985.4010949178755, 7989.6005199740075, 7863.095743989428, 7921.841563168704, 7926.841463170762, 7926.881096783524, 7928.524288542648, 7865.2134786521465, 7942.245486678757, 7944.682212711485, 7950.642221100006, 7952.403569732235, 38249.235015299535, 38733.80633096817, 38793.0, 38801.805990969864, 38848.22303553941, 3040.787144899858, 3274.115988683066, 3415.9146021349416, 3452.879149229765, 3608.9639103608893, 29236.0, 29620.555691664642, 29922.85038574815, 30233.848830755705, 30955.380892382025, 3038.103759390985, 3078.7998780079447, 3107.4717298059386, 3124.4844600640868, 3177.5551422800827, 247982.0, 248422.0, 248803.0, 249655.0, 249695.0, 53651.0, 53711.0, 54116.0, 54118.0, 54186.72906635442, 33428.1642958928, 34444.0, 34461.65538344585, 35935.64064359323, 35965.0, 13767.105138165987, 13886.166829990232, 13953.790693139612, 13957.58127256184, 13986.860131398556, 10845.83731244032, 10951.616693415852, 10965.56137754497, 10972.945135274273, 10973.177011724152, 19189.136488858036, 19251.22995080209, 19276.710849337273, 19315.227390904205, 19340.806591934183, 6724.798256052326, 6955.339242771928, 6994.860102797916, 7145.749898753519, 7265.564066156047, 790.9367250619937, 892.9732108036769, 894.8568229083315, 930.06993006993, 959.1511512311655, 28583.71416285852, 28706.856465717956, 28773.856130719632, 29351.85324073366, 29489.705102948697, 739.2570466680951, 985.3053597213947, 988.2439933450916, 995.2833959549113, 1048.0672201740458, 14831.629209269855, 15205.847941520444, 15391.307391167424, 15439.691206175814, 15585.610359741097, 377601.0, 377723.0, 380049.0, 380252.0, 381373.0, 48759.0, 48984.0, 49070.75464622725, 49236.75381623141, 49306.50693493091, 1084.6203828660064, 1195.0738177912187, 1216.7019080325376, 1220.5239956417004, 1221.084186859873, 28077.438451231268, 29074.0, 29097.709022910345, 29238.41523169482, 29678.554821678124, 42414.1517169661, 43059.138817224106, 43078.0, 43112.35331470093, 43146.56853431551, 285265.0, 288760.0, 288923.0, 289311.0, 289563.0, 22451.21420750266, 23102.884485577466, 23139.0, 24334.878325608257, 24350.0, 41955.58044419517, 43453.34819977766, 44686.3297050538, 46706.53293467158, 47454.28818567655, 37782.81108594439, 37828.43257351087, 38023.239535209694, 38056.0, 38539.0, 35664.880857188175, 36635.81682091572, 36969.63030369662, 37248.62751372452, 37282.62717372792, 35739.64260357363, 36270.0, 36316.27367452583, 36506.0, 36867.81566092152, 32734.0, 32997.0, 33199.502007469426, 33966.32067358688, 33985.15037124092, 25063.373415664755, 25301.62047569325, 25315.87342063278, 25584.360390990376, 25605.487890242464], "value": 17255.498268016174, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.998125009375, 375.61874697182355, 389.1322351156922, 398.83647704441165, 399.40289267545023, 15933.0, 16649.1675416229, 17386.82613173868, 17491.12544372781, 17527.298908043664, 14073.859261407382, 16269.349226030974, 16762.58093547662, 16795.32818687251, 16807.579810504714, 4523.705959112664, 4732.2428411454, 4771.165046116933, 4775.952240477603, 4781.330613714083, 3426.8629254829902, 5283.260343551906, 5566.2207290979295, 5584.664920104807, 5586.664800111986, 5508.256385387981, 5561.833145005636, 5564.165375193713, 5580.414056524068, 5590.385057643676, 6121.632702037892, 6136.723847426876, 6176.042713379434, 6221.222347206599, 6235.376462353751, 3403.23427228874, 3585.4442561403025, 3588.946165807515, 3615.9638403616154, 5049.394072711299, 11892.929636332685, 12155.513779448811, 12514.81227781584, 12551.748965020648, 12653.0, 1811.5018369948239, 1857.6749068912886, 1914.301280032792, 1996.3112726109468, 2327.592671282519, 8774.298056155556, 9450.149486546175, 9454.33819632626, 9573.090556397132, 9732.026797320212, 1510.8715759160484, 1695.7795486586788, 1748.4754573627988, 1800.79290881549, 1803.3958623861022, 65909.0, 66292.6685366575, 67291.0, 68658.65670671665, 70960.29039709589, 9805.558749856273, 9928.453935033642, 10134.189264858793, 10476.371417714961, 11039.613613523488, 14278.714425711636, 14327.212003339708, 14381.712365752835, 14392.640183995274, 14393.42426302957, 7115.857682846417, 7289.890651640229, 7303.415726741848, 7321.597312147883, 7344.306905068218, 6590.505712071518, 6637.103990961158, 6746.392824645805, 6842.418394436529, 6869.587824730532, 4197.454330936958, 4204.26425375558, 4250.257394468254, 4291.098869237495, 4472.239719247736, 1636.8526832585123, 1739.4520725971279, 1771.1498480729065, 1778.5642517583276, 1867.1784414857418, 775.5463054113294, 884.3102380143498, 915.8717779510873, 978.2320878110792, 979.8775153105862, 16129.0, 16470.0, 16654.83345166557, 16800.915995419946, 17218.913905430392, 845.0830848529414, 868.700298397052, 889.7908991387019, 891.7101941868918, 916.6058594804298, 9144.679936202201, 9146.588403521857, 9505.429674219431, 9511.476868772284, 9649.372790768577, 366354.0, 379127.0, 384589.0, 385747.0, 387217.0, 75384.0, 75880.62059689667, 76120.0, 76269.0, 76590.0, 882.1487264789381, 884.7390019944132, 904.6878826804742, 912.8174365127002, 914.6524320758069, 14750.262486875828, 14867.702645947236, 14881.851181488046, 15023.6995260092, 15145.242737863284, 32889.67110328866, 33667.32665346728, 34963.0, 35119.29761404809, 35939.0, 46867.296990544484, 47024.76487617677, 49071.50928490812, 49142.262866057754, 49559.0, 7391.0, 7506.662200200894, 7513.962430187814, 7520.8871866920945, 7544.8491030180185, 9421.246300295823, 9549.522523873917, 10109.64616238428, 11416.429178541206, 11685.415729213675, 8683.480390931689, 9177.908220917705, 9320.72037838866, 9346.252299816135, 9573.760655983377, 10086.546105425126, 10204.2346823987, 10236.48817559134, 10246.180305575386, 10374.325668831501, 8785.824283514421, 9082.636694532144, 9308.534573271445, 9557.426554406758, 9659.227261819178, 7522.623868806429, 7583.0, 7663.31030207284, 7706.190849960673, 7794.337481314152, 8739.475631462132, 9388.718338449857, 9414.67048653294, 9432.0, 9457.668981585612], "value": 7887.834010117139, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.689489180259, 1392.805007298978, 1465.7215129125466, 1551.852574005469, 1760.7358896165574, 6671.0, 7510.023696919399, 7751.069871615407, 7754.767356979286, 7951.244631759973, 7664.0, 7873.0, 7893.526388416699, 7894.250046245612, 7896.486728362653, 1910.751602291707, 2147.5060736030723, 2202.218212534551, 2227.209340684058, 2239.0931672672514, 2266.546690661866, 2296.4258935266184, 2296.540691861626, 2297.058206135485, 2297.9655305170436, 2224.3882932193696, 2231.1187081102953, 2259.4916143867663, 2261.7738226177335, 2264.4565304326925, 1844.0871768474624, 2059.3513043391285, 2097.465146387669, 2146.205903815598, 2146.720926279589, 2165.155589320166, 2169.9783002169934, 2182.432567532437, 2182.847200695936, 2189.627763280246, 7833.686652533892, 7914.0, 7919.128895821455, 7919.485233459806, 7927.8810817837775, 4682.906341873144, 4817.301491283744, 4820.590249828769, 4820.6143508519235, 4821.132196204681, 2822.0969289827262, 2936.4861149298786, 2977.776666749981, 2986.238509180167, 2990.3271763853177, 898.3486971945352, 900.9504477253748, 905.6558507767072, 917.2982668258787, 918.912703293186, 10711.357318560833, 10711.571537138505, 10738.677839664744, 10738.731531711692, 10739.40933248671, 4157.168566286755, 4278.764667943231, 4351.782410879443, 4369.257226271541, 4372.081862808782, 9165.17513423795, 9210.078992100736, 9222.907770922338, 9234.907650923406, 9237.676681316121, 4802.687825291415, 4803.879903002383, 4805.471398146201, 4807.014562014779, 4816.060868130681, 3794.2601192767147, 4094.3653733671326, 4203.180379825904, 4212.410262563182, 4284.764337961442, 3587.874424395186, 3660.743747937619, 3664.358737220976, 3689.870854520079, 3772.2832661794173, 1142.5886680794906, 1182.8876256755595, 1205.0781152418408, 1206.6681662542871, 1225.3138242584182, 788.1487992967582, 801.7234054251275, 879.8856148700628, 895.0780695883251, 916.7249825052457, 5272.314599102092, 5419.214213938957, 5423.945760542423, 5430.864228394322, 5679.488846003879, 832.9167083291622, 854.6837670062117, 866.1511718515764, 867.5618812499647, 916.0610374366328, 3608.440691692792, 3623.6376362363553, 3739.5325584301963, 3742.5696044954634, 3768.246350729865, 9428.669996550088, 9792.804143917081, 9831.80336393268, 9834.262430317754, 9871.75320616976, 9442.339036267533, 9643.27675424346, 9716.465594392235, 9730.513474326255, 9752.951235243778, 7055.611941343275, 7073.0, 7150.356467917808, 7156.821079473055, 7171.856562868714, 5050.0, 5155.2782610435315, 5230.607704422259, 5241.44964778708, 5288.206768984529, 8751.912480875364, 8767.29861611057, 8792.516411597424, 8877.378583499092, 8886.955565222133, 8588.65645374178, 8980.820383592421, 8989.595468203815, 8990.640374384951, 8998.685046023358, 5681.4034526374135, 6249.875002500015, 6407.359264073555, 6486.1243732097455, 6496.610203387811, 7549.6225188739245, 7571.583562904093, 7615.885761713468, 7635.0, 7644.503107298008, 6723.562968407038, 6851.725930962705, 6877.071595334566, 6923.515353925177, 7016.0, 6736.5958042517605, 6751.966240168767, 6773.322667733384, 6810.0, 6950.409215216763, 6458.967705161632, 6511.088447617432, 6531.052997315458, 6573.375529324707, 6582.539222254396, 4731.124741922756, 4794.4486384064885, 4803.663743537919, 4835.758212089452, 4870.829520966749, 4681.953180468288, 4688.5545873142, 4748.643851711066, 4763.73799441034, 4782.52174782519], "value": 4174.4672223121315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.88352100920133, 296.3923955890424, 300.98194108353493, 301.3520930000499, 302.18862354577976, 4809.374781278438, 4811.25425559038, 4811.302361157635, 4839.225723884179, 4868.586170175535, 4735.834245801398, 4776.355192049073, 4781.569658730714, 4802.279658051294, 4825.90348193036, 3554.2891421715694, 3656.8720094796686, 3658.609728303241, 3752.380857158579, 3769.2838360711376, 3681.3005528949548, 3721.5348081489815, 3728.8881333559902, 3746.2132952080096, 3762.7930463824478, 3491.1970246843243, 3710.05050984468, 3721.218544105741, 3730.552333719944, 3733.1973625670475, 3559.2703495783303, 3697.371446854041, 3697.9091168105338, 3704.907377315562, 3707.1658876752786, 3281.146901805524, 3288.145082278601, 3289.6216935052535, 3295.3574053059665, 3318.6847249511497, 4484.663650226246, 4513.1650644630845, 4522.977385113053, 4531.456225252958, 4544.613707834838, 4001.9599804001878, 4221.430106935555, 4236.9152616947795, 4310.698251122422, 4323.502797178333, 4978.6763860348965, 4993.90012199754, 4994.450610432849, 5008.7996480140755, 5017.122003649383, 3476.0962149841225, 3493.179102910814, 3493.8951831444842, 3511.7015053720465, 3524.8413821377844, 5130.53825155734, 5222.399424066243, 5249.186376111708, 5264.92102618461, 5298.417174110845, 3570.3394871948253, 3592.0, 3595.7123430125525, 3598.1904071583685, 3604.819759012039, 3631.928581068591, 3632.455131730209, 3637.4543818427446, 3641.7632853864416, 3646.58064322601, 4197.790110494463, 4206.621404073648, 4209.873703788891, 4221.092465120014, 4225.57744225575, 4932.926006109911, 4970.552650261494, 4987.451380348159, 5010.770207257809, 5063.139266324733, 1249.9187552809037, 1254.6298841841678, 1264.3299051502718, 1271.205496564647, 1276.3554405025402, 788.9625142937019, 807.3944541593804, 830.0620299062022, 835.3400813357501, 845.7018476638331, 4377.649788016951, 4394.428724265825, 4406.317020861771, 4408.603225709701, 4409.757463339547, 5084.77118529667, 5086.567641750418, 5098.133317335987, 5141.871453213699, 5171.276021357013, 4174.165166966558, 4343.7176583522605, 4348.739075655408, 4355.15074560464, 4426.645868330525, 2706.553418685934, 2719.3201699575106, 2721.2788611018095, 2724.850133242651, 2727.154582079562, 4823.155947709137, 4837.2260438329695, 4840.177169881058, 4840.515948405131, 4862.197737373364, 4990.0, 5171.301874247004, 5211.8012857043095, 5252.973735131376, 5261.342332208474, 4810.254410566367, 4815.6147508199965, 4816.4220293564995, 4818.614510839125, 4832.323474713543, 5059.229269755556, 5096.770645321044, 5097.700086477925, 5128.79484820603, 5139.460356662496, 4753.336332283673, 4972.328735620645, 4990.575801056951, 5005.949940500548, 5015.623828212972, 4765.404324459442, 4779.0, 4790.233562630102, 4821.566059054702, 4833.468318484894, 3603.2613314271034, 3612.9638703612627, 3614.7831130132276, 3624.746267761337, 3649.37960546713, 4860.8298709545, 5029.572486338702, 5097.719625420637, 5122.667026643257, 5130.153524668537, 4856.150173719514, 4875.829345972874, 4898.926516102332, 4901.754912254444, 4906.754662266943, 4872.317875497504, 4895.388076490439, 4913.828016019422, 4937.802487900443, 4938.358013458227, 4618.468876079294, 4827.637927155548, 4843.903121937612, 4848.539388758062, 4862.610991120631, 4915.361003069578, 4945.357103576512, 4956.925646115384, 4968.826091086795, 4973.502649734997, 4846.61227101824, 4864.318995340726, 4866.343043689057, 4890.339804126397, 4893.0], "value": 3738.807912335288, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.7188765055724, 668.8762578922899, 744.3970383988967, 769.1308821032233, 788.3299195683666, 11902.34537100459, 12325.938370308158, 12351.629451116469, 12369.319687417188, 12482.625521234377, 12470.56353027642, 12709.0, 12744.745105097893, 12753.681157971056, 12753.808692869614, 636.9936300637004, 774.7211004038542, 788.9881651775228, 801.2788490358665, 806.8951036365264, 803.9718609848657, 806.899137607799, 809.1827254472995, 815.6655771133836, 816.6937398475571, 846.5555583318776, 847.6058632735777, 848.2874385516166, 848.4654667559429, 849.9235068843802, 491.040016767221, 501.9749012549358, 504.7451037226214, 507.7994192294023, 843.4096132707099, 596.8269201931435, 612.1980205930201, 612.4120843989775, 613.0742578706186, 615.5229696984873, 12041.578544750979, 12064.819027714591, 12068.517259309618, 12084.758304833855, 12103.636890893287, 11682.29906205622, 11907.761844763143, 11963.461644225943, 12067.758644827141, 12475.875241247562, 10975.890241097566, 11085.33487990715, 11113.72215694606, 11121.0, 11204.0, 3984.9402258965847, 4047.7166598338126, 4100.17996400718, 4175.102352994121, 4194.140201258735, 44621.88445288894, 44804.55195448036, 44814.0, 44985.325220121726, 45188.77405612951, 9883.604655813831, 9991.800163996824, 10189.133923616575, 10240.948795256125, 10429.634962776267, 17957.0, 17993.910030450024, 17997.370092046716, 18009.639807204043, 18011.369602063864, 6629.86740265192, 6731.360520750521, 6742.056112144303, 6843.349881761224, 6850.828729281808, 3502.754807163474, 3532.275883443888, 3596.118950857057, 3642.8724994625063, 3649.489071529988, 2756.9172924812287, 2811.5782632605274, 2822.054611705061, 2823.294176455886, 2848.7863410244313, 496.2308421945969, 500.5570070487645, 515.6313236036252, 516.5996352826514, 517.8265281130788, 496.83852747857094, 504.32924210799547, 508.79648140744, 524.0985504931512, 525.1151809201508, 7465.477416580896, 7541.622918854036, 7586.203448637924, 7780.2219778021745, 7853.489523180975, 507.7106049551794, 520.3027942556992, 522.4514260026956, 528.6563733573208, 532.9573634109339, 3494.3186078714407, 3573.4997100405963, 3597.5143355647174, 3621.3662609043313, 3622.040159357772, 53252.0, 53292.73353633207, 53993.460065398845, 54158.0, 54320.45679543233, 46920.29619555709, 48158.518414816106, 48673.513264866895, 48689.26966095511, 49035.5096449031, 43771.34342984858, 43858.780706096266, 44088.0, 44211.33682994822, 44462.33306500405, 6781.525293229427, 6977.33715297046, 6994.370506654425, 7045.612491312822, 7109.502334836512, 30008.24979375533, 30057.0, 30774.69225307808, 30824.69175308308, 30903.0, 36967.26065478729, 37466.62533374631, 38309.0, 40775.79612101921, 40990.385144222266, 9888.110070093726, 10114.747131321776, 10192.0, 10559.0, 10774.622888198875, 11725.355105469282, 12073.396330183632, 12088.637340879788, 12287.508499659914, 12507.249565026128, 10794.352338859693, 11041.33751974884, 11055.391953442639, 11444.94277528607, 11459.885401145882, 10793.946030270112, 11019.063379612502, 11182.105431565293, 11183.384913829817, 11408.885911140782, 11158.330500170016, 11434.256773309708, 11455.854414558478, 11478.540858365572, 11707.239029463057, 8722.956385218287, 8966.282697384324, 8987.281017518451, 9051.683191088281, 9319.487428191514, 8345.83308333842, 8848.247898928663, 8878.467291962503, 8925.196732294125, 9416.62333506652], "value": 5837.105396980095, "unit": "score"}], "name": "dromaeo_css", "value": 6227.404134842558, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 114.0, 117.0, 114.0, 113.0, 114.0, 114.0, 115.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 131.0, 164.0, 135.0, 162.0, 156.0, 131.0, 195.0, 129.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 116.0, 77.0, 77.0, 76.0, 77.0, 107.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 126.0, 84.0, 86.0, 84.0, 122.0, 85.0, 85.0, 134.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 150.0, 145.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 63.0, 64.0, 63.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 67.0, 65.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 85.0, 84.0, 84.0, 84.0, 115.0, 83.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 145.0, 138.0, 135.0, 136.0, 131.0, 139.0, 134.0, 132.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 172.0, 175.0, 172.0, 170.0, 171.0, 175.0, 169.0, 169.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 77.0, 67.0, 73.0, 71.0, 69.0, 66.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1557.2, "alertThreshold": 2.0}]} 15:51:47 INFO - Return code: 0 15:51:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:51:47 ERROR - # TBPL SUCCESS # 15:51:47 INFO - Running post-action listener: _resource_record_post_action 15:51:47 INFO - ##### 15:51:47 INFO - ##### Finished run-tests step (success) 15:51:47 INFO - ##### 15:51:47 INFO - Running post-run listener: _resource_record_post_run 15:51:47 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521969664; Read time: 8; Write time: 372712 15:51:47 INFO - TinderboxPrint: CPU usage
13.1% 15:51:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 15:51:47 INFO - TinderboxPrint: I/O write bytes / time
521,969,664 / 372,712 15:51:47 INFO - TinderboxPrint: CPU idle
8,311.1 (86.9%) 15:51:47 INFO - TinderboxPrint: CPU user
1,211.5 (12.7%) 15:51:47 INFO - TinderboxPrint: Swap in / out
0 / 0 15:51:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243163136; Read time: 0; Write time: 215584 15:51:47 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278806528; Read time: 8; Write time: 157128 15:51:47 INFO - Running post-run listener: _upload_blobber_files 15:51:47 INFO - Blob upload gear active. 15:51:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:51:47 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 15:51:47 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'] 15:51:47 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 15:51:48 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:51:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:52 INFO - (blobuploader) - INFO - Done attempting. 15:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:53 INFO - (blobuploader) - INFO - Done attempting. 15:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:53 INFO - (blobuploader) - INFO - Done attempting. 15:51:53 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:53 INFO - Return code: 0 15:51:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:51:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3039668daba080e9541c6c2b1dc7219ab0134cd09e7207ddb4803a708f36de3abd9870e7294f10df57b4395d32f148a1f230318fbc84f6f5455e54f871647c2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ecd2aee05ee3e6935e7d21ebd38a9001d6517e29cfb7958652e73e651c2d850dcee01f7adf38379cf184a54fe8622c7b5dc56c9409ec08dc8455780ad587de4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/401efa3abb2cbaefbf259a786893d5d2fc8c6cec43f25170f591de8c2287be4cd7cdcdfbe24ef25ec5d9ba41b83c2b7cefe3213cbd285d5f59a0790060531686"} 15:51:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:51:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:51:53 INFO - Contents: 15:51:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3039668daba080e9541c6c2b1dc7219ab0134cd09e7207ddb4803a708f36de3abd9870e7294f10df57b4395d32f148a1f230318fbc84f6f5455e54f871647c2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ecd2aee05ee3e6935e7d21ebd38a9001d6517e29cfb7958652e73e651c2d850dcee01f7adf38379cf184a54fe8622c7b5dc56c9409ec08dc8455780ad587de4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/401efa3abb2cbaefbf259a786893d5d2fc8c6cec43f25170f591de8c2287be4cd7cdcdfbe24ef25ec5d9ba41b83c2b7cefe3213cbd285d5f59a0790060531686"} 15:51:53 INFO - Running post-run listener: copy_logs_to_upload_dir 15:51:53 INFO - Copying logs to upload dir... 15:51:53 INFO - mkdir: /builds/slave/test/build/upload/logs 15:51:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.771978 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-27 15:51:53.278193) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 15:51:53.282134) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3039668daba080e9541c6c2b1dc7219ab0134cd09e7207ddb4803a708f36de3abd9870e7294f10df57b4395d32f148a1f230318fbc84f6f5455e54f871647c2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ecd2aee05ee3e6935e7d21ebd38a9001d6517e29cfb7958652e73e651c2d850dcee01f7adf38379cf184a54fe8622c7b5dc56c9409ec08dc8455780ad587de4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/401efa3abb2cbaefbf259a786893d5d2fc8c6cec43f25170f591de8c2287be4cd7cdcdfbe24ef25ec5d9ba41b83c2b7cefe3213cbd285d5f59a0790060531686"} build_url:https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/ENBDSIOHS8mDtjvxTHYzkA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3039668daba080e9541c6c2b1dc7219ab0134cd09e7207ddb4803a708f36de3abd9870e7294f10df57b4395d32f148a1f230318fbc84f6f5455e54f871647c2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ecd2aee05ee3e6935e7d21ebd38a9001d6517e29cfb7958652e73e651c2d850dcee01f7adf38379cf184a54fe8622c7b5dc56c9409ec08dc8455780ad587de4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/401efa3abb2cbaefbf259a786893d5d2fc8c6cec43f25170f591de8c2287be4cd7cdcdfbe24ef25ec5d9ba41b83c2b7cefe3213cbd285d5f59a0790060531686"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 15:51:53.307337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 15:51:53.307635) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464388268.538242-1211838664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 15:51:53.391277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 15:51:53.391578) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 15:51:53.391891) ========= ========= Total master_lag: 0.15 =========