builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1466586339.0 results: success (0) buildid: 20160621233030 builduid: 05a8ccee52b34aee89f7251e9b49ce09 revision: 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.000054) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.001904) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.002439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.018383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.018792) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 02:05:39-- 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% 88.6M=0s 2016-06-22 02:05:39 (88.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099797 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.135056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.135423) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019689 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.186551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.186911) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 02:05:39,437 truncating revision to first 12 chars 2016-06-22 02:05:39,437 Setting DEBUG logging. 2016-06-22 02:05:39,437 attempt 1/10 2016-06-22 02:05:39,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2c11e355dbf5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 02:05:39,773 unpacking tar archive at: fx-team-2c11e355dbf5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692014 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.893628) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.893975) ========= script_repo_revision: 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.894571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.895108) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 02:05:39.906730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-22 02:05:39.907229) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:05:40 INFO - MultiFileLogger online at 20160622 02:05:40 in /builds/slave/test 02:05:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:05:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:05:40 INFO - {'append_to_log': False, 02:05:40 INFO - 'base_work_dir': '/builds/slave/test', 02:05:40 INFO - 'blob_upload_branch': 'Fx-Team', 02:05:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:05:40 INFO - 'branch': 'Fx-Team', 02:05:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:05:40 INFO - 'config_files': ('talos/linux_config.py',), 02:05:40 INFO - 'default_actions': ('clobber', 02:05:40 INFO - 'read-buildbot-config', 02:05:40 INFO - 'download-and-extract', 02:05:40 INFO - 'populate-webroot', 02:05:40 INFO - 'create-virtualenv', 02:05:40 INFO - 'install', 02:05:40 INFO - 'run-tests'), 02:05:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:05:40 INFO - 'download_minidump_stackwalk': True, 02:05:40 INFO - 'download_symbols': 'ondemand', 02:05:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:05:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:05:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:05:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:05:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:05:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:05:40 INFO - 'installer_path': 'installer.exe', 02:05:40 INFO - 'log_level': 'info', 02:05:40 INFO - 'log_name': 'talos', 02:05:40 INFO - 'log_to_console': True, 02:05:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:05:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:05:40 INFO - 'opt_config_files': (), 02:05:40 INFO - 'pip_index': False, 02:05:40 INFO - 'sps_profile': False, 02:05:40 INFO - 'sps_profile_interval': 0, 02:05:40 INFO - 'suite': 'dromaeojs-e10s', 02:05:40 INFO - 'system_bits': '32', 02:05:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:05:40 INFO - 'title': 'talos-linux64-ix-001', 02:05:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:05:40 INFO - 'use_talos_json': True, 02:05:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:05:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:05:40 INFO - 'work_dir': 'build'} 02:05:40 INFO - ##### 02:05:40 INFO - ##### Running clobber step. 02:05:40 INFO - ##### 02:05:40 INFO - Running pre-action listener: _resource_record_pre_action 02:05:40 INFO - Running main action method: clobber 02:05:40 INFO - rmtree: /builds/slave/test/build 02:05:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:05:40 INFO - Running post-action listener: _resource_record_post_action 02:05:40 INFO - ##### 02:05:40 INFO - ##### Finished clobber step (success) 02:05:40 INFO - ##### 02:05:40 INFO - ##### 02:05:40 INFO - ##### Running read-buildbot-config step. 02:05:40 INFO - ##### 02:05:40 INFO - Running pre-action listener: _resource_record_pre_action 02:05:40 INFO - Running main action method: read_buildbot_config 02:05:40 INFO - Using buildbot properties: 02:05:40 INFO - { 02:05:40 INFO - "project": "", 02:05:40 INFO - "product": "firefox", 02:05:40 INFO - "script_repo_revision": "production", 02:05:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:05:40 INFO - "repository": "", 02:05:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:05:40 INFO - "buildid": "20160621233030", 02:05:40 INFO - "pgo_build": "True", 02:05:40 INFO - "basedir": "/builds/slave/test", 02:05:40 INFO - "buildnumber": 853, 02:05:40 INFO - "slavename": "talos-linux64-ix-001", 02:05:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:05:40 INFO - "platform": "ubuntu64_hw", 02:05:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:05:40 INFO - "branch": "fx-team", 02:05:40 INFO - "repo_path": "integration/fx-team", 02:05:40 INFO - "revision": "2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d", 02:05:40 INFO - "stage_platform": "linux64-pgo", 02:05:40 INFO - "builduid": "05a8ccee52b34aee89f7251e9b49ce09", 02:05:40 INFO - "slavebuilddir": "test" 02:05:40 INFO - } 02:05:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:05:40 INFO - Running post-action listener: _resource_record_post_action 02:05:40 INFO - ##### 02:05:40 INFO - ##### Finished read-buildbot-config step (success) 02:05:40 INFO - ##### 02:05:40 INFO - ##### 02:05:40 INFO - ##### Running download-and-extract step. 02:05:40 INFO - ##### 02:05:40 INFO - Running pre-action listener: _resource_record_pre_action 02:05:40 INFO - Running main action method: download_and_extract 02:05:40 INFO - mkdir: /builds/slave/test/build/tests 02:05: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:05:40 INFO - https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:05:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:05:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:05:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/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:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/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:05:41 INFO - Downloaded 1361 bytes. 02:05:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:05:41 INFO - Using the following test package requirements: 02:05:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:05:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:05:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:41 INFO - u'jsshell-linux-x86_64.zip'], 02:05:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:05:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:05:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:05:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:05:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:05:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:05:41 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:05:41 INFO - https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:05:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:05:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:05:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/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:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/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:05:42 INFO - Downloaded 24268749 bytes. 02:05:42 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:05:42 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:05:43 INFO - Return code: 0 02:05:43 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:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:43 INFO - https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:05:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:05:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:05:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/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:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/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:05:45 INFO - Downloaded 24268749 bytes. 02:05:45 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:05:45 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:05:47 INFO - Return code: 0 02:05: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:05:47 INFO - https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:05:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:05:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:05:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/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:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/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:05:48 INFO - Downloaded 14405384 bytes. 02:05:48 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:05:48 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:05:48 INFO - Return code: 0 02:05:48 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:05:48 INFO - https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:05:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:05:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:05:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/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:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OPAbWs0OQoGpFDBjvLMWrg/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:05:54 INFO - Downloaded 60131647 bytes. 02:05:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:05:54 INFO - mkdir: /builds/slave/test/properties 02:05:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:05:54 INFO - Writing to file /builds/slave/test/properties/build_url 02:05:54 INFO - Contents: 02:05:54 INFO - build_url:https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:05:54 INFO - Running post-action listener: _resource_record_post_action 02:05:54 INFO - Running post-action listener: set_extra_try_arguments 02:05:54 INFO - ##### 02:05:54 INFO - ##### Finished download-and-extract step (success) 02:05:54 INFO - ##### 02:05:54 INFO - ##### 02:05:54 INFO - ##### Running populate-webroot step. 02:05:54 INFO - ##### 02:05:54 INFO - Running pre-action listener: _resource_record_pre_action 02:05:54 INFO - Running main action method: populate_webroot 02:05:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:05:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:05:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:05:54 INFO - '--tppagecycles', 02:05:54 INFO - '7'], 02:05:54 INFO - 'tests': ['tsvgm']}}, 02:05:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:05:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:05:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:05:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:05:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:05:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:05:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:54 INFO - 'talos_options': ['--disable-e10s'], 02:05:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:54 INFO - 'talos_options': ['--disable-e10s'], 02:05:54 INFO - 'tests': ['damp', 'tps']}, 02:05:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:54 INFO - 'tests': ['damp', 'tps']}, 02:05:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:05:54 INFO - 'tests': ['dromaeo_dom']}, 02:05:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:05:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:05:54 INFO - 'tests': ['basic_compositor_video']}, 02:05:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:05:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:05:54 INFO - 'tests': ['a11yr', 02:05:54 INFO - 'ts_paint', 02:05:54 INFO - 'tpaint', 02:05:54 INFO - 'sessionrestore', 02:05:54 INFO - 'sessionrestore_no_auto_restore', 02:05:54 INFO - 'tabpaint']}, 02:05:54 INFO - 'other-e10s': {'tests': ['a11yr', 02:05:54 INFO - 'ts_paint', 02:05:54 INFO - 'tpaint', 02:05:54 INFO - 'sessionrestore', 02:05:54 INFO - 'sessionrestore_no_auto_restore', 02:05:54 INFO - 'tabpaint']}, 02:05:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:05:54 INFO - 'ts_paint', 02:05:54 INFO - 'tpaint', 02:05:54 INFO - 'sessionrestore', 02:05:54 INFO - 'sessionrestore_no_auto_restore', 02:05:54 INFO - 'tabpaint']}, 02:05:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:05:54 INFO - 'ts_paint', 02:05:54 INFO - 'tpaint', 02:05:54 INFO - 'sessionrestore', 02:05:54 INFO - 'sessionrestore_no_auto_restore', 02:05:54 INFO - 'tabpaint']}, 02:05:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:05:54 INFO - 'tests': ['a11yr', 02:05:54 INFO - 'ts_paint', 02:05:54 INFO - 'tpaint', 02:05:54 INFO - 'sessionrestore', 02:05:54 INFO - 'sessionrestore_no_auto_restore', 02:05:54 INFO - 'tabpaint']}, 02:05:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:05:54 INFO - 'tests': ['a11yr', 02:05:54 INFO - 'ts_paint', 02:05:54 INFO - 'tpaint', 02:05:54 INFO - 'sessionrestore', 02:05:54 INFO - 'sessionrestore_no_auto_restore', 02:05:54 INFO - 'tabpaint']}, 02:05:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:05:54 INFO - 'tests': ['tsvgx', 02:05:54 INFO - 'tsvgr_opacity', 02:05:54 INFO - 'tart', 02:05:54 INFO - 'tscrollx', 02:05:54 INFO - 'cart']}, 02:05:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:05:54 INFO - 'tsvgr_opacity', 02:05:54 INFO - 'tart', 02:05:54 INFO - 'tscrollx', 02:05:54 INFO - 'cart']}, 02:05:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:54 INFO - 'talos_options': ['--disable-e10s'], 02:05:54 INFO - 'tests': ['tp5o']}, 02:05:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:54 INFO - 'tests': ['tp5o']}, 02:05:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:54 INFO - 'talos_options': ['--disable-e10s', 02:05:54 INFO - '--xperf_path', 02:05:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:54 INFO - 'tests': ['tp5n']}, 02:05:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:54 INFO - 'talos_options': ['--xperf_path', 02:05:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:54 INFO - 'tests': ['tp5n']}}, 02:05:54 INFO - 'talos.zip': {'path': '', 02:05:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:05:54 INFO - Running post-action listener: _resource_record_post_action 02:05:54 INFO - ##### 02:05:54 INFO - ##### Finished populate-webroot step (success) 02:05:54 INFO - ##### 02:05:54 INFO - ##### 02:05:54 INFO - ##### Running create-virtualenv step. 02:05:54 INFO - ##### 02:05:54 INFO - Running pre-action listener: _resource_record_pre_action 02:05:54 INFO - Running main action method: create_virtualenv 02:05:54 INFO - Creating virtualenv /builds/slave/test/build/venv 02:05:54 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:05:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:05:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:05:54 INFO - Using real prefix '/usr' 02:05:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:05:55 INFO - Installing distribute.............................................................................................................................................................................................done. 02:05:57 INFO - Installing pip.................done. 02:05:57 INFO - Return code: 0 02:05:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:05:57 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:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:57 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:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:57 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 0x7f1ecb6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561c0>, '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 0x1b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b57550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', '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:05:57 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:05:57 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:05:57 INFO - Using env: {'DISPLAY': ':0', 02:05:57 INFO - 'HOME': '/home/cltbld', 02:05:57 INFO - 'LANG': 'en_US.UTF-8', 02:05:57 INFO - 'LANGUAGE': 'en_US:en', 02:05:57 INFO - 'LOGNAME': 'cltbld', 02:05:57 INFO - 'MAIL': '/var/mail/cltbld', 02:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:57 INFO - 'MOZ_NO_REMOTE': '1', 02:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:57 INFO - 'NO_EM_RESTART': '1', 02:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:57 INFO - 'PWD': '/builds/slave/test', 02:05:57 INFO - 'SHELL': '/bin/bash', 02:05:57 INFO - 'SHLVL': '1', 02:05:57 INFO - 'TERM': 'linux', 02:05:57 INFO - 'TMOUT': '86400', 02:05:57 INFO - 'USER': 'cltbld', 02:05:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', 02:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:57 INFO - '_': '/tools/buildbot/bin/python'} 02:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:57 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:05:57 INFO - Cleaning up... 02:05:57 INFO - Return code: 0 02:05:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:05:57 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:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:57 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:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:57 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 0x7f1ecb6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561c0>, '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 0x1b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b57550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', '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:05:57 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:05:57 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:05:57 INFO - Using env: {'DISPLAY': ':0', 02:05:57 INFO - 'HOME': '/home/cltbld', 02:05:57 INFO - 'LANG': 'en_US.UTF-8', 02:05:57 INFO - 'LANGUAGE': 'en_US:en', 02:05:57 INFO - 'LOGNAME': 'cltbld', 02:05:57 INFO - 'MAIL': '/var/mail/cltbld', 02:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:57 INFO - 'MOZ_NO_REMOTE': '1', 02:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:57 INFO - 'NO_EM_RESTART': '1', 02:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:57 INFO - 'PWD': '/builds/slave/test', 02:05:57 INFO - 'SHELL': '/bin/bash', 02:05:57 INFO - 'SHLVL': '1', 02:05:57 INFO - 'TERM': 'linux', 02:05:57 INFO - 'TMOUT': '86400', 02:05:57 INFO - 'USER': 'cltbld', 02:05:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', 02:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:57 INFO - '_': '/tools/buildbot/bin/python'} 02:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:57 INFO - Downloading/unpacking psutil>=3.1.1 02:05: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:05: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:05: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:05: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:05: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:05: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:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:05:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:59 INFO - Installing collected packages: psutil 02:05:59 INFO - Running setup.py install for psutil 02:05:59 INFO - building 'psutil._psutil_linux' extension 02:05:59 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:06:00 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:06:00 INFO - building 'psutil._psutil_posix' extension 02:06:00 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:06:00 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:06:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:00 INFO - Successfully installed psutil 02:06:00 INFO - Cleaning up... 02:06:00 INFO - Return code: 0 02:06:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:06:00 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:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:00 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:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:00 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 0x7f1ecb6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561c0>, '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 0x1b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b57550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', '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:06:00 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:06:00 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:06:00 INFO - Using env: {'DISPLAY': ':0', 02:06:00 INFO - 'HOME': '/home/cltbld', 02:06:00 INFO - 'LANG': 'en_US.UTF-8', 02:06:00 INFO - 'LANGUAGE': 'en_US:en', 02:06:00 INFO - 'LOGNAME': 'cltbld', 02:06:00 INFO - 'MAIL': '/var/mail/cltbld', 02:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:00 INFO - 'MOZ_NO_REMOTE': '1', 02:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:00 INFO - 'NO_EM_RESTART': '1', 02:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:00 INFO - 'PWD': '/builds/slave/test', 02:06:00 INFO - 'SHELL': '/bin/bash', 02:06:00 INFO - 'SHLVL': '1', 02:06:00 INFO - 'TERM': 'linux', 02:06:00 INFO - 'TMOUT': '86400', 02:06:00 INFO - 'USER': 'cltbld', 02:06:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', 02:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:00 INFO - '_': '/tools/buildbot/bin/python'} 02:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:06:00 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:06:00 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:06:00 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:06:00 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:06:00 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:06:00 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:06:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:06:02 INFO - Installing collected packages: mozsystemmonitor 02:06:02 INFO - Running setup.py install for mozsystemmonitor 02:06:02 INFO - Successfully installed mozsystemmonitor 02:06:02 INFO - Cleaning up... 02:06:02 INFO - Return code: 0 02:06:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:06:02 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:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:02 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:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:02 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 0x7f1ecb6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561c0>, '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 0x1b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b57550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', '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:06:02 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:06:02 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:06:02 INFO - Using env: {'DISPLAY': ':0', 02:06:02 INFO - 'HOME': '/home/cltbld', 02:06:02 INFO - 'LANG': 'en_US.UTF-8', 02:06:02 INFO - 'LANGUAGE': 'en_US:en', 02:06:02 INFO - 'LOGNAME': 'cltbld', 02:06:02 INFO - 'MAIL': '/var/mail/cltbld', 02:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:02 INFO - 'MOZ_NO_REMOTE': '1', 02:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:02 INFO - 'NO_EM_RESTART': '1', 02:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:02 INFO - 'PWD': '/builds/slave/test', 02:06:02 INFO - 'SHELL': '/bin/bash', 02:06:02 INFO - 'SHLVL': '1', 02:06:02 INFO - 'TERM': 'linux', 02:06:02 INFO - 'TMOUT': '86400', 02:06:02 INFO - 'USER': 'cltbld', 02:06:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', 02:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:02 INFO - '_': '/tools/buildbot/bin/python'} 02:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:02 INFO - Downloading/unpacking jsonschema==2.5.1 02:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:06:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:05 INFO - Downloading functools32-3.2.3-2.tar.gz 02:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:06:05 INFO - warning: no files found matching '*.txt' 02:06:05 INFO - no previously-included directories found matching 'build' 02:06:05 INFO - no previously-included directories found matching 'dist' 02:06:05 INFO - no previously-included directories found matching '.git*' 02:06:05 INFO - Installing collected packages: jsonschema, functools32 02:06:05 INFO - Running setup.py install for functools32 02:06:05 INFO - warning: no files found matching '*.txt' 02:06:05 INFO - no previously-included directories found matching 'build' 02:06:05 INFO - no previously-included directories found matching 'dist' 02:06:05 INFO - no previously-included directories found matching '.git*' 02:06:05 INFO - Successfully installed jsonschema functools32 02:06:05 INFO - Cleaning up... 02:06:05 INFO - Return code: 0 02:06:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:06: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:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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', '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 0x7f1ecb6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561c0>, '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 0x1b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b57550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', '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:06: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:06: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 blobuploader==1.2.4 02:06:05 INFO - Using env: {'DISPLAY': ':0', 02:06:05 INFO - 'HOME': '/home/cltbld', 02:06:05 INFO - 'LANG': 'en_US.UTF-8', 02:06:05 INFO - 'LANGUAGE': 'en_US:en', 02:06:05 INFO - 'LOGNAME': 'cltbld', 02:06:05 INFO - 'MAIL': '/var/mail/cltbld', 02:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:05 INFO - 'MOZ_NO_REMOTE': '1', 02:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:05 INFO - 'NO_EM_RESTART': '1', 02:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:05 INFO - 'PWD': '/builds/slave/test', 02:06:05 INFO - 'SHELL': '/bin/bash', 02:06:05 INFO - 'SHLVL': '1', 02:06:05 INFO - 'TERM': 'linux', 02:06:05 INFO - 'TMOUT': '86400', 02:06:05 INFO - 'USER': 'cltbld', 02:06:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', 02:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:05 INFO - '_': '/tools/buildbot/bin/python'} 02:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:05 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:05 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:06:05 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:06:05 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:06:05 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:06:05 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:06:05 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:06:07 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06:07 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:06:07 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:06:07 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:06:07 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:06:07 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:06:07 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:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:06:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06:07 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:06:07 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:06:07 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:06:07 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:06:07 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:06:07 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:06:08 INFO - Downloading docopt-0.6.1.tar.gz 02:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:08 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:08 INFO - Running setup.py install for blobuploader 02:06:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:06:08 INFO - Running setup.py install for requests 02:06:08 INFO - Running setup.py install for docopt 02:06:08 INFO - Successfully installed blobuploader requests docopt 02:06:08 INFO - Cleaning up... 02:06:08 INFO - Return code: 0 02:06:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:08 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:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:08 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:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:08 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 0x7f1ecb6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561c0>, '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 0x1b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b57550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', '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:06:08 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:06:08 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:06:08 INFO - Using env: {'DISPLAY': ':0', 02:06:08 INFO - 'HOME': '/home/cltbld', 02:06:08 INFO - 'LANG': 'en_US.UTF-8', 02:06:08 INFO - 'LANGUAGE': 'en_US:en', 02:06:08 INFO - 'LOGNAME': 'cltbld', 02:06:08 INFO - 'MAIL': '/var/mail/cltbld', 02:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:08 INFO - 'MOZ_NO_REMOTE': '1', 02:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:08 INFO - 'NO_EM_RESTART': '1', 02:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:08 INFO - 'PWD': '/builds/slave/test', 02:06:08 INFO - 'SHELL': '/bin/bash', 02:06:08 INFO - 'SHLVL': '1', 02:06:08 INFO - 'TERM': 'linux', 02:06:08 INFO - 'TMOUT': '86400', 02:06:08 INFO - 'USER': 'cltbld', 02:06:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', 02:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:08 INFO - '_': '/tools/buildbot/bin/python'} 02:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:08 INFO - Running setup.py (path:/tmp/pip-e8Tq0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:09 INFO - Running setup.py (path:/tmp/pip-ctT3KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:09 INFO - Running setup.py (path:/tmp/pip-tHS4yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:09 INFO - Running setup.py (path:/tmp/pip-jw2NXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:09 INFO - Running setup.py (path:/tmp/pip-FxddAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:09 INFO - Running setup.py (path:/tmp/pip-NEdls8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:09 INFO - Running setup.py (path:/tmp/pip-I0lzRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:09 INFO - Running setup.py (path:/tmp/pip-aqW1qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:09 INFO - Running setup.py (path:/tmp/pip-jUGPqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:09 INFO - Running setup.py (path:/tmp/pip-K6NAxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:09 INFO - Running setup.py (path:/tmp/pip-vYJ2iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:09 INFO - Running setup.py (path:/tmp/pip-YSLTBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:09 INFO - Running setup.py (path:/tmp/pip-fL6BlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:09 INFO - Running setup.py (path:/tmp/pip-MTYCZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:09 INFO - Running setup.py (path:/tmp/pip-ild5F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:10 INFO - Running setup.py (path:/tmp/pip-EPzu_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:10 INFO - Running setup.py (path:/tmp/pip-kVPnbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:10 INFO - Running setup.py install for manifestparser 02:06:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:06:10 INFO - Running setup.py install for mozcrash 02:06:10 INFO - Running setup.py install for mozdebug 02:06:10 INFO - Running setup.py install for mozdevice 02:06:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:06:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:06:10 INFO - Running setup.py install for mozfile 02:06:10 INFO - Running setup.py install for mozhttpd 02:06:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:06:10 INFO - Running setup.py install for mozinfo 02:06:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:06:10 INFO - Running setup.py install for mozInstall 02:06:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:06:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:06:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:06:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:06:10 INFO - Running setup.py install for mozleak 02:06:11 INFO - Running setup.py install for mozlog 02:06:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:06:11 INFO - Running setup.py install for moznetwork 02:06:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:06:11 INFO - Running setup.py install for mozprocess 02:06:11 INFO - Running setup.py install for mozprofile 02:06:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:06:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:06:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:06:11 INFO - Running setup.py install for mozrunner 02:06:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:06:11 INFO - Running setup.py install for mozscreenshot 02:06:11 INFO - Running setup.py install for moztest 02:06:11 INFO - Running setup.py install for mozversion 02:06:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:06:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:11 INFO - Cleaning up... 02:06:11 INFO - Return code: 0 02:06:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:11 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:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:11 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:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:11 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 0x7f1ecb6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561c0>, '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 0x1b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b57550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', '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:06:11 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:06:11 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:06:11 INFO - Using env: {'DISPLAY': ':0', 02:06:11 INFO - 'HOME': '/home/cltbld', 02:06:11 INFO - 'LANG': 'en_US.UTF-8', 02:06:11 INFO - 'LANGUAGE': 'en_US:en', 02:06:11 INFO - 'LOGNAME': 'cltbld', 02:06:11 INFO - 'MAIL': '/var/mail/cltbld', 02:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:11 INFO - 'MOZ_NO_REMOTE': '1', 02:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:11 INFO - 'NO_EM_RESTART': '1', 02:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:11 INFO - 'PWD': '/builds/slave/test', 02:06:11 INFO - 'SHELL': '/bin/bash', 02:06:11 INFO - 'SHLVL': '1', 02:06:11 INFO - 'TERM': 'linux', 02:06:11 INFO - 'TMOUT': '86400', 02:06:11 INFO - 'USER': 'cltbld', 02:06:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', 02:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:11 INFO - '_': '/tools/buildbot/bin/python'} 02:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:12 INFO - Running setup.py (path:/tmp/pip-yMRhh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:12 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:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:12 INFO - Running setup.py (path:/tmp/pip-tINHfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:12 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:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:12 INFO - Running setup.py (path:/tmp/pip-Aipyd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:12 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:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:12 INFO - Running setup.py (path:/tmp/pip-JY1ooi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:12 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:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:12 INFO - Running setup.py (path:/tmp/pip-RwSNwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:12 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:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:12 INFO - Running setup.py (path:/tmp/pip-TH8Jjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:12 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:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:12 INFO - Running setup.py (path:/tmp/pip-oBisBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:12 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:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:12 INFO - Running setup.py (path:/tmp/pip-tsP_kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:12 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:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:12 INFO - Running setup.py (path:/tmp/pip-Q5lH1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:12 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:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:12 INFO - Running setup.py (path:/tmp/pip-YBonIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:12 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:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:12 INFO - Running setup.py (path:/tmp/pip-uFoxcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:12 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:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:12 INFO - Running setup.py (path:/tmp/pip-qofa_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:13 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:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:13 INFO - Running setup.py (path:/tmp/pip-Hc8orI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:13 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:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:13 INFO - Running setup.py (path:/tmp/pip-cq_hFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:13 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:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:13 INFO - Running setup.py (path:/tmp/pip-buUKiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:13 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:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:13 INFO - Running setup.py (path:/tmp/pip-KnVgQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:13 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:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:13 INFO - Running setup.py (path:/tmp/pip-HF0Lva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:15 INFO - Downloading blessings-1.6.tar.gz 02:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:06:15 INFO - Installing collected packages: blessings 02:06:15 INFO - Running setup.py install for blessings 02:06:15 INFO - Successfully installed blessings 02:06:15 INFO - Cleaning up... 02:06:15 INFO - Return code: 0 02:06:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:15 INFO - Reading from file tmpfile_stdout 02:06:15 INFO - Current package versions: 02:06:15 INFO - argparse == 1.2.1 02:06:15 INFO - blessings == 1.6 02:06:15 INFO - blobuploader == 1.2.4 02:06:15 INFO - docopt == 0.6.1 02:06:15 INFO - functools32 == 3.2.3-2 02:06:15 INFO - jsonschema == 2.5.1 02:06:15 INFO - manifestparser == 1.1 02:06:15 INFO - mozInstall == 1.12 02:06:15 INFO - mozcrash == 0.17 02:06:15 INFO - mozdebug == 0.1 02:06:15 INFO - mozdevice == 0.48 02:06:15 INFO - mozfile == 1.2 02:06:15 INFO - mozhttpd == 0.7 02:06:15 INFO - mozinfo == 0.9 02:06:15 INFO - mozleak == 0.1 02:06:15 INFO - mozlog == 3.2 02:06:15 INFO - moznetwork == 0.27 02:06:15 INFO - mozprocess == 0.22 02:06:15 INFO - mozprofile == 0.28 02:06:15 INFO - mozrunner == 6.11 02:06:15 INFO - mozscreenshot == 0.1 02:06:15 INFO - mozsystemmonitor == 0.3 02:06:15 INFO - moztest == 0.7 02:06:15 INFO - mozversion == 1.4 02:06:15 INFO - psutil == 3.1.1 02:06:15 INFO - requests == 1.2.3 02:06:15 INFO - wsgiref == 0.1.2 02:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:15 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:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:15 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:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:15 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 0x7f1ecb6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561c0>, '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 0x1b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b57550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', '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:06:15 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:06:15 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:06:15 INFO - Using env: {'DISPLAY': ':0', 02:06:15 INFO - 'HOME': '/home/cltbld', 02:06:15 INFO - 'LANG': 'en_US.UTF-8', 02:06:15 INFO - 'LANGUAGE': 'en_US:en', 02:06:15 INFO - 'LOGNAME': 'cltbld', 02:06:15 INFO - 'MAIL': '/var/mail/cltbld', 02:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:15 INFO - 'MOZ_NO_REMOTE': '1', 02:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:15 INFO - 'NO_EM_RESTART': '1', 02:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:15 INFO - 'PWD': '/builds/slave/test', 02:06:15 INFO - 'SHELL': '/bin/bash', 02:06:15 INFO - 'SHLVL': '1', 02:06:15 INFO - 'TERM': 'linux', 02:06:15 INFO - 'TMOUT': '86400', 02:06:15 INFO - 'USER': 'cltbld', 02:06:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', 02:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:15 INFO - '_': '/tools/buildbot/bin/python'} 02:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:15 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:06:15 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:06:15 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:06:15 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:06:15 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:06:15 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:06:15 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:06:15 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:06:15 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:06:15 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:06:15 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:06:15 INFO - Cleaning up... 02:06:15 INFO - Return code: 0 02:06:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:06:15 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:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:15 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:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:15 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 0x7f1ecb6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561c0>, '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 0x1b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b57550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', '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:06:15 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:06:15 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:06:15 INFO - Using env: {'DISPLAY': ':0', 02:06:15 INFO - 'HOME': '/home/cltbld', 02:06:15 INFO - 'LANG': 'en_US.UTF-8', 02:06:15 INFO - 'LANGUAGE': 'en_US:en', 02:06:15 INFO - 'LOGNAME': 'cltbld', 02:06:15 INFO - 'MAIL': '/var/mail/cltbld', 02:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:15 INFO - 'MOZ_NO_REMOTE': '1', 02:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:15 INFO - 'NO_EM_RESTART': '1', 02:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:15 INFO - 'PWD': '/builds/slave/test', 02:06:15 INFO - 'SHELL': '/bin/bash', 02:06:15 INFO - 'SHLVL': '1', 02:06:15 INFO - 'TERM': 'linux', 02:06:15 INFO - 'TMOUT': '86400', 02:06:15 INFO - 'USER': 'cltbld', 02:06:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', 02:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:15 INFO - '_': '/tools/buildbot/bin/python'} 02:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:06:16 INFO - Cleaning up... 02:06:16 INFO - Return code: 0 02:06:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:16 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 0x7f1ecb6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561c0>, '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 0x1b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b57550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', '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:06:16 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:06:16 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:06:16 INFO - Using env: {'DISPLAY': ':0', 02:06:16 INFO - 'HOME': '/home/cltbld', 02:06:16 INFO - 'LANG': 'en_US.UTF-8', 02:06:16 INFO - 'LANGUAGE': 'en_US:en', 02:06:16 INFO - 'LOGNAME': 'cltbld', 02:06:16 INFO - 'MAIL': '/var/mail/cltbld', 02:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:16 INFO - 'MOZ_NO_REMOTE': '1', 02:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:16 INFO - 'NO_EM_RESTART': '1', 02:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:16 INFO - 'PWD': '/builds/slave/test', 02:06:16 INFO - 'SHELL': '/bin/bash', 02:06:16 INFO - 'SHLVL': '1', 02:06:16 INFO - 'TERM': 'linux', 02:06:16 INFO - 'TMOUT': '86400', 02:06:16 INFO - 'USER': 'cltbld', 02:06:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', 02:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:16 INFO - '_': '/tools/buildbot/bin/python'} 02:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:16 INFO - Downloading/unpacking flake8 02:06:16 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:06:16 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:06:16 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:06:16 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:06:16 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:06:16 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:06:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:06:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:06:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:19 INFO - no previously-included directories found matching 'docs/_build' 02:06:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:06:19 INFO - Running setup.py install for pep8 02:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:19 INFO - no previously-included directories found matching 'docs/_build' 02:06:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:06:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:06:19 INFO - Cleaning up... 02:06:19 INFO - Return code: 0 02:06:19 INFO - Running post-action listener: _resource_record_post_action 02:06:19 INFO - Running post-action listener: _start_resource_monitoring 02:06:19 INFO - Starting resource monitoring. 02:06:19 INFO - ##### 02:06:19 INFO - ##### Finished create-virtualenv step (success) 02:06:19 INFO - ##### 02:06:19 INFO - ##### 02:06:19 INFO - ##### Running install step. 02:06:19 INFO - ##### 02:06:19 INFO - Running pre-action listener: _resource_record_pre_action 02:06:19 INFO - Running main action method: install 02:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:19 INFO - Reading from file tmpfile_stdout 02:06:19 INFO - Detecting whether we're running mozinstall >=1.0... 02:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:06:19 INFO - Reading from file tmpfile_stdout 02:06:19 INFO - Output received: 02:06:19 INFO - Usage: mozinstall [options] installer 02:06:19 INFO - Options: 02:06:19 INFO - -h, --help show this help message and exit 02:06:19 INFO - -d DEST, --destination=DEST 02:06:19 INFO - Directory to install application into. [default: 02:06:19 INFO - "/builds/slave/test"] 02:06:19 INFO - --app=APP Application being installed. [default: firefox] 02:06:19 INFO - mkdir: /builds/slave/test/build/application 02:06:19 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:06:19 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:06:36 INFO - Reading from file tmpfile_stdout 02:06:36 INFO - Output received: 02:06:36 INFO - /builds/slave/test/build/application/firefox/firefox 02:06:36 INFO - Running post-action listener: _resource_record_post_action 02:06:36 INFO - ##### 02:06:36 INFO - ##### Finished install step (success) 02:06:36 INFO - ##### 02:06:36 INFO - ##### 02:06:36 INFO - ##### Running run-tests step. 02:06:36 INFO - ##### 02:06:36 INFO - Running pre-action listener: _resource_record_pre_action 02:06:36 INFO - Running main action method: run_tests 02:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:06:36 INFO - Python 2.7.3 02:06:36 INFO - Return code: 0 02:06:36 INFO - grabbing minidump binary from tooltool 02:06: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:06:36 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 0x1b561c0>, '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 0x1b570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b57550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:06:36 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:06:36 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:06:36 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:06:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:06:36 INFO - Return code: 0 02:06:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:06:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:06:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:06:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:06:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:06:37 INFO - Return code: 0 02:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:06:37 INFO - Using env: {'DISPLAY': ':0', 02:06:37 INFO - 'HOME': '/home/cltbld', 02:06:37 INFO - 'LANG': 'en_US.UTF-8', 02:06:37 INFO - 'LANGUAGE': 'en_US:en', 02:06:37 INFO - 'LOGNAME': 'cltbld', 02:06:37 INFO - 'MAIL': '/var/mail/cltbld', 02:06:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:06:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:37 INFO - 'MOZ_NO_REMOTE': '1', 02:06:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:37 INFO - 'NO_EM_RESTART': '1', 02:06:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:37 INFO - 'PWD': '/builds/slave/test', 02:06:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:06:37 INFO - 'SHELL': '/bin/bash', 02:06:37 INFO - 'SHLVL': '1', 02:06:37 INFO - 'TERM': 'linux', 02:06:37 INFO - 'TMOUT': '86400', 02:06:37 INFO - 'USER': 'cltbld', 02:06:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111', 02:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:37 INFO - '_': '/tools/buildbot/bin/python'} 02:06:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:06:38 INFO - mozversion application_buildid: 20160621233030 02:06:38 INFO - mozversion application_changeset: 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d 02:06:38 INFO - mozversion application_display_name: Nightly 02:06:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:06:38 INFO - mozversion application_name: Firefox 02:06:38 INFO - mozversion application_remotingname: firefox 02:06:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:06:38 INFO - mozversion application_vendor: Mozilla 02:06:38 INFO - mozversion application_version: 50.0a1 02:06:38 INFO - mozversion platform_buildid: 20160621233030 02:06:38 INFO - mozversion platform_changeset: 2c11e355dbf56ef7e52d8de3ad7d8b26acc3f65d 02:06:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:06:38 INFO - mozversion platform_version: 50.0a1 02:06:38 INFO - using testdate: 1466586398 02:06:38 INFO - actual date: 1466586398 02:06:38 INFO - starting webserver on 'localhost:47223' 02:06:38 INFO - SUITE-START | Running 2 tests 02:06:38 INFO - TEST-START | dromaeo_css 02:06:38 INFO - operating with platform_type : linux_ 02:06:38 INFO - Initialising browser for dromaeo_css test... 02:06:38 INFO - TEST-INFO | started process 29164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJFAYib/profile http://localhost:47223/getInfo.html) 02:06:42 INFO - PROCESS | 29164 | __metrics Screen width/height:1600/1200 02:06:42 INFO - PROCESS | 29164 | colorDepth:24 02:06:42 INFO - PROCESS | 29164 | Browser inner width/height: 1024/697 02:06:42 INFO - PROCESS | 29164 | __metrics 02:06:43 ERROR - PROCESS | 29164 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:06:44 INFO - TEST-INFO | 29164: exit 0 02:06:44 INFO - Browser initialized. 02:06:44 INFO - Running cycle 1/1 for dromaeo_css test... 02:06:44 INFO - TEST-INFO | started process 29281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJFAYib/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:56 INFO - PROCESS | 29281 | RSS: Main: 184979456 02:06:56 INFO - PROCESS | 29281 | 02:07:45 INFO - PROCESS | 29281 | 1466586465982 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:09:53 INFO - PROCESS | 29281 | Cycle 1(1): loaded http://localhost:47223/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47223/tests/dromaeo/cssquery-ext.html) 02:09:55 INFO - PROCESS | 29281 | RSS: Main: 188321792 02:09:55 INFO - PROCESS | 29281 | 02:12:57 INFO - PROCESS | 29281 | Cycle 1(1): loaded http://localhost:47223/tests/dromaeo/cssquery-ext.html (next: http://localhost:47223/tests/dromaeo/cssquery-jquery.html) 02:12:57 INFO - PROCESS | 29281 | RSS: Main: 188108800 02:12:57 INFO - PROCESS | 29281 | 02:15:59 INFO - PROCESS | 29281 | Cycle 1(1): loaded http://localhost:47223/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47223/tests/dromaeo/cssquery-mootools.html) 02:16:00 INFO - PROCESS | 29281 | RSS: Main: 188829696 02:16:00 INFO - PROCESS | 29281 | 02:19:02 INFO - PROCESS | 29281 | Cycle 1(1): loaded http://localhost:47223/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47223/tests/dromaeo/cssquery-prototype.html) 02:19:02 INFO - PROCESS | 29281 | RSS: Main: 186396672 02:19:02 INFO - PROCESS | 29281 | 02:22:05 INFO - PROCESS | 29281 | Cycle 1(1): loaded http://localhost:47223/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47223/tests/dromaeo/cssquery-yui.html) 02:22:05 INFO - PROCESS | 29281 | RSS: Main: 188407808 02:22:05 INFO - PROCESS | 29281 | 02:25:08 INFO - PROCESS | 29281 | Cycle 1(1): loaded http://localhost:47223/tests/dromaeo/cssquery-yui.html (next: http://localhost:47223/tests/dromaeo/cssquery-dojo.html) 02:25:08 INFO - PROCESS | 29281 | RSS: Main: 189517824 02:25:08 INFO - PROCESS | 29281 | 02:25:08 INFO - PROCESS | 29281 | __start_tp_report 02:25:08 INFO - PROCESS | 29281 | _x_x_mozilla_page_load 02:25:08 INFO - PROCESS | 29281 | _x_x_mozilla_page_load_details 02:25:08 INFO - PROCESS | 29281 | |i|pagename|runs| 02:25:08 INFO - PROCESS | 29281 | |0;dojo.html;3096.845157742113;3101.240196151943;3125.2343175921897;3133.326334838009;3146.1977195815048;5322.175062865257;5340.973295133524;5385.111456609659;5415.864603384917;5421.186821976706;5292.179712144614;5313.654612450197;5330.440303768107;5377.892442151155;5379.220013098108;4852.344933433986;4871.269309603553;4978.327925730035;5021.14640511114;5053;738.6134044574638;4797.856064318059;4863.659543831933;4936.284238785374;4937.506249375069;4883.853484395456;4907.433157204701;4917.336159618441;4917.754112294371;4920.655554111214;4937.308776771255;4940.5059494050665;4945.060438516706;4956.553910148068;4957.454679985199;4823.638227132979;4835.6131509479155;4858.732769697665;4896;4905.975470122662;5335.466453354672;5387.164989426645;5407.459254074601;5411.756470958816;5457.399686034533;5628.380878103405;5722.341930677983;5734.483896449339;5742.483176514092;5746.482816546489;5760.884782304331;5789.710514474259;5795.333536643256;5807.361190269067;5836.9785287574505;5374.677519348852;5396.865078373033;5398.24424580559;5400.324959380077;5416.377116631598;5823.475887170175;5879.911801322898;5910.143029260733;5913.9112913306335;5967.836271927019;5622.859428514238;5626.240457538262;5627.296587926509;5627.690477023803;5645.125005624135;5759.992001399738;5762.942370576325;5765.88468230633;5769.798057067983;5772.5959182856795;5704.914426283609;5754.568407369464;5817.50551203144;5820.3888591698105;5828.504577110908;5784.7107644618445;5806.82579522615;5842.883142337129;5860.355360910296;5879.970600146972;4307.8492252771;4440.111977604492;4460.464744230648;4479.955200448019;4532.161550113239;3873.7288389812443;3911.6088391160656;3951.0714981979213;3965.8215380307956;3969.3053715599654;5489.176623506506;5504.862378440571;5526.972365138148;5549.19536667181;5562.888742225133;5672.744726487318;5816.738246778905;5818.476337129594;5819.88360232793;5831.241938547962;5504.4495550444635;5509.669419834822;5512.200730893998;5526.613137080366;5580.693061881636;4827.372441582642;4833.613310935117;4837.854864354075;4845.200541910615;4856.562909338177;5857.677827719431;5871.796281762228;5916.023856063787;5926.644401335933;5936.614120082181;5729.5702822288495;5750.654960702372;5773.566982476247;5787.160861674949;5827.504662103769;5924;5931.555133364928;5935.732892019783;5946.613470124428;5948.643081414956;5569.275994120739;5620.606557540933;5625.662460252398;5663.207150998781;5697.6296540724725;5802.448767367094;5804.883902322014;5810.215620891126;5810.448007439287;5845.473907348359;5620.4660557247;5621.634593751393;5626.409227031267;5659.349174844946;5666.320041595035;5489.313835770528;5545.334559852843;5571.192177134212;5623.831285061455;5654.46282603152;5516.806911758069;5519.944800551943;5529.612927095226;5540.002799496129;5544.112941929272;5622.606417550732;5707.600467967369;5718.22803921482;5718.256626638677;5738.22533957927;5413.37746159181;5519.420460851553;5563.805266815642;5586.497215250484;5605.131204663284 02:25:08 INFO - PROCESS | 29281 | |1;ext.html;567.4439049731263;616.3035769580373;616.3035769580373;634.8635043465654;653.6241661044901;40177.196456070895;41863.372049419246;44185.558144418545;44216;44434.99999999992;44908.55091449084;45401.772991134996;45503.31745023819;45514.317285240664;45829.08341833161;8875.511846848436;8997.910020899806;9031.322650801183;9050.1854833065;9082.137196966278;8939.329550283723;8971.282297416225;9025.142611451902;9032.27741780656;9081.364304498687;9027.503487308195;9078.86381704275;9079.954600226989;9096.13586709265;9159.267258619295;9028.548572571379;9102.453852768855;9110.544472776368;9111.134442227978;9120.635174593008;8811;8945.865812012826;8957.417767845134;8977.236934860544;9027.819443611092;35190.29619407623;42671.786641066596;43137.35293970593;43246.35130473045;43350.78324608357;3376.1390845334527;3406.471996840494;3556.7837404172033;3583.6774690278;3672.7429079964413;32255.838720806245;32337;32596.511052334234;32669.50995735066;33512.497312540334;3778.792166430845;3795.4876091727815;3811;3954.584768599313;4039.9900024993754;292484;292906;293504;293994.53002735064;294542;34285.485717714255;35093.490650934706;35169.64830351664;35265;35303.64696353055;35570.11074723101;37388.43917341242;37441.62558374436;37472.81263593664;37596.81201594029;15487.457938972082;15585;15593.376264949502;15628.3748650055;15680.294386752395;12250.142490025613;12265.754684906253;12322.691932701575;12349.012079033655;12384.31886246247;8381.958090209631;8409.789755256168;8443.915560844436;8517.276031537389;8575.656973720981;3232.595925509311;3261.1684020574603;3274.574305340338;3277.5411442398085;3300.2409445827593;1064.685917654294;1079.983800242997;1091.3888222595372;1096.5613754498106;1160.5937921727498;32822.67177328196;33177.17057073592;33631.3273734524;33744.66255337464;34204.31591368159;1114.1254115519441;1148.3970915269383;1162.9533419922138;1182.7043239190202;1261.6278197931633;17029.48911532656;17391.47825565235;17489.38787142444;17497.212625431886;17703.468895933143;574181;580215;588102;588456;589127;59716.70141649351;60135;60152;60367;60495.69752151211;1246.8379110715548;1306.3533550892369;1349.7570437321376;1356.3557310277736;1374.2098293481288;31594;33041;33053.17367065843;33155.50266746049;33344.66655333416;51958;51985.48014519957;52284.738576306874;52383.47616523786;52416.47583524116;449619;450893;452618;454522;455505;28406.57390139191;28678;29231.561526577545;29336.706632933397;29715.10854674363;49653;50454.49545504498;50832;51092.23361649652;51342.74328628333;42689.786551067045;43008;43195.136097278504;43209.78395108004;43270;41961.37057944072;41998.58001419947;42270.154596907276;42376;42698.359524607775;40480;41806.79096604497;42210.36684449674;42732;42757.35863962105;36000.27999440049;37692;37752.24495510019;38076.42885356777;38076.80961595285;28404;28555.571666424607;28702.42595148127;28745.28136796513;28970.116942398676 02:25:08 INFO - PROCESS | 29281 | |2;jquery.html;380.676425038717;381.43166681644357;389.9785511796851;402.38033428520083;406.7742402966354;17538.82461175388;19598.510037249074;20501.282455114073;20592.382228533148;20719.482012949684;18291;18803.247870085215;18893.811061889377;18937.810621893812;19118;5668.716564171786;5678.744456499447;5820.38885916979;5866.208061911651;5872.61827981182;5654.830355089333;5659.320881494226;5682.51698605619;5721.942780572203;5726.513246374063;5440.401555828856;5596.048671725816;5637.943620563803;5641.661500309974;5784.045632470637;5694.772209111651;5715.428457154293;5725.914111288334;5731.828045158652;5750.626209296403;5030.798768049273;5059;5106.285120083191;5119.795208191668;5126.384833819965;19898.403047908585;21509.139634414605;21528.56942861134;22577.661335079985;22814;2208.2271205078255;2216.1910902520626;2308.653701944705;2337.4972692788965;2389.6057150570136;10128.797424051478;10162.9491852541;10174.186065114773;11029.889701102966;12592.748145037049;1925.4416219296388;1931.4109196695142;1973.5855470351244;2023.2918478532542;2051.169276443043;68251.31748682499;72530;74292.25707742962;81408;82742;10112.494375281207;10735;10871.728206794734;10928.781424371467;10987.725306867393;14548.781768273484;14642.414303427744;14645.780313295309;14668.486602968846;14689.531046895225;8022.839543209103;8172.305354044854;8245.8350832983;8271.95864020676;8282.958585207036;7816.140224575292;7905.841883162305;7920.762377128695;8024.558649274346;8069.596520173968;4518.096380723802;4586.4496260448295;4664.090502352009;4706.1999460091865;4717.646176536773;1885.1833565240668;1938.1472152253245;1949.7952714965008;1969.5371587676884;1981.9702704459444;940.3840484482674;973.3332667123043;978.4814048554277;981.5533932060895;1029.0172884894907;19303.51741206481;19555.706664400044;19630;19882.50293742639;20162;960.7982323711959;965.0650445856014;1012.7670635753818;1045.1847558904067;1074.5164675895878;10560.735981600368;10723.678289651323;11285.661430157108;11297.096232301561;11860.88139118615;465281;468518;469913;471532;477221;53388.46611533913;68245.65877170682;82164;86002.56998714966;90074.54962725275;1017.6031347774374;1024.6311327921942;1028.5063169678447;1047.4186826311318;1050.3540322701635;17399.826001740326;18017.639647207245;18018.90990545039;18136.727949080512;18336.816631834045;37602.435963460026;37663.246735065695;39455.2108957825;42059.7897010513;42878.35682464828;48583.75708121437;57469.71265143647;58229.708851457166;58271.417285826596;58575;8626.698065567674;8657.22085012352;8702;8753;8783.165599268059;9749.22006239485;13948.232847193502;14069.718605627626;14090.36593353281;14097.929510352382;11805.881941180478;11879.524819007489;12049.216800907912;12155.027597792332;12233.571824986082;11885.881141188478;11908.285502869856;12310.138290319592;12335.198212116184;12494;11569.710757231136;12393.070519710878;12410.81383779226;12734.936325318315;12824.358782061046;7388.187299396955;7770;7788.92211077882;8684.956575217337;8696.739097827076;8925.553722313729;10884.1978347192;12061.75876482483;12397.380130993233;12643.304618246084 02:25:08 INFO - PROCESS | 29281 | |3;mootools.html;1441.783732440134;1468.1117923656188;1574.1420925595548;1706.7857694742556;1728.0841154188277;7636.618169091551;8126.309263712584;8245;8698.869516957251;8722.21500064994;8312.418130730852;8508.957455212716;8561.61472733727;8591.441556298836;8621.051684314736;2209.723784526934;2245.4498647831224;2260.5704916065893;2270.2508172303183;2276.612975794119;2180.2260197629853;2198.56028794241;2205.9889700551475;2210.9005094770773;2232.363776323748;2239.026023679696;2248.1007596961263;2249.246502421691;2256.5035692147703;2294.552562250362;2143.2605751015954;2159.88120653364;2202.768709285526;2219.1012639880873;2221.422430168168;2234.273860995183;2234.9217777377876;2258.9887050564644;2263.411513006614;2266.2747920665392;8579.785505362415;8587.313014958789;8710.651573937035;8727.956360218222;8728.694495692684;4903.754812259408;4976.353074100344;5024.572911302544;5032.194848824171;5079.339685840817;3004.248937765559;3179.5230715392877;3286.901392958215;3331.1006028372444;3369.2924485858;1031.5461197073264;1048.3866937841372;1053.2469284461647;1057.4289883462998;1058.2433560004556;11807.23252988553;11808.527658893634;11865.881341186563;11884.346360950145;11991.400429978466;4390.7585082820115;4411.426514553087;4544.18204723153;4554.0891821635805;4560.247559152769;10176.084152426318;10201.897981020244;10211.183105351554;10224.233182511192;10257.794844103077;5031.572316353151;5043.798248070109;5086.389633243961;5099.745012749348;5115.258287548285;4622.815087396534;4668.183067963093;4717.457492388419;4738.336632871401;4779.235322348477;3491.633378495272;3493.0568746438826;3509.701675357572;3596.8561257549927;3611.3499570077115;1071.839224116373;1079.4872435593031;1082.8375743638517;1084.6203828659907;1086.299336927693;853.7822855171892;978.3836183204536;981.8625392445064;988.2439933450916;1001.6494227020485;5693.861227754465;5849.210356601804;5926.940730592725;5982.760689572368;6018.21763170785;442.2261043174445;446.5133005024474;450.47069693110467;461.9445666520039;464.8373069425674;4086.9182616348103;4096.221717873595;4133.855315063958;4143.399207114951;4156.501219853637;10603.787924241473;10787.244892857425;10804.837927431096;10981.670549883516;11062.39156846365;10685.198610104273;10769.784604308026;10795.352278863136;10823.67528974132;10833.187510936712;7621.466497345133;7992.600369981594;7998.280154786097;8113.837723245502;8146.796330091676;5889.440503152194;5935;5971.402859713994;6045.063015232646;6054.182685337423;9525.809483810146;10009.799804003733;10047.447390393598;10204.591816327264;10219.284650074424;9141.085891410805;9737.464439455898;9861.915189329025;10359.741006474596;10396.428196448966;7312.963435183003;7649.770506884803;7666.386689064973;7677.9616101921365;7685.193054729397;8023.4784738991775;8320.791980200544;8332.625031873458;8496.32029437656;8512;7470.439717021354;7601.733939312318;7737.419693522896;7821.804454888674;7850.528968261922;7246.855062898818;7364.484486086137;7375.078115235596;7418.1839997599145;7647.847043058996;6637.4690024798865;6675.299093595297;6710.496712746466;6732.293109223461;6737.764178253738;4855.441624213261;4898.681585696918;4960.727160006234;4972.577330926912;5031.874203144805;4847.781849816837;4921.360223170965;4931.211006238985;4949.183384741477;5022.121128802518 02:25:08 INFO - PROCESS | 29281 | |4;prototype.html;320.5592310572962;320.90052083854005;326.59012938761856;331.3770112189084;331.66004845033854;5591.468810463005;5591.916121258179;5633.887322253552;5653.265075540174;5657.57568182387;5548.112302031675;5552.222688823558;5566.888662226753;5567.693776842272;5576.525995290405;4087.3664581989765;4206.242876282268;4306.7631280279575;4313.784310784464;4323.978380108095;4243.618074373306;4289.806958686867;4317.201317756209;4319.460067491564;4325.113351762881;4252.425922500469;4300.397944287803;4301.096769678371;4303.376010478479;4308.74147551148;4051.7974101294817;4222.197782421361;4222.662187025061;4229.238737027334;4304.978475107636;3644.4511082789973;3655.5430571178604;3662.5421822272215;3668.853245870162;3680.8527658893613;5473.863153421156;5480.232767412565;5493.945060549383;5499.560035197214;5500.779968801243;4671.789769460383;4815.205491093965;4907.386576677915;4918.2376731606655;4956.306117143603;5792.82621521355;5871.471567558898;5891.440313170242;5891.79378721747;5910.581460449504;4085.5301640311445;4095.85664501744;4097.364908439196;4116.855910043164;4118.320477121271;5848.654809393821;6017.849553761147;6029.457348838626;6036.849078773066;6051.546134039964;4115.9176816463505;4151.356539736345;4157.875263742093;4175.164967006611;4180.686448516373;4185.686073544496;4218.974892051832;4224.366345048206;4239.236937351307;4246.44796176495;4731.858044258678;4885.1450996076255;4927.5811556017425;4928.422904670471;4928.457869634337;5835.066389377764;5870.823875283749;5902.763889444374;5936.940630593639;5941.999290358342;1454.163855782929;1457.7813328000884;1461.4738694070127;1462.9853701463062;1472.3227315434806;915.1397686174975;924.3945215883473;933.9766505837408;941.7457286532598;989.9259303655614;5598.86002849932;5600.215969764236;5609.158626206102;5620.156976453564;5627.774889004394;5861.6189947653265;5932.40675932412;5942.821715348547;5944.286685597669;5949.6430214187285;5265.052290587654;5479.808206712746;5542.528885044816;5549.667019978814;5556.444355564411;3147.118806734118;3166.0660105269003;3181.411438883814;3181.872725091017;3182.411253918033;5888.9705551472825;6084.056971169476;6092.45167934888;6138.14066030756;6154.969225153845;6014.51883849291;6099.78004399122;6102;6124.203853499017;6131.172291740647;5950.821475355746;5954.642721436641;6103.23709536308;6125.908111378333;6131.14164017038;5649.22049554389;5881.9705901470215;5923.437273459014;5928.170056192051;5944.970275148597;5795.884082318415;5828.213191219301;5829.650220986754;5834.299884013945;5875.706214689163;5883.764169615519;6041.818745437644;6065.8180254592435;6144.969275153596;6164.229471316085;4119.567445418188;4176.227397931392;4188.979055104827;4199.727017743837;4205.789710514401;5926.644401335933;5933.703314834327;6008.759649613967;6021.157038014769;6022.488088512526;5568.136938774496;5693.9430605693415;5754.395788442321;5786.1899334094105;5837.153612726216;5748.597598168088;5786.537077033911;5827.329857066492;5828.6502809831545;5836.562257830595;5538.695371754592;5588.776448941997;5649.548036157015;5679.636887146972;5761.798337058183;5854.5609079320075;5872.383399742966;5875.50058245054;5934.258217722785;5954.261039921511;5539.501444869981;5697.287839020122;5708.372079071381;5727.4845263926445;5733.340665823317 02:25:08 INFO - PROCESS | 29281 | |5;yui.html;707.5259576084027;741.0292516802989;746.7237122264763;751.2149803455388;782.9217078292171;14961.92519037406;15033.398664053439;15086.47197348093;15122.319495622696;15146.77279840802;14808.185549794784;15167.6966460671;15185.848141518582;15196.620084497865;15239.238038098107;664.5215444879703;783.5690370296343;784.2510402565537;800.383704547498;808.9352851771873;804.0953926832314;808.2725547007682;808.49873078691;809.7125520440247;810.1898101898101;843.3042739739709;845.0324378586546;846.2975730143966;847.8812966184739;848.3637272045966;840.5503055865113;841.8232171244047;841.9158084191594;842.0358689300778;842.5029232752644;617.4381313005143;617.6726335042434;617.9258488981307;620.1937481274325;621.1800423441059;15090.773638395432;15114.54656360311;15322.846771532253;15357.232138393147;15361.078335299917;14510.201938893357;14636.70726585473;14701.338439770128;14861;14930.402783888632;11907.702307442296;12007.159498835084;12114.0914431418;12246.877531224663;12316.199447035913;3940.9701462792264;3992.7604343739176;4101.118259574206;4202.642775364097;4203.810828512694;70353.2964670357;73609.6319518399;74290;74311;74699.6265018677;11586.88413115875;11968.755459060063;12160.331181785086;12181.756364872654;12190.878091218974;20197.293094741613;22378.440538986655;22426.21508247236;22448.551028979327;22541.54916901653;8739.956300218459;8745.212930836255;8763.824723505622;9225.356312242835;9478.146966772885;4903.264510323409;4941.950580494221;4956.653034287565;5120.667156634881;5149.76826042829;3581.659742324475;3683.686886614614;3684.318401095752;3687.4468829675225;3692.132348898007;647.2459584584001;658.3844105761033;662.2748090840522;675.6081472745894;679.1680191765048;710.5398406275051;745.2063552316765;758.2531206761336;758.6093162021564;766.7431410477441;9490.335676502717;9666.75833104178;9750.219982401391;9881.950590247003;10030.097291243823;753.886916962449;764.6673696941848;778.1790211327104;781.4217479065564;796.9242921922408;4524.977375113103;4861.513848615181;4870.902581948341;4922.876928076755;4929.556339929351;66362.66818665972;67247.66376168186;112256;116503.41748291205;117048;88916.5554172225;95931.52034239784;96184;96772.51613741886;97602.5119874396;82018.17981820105;87599;88802.11197888068;88805;90139;10224.386536807815;10577.152871823566;11004.559817607205;11016.669499915015;11038.558457661604;36120.638793611724;48080.27879581879;49785.75107124441;51137.23294150665;51703.48296516987;69956.60086798338;74497.62751186427;75924.24075759393;76250;76806;13357.065005449525;13368.866311337151;13531.25578093175;13627.250501222528;13636.250006249355;14459.927700361852;14750.483733069721;14825.258737062888;15178.772318415453;15348.76976845326;13935.512257070954;14496.565103046925;14690.63273418173;14718.999112051197;15379;13868.583942481742;13909.095908765898;14266.500672476413;14544.563663090124;14548;13214;13222.537211197561;13292.335383230993;13463.259520726455;13695.383707732977;11408.855435463265;11465.770684586429;11830.592228406274;12053.63839084829;12144.332061736335;11098.66703998849;12261.26432414058;12314.630561083182;12448.62654120378;12691.111622186358 02:25:08 INFO - PROCESS | 29281 | __end_tp_report 02:25:08 INFO - PROCESS | 29281 | __start_cc_report 02:25:08 INFO - PROCESS | 29281 | _x_x_mozilla_cycle_collect,362 02:25:08 INFO - PROCESS | 29281 | __end_cc_report 02:25:08 INFO - PROCESS | 29281 | __startTimestamp1466587508512__endTimestamp 02:25:08 INFO - PROCESS | 29281 | 02:25:08 INFO - PROCESS | 29281 | ------- Summary: start ------- 02:25:08 INFO - PROCESS | 29281 | Number of tests: 6 02:25:08 INFO - PROCESS | 29281 | 02:25:08 INFO - PROCESS | 29281 | [#0] dojo.html Cycles:165 Average:5330.40 Median:5563.81 stddev:704.83 (12.7%) stddev-sans-first:684.86 02:25:08 INFO - PROCESS | 29281 | Values: 3096.8 3101.2 3125.2 3133.3 3146.2 5322.2 5341.0 5385.1 5415.9 5421.2 5292.2 5313.7 5330.4 5377.9 5379.2 4852.3 4871.3 4978.3 5021.1 5053.0 738.6 4797.9 4863.7 4936.3 4937.5 4883.9 4907.4 4917.3 4917.8 4920.7 4937.3 4940.5 4945.1 4956.6 4957.5 4823.6 4835.6 4858.7 4896.0 4906.0 5335.5 5387.2 5407.5 5411.8 5457.4 5628.4 5722.3 5734.5 5742.5 5746.5 5760.9 5789.7 5795.3 5807.4 5837.0 5374.7 5396.9 5398.2 5400.3 5416.4 5823.5 5879.9 5910.1 5913.9 5967.8 5622.9 5626.2 5627.3 5627.7 5645.1 5760.0 5762.9 5765.9 5769.8 5772.6 5704.9 5754.6 5817.5 5820.4 5828.5 5784.7 5806.8 5842.9 5860.4 5880.0 4307.8 4440.1 4460.5 4480.0 4532.2 3873.7 3911.6 3951.1 3965.8 3969.3 5489.2 5504.9 5527.0 5549.2 5562.9 5672.7 5816.7 5818.5 5819.9 5831.2 5504.4 5509.7 5512.2 5526.6 5580.7 4827.4 4833.6 4837.9 4845.2 4856.6 5857.7 5871.8 5916.0 5926.6 5936.6 5729.6 5750.7 5773.6 5787.2 5827.5 5924.0 5931.6 5935.7 5946.6 5948.6 5569.3 5620.6 5625.7 5663.2 5697.6 5802.4 5804.9 5810.2 5810.4 5845.5 5620.5 5621.6 5626.4 5659.3 5666.3 5489.3 5545.3 5571.2 5623.8 5654.5 5516.8 5519.9 5529.6 5540.0 5544.1 5622.6 5707.6 5718.2 5718.3 5738.2 5413.4 5519.4 5563.8 5586.5 5605.1 02:25:08 INFO - PROCESS | 29281 | 02:25:08 INFO - PROCESS | 29281 | [#1] ext.html Cycles:180 Average:59185.64 Median:22108.59 stddev:122378.31 (553.5%) stddev-sans-first:122642.47 02:25:08 INFO - PROCESS | 29281 | Values: 567.4 616.3 616.3 634.9 653.6 40177.2 41863.4 44185.6 44216.0 44435.0 44908.6 45401.8 45503.3 45514.3 45829.1 8875.5 8997.9 9031.3 9050.2 9082.1 8939.3 8971.3 9025.1 9032.3 9081.4 9027.5 9078.9 9080.0 9096.1 9159.3 9028.5 9102.5 9110.5 9111.1 9120.6 8811.0 8945.9 8957.4 8977.2 9027.8 35190.3 42671.8 43137.4 43246.4 43350.8 3376.1 3406.5 3556.8 3583.7 3672.7 32255.8 32337.0 32596.5 32669.5 33512.5 3778.8 3795.5 3811.0 3954.6 4040.0 292484.0 292906.0 293504.0 293994.5 294542.0 34285.5 35093.5 35169.6 35265.0 35303.6 35570.1 37388.4 37441.6 37472.8 37596.8 15487.5 15585.0 15593.4 15628.4 15680.3 12250.1 12265.8 12322.7 12349.0 12384.3 8382.0 8409.8 8443.9 8517.3 8575.7 3232.6 3261.2 3274.6 3277.5 3300.2 1064.7 1080.0 1091.4 1096.6 1160.6 32822.7 33177.2 33631.3 33744.7 34204.3 1114.1 1148.4 1163.0 1182.7 1261.6 17029.5 17391.5 17489.4 17497.2 17703.5 574181.0 580215.0 588102.0 588456.0 589127.0 59716.7 60135.0 60152.0 60367.0 60495.7 1246.8 1306.4 1349.8 1356.4 1374.2 31594.0 33041.0 33053.2 33155.5 33344.7 51958.0 51985.5 52284.7 52383.5 52416.5 449619.0 450893.0 452618.0 454522.0 455505.0 28406.6 28678.0 29231.6 29336.7 29715.1 49653.0 50454.5 50832.0 51092.2 51342.7 42689.8 43008.0 43195.1 43209.8 43270.0 41961.4 41998.6 42270.2 42376.0 42698.4 40480.0 41806.8 42210.4 42732.0 42757.4 36000.3 37692.0 37752.2 38076.4 38076.8 28404.0 28555.6 28702.4 28745.3 28970.1 02:25:08 INFO - PROCESS | 29281 | 02:25:08 INFO - PROCESS | 29281 | [#2] jquery.html Cycles:180 Average:27778.29 Median:2363.55 stddev:77285.20 (3269.9%) stddev-sans-first:77474.63 02:25:08 INFO - PROCESS | 29281 | Values: 380.7 381.4 390.0 402.4 406.8 17538.8 19598.5 20501.3 20592.4 20719.5 18291.0 18803.2 18893.8 18937.8 19118.0 5668.7 5678.7 5820.4 5866.2 5872.6 5654.8 5659.3 5682.5 5721.9 5726.5 5440.4 5596.0 5637.9 5641.7 5784.0 5694.8 5715.4 5725.9 5731.8 5750.6 5030.8 5059.0 5106.3 5119.8 5126.4 19898.4 21509.1 21528.6 22577.7 22814.0 2208.2 2216.2 2308.7 2337.5 2389.6 10128.8 10162.9 10174.2 11029.9 12592.7 1925.4 1931.4 1973.6 2023.3 2051.2 68251.3 72530.0 74292.3 81408.0 82742.0 10112.5 10735.0 10871.7 10928.8 10987.7 14548.8 14642.4 14645.8 14668.5 14689.5 8022.8 8172.3 8245.8 8272.0 8283.0 7816.1 7905.8 7920.8 8024.6 8069.6 4518.1 4586.4 4664.1 4706.2 4717.6 1885.2 1938.1 1949.8 1969.5 1982.0 940.4 973.3 978.5 981.6 1029.0 19303.5 19555.7 19630.0 19882.5 20162.0 960.8 965.1 1012.8 1045.2 1074.5 10560.7 10723.7 11285.7 11297.1 11860.9 465281.0 468518.0 469913.0 471532.0 477221.0 53388.5 68245.7 82164.0 86002.6 90074.5 1017.6 1024.6 1028.5 1047.4 1050.4 17399.8 18017.6 18018.9 18136.7 18336.8 37602.4 37663.2 39455.2 42059.8 42878.4 48583.8 57469.7 58229.7 58271.4 58575.0 8626.7 8657.2 8702.0 8753.0 8783.2 9749.2 13948.2 14069.7 14090.4 14097.9 11805.9 11879.5 12049.2 12155.0 12233.6 11885.9 11908.3 12310.1 12335.2 12494.0 11569.7 12393.1 12410.8 12734.9 12824.4 7388.2 7770.0 7788.9 8685.0 8696.7 8925.6 10884.2 12061.8 12397.4 12643.3 02:25:08 INFO - PROCESS | 29281 | 02:25:08 INFO - PROCESS | 29281 | [#3] mootools.html Cycles:180 Average:5639.27 Median:2542.38 stddev:3268.45 (128.6%) stddev-sans-first:3262.39 02:25:08 INFO - PROCESS | 29281 | Values: 1441.8 1468.1 1574.1 1706.8 1728.1 7636.6 8126.3 8245.0 8698.9 8722.2 8312.4 8509.0 8561.6 8591.4 8621.1 2209.7 2245.4 2260.6 2270.3 2276.6 2180.2 2198.6 2206.0 2210.9 2232.4 2239.0 2248.1 2249.2 2256.5 2294.6 2143.3 2159.9 2202.8 2219.1 2221.4 2234.3 2234.9 2259.0 2263.4 2266.3 8579.8 8587.3 8710.7 8728.0 8728.7 4903.8 4976.4 5024.6 5032.2 5079.3 3004.2 3179.5 3286.9 3331.1 3369.3 1031.5 1048.4 1053.2 1057.4 1058.2 11807.2 11808.5 11865.9 11884.3 11991.4 4390.8 4411.4 4544.2 4554.1 4560.2 10176.1 10201.9 10211.2 10224.2 10257.8 5031.6 5043.8 5086.4 5099.7 5115.3 4622.8 4668.2 4717.5 4738.3 4779.2 3491.6 3493.1 3509.7 3596.9 3611.3 1071.8 1079.5 1082.8 1084.6 1086.3 853.8 978.4 981.9 988.2 1001.6 5693.9 5849.2 5926.9 5982.8 6018.2 442.2 446.5 450.5 461.9 464.8 4086.9 4096.2 4133.9 4143.4 4156.5 10603.8 10787.2 10804.8 10981.7 11062.4 10685.2 10769.8 10795.4 10823.7 10833.2 7621.5 7992.6 7998.3 8113.8 8146.8 5889.4 5935.0 5971.4 6045.1 6054.2 9525.8 10009.8 10047.4 10204.6 10219.3 9141.1 9737.5 9861.9 10359.7 10396.4 7313.0 7649.8 7666.4 7678.0 7685.2 8023.5 8320.8 8332.6 8496.3 8512.0 7470.4 7601.7 7737.4 7821.8 7850.5 7246.9 7364.5 7375.1 7418.2 7647.8 6637.5 6675.3 6710.5 6732.3 6737.8 4855.4 4898.7 4960.7 4972.6 5031.9 4847.8 4921.4 4931.2 4949.2 5022.1 02:25:08 INFO - PROCESS | 29281 | 02:25:08 INFO - PROCESS | 29281 | [#4] prototype.html Cycles:180 Average:4866.11 Median:5595.39 stddev:1450.15 (25.9%) stddev-sans-first:1413.52 02:25:08 INFO - PROCESS | 29281 | Values: 320.6 320.9 326.6 331.4 331.7 5591.5 5591.9 5633.9 5653.3 5657.6 5548.1 5552.2 5566.9 5567.7 5576.5 4087.4 4206.2 4306.8 4313.8 4324.0 4243.6 4289.8 4317.2 4319.5 4325.1 4252.4 4300.4 4301.1 4303.4 4308.7 4051.8 4222.2 4222.7 4229.2 4305.0 3644.5 3655.5 3662.5 3668.9 3680.9 5473.9 5480.2 5493.9 5499.6 5500.8 4671.8 4815.2 4907.4 4918.2 4956.3 5792.8 5871.5 5891.4 5891.8 5910.6 4085.5 4095.9 4097.4 4116.9 4118.3 5848.7 6017.8 6029.5 6036.8 6051.5 4115.9 4151.4 4157.9 4175.2 4180.7 4185.7 4219.0 4224.4 4239.2 4246.4 4731.9 4885.1 4927.6 4928.4 4928.5 5835.1 5870.8 5902.8 5936.9 5942.0 1454.2 1457.8 1461.5 1463.0 1472.3 915.1 924.4 934.0 941.7 989.9 5598.9 5600.2 5609.2 5620.2 5627.8 5861.6 5932.4 5942.8 5944.3 5949.6 5265.1 5479.8 5542.5 5549.7 5556.4 3147.1 3166.1 3181.4 3181.9 3182.4 5889.0 6084.1 6092.5 6138.1 6155.0 6014.5 6099.8 6102.0 6124.2 6131.2 5950.8 5954.6 6103.2 6125.9 6131.1 5649.2 5882.0 5923.4 5928.2 5945.0 5795.9 5828.2 5829.7 5834.3 5875.7 5883.8 6041.8 6065.8 6145.0 6164.2 4119.6 4176.2 4189.0 4199.7 4205.8 5926.6 5933.7 6008.8 6021.2 6022.5 5568.1 5693.9 5754.4 5786.2 5837.2 5748.6 5786.5 5827.3 5828.7 5836.6 5538.7 5588.8 5649.5 5679.6 5761.8 5854.6 5872.4 5875.5 5934.3 5954.3 5539.5 5697.3 5708.4 5727.5 5733.3 02:25:08 INFO - PROCESS | 29281 | 02:25:08 INFO - PROCESS | 29281 | [#5] yui.html Cycles:180 Average:20244.09 Median:26302.63 stddev:28126.27 (106.9%) stddev-sans-first:28166.92 02:25:08 INFO - PROCESS | 29281 | Values: 707.5 741.0 746.7 751.2 782.9 14961.9 15033.4 15086.5 15122.3 15146.8 14808.2 15167.7 15185.8 15196.6 15239.2 664.5 783.6 784.3 800.4 808.9 804.1 808.3 808.5 809.7 810.2 843.3 845.0 846.3 847.9 848.4 840.6 841.8 841.9 842.0 842.5 617.4 617.7 617.9 620.2 621.2 15090.8 15114.5 15322.8 15357.2 15361.1 14510.2 14636.7 14701.3 14861.0 14930.4 11907.7 12007.2 12114.1 12246.9 12316.2 3941.0 3992.8 4101.1 4202.6 4203.8 70353.3 73609.6 74290.0 74311.0 74699.6 11586.9 11968.8 12160.3 12181.8 12190.9 20197.3 22378.4 22426.2 22448.6 22541.5 8740.0 8745.2 8763.8 9225.4 9478.1 4903.3 4942.0 4956.7 5120.7 5149.8 3581.7 3683.7 3684.3 3687.4 3692.1 647.2 658.4 662.3 675.6 679.2 710.5 745.2 758.3 758.6 766.7 9490.3 9666.8 9750.2 9882.0 10030.1 753.9 764.7 778.2 781.4 796.9 4525.0 4861.5 4870.9 4922.9 4929.6 66362.7 67247.7 112256.0 116503.4 117048.0 88916.6 95931.5 96184.0 96772.5 97602.5 82018.2 87599.0 88802.1 88805.0 90139.0 10224.4 10577.2 11004.6 11016.7 11038.6 36120.6 48080.3 49785.8 51137.2 51703.5 69956.6 74497.6 75924.2 76250.0 76806.0 13357.1 13368.9 13531.3 13627.3 13636.3 14459.9 14750.5 14825.3 15178.8 15348.8 13935.5 14496.6 14690.6 14719.0 15379.0 13868.6 13909.1 14266.5 14544.6 14548.0 13214.0 13222.5 13292.3 13463.3 13695.4 11408.9 11465.8 11830.6 12053.6 12144.3 11098.7 12261.3 12314.6 12448.6 12691.1 02:25:08 INFO - PROCESS | 29281 | -------- Summary: end -------- 02:25:08 INFO - PROCESS | 29281 | 02:25:09 INFO - TEST-INFO | 29281: exit 0 02:25:09 INFO - TEST-OK | dromaeo_css | took 1111172ms 02:25:09 INFO - TEST-START | kraken 02:25:09 INFO - operating with platform_type : linux_ 02:25:09 INFO - Initialising browser for kraken test... 02:25:09 INFO - TEST-INFO | started process 29518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXPohkQ/profile http://localhost:47223/getInfo.html) 02:25:13 INFO - PROCESS | 29518 | __metrics Screen width/height:1600/1200 02:25:13 INFO - PROCESS | 29518 | colorDepth:24 02:25:13 INFO - PROCESS | 29518 | Browser inner width/height: 1024/697 02:25:13 INFO - PROCESS | 29518 | __metrics 02:25:14 ERROR - PROCESS | 29518 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:25:15 INFO - TEST-INFO | 29518: exit 0 02:25:15 INFO - Browser initialized. 02:25:15 INFO - Running cycle 1/1 for kraken test... 02:25:15 INFO - TEST-INFO | started process 29639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXPohkQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:27 INFO - PROCESS | 29639 | RSS: Main: 185122816 02:25:27 INFO - PROCESS | 29639 | 02:25:30 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47223/tests/kraken/driver.html?testName=audio-beat-detection) 02:25:30 INFO - PROCESS | 29639 | RSS: Main: 190812160 02:25:30 INFO - PROCESS | 29639 | 02:25:33 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47223/tests/kraken/driver.html?testName=audio-dft) 02:25:34 INFO - PROCESS | 29639 | RSS: Main: 189726720 02:25:34 INFO - PROCESS | 29639 | 02:25:37 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47223/tests/kraken/driver.html?testName=audio-fft) 02:25:37 INFO - PROCESS | 29639 | RSS: Main: 184946688 02:25:37 INFO - PROCESS | 29639 | 02:25:40 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47223/tests/kraken/driver.html?testName=audio-oscillator) 02:25:40 INFO - PROCESS | 29639 | RSS: Main: 185872384 02:25:40 INFO - PROCESS | 29639 | 02:25:42 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47223/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:25:43 INFO - PROCESS | 29639 | RSS: Main: 186228736 02:25:43 INFO - PROCESS | 29639 | 02:25:46 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47223/tests/kraken/driver.html?testName=imaging-darkroom) 02:25:47 INFO - PROCESS | 29639 | RSS: Main: 186646528 02:25:47 INFO - PROCESS | 29639 | 02:25:50 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47223/tests/kraken/driver.html?testName=imaging-desaturate) 02:25:51 INFO - PROCESS | 29639 | RSS: Main: 184008704 02:25:51 INFO - PROCESS | 29639 | 02:25:54 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47223/tests/kraken/driver.html?testName=json-parse-financial) 02:25:54 INFO - PROCESS | 29639 | RSS: Main: 185421824 02:25:54 INFO - PROCESS | 29639 | 02:25:56 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47223/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:25:57 INFO - PROCESS | 29639 | RSS: Main: 185864192 02:25:57 INFO - PROCESS | 29639 | 02:25:58 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47223/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:25:59 INFO - PROCESS | 29639 | RSS: Main: 186232832 02:25:59 INFO - PROCESS | 29639 | 02:26:01 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47223/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:02 INFO - PROCESS | 29639 | RSS: Main: 186327040 02:26:02 INFO - PROCESS | 29639 | 02:26:04 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:05 INFO - PROCESS | 29639 | RSS: Main: 186200064 02:26:05 INFO - PROCESS | 29639 | 02:26:08 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:08 INFO - PROCESS | 29639 | RSS: Main: 186376192 02:26:08 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | Cycle 1(1): loaded http://localhost:47223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47223/tests/kraken/driver.html?testName=ai-astar) 02:26:10 INFO - PROCESS | 29639 | RSS: Main: 187068416 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | __start_tp_report 02:26:10 INFO - PROCESS | 29639 | _x_x_mozilla_page_load 02:26:10 INFO - PROCESS | 29639 | _x_x_mozilla_page_load_details 02:26:10 INFO - PROCESS | 29639 | |i|pagename|runs| 02:26:10 INFO - PROCESS | 29639 | |0;ai-astar;113;106;111;109;113;110;110;109;111;109 02:26:10 INFO - PROCESS | 29639 | |1;audio-beat-detection;156;132;161;178;130;150;164;127;182;130 02:26:10 INFO - PROCESS | 29639 | |2;audio-dft;161;161;162;163;163;169;160;162;163;161 02:26:10 INFO - PROCESS | 29639 | |3;audio-fft;75;76;77;160;78;74;75;73;155;76 02:26:10 INFO - PROCESS | 29639 | |4;audio-oscillator;84;84;155;86;87;85;152;84;85;149 02:26:10 INFO - PROCESS | 29639 | |5;imaging-gaussian-blur;118;117;117;118;117;118;117;119;117;117 02:26:10 INFO - PROCESS | 29639 | |6;imaging-darkroom;150;151;147;149;147;147;146;148;147;147 02:26:10 INFO - PROCESS | 29639 | |7;imaging-desaturate;95;97;95;95;95;96;95;96;96;96 02:26:10 INFO - PROCESS | 29639 | |8;json-parse-financial;55;55;55;54;57;55;55;54;54;54 02:26:10 INFO - PROCESS | 29639 | |9;json-stringify-tinderbox;61;61;62;61;63;63;61;61;61;61 02:26:10 INFO - PROCESS | 29639 | |10;stanford-crypto-aes;80;87;81;80;84;82;82;95;110;87 02:26:10 INFO - PROCESS | 29639 | |11;stanford-crypto-ccm;124;123;142;122;127;123;138;132;132;123 02:26:10 INFO - PROCESS | 29639 | |12;stanford-crypto-pbkdf2;172;168;163;166;170;176;166;162;163;161 02:26:10 INFO - PROCESS | 29639 | |13;stanford-crypto-sha256-iterative;64;64;65;65;64;65;63;63;62;67 02:26:10 INFO - PROCESS | 29639 | __end_tp_report 02:26:10 INFO - PROCESS | 29639 | __start_cc_report 02:26:10 INFO - PROCESS | 29639 | _x_x_mozilla_cycle_collect,919 02:26:10 INFO - PROCESS | 29639 | __end_cc_report 02:26:10 INFO - PROCESS | 29639 | __startTimestamp1466587570851__endTimestamp 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | ------- Summary: start ------- 02:26:10 INFO - PROCESS | 29639 | Number of tests: 14 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:2.08 (1.9%) stddev-sans-first:1.92 02:26:10 INFO - PROCESS | 29639 | Values: 113.0 106.0 111.0 109.0 113.0 110.0 110.0 109.0 111.0 109.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:158.50 stddev:20.56 (13.0%) stddev-sans-first:21.73 02:26:10 INFO - PROCESS | 29639 | Values: 156.0 132.0 161.0 178.0 130.0 150.0 164.0 127.0 182.0 130.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.51 (1.5%) stddev-sans-first:2.60 02:26:10 INFO - PROCESS | 29639 | Values: 161.0 161.0 162.0 163.0 163.0 169.0 160.0 162.0 163.0 161.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#3] audio-fft Cycles:10 Average:91.90 Median:75.50 stddev:34.62 (45.9%) stddev-sans-first:36.18 02:26:10 INFO - PROCESS | 29639 | Values: 75.0 76.0 77.0 160.0 78.0 74.0 75.0 73.0 155.0 76.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:84.50 stddev:32.41 (38.4%) stddev-sans-first:33.46 02:26:10 INFO - PROCESS | 29639 | Values: 84.0 84.0 155.0 86.0 87.0 85.0 152.0 84.0 85.0 149.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 02:26:10 INFO - PROCESS | 29639 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 117.0 119.0 117.0 117.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:147.50 stddev:1.60 (1.1%) stddev-sans-first:1.50 02:26:10 INFO - PROCESS | 29639 | Values: 150.0 151.0 147.0 149.0 147.0 147.0 146.0 148.0 147.0 147.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 02:26:10 INFO - PROCESS | 29639 | Values: 95.0 97.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 02:26:10 INFO - PROCESS | 29639 | Values: 55.0 55.0 55.0 54.0 57.0 55.0 55.0 54.0 54.0 54.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 02:26:10 INFO - PROCESS | 29639 | Values: 61.0 61.0 62.0 61.0 63.0 63.0 61.0 61.0 61.0 61.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:83.00 stddev:9.34 (11.3%) stddev-sans-first:9.58 02:26:10 INFO - PROCESS | 29639 | Values: 80.0 87.0 81.0 80.0 84.0 82.0 82.0 95.0 110.0 87.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:129.50 stddev:7.09 (5.5%) stddev-sans-first:7.32 02:26:10 INFO - PROCESS | 29639 | Values: 124.0 123.0 142.0 122.0 127.0 123.0 138.0 132.0 132.0 123.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.00 stddev:4.83 (2.9%) stddev-sans-first:4.73 02:26:10 INFO - PROCESS | 29639 | Values: 172.0 168.0 163.0 166.0 170.0 176.0 166.0 162.0 163.0 161.0 02:26:10 INFO - PROCESS | 29639 | 02:26:10 INFO - PROCESS | 29639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.40 (2.2%) stddev-sans-first:1.48 02:26:10 INFO - PROCESS | 29639 | Values: 64.0 64.0 65.0 65.0 64.0 65.0 63.0 63.0 62.0 67.0 02:26:10 INFO - PROCESS | 29639 | -------- Summary: end -------- 02:26:10 INFO - PROCESS | 29639 | 02:26:11 INFO - TEST-INFO | 29639: exit 0 02:26:11 INFO - TEST-OK | kraken | took 62708ms 02:26:11 INFO - SUITE-END | took 1173s 02:26:12 INFO - Completed test suite (00:19:33) 02:26:12 INFO - javascript benchmark 02:26:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7167.499895866944, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.845157742113, 3101.240196151943, 3125.2343175921897, 3133.326334838009, 3146.1977195815048, 5322.175062865257, 5340.973295133524, 5385.111456609659, 5415.864603384917, 5421.186821976706, 5292.179712144614, 5313.654612450197, 5330.440303768107, 5377.892442151155, 5379.220013098108, 4852.344933433986, 4871.269309603553, 4978.327925730035, 5021.14640511114, 5053.0, 738.6134044574638, 4797.856064318059, 4863.659543831933, 4936.284238785374, 4937.506249375069, 4883.853484395456, 4907.433157204701, 4917.336159618441, 4917.754112294371, 4920.655554111214, 4937.308776771255, 4940.5059494050665, 4945.060438516706, 4956.553910148068, 4957.454679985199, 4823.638227132979, 4835.6131509479155, 4858.732769697665, 4896.0, 4905.975470122662, 5335.466453354672, 5387.164989426645, 5407.459254074601, 5411.756470958816, 5457.399686034533, 5628.380878103405, 5722.341930677983, 5734.483896449339, 5742.483176514092, 5746.482816546489, 5760.884782304331, 5789.710514474259, 5795.333536643256, 5807.361190269067, 5836.9785287574505, 5374.677519348852, 5396.865078373033, 5398.24424580559, 5400.324959380077, 5416.377116631598, 5823.475887170175, 5879.911801322898, 5910.143029260733, 5913.9112913306335, 5967.836271927019, 5622.859428514238, 5626.240457538262, 5627.296587926509, 5627.690477023803, 5645.125005624135, 5759.992001399738, 5762.942370576325, 5765.88468230633, 5769.798057067983, 5772.5959182856795, 5704.914426283609, 5754.568407369464, 5817.50551203144, 5820.3888591698105, 5828.504577110908, 5784.7107644618445, 5806.82579522615, 5842.883142337129, 5860.355360910296, 5879.970600146972, 4307.8492252771, 4440.111977604492, 4460.464744230648, 4479.955200448019, 4532.161550113239, 3873.7288389812443, 3911.6088391160656, 3951.0714981979213, 3965.8215380307956, 3969.3053715599654, 5489.176623506506, 5504.862378440571, 5526.972365138148, 5549.19536667181, 5562.888742225133, 5672.744726487318, 5816.738246778905, 5818.476337129594, 5819.88360232793, 5831.241938547962, 5504.4495550444635, 5509.669419834822, 5512.200730893998, 5526.613137080366, 5580.693061881636, 4827.372441582642, 4833.613310935117, 4837.854864354075, 4845.200541910615, 4856.562909338177, 5857.677827719431, 5871.796281762228, 5916.023856063787, 5926.644401335933, 5936.614120082181, 5729.5702822288495, 5750.654960702372, 5773.566982476247, 5787.160861674949, 5827.504662103769, 5924.0, 5931.555133364928, 5935.732892019783, 5946.613470124428, 5948.643081414956, 5569.275994120739, 5620.606557540933, 5625.662460252398, 5663.207150998781, 5697.6296540724725, 5802.448767367094, 5804.883902322014, 5810.215620891126, 5810.448007439287, 5845.473907348359, 5620.4660557247, 5621.634593751393, 5626.409227031267, 5659.349174844946, 5666.320041595035, 5489.313835770528, 5545.334559852843, 5571.192177134212, 5623.831285061455, 5654.46282603152, 5516.806911758069, 5519.944800551943, 5529.612927095226, 5540.002799496129, 5544.112941929272, 5622.606417550732, 5707.600467967369, 5718.22803921482, 5718.256626638677, 5738.22533957927, 5413.37746159181, 5519.420460851553, 5563.805266815642, 5586.497215250484, 5605.131204663284], "value": 5284.57771504437, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.4439049731263, 616.3035769580373, 616.3035769580373, 634.8635043465654, 653.6241661044901, 40177.196456070895, 41863.372049419246, 44185.558144418545, 44216.0, 44434.99999999992, 44908.55091449084, 45401.772991134996, 45503.31745023819, 45514.317285240664, 45829.08341833161, 8875.511846848436, 8997.910020899806, 9031.322650801183, 9050.1854833065, 9082.137196966278, 8939.329550283723, 8971.282297416225, 9025.142611451902, 9032.27741780656, 9081.364304498687, 9027.503487308195, 9078.86381704275, 9079.954600226989, 9096.13586709265, 9159.267258619295, 9028.548572571379, 9102.453852768855, 9110.544472776368, 9111.134442227978, 9120.635174593008, 8811.0, 8945.865812012826, 8957.417767845134, 8977.236934860544, 9027.819443611092, 35190.29619407623, 42671.786641066596, 43137.35293970593, 43246.35130473045, 43350.78324608357, 3376.1390845334527, 3406.471996840494, 3556.7837404172033, 3583.6774690278, 3672.7429079964413, 32255.838720806245, 32337.0, 32596.511052334234, 32669.50995735066, 33512.497312540334, 3778.792166430845, 3795.4876091727815, 3811.0, 3954.584768599313, 4039.9900024993754, 292484.0, 292906.0, 293504.0, 293994.53002735064, 294542.0, 34285.485717714255, 35093.490650934706, 35169.64830351664, 35265.0, 35303.64696353055, 35570.11074723101, 37388.43917341242, 37441.62558374436, 37472.81263593664, 37596.81201594029, 15487.457938972082, 15585.0, 15593.376264949502, 15628.3748650055, 15680.294386752395, 12250.142490025613, 12265.754684906253, 12322.691932701575, 12349.012079033655, 12384.31886246247, 8381.958090209631, 8409.789755256168, 8443.915560844436, 8517.276031537389, 8575.656973720981, 3232.595925509311, 3261.1684020574603, 3274.574305340338, 3277.5411442398085, 3300.2409445827593, 1064.685917654294, 1079.983800242997, 1091.3888222595372, 1096.5613754498106, 1160.5937921727498, 32822.67177328196, 33177.17057073592, 33631.3273734524, 33744.66255337464, 34204.31591368159, 1114.1254115519441, 1148.3970915269383, 1162.9533419922138, 1182.7043239190202, 1261.6278197931633, 17029.48911532656, 17391.47825565235, 17489.38787142444, 17497.212625431886, 17703.468895933143, 574181.0, 580215.0, 588102.0, 588456.0, 589127.0, 59716.70141649351, 60135.0, 60152.0, 60367.0, 60495.69752151211, 1246.8379110715548, 1306.3533550892369, 1349.7570437321376, 1356.3557310277736, 1374.2098293481288, 31594.0, 33041.0, 33053.17367065843, 33155.50266746049, 33344.66655333416, 51958.0, 51985.48014519957, 52284.738576306874, 52383.47616523786, 52416.47583524116, 449619.0, 450893.0, 452618.0, 454522.0, 455505.0, 28406.57390139191, 28678.0, 29231.561526577545, 29336.706632933397, 29715.10854674363, 49653.0, 50454.49545504498, 50832.0, 51092.23361649652, 51342.74328628333, 42689.786551067045, 43008.0, 43195.136097278504, 43209.78395108004, 43270.0, 41961.37057944072, 41998.58001419947, 42270.154596907276, 42376.0, 42698.359524607775, 40480.0, 41806.79096604497, 42210.36684449674, 42732.0, 42757.35863962105, 36000.27999440049, 37692.0, 37752.24495510019, 38076.42885356777, 38076.80961595285, 28404.0, 28555.571666424607, 28702.42595148127, 28745.28136796513, 28970.116942398676], "value": 18901.852270945663, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.676425038717, 381.43166681644357, 389.9785511796851, 402.38033428520083, 406.7742402966354, 17538.82461175388, 19598.510037249074, 20501.282455114073, 20592.382228533148, 20719.482012949684, 18291.0, 18803.247870085215, 18893.811061889377, 18937.810621893812, 19118.0, 5668.716564171786, 5678.744456499447, 5820.38885916979, 5866.208061911651, 5872.61827981182, 5654.830355089333, 5659.320881494226, 5682.51698605619, 5721.942780572203, 5726.513246374063, 5440.401555828856, 5596.048671725816, 5637.943620563803, 5641.661500309974, 5784.045632470637, 5694.772209111651, 5715.428457154293, 5725.914111288334, 5731.828045158652, 5750.626209296403, 5030.798768049273, 5059.0, 5106.285120083191, 5119.795208191668, 5126.384833819965, 19898.403047908585, 21509.139634414605, 21528.56942861134, 22577.661335079985, 22814.0, 2208.2271205078255, 2216.1910902520626, 2308.653701944705, 2337.4972692788965, 2389.6057150570136, 10128.797424051478, 10162.9491852541, 10174.186065114773, 11029.889701102966, 12592.748145037049, 1925.4416219296388, 1931.4109196695142, 1973.5855470351244, 2023.2918478532542, 2051.169276443043, 68251.31748682499, 72530.0, 74292.25707742962, 81408.0, 82742.0, 10112.494375281207, 10735.0, 10871.728206794734, 10928.781424371467, 10987.725306867393, 14548.781768273484, 14642.414303427744, 14645.780313295309, 14668.486602968846, 14689.531046895225, 8022.839543209103, 8172.305354044854, 8245.8350832983, 8271.95864020676, 8282.958585207036, 7816.140224575292, 7905.841883162305, 7920.762377128695, 8024.558649274346, 8069.596520173968, 4518.096380723802, 4586.4496260448295, 4664.090502352009, 4706.1999460091865, 4717.646176536773, 1885.1833565240668, 1938.1472152253245, 1949.7952714965008, 1969.5371587676884, 1981.9702704459444, 940.3840484482674, 973.3332667123043, 978.4814048554277, 981.5533932060895, 1029.0172884894907, 19303.51741206481, 19555.706664400044, 19630.0, 19882.50293742639, 20162.0, 960.7982323711959, 965.0650445856014, 1012.7670635753818, 1045.1847558904067, 1074.5164675895878, 10560.735981600368, 10723.678289651323, 11285.661430157108, 11297.096232301561, 11860.88139118615, 465281.0, 468518.0, 469913.0, 471532.0, 477221.0, 53388.46611533913, 68245.65877170682, 82164.0, 86002.56998714966, 90074.54962725275, 1017.6031347774374, 1024.6311327921942, 1028.5063169678447, 1047.4186826311318, 1050.3540322701635, 17399.826001740326, 18017.639647207245, 18018.90990545039, 18136.727949080512, 18336.816631834045, 37602.435963460026, 37663.246735065695, 39455.2108957825, 42059.7897010513, 42878.35682464828, 48583.75708121437, 57469.71265143647, 58229.708851457166, 58271.417285826596, 58575.0, 8626.698065567674, 8657.22085012352, 8702.0, 8753.0, 8783.165599268059, 9749.22006239485, 13948.232847193502, 14069.718605627626, 14090.36593353281, 14097.929510352382, 11805.881941180478, 11879.524819007489, 12049.216800907912, 12155.027597792332, 12233.571824986082, 11885.881141188478, 11908.285502869856, 12310.138290319592, 12335.198212116184, 12494.0, 11569.710757231136, 12393.070519710878, 12410.81383779226, 12734.936325318315, 12824.358782061046, 7388.187299396955, 7770.0, 7788.92211077882, 8684.956575217337, 8696.739097827076, 8925.553722313729, 10884.1978347192, 12061.75876482483, 12397.380130993233, 12643.304618246084], "value": 9122.366390610414, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.783732440134, 1468.1117923656188, 1574.1420925595548, 1706.7857694742556, 1728.0841154188277, 7636.618169091551, 8126.309263712584, 8245.0, 8698.869516957251, 8722.21500064994, 8312.418130730852, 8508.957455212716, 8561.61472733727, 8591.441556298836, 8621.051684314736, 2209.723784526934, 2245.4498647831224, 2260.5704916065893, 2270.2508172303183, 2276.612975794119, 2180.2260197629853, 2198.56028794241, 2205.9889700551475, 2210.9005094770773, 2232.363776323748, 2239.026023679696, 2248.1007596961263, 2249.246502421691, 2256.5035692147703, 2294.552562250362, 2143.2605751015954, 2159.88120653364, 2202.768709285526, 2219.1012639880873, 2221.422430168168, 2234.273860995183, 2234.9217777377876, 2258.9887050564644, 2263.411513006614, 2266.2747920665392, 8579.785505362415, 8587.313014958789, 8710.651573937035, 8727.956360218222, 8728.694495692684, 4903.754812259408, 4976.353074100344, 5024.572911302544, 5032.194848824171, 5079.339685840817, 3004.248937765559, 3179.5230715392877, 3286.901392958215, 3331.1006028372444, 3369.2924485858, 1031.5461197073264, 1048.3866937841372, 1053.2469284461647, 1057.4289883462998, 1058.2433560004556, 11807.23252988553, 11808.527658893634, 11865.881341186563, 11884.346360950145, 11991.400429978466, 4390.7585082820115, 4411.426514553087, 4544.18204723153, 4554.0891821635805, 4560.247559152769, 10176.084152426318, 10201.897981020244, 10211.183105351554, 10224.233182511192, 10257.794844103077, 5031.572316353151, 5043.798248070109, 5086.389633243961, 5099.745012749348, 5115.258287548285, 4622.815087396534, 4668.183067963093, 4717.457492388419, 4738.336632871401, 4779.235322348477, 3491.633378495272, 3493.0568746438826, 3509.701675357572, 3596.8561257549927, 3611.3499570077115, 1071.839224116373, 1079.4872435593031, 1082.8375743638517, 1084.6203828659907, 1086.299336927693, 853.7822855171892, 978.3836183204536, 981.8625392445064, 988.2439933450916, 1001.6494227020485, 5693.861227754465, 5849.210356601804, 5926.940730592725, 5982.760689572368, 6018.21763170785, 442.2261043174445, 446.5133005024474, 450.47069693110467, 461.9445666520039, 464.8373069425674, 4086.9182616348103, 4096.221717873595, 4133.855315063958, 4143.399207114951, 4156.501219853637, 10603.787924241473, 10787.244892857425, 10804.837927431096, 10981.670549883516, 11062.39156846365, 10685.198610104273, 10769.784604308026, 10795.352278863136, 10823.67528974132, 10833.187510936712, 7621.466497345133, 7992.600369981594, 7998.280154786097, 8113.837723245502, 8146.796330091676, 5889.440503152194, 5935.0, 5971.402859713994, 6045.063015232646, 6054.182685337423, 9525.809483810146, 10009.799804003733, 10047.447390393598, 10204.591816327264, 10219.284650074424, 9141.085891410805, 9737.464439455898, 9861.915189329025, 10359.741006474596, 10396.428196448966, 7312.963435183003, 7649.770506884803, 7666.386689064973, 7677.9616101921365, 7685.193054729397, 8023.4784738991775, 8320.791980200544, 8332.625031873458, 8496.32029437656, 8512.0, 7470.439717021354, 7601.733939312318, 7737.419693522896, 7821.804454888674, 7850.528968261922, 7246.855062898818, 7364.484486086137, 7375.078115235596, 7418.1839997599145, 7647.847043058996, 6637.4690024798865, 6675.299093595297, 6710.496712746466, 6732.293109223461, 6737.764178253738, 4855.441624213261, 4898.681585696918, 4960.727160006234, 4972.577330926912, 5031.874203144805, 4847.781849816837, 4921.360223170965, 4931.211006238985, 4949.183384741477, 5022.121128802518], "value": 4408.821841190986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.5592310572962, 320.90052083854005, 326.59012938761856, 331.3770112189084, 331.66004845033854, 5591.468810463005, 5591.916121258179, 5633.887322253552, 5653.265075540174, 5657.57568182387, 5548.112302031675, 5552.222688823558, 5566.888662226753, 5567.693776842272, 5576.525995290405, 4087.3664581989765, 4206.242876282268, 4306.7631280279575, 4313.784310784464, 4323.978380108095, 4243.618074373306, 4289.806958686867, 4317.201317756209, 4319.460067491564, 4325.113351762881, 4252.425922500469, 4300.397944287803, 4301.096769678371, 4303.376010478479, 4308.74147551148, 4051.7974101294817, 4222.197782421361, 4222.662187025061, 4229.238737027334, 4304.978475107636, 3644.4511082789973, 3655.5430571178604, 3662.5421822272215, 3668.853245870162, 3680.8527658893613, 5473.863153421156, 5480.232767412565, 5493.945060549383, 5499.560035197214, 5500.779968801243, 4671.789769460383, 4815.205491093965, 4907.386576677915, 4918.2376731606655, 4956.306117143603, 5792.82621521355, 5871.471567558898, 5891.440313170242, 5891.79378721747, 5910.581460449504, 4085.5301640311445, 4095.85664501744, 4097.364908439196, 4116.855910043164, 4118.320477121271, 5848.654809393821, 6017.849553761147, 6029.457348838626, 6036.849078773066, 6051.546134039964, 4115.9176816463505, 4151.356539736345, 4157.875263742093, 4175.164967006611, 4180.686448516373, 4185.686073544496, 4218.974892051832, 4224.366345048206, 4239.236937351307, 4246.44796176495, 4731.858044258678, 4885.1450996076255, 4927.5811556017425, 4928.422904670471, 4928.457869634337, 5835.066389377764, 5870.823875283749, 5902.763889444374, 5936.940630593639, 5941.999290358342, 1454.163855782929, 1457.7813328000884, 1461.4738694070127, 1462.9853701463062, 1472.3227315434806, 915.1397686174975, 924.3945215883473, 933.9766505837408, 941.7457286532598, 989.9259303655614, 5598.86002849932, 5600.215969764236, 5609.158626206102, 5620.156976453564, 5627.774889004394, 5861.6189947653265, 5932.40675932412, 5942.821715348547, 5944.286685597669, 5949.6430214187285, 5265.052290587654, 5479.808206712746, 5542.528885044816, 5549.667019978814, 5556.444355564411, 3147.118806734118, 3166.0660105269003, 3181.411438883814, 3181.872725091017, 3182.411253918033, 5888.9705551472825, 6084.056971169476, 6092.45167934888, 6138.14066030756, 6154.969225153845, 6014.51883849291, 6099.78004399122, 6102.0, 6124.203853499017, 6131.172291740647, 5950.821475355746, 5954.642721436641, 6103.23709536308, 6125.908111378333, 6131.14164017038, 5649.22049554389, 5881.9705901470215, 5923.437273459014, 5928.170056192051, 5944.970275148597, 5795.884082318415, 5828.213191219301, 5829.650220986754, 5834.299884013945, 5875.706214689163, 5883.764169615519, 6041.818745437644, 6065.8180254592435, 6144.969275153596, 6164.229471316085, 4119.567445418188, 4176.227397931392, 4188.979055104827, 4199.727017743837, 4205.789710514401, 5926.644401335933, 5933.703314834327, 6008.759649613967, 6021.157038014769, 6022.488088512526, 5568.136938774496, 5693.9430605693415, 5754.395788442321, 5786.1899334094105, 5837.153612726216, 5748.597598168088, 5786.537077033911, 5827.329857066492, 5828.6502809831545, 5836.562257830595, 5538.695371754592, 5588.776448941997, 5649.548036157015, 5679.636887146972, 5761.798337058183, 5854.5609079320075, 5872.383399742966, 5875.50058245054, 5934.258217722785, 5954.261039921511, 5539.501444869981, 5697.287839020122, 5708.372079071381, 5727.4845263926445, 5733.340665823317], "value": 4394.477751695027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.5259576084027, 741.0292516802989, 746.7237122264763, 751.2149803455388, 782.9217078292171, 14961.92519037406, 15033.398664053439, 15086.47197348093, 15122.319495622696, 15146.77279840802, 14808.185549794784, 15167.6966460671, 15185.848141518582, 15196.620084497865, 15239.238038098107, 664.5215444879703, 783.5690370296343, 784.2510402565537, 800.383704547498, 808.9352851771873, 804.0953926832314, 808.2725547007682, 808.49873078691, 809.7125520440247, 810.1898101898101, 843.3042739739709, 845.0324378586546, 846.2975730143966, 847.8812966184739, 848.3637272045966, 840.5503055865113, 841.8232171244047, 841.9158084191594, 842.0358689300778, 842.5029232752644, 617.4381313005143, 617.6726335042434, 617.9258488981307, 620.1937481274325, 621.1800423441059, 15090.773638395432, 15114.54656360311, 15322.846771532253, 15357.232138393147, 15361.078335299917, 14510.201938893357, 14636.70726585473, 14701.338439770128, 14861.0, 14930.402783888632, 11907.702307442296, 12007.159498835084, 12114.0914431418, 12246.877531224663, 12316.199447035913, 3940.9701462792264, 3992.7604343739176, 4101.118259574206, 4202.642775364097, 4203.810828512694, 70353.2964670357, 73609.6319518399, 74290.0, 74311.0, 74699.6265018677, 11586.88413115875, 11968.755459060063, 12160.331181785086, 12181.756364872654, 12190.878091218974, 20197.293094741613, 22378.440538986655, 22426.21508247236, 22448.551028979327, 22541.54916901653, 8739.956300218459, 8745.212930836255, 8763.824723505622, 9225.356312242835, 9478.146966772885, 4903.264510323409, 4941.950580494221, 4956.653034287565, 5120.667156634881, 5149.76826042829, 3581.659742324475, 3683.686886614614, 3684.318401095752, 3687.4468829675225, 3692.132348898007, 647.2459584584001, 658.3844105761033, 662.2748090840522, 675.6081472745894, 679.1680191765048, 710.5398406275051, 745.2063552316765, 758.2531206761336, 758.6093162021564, 766.7431410477441, 9490.335676502717, 9666.75833104178, 9750.219982401391, 9881.950590247003, 10030.097291243823, 753.886916962449, 764.6673696941848, 778.1790211327104, 781.4217479065564, 796.9242921922408, 4524.977375113103, 4861.513848615181, 4870.902581948341, 4922.876928076755, 4929.556339929351, 66362.66818665972, 67247.66376168186, 112256.0, 116503.41748291205, 117048.0, 88916.5554172225, 95931.52034239784, 96184.0, 96772.51613741886, 97602.5119874396, 82018.17981820105, 87599.0, 88802.11197888068, 88805.0, 90139.0, 10224.386536807815, 10577.152871823566, 11004.559817607205, 11016.669499915015, 11038.558457661604, 36120.638793611724, 48080.27879581879, 49785.75107124441, 51137.23294150665, 51703.48296516987, 69956.60086798338, 74497.62751186427, 75924.24075759393, 76250.0, 76806.0, 13357.065005449525, 13368.866311337151, 13531.25578093175, 13627.250501222528, 13636.250006249355, 14459.927700361852, 14750.483733069721, 14825.258737062888, 15178.772318415453, 15348.76976845326, 13935.512257070954, 14496.565103046925, 14690.63273418173, 14718.999112051197, 15379.0, 13868.583942481742, 13909.095908765898, 14266.500672476413, 14544.563663090124, 14548.0, 13214.0, 13222.537211197561, 13292.335383230993, 13463.259520726455, 13695.383707732977, 11408.855435463265, 11465.770684586429, 11830.592228406274, 12053.63839084829, 12144.332061736335, 11098.66703998849, 12261.26432414058, 12314.630561083182, 12448.62654120378, 12691.111622186358], "value": 7679.113707837876, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 111.0, 109.0, 113.0, 110.0, 110.0, 109.0, 111.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 161.0, 178.0, 130.0, 150.0, 164.0, 127.0, 182.0, 130.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 163.0, 163.0, 169.0, 160.0, 162.0, 163.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 160.0, 78.0, 74.0, 75.0, 73.0, 155.0, 76.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 155.0, 86.0, 87.0, 85.0, 152.0, 84.0, 85.0, 149.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 119.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 147.0, 149.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 57.0, 55.0, 55.0, 54.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 63.0, 63.0, 61.0, 61.0, 61.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 81.0, 80.0, 84.0, 82.0, 82.0, 95.0, 110.0, 87.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 142.0, 122.0, 127.0, 123.0, 138.0, 132.0, 132.0, 123.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 163.0, 166.0, 170.0, 176.0, 166.0, 162.0, 163.0, 161.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 63.0, 63.0, 62.0, 67.0], "value": 64.2, "unit": "score"}]}]} 02:26:12 INFO - Return code: 0 02:26:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:26:12 ERROR - # TBPL SUCCESS # 02:26:12 INFO - Running post-action listener: _resource_record_post_action 02:26:12 INFO - ##### 02:26:12 INFO - ##### Finished run-tests step (success) 02:26:12 INFO - ##### 02:26:12 INFO - Running post-run listener: _resource_record_post_run 02:26:12 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401440768; Read time: 16; Write time: 305340 02:26:12 INFO - TinderboxPrint: CPU usage
13.4% 02:26:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:26:12 INFO - TinderboxPrint: I/O write bytes / time
401,440,768 / 305,340 02:26:12 INFO - TinderboxPrint: CPU idle
8,229.8 (86.5%) 02:26:12 INFO - TinderboxPrint: CPU user
1,222.8 (12.9%) 02:26:12 INFO - TinderboxPrint: Swap in / out
0 / 0 02:26:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111947776; Read time: 0; Write time: 82696 02:26:12 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289492992; Read time: 16; Write time: 222644 02:26:12 INFO - Running post-run listener: _upload_blobber_files 02:26:12 INFO - Blob upload gear active. 02:26:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:26:12 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:26:12 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:26:12 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:26:13 INFO - (blobuploader) - INFO - Open directory for files ... 02:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:26:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:16 INFO - (blobuploader) - INFO - Done attempting. 02:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:17 INFO - (blobuploader) - INFO - Done attempting. 02:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:26:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:18 INFO - (blobuploader) - INFO - Done attempting. 02:26:18 INFO - (blobuploader) - INFO - Iteration through files over. 02:26:18 INFO - Return code: 0 02:26:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:26:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:26:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3518eda0393dad5960b64c6d86a12afbe2353acdb0e8d8460e6fb761c40ba038ed99548127dccdaf410984755a026568a4422ac88511ecdd8103fc80d8370bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd8c8e349da3f8795868e5821f2bf1bb627530d075d8f6febf28f240b37908f00077ff7222f49202b33675d3276afb420ca920fc34356184f316ae3f799e3b12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb06c76a3e7b237dea287f1142ec4e415f335b99875806047b284b08860fd0b2b00d295f6a931b4f7612ae98cc0e83d1018a2c25ae4e0f042a786be033e841b3"} 02:26:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:26:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:26:18 INFO - Contents: 02:26:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3518eda0393dad5960b64c6d86a12afbe2353acdb0e8d8460e6fb761c40ba038ed99548127dccdaf410984755a026568a4422ac88511ecdd8103fc80d8370bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd8c8e349da3f8795868e5821f2bf1bb627530d075d8f6febf28f240b37908f00077ff7222f49202b33675d3276afb420ca920fc34356184f316ae3f799e3b12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb06c76a3e7b237dea287f1142ec4e415f335b99875806047b284b08860fd0b2b00d295f6a931b4f7612ae98cc0e83d1018a2c25ae4e0f042a786be033e841b3"} 02:26:18 INFO - Running post-run listener: copy_logs_to_upload_dir 02:26:18 INFO - Copying logs to upload dir... 02:26:18 INFO - mkdir: /builds/slave/test/build/upload/logs 02:26:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.924672 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-22 02:26:17.854039) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 02:26:17.857663) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3518eda0393dad5960b64c6d86a12afbe2353acdb0e8d8460e6fb761c40ba038ed99548127dccdaf410984755a026568a4422ac88511ecdd8103fc80d8370bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd8c8e349da3f8795868e5821f2bf1bb627530d075d8f6febf28f240b37908f00077ff7222f49202b33675d3276afb420ca920fc34356184f316ae3f799e3b12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb06c76a3e7b237dea287f1142ec4e415f335b99875806047b284b08860fd0b2b00d295f6a931b4f7612ae98cc0e83d1018a2c25ae4e0f042a786be033e841b3"} build_url:https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/OPAbWs0OQoGpFDBjvLMWrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3518eda0393dad5960b64c6d86a12afbe2353acdb0e8d8460e6fb761c40ba038ed99548127dccdaf410984755a026568a4422ac88511ecdd8103fc80d8370bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd8c8e349da3f8795868e5821f2bf1bb627530d075d8f6febf28f240b37908f00077ff7222f49202b33675d3276afb420ca920fc34356184f316ae3f799e3b12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb06c76a3e7b237dea287f1142ec4e415f335b99875806047b284b08860fd0b2b00d295f6a931b4f7612ae98cc0e83d1018a2c25ae4e0f042a786be033e841b3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 02:26:17.883899) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:26:17.884367) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466586286.661079-1855567111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:26:17.969801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 02:26:17.970196) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 02:26:17.970549) ========= ========= Total master_lag: 0.18 =========