builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1466600185.96 results: success (0) buildid: 20160622044402 builduid: 997bc1d0c2f84e2897423cce2088b506 revision: 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:25.963815) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:25.964542) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:25.964881) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:25.981627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:25.982058) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 05:56:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-06-22 05:56:26 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081244 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:26.079738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:26.080073) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023103 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:26.132986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 05:56:26.133776) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d --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 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d --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=5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 05:56:26,328 truncating revision to first 12 chars 2016-06-22 05:56:26,328 Setting DEBUG logging. 2016-06-22 05:56:26,328 attempt 1/10 2016-06-22 05:56:26,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2c11e355dbf5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 05:56:27,482 unpacking tar archive at: mozilla-central-2c11e355dbf5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.523786 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 05:56:27.675098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:27.675497) ========= script_repo_revision: 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:27.676021) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:27.676392) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 05:56:27.686713) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-22 05:56:27.687031) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:56:27 INFO - MultiFileLogger online at 20160622 05:56:27 in /builds/slave/test 05:56:27 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 05:56:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:27 INFO - {'append_to_log': False, 05:56:27 INFO - 'base_work_dir': '/builds/slave/test', 05:56:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:56:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:27 INFO - 'branch': 'Firefox-Non-PGO', 05:56:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:27 INFO - 'config_files': ('talos/linux_config.py',), 05:56:27 INFO - 'default_actions': ('clobber', 05:56:27 INFO - 'read-buildbot-config', 05:56:27 INFO - 'download-and-extract', 05:56:27 INFO - 'populate-webroot', 05:56:27 INFO - 'create-virtualenv', 05:56:27 INFO - 'install', 05:56:27 INFO - 'run-tests'), 05:56:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:27 INFO - 'download_minidump_stackwalk': True, 05:56:27 INFO - 'download_symbols': 'ondemand', 05:56:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:56:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:56:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:56:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:56:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:27 INFO - 'installer_path': 'installer.exe', 05:56:27 INFO - 'log_level': 'info', 05:56:27 INFO - 'log_name': 'talos', 05:56:27 INFO - 'log_to_console': True, 05:56:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:56:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:56:27 INFO - 'opt_config_files': (), 05:56:27 INFO - 'pip_index': False, 05:56:27 INFO - 'sps_profile': False, 05:56:27 INFO - 'sps_profile_interval': 0, 05:56:27 INFO - 'suite': 'dromaeojs', 05:56:27 INFO - 'system_bits': '32', 05:56:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:27 INFO - 'title': 'talos-linux64-ix-051', 05:56:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:27 INFO - 'use_talos_json': True, 05:56:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:27 INFO - 'work_dir': 'build'} 05:56:27 INFO - ##### 05:56:27 INFO - ##### Running clobber step. 05:56:27 INFO - ##### 05:56:27 INFO - Running pre-action listener: _resource_record_pre_action 05:56:27 INFO - Running main action method: clobber 05:56:27 INFO - rmtree: /builds/slave/test/build 05:56:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:28 INFO - Running post-action listener: _resource_record_post_action 05:56:28 INFO - ##### 05:56:28 INFO - ##### Finished clobber step (success) 05:56:28 INFO - ##### 05:56:28 INFO - ##### 05:56:28 INFO - ##### Running read-buildbot-config step. 05:56:28 INFO - ##### 05:56:28 INFO - Running pre-action listener: _resource_record_pre_action 05:56:28 INFO - Running main action method: read_buildbot_config 05:56:28 INFO - Using buildbot properties: 05:56:28 INFO - { 05:56:28 INFO - "project": "", 05:56:28 INFO - "product": "firefox", 05:56:28 INFO - "script_repo_revision": "production", 05:56:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:56:28 INFO - "repository": "", 05:56:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:56:28 INFO - "buildid": "20160622044402", 05:56:28 INFO - "pgo_build": "False", 05:56:28 INFO - "basedir": "/builds/slave/test", 05:56:28 INFO - "buildnumber": 123, 05:56:28 INFO - "slavename": "talos-linux64-ix-051", 05:56:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:56:28 INFO - "platform": "ubuntu64_hw", 05:56:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:56:28 INFO - "branch": "mozilla-central", 05:56:28 INFO - "repo_path": "mozilla-central", 05:56:28 INFO - "revision": "2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d", 05:56:28 INFO - "stage_platform": "linux64", 05:56:28 INFO - "builduid": "997bc1d0c2f84e2897423cce2088b506", 05:56:28 INFO - "slavebuilddir": "test" 05:56:28 INFO - } 05:56:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:56:28 INFO - Running post-action listener: _resource_record_post_action 05:56:28 INFO - ##### 05:56:28 INFO - ##### Finished read-buildbot-config step (success) 05:56:28 INFO - ##### 05:56:28 INFO - ##### 05:56:28 INFO - ##### Running download-and-extract step. 05:56:28 INFO - ##### 05:56:28 INFO - Running pre-action listener: _resource_record_pre_action 05:56:28 INFO - Running main action method: download_and_extract 05:56:28 INFO - mkdir: /builds/slave/test/build/tests 05:56:28 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')]} 05:56:28 INFO - https://queue.taskcluster.net/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:56:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:56:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:56:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:56:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:56:37 INFO - Downloaded 1361 bytes. 05:56:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:56:37 INFO - Using the following test package requirements: 05:56:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:56:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:56:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:56:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:37 INFO - u'jsshell-linux-x86_64.zip'], 05:56:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:56:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:56:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:56:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:56:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:56:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:56:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:56:37 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')]} 05:56:37 INFO - https://queue.taskcluster.net/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:49 INFO - Downloaded 22701867 bytes. 05:56:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:56:50 INFO - Return code: 0 05:56:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:56:50 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')]} 05:56:50 INFO - https://queue.taskcluster.net/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:56:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:56:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:56:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:51 INFO - Downloaded 22701867 bytes. 05:56:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:56:53 INFO - Return code: 0 05:56:53 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')]} 05:56:53 INFO - https://queue.taskcluster.net/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:56:54 INFO - Downloaded 14405384 bytes. 05:56:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:56:54 INFO - Return code: 0 05:56:54 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')]} 05:56:54 INFO - https://queue.taskcluster.net/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:56:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:56:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:56:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:56:55 INFO - Downloaded 56241829 bytes. 05:56:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:56:55 INFO - mkdir: /builds/slave/test/properties 05:56:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:56:55 INFO - Writing to file /builds/slave/test/properties/build_url 05:56:55 INFO - Contents: 05:56:55 INFO - build_url:https://queue.taskcluster.net/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:56:56 INFO - Running post-action listener: _resource_record_post_action 05:56:56 INFO - Running post-action listener: set_extra_try_arguments 05:56:56 INFO - ##### 05:56:56 INFO - ##### Finished download-and-extract step (success) 05:56:56 INFO - ##### 05:56:56 INFO - ##### 05:56:56 INFO - ##### Running populate-webroot step. 05:56:56 INFO - ##### 05:56:56 INFO - Running pre-action listener: _resource_record_pre_action 05:56:56 INFO - Running main action method: populate_webroot 05:56:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:56:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:56:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:56:56 INFO - '--tppagecycles', 05:56:56 INFO - '7'], 05:56:56 INFO - 'tests': ['tsvgm']}}, 05:56:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:56:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:56:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:56:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:56:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:56:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:56:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:56 INFO - 'talos_options': ['--disable-e10s'], 05:56:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:56 INFO - 'talos_options': ['--disable-e10s'], 05:56:56 INFO - 'tests': ['damp', 'tps']}, 05:56:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:56 INFO - 'tests': ['damp', 'tps']}, 05:56:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:56:56 INFO - 'tests': ['dromaeo_dom']}, 05:56:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:56:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:56:56 INFO - 'tests': ['basic_compositor_video']}, 05:56:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:56:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:56:56 INFO - 'tests': ['a11yr', 05:56:56 INFO - 'ts_paint', 05:56:56 INFO - 'tpaint', 05:56:56 INFO - 'sessionrestore', 05:56:56 INFO - 'sessionrestore_no_auto_restore', 05:56:56 INFO - 'tabpaint']}, 05:56:56 INFO - 'other-e10s': {'tests': ['a11yr', 05:56:56 INFO - 'ts_paint', 05:56:56 INFO - 'tpaint', 05:56:56 INFO - 'sessionrestore', 05:56:56 INFO - 'sessionrestore_no_auto_restore', 05:56:56 INFO - 'tabpaint']}, 05:56:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:56:56 INFO - 'ts_paint', 05:56:56 INFO - 'tpaint', 05:56:56 INFO - 'sessionrestore', 05:56:56 INFO - 'sessionrestore_no_auto_restore', 05:56:56 INFO - 'tabpaint']}, 05:56:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:56:56 INFO - 'ts_paint', 05:56:56 INFO - 'tpaint', 05:56:56 INFO - 'sessionrestore', 05:56:56 INFO - 'sessionrestore_no_auto_restore', 05:56:56 INFO - 'tabpaint']}, 05:56:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:56:56 INFO - 'tests': ['a11yr', 05:56:56 INFO - 'ts_paint', 05:56:56 INFO - 'tpaint', 05:56:56 INFO - 'sessionrestore', 05:56:56 INFO - 'sessionrestore_no_auto_restore', 05:56:56 INFO - 'tabpaint']}, 05:56:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:56:56 INFO - 'tests': ['a11yr', 05:56:56 INFO - 'ts_paint', 05:56:56 INFO - 'tpaint', 05:56:56 INFO - 'sessionrestore', 05:56:56 INFO - 'sessionrestore_no_auto_restore', 05:56:56 INFO - 'tabpaint']}, 05:56:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:56:56 INFO - 'tests': ['tsvgx', 05:56:56 INFO - 'tsvgr_opacity', 05:56:56 INFO - 'tart', 05:56:56 INFO - 'tscrollx', 05:56:56 INFO - 'cart']}, 05:56:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:56:56 INFO - 'tsvgr_opacity', 05:56:56 INFO - 'tart', 05:56:56 INFO - 'tscrollx', 05:56:56 INFO - 'cart']}, 05:56:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:56 INFO - 'talos_options': ['--disable-e10s'], 05:56:56 INFO - 'tests': ['tp5o']}, 05:56:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:56 INFO - 'tests': ['tp5o']}, 05:56:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:56 INFO - 'talos_options': ['--disable-e10s', 05:56:56 INFO - '--xperf_path', 05:56:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:56 INFO - 'tests': ['tp5n']}, 05:56:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:56 INFO - 'talos_options': ['--xperf_path', 05:56:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:56 INFO - 'tests': ['tp5n']}}, 05:56:56 INFO - 'talos.zip': {'path': '', 05:56:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:56:56 INFO - Running post-action listener: _resource_record_post_action 05:56:56 INFO - ##### 05:56:56 INFO - ##### Finished populate-webroot step (success) 05:56:56 INFO - ##### 05:56:56 INFO - ##### 05:56:56 INFO - ##### Running create-virtualenv step. 05:56:56 INFO - ##### 05:56:56 INFO - Running pre-action listener: _resource_record_pre_action 05:56:56 INFO - Running main action method: create_virtualenv 05:56:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:56:56 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 05:56:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:56:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:56:56 INFO - Using real prefix '/usr' 05:56:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:56:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:56:58 INFO - Installing pip.................done. 05:56:58 INFO - Return code: 0 05:56:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:56:58 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')]} 05:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:58 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')]} 05:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:58 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 0x7f3e4c5fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf571c0>, '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 0xf580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf58550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', '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 05:56:58 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 05:56:58 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 05:56:58 INFO - Using env: {'DISPLAY': ':0', 05:56:58 INFO - 'HOME': '/home/cltbld', 05:56:58 INFO - 'LANG': 'en_US.UTF-8', 05:56:58 INFO - 'LANGUAGE': 'en_US:en', 05:56:58 INFO - 'LOGNAME': 'cltbld', 05:56:58 INFO - 'MAIL': '/var/mail/cltbld', 05:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:58 INFO - 'MOZ_NO_REMOTE': '1', 05:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:58 INFO - 'NO_EM_RESTART': '1', 05:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:58 INFO - 'PWD': '/builds/slave/test', 05:56:58 INFO - 'SHELL': '/bin/bash', 05:56:58 INFO - 'SHLVL': '1', 05:56:58 INFO - 'TERM': 'linux', 05:56:58 INFO - 'TMOUT': '86400', 05:56:58 INFO - 'USER': 'cltbld', 05:56:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', 05:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:58 INFO - '_': '/tools/buildbot/bin/python'} 05:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:59 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 05:56:59 INFO - Cleaning up... 05:56:59 INFO - Return code: 0 05:56:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:56:59 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')]} 05:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:59 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')]} 05:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f3e4c5fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf571c0>, '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 0xf580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf58550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', '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 05:56:59 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 05:56:59 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 05:56:59 INFO - Using env: {'DISPLAY': ':0', 05:56:59 INFO - 'HOME': '/home/cltbld', 05:56:59 INFO - 'LANG': 'en_US.UTF-8', 05:56:59 INFO - 'LANGUAGE': 'en_US:en', 05:56:59 INFO - 'LOGNAME': 'cltbld', 05:56:59 INFO - 'MAIL': '/var/mail/cltbld', 05:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:59 INFO - 'MOZ_NO_REMOTE': '1', 05:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:59 INFO - 'NO_EM_RESTART': '1', 05:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:59 INFO - 'PWD': '/builds/slave/test', 05:56:59 INFO - 'SHELL': '/bin/bash', 05:56:59 INFO - 'SHLVL': '1', 05:56:59 INFO - 'TERM': 'linux', 05:56:59 INFO - 'TMOUT': '86400', 05:56:59 INFO - 'USER': 'cltbld', 05:56:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', 05:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:59 INFO - '_': '/tools/buildbot/bin/python'} 05:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:59 INFO - Downloading/unpacking psutil>=3.1.1 05:56:59 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 05:56:59 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 05:56:59 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 05:56:59 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 05:56:59 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 05:56:59 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 05:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:57:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:01 INFO - Installing collected packages: psutil 05:57:01 INFO - Running setup.py install for psutil 05:57:01 INFO - building 'psutil._psutil_linux' extension 05:57:01 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 05:57:01 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 05:57:01 INFO - building 'psutil._psutil_posix' extension 05:57:01 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 05:57:01 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 05:57:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:01 INFO - Successfully installed psutil 05:57:01 INFO - Cleaning up... 05:57:01 INFO - Return code: 0 05:57:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:57:01 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')]} 05:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:01 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')]} 05:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:01 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 0x7f3e4c5fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf571c0>, '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 0xf580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf58550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', '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 05:57:01 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 05:57:01 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 05:57:01 INFO - Using env: {'DISPLAY': ':0', 05:57:01 INFO - 'HOME': '/home/cltbld', 05:57:01 INFO - 'LANG': 'en_US.UTF-8', 05:57:01 INFO - 'LANGUAGE': 'en_US:en', 05:57:01 INFO - 'LOGNAME': 'cltbld', 05:57:01 INFO - 'MAIL': '/var/mail/cltbld', 05:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:01 INFO - 'MOZ_NO_REMOTE': '1', 05:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:01 INFO - 'NO_EM_RESTART': '1', 05:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:01 INFO - 'PWD': '/builds/slave/test', 05:57:01 INFO - 'SHELL': '/bin/bash', 05:57:01 INFO - 'SHLVL': '1', 05:57:01 INFO - 'TERM': 'linux', 05:57:01 INFO - 'TMOUT': '86400', 05:57:01 INFO - 'USER': 'cltbld', 05:57:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', 05:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:01 INFO - '_': '/tools/buildbot/bin/python'} 05:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:57:02 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 05:57:02 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 05:57:02 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 05:57:02 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 05:57:02 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 05:57:02 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 05:57:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:57:03 INFO - Installing collected packages: mozsystemmonitor 05:57:03 INFO - Running setup.py install for mozsystemmonitor 05:57:04 INFO - Successfully installed mozsystemmonitor 05:57:04 INFO - Cleaning up... 05:57:04 INFO - Return code: 0 05:57:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:57:04 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')]} 05:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:04 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')]} 05:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:04 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e4c5fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf571c0>, '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 0xf580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf58550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', '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 05:57:04 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==2.5.1'] in /builds/slave/test/build 05:57:04 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==2.5.1 05:57:04 INFO - Using env: {'DISPLAY': ':0', 05:57:04 INFO - 'HOME': '/home/cltbld', 05:57:04 INFO - 'LANG': 'en_US.UTF-8', 05:57:04 INFO - 'LANGUAGE': 'en_US:en', 05:57:04 INFO - 'LOGNAME': 'cltbld', 05:57:04 INFO - 'MAIL': '/var/mail/cltbld', 05:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:04 INFO - 'MOZ_NO_REMOTE': '1', 05:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:04 INFO - 'NO_EM_RESTART': '1', 05:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:04 INFO - 'PWD': '/builds/slave/test', 05:57:04 INFO - 'SHELL': '/bin/bash', 05:57:04 INFO - 'SHLVL': '1', 05:57:04 INFO - 'TERM': 'linux', 05:57:04 INFO - 'TMOUT': '86400', 05:57:04 INFO - 'USER': 'cltbld', 05:57:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', 05:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:04 INFO - '_': '/tools/buildbot/bin/python'} 05:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:04 INFO - Downloading/unpacking jsonschema==2.5.1 05:57:04 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 05:57:04 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 05:57:04 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 05:57:04 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 05:57:04 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 05:57:04 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 05:57:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:57:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:57:06 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 05:57:06 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 05:57:06 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 05:57:06 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 05:57:06 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 05:57:06 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 05:57:06 INFO - Downloading functools32-3.2.3-2.tar.gz 05:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:57:06 INFO - warning: no files found matching '*.txt' 05:57:06 INFO - no previously-included directories found matching 'build' 05:57:06 INFO - no previously-included directories found matching 'dist' 05:57:06 INFO - no previously-included directories found matching '.git*' 05:57:06 INFO - Installing collected packages: jsonschema, functools32 05:57:06 INFO - Running setup.py install for functools32 05:57:06 INFO - warning: no files found matching '*.txt' 05:57:06 INFO - no previously-included directories found matching 'build' 05:57:06 INFO - no previously-included directories found matching 'dist' 05:57:06 INFO - no previously-included directories found matching '.git*' 05:57:06 INFO - Successfully installed jsonschema functools32 05:57:06 INFO - Cleaning up... 05:57:06 INFO - Return code: 0 05:57:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:57:06 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')]} 05:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:06 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')]} 05:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:06 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 0x7f3e4c5fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf571c0>, '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 0xf580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf58550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', '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 05:57:06 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 05:57:06 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 05:57:06 INFO - Using env: {'DISPLAY': ':0', 05:57:06 INFO - 'HOME': '/home/cltbld', 05:57:06 INFO - 'LANG': 'en_US.UTF-8', 05:57:06 INFO - 'LANGUAGE': 'en_US:en', 05:57:06 INFO - 'LOGNAME': 'cltbld', 05:57:06 INFO - 'MAIL': '/var/mail/cltbld', 05:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:06 INFO - 'MOZ_NO_REMOTE': '1', 05:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:06 INFO - 'NO_EM_RESTART': '1', 05:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:06 INFO - 'PWD': '/builds/slave/test', 05:57:06 INFO - 'SHELL': '/bin/bash', 05:57:06 INFO - 'SHLVL': '1', 05:57:06 INFO - 'TERM': 'linux', 05:57:06 INFO - 'TMOUT': '86400', 05:57:06 INFO - 'USER': 'cltbld', 05:57:06 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', 05:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:06 INFO - '_': '/tools/buildbot/bin/python'} 05:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:57:06 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 05:57:06 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 05:57:06 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 05:57:06 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 05:57:06 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 05:57:06 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 05:57:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:57:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:57:08 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 05:57:08 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 05:57:08 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 05:57:08 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 05:57:08 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 05:57:08 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 05:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:57:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:57:09 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 05:57:09 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 05:57:09 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 05:57:09 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 05:57:09 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 05:57:09 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 05:57:09 INFO - Downloading docopt-0.6.1.tar.gz 05:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:57:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:57:09 INFO - Running setup.py install for blobuploader 05:57:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:57:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:57:09 INFO - Running setup.py install for requests 05:57:10 INFO - Running setup.py install for docopt 05:57:10 INFO - Successfully installed blobuploader requests docopt 05:57:10 INFO - Cleaning up... 05:57:10 INFO - Return code: 0 05:57:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:10 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')]} 05:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:10 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')]} 05:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:10 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 0x7f3e4c5fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf571c0>, '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 0xf580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf58550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', '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 05:57:10 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 05:57:10 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 05:57:10 INFO - Using env: {'DISPLAY': ':0', 05:57:10 INFO - 'HOME': '/home/cltbld', 05:57:10 INFO - 'LANG': 'en_US.UTF-8', 05:57:10 INFO - 'LANGUAGE': 'en_US:en', 05:57:10 INFO - 'LOGNAME': 'cltbld', 05:57:10 INFO - 'MAIL': '/var/mail/cltbld', 05:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:10 INFO - 'MOZ_NO_REMOTE': '1', 05:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:10 INFO - 'NO_EM_RESTART': '1', 05:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:10 INFO - 'PWD': '/builds/slave/test', 05:57:10 INFO - 'SHELL': '/bin/bash', 05:57:10 INFO - 'SHLVL': '1', 05:57:10 INFO - 'TERM': 'linux', 05:57:10 INFO - 'TMOUT': '86400', 05:57:10 INFO - 'USER': 'cltbld', 05:57:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', 05:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:10 INFO - '_': '/tools/buildbot/bin/python'} 05:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:10 INFO - Running setup.py (path:/tmp/pip-ocAeM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:10 INFO - Running setup.py (path:/tmp/pip-B3bCoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:10 INFO - Running setup.py (path:/tmp/pip-ph5dY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:10 INFO - Running setup.py (path:/tmp/pip-LGFh2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:10 INFO - Running setup.py (path:/tmp/pip-pWACPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:10 INFO - Running setup.py (path:/tmp/pip-PU70FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:10 INFO - Running setup.py (path:/tmp/pip-T5BXla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:10 INFO - Running setup.py (path:/tmp/pip-5UhVSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:11 INFO - Running setup.py (path:/tmp/pip-iZv_mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:11 INFO - Running setup.py (path:/tmp/pip-gF5R6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:11 INFO - Running setup.py (path:/tmp/pip-tDLJjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:11 INFO - Running setup.py (path:/tmp/pip-LebX1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:11 INFO - Running setup.py (path:/tmp/pip-imll4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:11 INFO - Running setup.py (path:/tmp/pip-Vfg0Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:11 INFO - Running setup.py (path:/tmp/pip-di9_Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:11 INFO - Running setup.py (path:/tmp/pip-594h71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:11 INFO - Running setup.py (path:/tmp/pip-iCZSSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:11 INFO - Running setup.py install for manifestparser 05:57:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Running setup.py install for mozcrash 05:57:11 INFO - Running setup.py install for mozdebug 05:57:11 INFO - Running setup.py install for mozdevice 05:57:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Running setup.py install for mozfile 05:57:12 INFO - Running setup.py install for mozhttpd 05:57:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Running setup.py install for mozinfo 05:57:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Running setup.py install for mozInstall 05:57:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Running setup.py install for mozleak 05:57:12 INFO - Running setup.py install for mozlog 05:57:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Running setup.py install for moznetwork 05:57:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Running setup.py install for mozprocess 05:57:12 INFO - Running setup.py install for mozprofile 05:57:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:13 INFO - Running setup.py install for mozrunner 05:57:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:13 INFO - Running setup.py install for mozscreenshot 05:57:13 INFO - Running setup.py install for moztest 05:57:13 INFO - Running setup.py install for mozversion 05:57:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:13 INFO - Cleaning up... 05:57:13 INFO - Return code: 0 05:57:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:13 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 0x7f3e4c5fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf571c0>, '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 0xf580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf58550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', '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 05:57:13 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 05:57:13 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 05:57:13 INFO - Using env: {'DISPLAY': ':0', 05:57:13 INFO - 'HOME': '/home/cltbld', 05:57:13 INFO - 'LANG': 'en_US.UTF-8', 05:57:13 INFO - 'LANGUAGE': 'en_US:en', 05:57:13 INFO - 'LOGNAME': 'cltbld', 05:57:13 INFO - 'MAIL': '/var/mail/cltbld', 05:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:13 INFO - 'MOZ_NO_REMOTE': '1', 05:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:13 INFO - 'NO_EM_RESTART': '1', 05:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:13 INFO - 'PWD': '/builds/slave/test', 05:57:13 INFO - 'SHELL': '/bin/bash', 05:57:13 INFO - 'SHLVL': '1', 05:57:13 INFO - 'TERM': 'linux', 05:57:13 INFO - 'TMOUT': '86400', 05:57:13 INFO - 'USER': 'cltbld', 05:57:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', 05:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:13 INFO - '_': '/tools/buildbot/bin/python'} 05:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:13 INFO - Running setup.py (path:/tmp/pip-550wSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:13 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)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:13 INFO - Running setup.py (path:/tmp/pip-KvgrHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:13 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)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:13 INFO - Running setup.py (path:/tmp/pip-boJbz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:13 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)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:13 INFO - Running setup.py (path:/tmp/pip-popF88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:13 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)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:13 INFO - Running setup.py (path:/tmp/pip-Rgkkdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:14 INFO - Running setup.py (path:/tmp/pip-GBeqPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:14 INFO - Running setup.py (path:/tmp/pip-VhmwIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:14 INFO - Running setup.py (path:/tmp/pip-oMJUoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:14 INFO - Running setup.py (path:/tmp/pip-LTm5GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:14 INFO - Running setup.py (path:/tmp/pip-jTqmPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:14 INFO - Running setup.py (path:/tmp/pip-t0cAw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:14 INFO - Running setup.py (path:/tmp/pip-_h7tni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:14 INFO - Running setup.py (path:/tmp/pip-Lrn0Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:14 INFO - Running setup.py (path:/tmp/pip-UMU5OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:14 INFO - Running setup.py (path:/tmp/pip-XcMD7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:14 INFO - Running setup.py (path:/tmp/pip-CnSTJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:14 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)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:14 INFO - Running setup.py (path:/tmp/pip-KTLXBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:14 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)) 05:57:14 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)) 05:57:14 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)) 05:57:14 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)) 05:57:14 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)) 05:57:14 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)) 05:57:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:14 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 05:57:14 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 05:57:14 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 05:57:14 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 05:57:14 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 05:57:14 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 05:57:16 INFO - Downloading blessings-1.6.tar.gz 05:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:16 INFO - Installing collected packages: blessings 05:57:16 INFO - Running setup.py install for blessings 05:57:16 INFO - Successfully installed blessings 05:57:16 INFO - Cleaning up... 05:57:17 INFO - Return code: 0 05:57:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:17 INFO - Reading from file tmpfile_stdout 05:57:17 INFO - Current package versions: 05:57:17 INFO - argparse == 1.2.1 05:57:17 INFO - blessings == 1.6 05:57:17 INFO - blobuploader == 1.2.4 05:57:17 INFO - docopt == 0.6.1 05:57:17 INFO - functools32 == 3.2.3-2 05:57:17 INFO - jsonschema == 2.5.1 05:57:17 INFO - manifestparser == 1.1 05:57:17 INFO - mozInstall == 1.12 05:57:17 INFO - mozcrash == 0.17 05:57:17 INFO - mozdebug == 0.1 05:57:17 INFO - mozdevice == 0.48 05:57:17 INFO - mozfile == 1.2 05:57:17 INFO - mozhttpd == 0.7 05:57:17 INFO - mozinfo == 0.9 05:57:17 INFO - mozleak == 0.1 05:57:17 INFO - mozlog == 3.2 05:57:17 INFO - moznetwork == 0.27 05:57:17 INFO - mozprocess == 0.22 05:57:17 INFO - mozprofile == 0.28 05:57:17 INFO - mozrunner == 6.11 05:57:17 INFO - mozscreenshot == 0.1 05:57:17 INFO - mozsystemmonitor == 0.3 05:57:17 INFO - moztest == 0.7 05:57:17 INFO - mozversion == 1.4 05:57:17 INFO - psutil == 3.1.1 05:57:17 INFO - requests == 1.2.3 05:57:17 INFO - wsgiref == 0.1.2 05:57:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:17 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')]} 05:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:17 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')]} 05:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:17 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 0x7f3e4c5fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf571c0>, '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 0xf580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf58550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', '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 05:57:17 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 05:57:17 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 05:57:17 INFO - Using env: {'DISPLAY': ':0', 05:57:17 INFO - 'HOME': '/home/cltbld', 05:57:17 INFO - 'LANG': 'en_US.UTF-8', 05:57:17 INFO - 'LANGUAGE': 'en_US:en', 05:57:17 INFO - 'LOGNAME': 'cltbld', 05:57:17 INFO - 'MAIL': '/var/mail/cltbld', 05:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:17 INFO - 'MOZ_NO_REMOTE': '1', 05:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:17 INFO - 'NO_EM_RESTART': '1', 05:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:17 INFO - 'PWD': '/builds/slave/test', 05:57:17 INFO - 'SHELL': '/bin/bash', 05:57:17 INFO - 'SHLVL': '1', 05:57:17 INFO - 'TERM': 'linux', 05:57:17 INFO - 'TMOUT': '86400', 05:57:17 INFO - 'USER': 'cltbld', 05:57:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', 05:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:17 INFO - '_': '/tools/buildbot/bin/python'} 05:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 INFO - Cleaning up... 05:57:17 INFO - Return code: 0 05:57:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57:17 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')]} 05:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:17 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')]} 05:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:17 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 0x7f3e4c5fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf571c0>, '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 0xf580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf58550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', '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 05:57:17 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 05:57:17 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 05:57:17 INFO - Using env: {'DISPLAY': ':0', 05:57:17 INFO - 'HOME': '/home/cltbld', 05:57:17 INFO - 'LANG': 'en_US.UTF-8', 05:57:17 INFO - 'LANGUAGE': 'en_US:en', 05:57:17 INFO - 'LOGNAME': 'cltbld', 05:57:17 INFO - 'MAIL': '/var/mail/cltbld', 05:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:17 INFO - 'MOZ_NO_REMOTE': '1', 05:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:17 INFO - 'NO_EM_RESTART': '1', 05:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:17 INFO - 'PWD': '/builds/slave/test', 05:57:17 INFO - 'SHELL': '/bin/bash', 05:57:17 INFO - 'SHLVL': '1', 05:57:17 INFO - 'TERM': 'linux', 05:57:17 INFO - 'TMOUT': '86400', 05:57:17 INFO - 'USER': 'cltbld', 05:57:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', 05:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:17 INFO - '_': '/tools/buildbot/bin/python'} 05:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:57:17 INFO - Cleaning up... 05:57:17 INFO - Return code: 0 05:57:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:57:17 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')]} 05:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:17 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')]} 05:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:17 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 0x7f3e4c5fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf571c0>, '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 0xf580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf58550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', '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 05:57:17 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 05:57:17 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 05:57:17 INFO - Using env: {'DISPLAY': ':0', 05:57:17 INFO - 'HOME': '/home/cltbld', 05:57:17 INFO - 'LANG': 'en_US.UTF-8', 05:57:17 INFO - 'LANGUAGE': 'en_US:en', 05:57:17 INFO - 'LOGNAME': 'cltbld', 05:57:17 INFO - 'MAIL': '/var/mail/cltbld', 05:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:17 INFO - 'MOZ_NO_REMOTE': '1', 05:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:17 INFO - 'NO_EM_RESTART': '1', 05:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:17 INFO - 'PWD': '/builds/slave/test', 05:57:17 INFO - 'SHELL': '/bin/bash', 05:57:17 INFO - 'SHLVL': '1', 05:57:17 INFO - 'TERM': 'linux', 05:57:17 INFO - 'TMOUT': '86400', 05:57:17 INFO - 'USER': 'cltbld', 05:57:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', 05:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:17 INFO - '_': '/tools/buildbot/bin/python'} 05:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:17 INFO - Downloading/unpacking flake8 05:57:17 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 05:57:17 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 05:57:17 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 05:57:17 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 05:57:17 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 05:57:17 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 05:57:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:57:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:57:19 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 05:57:19 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 05:57:19 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 05:57:19 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 05:57:19 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 05:57:19 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 05:57:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:57:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:57:20 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 05:57:20 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 05:57:20 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 05:57:20 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 05:57:20 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 05:57:20 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 05:57:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:57:20 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 05:57:20 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 05:57:20 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 05:57:20 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 05:57:20 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 05:57:20 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 05:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:57:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:20 INFO - no previously-included directories found matching 'docs/_build' 05:57:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:57:20 INFO - Running setup.py install for pep8 05:57:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:20 INFO - no previously-included directories found matching 'docs/_build' 05:57:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:57:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:57:20 INFO - Cleaning up... 05:57:20 INFO - Return code: 0 05:57:20 INFO - Running post-action listener: _resource_record_post_action 05:57:20 INFO - Running post-action listener: _start_resource_monitoring 05:57:20 INFO - Starting resource monitoring. 05:57:20 INFO - ##### 05:57:20 INFO - ##### Finished create-virtualenv step (success) 05:57:20 INFO - ##### 05:57:20 INFO - ##### 05:57:20 INFO - ##### Running install step. 05:57:20 INFO - ##### 05:57:20 INFO - Running pre-action listener: _resource_record_pre_action 05:57:20 INFO - Running main action method: install 05:57:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:21 INFO - Reading from file tmpfile_stdout 05:57:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:21 INFO - Reading from file tmpfile_stdout 05:57:21 INFO - Output received: 05:57:21 INFO - Usage: mozinstall [options] installer 05:57:21 INFO - Options: 05:57:21 INFO - -h, --help show this help message and exit 05:57:21 INFO - -d DEST, --destination=DEST 05:57:21 INFO - Directory to install application into. [default: 05:57:21 INFO - "/builds/slave/test"] 05:57:21 INFO - --app=APP Application being installed. [default: firefox] 05:57:21 INFO - mkdir: /builds/slave/test/build/application 05:57:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:57:37 INFO - Reading from file tmpfile_stdout 05:57:37 INFO - Output received: 05:57:37 INFO - /builds/slave/test/build/application/firefox/firefox 05:57:37 INFO - Running post-action listener: _resource_record_post_action 05:57:37 INFO - ##### 05:57:37 INFO - ##### Finished install step (success) 05:57:37 INFO - ##### 05:57:37 INFO - ##### 05:57:37 INFO - ##### Running run-tests step. 05:57:37 INFO - ##### 05:57:37 INFO - Running pre-action listener: _resource_record_pre_action 05:57:37 INFO - Running main action method: run_tests 05:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:37 INFO - Python 2.7.3 05:57:37 INFO - Return code: 0 05:57:37 INFO - grabbing minidump binary from tooltool 05:57:37 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')]} 05:57:37 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 0xf571c0>, '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 0xf580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf58550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:37 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 05:57:37 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 05:57:37 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 05:57:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:37 INFO - Return code: 0 05:57:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:57:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:57:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:57:38 INFO - Return code: 0 05:57:38 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/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 05:57:38 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/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 05:57:38 INFO - Using env: {'DISPLAY': ':0', 05:57:38 INFO - 'HOME': '/home/cltbld', 05:57:38 INFO - 'LANG': 'en_US.UTF-8', 05:57:38 INFO - 'LANGUAGE': 'en_US:en', 05:57:38 INFO - 'LOGNAME': 'cltbld', 05:57:38 INFO - 'MAIL': '/var/mail/cltbld', 05:57:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:38 INFO - 'MOZ_NO_REMOTE': '1', 05:57:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:38 INFO - 'NO_EM_RESTART': '1', 05:57:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:38 INFO - 'PWD': '/builds/slave/test', 05:57:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:38 INFO - 'SHELL': '/bin/bash', 05:57:38 INFO - 'SHLVL': '1', 05:57:38 INFO - 'TERM': 'linux', 05:57:38 INFO - 'TMOUT': '86400', 05:57:38 INFO - 'USER': 'cltbld', 05:57:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557', 05:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:38 INFO - '_': '/tools/buildbot/bin/python'} 05:57:38 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/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 05:57:38 INFO - mozversion application_buildid: 20160622044402 05:57:38 INFO - mozversion application_changeset: 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d 05:57:38 INFO - mozversion application_display_name: Nightly 05:57:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:38 INFO - mozversion application_name: Firefox 05:57:38 INFO - mozversion application_remotingname: firefox 05:57:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:57:38 INFO - mozversion application_vendor: Mozilla 05:57:38 INFO - mozversion application_version: 50.0a1 05:57:38 INFO - mozversion platform_buildid: 20160622044402 05:57:38 INFO - mozversion platform_changeset: 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d 05:57:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:57:38 INFO - mozversion platform_version: 50.0a1 05:57:38 INFO - using testdate: 1466600258 05:57:38 INFO - actual date: 1466600258 05:57:38 INFO - starting webserver on 'localhost:42748' 05:57:38 INFO - SUITE-START | Running 2 tests 05:57:38 INFO - TEST-START | dromaeo_css 05:57:38 INFO - operating with platform_type : linux_ 05:57:38 INFO - Initialising browser for dromaeo_css test... 05:57:38 INFO - TEST-INFO | started process 6351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZFdltw/profile http://localhost:42748/getInfo.html) 05:57:42 INFO - PROCESS | 6351 | __metrics Screen width/height:1600/1200 05:57:42 INFO - PROCESS | 6351 | colorDepth:24 05:57:42 INFO - PROCESS | 6351 | Browser inner width/height: 1024/697 05:57:42 INFO - PROCESS | 6351 | __metrics 05:57:43 INFO - PROCESS | 6351 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:57:44 INFO - TEST-INFO | 6351: exit 0 05:57:44 INFO - Browser initialized. 05:57:44 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:44 INFO - TEST-INFO | started process 6433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZFdltw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:56 INFO - PROCESS | 6433 | RSS: Main: 175357952 05:57:56 INFO - PROCESS | 6433 | 05:58:48 INFO - PROCESS | 6433 | 1466600328033 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] 06:01:00 INFO - PROCESS | 6433 | Cycle 1(1): loaded http://localhost:42748/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42748/tests/dromaeo/cssquery-ext.html) 06:01:02 INFO - PROCESS | 6433 | RSS: Main: 289964032 06:01:02 INFO - PROCESS | 6433 | 06:04:04 INFO - PROCESS | 6433 | Cycle 1(1): loaded http://localhost:42748/tests/dromaeo/cssquery-ext.html (next: http://localhost:42748/tests/dromaeo/cssquery-jquery.html) 06:04:05 INFO - PROCESS | 6433 | RSS: Main: 261505024 06:04:05 INFO - PROCESS | 6433 | 06:07:07 INFO - PROCESS | 6433 | Cycle 1(1): loaded http://localhost:42748/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42748/tests/dromaeo/cssquery-mootools.html) 06:07:08 INFO - PROCESS | 6433 | RSS: Main: 264757248 06:07:08 INFO - PROCESS | 6433 | 06:10:10 INFO - PROCESS | 6433 | Cycle 1(1): loaded http://localhost:42748/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42748/tests/dromaeo/cssquery-prototype.html) 06:10:11 INFO - PROCESS | 6433 | RSS: Main: 258740224 06:10:11 INFO - PROCESS | 6433 | 06:13:14 INFO - PROCESS | 6433 | Cycle 1(1): loaded http://localhost:42748/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42748/tests/dromaeo/cssquery-yui.html) 06:13:14 INFO - PROCESS | 6433 | RSS: Main: 232898560 06:13:14 INFO - PROCESS | 6433 | 06:16:17 INFO - PROCESS | 6433 | Cycle 1(1): loaded http://localhost:42748/tests/dromaeo/cssquery-yui.html (next: http://localhost:42748/tests/dromaeo/cssquery-dojo.html) 06:16:17 INFO - PROCESS | 6433 | RSS: Main: 297353216 06:16:17 INFO - PROCESS | 6433 | 06:16:17 INFO - PROCESS | 6433 | __start_tp_report 06:16:17 INFO - PROCESS | 6433 | _x_x_mozilla_page_load 06:16:17 INFO - PROCESS | 6433 | _x_x_mozilla_page_load_details 06:16:17 INFO - PROCESS | 6433 | |i|pagename|runs| 06:16:17 INFO - PROCESS | 6433 | |0;dojo.html;2629.4741051789642;2669.813113082084;2670.5193065248272;2683.1011611110275;2706.255779660592;4665.9766701166445;4714.010057887844;4731.763411829412;4825.131476334259;4901.754912254386;4741.739204343759;4791.760411979396;4806.0628177505405;4818.734969576672;4846.079244943458;4397.450318710169;4436.5119836818085;4468.955310446902;4533.455985281771;4584.083183363324;4485.708428952108;4510.481294651125;4526.07215520819;4533.2066888294585;4564.292534657134;4302;4354.455693038371;4364.956350436487;4396.098799746044;4423.579759922803;4375.7155784873885;4376.518582955872;4381.846635367779;4422.5577442255835;4448.7108337957925;4405.713628614129;4408.338749187616;4413.8234470621455;4417.403650507173;4464.6428285737065;4651.534846515321;4705.176594096054;4769.141554520185;4770.856874293742;4810.975945120287;5106.744662766884;5119.59043276537;5158.74206289684;5175.741212939338;5178.792848286064;5162.354705661793;5187.766550505236;5200.167973124282;5207.687538747649;5211.895762084737;4672.859814205579;4780.665353425296;4801.423829140525;4823.589994850477;4827.25177597473;5337.8131765388025;5349.170878513836;5362.758675859595;5365.651232669864;5368.0605893968395;5124.820631277962;5124.948750512447;5129.8717532062;5130.204818253177;5133.101707201225;4989.925151122736;5074.11203039474;5120.1039818031695;5125.8718532036255;5142.434332223453;5065.468125846733;5096.388433388017;5098.490150984946;5110.233464980282;5155.639105262596;4904.926426103611;5080.49195080489;5097.617678674114;5098.4646612105935;5101.51535604117;4291.678124140702;4297.78511074445;4345.587169218919;4348.369486424451;4351;3797.35444974355;3797.867074652374;3829.1767270037076;3835.846566137379;3874.535055793323;4359.542248063971;4372.825086996484;4374.650027997753;4413.360062790877;4416.050549131952;4926.261060840831;5078.314427552233;5108.386993560796;5129.1793313070475;5173.741312934339;4394.604485596312;4397.582229688174;4433.689641725048;4441;4442.755648439303;4618.745968971672;4649.163150632851;4650.720956742606;4657.930131048037;4707.670463067621;4686.039361930728;4764;4815.614750819926;4820.975895120642;4829.975850120727;5145.588352931832;5167.534921857051;5167.948320516897;5171.715555644476;5208.765605547836;4829.3072568601;4838.419389673121;4838.903221935612;4840.685355451885;4885.998370334144;4830.106430310404;5003.599712022957;5035.874103147304;5059.569936555434;5133.666311689728;5133.255677926754;5146.536811686966;5151.304573882478;5163.302954101148;5164.32863727713;5002.474740152377;5004.4495105537635;5007.674501157413;5007.84976450707;5011.373578302712;4825.9034819302715;4921.31101645777;4948.653594248368;4981.028699403581;5004.599632029502;4889.095517329305;4916;4962.801487940442;4963.404391473046;4966;4933.925991110064;5032.446430892525;5036.471170527042;5037.19404895215;5075.213341932006;4920.704757714549;4970.304157418037;4974.427940786856;4975.154223782039;4990.051890140861 06:16:17 INFO - PROCESS | 6433 | |1;ext.html;557.8382269141948;584.7953216374269;593.6230493636542;594.5659668442037;595.4045954045954;26694.86652566737;29315.413691726153;29341;29344.70655293449;29354;29000.27499312513;29507.40985180295;39999.20001599973;41607.79196104023;41735.791321043354;7837.333826624758;7960.164182760814;7971.481853679521;7973.32226760726;7977.042754869395;7774.261445162729;7881;7882.251186137308;7887.211278872124;7887.408444366667;7643.694252229904;7830.412719046066;7841.411894107936;8045.637946292431;10142.49287535624;9993.600255989752;10340.638077667321;10353.06822385989;10365.740856478573;10376.792464150674;9978.401295922267;10152.593896244141;10155.949220253926;10156.542955566943;10164.796704065877;28882.855585722147;29399.26501837471;29453;32016.679833201604;38010.619893800984;3045.670122075651;3160.8261545614982;3182.7772055956093;3262.13553408347;3556.982215088934;27745.167644970683;30332.393352133055;30376.696233037608;30585.08244752661;30835.229119271975;3526.612072672004;3589.4974703541525;3596.7841929484052;3631.6005239423644;3633.0554354148358;245291;249695;250457;250847;251278;35592.822035890174;35671.28657426837;35922.82038589843;35924.46113308302;35963.460548091796;35739.28521429557;36941;36946.26107477889;62424;63020;15017.924910375377;15307.387704491919;15315.310811013309;15335.61660958485;15338.693226135638;9765.511724413751;9814.06766357195;9823.656172034087;9882;9899.059589339002;19355.12901919417;19381.61938857082;19497.17140255656;19500.34836269539;19648.3123090694;5714.485696287271;7462.291082347168;7482.2517748224745;7554.32011118991;7659.502132361378;772.632999325316;802.6789284286332;863.7667829686076;864.3906046237513;931.7950050988771;27001.459970800868;28375.29061773431;28387.290317742223;28589.285267868054;28770.568441473395;874.908134645853;920.1948295241664;1012.3622118065572;1021.99489002556;1068.8289873620183;14789.852101479062;15086.849131508763;15230.695386092217;15464.38142474311;15518.689626207413;372950;374837;376314;379166;379353;50303.24545131826;50801.745991270545;50826.74586627117;50905.23642145371;50907.745461273196;1053.3890343600692;1102.2119184782919;1149.6091328948198;1156.0289356940211;1161.0885454918018;27757.306067348476;29178.854105729337;29266.41467170602;29380.265493362836;30012.24969375783;42713.786431067645;43105.56894431016;43218.135637287705;43221.351679725456;43233;285966;291957;292172;292181;292830;22948.885255573616;23299.417514562272;23299.88350058239;24730.25809225726;24843.751562484867;41410.58589414067;42067.15865682608;42919;43021.784891075346;43949;35377.469337960465;37334;38055.429168563045;38083.619163808005;38837.80581097076;37023.81488092542;37205.6279437213;37456.2508749818;37546.624533754315;37734.81132594319;36333;36586;36775;37088.62911370852;37088.81455592705;29500.409991800472;31673.20816979594;33846.492302614985;33859.64123095102;34118.65881341254;25570.360740981625;25732;25733.742662573135;25809.096681616054;26205.213843584723 06:16:17 INFO - PROCESS | 6433 | |2;jquery.html;366.3607005774923;370.233616414023;372.87322310414487;377.47907887115775;380.5262448251927;15596.454124105658;16727.41454049107;17451.389201377955;17614.11929403531;17698.734518982226;16036.919815400935;16223.83776162238;17090;17099.23053462594;17156.742648860276;5103.336566246392;5247.685138891659;5257.526822585966;5282.366116066059;5286.154215325549;3734.2904848078915;3889.2610404023144;5117.948820511803;5840.766369345221;6168.660723660197;6180.227471566054;6191.164192833978;6207.131001659771;6208.875822483547;6215.223097112861;5935.37678543751;6127.111568822518;6131.080337949321;6145.569810113294;6155.507559395238;3338.115399419156;5057.645964782467;5330.387005494379;5371.919421208685;5379.1662292344745;19445.9027704862;20099.497512562157;20137.194512219492;20238.69641955372;20276.594468110703;1821.2350812658583;2009.859309848311;2017.031824724126;2098.8635738676935;2162.632352500079;9325.860112098324;9367.203787678056;9371.437713737198;9580.0898914603;9735.513224338754;1674.2131198336883;1710.3671641492726;1798.2537247042462;1801.2704854533936;1830.8718389712726;66340;69565.65217173882;70546.64726676384;71302;73013.26986730118;9518.477603435094;9929.702108936743;10028.949855250678;10143.442110683836;10222.437765922945;13748.381322840496;13781;13788.862111378758;13803.861961380459;13847.307634618228;7293.817654558678;7401.888971665429;7457.142428620669;7564.319211270902;7605.923940760522;7162.4270058395205;7242.818929526804;7245.456590755714;7510.962445187848;7548.056492938383;4263.360495925574;4358.084802191575;4414.867553973386;4463.174312752151;4467.374567560544;1586.325811530095;1681.9495415137565;1693.8729595280404;1723.276223985929;1751.6584266068248;740.3521918321469;754.1967804288415;759.9354054905396;791.3550456378033;856.9914300856911;16204.622607078294;16405.507834764976;17049.40327088571;17147;17448.65102697939;791.6754130806457;811.0024669656237;838.4550042472441;849.2059923971107;867.9826403471895;9241.445513269226;9547.52262386878;9571.688506140244;9584.233261339075;9592.232621390272;367064.9880503589;382274;384458;384908;389110;71472.64263678752;76282.61858690671;77082.22917770862;77499.2250077492;79723;748.5359077372173;857.9313654907593;872.320782493697;876.4390789894472;878.5563290538365;14207.786883196553;14949.103053816805;15025.549233523012;16025.278862450985;16161.515154545383;26557.734422655525;31856;36318.818405907805;36635;36676.63323366732;47420;47512;48278.5172148274;49002.50997490122;49220.753896230286;7613.581253031137;7624.627567037986;7758.107817600822;7800.882986755317;7891.921080789119;10720.35677859331;11666.475008624802;11816.82274765862;12137.453814578541;12176.269423834598;10030.197584193393;10119.848202276824;10150.441725705157;10259.127974122282;10291.94854025725;10152.695419137437;10550.261481696207;10556.472176390997;10579.682609521727;10822.458877056273;10400.323978941344;10455.68632941013;10457.16342692598;10622.36265824053;10737.14102871784;7771.533707977539;7856.5678887661725;7972.242636949481;8003;8055.355571554144;10163.796724065625;10424.635137770141;10426.061654451136;10539.841902371623;10701.625443109453 06:16:17 INFO - PROCESS | 6433 | |3;mootools.html;1263.4630282130104;1358.1986627889546;1407.1346122134887;1485.3835658201847;1674.0959881663894;6686.13080299561;7603.277688619579;7760.573168475732;7790.8831367529465;8022.8395432091465;7681.807954801133;7834.315622141238;7840.960795196016;7855.685772569104;7861.528308301506;1878.1548303263587;1942.922283108674;1943.6987266973642;2096.8951552422354;2126.5109024924277;1925.7689077310672;2171.4896999205253;2255.492514184312;2256.244158207003;2256.458449972003;2184.191849015858;2187.7702841201685;2212.214663794354;2213.889305534725;2216.56776928499;1823.6626224148574;2189.7262842144733;2220.678001689762;2224.354937068248;2226.9665955010687;2177.520945392011;2243.2036626997506;2244.3491387497606;2253.605619016682;2253.752087270399;7841.725539606144;7871.21287871214;7885.645145968445;7892.0529536456;7906.881396778996;4529.932051019237;4671.462781780071;4671.976640116812;4673.182193116225;4676.438827340707;2845.8434786086755;2928.970710292891;2981.1354707134906;3033.6966303369486;3040.4375190589813;981.0924894472585;982.0915653020999;1006.2603986070233;1031.5512751952924;1032.26193271811;10705.892941070568;10924.945375273152;10945.781084378268;10968.616098436516;10981.066609338215;4143.129942712004;4273.91452170961;4304.418903448057;4343;4383.780810959439;9387;9399.34204605671;9409.529523523934;9451.905480945103;9452.52737363129;4774.474807771142;4778.259369797687;4779.856604301876;4779.928301075487;4781.6891902026255;3663.3589121904092;4114.979425102855;4242.554531774119;4304.5910638489295;4314.482262128565;3633.709303255733;3741.6258374162912;3745.082454798537;3762.3415902217002;3764.7741135531955;1131.7849608574345;1166.3235323512342;1175.4886624318278;1182.1429463638965;1190.1133655426763;852.2074470742269;855.2089317381522;856.3277826905974;859.4843094143464;876.4478378621428;5403.378611459654;5484.478974497416;5569.415211402745;5673.092305231144;5930.644161350333;817.2767101115437;831.0650518167062;841.381584535366;884.6638277454655;944.8771659684197;3440.4839274108585;3487;3648.908777280536;3785.413260944558;3874.2638898609175;9450.716478505656;9877.456739879375;9893.109620134222;9901.356411833207;9919.057689519628;9469.810603787886;9693.176080033276;9817.361871478332;9830.311878168459;9833.508324583741;7377.594232317167;7392.519486233377;7472.402207823361;7479.102507699111;7522.435817313723;5416.593755468277;5420.349558053059;5449.3460784706085;5466.5900057495055;5509.063459211863;9023.864642030507;9245.86131208019;9291.72124836256;9315.86026209594;9317.301202409983;9084;9369.297302702189;9434.716958491255;9545.47499887485;9549.618015279311;6573.408393244631;6634.170728658918;6720.193576770819;6742.08981787472;6746.190457145174;7589.241075892367;7592;7599.734009309647;7616.04799400075;7704.614769261627;6650.900236496554;6828.351306625863;6851.657417129024;6930.930690693029;6945.479089068239;6636.236832764101;6675.7329706813125;6768.2216545097945;6824.829379265558;6860.5197636164985;6092.360302168386;6258.749650013949;6268.498520118288;6275.717592708248;6409.679516024087;4615.353850461005;4617.492075871584;4619.143674201814;4623.907521849612;4634;4601.217792975135;4666.253399456071;4677.368555244999;4681.110588988081;4689.226277664147 06:16:17 INFO - PROCESS | 6433 | |4;prototype.html;308.06655832826533;310.09297803923533;312.7982451318899;315.9684031596842;317.2686956565118;4882.7314497702655;4898.779554920028;4937.604991600672;4940.382452193476;4990.825321113762;4788.497207793183;4792.952070479294;4816.7591620418925;4877.7804998775055;4887.142885703437;3684.1710615111588;3745.8501659933704;3760.0975765816142;3819.197968426634;3883.669888059518;3793.3688513938996;3841.1165431950667;3845.3078445879732;3858.8070596470066;3868.9226215475674;3787.674313990109;3793.127580656451;3795.335816232162;3808.0479880029993;3813.713971452138;3625.655562721537;3668.596454390028;3820;3826.942595861064;3844.404572102574;3360.2439451123546;3394.6435624259343;3397.9830100849586;3400.2009527760956;3407.863685452579;4682.719036857799;4698.436187657503;4702.5297470253045;4753.714777113384;4792.760361981922;4211.873643790691;4354.738715677069;4377.7592232427205;4406.317020861771;4410.713303635285;5028.4971502849785;5065.924011139836;5066.189409694432;5094.566961808251;5100.209467532539;3701.167237371597;3705.7035437164964;3717.3680474319162;3749.681277091423;3755.8122093895195;5116.360454943132;5247.763850626731;5305.1776974569;5329.120695085307;5339.839804805823;3792.6156952712063;3815.1797363566966;3819.4652748615217;3822.8088595570666;3828.655421012122;3882.320593896057;3894.824732887027;3895.610438956082;3896.7272290939363;3903.863364782219;4300.828081818661;4341.60925516705;4369.169857727022;4390.758508282075;4391.824327026883;4791.401074865642;4994.227049397484;5007;5043.823466178666;5084;1292.7414517096618;1297.0920355751011;1297.1114786371365;1297.9286139262242;1300;806.052887856766;824.9917500825035;833.4207725630629;849.1211595998236;856.1994535109692;4396.714213576107;4472.457002334189;4475.865724028285;4490.865274041784;4504.301833215857;5187.351581052369;5230.764615592308;5236.188390799356;5258.237555554423;5267.841964741064;4493.505714371417;4498.280275156025;4505.324201369821;4513.435820522434;4514.277715565494;2650.509655713699;2816.9295767605563;2817.577363395466;2825;2826.3781967967016;4946.925796113062;4970.502949705073;4974.7512624369365;4996.125678006334;5009.974950125226;5233.738313084331;5289.312389389432;5402.378726446509;5424.810131645373;5447.509724124848;4873.512648735098;4917.680350777188;4925.335079764186;4935.925961110586;4938.23457364102;5215.634905556574;5217.6086793491395;5218.947810521846;5237.188235823453;5239.266502689703;4984.675996060245;5052.267421223828;5122.359705036871;5123.3339665843205;5137.537621614073;4865.781039853145;4893.486183950777;4897.240927656219;4916.7541622919425;4917.557419832232;3358.261182539935;3383.509391138222;3449.9482507762905;3471.6007659119523;3473.2185258316676;4716.457607375059;4822.9758851205515;4826.251930950708;4853;4904.6566740327835;5132.8460146195675;5141.794328226829;5142.382914050338;5155.948440515697;5165.173572228426;5135.818761684759;5145.845624631267;5148.459411761711;5158.226266060121;5159.17453207485;4819.2530157825595;5010.549050585465;5059.114654935445;5080.593552515716;5089.745512724275;4902.313676085279;4966.379202599675;5126.923096153486;5142;5162.483751624807;4976.253561965734;4986.60375094974;4988;5043.747812609281;5050.191969284897 06:16:17 INFO - PROCESS | 6433 | |5;yui.html;581.6742624130485;607.1196764691199;659.4324703354848;728.1553398058251;737.5685224143875;13198.208107513545;13446.327683615817;13509.121907076033;13683.452661893538;14062.718745625081;12391.44238509267;12481.438335274912;12496.125271231018;12513.562025329114;12522.37388130592;629.6442509981869;754.6000619671555;764.3159372361733;764.8737958236912;795.1333046978792;762.778794149696;769.742136384312;770.445279398832;785.650385578415;791.9981223751959;831.2020460358033;835.0188528479043;835.6573804740058;835.7534527314426;836.0970152235601;658.4798009572432;805.7099444200084;812.29736278119;819.9672013119468;825.3149885594971;614.6527212125135;615.2678312807789;617.0466629058071;617.0620656601985;617.222299902122;12377.195482293711;12387.318697471635;12402.689932751664;12422;12439.689007774787;12817.551385701548;13281.468741250339;13316.201027938354;13554.93222533881;13710;11901.583444579484;11990.580329688419;12086;12232.755344893052;12796.61610151697;4204.642605378546;4236.195122926634;4299.376590394407;4331.068820203672;4434.84478043267;61602.69198653978;61874.69062654658;62237.377626224064;64753.02870456994;65245.347546524405;10710.571577136983;10912.836307455394;10929.071028962468;10974.780504389868;11297.079496485618;19204.231830726614;19290.324838630862;19362.515937101685;19493;19500.219991200476;6784.660766961731;6922.58464492122;7194.820129496805;7268.45486588508;7306.488545801849;3652.8538858445363;3687.59436461989;3702.3891057975134;3704.7218709545164;3765.4728338032696;2901.8984335548153;2971.8811247549856;2974.8810047597854;2978.9851050744605;3001.849907504616;518.8702824293927;524.8923970586021;531.3942105999164;535.3254898827505;539.9298091248191;480.7572176051142;519.0812262295716;532.8401479556118;570.0878594249168;578.8914229250937;7477.252274772588;7582.241775822374;7815.921840781633;7910.683572657144;7944.677066365549;560.7308491923818;564.542720396472;569.2059576890215;578.6875087452812;597.2206270816627;3543.645635436436;3555.2000799820353;3615.2769446110356;3633.0644759274246;3735.028892487973;54012;60788.13694904397;89480;89521;89999;49634;68805;79761.20238797653;80896.59551702204;81489;45614.54385456169;46679.29981050287;69812.95280570796;73123.63438182775;76750;6990.161180658353;7055;7109.21798602143;7115.1106111736035;7261.745838895613;38799.80600096982;42421.363679544214;44310.335344970495;44871.32693009542;44934.55065449434;55448.72275638596;62639.373606263354;63207.36792632015;63822;65184.674076629315;9212.124848139416;9269.768255793659;9600.087991641063;9635.181009614262;9853.704388868346;10645.414502202453;10976.780464390828;11147.163962702667;11152.944235278772;11828.408579570814;10541.31481453703;10606.734831628963;10611.681649550526;11037.724056898642;11171;9667.564959576977;9719.368241064309;9846.212303015598;10217.59129634836;10559.947200263949;9864.260180486635;9996.400215987063;10091.949540252546;10206.23453240995;10410.739731506774;8336.749897503085;8469.195426434479;8682.43564168327;8807.427517211361;9067.365284430027;8689.652413903374;8739.943449763236;8872.689455869013;9019.864702029607;9355.4386736796 06:16:17 INFO - PROCESS | 6433 | __end_tp_report 06:16:17 INFO - PROCESS | 6433 | __start_cc_report 06:16:17 INFO - PROCESS | 6433 | _x_x_mozilla_cycle_collect,1048 06:16:17 INFO - PROCESS | 6433 | __end_cc_report 06:16:17 INFO - PROCESS | 6433 | __startTimestamp1466601377812__endTimestamp 06:16:17 INFO - PROCESS | 6433 | 06:16:17 INFO - PROCESS | 6433 | ------- Summary: start ------- 06:16:17 INFO - PROCESS | 6433 | Number of tests: 6 06:16:17 INFO - PROCESS | 6433 | 06:16:17 INFO - PROCESS | 6433 | [#0] dojo.html Cycles:165 Average:4744.95 Median:4838.90 stddev:498.63 (10.3%) stddev-sans-first:471.74 06:16:17 INFO - PROCESS | 6433 | Values: 2629.5 2669.8 2670.5 2683.1 2706.3 4666.0 4714.0 4731.8 4825.1 4901.8 4741.7 4791.8 4806.1 4818.7 4846.1 4397.5 4436.5 4469.0 4533.5 4584.1 4485.7 4510.5 4526.1 4533.2 4564.3 4302.0 4354.5 4365.0 4396.1 4423.6 4375.7 4376.5 4381.8 4422.6 4448.7 4405.7 4408.3 4413.8 4417.4 4464.6 4651.5 4705.2 4769.1 4770.9 4811.0 5106.7 5119.6 5158.7 5175.7 5178.8 5162.4 5187.8 5200.2 5207.7 5211.9 4672.9 4780.7 4801.4 4823.6 4827.3 5337.8 5349.2 5362.8 5365.7 5368.1 5124.8 5124.9 5129.9 5130.2 5133.1 4989.9 5074.1 5120.1 5125.9 5142.4 5065.5 5096.4 5098.5 5110.2 5155.6 4904.9 5080.5 5097.6 5098.5 5101.5 4291.7 4297.8 4345.6 4348.4 4351.0 3797.4 3797.9 3829.2 3835.8 3874.5 4359.5 4372.8 4374.7 4413.4 4416.1 4926.3 5078.3 5108.4 5129.2 5173.7 4394.6 4397.6 4433.7 4441.0 4442.8 4618.7 4649.2 4650.7 4657.9 4707.7 4686.0 4764.0 4815.6 4821.0 4830.0 5145.6 5167.5 5167.9 5171.7 5208.8 4829.3 4838.4 4838.9 4840.7 4886.0 4830.1 5003.6 5035.9 5059.6 5133.7 5133.3 5146.5 5151.3 5163.3 5164.3 5002.5 5004.4 5007.7 5007.8 5011.4 4825.9 4921.3 4948.7 4981.0 5004.6 4889.1 4916.0 4962.8 4963.4 4966.0 4933.9 5032.4 5036.5 5037.2 5075.2 4920.7 4970.3 4974.4 4975.2 4990.1 06:16:17 INFO - PROCESS | 6433 | 06:16:17 INFO - PROCESS | 6433 | [#1] ext.html Cycles:180 Average:45451.58 Median:35632.05 stddev:81519.23 (228.8%) stddev-sans-first:81678.22 06:16:17 INFO - PROCESS | 6433 | Values: 557.8 584.8 593.6 594.6 595.4 26694.9 29315.4 29341.0 29344.7 29354.0 29000.3 29507.4 39999.2 41607.8 41735.8 7837.3 7960.2 7971.5 7973.3 7977.0 7774.3 7881.0 7882.3 7887.2 7887.4 7643.7 7830.4 7841.4 8045.6 10142.5 9993.6 10340.6 10353.1 10365.7 10376.8 9978.4 10152.6 10155.9 10156.5 10164.8 28882.9 29399.3 29453.0 32016.7 38010.6 3045.7 3160.8 3182.8 3262.1 3557.0 27745.2 30332.4 30376.7 30585.1 30835.2 3526.6 3589.5 3596.8 3631.6 3633.1 245291.0 249695.0 250457.0 250847.0 251278.0 35592.8 35671.3 35922.8 35924.5 35963.5 35739.3 36941.0 36946.3 62424.0 63020.0 15017.9 15307.4 15315.3 15335.6 15338.7 9765.5 9814.1 9823.7 9882.0 9899.1 19355.1 19381.6 19497.2 19500.3 19648.3 5714.5 7462.3 7482.3 7554.3 7659.5 772.6 802.7 863.8 864.4 931.8 27001.5 28375.3 28387.3 28589.3 28770.6 874.9 920.2 1012.4 1022.0 1068.8 14789.9 15086.8 15230.7 15464.4 15518.7 372950.0 374837.0 376314.0 379166.0 379353.0 50303.2 50801.7 50826.7 50905.2 50907.7 1053.4 1102.2 1149.6 1156.0 1161.1 27757.3 29178.9 29266.4 29380.3 30012.2 42713.8 43105.6 43218.1 43221.4 43233.0 285966.0 291957.0 292172.0 292181.0 292830.0 22948.9 23299.4 23299.9 24730.3 24843.8 41410.6 42067.2 42919.0 43021.8 43949.0 35377.5 37334.0 38055.4 38083.6 38837.8 37023.8 37205.6 37456.3 37546.6 37734.8 36333.0 36586.0 36775.0 37088.6 37088.8 29500.4 31673.2 33846.5 33859.6 34118.7 25570.4 25732.0 25733.7 25809.1 26205.2 06:16:17 INFO - PROCESS | 6433 | 06:16:17 INFO - PROCESS | 6433 | [#2] jquery.html Cycles:180 Average:23961.67 Median:196686.68 stddev:63019.18 (32.0%) stddev-sans-first:63171.07 06:16:17 INFO - PROCESS | 6433 | Values: 366.4 370.2 372.9 377.5 380.5 15596.5 16727.4 17451.4 17614.1 17698.7 16036.9 16223.8 17090.0 17099.2 17156.7 5103.3 5247.7 5257.5 5282.4 5286.2 3734.3 3889.3 5117.9 5840.8 6168.7 6180.2 6191.2 6207.1 6208.9 6215.2 5935.4 6127.1 6131.1 6145.6 6155.5 3338.1 5057.6 5330.4 5371.9 5379.2 19445.9 20099.5 20137.2 20238.7 20276.6 1821.2 2009.9 2017.0 2098.9 2162.6 9325.9 9367.2 9371.4 9580.1 9735.5 1674.2 1710.4 1798.3 1801.3 1830.9 66340.0 69565.7 70546.6 71302.0 73013.3 9518.5 9929.7 10028.9 10143.4 10222.4 13748.4 13781.0 13788.9 13803.9 13847.3 7293.8 7401.9 7457.1 7564.3 7605.9 7162.4 7242.8 7245.5 7511.0 7548.1 4263.4 4358.1 4414.9 4463.2 4467.4 1586.3 1681.9 1693.9 1723.3 1751.7 740.4 754.2 759.9 791.4 857.0 16204.6 16405.5 17049.4 17147.0 17448.7 791.7 811.0 838.5 849.2 868.0 9241.4 9547.5 9571.7 9584.2 9592.2 367065.0 382274.0 384458.0 384908.0 389110.0 71472.6 76282.6 77082.2 77499.2 79723.0 748.5 857.9 872.3 876.4 878.6 14207.8 14949.1 15025.5 16025.3 16161.5 26557.7 31856.0 36318.8 36635.0 36676.6 47420.0 47512.0 48278.5 49002.5 49220.8 7613.6 7624.6 7758.1 7800.9 7891.9 10720.4 11666.5 11816.8 12137.5 12176.3 10030.2 10119.8 10150.4 10259.1 10291.9 10152.7 10550.3 10556.5 10579.7 10822.5 10400.3 10455.7 10457.2 10622.4 10737.1 7771.5 7856.6 7972.2 8003.0 8055.4 10163.8 10424.6 10426.1 10539.8 10701.6 06:16:17 INFO - PROCESS | 6433 | 06:16:17 INFO - PROCESS | 6433 | [#3] mootools.html Cycles:180 Average:5221.92 Median:5434.85 stddev:2945.82 (54.2%) stddev-sans-first:2939.07 06:16:17 INFO - PROCESS | 6433 | Values: 1263.5 1358.2 1407.1 1485.4 1674.1 6686.1 7603.3 7760.6 7790.9 8022.8 7681.8 7834.3 7841.0 7855.7 7861.5 1878.2 1942.9 1943.7 2096.9 2126.5 1925.8 2171.5 2255.5 2256.2 2256.5 2184.2 2187.8 2212.2 2213.9 2216.6 1823.7 2189.7 2220.7 2224.4 2227.0 2177.5 2243.2 2244.3 2253.6 2253.8 7841.7 7871.2 7885.6 7892.1 7906.9 4529.9 4671.5 4672.0 4673.2 4676.4 2845.8 2929.0 2981.1 3033.7 3040.4 981.1 982.1 1006.3 1031.6 1032.3 10705.9 10924.9 10945.8 10968.6 10981.1 4143.1 4273.9 4304.4 4343.0 4383.8 9387.0 9399.3 9409.5 9451.9 9452.5 4774.5 4778.3 4779.9 4779.9 4781.7 3663.4 4115.0 4242.6 4304.6 4314.5 3633.7 3741.6 3745.1 3762.3 3764.8 1131.8 1166.3 1175.5 1182.1 1190.1 852.2 855.2 856.3 859.5 876.4 5403.4 5484.5 5569.4 5673.1 5930.6 817.3 831.1 841.4 884.7 944.9 3440.5 3487.0 3648.9 3785.4 3874.3 9450.7 9877.5 9893.1 9901.4 9919.1 9469.8 9693.2 9817.4 9830.3 9833.5 7377.6 7392.5 7472.4 7479.1 7522.4 5416.6 5420.3 5449.3 5466.6 5509.1 9023.9 9245.9 9291.7 9315.9 9317.3 9084.0 9369.3 9434.7 9545.5 9549.6 6573.4 6634.2 6720.2 6742.1 6746.2 7589.2 7592.0 7599.7 7616.0 7704.6 6650.9 6828.4 6851.7 6930.9 6945.5 6636.2 6675.7 6768.2 6824.8 6860.5 6092.4 6258.7 6268.5 6275.7 6409.7 4615.4 4617.5 4619.1 4623.9 4634.0 4601.2 4666.3 4677.4 4681.1 4689.2 06:16:17 INFO - PROCESS | 6433 | 06:16:17 INFO - PROCESS | 6433 | [#4] prototype.html Cycles:180 Average:4223.98 Median:4821.11 stddev:1220.79 (25.3%) stddev-sans-first:1188.31 06:16:17 INFO - PROCESS | 6433 | Values: 308.1 310.1 312.8 316.0 317.3 4882.7 4898.8 4937.6 4940.4 4990.8 4788.5 4793.0 4816.8 4877.8 4887.1 3684.2 3745.9 3760.1 3819.2 3883.7 3793.4 3841.1 3845.3 3858.8 3868.9 3787.7 3793.1 3795.3 3808.0 3813.7 3625.7 3668.6 3820.0 3826.9 3844.4 3360.2 3394.6 3398.0 3400.2 3407.9 4682.7 4698.4 4702.5 4753.7 4792.8 4211.9 4354.7 4377.8 4406.3 4410.7 5028.5 5065.9 5066.2 5094.6 5100.2 3701.2 3705.7 3717.4 3749.7 3755.8 5116.4 5247.8 5305.2 5329.1 5339.8 3792.6 3815.2 3819.5 3822.8 3828.7 3882.3 3894.8 3895.6 3896.7 3903.9 4300.8 4341.6 4369.2 4390.8 4391.8 4791.4 4994.2 5007.0 5043.8 5084.0 1292.7 1297.1 1297.1 1297.9 1300.0 806.1 825.0 833.4 849.1 856.2 4396.7 4472.5 4475.9 4490.9 4504.3 5187.4 5230.8 5236.2 5258.2 5267.8 4493.5 4498.3 4505.3 4513.4 4514.3 2650.5 2816.9 2817.6 2825.0 2826.4 4946.9 4970.5 4974.8 4996.1 5010.0 5233.7 5289.3 5402.4 5424.8 5447.5 4873.5 4917.7 4925.3 4935.9 4938.2 5215.6 5217.6 5218.9 5237.2 5239.3 4984.7 5052.3 5122.4 5123.3 5137.5 4865.8 4893.5 4897.2 4916.8 4917.6 3358.3 3383.5 3449.9 3471.6 3473.2 4716.5 4823.0 4826.3 4853.0 4904.7 5132.8 5141.8 5142.4 5155.9 5165.2 5135.8 5145.8 5148.5 5158.2 5159.2 4819.3 5010.5 5059.1 5080.6 5089.7 4902.3 4966.4 5126.9 5142.0 5162.5 4976.3 4986.6 4988.0 5043.7 5050.2 06:16:17 INFO - PROCESS | 6433 | 06:16:17 INFO - PROCESS | 6433 | [#5] yui.html Cycles:180 Average:16268.21 Median:569.65 stddev:22410.51 (3934.1%) stddev-sans-first:22442.42 06:16:17 INFO - PROCESS | 6433 | Values: 581.7 607.1 659.4 728.2 737.6 13198.2 13446.3 13509.1 13683.5 14062.7 12391.4 12481.4 12496.1 12513.6 12522.4 629.6 754.6 764.3 764.9 795.1 762.8 769.7 770.4 785.7 792.0 831.2 835.0 835.7 835.8 836.1 658.5 805.7 812.3 820.0 825.3 614.7 615.3 617.0 617.1 617.2 12377.2 12387.3 12402.7 12422.0 12439.7 12817.6 13281.5 13316.2 13554.9 13710.0 11901.6 11990.6 12086.0 12232.8 12796.6 4204.6 4236.2 4299.4 4331.1 4434.8 61602.7 61874.7 62237.4 64753.0 65245.3 10710.6 10912.8 10929.1 10974.8 11297.1 19204.2 19290.3 19362.5 19493.0 19500.2 6784.7 6922.6 7194.8 7268.5 7306.5 3652.9 3687.6 3702.4 3704.7 3765.5 2901.9 2971.9 2974.9 2979.0 3001.8 518.9 524.9 531.4 535.3 539.9 480.8 519.1 532.8 570.1 578.9 7477.3 7582.2 7815.9 7910.7 7944.7 560.7 564.5 569.2 578.7 597.2 3543.6 3555.2 3615.3 3633.1 3735.0 54012.0 60788.1 89480.0 89521.0 89999.0 49634.0 68805.0 79761.2 80896.6 81489.0 45614.5 46679.3 69813.0 73123.6 76750.0 6990.2 7055.0 7109.2 7115.1 7261.7 38799.8 42421.4 44310.3 44871.3 44934.6 55448.7 62639.4 63207.4 63822.0 65184.7 9212.1 9269.8 9600.1 9635.2 9853.7 10645.4 10976.8 11147.2 11152.9 11828.4 10541.3 10606.7 10611.7 11037.7 11171.0 9667.6 9719.4 9846.2 10217.6 10559.9 9864.3 9996.4 10091.9 10206.2 10410.7 8336.7 8469.2 8682.4 8807.4 9067.4 8689.7 8739.9 8872.7 9019.9 9355.4 06:16:17 INFO - PROCESS | 6433 | -------- Summary: end -------- 06:16:17 INFO - PROCESS | 6433 | 06:16:18 INFO - TEST-INFO | 6433: exit 0 06:16:18 INFO - TEST-OK | dromaeo_css | took 1120180ms 06:16:18 INFO - TEST-START | kraken 06:16:18 INFO - operating with platform_type : linux_ 06:16:18 INFO - Initialising browser for kraken test... 06:16:18 INFO - TEST-INFO | started process 6613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiCJNyP/profile http://localhost:42748/getInfo.html) 06:16:22 INFO - PROCESS | 6613 | __metrics Screen width/height:1600/1200 06:16:22 INFO - PROCESS | 6613 | colorDepth:24 06:16:22 INFO - PROCESS | 6613 | Browser inner width/height: 1024/697 06:16:22 INFO - PROCESS | 6613 | __metrics 06:16:23 INFO - PROCESS | 6613 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:16:24 INFO - TEST-INFO | 6613: exit 0 06:16:24 INFO - Browser initialized. 06:16:24 INFO - Running cycle 1/1 for kraken test... 06:16:24 INFO - TEST-INFO | started process 6694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiCJNyP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:36 INFO - PROCESS | 6694 | RSS: Main: 175497216 06:16:36 INFO - PROCESS | 6694 | 06:16:39 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42748/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:40 INFO - PROCESS | 6694 | RSS: Main: 234389504 06:16:40 INFO - PROCESS | 6694 | 06:16:43 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42748/tests/kraken/driver.html?testName=audio-dft) 06:16:43 INFO - PROCESS | 6694 | RSS: Main: 220987392 06:16:43 INFO - PROCESS | 6694 | 06:16:47 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42748/tests/kraken/driver.html?testName=audio-fft) 06:16:47 INFO - PROCESS | 6694 | RSS: Main: 289505280 06:16:47 INFO - PROCESS | 6694 | 06:16:49 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42748/tests/kraken/driver.html?testName=audio-oscillator) 06:16:50 INFO - PROCESS | 6694 | RSS: Main: 199372800 06:16:50 INFO - PROCESS | 6694 | 06:16:52 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42748/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:53 INFO - PROCESS | 6694 | RSS: Main: 202936320 06:16:53 INFO - PROCESS | 6694 | 06:16:56 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42748/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:57 INFO - PROCESS | 6694 | RSS: Main: 239853568 06:16:57 INFO - PROCESS | 6694 | 06:17:00 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42748/tests/kraken/driver.html?testName=imaging-desaturate) 06:17:01 INFO - PROCESS | 6694 | RSS: Main: 235696128 06:17:01 INFO - PROCESS | 6694 | 06:17:04 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42748/tests/kraken/driver.html?testName=json-parse-financial) 06:17:04 INFO - PROCESS | 6694 | RSS: Main: 237281280 06:17:04 INFO - PROCESS | 6694 | 06:17:06 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42748/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:17:07 INFO - PROCESS | 6694 | RSS: Main: 225865728 06:17:07 INFO - PROCESS | 6694 | 06:17:08 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42748/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:17:09 INFO - PROCESS | 6694 | RSS: Main: 231763968 06:17:09 INFO - PROCESS | 6694 | 06:17:11 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42748/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:17:12 INFO - PROCESS | 6694 | RSS: Main: 238575616 06:17:12 INFO - PROCESS | 6694 | 06:17:15 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:17:15 INFO - PROCESS | 6694 | RSS: Main: 241438720 06:17:15 INFO - PROCESS | 6694 | 06:17:18 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:19 INFO - PROCESS | 6694 | RSS: Main: 239325184 06:17:19 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:42748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42748/tests/kraken/driver.html?testName=ai-astar) 06:17:21 INFO - PROCESS | 6694 | RSS: Main: 282095616 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | __start_tp_report 06:17:21 INFO - PROCESS | 6694 | _x_x_mozilla_page_load 06:17:21 INFO - PROCESS | 6694 | _x_x_mozilla_page_load_details 06:17:21 INFO - PROCESS | 6694 | |i|pagename|runs| 06:17:21 INFO - PROCESS | 6694 | |0;ai-astar;112;108;112;113;111;114;112;112;113;111 06:17:21 INFO - PROCESS | 6694 | |1;audio-beat-detection;160;129;131;186;131;137;174;130;170;130 06:17:21 INFO - PROCESS | 6694 | |2;audio-dft;160;161;161;161;161;159;161;162;160;160 06:17:21 INFO - PROCESS | 6694 | |3;audio-fft;77;75;78;102;75;76;74;75;100;75 06:17:21 INFO - PROCESS | 6694 | |4;audio-oscillator;87;88;112;87;87;87;120;85;86;128 06:17:21 INFO - PROCESS | 6694 | |5;imaging-gaussian-blur;117;118;117;117;117;116;117;117;116;117 06:17:21 INFO - PROCESS | 6694 | |6;imaging-darkroom;146;146;147;146;146;146;146;147;147;146 06:17:21 INFO - PROCESS | 6694 | |7;imaging-desaturate;98;95;94;94;95;95;94;95;94;95 06:17:21 INFO - PROCESS | 6694 | |8;json-parse-financial;66;63;63;64;64;65;65;63;65;63 06:17:21 INFO - PROCESS | 6694 | |9;json-stringify-tinderbox;65;65;65;65;66;65;65;65;64;64 06:17:21 INFO - PROCESS | 6694 | |10;stanford-crypto-aes;87;93;83;84;84;85;84;84;113;85 06:17:21 INFO - PROCESS | 6694 | |11;stanford-crypto-ccm;140;133;142;129;130;134;131;128;134;132 06:17:21 INFO - PROCESS | 6694 | |12;stanford-crypto-pbkdf2;171;167;168;170;168;169;167;170;170;167 06:17:21 INFO - PROCESS | 6694 | |13;stanford-crypto-sha256-iterative;67;67;73;66;68;67;67;66;66;64 06:17:21 INFO - PROCESS | 6694 | __end_tp_report 06:17:21 INFO - PROCESS | 6694 | __start_cc_report 06:17:21 INFO - PROCESS | 6694 | _x_x_mozilla_cycle_collect,1927 06:17:21 INFO - PROCESS | 6694 | __end_cc_report 06:17:21 INFO - PROCESS | 6694 | __startTimestamp1466601441354__endTimestamp 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | ------- Summary: start ------- 06:17:21 INFO - PROCESS | 6694 | Number of tests: 14 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.62 (1.4%) stddev-sans-first:1.72 06:17:21 INFO - PROCESS | 6694 | Values: 112.0 108.0 112.0 113.0 111.0 114.0 112.0 112.0 113.0 111.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:148.50 stddev:22.25 (15.0%) stddev-sans-first:23.16 06:17:21 INFO - PROCESS | 6694 | Values: 160.0 129.0 131.0 186.0 131.0 137.0 174.0 130.0 170.0 130.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 06:17:21 INFO - PROCESS | 6694 | Values: 160.0 161.0 161.0 161.0 161.0 159.0 161.0 162.0 160.0 160.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:10.77 (14.4%) stddev-sans-first:11.34 06:17:21 INFO - PROCESS | 6694 | Values: 77.0 75.0 78.0 102.0 75.0 76.0 74.0 75.0 100.0 75.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:87.00 stddev:16.53 (19.0%) stddev-sans-first:17.16 06:17:21 INFO - PROCESS | 6694 | Values: 87.0 88.0 112.0 87.0 87.0 87.0 120.0 85.0 86.0 128.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:17:21 INFO - PROCESS | 6694 | Values: 117.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:17:21 INFO - PROCESS | 6694 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.20 (1.3%) stddev-sans-first:0.53 06:17:21 INFO - PROCESS | 6694 | Values: 98.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.50 stddev:1.10 (1.7%) stddev-sans-first:0.93 06:17:21 INFO - PROCESS | 6694 | Values: 66.0 63.0 63.0 64.0 64.0 65.0 65.0 63.0 65.0 63.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 06:17:21 INFO - PROCESS | 6694 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 64.0 64.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:84.50 stddev:9.17 (10.9%) stddev-sans-first:9.72 06:17:21 INFO - PROCESS | 6694 | Values: 87.0 93.0 83.0 84.0 84.0 85.0 84.0 84.0 113.0 85.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:133.50 stddev:4.55 (3.4%) stddev-sans-first:4.13 06:17:21 INFO - PROCESS | 6694 | Values: 140.0 133.0 142.0 129.0 130.0 134.0 131.0 128.0 134.0 132.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:169.50 stddev:1.49 (0.9%) stddev-sans-first:1.33 06:17:21 INFO - PROCESS | 6694 | Values: 171.0 167.0 168.0 170.0 168.0 169.0 167.0 170.0 170.0 167.0 06:17:21 INFO - PROCESS | 6694 | 06:17:21 INFO - PROCESS | 6694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.33 (3.5%) stddev-sans-first:2.47 06:17:21 INFO - PROCESS | 6694 | Values: 67.0 67.0 73.0 66.0 68.0 67.0 67.0 66.0 66.0 64.0 06:17:21 INFO - PROCESS | 6694 | -------- Summary: end -------- 06:17:21 INFO - PROCESS | 6694 | 06:17:22 INFO - TEST-INFO | 6694: exit 0 06:17:22 INFO - TEST-OK | kraken | took 63789ms 06:17:22 INFO - SUITE-END | took 1183s 06:17:22 INFO - Completed test suite (00:19:44) 06:17:22 INFO - javascript benchmark 06:17:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2629.4741051789642, 2669.813113082084, 2670.5193065248272, 2683.1011611110275, 2706.255779660592, 4665.9766701166445, 4714.010057887844, 4731.763411829412, 4825.131476334259, 4901.754912254386, 4741.739204343759, 4791.760411979396, 4806.0628177505405, 4818.734969576672, 4846.079244943458, 4397.450318710169, 4436.5119836818085, 4468.955310446902, 4533.455985281771, 4584.083183363324, 4485.708428952108, 4510.481294651125, 4526.07215520819, 4533.2066888294585, 4564.292534657134, 4302.0, 4354.455693038371, 4364.956350436487, 4396.098799746044, 4423.579759922803, 4375.7155784873885, 4376.518582955872, 4381.846635367779, 4422.5577442255835, 4448.7108337957925, 4405.713628614129, 4408.338749187616, 4413.8234470621455, 4417.403650507173, 4464.6428285737065, 4651.534846515321, 4705.176594096054, 4769.141554520185, 4770.856874293742, 4810.975945120287, 5106.744662766884, 5119.59043276537, 5158.74206289684, 5175.741212939338, 5178.792848286064, 5162.354705661793, 5187.766550505236, 5200.167973124282, 5207.687538747649, 5211.895762084737, 4672.859814205579, 4780.665353425296, 4801.423829140525, 4823.589994850477, 4827.25177597473, 5337.8131765388025, 5349.170878513836, 5362.758675859595, 5365.651232669864, 5368.0605893968395, 5124.820631277962, 5124.948750512447, 5129.8717532062, 5130.204818253177, 5133.101707201225, 4989.925151122736, 5074.11203039474, 5120.1039818031695, 5125.8718532036255, 5142.434332223453, 5065.468125846733, 5096.388433388017, 5098.490150984946, 5110.233464980282, 5155.639105262596, 4904.926426103611, 5080.49195080489, 5097.617678674114, 5098.4646612105935, 5101.51535604117, 4291.678124140702, 4297.78511074445, 4345.587169218919, 4348.369486424451, 4351.0, 3797.35444974355, 3797.867074652374, 3829.1767270037076, 3835.846566137379, 3874.535055793323, 4359.542248063971, 4372.825086996484, 4374.650027997753, 4413.360062790877, 4416.050549131952, 4926.261060840831, 5078.314427552233, 5108.386993560796, 5129.1793313070475, 5173.741312934339, 4394.604485596312, 4397.582229688174, 4433.689641725048, 4441.0, 4442.755648439303, 4618.745968971672, 4649.163150632851, 4650.720956742606, 4657.930131048037, 4707.670463067621, 4686.039361930728, 4764.0, 4815.614750819926, 4820.975895120642, 4829.975850120727, 5145.588352931832, 5167.534921857051, 5167.948320516897, 5171.715555644476, 5208.765605547836, 4829.3072568601, 4838.419389673121, 4838.903221935612, 4840.685355451885, 4885.998370334144, 4830.106430310404, 5003.599712022957, 5035.874103147304, 5059.569936555434, 5133.666311689728, 5133.255677926754, 5146.536811686966, 5151.304573882478, 5163.302954101148, 5164.32863727713, 5002.474740152377, 5004.4495105537635, 5007.674501157413, 5007.84976450707, 5011.373578302712, 4825.9034819302715, 4921.31101645777, 4948.653594248368, 4981.028699403581, 5004.599632029502, 4889.095517329305, 4916.0, 4962.801487940442, 4963.404391473046, 4966.0, 4933.925991110064, 5032.446430892525, 5036.471170527042, 5037.19404895215, 5075.213341932006, 4920.704757714549, 4970.304157418037, 4974.427940786856, 4975.154223782039, 4990.051890140861], "value": 4712.998620981138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.8382269141948, 584.7953216374269, 593.6230493636542, 594.5659668442037, 595.4045954045954, 26694.86652566737, 29315.413691726153, 29341.0, 29344.70655293449, 29354.0, 29000.27499312513, 29507.40985180295, 39999.20001599973, 41607.79196104023, 41735.791321043354, 7837.333826624758, 7960.164182760814, 7971.481853679521, 7973.32226760726, 7977.042754869395, 7774.261445162729, 7881.0, 7882.251186137308, 7887.211278872124, 7887.408444366667, 7643.694252229904, 7830.412719046066, 7841.411894107936, 8045.637946292431, 10142.49287535624, 9993.600255989752, 10340.638077667321, 10353.06822385989, 10365.740856478573, 10376.792464150674, 9978.401295922267, 10152.593896244141, 10155.949220253926, 10156.542955566943, 10164.796704065877, 28882.855585722147, 29399.26501837471, 29453.0, 32016.679833201604, 38010.619893800984, 3045.670122075651, 3160.8261545614982, 3182.7772055956093, 3262.13553408347, 3556.982215088934, 27745.167644970683, 30332.393352133055, 30376.696233037608, 30585.08244752661, 30835.229119271975, 3526.612072672004, 3589.4974703541525, 3596.7841929484052, 3631.6005239423644, 3633.0554354148358, 245291.0, 249695.0, 250457.0, 250847.0, 251278.0, 35592.822035890174, 35671.28657426837, 35922.82038589843, 35924.46113308302, 35963.460548091796, 35739.28521429557, 36941.0, 36946.26107477889, 62424.0, 63020.0, 15017.924910375377, 15307.387704491919, 15315.310811013309, 15335.61660958485, 15338.693226135638, 9765.511724413751, 9814.06766357195, 9823.656172034087, 9882.0, 9899.059589339002, 19355.12901919417, 19381.61938857082, 19497.17140255656, 19500.34836269539, 19648.3123090694, 5714.485696287271, 7462.291082347168, 7482.2517748224745, 7554.32011118991, 7659.502132361378, 772.632999325316, 802.6789284286332, 863.7667829686076, 864.3906046237513, 931.7950050988771, 27001.459970800868, 28375.29061773431, 28387.290317742223, 28589.285267868054, 28770.568441473395, 874.908134645853, 920.1948295241664, 1012.3622118065572, 1021.99489002556, 1068.8289873620183, 14789.852101479062, 15086.849131508763, 15230.695386092217, 15464.38142474311, 15518.689626207413, 372950.0, 374837.0, 376314.0, 379166.0, 379353.0, 50303.24545131826, 50801.745991270545, 50826.74586627117, 50905.23642145371, 50907.745461273196, 1053.3890343600692, 1102.2119184782919, 1149.6091328948198, 1156.0289356940211, 1161.0885454918018, 27757.306067348476, 29178.854105729337, 29266.41467170602, 29380.265493362836, 30012.24969375783, 42713.786431067645, 43105.56894431016, 43218.135637287705, 43221.351679725456, 43233.0, 285966.0, 291957.0, 292172.0, 292181.0, 292830.0, 22948.885255573616, 23299.417514562272, 23299.88350058239, 24730.25809225726, 24843.751562484867, 41410.58589414067, 42067.15865682608, 42919.0, 43021.784891075346, 43949.0, 35377.469337960465, 37334.0, 38055.429168563045, 38083.619163808005, 38837.80581097076, 37023.81488092542, 37205.6279437213, 37456.2508749818, 37546.624533754315, 37734.81132594319, 36333.0, 36586.0, 36775.0, 37088.62911370852, 37088.81455592705, 29500.409991800472, 31673.20816979594, 33846.492302614985, 33859.64123095102, 34118.65881341254, 25570.360740981625, 25732.0, 25733.742662573135, 25809.096681616054, 26205.213843584723], "value": 17334.851318749144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.3607005774923, 370.233616414023, 372.87322310414487, 377.47907887115775, 380.5262448251927, 15596.454124105658, 16727.41454049107, 17451.389201377955, 17614.11929403531, 17698.734518982226, 16036.919815400935, 16223.83776162238, 17090.0, 17099.23053462594, 17156.742648860276, 5103.336566246392, 5247.685138891659, 5257.526822585966, 5282.366116066059, 5286.154215325549, 3734.2904848078915, 3889.2610404023144, 5117.948820511803, 5840.766369345221, 6168.660723660197, 6180.227471566054, 6191.164192833978, 6207.131001659771, 6208.875822483547, 6215.223097112861, 5935.37678543751, 6127.111568822518, 6131.080337949321, 6145.569810113294, 6155.507559395238, 3338.115399419156, 5057.645964782467, 5330.387005494379, 5371.919421208685, 5379.1662292344745, 19445.9027704862, 20099.497512562157, 20137.194512219492, 20238.69641955372, 20276.594468110703, 1821.2350812658583, 2009.859309848311, 2017.031824724126, 2098.8635738676935, 2162.632352500079, 9325.860112098324, 9367.203787678056, 9371.437713737198, 9580.0898914603, 9735.513224338754, 1674.2131198336883, 1710.3671641492726, 1798.2537247042462, 1801.2704854533936, 1830.8718389712726, 66340.0, 69565.65217173882, 70546.64726676384, 71302.0, 73013.26986730118, 9518.477603435094, 9929.702108936743, 10028.949855250678, 10143.442110683836, 10222.437765922945, 13748.381322840496, 13781.0, 13788.862111378758, 13803.861961380459, 13847.307634618228, 7293.817654558678, 7401.888971665429, 7457.142428620669, 7564.319211270902, 7605.923940760522, 7162.4270058395205, 7242.818929526804, 7245.456590755714, 7510.962445187848, 7548.056492938383, 4263.360495925574, 4358.084802191575, 4414.867553973386, 4463.174312752151, 4467.374567560544, 1586.325811530095, 1681.9495415137565, 1693.8729595280404, 1723.276223985929, 1751.6584266068248, 740.3521918321469, 754.1967804288415, 759.9354054905396, 791.3550456378033, 856.9914300856911, 16204.622607078294, 16405.507834764976, 17049.40327088571, 17147.0, 17448.65102697939, 791.6754130806457, 811.0024669656237, 838.4550042472441, 849.2059923971107, 867.9826403471895, 9241.445513269226, 9547.52262386878, 9571.688506140244, 9584.233261339075, 9592.232621390272, 367064.9880503589, 382274.0, 384458.0, 384908.0, 389110.0, 71472.64263678752, 76282.61858690671, 77082.22917770862, 77499.2250077492, 79723.0, 748.5359077372173, 857.9313654907593, 872.320782493697, 876.4390789894472, 878.5563290538365, 14207.786883196553, 14949.103053816805, 15025.549233523012, 16025.278862450985, 16161.515154545383, 26557.734422655525, 31856.0, 36318.818405907805, 36635.0, 36676.63323366732, 47420.0, 47512.0, 48278.5172148274, 49002.50997490122, 49220.753896230286, 7613.581253031137, 7624.627567037986, 7758.107817600822, 7800.882986755317, 7891.921080789119, 10720.35677859331, 11666.475008624802, 11816.82274765862, 12137.453814578541, 12176.269423834598, 10030.197584193393, 10119.848202276824, 10150.441725705157, 10259.127974122282, 10291.94854025725, 10152.695419137437, 10550.261481696207, 10556.472176390997, 10579.682609521727, 10822.458877056273, 10400.323978941344, 10455.68632941013, 10457.16342692598, 10622.36265824053, 10737.14102871784, 7771.533707977539, 7856.5678887661725, 7972.242636949481, 8003.0, 8055.355571554144, 10163.796724065625, 10424.635137770141, 10426.061654451136, 10539.841902371623, 10701.625443109453], "value": 8183.478455470144, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.4630282130104, 1358.1986627889546, 1407.1346122134887, 1485.3835658201847, 1674.0959881663894, 6686.13080299561, 7603.277688619579, 7760.573168475732, 7790.8831367529465, 8022.8395432091465, 7681.807954801133, 7834.315622141238, 7840.960795196016, 7855.685772569104, 7861.528308301506, 1878.1548303263587, 1942.922283108674, 1943.6987266973642, 2096.8951552422354, 2126.5109024924277, 1925.7689077310672, 2171.4896999205253, 2255.492514184312, 2256.244158207003, 2256.458449972003, 2184.191849015858, 2187.7702841201685, 2212.214663794354, 2213.889305534725, 2216.56776928499, 1823.6626224148574, 2189.7262842144733, 2220.678001689762, 2224.354937068248, 2226.9665955010687, 2177.520945392011, 2243.2036626997506, 2244.3491387497606, 2253.605619016682, 2253.752087270399, 7841.725539606144, 7871.21287871214, 7885.645145968445, 7892.0529536456, 7906.881396778996, 4529.932051019237, 4671.462781780071, 4671.976640116812, 4673.182193116225, 4676.438827340707, 2845.8434786086755, 2928.970710292891, 2981.1354707134906, 3033.6966303369486, 3040.4375190589813, 981.0924894472585, 982.0915653020999, 1006.2603986070233, 1031.5512751952924, 1032.26193271811, 10705.892941070568, 10924.945375273152, 10945.781084378268, 10968.616098436516, 10981.066609338215, 4143.129942712004, 4273.91452170961, 4304.418903448057, 4343.0, 4383.780810959439, 9387.0, 9399.34204605671, 9409.529523523934, 9451.905480945103, 9452.52737363129, 4774.474807771142, 4778.259369797687, 4779.856604301876, 4779.928301075487, 4781.6891902026255, 3663.3589121904092, 4114.979425102855, 4242.554531774119, 4304.5910638489295, 4314.482262128565, 3633.709303255733, 3741.6258374162912, 3745.082454798537, 3762.3415902217002, 3764.7741135531955, 1131.7849608574345, 1166.3235323512342, 1175.4886624318278, 1182.1429463638965, 1190.1133655426763, 852.2074470742269, 855.2089317381522, 856.3277826905974, 859.4843094143464, 876.4478378621428, 5403.378611459654, 5484.478974497416, 5569.415211402745, 5673.092305231144, 5930.644161350333, 817.2767101115437, 831.0650518167062, 841.381584535366, 884.6638277454655, 944.8771659684197, 3440.4839274108585, 3487.0, 3648.908777280536, 3785.413260944558, 3874.2638898609175, 9450.716478505656, 9877.456739879375, 9893.109620134222, 9901.356411833207, 9919.057689519628, 9469.810603787886, 9693.176080033276, 9817.361871478332, 9830.311878168459, 9833.508324583741, 7377.594232317167, 7392.519486233377, 7472.402207823361, 7479.102507699111, 7522.435817313723, 5416.593755468277, 5420.349558053059, 5449.3460784706085, 5466.5900057495055, 5509.063459211863, 9023.864642030507, 9245.86131208019, 9291.72124836256, 9315.86026209594, 9317.301202409983, 9084.0, 9369.297302702189, 9434.716958491255, 9545.47499887485, 9549.618015279311, 6573.408393244631, 6634.170728658918, 6720.193576770819, 6742.08981787472, 6746.190457145174, 7589.241075892367, 7592.0, 7599.734009309647, 7616.04799400075, 7704.614769261627, 6650.900236496554, 6828.351306625863, 6851.657417129024, 6930.930690693029, 6945.479089068239, 6636.236832764101, 6675.7329706813125, 6768.2216545097945, 6824.829379265558, 6860.5197636164985, 6092.360302168386, 6258.749650013949, 6268.498520118288, 6275.717592708248, 6409.679516024087, 4615.353850461005, 4617.492075871584, 4619.143674201814, 4623.907521849612, 4634.0, 4601.217792975135, 4666.253399456071, 4677.368555244999, 4681.110588988081, 4689.226277664147], "value": 4195.073838990563, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.06655832826533, 310.09297803923533, 312.7982451318899, 315.9684031596842, 317.2686956565118, 4882.7314497702655, 4898.779554920028, 4937.604991600672, 4940.382452193476, 4990.825321113762, 4788.497207793183, 4792.952070479294, 4816.7591620418925, 4877.7804998775055, 4887.142885703437, 3684.1710615111588, 3745.8501659933704, 3760.0975765816142, 3819.197968426634, 3883.669888059518, 3793.3688513938996, 3841.1165431950667, 3845.3078445879732, 3858.8070596470066, 3868.9226215475674, 3787.674313990109, 3793.127580656451, 3795.335816232162, 3808.0479880029993, 3813.713971452138, 3625.655562721537, 3668.596454390028, 3820.0, 3826.942595861064, 3844.404572102574, 3360.2439451123546, 3394.6435624259343, 3397.9830100849586, 3400.2009527760956, 3407.863685452579, 4682.719036857799, 4698.436187657503, 4702.5297470253045, 4753.714777113384, 4792.760361981922, 4211.873643790691, 4354.738715677069, 4377.7592232427205, 4406.317020861771, 4410.713303635285, 5028.4971502849785, 5065.924011139836, 5066.189409694432, 5094.566961808251, 5100.209467532539, 3701.167237371597, 3705.7035437164964, 3717.3680474319162, 3749.681277091423, 3755.8122093895195, 5116.360454943132, 5247.763850626731, 5305.1776974569, 5329.120695085307, 5339.839804805823, 3792.6156952712063, 3815.1797363566966, 3819.4652748615217, 3822.8088595570666, 3828.655421012122, 3882.320593896057, 3894.824732887027, 3895.610438956082, 3896.7272290939363, 3903.863364782219, 4300.828081818661, 4341.60925516705, 4369.169857727022, 4390.758508282075, 4391.824327026883, 4791.401074865642, 4994.227049397484, 5007.0, 5043.823466178666, 5084.0, 1292.7414517096618, 1297.0920355751011, 1297.1114786371365, 1297.9286139262242, 1300.0, 806.052887856766, 824.9917500825035, 833.4207725630629, 849.1211595998236, 856.1994535109692, 4396.714213576107, 4472.457002334189, 4475.865724028285, 4490.865274041784, 4504.301833215857, 5187.351581052369, 5230.764615592308, 5236.188390799356, 5258.237555554423, 5267.841964741064, 4493.505714371417, 4498.280275156025, 4505.324201369821, 4513.435820522434, 4514.277715565494, 2650.509655713699, 2816.9295767605563, 2817.577363395466, 2825.0, 2826.3781967967016, 4946.925796113062, 4970.502949705073, 4974.7512624369365, 4996.125678006334, 5009.974950125226, 5233.738313084331, 5289.312389389432, 5402.378726446509, 5424.810131645373, 5447.509724124848, 4873.512648735098, 4917.680350777188, 4925.335079764186, 4935.925961110586, 4938.23457364102, 5215.634905556574, 5217.6086793491395, 5218.947810521846, 5237.188235823453, 5239.266502689703, 4984.675996060245, 5052.267421223828, 5122.359705036871, 5123.3339665843205, 5137.537621614073, 4865.781039853145, 4893.486183950777, 4897.240927656219, 4916.7541622919425, 4917.557419832232, 3358.261182539935, 3383.509391138222, 3449.9482507762905, 3471.6007659119523, 3473.2185258316676, 4716.457607375059, 4822.9758851205515, 4826.251930950708, 4853.0, 4904.6566740327835, 5132.8460146195675, 5141.794328226829, 5142.382914050338, 5155.948440515697, 5165.173572228426, 5135.818761684759, 5145.845624631267, 5148.459411761711, 5158.226266060121, 5159.17453207485, 4819.2530157825595, 5010.549050585465, 5059.114654935445, 5080.593552515716, 5089.745512724275, 4902.313676085279, 4966.379202599675, 5126.923096153486, 5142.0, 5162.483751624807, 4976.253561965734, 4986.60375094974, 4988.0, 5043.747812609281, 5050.191969284897], "value": 3836.3658719448204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.6742624130485, 607.1196764691199, 659.4324703354848, 728.1553398058251, 737.5685224143875, 13198.208107513545, 13446.327683615817, 13509.121907076033, 13683.452661893538, 14062.718745625081, 12391.44238509267, 12481.438335274912, 12496.125271231018, 12513.562025329114, 12522.37388130592, 629.6442509981869, 754.6000619671555, 764.3159372361733, 764.8737958236912, 795.1333046978792, 762.778794149696, 769.742136384312, 770.445279398832, 785.650385578415, 791.9981223751959, 831.2020460358033, 835.0188528479043, 835.6573804740058, 835.7534527314426, 836.0970152235601, 658.4798009572432, 805.7099444200084, 812.29736278119, 819.9672013119468, 825.3149885594971, 614.6527212125135, 615.2678312807789, 617.0466629058071, 617.0620656601985, 617.222299902122, 12377.195482293711, 12387.318697471635, 12402.689932751664, 12422.0, 12439.689007774787, 12817.551385701548, 13281.468741250339, 13316.201027938354, 13554.93222533881, 13710.0, 11901.583444579484, 11990.580329688419, 12086.0, 12232.755344893052, 12796.61610151697, 4204.642605378546, 4236.195122926634, 4299.376590394407, 4331.068820203672, 4434.84478043267, 61602.69198653978, 61874.69062654658, 62237.377626224064, 64753.02870456994, 65245.347546524405, 10710.571577136983, 10912.836307455394, 10929.071028962468, 10974.780504389868, 11297.079496485618, 19204.231830726614, 19290.324838630862, 19362.515937101685, 19493.0, 19500.219991200476, 6784.660766961731, 6922.58464492122, 7194.820129496805, 7268.45486588508, 7306.488545801849, 3652.8538858445363, 3687.59436461989, 3702.3891057975134, 3704.7218709545164, 3765.4728338032696, 2901.8984335548153, 2971.8811247549856, 2974.8810047597854, 2978.9851050744605, 3001.849907504616, 518.8702824293927, 524.8923970586021, 531.3942105999164, 535.3254898827505, 539.9298091248191, 480.7572176051142, 519.0812262295716, 532.8401479556118, 570.0878594249168, 578.8914229250937, 7477.252274772588, 7582.241775822374, 7815.921840781633, 7910.683572657144, 7944.677066365549, 560.7308491923818, 564.542720396472, 569.2059576890215, 578.6875087452812, 597.2206270816627, 3543.645635436436, 3555.2000799820353, 3615.2769446110356, 3633.0644759274246, 3735.028892487973, 54012.0, 60788.13694904397, 89480.0, 89521.0, 89999.0, 49634.0, 68805.0, 79761.20238797653, 80896.59551702204, 81489.0, 45614.54385456169, 46679.29981050287, 69812.95280570796, 73123.63438182775, 76750.0, 6990.161180658353, 7055.0, 7109.21798602143, 7115.1106111736035, 7261.745838895613, 38799.80600096982, 42421.363679544214, 44310.335344970495, 44871.32693009542, 44934.55065449434, 55448.72275638596, 62639.373606263354, 63207.36792632015, 63822.0, 65184.674076629315, 9212.124848139416, 9269.768255793659, 9600.087991641063, 9635.181009614262, 9853.704388868346, 10645.414502202453, 10976.780464390828, 11147.163962702667, 11152.944235278772, 11828.408579570814, 10541.31481453703, 10606.734831628963, 10611.681649550526, 11037.724056898642, 11171.0, 9667.564959576977, 9719.368241064309, 9846.212303015598, 10217.59129634836, 10559.947200263949, 9864.260180486635, 9996.400215987063, 10091.949540252546, 10206.23453240995, 10410.739731506774, 8336.749897503085, 8469.195426434479, 8682.43564168327, 8807.427517211361, 9067.365284430027, 8689.652413903374, 8739.943449763236, 8872.689455869013, 9019.864702029607, 9355.4386736796], "value": 6313.268872075248, "unit": "score"}], "name": "dromaeo_css", "value": 6387.822750486063, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 112.0, 113.0, 111.0, 114.0, 112.0, 112.0, 113.0, 111.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 129.0, 131.0, 186.0, 131.0, 137.0, 174.0, 130.0, 170.0, 130.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 161.0, 159.0, 161.0, 162.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 78.0, 102.0, 75.0, 76.0, 74.0, 75.0, 100.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 112.0, 87.0, 87.0, 87.0, 120.0, 85.0, 86.0, 128.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 64.0, 64.0, 65.0, 65.0, 63.0, 65.0, 63.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 93.0, 83.0, 84.0, 84.0, 85.0, 84.0, 84.0, 113.0, 85.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 142.0, 129.0, 130.0, 134.0, 131.0, 128.0, 134.0, 132.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 168.0, 170.0, 168.0, 169.0, 167.0, 170.0, 170.0, 167.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 73.0, 66.0, 68.0, 67.0, 67.0, 66.0, 66.0, 64.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1542.0, "alertThreshold": 2.0}]} 06:17:22 INFO - Return code: 0 06:17:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:17:22 INFO - # TBPL SUCCESS # 06:17:22 INFO - Running post-action listener: _resource_record_post_action 06:17:22 INFO - ##### 06:17:22 INFO - ##### Finished run-tests step (success) 06:17:22 INFO - ##### 06:17:22 INFO - Running post-run listener: _resource_record_post_run 06:17:22 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534937600; Read time: 12; Write time: 530232 06:17:22 INFO - TinderboxPrint: CPU usage
13.2% 06:17:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:17:22 INFO - TinderboxPrint: I/O write bytes / time
534,937,600 / 530,232 06:17:22 INFO - TinderboxPrint: CPU idle
8,320.3 (86.8%) 06:17:22 INFO - TinderboxPrint: CPU user
1,215.7 (12.7%) 06:17:22 INFO - TinderboxPrint: Swap in / out
0 / 0 06:17:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246054912; Read time: 0; Write time: 274172 06:17:22 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288296960; Read time: 12; Write time: 256028 06:17:23 INFO - Running post-run listener: _upload_blobber_files 06:17:23 INFO - Blob upload gear active. 06:17:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:17:23 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 06:17:23 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'] 06:17:23 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 06:17:23 INFO - (blobuploader) - INFO - Open directory for files ... 06:17:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:17:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:24 INFO - (blobuploader) - INFO - Done attempting. 06:17:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:17:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:17:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:25 INFO - (blobuploader) - INFO - Done attempting. 06:17:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:17:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:17:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:28 INFO - (blobuploader) - INFO - Done attempting. 06:17:28 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:28 INFO - Return code: 0 06:17:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/22072cb0e5ad2756cb36f98bd36f51790a952e40a81ceb756b7390e9971236f6b5fcf4a7713fd93563dde98c572fee5a0466c45780e77aaa43335511494cdee1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc91c6638921d8fa72ae9247d0ced8613dcab5925907ab49392232f1fd6c2c1e43c3a7fcc0e772f6c43719ad7369b3f908ee6603aae808423b8c1e142525837a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf11c8ac178773b0d6f9c87d9c96c2937563b305976d69ad69105be4c7f102f7cbce617b519ff40836b9abf5e9c3618e73619d6f6293585ea8c987d9fc35d2ef"} 06:17:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:28 INFO - Contents: 06:17:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/22072cb0e5ad2756cb36f98bd36f51790a952e40a81ceb756b7390e9971236f6b5fcf4a7713fd93563dde98c572fee5a0466c45780e77aaa43335511494cdee1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc91c6638921d8fa72ae9247d0ced8613dcab5925907ab49392232f1fd6c2c1e43c3a7fcc0e772f6c43719ad7369b3f908ee6603aae808423b8c1e142525837a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf11c8ac178773b0d6f9c87d9c96c2937563b305976d69ad69105be4c7f102f7cbce617b519ff40836b9abf5e9c3618e73619d6f6293585ea8c987d9fc35d2ef"} 06:17:28 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:28 INFO - Copying logs to upload dir... 06:17:28 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.628303 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-22 06:17:28.327295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 06:17:28.330959) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557 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/22072cb0e5ad2756cb36f98bd36f51790a952e40a81ceb756b7390e9971236f6b5fcf4a7713fd93563dde98c572fee5a0466c45780e77aaa43335511494cdee1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc91c6638921d8fa72ae9247d0ced8613dcab5925907ab49392232f1fd6c2c1e43c3a7fcc0e772f6c43719ad7369b3f908ee6603aae808423b8c1e142525837a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf11c8ac178773b0d6f9c87d9c96c2937563b305976d69ad69105be4c7f102f7cbce617b519ff40836b9abf5e9c3618e73619d6f6293585ea8c987d9fc35d2ef"} build_url:https://queue.taskcluster.net/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/TtjZMnnVQEOdaS21kuv5Jw/artifacts/public/build/firefox-50.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/22072cb0e5ad2756cb36f98bd36f51790a952e40a81ceb756b7390e9971236f6b5fcf4a7713fd93563dde98c572fee5a0466c45780e77aaa43335511494cdee1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc91c6638921d8fa72ae9247d0ced8613dcab5925907ab49392232f1fd6c2c1e43c3a7fcc0e772f6c43719ad7369b3f908ee6603aae808423b8c1e142525837a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf11c8ac178773b0d6f9c87d9c96c2937563b305976d69ad69105be4c7f102f7cbce617b519ff40836b9abf5e9c3618e73619d6f6293585ea8c987d9fc35d2ef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 06:17:28.358087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:17:28.358491) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466598516.305281-1369715557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:17:28.442686) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 06:17:28.443042) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 06:17:28.443344) ========= ========= Total master_lag: 0.17 =========