builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1466068705.43 results: success (0) buildid: 20160616004126 builduid: e49a9bb372a24e188b8730869d96f74e revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.427230) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.428984) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.429353) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.464517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.464902) ========= 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=0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 02:18:25-- 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% 46.6M=0s 2016-06-16 02:18:25 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119651 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.615088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.615471) ========= 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=0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023028 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.672212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.672628) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6b40db1565705c392042da04396d1ca83c0d017d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6b40db1565705c392042da04396d1ca83c0d017d --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=0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 02:18:25,686 truncating revision to first 12 chars 2016-06-16 02:18:25,686 Setting DEBUG logging. 2016-06-16 02:18:25,686 attempt 1/10 2016-06-16 02:18:25,686 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6b40db156570?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 02:18:25,979 unpacking tar archive at: fx-team-6b40db156570/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696824 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:26.384056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:26.384360) ========= script_repo_revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:26.384793) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:26.385065) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:26.396602) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2016-06-16 02:18:26.396878) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:18:26 INFO - MultiFileLogger online at 20160616 02:18:26 in /builds/slave/test 02:18:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:18:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:18:26 INFO - {'append_to_log': False, 02:18:26 INFO - 'base_work_dir': '/builds/slave/test', 02:18:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:18:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:18:26 INFO - 'branch': 'Fx-Team-Non-PGO', 02:18:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:18:26 INFO - 'config_files': ('talos/linux_config.py',), 02:18:26 INFO - 'default_actions': ('clobber', 02:18:26 INFO - 'read-buildbot-config', 02:18:26 INFO - 'download-and-extract', 02:18:26 INFO - 'populate-webroot', 02:18:26 INFO - 'create-virtualenv', 02:18:26 INFO - 'install', 02:18:26 INFO - 'run-tests'), 02:18:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:18:26 INFO - 'download_minidump_stackwalk': True, 02:18:26 INFO - 'download_symbols': 'ondemand', 02:18:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:18:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:18:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:18:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:18:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:18:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:18:26 INFO - 'installer_path': 'installer.exe', 02:18:26 INFO - 'log_level': 'info', 02:18:26 INFO - 'log_name': 'talos', 02:18:26 INFO - 'log_to_console': True, 02:18:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:18:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:18:26 INFO - 'opt_config_files': (), 02:18:26 INFO - 'pip_index': False, 02:18:26 INFO - 'sps_profile': False, 02:18:26 INFO - 'sps_profile_interval': 0, 02:18:26 INFO - 'suite': 'dromaeojs', 02:18:26 INFO - 'system_bits': '32', 02:18:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:18:26 INFO - 'title': 'talos-linux64-ix-017', 02:18:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:18:26 INFO - 'use_talos_json': True, 02:18:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:18:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:18:26 INFO - 'work_dir': 'build'} 02:18:26 INFO - ##### 02:18:26 INFO - ##### Running clobber step. 02:18:26 INFO - ##### 02:18:26 INFO - Running pre-action listener: _resource_record_pre_action 02:18:26 INFO - Running main action method: clobber 02:18:26 INFO - rmtree: /builds/slave/test/build 02:18:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:18:26 INFO - Running post-action listener: _resource_record_post_action 02:18:26 INFO - ##### 02:18:26 INFO - ##### Finished clobber step (success) 02:18:26 INFO - ##### 02:18:26 INFO - ##### 02:18:26 INFO - ##### Running read-buildbot-config step. 02:18:26 INFO - ##### 02:18:26 INFO - Running pre-action listener: _resource_record_pre_action 02:18:26 INFO - Running main action method: read_buildbot_config 02:18:26 INFO - Using buildbot properties: 02:18:26 INFO - { 02:18:26 INFO - "project": "", 02:18:26 INFO - "product": "firefox", 02:18:26 INFO - "script_repo_revision": "production", 02:18:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:18:26 INFO - "repository": "", 02:18:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:18:26 INFO - "buildid": "20160616004126", 02:18:26 INFO - "pgo_build": "False", 02:18:26 INFO - "basedir": "/builds/slave/test", 02:18:26 INFO - "buildnumber": 1864, 02:18:26 INFO - "slavename": "talos-linux64-ix-017", 02:18:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:18:26 INFO - "platform": "ubuntu64_hw", 02:18:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:18:26 INFO - "branch": "fx-team", 02:18:26 INFO - "repo_path": "integration/fx-team", 02:18:26 INFO - "revision": "6b40db1565705c392042da04396d1ca83c0d017d", 02:18:26 INFO - "stage_platform": "linux64", 02:18:26 INFO - "builduid": "e49a9bb372a24e188b8730869d96f74e", 02:18:26 INFO - "slavebuilddir": "test" 02:18:26 INFO - } 02:18:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:18:26 INFO - Running post-action listener: _resource_record_post_action 02:18:26 INFO - ##### 02:18:26 INFO - ##### Finished read-buildbot-config step (success) 02:18:26 INFO - ##### 02:18:26 INFO - ##### 02:18:26 INFO - ##### Running download-and-extract step. 02:18:26 INFO - ##### 02:18:26 INFO - Running pre-action listener: _resource_record_pre_action 02:18:26 INFO - Running main action method: download_and_extract 02:18:26 INFO - mkdir: /builds/slave/test/build/tests 02:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:26 INFO - https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:18:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:18:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:18:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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 02:18:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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 02:18:29 INFO - Downloaded 1361 bytes. 02:18:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:18:29 INFO - Using the following test package requirements: 02:18:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:18:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:18:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:18:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:29 INFO - u'jsshell-linux-x86_64.zip'], 02:18:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:18:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:18:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:18:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:18:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:18:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:18:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:29 INFO - https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:18:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:18:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:18:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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 02:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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 02:18:35 INFO - Downloaded 22654315 bytes. 02:18:35 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'] 02:18:35 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 02:18:36 INFO - Return code: 0 02:18:36 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 02:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:36 INFO - https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:18:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:18:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:18:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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 02:18:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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 02:18:37 INFO - Downloaded 22654315 bytes. 02:18:37 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'] 02:18:37 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 02:18:38 INFO - Return code: 0 02:18:38 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')]} 02:18:38 INFO - https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:18:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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 02:18:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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 02:18:40 INFO - Downloaded 14405384 bytes. 02:18:40 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'] 02:18:40 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 02:18:40 INFO - Return code: 0 02:18:40 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')]} 02:18:40 INFO - https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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 02:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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 02:19:11 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:11 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 02:19:11 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 02:19:11 INFO - Server: 10.26.75.40 02:19:11 INFO - Address: 10.26.75.40#53 02:19:11 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 02:19:11 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 02:19:11 INFO - Address: 10.26.48.46 02:19:11 INFO - Return code: 0 02:19:11 INFO - retry: attempt #1 caught exception: 02:19:11 INFO - retry: Failed, sleeping 30 seconds before retrying 02:19:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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 #2 02:19:43 INFO - Downloaded 55447192 bytes. 02:19:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:43 INFO - mkdir: /builds/slave/test/properties 02:19:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:43 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:43 INFO - Contents: 02:19:43 INFO - build_url:https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:44 INFO - Running post-action listener: _resource_record_post_action 02:19:44 INFO - Running post-action listener: set_extra_try_arguments 02:19:44 INFO - ##### 02:19:44 INFO - ##### Finished download-and-extract step (success) 02:19:44 INFO - ##### 02:19:44 INFO - ##### 02:19:44 INFO - ##### Running populate-webroot step. 02:19:44 INFO - ##### 02:19:44 INFO - Running pre-action listener: _resource_record_pre_action 02:19:44 INFO - Running main action method: populate_webroot 02:19:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:19:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:19:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:19:44 INFO - '--tppagecycles', 02:19:44 INFO - '7'], 02:19:44 INFO - 'tests': ['tsvgm']}}, 02:19:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:19:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:19:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:44 INFO - 'talos_options': ['--disable-e10s'], 02:19:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:44 INFO - 'talos_options': ['--disable-e10s'], 02:19:44 INFO - 'tests': ['damp', 'tps']}, 02:19:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:44 INFO - 'tests': ['damp', 'tps']}, 02:19:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:19:44 INFO - 'tests': ['dromaeo_dom']}, 02:19:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:19:44 INFO - 'tests': ['basic_compositor_video']}, 02:19:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:19:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:19:44 INFO - 'tests': ['a11yr', 02:19:44 INFO - 'ts_paint', 02:19:44 INFO - 'tpaint', 02:19:44 INFO - 'sessionrestore', 02:19:44 INFO - 'sessionrestore_no_auto_restore', 02:19:44 INFO - 'tabpaint']}, 02:19:44 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:44 INFO - 'ts_paint', 02:19:44 INFO - 'tpaint', 02:19:44 INFO - 'sessionrestore', 02:19:44 INFO - 'sessionrestore_no_auto_restore', 02:19:44 INFO - 'tabpaint']}, 02:19:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:19:44 INFO - 'ts_paint', 02:19:44 INFO - 'tpaint', 02:19:44 INFO - 'sessionrestore', 02:19:44 INFO - 'sessionrestore_no_auto_restore', 02:19:44 INFO - 'tabpaint']}, 02:19:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:19:44 INFO - 'ts_paint', 02:19:44 INFO - 'tpaint', 02:19:44 INFO - 'sessionrestore', 02:19:44 INFO - 'sessionrestore_no_auto_restore', 02:19:44 INFO - 'tabpaint']}, 02:19:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:19:44 INFO - 'tests': ['a11yr', 02:19:44 INFO - 'ts_paint', 02:19:44 INFO - 'tpaint', 02:19:44 INFO - 'sessionrestore', 02:19:44 INFO - 'sessionrestore_no_auto_restore', 02:19:44 INFO - 'tabpaint']}, 02:19:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:19:44 INFO - 'tests': ['a11yr', 02:19:44 INFO - 'ts_paint', 02:19:44 INFO - 'tpaint', 02:19:44 INFO - 'sessionrestore', 02:19:44 INFO - 'sessionrestore_no_auto_restore', 02:19:44 INFO - 'tabpaint']}, 02:19:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:19:44 INFO - 'tests': ['tsvgx', 02:19:44 INFO - 'tsvgr_opacity', 02:19:44 INFO - 'tart', 02:19:44 INFO - 'tscrollx', 02:19:44 INFO - 'cart']}, 02:19:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:44 INFO - 'tsvgr_opacity', 02:19:44 INFO - 'tart', 02:19:44 INFO - 'tscrollx', 02:19:44 INFO - 'cart']}, 02:19:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:44 INFO - 'talos_options': ['--disable-e10s'], 02:19:44 INFO - 'tests': ['tp5o']}, 02:19:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:44 INFO - 'tests': ['tp5o']}, 02:19:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:44 INFO - 'talos_options': ['--disable-e10s', 02:19:44 INFO - '--xperf_path', 02:19:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:44 INFO - 'tests': ['tp5n']}, 02:19:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:44 INFO - 'talos_options': ['--xperf_path', 02:19:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:44 INFO - 'tests': ['tp5n']}}, 02:19:44 INFO - 'talos.zip': {'path': '', 02:19:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:19:44 INFO - Running post-action listener: _resource_record_post_action 02:19:44 INFO - ##### 02:19:44 INFO - ##### Finished populate-webroot step (success) 02:19:44 INFO - ##### 02:19:44 INFO - ##### 02:19:44 INFO - ##### Running create-virtualenv step. 02:19:44 INFO - ##### 02:19:44 INFO - Running pre-action listener: _resource_record_pre_action 02:19:44 INFO - Running main action method: create_virtualenv 02:19:44 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:44 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 02:19:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:19:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:44 INFO - Using real prefix '/usr' 02:19:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:45 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:46 INFO - Installing pip.................done. 02:19:46 INFO - Return code: 0 02:19:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f076d831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe1c0>, '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 0x13ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ff550>, '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': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', '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 02:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:19:47 INFO - Using env: {'DISPLAY': ':0', 02:19:47 INFO - 'HOME': '/home/cltbld', 02:19:47 INFO - 'LANG': 'en_US.UTF-8', 02:19:47 INFO - 'LANGUAGE': 'en_US:en', 02:19:47 INFO - 'LOGNAME': 'cltbld', 02:19:47 INFO - 'MAIL': '/var/mail/cltbld', 02:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:47 INFO - 'MOZ_NO_REMOTE': '1', 02:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:47 INFO - 'NO_EM_RESTART': '1', 02:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:47 INFO - 'PWD': '/builds/slave/test', 02:19:47 INFO - 'SHELL': '/bin/bash', 02:19:47 INFO - 'SHLVL': '1', 02:19:47 INFO - 'TERM': 'linux', 02:19:47 INFO - 'TMOUT': '86400', 02:19:47 INFO - 'USER': 'cltbld', 02:19:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', 02:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:47 INFO - '_': '/tools/buildbot/bin/python'} 02:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:47 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 02:19:47 INFO - Cleaning up... 02:19:47 INFO - Return code: 0 02:19:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19:47 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')]} 02:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:47 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')]} 02:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:47 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 0x7f076d831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe1c0>, '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 0x13ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ff550>, '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': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', '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 02:19:47 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 02:19:47 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 02:19:47 INFO - Using env: {'DISPLAY': ':0', 02:19:47 INFO - 'HOME': '/home/cltbld', 02:19:47 INFO - 'LANG': 'en_US.UTF-8', 02:19:47 INFO - 'LANGUAGE': 'en_US:en', 02:19:47 INFO - 'LOGNAME': 'cltbld', 02:19:47 INFO - 'MAIL': '/var/mail/cltbld', 02:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:47 INFO - 'MOZ_NO_REMOTE': '1', 02:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:47 INFO - 'NO_EM_RESTART': '1', 02:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:47 INFO - 'PWD': '/builds/slave/test', 02:19:47 INFO - 'SHELL': '/bin/bash', 02:19:47 INFO - 'SHLVL': '1', 02:19:47 INFO - 'TERM': 'linux', 02:19:47 INFO - 'TMOUT': '86400', 02:19:47 INFO - 'USER': 'cltbld', 02:19:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', 02:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:47 INFO - '_': '/tools/buildbot/bin/python'} 02:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:47 INFO - Downloading/unpacking psutil>=3.1.1 02:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:47 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 02:19:47 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 02:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:19:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:49 INFO - Installing collected packages: psutil 02:19:49 INFO - Running setup.py install for psutil 02:19:49 INFO - building 'psutil._psutil_linux' extension 02:19:49 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 02:19:49 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 02:19:49 INFO - building 'psutil._psutil_posix' extension 02:19:49 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 02:19:49 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 02:19:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:50 INFO - Successfully installed psutil 02:19:50 INFO - Cleaning up... 02:19:50 INFO - Return code: 0 02:19:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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')]} 02:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:50 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 0x7f076d831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe1c0>, '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 0x13ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ff550>, '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': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', '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 02:19:50 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 02:19:50 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 02:19:50 INFO - Using env: {'DISPLAY': ':0', 02:19:50 INFO - 'HOME': '/home/cltbld', 02:19:50 INFO - 'LANG': 'en_US.UTF-8', 02:19:50 INFO - 'LANGUAGE': 'en_US:en', 02:19:50 INFO - 'LOGNAME': 'cltbld', 02:19:50 INFO - 'MAIL': '/var/mail/cltbld', 02:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:50 INFO - 'MOZ_NO_REMOTE': '1', 02:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:50 INFO - 'NO_EM_RESTART': '1', 02:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:50 INFO - 'PWD': '/builds/slave/test', 02:19:50 INFO - 'SHELL': '/bin/bash', 02:19:50 INFO - 'SHLVL': '1', 02:19:50 INFO - 'TERM': 'linux', 02:19:50 INFO - 'TMOUT': '86400', 02:19:50 INFO - 'USER': 'cltbld', 02:19:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', 02:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:50 INFO - '_': '/tools/buildbot/bin/python'} 02:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:19:50 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 02:19:50 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 02:19:50 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 02:19:50 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 02:19:50 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 02:19:50 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 02:19:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:19:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:19:52 INFO - Installing collected packages: mozsystemmonitor 02:19:52 INFO - Running setup.py install for mozsystemmonitor 02:19:52 INFO - Successfully installed mozsystemmonitor 02:19:52 INFO - Cleaning up... 02:19:52 INFO - Return code: 0 02:19:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:19:52 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')]} 02:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:52 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')]} 02:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:52 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 0x7f076d831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe1c0>, '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 0x13ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ff550>, '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': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', '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 02:19:52 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 02:19:52 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 02:19:52 INFO - Using env: {'DISPLAY': ':0', 02:19:52 INFO - 'HOME': '/home/cltbld', 02:19:52 INFO - 'LANG': 'en_US.UTF-8', 02:19:52 INFO - 'LANGUAGE': 'en_US:en', 02:19:52 INFO - 'LOGNAME': 'cltbld', 02:19:52 INFO - 'MAIL': '/var/mail/cltbld', 02:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:52 INFO - 'MOZ_NO_REMOTE': '1', 02:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:52 INFO - 'NO_EM_RESTART': '1', 02:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:52 INFO - 'PWD': '/builds/slave/test', 02:19:52 INFO - 'SHELL': '/bin/bash', 02:19:52 INFO - 'SHLVL': '1', 02:19:52 INFO - 'TERM': 'linux', 02:19:52 INFO - 'TMOUT': '86400', 02:19:52 INFO - 'USER': 'cltbld', 02:19:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', 02:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:52 INFO - '_': '/tools/buildbot/bin/python'} 02:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:52 INFO - Downloading/unpacking jsonschema==2.5.1 02:19:52 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 02:19:52 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 02:19:52 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 02:19:52 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 02:19:52 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 02:19:52 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 02:19:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:19:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:19:54 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 02:19:54 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 02:19:54 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 02:19:54 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 02:19:54 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 02:19:54 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 02:19:54 INFO - Downloading functools32-3.2.3-2.tar.gz 02:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:19:54 INFO - warning: no files found matching '*.txt' 02:19:54 INFO - no previously-included directories found matching 'build' 02:19:54 INFO - no previously-included directories found matching 'dist' 02:19:54 INFO - no previously-included directories found matching '.git*' 02:19:54 INFO - Installing collected packages: jsonschema, functools32 02:19:54 INFO - Running setup.py install for functools32 02:19:54 INFO - warning: no files found matching '*.txt' 02:19:54 INFO - no previously-included directories found matching 'build' 02:19:54 INFO - no previously-included directories found matching 'dist' 02:19:54 INFO - no previously-included directories found matching '.git*' 02:19:54 INFO - Successfully installed jsonschema functools32 02:19:54 INFO - Cleaning up... 02:19:54 INFO - Return code: 0 02:19:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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')]} 02:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:54 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 0x7f076d831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe1c0>, '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 0x13ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ff550>, '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': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', '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 02:19:54 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 02:19:54 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 02:19:54 INFO - Using env: {'DISPLAY': ':0', 02:19:54 INFO - 'HOME': '/home/cltbld', 02:19:54 INFO - 'LANG': 'en_US.UTF-8', 02:19:54 INFO - 'LANGUAGE': 'en_US:en', 02:19:54 INFO - 'LOGNAME': 'cltbld', 02:19:54 INFO - 'MAIL': '/var/mail/cltbld', 02:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:54 INFO - 'MOZ_NO_REMOTE': '1', 02:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:54 INFO - 'NO_EM_RESTART': '1', 02:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:54 INFO - 'PWD': '/builds/slave/test', 02:19:54 INFO - 'SHELL': '/bin/bash', 02:19:54 INFO - 'SHLVL': '1', 02:19:54 INFO - 'TERM': 'linux', 02:19:54 INFO - 'TMOUT': '86400', 02:19:54 INFO - 'USER': 'cltbld', 02:19:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', 02:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:54 INFO - '_': '/tools/buildbot/bin/python'} 02:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:55 INFO - Downloading/unpacking blobuploader==1.2.4 02:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:55 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 02:19:55 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 02:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:56 INFO - Downloading blobuploader-1.2.4.tar.gz 02:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:19:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:57 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 02:19:57 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 02:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:19:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:57 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 02:19:57 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 02:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:57 INFO - Downloading docopt-0.6.1.tar.gz 02:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:19:57 INFO - Installing collected packages: blobuploader, requests, docopt 02:19:57 INFO - Running setup.py install for blobuploader 02:19:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:19:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:19:57 INFO - Running setup.py install for requests 02:19:58 INFO - Running setup.py install for docopt 02:19:58 INFO - Successfully installed blobuploader requests docopt 02:19:58 INFO - Cleaning up... 02:19:58 INFO - Return code: 0 02:19:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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')]} 02:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:58 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 0x7f076d831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe1c0>, '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 0x13ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ff550>, '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': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', '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 02:19:58 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 02:19:58 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 02:19:58 INFO - Using env: {'DISPLAY': ':0', 02:19:58 INFO - 'HOME': '/home/cltbld', 02:19:58 INFO - 'LANG': 'en_US.UTF-8', 02:19:58 INFO - 'LANGUAGE': 'en_US:en', 02:19:58 INFO - 'LOGNAME': 'cltbld', 02:19:58 INFO - 'MAIL': '/var/mail/cltbld', 02:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:58 INFO - 'MOZ_NO_REMOTE': '1', 02:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:58 INFO - 'NO_EM_RESTART': '1', 02:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:58 INFO - 'PWD': '/builds/slave/test', 02:19:58 INFO - 'SHELL': '/bin/bash', 02:19:58 INFO - 'SHLVL': '1', 02:19:58 INFO - 'TERM': 'linux', 02:19:58 INFO - 'TMOUT': '86400', 02:19:58 INFO - 'USER': 'cltbld', 02:19:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', 02:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:58 INFO - '_': '/tools/buildbot/bin/python'} 02:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:58 INFO - Running setup.py (path:/tmp/pip-CU_TCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:58 INFO - Running setup.py (path:/tmp/pip-awrAFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:58 INFO - Running setup.py (path:/tmp/pip-LrTbRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:58 INFO - Running setup.py (path:/tmp/pip-E6RcES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:58 INFO - Running setup.py (path:/tmp/pip-WPhNBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:58 INFO - Running setup.py (path:/tmp/pip-6oFomw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:59 INFO - Running setup.py (path:/tmp/pip-L0OLsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:59 INFO - Running setup.py (path:/tmp/pip-FA4izB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:59 INFO - Running setup.py (path:/tmp/pip-0t7Bmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:59 INFO - Running setup.py (path:/tmp/pip-xVcbAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:59 INFO - Running setup.py (path:/tmp/pip-zXZi_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:59 INFO - Running setup.py (path:/tmp/pip-vKgOip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:59 INFO - Running setup.py (path:/tmp/pip-05RURB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:59 INFO - Running setup.py (path:/tmp/pip-MzY6hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:59 INFO - Running setup.py (path:/tmp/pip-M_Pztg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:59 INFO - Running setup.py (path:/tmp/pip-bSP5fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:59 INFO - Running setup.py (path:/tmp/pip-_7mCow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:19:59 INFO - Running setup.py install for manifestparser 02:19:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:19:59 INFO - Running setup.py install for mozcrash 02:19:59 INFO - Running setup.py install for mozdebug 02:20:00 INFO - Running setup.py install for mozdevice 02:20:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:00 INFO - Running setup.py install for mozfile 02:20:00 INFO - Running setup.py install for mozhttpd 02:20:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:00 INFO - Running setup.py install for mozinfo 02:20:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:00 INFO - Running setup.py install for mozInstall 02:20:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:00 INFO - Running setup.py install for mozleak 02:20:00 INFO - Running setup.py install for mozlog 02:20:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:00 INFO - Running setup.py install for moznetwork 02:20:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:00 INFO - Running setup.py install for mozprocess 02:20:01 INFO - Running setup.py install for mozprofile 02:20:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:01 INFO - Running setup.py install for mozrunner 02:20:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:01 INFO - Running setup.py install for mozscreenshot 02:20:01 INFO - Running setup.py install for moztest 02:20:01 INFO - Running setup.py install for mozversion 02:20:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:01 INFO - Cleaning up... 02:20:01 INFO - Return code: 0 02:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:01 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 0x7f076d831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe1c0>, '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 0x13ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ff550>, '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': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', '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 02:20:01 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 02:20:01 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 02:20:01 INFO - Using env: {'DISPLAY': ':0', 02:20:01 INFO - 'HOME': '/home/cltbld', 02:20:01 INFO - 'LANG': 'en_US.UTF-8', 02:20:01 INFO - 'LANGUAGE': 'en_US:en', 02:20:01 INFO - 'LOGNAME': 'cltbld', 02:20:01 INFO - 'MAIL': '/var/mail/cltbld', 02:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:01 INFO - 'MOZ_NO_REMOTE': '1', 02:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:01 INFO - 'NO_EM_RESTART': '1', 02:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:01 INFO - 'PWD': '/builds/slave/test', 02:20:01 INFO - 'SHELL': '/bin/bash', 02:20:01 INFO - 'SHLVL': '1', 02:20:01 INFO - 'TERM': 'linux', 02:20:01 INFO - 'TMOUT': '86400', 02:20:01 INFO - 'USER': 'cltbld', 02:20:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', 02:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:01 INFO - '_': '/tools/buildbot/bin/python'} 02:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:01 INFO - Running setup.py (path:/tmp/pip-d5hRBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:01 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)) 02:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:01 INFO - Running setup.py (path:/tmp/pip-DREyXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:01 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)) 02:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:01 INFO - Running setup.py (path:/tmp/pip-OaXHok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:02 INFO - Running setup.py (path:/tmp/pip-usi8vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:02 INFO - Running setup.py (path:/tmp/pip-4HtDCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:02 INFO - Running setup.py (path:/tmp/pip-uVtUiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:02 INFO - Running setup.py (path:/tmp/pip-rygbg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:02 INFO - Running setup.py (path:/tmp/pip-5hUj_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:02 INFO - Running setup.py (path:/tmp/pip-20wIjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:02 INFO - Running setup.py (path:/tmp/pip-CHF6I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:02 INFO - Running setup.py (path:/tmp/pip-K5L5Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:02 INFO - Running setup.py (path:/tmp/pip-kTtvKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:02 INFO - Running setup.py (path:/tmp/pip-wqS6wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:02 INFO - Running setup.py (path:/tmp/pip-JLIH64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:02 INFO - Running setup.py (path:/tmp/pip-jXigEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:02 INFO - Running setup.py (path:/tmp/pip-Or6esg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:02 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)) 02:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:02 INFO - Running setup.py (path:/tmp/pip-pv8vKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:03 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 02:20:03 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 02:20:03 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 02:20:03 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 02:20:03 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 02:20:03 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 02:20:05 INFO - Downloading blessings-1.6.tar.gz 02:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:05 INFO - Installing collected packages: blessings 02:20:05 INFO - Running setup.py install for blessings 02:20:05 INFO - Successfully installed blessings 02:20:05 INFO - Cleaning up... 02:20:05 INFO - Return code: 0 02:20:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:05 INFO - Reading from file tmpfile_stdout 02:20:05 INFO - Current package versions: 02:20:05 INFO - argparse == 1.2.1 02:20:05 INFO - blessings == 1.6 02:20:05 INFO - blobuploader == 1.2.4 02:20:05 INFO - docopt == 0.6.1 02:20:05 INFO - functools32 == 3.2.3-2 02:20:05 INFO - jsonschema == 2.5.1 02:20:05 INFO - manifestparser == 1.1 02:20:05 INFO - mozInstall == 1.12 02:20:05 INFO - mozcrash == 0.17 02:20:05 INFO - mozdebug == 0.1 02:20:05 INFO - mozdevice == 0.48 02:20:05 INFO - mozfile == 1.2 02:20:05 INFO - mozhttpd == 0.7 02:20:05 INFO - mozinfo == 0.9 02:20:05 INFO - mozleak == 0.1 02:20:05 INFO - mozlog == 3.2 02:20:05 INFO - moznetwork == 0.27 02:20:05 INFO - mozprocess == 0.22 02:20:05 INFO - mozprofile == 0.28 02:20:05 INFO - mozrunner == 6.11 02:20:05 INFO - mozscreenshot == 0.1 02:20:05 INFO - mozsystemmonitor == 0.3 02:20:05 INFO - moztest == 0.7 02:20:05 INFO - mozversion == 1.4 02:20:05 INFO - psutil == 3.1.1 02:20:05 INFO - requests == 1.2.3 02:20:05 INFO - wsgiref == 0.1.2 02:20:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:05 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 0x7f076d831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe1c0>, '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 0x13ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ff550>, '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': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', '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 02:20:05 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 02:20:05 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 02:20:05 INFO - Using env: {'DISPLAY': ':0', 02:20:05 INFO - 'HOME': '/home/cltbld', 02:20:05 INFO - 'LANG': 'en_US.UTF-8', 02:20:05 INFO - 'LANGUAGE': 'en_US:en', 02:20:05 INFO - 'LOGNAME': 'cltbld', 02:20:05 INFO - 'MAIL': '/var/mail/cltbld', 02:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:05 INFO - 'MOZ_NO_REMOTE': '1', 02:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:05 INFO - 'NO_EM_RESTART': '1', 02:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:05 INFO - 'PWD': '/builds/slave/test', 02:20:05 INFO - 'SHELL': '/bin/bash', 02:20:05 INFO - 'SHLVL': '1', 02:20:05 INFO - 'TERM': 'linux', 02:20:05 INFO - 'TMOUT': '86400', 02:20:05 INFO - 'USER': 'cltbld', 02:20:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', 02:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:05 INFO - '_': '/tools/buildbot/bin/python'} 02:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:05 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)) 02:20:05 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)) 02:20:05 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)) 02:20:05 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)) 02:20:05 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)) 02:20:05 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)) 02:20:05 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)) 02:20:05 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)) 02:20:05 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)) 02:20:05 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)) 02:20:05 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)) 02:20:05 INFO - Cleaning up... 02:20:05 INFO - Return code: 0 02:20:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:05 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 0x7f076d831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe1c0>, '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 0x13ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ff550>, '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': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', '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 02:20:05 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 02:20:05 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 02:20:05 INFO - Using env: {'DISPLAY': ':0', 02:20:05 INFO - 'HOME': '/home/cltbld', 02:20:05 INFO - 'LANG': 'en_US.UTF-8', 02:20:05 INFO - 'LANGUAGE': 'en_US:en', 02:20:05 INFO - 'LOGNAME': 'cltbld', 02:20:05 INFO - 'MAIL': '/var/mail/cltbld', 02:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:05 INFO - 'MOZ_NO_REMOTE': '1', 02:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:05 INFO - 'NO_EM_RESTART': '1', 02:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:05 INFO - 'PWD': '/builds/slave/test', 02:20:05 INFO - 'SHELL': '/bin/bash', 02:20:05 INFO - 'SHLVL': '1', 02:20:05 INFO - 'TERM': 'linux', 02:20:05 INFO - 'TMOUT': '86400', 02:20:05 INFO - 'USER': 'cltbld', 02:20:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', 02:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:05 INFO - '_': '/tools/buildbot/bin/python'} 02:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:20:06 INFO - Cleaning up... 02:20:06 INFO - Return code: 0 02:20:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f076d831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe1c0>, '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 0x13ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ff550>, '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': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', '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 02:20: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', 'flake8'] in /builds/slave/test/build 02:20: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 flake8 02:20:06 INFO - Using env: {'DISPLAY': ':0', 02:20:06 INFO - 'HOME': '/home/cltbld', 02:20:06 INFO - 'LANG': 'en_US.UTF-8', 02:20:06 INFO - 'LANGUAGE': 'en_US:en', 02:20:06 INFO - 'LOGNAME': 'cltbld', 02:20:06 INFO - 'MAIL': '/var/mail/cltbld', 02:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:06 INFO - 'MOZ_NO_REMOTE': '1', 02:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:06 INFO - 'NO_EM_RESTART': '1', 02:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:06 INFO - 'PWD': '/builds/slave/test', 02:20:06 INFO - 'SHELL': '/bin/bash', 02:20:06 INFO - 'SHLVL': '1', 02:20:06 INFO - 'TERM': 'linux', 02:20:06 INFO - 'TMOUT': '86400', 02:20:06 INFO - 'USER': 'cltbld', 02:20:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', 02:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:06 INFO - '_': '/tools/buildbot/bin/python'} 02:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:06 INFO - Downloading/unpacking flake8 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:20:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:20:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:20:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:08 INFO - no previously-included directories found matching 'docs/_build' 02:20:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:20:08 INFO - Running setup.py install for pep8 02:20:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:08 INFO - no previously-included directories found matching 'docs/_build' 02:20:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:20:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:20:09 INFO - Cleaning up... 02:20:09 INFO - Return code: 0 02:20:09 INFO - Running post-action listener: _resource_record_post_action 02:20:09 INFO - Running post-action listener: _start_resource_monitoring 02:20:09 INFO - Starting resource monitoring. 02:20:09 INFO - ##### 02:20:09 INFO - ##### Finished create-virtualenv step (success) 02:20:09 INFO - ##### 02:20:09 INFO - ##### 02:20:09 INFO - ##### Running install step. 02:20:09 INFO - ##### 02:20:09 INFO - Running pre-action listener: _resource_record_pre_action 02:20:09 INFO - Running main action method: install 02:20:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:09 INFO - Reading from file tmpfile_stdout 02:20:09 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:09 INFO - Reading from file tmpfile_stdout 02:20:09 INFO - Output received: 02:20:09 INFO - Usage: mozinstall [options] installer 02:20:09 INFO - Options: 02:20:09 INFO - -h, --help show this help message and exit 02:20:09 INFO - -d DEST, --destination=DEST 02:20:09 INFO - Directory to install application into. [default: 02:20:09 INFO - "/builds/slave/test"] 02:20:09 INFO - --app=APP Application being installed. [default: firefox] 02:20:09 INFO - mkdir: /builds/slave/test/build/application 02:20:09 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'] 02:20:09 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 02:20:25 INFO - Reading from file tmpfile_stdout 02:20:25 INFO - Output received: 02:20:25 INFO - /builds/slave/test/build/application/firefox/firefox 02:20:25 INFO - Running post-action listener: _resource_record_post_action 02:20:25 INFO - ##### 02:20:25 INFO - ##### Finished install step (success) 02:20:25 INFO - ##### 02:20:25 INFO - ##### 02:20:25 INFO - ##### Running run-tests step. 02:20:25 INFO - ##### 02:20:25 INFO - Running pre-action listener: _resource_record_pre_action 02:20:25 INFO - Running main action method: run_tests 02:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:20:25 INFO - Python 2.7.3 02:20:25 INFO - Return code: 0 02:20:25 INFO - grabbing minidump binary from tooltool 02:20:25 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')]} 02:20:25 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 0x13fe1c0>, '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 0x13ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ff550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:20:25 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 02:20:25 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 02:20:25 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 02:20:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:20:25 INFO - Return code: 0 02:20:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:20:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:20:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:20:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:20:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:20:26 INFO - Return code: 0 02:20:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 02:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 02:20:26 INFO - Using env: {'DISPLAY': ':0', 02:20:26 INFO - 'HOME': '/home/cltbld', 02:20:26 INFO - 'LANG': 'en_US.UTF-8', 02:20:26 INFO - 'LANGUAGE': 'en_US:en', 02:20:26 INFO - 'LOGNAME': 'cltbld', 02:20:26 INFO - 'MAIL': '/var/mail/cltbld', 02:20:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:20:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:26 INFO - 'MOZ_NO_REMOTE': '1', 02:20:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:26 INFO - 'NO_EM_RESTART': '1', 02:20:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:26 INFO - 'PWD': '/builds/slave/test', 02:20:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:20:26 INFO - 'SHELL': '/bin/bash', 02:20:26 INFO - 'SHLVL': '1', 02:20:26 INFO - 'TERM': 'linux', 02:20:26 INFO - 'TMOUT': '86400', 02:20:26 INFO - 'USER': 'cltbld', 02:20:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291', 02:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:26 INFO - '_': '/tools/buildbot/bin/python'} 02:20:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 02:20:26 INFO - mozversion application_buildid: 20160616004126 02:20:26 INFO - mozversion application_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 02:20:26 INFO - mozversion application_display_name: Nightly 02:20:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:20:26 INFO - mozversion application_name: Firefox 02:20:26 INFO - mozversion application_remotingname: firefox 02:20:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:20:26 INFO - mozversion application_vendor: Mozilla 02:20:26 INFO - mozversion application_version: 50.0a1 02:20:26 INFO - mozversion platform_buildid: 20160616004126 02:20:26 INFO - mozversion platform_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 02:20:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:20:26 INFO - mozversion platform_version: 50.0a1 02:20:26 INFO - using testdate: 1466068826 02:20:26 INFO - actual date: 1466068826 02:20:26 INFO - starting webserver on 'localhost:43667' 02:20:26 INFO - SUITE-START | Running 2 tests 02:20:26 INFO - TEST-START | dromaeo_css 02:20:26 INFO - operating with platform_type : linux_ 02:20:26 INFO - Initialising browser for dromaeo_css test... 02:20:26 INFO - TEST-INFO | started process 6319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS9AvhW/profile http://localhost:43667/getInfo.html) 02:20:30 INFO - PROCESS | 6319 | __metrics Screen width/height:1600/1200 02:20:30 INFO - PROCESS | 6319 | colorDepth:24 02:20:30 INFO - PROCESS | 6319 | Browser inner width/height: 1024/697 02:20:30 INFO - PROCESS | 6319 | __metrics 02:20:31 INFO - PROCESS | 6319 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:20:32 INFO - TEST-INFO | 6319: exit 0 02:20:32 INFO - Browser initialized. 02:20:32 INFO - Running cycle 1/1 for dromaeo_css test... 02:20:32 INFO - TEST-INFO | started process 6403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS9AvhW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:45 INFO - PROCESS | 6403 | RSS: Main: 175353856 02:20:45 INFO - PROCESS | 6403 | 02:21:35 INFO - PROCESS | 6403 | 1466068895892 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] 02:23:49 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:43667/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43667/tests/dromaeo/cssquery-ext.html) 02:23:50 INFO - PROCESS | 6403 | RSS: Main: 275673088 02:23:50 INFO - PROCESS | 6403 | 02:26:52 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:43667/tests/dromaeo/cssquery-ext.html (next: http://localhost:43667/tests/dromaeo/cssquery-jquery.html) 02:26:53 INFO - PROCESS | 6403 | RSS: Main: 260288512 02:26:53 INFO - PROCESS | 6403 | 02:29:55 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:43667/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43667/tests/dromaeo/cssquery-mootools.html) 02:29:56 INFO - PROCESS | 6403 | RSS: Main: 256684032 02:29:56 INFO - PROCESS | 6403 | 02:32:58 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:43667/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43667/tests/dromaeo/cssquery-prototype.html) 02:32:59 INFO - PROCESS | 6403 | RSS: Main: 256303104 02:32:59 INFO - PROCESS | 6403 | 02:36:02 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:43667/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43667/tests/dromaeo/cssquery-yui.html) 02:36:02 INFO - PROCESS | 6403 | RSS: Main: 234999808 02:36:02 INFO - PROCESS | 6403 | 02:39:05 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:43667/tests/dromaeo/cssquery-yui.html (next: http://localhost:43667/tests/dromaeo/cssquery-dojo.html) 02:39:05 INFO - PROCESS | 6403 | RSS: Main: 292945920 02:39:05 INFO - PROCESS | 6403 | 02:39:05 INFO - PROCESS | 6403 | __start_tp_report 02:39:05 INFO - PROCESS | 6403 | _x_x_mozilla_page_load 02:39:05 INFO - PROCESS | 6403 | _x_x_mozilla_page_load_details 02:39:05 INFO - PROCESS | 6403 | |i|pagename|runs| 02:39:05 INFO - PROCESS | 6403 | |0;dojo.html;2585.9482810343793;2630.7369263073706;2654.4027593791398;2666.1201803404865;2677.4645070985807;4630.398048253723;4652.139354219467;4687.0625874825;4789.664723469358;4805.1831188697915;4702.764861756907;4740.8577742667685;4778.235482322829;4845.878853028676;4854.174790285651;4380.123975204956;4412.51462339144;4463.33050042493;4481.843135490259;4508.954910450902;4394.4946331172005;4449.132419178261;4453.421055262827;4519.073589914076;4532.9320060199125;4375.5405682403525;4441.5336389679105;4451.666125040619;4498.122866041123;4506.233940230169;4317.740935543878;4333.046729719456;4349.412829268072;4351.73889566627;4400.713953593038;4288.335308027261;4304.741715497049;4311.094670119279;4323.4163387942535;4330.458692663417;4742.33607294979;4759.4764575896625;4770.379850619432;4790.449098353699;4806.375171227753;4947.381577302837;5052.898942021176;5092.8217512387255;5138.743062846843;5145.073886700392;5136.486351364871;5179.7410129493755;5188.6367954243215;5224.843254702365;5227.111391063529;4849;4852.4662287148385;4860.927086093711;4863.124637565237;4875.414950205998;5072.619553533426;5260.342457192851;5312.760925758273;5327.413984461706;5338.145896656516;5123.154679477919;5178.352705911761;5179.741012949413;5199.922001169985;5201.5838732901275;5226.477352264743;5229.111051121318;5231.895362092737;5232.895342093213;5265.262863199156;4936.851894443173;5044.899102018013;5075.264086707407;5088.465711100281;5179.041877252645;5074.0359331727595;5086.05907907031;5087.160618497906;5096.745162741848;5133;4315.331123675835;4316.870493885189;4322;4325.437693099877;4378.846740364072;3677.4667673187237;3709.629037096323;3716.925661486755;3752.7185461090526;3799.981000094982;4336.457942757155;4338.349247612883;4342.5006124296115;4387.298032314814;4412;5110.182370820651;5118.283440318359;5119.0529751996;5125.56432703217;5129.256257842667;4211.284081706117;4317.244482215599;4343.478782546114;4354.085642015149;4384.517703052662;4588.449386073693;4604.401427814362;4611.077784443125;4613.515580863961;4659.324397962344;4731.881702957454;4822.614190864792;4824.541668541483;4826.662133650681;4861.538153875376;5025.447200807981;5068.366454193226;5076.238564215398;5146.511081447256;5151.5106064923775;4759.809607615656;4770.308305295782;4786.473487916396;4789.592884604847;4839.975800120977;4997.150484417585;4998.750062496933;5004.449510553909;5011.072951503984;5014.373203349582;4986.127427700066;5030.0694371541385;5062.265971434195;5088.338515992898;5114.028334616411;4957.231629097496;4962.379702537183;4963.503649635008;4982.352294201731;5013.072581572421;4906.2640603909695;4966.453690094015;4973.602111830973;4983.925241121314;5028.899422011466;4826.131296366688;4864.610831133572;4865.464798872192;4913.213885778401;4941.011797640558;5027.271045698426;5031.094403007493;5036.269740887477;5036.949630503648;5084.745762711776;4836.371271734652;4907.141250281115;4945.925811112764;4952.034353301072;4987.326710893983 02:39:05 INFO - PROCESS | 6403 | |1;ext.html;548.4947888149702;577.1458241802133;586.4340911020867;587.145703002132;601.5398220361425;26713.732862671368;38028.23943521128;38910.416343754834;39257.21485570287;39307;38717.41923871137;39066.80466597663;39261.21477570454;39280.41079383811;39301;7775.222477752222;7900.288973992339;7920.683172673086;7947.880781788278;7949;7753.069631644211;7847.058352997648;7847.372210223169;7851.646675899569;7852.646630901623;7830.451868369217;7882.093559240703;7883.054033515986;7886.132525422227;7890.447668663167;7814.648340824648;7854;7855.332296754783;7855.567943763091;7857.8035549111155;7706.229377062305;7792.883106753403;7808.063032436087;7808.804779880492;7812.921870781333;38668.226635467414;38735.61264387348;38769.22461550782;38906.02734931621;39160.216795664215;2970.1980465274255;3091.675374085711;3288.8848890288964;3360.5631267935255;3676.4117741161285;29563.408731825242;29588.55617165744;29717.70282297171;30044;30152.24619384511;3370.8370612138774;3391.0674564494716;3417.265287963075;3417.709494692954;3434.5019972104155;253019;253866;254199;256118;256561;54645.72677136589;54715.45284547104;55072;55106.44893551093;55328.17007744887;33120.1719957003;33771.83114084414;33932.49101263483;35141.29717405689;58163;13164.868351316556;13194.076414650883;13245.73508529824;13268.40292186854;13274.070815042855;10366.118879895294;10393.37639741618;10456.215783816244;10459.581616735397;10459.84310235347;18422.263109475472;18467.81532184688;18481.445556633324;18540.536486587942;18568.907155464138;6636.739019586264;6728.394444499921;6875.1749790025515;6982.371586557234;7048.788536343918;804.5816175588661;915.2494954137543;942.8821397325335;947.8341290274175;995.8605795188679;27691.86154069257;27709.861450692617;27772.166834994983;28403.431931361258;28559.14322570326;788.917163697815;961.5817119553017;964.3249725192394;974.6101559376306;981.7790997025755;14365.425382984773;14527.709445811024;14545.20001399912;14588;14820.481283155254;390818;393619;394037;394141;394193;47288.290675639895;48451.27323090156;48537.27194092092;48571.5142848574;48583.5141648579;1077.9137668986461;1156.4680247086267;1194.1103877611408;1198.6823491774687;1200.7238335182956;27382.5892611607;28081.719182807912;28550.42899141964;28917.277068073465;29196.27009324784;42252.78873605612;42355.7882210587;42729;42751.3587296197;42803.57196427996;295948;298389;298954;298967;300103;22383.44041398978;23526;24099.397515062265;24125;25402.745972540037;41188.1762364757;41420.378694319006;41528.79235603803;42323.57676423196;42598.5740142607;35633.64366356303;35787.82106089453;35833.82083089672;35891.820540897126;36136.193190340906;35201.64798352086;35980.46029309615;36200.27599448049;36215.27569448543;36386.45420318644;34467.827660861534;34879.65120348764;34904;35576.288474229856;35604.28791424105;31805;31875.526070693977;32514;32543.837280813445;32675;24767.628485573092;25054.62418063694;25127.390279984105;25215.243542693748;25602 02:39:05 INFO - PROCESS | 6403 | |2;jquery.html;350.491786908982;356.6576086956522;358.7919006975953;364.46423757077105;367.0255471722574;15889.364425422984;17174.3130274789;17329.393471228508;17726.734098988527;17789.733154002668;16126.838731612681;16706.916465417657;17659.55851103723;17686.734698979526;17688.823111768877;4940.086084074449;5064.164412871872;5069.594432445414;5103.56619687327;5151.278820965068;3717.34946384383;5084.79660813567;5651.124075768263;5970.373110823366;5987.461128498434;5993.370696076914;6000.579959402844;6012.669303188345;6019.699015049252;6020.367861374559;5720.628159169662;5919.88160236795;5920.526357891358;5921.792737254197;5930.347661757203;3347.866085356583;4857.198562237227;5159.793608255665;5172.379314482248;5178.922316165223;19626.607467850565;20179.293724719566;20372.490687732778;20426.38720838377;20465.4883627909;1920.9615807683908;2024.7064175694443;2472.443700167466;2502.1367628168255;2516.509280690266;13080.345982700826;13176.6705832354;13325.66685832862;13403.396847141901;13617;1745.6246906915073;1799.5501124718821;1863.8602104842191;1920.7983161768093;1947.3281717807333;63924;64607.03089453709;64671.02993455102;66195;66630;9428.764280892896;9481.4785186814;9621.08599683029;9686.418814871131;9715.805683886425;12934.223946563236;13027.869721302666;13057.738845223043;13087.345632718327;13090.672733181556;6930.237673855871;6974;7025.859482810418;7097.9645101775195;7118.822029449305;6595.769148079794;6626.204855417381;6737.056812046318;6763.628000460022;6768.492363072789;4037.152198038386;4084.1219137884905;4143.357779544175;4197.160567886435;4224.76763777989;1599.2723310893516;1611.7260065788844;1675.689997350494;1706.1298737643642;1734.826517348255;848.1620666484208;866.9176428239307;910.3400034974591;917;934.1499235695485;16257.67484650324;16498.092604906844;16546.751798723028;16553.25510352013;16956.406525771537;874.7026011156238;897.0804924951846;913.0458670689146;918.6049998500575;938.4134915677702;8892.8666070009;9234.722958311262;9557.808843823084;9696.127348538525;9710.320277580642;360156;363663;387444;389339;390445;73913;74423.25576744163;75544.62227688936;75611.62194189103;75990;863.4819108534829;885.2386947225381;893.5889490834289;899.8065415935605;903.074348792493;14606.858484910179;14689;14768;14936.775948360566;15072.924635376752;35534;35903.820480897426;36738.8163059183;36959;37257.068573285884;48755;50951.49048509468;51823;52200;52610.21084683656;7230.855382892418;7276.563406195645;7291.380232680282;7385.889211661722;7462.96268518654;10835.458227088771;11400.771984560428;11424.371659558805;11716.179867409199;11735.119866009913;9453.574589143367;9509.619615215313;10107.898921010696;10434.426106563908;10498.160147188053;10126.392416455037;10389.37663740178;10389.792204156025;10453.790924181625;10687.786244275227;10623.628173013907;10904.291221070605;10948.178886583379;10968.945155274172;10991.06575941022;6583.80248592543;6740.797776066725;7006.404455621329;7550.962245188739;7693.307602315818;9048.819023619359;9117.452952822852;9357.111074447917;9439.150476456876;9534.713958581253 02:39:05 INFO - PROCESS | 6403 | |3;mootools.html;1207.8973287270583;1347.1647578501327;1397.2315226625358;1450.5358285348686;1681.3862940026886;6796.524243302964;7485.326320631142;7762.534247945127;7779.10540287867;7983.161768014362;7681.615919204045;7807.297343239107;7843.52938823671;7849.48978316409;7851.489653172554;1882.557598964249;2107.3045894854663;2190.145843121184;2195.9670604940857;2221.9888900555475;2210.8784016879067;2233.475133343671;2235.0054225869494;2235.9217427390045;2237.574860776447;2153.192552792703;2173.5544213436287;2176.09691977829;2177.4556360909774;2177.923772667957;1803.6933721267417;2048.354768247997;2112.3029400297864;2115.058798834519;2125.341144245289;2128.531723020933;2147.95704085919;2150.8817015064164;2151.956960860774;2152.397328747953;7848.882266766003;7856.803579910491;7894.881576776353;7912.841743165162;7915.05019397676;4262.616364527176;4378.211921854065;4386.122775444892;4386.649068074546;4388.846390376321;2712.443948990452;2828.3070647691447;2830.3348713052624;2841.701621329772;2843.061789609424;915.8397280475957;948.7883514304131;957.4494665567327;970.8883478399933;973.0172525748974;10603.575856965635;10631.362118272851;10650.627228046982;10651.041406273473;10673.146148308117;4136.276151673445;4242.193983143193;4305.892352691208;4324.935125973113;4327.415798867176;9035.141661542142;9080.364374493854;9084.54577271147;9095.408798428214;9096.8635470468;4420.049689316812;4423.225935461282;4425.048614547888;4425.734455932655;4426.048399594103;3476.2699833035344;3967.444557761916;4070.715049946475;4098.057446787256;4126.546079931205;3567.7680950738118;3575.891473643127;3603.765755225902;3606.1165014571598;3664.3953747631344;1154.3362566524281;1158.2818652435376;1163.3310846263432;1176.129664048598;1185;774.6746366526072;781.4842204145236;798.5807451088109;814.621201141472;817.9938675429255;4840.273958906122;4958.983408401269;4960.553550180501;5014.247862820606;5096.490350964948;376.68170396015324;380.1219183685695;387.0884068019829;388.86778495311165;403.31839191765823;3298.422776014188;3415.5047518109736;3428.3828910796296;3454.758166928291;3466.3587236361354;9213.216876565433;9631.662891798753;9679.274054445805;9752.853707194397;9770.706878793648;9612.231021518402;9620.567074481665;9627.277954153467;9632;9660.516974151264;7289.927100729031;7381.483296169324;7387.85224295511;7404.370628496638;7424.294692004251;5318.388385335581;5407.729613519387;5511.145772405283;5631.831045068655;5661.122526008476;8557.144285571392;8770.736877893672;8844.319579279916;9046.728598142066;9102.31732620043;9036.322275829207;9125.361224714206;9198.448093114435;9307.488088155216;9307.534623268673;6151.200343955436;6586;6759.493038022267;6798.150231221098;6981.895271571032;7563.092428908566;7583.317501424898;7645.426593005658;7661.808454788675;7662.157162711986;6585.440237579668;6706.966465167643;6736.7642132525125;6818.522703410912;6943.305669433016;6586.571872828251;6706.295838936841;6886.655667216719;6928.965355173192;6955;6115.113308570143;6137.41694539018;6315.55791094619;6327.873442531216;6338.239411270677;4449.310356894686;4484.730916145042;4604.309353596987;4605.815767369268;4657.836975705834;4605.194091033989;4606.723596584216;4612.238980568303;4622.768861556841;4677.508861569486 02:39:05 INFO - PROCESS | 6403 | |4;prototype.html;270.3525057487319;279.2713105874636;282.82747524010335;284.13575374901336;291.8774114871754;4724.574788269055;4847.515248475151;4886.682365646235;4928.186849169882;4988.4263309719345;4648.674592778507;4791.185498465261;4817.855464336067;4818.494058123891;4876.2198048312275;3800.524934383195;3814.4469051987444;3826.827792749333;3835.271298453299;3837.846486140565;3626.3653860574427;3648.890533284006;3785.167263202105;3810.5236845394325;3824.9043773905596;3738.5513738351437;3742.3450896093077;3744.6817020553285;3762.51087358643;3775.7734535927793;3755.5681096673957;3757.380032294668;3772.7170462215445;3775.5469343678933;3776.15036616759;3318.5188147718445;3347.96652033479;3365.444701624229;3376.2909788944353;3382.8646854125805;4704.0356726870905;4745.240761478181;4749.833755818564;4753.453352864431;4790.568848803624;4267.97866010668;4283.357496375537;4290.871273861758;4292.420523229355;4336.978315108436;4917.483664215278;5034.496550344973;5049.570786483153;5051.520105589963;5132.40977287613;3559.2169722660974;3566.144125409909;3568.946465803015;3579.3378225028455;3584.8386822593047;5290.365156181244;5341.839744807662;5345.251664766897;5380.574147850823;5382.165764306539;3581.374896174309;3665.4605065872397;3670.944935825965;3672.3573374659327;3677.282929828658;3603.72972027099;3686.6866316362875;3690.3910854708674;3692.464592634107;3704.259148170323;4194.517630472474;4194.580541945842;4210.7684077375425;4255.212785634668;4258.467691538558;5056.115179843513;5101.387833459934;5106.157484015096;5112.105381558287;5129.743512824344;1200.9039276858005;1206.203905422417;1231.5320178332356;1234.5370486067725;1260.571405722059;781.3905153979905;806.4314658165979;813.9023317201974;816.1389733830865;820.7524562664836;3986.3023970804993;3987.840486380512;4003.3794761811964;4031.8992025199605;4086.979565102215;4605.976970115128;4638.281066434708;4642.86071417858;4670.416197975253;4685.718856868531;3981.5222173338807;4017.31705610047;4067.776272305052;4079.510978492888;4117.71466835903;2372.5610762009082;2482.416632091457;2500.612405077216;2502.87485625718;2507.8369905956056;4308;4364.406991448099;4384.610387338908;4430.316479737743;4460.50934397216;4714.945147173428;4731.4558825735485;4744.454387745384;4751.857444276678;4803.735794531264;4128.401381799622;4383.232934236496;4408.7575183365225;4432.999999999935;4436.157130145262;4633.907321853477;4645.910469537719;4649.883752906069;4656.650751193606;4659.464161621457;4525.456945166469;4588.839390621446;4590.954090459053;4596.931046034245;4620.214563524141;4070.9592904070582;4339.848105316299;4402.779861007001;4408.426904502394;4515.412996310459;3273.688999545039;3305.173706573357;3313.701766840996;3317.834108294527;3327.850246738854;4671.084855209348;4687.953120468888;4728.361671174485;4730.787114579921;4734.218853889208;4838.8790280241865;4955.2567114933045;5109.616778741535;5137.717425541631;5156.535911767809;5084.7966081356335;5100.6429549931145;5112.437631860418;5128.6153538485505;5138.3833939927445;4864.391951006124;4981.651284410202;4983.601311894967;4985.75071246429;5003.649744517848;5071.92392114126;5085.237214417719;5157;5161.200013997836;5173.715445650525;4992.475790041994;5002.3237567901;5030.673006254582;5060.190369541003;5062.974685126551 02:39:05 INFO - PROCESS | 6403 | |5;yui.html;709.3225969199415;717.1716667249328;735.3712575747736;752.984940301194;759.8290384663447;12254.264744115348;13858;14494.275286235672;14510.129392236473;14511.419543218259;13922.791158132635;13942.581722548315;14017.088889222194;14042.438302467914;14096.083754555972;632.7911789109583;775.9495632783851;800.0199755299755;808.0626473290984;808.8261023879865;795.2286282306183;805.8509175802466;806.2058872011064;806.3911746631285;807.8868958345836;836.0636087581917;844.6705784743924;844.8605980013322;845.213951025546;845.3997661660198;655.6295692933477;805.899262592176;831.966721331146;832.3133414932705;832.6627715775121;612.2683393344954;612.3662009819859;612.5130521235628;612.7303986246083;612.7457105301295;13525.323733813368;13531.631964406288;13577.864221357759;13593.252371119584;13621.523246686318;11778.705532361759;11926;12175.695607609792;12304.753904921941;12348.691282718004;11657.591984280594;11701.765964680659;11780.587679431179;11929.582464613697;11965.581204657883;4185.811638476276;4209.179210054041;4223.87328380146;4264.786760661955;4303.440552728157;61364;61378.38621613771;61918;62577.68711156415;62705;9867.605295788087;10170.644027459151;10216.080552750289;10284.331518451278;10454.790904181873;17851.196696148705;17862.821371786114;17895.642087158183;17903.820961790476;17905.552361191076;6487.610743355413;6573.901391479131;6634.402903738686;6770.966145169341;6895.310468953165;3542;3549.6450354964813;3570.4465807799834;3687.520622319135;3720.8511659533315;2778.499870023415;2860.0704770949524;2872.755815755684;2874.626298581171;2876.3096856754228;472.6667699272005;480.85814684668105;485.86638674364127;489.54961435479447;490.1740567144302;419.9202151591249;478.3852749217239;541.8347404041726;564.0608387035621;565.9405762394972;7423.517471364344;7450.627468626547;7811.726589569338;8063.435559510778;8095.069067057246;481.802460990992;486.9651989522265;500.76964596286115;533.5171669638983;549.631746729692;3761.5298087739034;3835.347990841564;3859.826307816155;3904.375299951994;3907.8241479133508;85441.57279213688;85563;87594;89115.10884891197;89698;77264;77833.22166778373;78460.60769696115;79287.60356198181;79785.20214797778;19401.51496212606;19512.219511219675;22707.88646056759;47747.04505909932;67712.32287677159;6640.833979150367;6815.42068924147;6969.895451568332;6977.33715297046;7054.717811287491;38823;40766;41032.179356413304;41876;41995.79002105092;37109.81445092757;38111.80944095262;50764.492355077455;56617.43382566122;60307.396926030175;11153.49809258569;11313.71715707114;11393.316401015965;11686.883131168579;11824.82262766042;11754.471048802654;11995.220310679779;12120.818187727367;12714.300713460478;12856.807147892976;12097.395130243276;12574.622761317176;12627.179233349803;12654.240745554927;13185.868141318464;12157.090231192993;12408.177891027768;12577.622671319876;12658.936705316415;12770.361481926053;11819.82270265964;11906.821397679216;12175.33035683046;12245.75508489843;12462.875371246171;9965.501724913871;10245.436500992218;10427.287329030247;10663.636997837337;10738.409387483764;10305.433201174008;10412.68761937143;10772.407517586294;10808.729781755519;10823.837642435212 02:39:05 INFO - PROCESS | 6403 | __end_tp_report 02:39:05 INFO - PROCESS | 6403 | __start_cc_report 02:39:05 INFO - PROCESS | 6403 | _x_x_mozilla_cycle_collect,925 02:39:05 INFO - PROCESS | 6403 | __end_cc_report 02:39:05 INFO - PROCESS | 6403 | __startTimestamp1466069945807__endTimestamp 02:39:05 INFO - PROCESS | 6403 | 02:39:05 INFO - PROCESS | 6403 | ------- Summary: start ------- 02:39:05 INFO - PROCESS | 6403 | Number of tests: 6 02:39:05 INFO - PROCESS | 6403 | 02:39:05 INFO - PROCESS | 6403 | [#0] dojo.html Cycles:165 Average:4725.87 Median:4854.17 stddev:509.81 (10.5%) stddev-sans-first:482.94 02:39:05 INFO - PROCESS | 6403 | Values: 2585.9 2630.7 2654.4 2666.1 2677.5 4630.4 4652.1 4687.1 4789.7 4805.2 4702.8 4740.9 4778.2 4845.9 4854.2 4380.1 4412.5 4463.3 4481.8 4509.0 4394.5 4449.1 4453.4 4519.1 4532.9 4375.5 4441.5 4451.7 4498.1 4506.2 4317.7 4333.0 4349.4 4351.7 4400.7 4288.3 4304.7 4311.1 4323.4 4330.5 4742.3 4759.5 4770.4 4790.4 4806.4 4947.4 5052.9 5092.8 5138.7 5145.1 5136.5 5179.7 5188.6 5224.8 5227.1 4849.0 4852.5 4860.9 4863.1 4875.4 5072.6 5260.3 5312.8 5327.4 5338.1 5123.2 5178.4 5179.7 5199.9 5201.6 5226.5 5229.1 5231.9 5232.9 5265.3 4936.9 5044.9 5075.3 5088.5 5179.0 5074.0 5086.1 5087.2 5096.7 5133.0 4315.3 4316.9 4322.0 4325.4 4378.8 3677.5 3709.6 3716.9 3752.7 3800.0 4336.5 4338.3 4342.5 4387.3 4412.0 5110.2 5118.3 5119.1 5125.6 5129.3 4211.3 4317.2 4343.5 4354.1 4384.5 4588.4 4604.4 4611.1 4613.5 4659.3 4731.9 4822.6 4824.5 4826.7 4861.5 5025.4 5068.4 5076.2 5146.5 5151.5 4759.8 4770.3 4786.5 4789.6 4840.0 4997.2 4998.8 5004.4 5011.1 5014.4 4986.1 5030.1 5062.3 5088.3 5114.0 4957.2 4962.4 4963.5 4982.4 5013.1 4906.3 4966.5 4973.6 4983.9 5028.9 4826.1 4864.6 4865.5 4913.2 4941.0 5027.3 5031.1 5036.3 5036.9 5084.7 4836.4 4907.1 4945.9 4952.0 4987.3 02:39:05 INFO - PROCESS | 6403 | 02:39:05 INFO - PROCESS | 6403 | [#1] ext.html Cycles:180 Average:46531.29 Median:36168.23 stddev:84471.54 (233.6%) stddev-sans-first:84637.95 02:39:05 INFO - PROCESS | 6403 | Values: 548.5 577.1 586.4 587.1 601.5 26713.7 38028.2 38910.4 39257.2 39307.0 38717.4 39066.8 39261.2 39280.4 39301.0 7775.2 7900.3 7920.7 7947.9 7949.0 7753.1 7847.1 7847.4 7851.6 7852.6 7830.5 7882.1 7883.1 7886.1 7890.4 7814.6 7854.0 7855.3 7855.6 7857.8 7706.2 7792.9 7808.1 7808.8 7812.9 38668.2 38735.6 38769.2 38906.0 39160.2 2970.2 3091.7 3288.9 3360.6 3676.4 29563.4 29588.6 29717.7 30044.0 30152.2 3370.8 3391.1 3417.3 3417.7 3434.5 253019.0 253866.0 254199.0 256118.0 256561.0 54645.7 54715.5 55072.0 55106.4 55328.2 33120.2 33771.8 33932.5 35141.3 58163.0 13164.9 13194.1 13245.7 13268.4 13274.1 10366.1 10393.4 10456.2 10459.6 10459.8 18422.3 18467.8 18481.4 18540.5 18568.9 6636.7 6728.4 6875.2 6982.4 7048.8 804.6 915.2 942.9 947.8 995.9 27691.9 27709.9 27772.2 28403.4 28559.1 788.9 961.6 964.3 974.6 981.8 14365.4 14527.7 14545.2 14588.0 14820.5 390818.0 393619.0 394037.0 394141.0 394193.0 47288.3 48451.3 48537.3 48571.5 48583.5 1077.9 1156.5 1194.1 1198.7 1200.7 27382.6 28081.7 28550.4 28917.3 29196.3 42252.8 42355.8 42729.0 42751.4 42803.6 295948.0 298389.0 298954.0 298967.0 300103.0 22383.4 23526.0 24099.4 24125.0 25402.7 41188.2 41420.4 41528.8 42323.6 42598.6 35633.6 35787.8 35833.8 35891.8 36136.2 35201.6 35980.5 36200.3 36215.3 36386.5 34467.8 34879.7 34904.0 35576.3 35604.3 31805.0 31875.5 32514.0 32543.8 32675.0 24767.6 25054.6 25127.4 25215.2 25602.0 02:39:05 INFO - PROCESS | 6403 | 02:39:05 INFO - PROCESS | 6403 | [#2] jquery.html Cycles:180 Average:23826.18 Median:26806.10 stddev:62441.78 (232.9%) stddev-sans-first:62592.07 02:39:05 INFO - PROCESS | 6403 | Values: 350.5 356.7 358.8 364.5 367.0 15889.4 17174.3 17329.4 17726.7 17789.7 16126.8 16706.9 17659.6 17686.7 17688.8 4940.1 5064.2 5069.6 5103.6 5151.3 3717.3 5084.8 5651.1 5970.4 5987.5 5993.4 6000.6 6012.7 6019.7 6020.4 5720.6 5919.9 5920.5 5921.8 5930.3 3347.9 4857.2 5159.8 5172.4 5178.9 19626.6 20179.3 20372.5 20426.4 20465.5 1921.0 2024.7 2472.4 2502.1 2516.5 13080.3 13176.7 13325.7 13403.4 13617.0 1745.6 1799.6 1863.9 1920.8 1947.3 63924.0 64607.0 64671.0 66195.0 66630.0 9428.8 9481.5 9621.1 9686.4 9715.8 12934.2 13027.9 13057.7 13087.3 13090.7 6930.2 6974.0 7025.9 7098.0 7118.8 6595.8 6626.2 6737.1 6763.6 6768.5 4037.2 4084.1 4143.4 4197.2 4224.8 1599.3 1611.7 1675.7 1706.1 1734.8 848.2 866.9 910.3 917.0 934.1 16257.7 16498.1 16546.8 16553.3 16956.4 874.7 897.1 913.0 918.6 938.4 8892.9 9234.7 9557.8 9696.1 9710.3 360156.0 363663.0 387444.0 389339.0 390445.0 73913.0 74423.3 75544.6 75611.6 75990.0 863.5 885.2 893.6 899.8 903.1 14606.9 14689.0 14768.0 14936.8 15072.9 35534.0 35903.8 36738.8 36959.0 37257.1 48755.0 50951.5 51823.0 52200.0 52610.2 7230.9 7276.6 7291.4 7385.9 7463.0 10835.5 11400.8 11424.4 11716.2 11735.1 9453.6 9509.6 10107.9 10434.4 10498.2 10126.4 10389.4 10389.8 10453.8 10687.8 10623.6 10904.3 10948.2 10968.9 10991.1 6583.8 6740.8 7006.4 7551.0 7693.3 9048.8 9117.5 9357.1 9439.2 9534.7 02:39:05 INFO - PROCESS | 6403 | 02:39:05 INFO - PROCESS | 6403 | [#3] mootools.html Cycles:180 Average:5101.97 Median:4899.63 stddev:2922.57 (59.6%) stddev-sans-first:2916.12 02:39:05 INFO - PROCESS | 6403 | Values: 1207.9 1347.2 1397.2 1450.5 1681.4 6796.5 7485.3 7762.5 7779.1 7983.2 7681.6 7807.3 7843.5 7849.5 7851.5 1882.6 2107.3 2190.1 2196.0 2222.0 2210.9 2233.5 2235.0 2235.9 2237.6 2153.2 2173.6 2176.1 2177.5 2177.9 1803.7 2048.4 2112.3 2115.1 2125.3 2128.5 2148.0 2150.9 2152.0 2152.4 7848.9 7856.8 7894.9 7912.8 7915.1 4262.6 4378.2 4386.1 4386.6 4388.8 2712.4 2828.3 2830.3 2841.7 2843.1 915.8 948.8 957.4 970.9 973.0 10603.6 10631.4 10650.6 10651.0 10673.1 4136.3 4242.2 4305.9 4324.9 4327.4 9035.1 9080.4 9084.5 9095.4 9096.9 4420.0 4423.2 4425.0 4425.7 4426.0 3476.3 3967.4 4070.7 4098.1 4126.5 3567.8 3575.9 3603.8 3606.1 3664.4 1154.3 1158.3 1163.3 1176.1 1185.0 774.7 781.5 798.6 814.6 818.0 4840.3 4959.0 4960.6 5014.2 5096.5 376.7 380.1 387.1 388.9 403.3 3298.4 3415.5 3428.4 3454.8 3466.4 9213.2 9631.7 9679.3 9752.9 9770.7 9612.2 9620.6 9627.3 9632.0 9660.5 7289.9 7381.5 7387.9 7404.4 7424.3 5318.4 5407.7 5511.1 5631.8 5661.1 8557.1 8770.7 8844.3 9046.7 9102.3 9036.3 9125.4 9198.4 9307.5 9307.5 6151.2 6586.0 6759.5 6798.2 6981.9 7563.1 7583.3 7645.4 7661.8 7662.2 6585.4 6707.0 6736.8 6818.5 6943.3 6586.6 6706.3 6886.7 6929.0 6955.0 6115.1 6137.4 6315.6 6327.9 6338.2 4449.3 4484.7 4604.3 4605.8 4657.8 4605.2 4606.7 4612.2 4622.8 4677.5 02:39:05 INFO - PROCESS | 6403 | 02:39:05 INFO - PROCESS | 6403 | [#4] prototype.html Cycles:180 Average:4045.58 Median:4431.66 stddev:1181.95 (26.7%) stddev-sans-first:1150.80 02:39:05 INFO - PROCESS | 6403 | Values: 270.4 279.3 282.8 284.1 291.9 4724.6 4847.5 4886.7 4928.2 4988.4 4648.7 4791.2 4817.9 4818.5 4876.2 3800.5 3814.4 3826.8 3835.3 3837.8 3626.4 3648.9 3785.2 3810.5 3824.9 3738.6 3742.3 3744.7 3762.5 3775.8 3755.6 3757.4 3772.7 3775.5 3776.2 3318.5 3348.0 3365.4 3376.3 3382.9 4704.0 4745.2 4749.8 4753.5 4790.6 4268.0 4283.4 4290.9 4292.4 4337.0 4917.5 5034.5 5049.6 5051.5 5132.4 3559.2 3566.1 3568.9 3579.3 3584.8 5290.4 5341.8 5345.3 5380.6 5382.2 3581.4 3665.5 3670.9 3672.4 3677.3 3603.7 3686.7 3690.4 3692.5 3704.3 4194.5 4194.6 4210.8 4255.2 4258.5 5056.1 5101.4 5106.2 5112.1 5129.7 1200.9 1206.2 1231.5 1234.5 1260.6 781.4 806.4 813.9 816.1 820.8 3986.3 3987.8 4003.4 4031.9 4087.0 4606.0 4638.3 4642.9 4670.4 4685.7 3981.5 4017.3 4067.8 4079.5 4117.7 2372.6 2482.4 2500.6 2502.9 2507.8 4308.0 4364.4 4384.6 4430.3 4460.5 4714.9 4731.5 4744.5 4751.9 4803.7 4128.4 4383.2 4408.8 4433.0 4436.2 4633.9 4645.9 4649.9 4656.7 4659.5 4525.5 4588.8 4591.0 4596.9 4620.2 4071.0 4339.8 4402.8 4408.4 4515.4 3273.7 3305.2 3313.7 3317.8 3327.9 4671.1 4688.0 4728.4 4730.8 4734.2 4838.9 4955.3 5109.6 5137.7 5156.5 5084.8 5100.6 5112.4 5128.6 5138.4 4864.4 4981.7 4983.6 4985.8 5003.6 5071.9 5085.2 5157.0 5161.2 5173.7 4992.5 5002.3 5030.7 5060.2 5063.0 02:39:05 INFO - PROCESS | 6403 | 02:39:05 INFO - PROCESS | 6403 | [#5] yui.html Cycles:180 Average:15844.47 Median:22609.00 stddev:21690.52 (95.9%) stddev-sans-first:21721.59 02:39:05 INFO - PROCESS | 6403 | Values: 709.3 717.2 735.4 753.0 759.8 12254.3 13858.0 14494.3 14510.1 14511.4 13922.8 13942.6 14017.1 14042.4 14096.1 632.8 775.9 800.0 808.1 808.8 795.2 805.9 806.2 806.4 807.9 836.1 844.7 844.9 845.2 845.4 655.6 805.9 832.0 832.3 832.7 612.3 612.4 612.5 612.7 612.7 13525.3 13531.6 13577.9 13593.3 13621.5 11778.7 11926.0 12175.7 12304.8 12348.7 11657.6 11701.8 11780.6 11929.6 11965.6 4185.8 4209.2 4223.9 4264.8 4303.4 61364.0 61378.4 61918.0 62577.7 62705.0 9867.6 10170.6 10216.1 10284.3 10454.8 17851.2 17862.8 17895.6 17903.8 17905.6 6487.6 6573.9 6634.4 6771.0 6895.3 3542.0 3549.6 3570.4 3687.5 3720.9 2778.5 2860.1 2872.8 2874.6 2876.3 472.7 480.9 485.9 489.5 490.2 419.9 478.4 541.8 564.1 565.9 7423.5 7450.6 7811.7 8063.4 8095.1 481.8 487.0 500.8 533.5 549.6 3761.5 3835.3 3859.8 3904.4 3907.8 85441.6 85563.0 87594.0 89115.1 89698.0 77264.0 77833.2 78460.6 79287.6 79785.2 19401.5 19512.2 22707.9 47747.0 67712.3 6640.8 6815.4 6969.9 6977.3 7054.7 38823.0 40766.0 41032.2 41876.0 41995.8 37109.8 38111.8 50764.5 56617.4 60307.4 11153.5 11313.7 11393.3 11686.9 11824.8 11754.5 11995.2 12120.8 12714.3 12856.8 12097.4 12574.6 12627.2 12654.2 13185.9 12157.1 12408.2 12577.6 12658.9 12770.4 11819.8 11906.8 12175.3 12245.8 12462.9 9965.5 10245.4 10427.3 10663.6 10738.4 10305.4 10412.7 10772.4 10808.7 10823.8 02:39:05 INFO - PROCESS | 6403 | -------- Summary: end -------- 02:39:05 INFO - PROCESS | 6403 | 02:39:06 INFO - TEST-INFO | 6403: exit 0 02:39:06 INFO - TEST-OK | dromaeo_css | took 1120068ms 02:39:06 INFO - TEST-START | kraken 02:39:06 INFO - operating with platform_type : linux_ 02:39:06 INFO - Initialising browser for kraken test... 02:39:06 INFO - TEST-INFO | started process 6581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaop14R/profile http://localhost:43667/getInfo.html) 02:39:10 INFO - PROCESS | 6581 | __metrics Screen width/height:1600/1200 02:39:10 INFO - PROCESS | 6581 | colorDepth:24 02:39:10 INFO - PROCESS | 6581 | Browser inner width/height: 1024/697 02:39:10 INFO - PROCESS | 6581 | __metrics 02:39:11 INFO - PROCESS | 6581 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:39:12 INFO - TEST-INFO | 6581: exit 0 02:39:12 INFO - Browser initialized. 02:39:12 INFO - Running cycle 1/1 for kraken test... 02:39:12 INFO - TEST-INFO | started process 6661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaop14R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:24 INFO - PROCESS | 6661 | RSS: Main: 175202304 02:39:24 INFO - PROCESS | 6661 | 02:39:27 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43667/tests/kraken/driver.html?testName=audio-beat-detection) 02:39:28 INFO - PROCESS | 6661 | RSS: Main: 233357312 02:39:28 INFO - PROCESS | 6661 | 02:39:31 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43667/tests/kraken/driver.html?testName=audio-dft) 02:39:31 INFO - PROCESS | 6661 | RSS: Main: 221671424 02:39:31 INFO - PROCESS | 6661 | 02:39:35 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43667/tests/kraken/driver.html?testName=audio-fft) 02:39:35 INFO - PROCESS | 6661 | RSS: Main: 288985088 02:39:35 INFO - PROCESS | 6661 | 02:39:37 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43667/tests/kraken/driver.html?testName=audio-oscillator) 02:39:38 INFO - PROCESS | 6661 | RSS: Main: 199000064 02:39:38 INFO - PROCESS | 6661 | 02:39:40 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43667/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:39:41 INFO - PROCESS | 6661 | RSS: Main: 203427840 02:39:41 INFO - PROCESS | 6661 | 02:39:44 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43667/tests/kraken/driver.html?testName=imaging-darkroom) 02:39:45 INFO - PROCESS | 6661 | RSS: Main: 238854144 02:39:45 INFO - PROCESS | 6661 | 02:39:48 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43667/tests/kraken/driver.html?testName=imaging-desaturate) 02:39:49 INFO - PROCESS | 6661 | RSS: Main: 234917888 02:39:49 INFO - PROCESS | 6661 | 02:39:52 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43667/tests/kraken/driver.html?testName=json-parse-financial) 02:39:52 INFO - PROCESS | 6661 | RSS: Main: 237072384 02:39:52 INFO - PROCESS | 6661 | 02:39:54 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43667/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:39:55 INFO - PROCESS | 6661 | RSS: Main: 227516416 02:39:55 INFO - PROCESS | 6661 | 02:39:56 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43667/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:39:57 INFO - PROCESS | 6661 | RSS: Main: 232882176 02:39:57 INFO - PROCESS | 6661 | 02:39:59 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43667/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:00 INFO - PROCESS | 6661 | RSS: Main: 236244992 02:40:00 INFO - PROCESS | 6661 | 02:40:03 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:03 INFO - PROCESS | 6661 | RSS: Main: 241426432 02:40:03 INFO - PROCESS | 6661 | 02:40:06 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:40:07 INFO - PROCESS | 6661 | RSS: Main: 240054272 02:40:07 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | Cycle 1(1): loaded http://localhost:43667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43667/tests/kraken/driver.html?testName=ai-astar) 02:40:09 INFO - PROCESS | 6661 | RSS: Main: 282533888 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | __start_tp_report 02:40:09 INFO - PROCESS | 6661 | _x_x_mozilla_page_load 02:40:09 INFO - PROCESS | 6661 | _x_x_mozilla_page_load_details 02:40:09 INFO - PROCESS | 6661 | |i|pagename|runs| 02:40:09 INFO - PROCESS | 6661 | |0;ai-astar;112;107;113;113;111;113;113;111;113;113 02:40:09 INFO - PROCESS | 6661 | |1;audio-beat-detection;157;135;137;188;133;134;153;130;181;132 02:40:09 INFO - PROCESS | 6661 | |2;audio-dft;162;162;162;160;163;162;164;162;161;160 02:40:09 INFO - PROCESS | 6661 | |3;audio-fft;76;77;78;113;77;77;76;76;99;76 02:40:09 INFO - PROCESS | 6661 | |4;audio-oscillator;86;87;113;86;86;90;126;86;85;124 02:40:09 INFO - PROCESS | 6661 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;116 02:40:09 INFO - PROCESS | 6661 | |6;imaging-darkroom;146;146;145;146;146;147;146;146;146;145 02:40:09 INFO - PROCESS | 6661 | |7;imaging-desaturate;96;95;96;95;96;96;95;95;96;95 02:40:09 INFO - PROCESS | 6661 | |8;json-parse-financial;65;65;64;65;70;64;65;65;65;63 02:40:09 INFO - PROCESS | 6661 | |9;json-stringify-tinderbox;64;66;66;65;66;65;65;65;66;66 02:40:09 INFO - PROCESS | 6661 | |10;stanford-crypto-aes;89;83;85;83;89;86;85;86;113;90 02:40:09 INFO - PROCESS | 6661 | |11;stanford-crypto-ccm;143;140;131;143;133;128;132;139;163;136 02:40:09 INFO - PROCESS | 6661 | |12;stanford-crypto-pbkdf2;179;178;170;170;169;175;171;171;172;174 02:40:09 INFO - PROCESS | 6661 | |13;stanford-crypto-sha256-iterative;68;66;71;67;67;67;68;67;68;66 02:40:09 INFO - PROCESS | 6661 | __end_tp_report 02:40:09 INFO - PROCESS | 6661 | __start_cc_report 02:40:09 INFO - PROCESS | 6661 | _x_x_mozilla_cycle_collect,1902 02:40:09 INFO - PROCESS | 6661 | __end_cc_report 02:40:09 INFO - PROCESS | 6661 | __startTimestamp1466070009500__endTimestamp 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | ------- Summary: start ------- 02:40:09 INFO - PROCESS | 6661 | Number of tests: 14 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:1.91 (1.7%) stddev-sans-first:2.03 02:40:09 INFO - PROCESS | 6661 | Values: 112.0 107.0 113.0 113.0 111.0 113.0 113.0 111.0 113.0 113.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:145.00 stddev:21.31 (14.7%) stddev-sans-first:22.35 02:40:09 INFO - PROCESS | 6661 | Values: 157.0 135.0 137.0 188.0 133.0 134.0 153.0 130.0 181.0 132.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 02:40:09 INFO - PROCESS | 6661 | Values: 162.0 162.0 162.0 160.0 163.0 162.0 164.0 162.0 161.0 160.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#3] audio-fft Cycles:10 Average:82.50 Median:77.00 stddev:12.83 (16.7%) stddev-sans-first:13.40 02:40:09 INFO - PROCESS | 6661 | Values: 76.0 77.0 78.0 113.0 77.0 77.0 76.0 76.0 99.0 76.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:86.00 stddev:17.01 (19.8%) stddev-sans-first:17.57 02:40:09 INFO - PROCESS | 6661 | Values: 86.0 87.0 113.0 86.0 86.0 90.0 126.0 86.0 85.0 124.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:40:09 INFO - PROCESS | 6661 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 02:40:09 INFO - PROCESS | 6661 | Values: 146.0 146.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:40:09 INFO - PROCESS | 6661 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:1.85 (2.9%) stddev-sans-first:1.96 02:40:09 INFO - PROCESS | 6661 | Values: 65.0 65.0 64.0 65.0 70.0 64.0 65.0 65.0 65.0 63.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 02:40:09 INFO - PROCESS | 6661 | Values: 64.0 66.0 66.0 65.0 66.0 65.0 65.0 65.0 66.0 66.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:86.00 stddev:8.81 (10.2%) stddev-sans-first:9.35 02:40:09 INFO - PROCESS | 6661 | Values: 89.0 83.0 85.0 83.0 89.0 86.0 85.0 86.0 113.0 90.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:139.50 stddev:9.93 (7.1%) stddev-sans-first:10.42 02:40:09 INFO - PROCESS | 6661 | Values: 143.0 140.0 131.0 143.0 133.0 128.0 132.0 139.0 163.0 136.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:173.00 stddev:3.48 (2.0%) stddev-sans-first:2.91 02:40:09 INFO - PROCESS | 6661 | Values: 179.0 178.0 170.0 170.0 169.0 175.0 171.0 171.0 172.0 174.0 02:40:09 INFO - PROCESS | 6661 | 02:40:09 INFO - PROCESS | 6661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.43 (2.1%) stddev-sans-first:1.51 02:40:09 INFO - PROCESS | 6661 | Values: 68.0 66.0 71.0 67.0 67.0 67.0 68.0 67.0 68.0 66.0 02:40:09 INFO - PROCESS | 6661 | -------- Summary: end -------- 02:40:09 INFO - PROCESS | 6661 | 02:40:10 INFO - TEST-INFO | 6661: exit 0 02:40:10 INFO - TEST-OK | kraken | took 64012ms 02:40:10 INFO - SUITE-END | took 1184s 02:40:11 INFO - Completed test suite (00:19:44) 02:40:11 INFO - javascript benchmark 02:40:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.9482810343793, 2630.7369263073706, 2654.4027593791398, 2666.1201803404865, 2677.4645070985807, 4630.398048253723, 4652.139354219467, 4687.0625874825, 4789.664723469358, 4805.1831188697915, 4702.764861756907, 4740.8577742667685, 4778.235482322829, 4845.878853028676, 4854.174790285651, 4380.123975204956, 4412.51462339144, 4463.33050042493, 4481.843135490259, 4508.954910450902, 4394.4946331172005, 4449.132419178261, 4453.421055262827, 4519.073589914076, 4532.9320060199125, 4375.5405682403525, 4441.5336389679105, 4451.666125040619, 4498.122866041123, 4506.233940230169, 4317.740935543878, 4333.046729719456, 4349.412829268072, 4351.73889566627, 4400.713953593038, 4288.335308027261, 4304.741715497049, 4311.094670119279, 4323.4163387942535, 4330.458692663417, 4742.33607294979, 4759.4764575896625, 4770.379850619432, 4790.449098353699, 4806.375171227753, 4947.381577302837, 5052.898942021176, 5092.8217512387255, 5138.743062846843, 5145.073886700392, 5136.486351364871, 5179.7410129493755, 5188.6367954243215, 5224.843254702365, 5227.111391063529, 4849.0, 4852.4662287148385, 4860.927086093711, 4863.124637565237, 4875.414950205998, 5072.619553533426, 5260.342457192851, 5312.760925758273, 5327.413984461706, 5338.145896656516, 5123.154679477919, 5178.352705911761, 5179.741012949413, 5199.922001169985, 5201.5838732901275, 5226.477352264743, 5229.111051121318, 5231.895362092737, 5232.895342093213, 5265.262863199156, 4936.851894443173, 5044.899102018013, 5075.264086707407, 5088.465711100281, 5179.041877252645, 5074.0359331727595, 5086.05907907031, 5087.160618497906, 5096.745162741848, 5133.0, 4315.331123675835, 4316.870493885189, 4322.0, 4325.437693099877, 4378.846740364072, 3677.4667673187237, 3709.629037096323, 3716.925661486755, 3752.7185461090526, 3799.981000094982, 4336.457942757155, 4338.349247612883, 4342.5006124296115, 4387.298032314814, 4412.0, 5110.182370820651, 5118.283440318359, 5119.0529751996, 5125.56432703217, 5129.256257842667, 4211.284081706117, 4317.244482215599, 4343.478782546114, 4354.085642015149, 4384.517703052662, 4588.449386073693, 4604.401427814362, 4611.077784443125, 4613.515580863961, 4659.324397962344, 4731.881702957454, 4822.614190864792, 4824.541668541483, 4826.662133650681, 4861.538153875376, 5025.447200807981, 5068.366454193226, 5076.238564215398, 5146.511081447256, 5151.5106064923775, 4759.809607615656, 4770.308305295782, 4786.473487916396, 4789.592884604847, 4839.975800120977, 4997.150484417585, 4998.750062496933, 5004.449510553909, 5011.072951503984, 5014.373203349582, 4986.127427700066, 5030.0694371541385, 5062.265971434195, 5088.338515992898, 5114.028334616411, 4957.231629097496, 4962.379702537183, 4963.503649635008, 4982.352294201731, 5013.072581572421, 4906.2640603909695, 4966.453690094015, 4973.602111830973, 4983.925241121314, 5028.899422011466, 4826.131296366688, 4864.610831133572, 4865.464798872192, 4913.213885778401, 4941.011797640558, 5027.271045698426, 5031.094403007493, 5036.269740887477, 5036.949630503648, 5084.745762711776, 4836.371271734652, 4907.141250281115, 4945.925811112764, 4952.034353301072, 4987.326710893983], "value": 4692.33267099197, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.4947888149702, 577.1458241802133, 586.4340911020867, 587.145703002132, 601.5398220361425, 26713.732862671368, 38028.23943521128, 38910.416343754834, 39257.21485570287, 39307.0, 38717.41923871137, 39066.80466597663, 39261.21477570454, 39280.41079383811, 39301.0, 7775.222477752222, 7900.288973992339, 7920.683172673086, 7947.880781788278, 7949.0, 7753.069631644211, 7847.058352997648, 7847.372210223169, 7851.646675899569, 7852.646630901623, 7830.451868369217, 7882.093559240703, 7883.054033515986, 7886.132525422227, 7890.447668663167, 7814.648340824648, 7854.0, 7855.332296754783, 7855.567943763091, 7857.8035549111155, 7706.229377062305, 7792.883106753403, 7808.063032436087, 7808.804779880492, 7812.921870781333, 38668.226635467414, 38735.61264387348, 38769.22461550782, 38906.02734931621, 39160.216795664215, 2970.1980465274255, 3091.675374085711, 3288.8848890288964, 3360.5631267935255, 3676.4117741161285, 29563.408731825242, 29588.55617165744, 29717.70282297171, 30044.0, 30152.24619384511, 3370.8370612138774, 3391.0674564494716, 3417.265287963075, 3417.709494692954, 3434.5019972104155, 253019.0, 253866.0, 254199.0, 256118.0, 256561.0, 54645.72677136589, 54715.45284547104, 55072.0, 55106.44893551093, 55328.17007744887, 33120.1719957003, 33771.83114084414, 33932.49101263483, 35141.29717405689, 58163.0, 13164.868351316556, 13194.076414650883, 13245.73508529824, 13268.40292186854, 13274.070815042855, 10366.118879895294, 10393.37639741618, 10456.215783816244, 10459.581616735397, 10459.84310235347, 18422.263109475472, 18467.81532184688, 18481.445556633324, 18540.536486587942, 18568.907155464138, 6636.739019586264, 6728.394444499921, 6875.1749790025515, 6982.371586557234, 7048.788536343918, 804.5816175588661, 915.2494954137543, 942.8821397325335, 947.8341290274175, 995.8605795188679, 27691.86154069257, 27709.861450692617, 27772.166834994983, 28403.431931361258, 28559.14322570326, 788.917163697815, 961.5817119553017, 964.3249725192394, 974.6101559376306, 981.7790997025755, 14365.425382984773, 14527.709445811024, 14545.20001399912, 14588.0, 14820.481283155254, 390818.0, 393619.0, 394037.0, 394141.0, 394193.0, 47288.290675639895, 48451.27323090156, 48537.27194092092, 48571.5142848574, 48583.5141648579, 1077.9137668986461, 1156.4680247086267, 1194.1103877611408, 1198.6823491774687, 1200.7238335182956, 27382.5892611607, 28081.719182807912, 28550.42899141964, 28917.277068073465, 29196.27009324784, 42252.78873605612, 42355.7882210587, 42729.0, 42751.3587296197, 42803.57196427996, 295948.0, 298389.0, 298954.0, 298967.0, 300103.0, 22383.44041398978, 23526.0, 24099.397515062265, 24125.0, 25402.745972540037, 41188.1762364757, 41420.378694319006, 41528.79235603803, 42323.57676423196, 42598.5740142607, 35633.64366356303, 35787.82106089453, 35833.82083089672, 35891.820540897126, 36136.193190340906, 35201.64798352086, 35980.46029309615, 36200.27599448049, 36215.27569448543, 36386.45420318644, 34467.827660861534, 34879.65120348764, 34904.0, 35576.288474229856, 35604.28791424105, 31805.0, 31875.526070693977, 32514.0, 32543.837280813445, 32675.0, 24767.628485573092, 25054.62418063694, 25127.390279984105, 25215.243542693748, 25602.0], "value": 17220.058025496648, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.491786908982, 356.6576086956522, 358.7919006975953, 364.46423757077105, 367.0255471722574, 15889.364425422984, 17174.3130274789, 17329.393471228508, 17726.734098988527, 17789.733154002668, 16126.838731612681, 16706.916465417657, 17659.55851103723, 17686.734698979526, 17688.823111768877, 4940.086084074449, 5064.164412871872, 5069.594432445414, 5103.56619687327, 5151.278820965068, 3717.34946384383, 5084.79660813567, 5651.124075768263, 5970.373110823366, 5987.461128498434, 5993.370696076914, 6000.579959402844, 6012.669303188345, 6019.699015049252, 6020.367861374559, 5720.628159169662, 5919.88160236795, 5920.526357891358, 5921.792737254197, 5930.347661757203, 3347.866085356583, 4857.198562237227, 5159.793608255665, 5172.379314482248, 5178.922316165223, 19626.607467850565, 20179.293724719566, 20372.490687732778, 20426.38720838377, 20465.4883627909, 1920.9615807683908, 2024.7064175694443, 2472.443700167466, 2502.1367628168255, 2516.509280690266, 13080.345982700826, 13176.6705832354, 13325.66685832862, 13403.396847141901, 13617.0, 1745.6246906915073, 1799.5501124718821, 1863.8602104842191, 1920.7983161768093, 1947.3281717807333, 63924.0, 64607.03089453709, 64671.02993455102, 66195.0, 66630.0, 9428.764280892896, 9481.4785186814, 9621.08599683029, 9686.418814871131, 9715.805683886425, 12934.223946563236, 13027.869721302666, 13057.738845223043, 13087.345632718327, 13090.672733181556, 6930.237673855871, 6974.0, 7025.859482810418, 7097.9645101775195, 7118.822029449305, 6595.769148079794, 6626.204855417381, 6737.056812046318, 6763.628000460022, 6768.492363072789, 4037.152198038386, 4084.1219137884905, 4143.357779544175, 4197.160567886435, 4224.76763777989, 1599.2723310893516, 1611.7260065788844, 1675.689997350494, 1706.1298737643642, 1734.826517348255, 848.1620666484208, 866.9176428239307, 910.3400034974591, 917.0, 934.1499235695485, 16257.67484650324, 16498.092604906844, 16546.751798723028, 16553.25510352013, 16956.406525771537, 874.7026011156238, 897.0804924951846, 913.0458670689146, 918.6049998500575, 938.4134915677702, 8892.8666070009, 9234.722958311262, 9557.808843823084, 9696.127348538525, 9710.320277580642, 360156.0, 363663.0, 387444.0, 389339.0, 390445.0, 73913.0, 74423.25576744163, 75544.62227688936, 75611.62194189103, 75990.0, 863.4819108534829, 885.2386947225381, 893.5889490834289, 899.8065415935605, 903.074348792493, 14606.858484910179, 14689.0, 14768.0, 14936.775948360566, 15072.924635376752, 35534.0, 35903.820480897426, 36738.8163059183, 36959.0, 37257.068573285884, 48755.0, 50951.49048509468, 51823.0, 52200.0, 52610.21084683656, 7230.855382892418, 7276.563406195645, 7291.380232680282, 7385.889211661722, 7462.96268518654, 10835.458227088771, 11400.771984560428, 11424.371659558805, 11716.179867409199, 11735.119866009913, 9453.574589143367, 9509.619615215313, 10107.898921010696, 10434.426106563908, 10498.160147188053, 10126.392416455037, 10389.37663740178, 10389.792204156025, 10453.790924181625, 10687.786244275227, 10623.628173013907, 10904.291221070605, 10948.178886583379, 10968.945155274172, 10991.06575941022, 6583.80248592543, 6740.797776066725, 7006.404455621329, 7550.962245188739, 7693.307602315818, 9048.819023619359, 9117.452952822852, 9357.111074447917, 9439.150476456876, 9534.713958581253], "value": 8204.892620901857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1207.8973287270583, 1347.1647578501327, 1397.2315226625358, 1450.5358285348686, 1681.3862940026886, 6796.524243302964, 7485.326320631142, 7762.534247945127, 7779.10540287867, 7983.161768014362, 7681.615919204045, 7807.297343239107, 7843.52938823671, 7849.48978316409, 7851.489653172554, 1882.557598964249, 2107.3045894854663, 2190.145843121184, 2195.9670604940857, 2221.9888900555475, 2210.8784016879067, 2233.475133343671, 2235.0054225869494, 2235.9217427390045, 2237.574860776447, 2153.192552792703, 2173.5544213436287, 2176.09691977829, 2177.4556360909774, 2177.923772667957, 1803.6933721267417, 2048.354768247997, 2112.3029400297864, 2115.058798834519, 2125.341144245289, 2128.531723020933, 2147.95704085919, 2150.8817015064164, 2151.956960860774, 2152.397328747953, 7848.882266766003, 7856.803579910491, 7894.881576776353, 7912.841743165162, 7915.05019397676, 4262.616364527176, 4378.211921854065, 4386.122775444892, 4386.649068074546, 4388.846390376321, 2712.443948990452, 2828.3070647691447, 2830.3348713052624, 2841.701621329772, 2843.061789609424, 915.8397280475957, 948.7883514304131, 957.4494665567327, 970.8883478399933, 973.0172525748974, 10603.575856965635, 10631.362118272851, 10650.627228046982, 10651.041406273473, 10673.146148308117, 4136.276151673445, 4242.193983143193, 4305.892352691208, 4324.935125973113, 4327.415798867176, 9035.141661542142, 9080.364374493854, 9084.54577271147, 9095.408798428214, 9096.8635470468, 4420.049689316812, 4423.225935461282, 4425.048614547888, 4425.734455932655, 4426.048399594103, 3476.2699833035344, 3967.444557761916, 4070.715049946475, 4098.057446787256, 4126.546079931205, 3567.7680950738118, 3575.891473643127, 3603.765755225902, 3606.1165014571598, 3664.3953747631344, 1154.3362566524281, 1158.2818652435376, 1163.3310846263432, 1176.129664048598, 1185.0, 774.6746366526072, 781.4842204145236, 798.5807451088109, 814.621201141472, 817.9938675429255, 4840.273958906122, 4958.983408401269, 4960.553550180501, 5014.247862820606, 5096.490350964948, 376.68170396015324, 380.1219183685695, 387.0884068019829, 388.86778495311165, 403.31839191765823, 3298.422776014188, 3415.5047518109736, 3428.3828910796296, 3454.758166928291, 3466.3587236361354, 9213.216876565433, 9631.662891798753, 9679.274054445805, 9752.853707194397, 9770.706878793648, 9612.231021518402, 9620.567074481665, 9627.277954153467, 9632.0, 9660.516974151264, 7289.927100729031, 7381.483296169324, 7387.85224295511, 7404.370628496638, 7424.294692004251, 5318.388385335581, 5407.729613519387, 5511.145772405283, 5631.831045068655, 5661.122526008476, 8557.144285571392, 8770.736877893672, 8844.319579279916, 9046.728598142066, 9102.31732620043, 9036.322275829207, 9125.361224714206, 9198.448093114435, 9307.488088155216, 9307.534623268673, 6151.200343955436, 6586.0, 6759.493038022267, 6798.150231221098, 6981.895271571032, 7563.092428908566, 7583.317501424898, 7645.426593005658, 7661.808454788675, 7662.157162711986, 6585.440237579668, 6706.966465167643, 6736.7642132525125, 6818.522703410912, 6943.305669433016, 6586.571872828251, 6706.295838936841, 6886.655667216719, 6928.965355173192, 6955.0, 6115.113308570143, 6137.41694539018, 6315.55791094619, 6327.873442531216, 6338.239411270677, 4449.310356894686, 4484.730916145042, 4604.309353596987, 4605.815767369268, 4657.836975705834, 4605.194091033989, 4606.723596584216, 4612.238980568303, 4622.768861556841, 4677.508861569486], "value": 4010.9883821814446, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.3525057487319, 279.2713105874636, 282.82747524010335, 284.13575374901336, 291.8774114871754, 4724.574788269055, 4847.515248475151, 4886.682365646235, 4928.186849169882, 4988.4263309719345, 4648.674592778507, 4791.185498465261, 4817.855464336067, 4818.494058123891, 4876.2198048312275, 3800.524934383195, 3814.4469051987444, 3826.827792749333, 3835.271298453299, 3837.846486140565, 3626.3653860574427, 3648.890533284006, 3785.167263202105, 3810.5236845394325, 3824.9043773905596, 3738.5513738351437, 3742.3450896093077, 3744.6817020553285, 3762.51087358643, 3775.7734535927793, 3755.5681096673957, 3757.380032294668, 3772.7170462215445, 3775.5469343678933, 3776.15036616759, 3318.5188147718445, 3347.96652033479, 3365.444701624229, 3376.2909788944353, 3382.8646854125805, 4704.0356726870905, 4745.240761478181, 4749.833755818564, 4753.453352864431, 4790.568848803624, 4267.97866010668, 4283.357496375537, 4290.871273861758, 4292.420523229355, 4336.978315108436, 4917.483664215278, 5034.496550344973, 5049.570786483153, 5051.520105589963, 5132.40977287613, 3559.2169722660974, 3566.144125409909, 3568.946465803015, 3579.3378225028455, 3584.8386822593047, 5290.365156181244, 5341.839744807662, 5345.251664766897, 5380.574147850823, 5382.165764306539, 3581.374896174309, 3665.4605065872397, 3670.944935825965, 3672.3573374659327, 3677.282929828658, 3603.72972027099, 3686.6866316362875, 3690.3910854708674, 3692.464592634107, 3704.259148170323, 4194.517630472474, 4194.580541945842, 4210.7684077375425, 4255.212785634668, 4258.467691538558, 5056.115179843513, 5101.387833459934, 5106.157484015096, 5112.105381558287, 5129.743512824344, 1200.9039276858005, 1206.203905422417, 1231.5320178332356, 1234.5370486067725, 1260.571405722059, 781.3905153979905, 806.4314658165979, 813.9023317201974, 816.1389733830865, 820.7524562664836, 3986.3023970804993, 3987.840486380512, 4003.3794761811964, 4031.8992025199605, 4086.979565102215, 4605.976970115128, 4638.281066434708, 4642.86071417858, 4670.416197975253, 4685.718856868531, 3981.5222173338807, 4017.31705610047, 4067.776272305052, 4079.510978492888, 4117.71466835903, 2372.5610762009082, 2482.416632091457, 2500.612405077216, 2502.87485625718, 2507.8369905956056, 4308.0, 4364.406991448099, 4384.610387338908, 4430.316479737743, 4460.50934397216, 4714.945147173428, 4731.4558825735485, 4744.454387745384, 4751.857444276678, 4803.735794531264, 4128.401381799622, 4383.232934236496, 4408.7575183365225, 4432.999999999935, 4436.157130145262, 4633.907321853477, 4645.910469537719, 4649.883752906069, 4656.650751193606, 4659.464161621457, 4525.456945166469, 4588.839390621446, 4590.954090459053, 4596.931046034245, 4620.214563524141, 4070.9592904070582, 4339.848105316299, 4402.779861007001, 4408.426904502394, 4515.412996310459, 3273.688999545039, 3305.173706573357, 3313.701766840996, 3317.834108294527, 3327.850246738854, 4671.084855209348, 4687.953120468888, 4728.361671174485, 4730.787114579921, 4734.218853889208, 4838.8790280241865, 4955.2567114933045, 5109.616778741535, 5137.717425541631, 5156.535911767809, 5084.7966081356335, 5100.6429549931145, 5112.437631860418, 5128.6153538485505, 5138.3833939927445, 4864.391951006124, 4981.651284410202, 4983.601311894967, 4985.75071246429, 5003.649744517848, 5071.92392114126, 5085.237214417719, 5157.0, 5161.200013997836, 5173.715445650525, 4992.475790041994, 5002.3237567901, 5030.673006254582, 5060.190369541003, 5062.974685126551], "value": 3665.837940179091, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.3225969199415, 717.1716667249328, 735.3712575747736, 752.984940301194, 759.8290384663447, 12254.264744115348, 13858.0, 14494.275286235672, 14510.129392236473, 14511.419543218259, 13922.791158132635, 13942.581722548315, 14017.088889222194, 14042.438302467914, 14096.083754555972, 632.7911789109583, 775.9495632783851, 800.0199755299755, 808.0626473290984, 808.8261023879865, 795.2286282306183, 805.8509175802466, 806.2058872011064, 806.3911746631285, 807.8868958345836, 836.0636087581917, 844.6705784743924, 844.8605980013322, 845.213951025546, 845.3997661660198, 655.6295692933477, 805.899262592176, 831.966721331146, 832.3133414932705, 832.6627715775121, 612.2683393344954, 612.3662009819859, 612.5130521235628, 612.7303986246083, 612.7457105301295, 13525.323733813368, 13531.631964406288, 13577.864221357759, 13593.252371119584, 13621.523246686318, 11778.705532361759, 11926.0, 12175.695607609792, 12304.753904921941, 12348.691282718004, 11657.591984280594, 11701.765964680659, 11780.587679431179, 11929.582464613697, 11965.581204657883, 4185.811638476276, 4209.179210054041, 4223.87328380146, 4264.786760661955, 4303.440552728157, 61364.0, 61378.38621613771, 61918.0, 62577.68711156415, 62705.0, 9867.605295788087, 10170.644027459151, 10216.080552750289, 10284.331518451278, 10454.790904181873, 17851.196696148705, 17862.821371786114, 17895.642087158183, 17903.820961790476, 17905.552361191076, 6487.610743355413, 6573.901391479131, 6634.402903738686, 6770.966145169341, 6895.310468953165, 3542.0, 3549.6450354964813, 3570.4465807799834, 3687.520622319135, 3720.8511659533315, 2778.499870023415, 2860.0704770949524, 2872.755815755684, 2874.626298581171, 2876.3096856754228, 472.6667699272005, 480.85814684668105, 485.86638674364127, 489.54961435479447, 490.1740567144302, 419.9202151591249, 478.3852749217239, 541.8347404041726, 564.0608387035621, 565.9405762394972, 7423.517471364344, 7450.627468626547, 7811.726589569338, 8063.435559510778, 8095.069067057246, 481.802460990992, 486.9651989522265, 500.76964596286115, 533.5171669638983, 549.631746729692, 3761.5298087739034, 3835.347990841564, 3859.826307816155, 3904.375299951994, 3907.8241479133508, 85441.57279213688, 85563.0, 87594.0, 89115.10884891197, 89698.0, 77264.0, 77833.22166778373, 78460.60769696115, 79287.60356198181, 79785.20214797778, 19401.51496212606, 19512.219511219675, 22707.88646056759, 47747.04505909932, 67712.32287677159, 6640.833979150367, 6815.42068924147, 6969.895451568332, 6977.33715297046, 7054.717811287491, 38823.0, 40766.0, 41032.179356413304, 41876.0, 41995.79002105092, 37109.81445092757, 38111.80944095262, 50764.492355077455, 56617.43382566122, 60307.396926030175, 11153.49809258569, 11313.71715707114, 11393.316401015965, 11686.883131168579, 11824.82262766042, 11754.471048802654, 11995.220310679779, 12120.818187727367, 12714.300713460478, 12856.807147892976, 12097.395130243276, 12574.622761317176, 12627.179233349803, 12654.240745554927, 13185.868141318464, 12157.090231192993, 12408.177891027768, 12577.622671319876, 12658.936705316415, 12770.361481926053, 11819.82270265964, 11906.821397679216, 12175.33035683046, 12245.75508489843, 12462.875371246171, 9965.501724913871, 10245.436500992218, 10427.287329030247, 10663.636997837337, 10738.409387483764, 10305.433201174008, 10412.68761937143, 10772.407517586294, 10808.729781755519, 10823.837642435212], "value": 6368.533178536009, "unit": "score"}], "name": "dromaeo_css", "value": 6292.675266520902, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 113.0, 113.0, 111.0, 113.0, 113.0, 111.0, 113.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 135.0, 137.0, 188.0, 133.0, 134.0, 153.0, 130.0, 181.0, 132.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 163.0, 162.0, 164.0, 162.0, 161.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 113.0, 77.0, 77.0, 76.0, 76.0, 99.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 113.0, 86.0, 86.0, 90.0, 126.0, 86.0, 85.0, 124.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 70.0, 64.0, 65.0, 65.0, 65.0, 63.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 85.0, 83.0, 89.0, 86.0, 85.0, 86.0, 113.0, 90.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 140.0, 131.0, 143.0, 133.0, 128.0, 132.0, 139.0, 163.0, 136.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 170.0, 170.0, 169.0, 175.0, 171.0, 171.0, 172.0, 174.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 71.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1557.9, "alertThreshold": 2.0}]} 02:40:11 INFO - Return code: 0 02:40:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:40:11 INFO - # TBPL SUCCESS # 02:40:11 INFO - Running post-action listener: _resource_record_post_action 02:40:11 INFO - ##### 02:40:11 INFO - ##### Finished run-tests step (success) 02:40:11 INFO - ##### 02:40:11 INFO - Running post-run listener: _resource_record_post_run 02:40:11 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 503808; Write bytes: 365551616; Read time: 120; Write time: 262252 02:40:11 INFO - TinderboxPrint: CPU usage
13.2% 02:40:11 INFO - TinderboxPrint: I/O read bytes / time
503,808 / 120 02:40:11 INFO - TinderboxPrint: I/O write bytes / time
365,551,616 / 262,252 02:40:11 INFO - TinderboxPrint: CPU idle
8,322.1 (86.8%) 02:40:11 INFO - TinderboxPrint: CPU user
1,224.5 (12.8%) 02:40:11 INFO - TinderboxPrint: Swap in / out
0 / 0 02:40:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 71258112; Read time: 0; Write time: 60284 02:40:11 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 503808; Write bytes: 293994496; Read time: 120; Write time: 201968 02:40:11 INFO - Running post-run listener: _upload_blobber_files 02:40:11 INFO - Blob upload gear active. 02:40:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:11 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 02:40:11 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:40:11 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:40:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:40:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:40:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:40:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:13 INFO - (blobuploader) - INFO - Done attempting. 02:40:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:40:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:40:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:14 INFO - (blobuploader) - INFO - Done attempting. 02:40:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:40:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:40:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:18 INFO - (blobuploader) - INFO - Done attempting. 02:40:18 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:18 INFO - Return code: 0 02:40:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef31d862b3b9d8156aa7e1b330e9b078fc4b140b6bfc7281aad57bfc530cd2b57f17c35868478d1ad168aab4fbc36c1c0935dbc23970204ceb6ca24bf41a73a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ec1e2ac02a41957d19d21591ff48269d43013537fa3b28b18b8657e0e24b0e57ee831e0dbd0d6eed5b9d283821965bc180168264d25eb84baae3563aee46c60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f20a2dfc184b0f5f8b94d5a893655cac7e472e8b5e98e98d8ecd4a39d9fa9f9a653bae0044e865421f6949a21478740a4716ec6a1744c7d31231321078949484"} 02:40:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:18 INFO - Contents: 02:40:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef31d862b3b9d8156aa7e1b330e9b078fc4b140b6bfc7281aad57bfc530cd2b57f17c35868478d1ad168aab4fbc36c1c0935dbc23970204ceb6ca24bf41a73a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ec1e2ac02a41957d19d21591ff48269d43013537fa3b28b18b8657e0e24b0e57ee831e0dbd0d6eed5b9d283821965bc180168264d25eb84baae3563aee46c60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f20a2dfc184b0f5f8b94d5a893655cac7e472e8b5e98e98d8ecd4a39d9fa9f9a653bae0044e865421f6949a21478740a4716ec6a1744c7d31231321078949484"} 02:40:18 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:18 INFO - Copying logs to upload dir... 02:40:18 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1312.202086 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2016-06-16 02:40:18.611685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 02:40:18.615032) ========= 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=0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef31d862b3b9d8156aa7e1b330e9b078fc4b140b6bfc7281aad57bfc530cd2b57f17c35868478d1ad168aab4fbc36c1c0935dbc23970204ceb6ca24bf41a73a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ec1e2ac02a41957d19d21591ff48269d43013537fa3b28b18b8657e0e24b0e57ee831e0dbd0d6eed5b9d283821965bc180168264d25eb84baae3563aee46c60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f20a2dfc184b0f5f8b94d5a893655cac7e472e8b5e98e98d8ecd4a39d9fa9f9a653bae0044e865421f6949a21478740a4716ec6a1744c7d31231321078949484"} build_url:https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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/Fx-Team-Non-PGO/sha512/ef31d862b3b9d8156aa7e1b330e9b078fc4b140b6bfc7281aad57bfc530cd2b57f17c35868478d1ad168aab4fbc36c1c0935dbc23970204ceb6ca24bf41a73a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ec1e2ac02a41957d19d21591ff48269d43013537fa3b28b18b8657e0e24b0e57ee831e0dbd0d6eed5b9d283821965bc180168264d25eb84baae3563aee46c60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f20a2dfc184b0f5f8b94d5a893655cac7e472e8b5e98e98d8ecd4a39d9fa9f9a653bae0044e865421f6949a21478740a4716ec6a1744c7d31231321078949484"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 02:40:18.640368) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:40:18.640716) ========= 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=0333a256a5e4f052382dd180000001b1-1466067757.925481-449832291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:40:18.723474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 02:40:18.723798) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 02:40:18.724151) ========= ========= Total master_lag: 0.18 =========