builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1466489674.93 results: success (0) buildid: 20160620203028 builduid: 225ecab999204cee827564fb449f0f2b revision: 027db1e33f89606c4996feae0203e5f3bb5db43d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:34.925631) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:34.926207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:34.926500) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:34.948512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:34.948861) ========= 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=0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 23:14:35-- 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% 102M=0s 2016-06-20 23:14:36 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.251461 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:35.214247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:35.214557) ========= 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=0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015404 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:35.263892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:35.264223) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 027db1e33f89606c4996feae0203e5f3bb5db43d --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 027db1e33f89606c4996feae0203e5f3bb5db43d --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=0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 23:14:36,159 truncating revision to first 12 chars 2016-06-20 23:14:36,159 Setting DEBUG logging. 2016-06-20 23:14:36,159 attempt 1/10 2016-06-20 23:14:36,159 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/027db1e33f89?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 23:14:36,671 unpacking tar archive at: fx-team-027db1e33f89/testing/mozharness/ program finished with exit code 0 elapsedTime=0.865908 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:36.143585) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:36.143905) ========= script_repo_revision: 027db1e33f89606c4996feae0203e5f3bb5db43d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:36.144310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:36.144591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 23:14:36.158850) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-20 23:14:36.159135) ========= /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=0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:14:37 INFO - MultiFileLogger online at 20160620 23:14:37 in /builds/slave/test 23:14:37 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 23:14:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:14:37 INFO - {'append_to_log': False, 23:14:37 INFO - 'base_work_dir': '/builds/slave/test', 23:14:37 INFO - 'blob_upload_branch': 'Fx-Team', 23:14:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:14:37 INFO - 'branch': 'Fx-Team', 23:14:37 INFO - 'buildbot_json_path': 'buildprops.json', 23:14:37 INFO - 'config_files': ('talos/linux_config.py',), 23:14:37 INFO - 'default_actions': ('clobber', 23:14:37 INFO - 'read-buildbot-config', 23:14:37 INFO - 'download-and-extract', 23:14:37 INFO - 'populate-webroot', 23:14:37 INFO - 'create-virtualenv', 23:14:37 INFO - 'install', 23:14:37 INFO - 'run-tests'), 23:14:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:14:37 INFO - 'download_minidump_stackwalk': True, 23:14:37 INFO - 'download_symbols': 'ondemand', 23:14:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:14:37 INFO - 'tooltool.py': '/tools/tooltool.py', 23:14:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:14:37 INFO - '/tools/misc-python/virtualenv.py')}, 23:14:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:14:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:14:37 INFO - 'installer_path': 'installer.exe', 23:14:37 INFO - 'log_level': 'info', 23:14:37 INFO - 'log_name': 'talos', 23:14:37 INFO - 'log_to_console': True, 23:14:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:14:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:14:37 INFO - 'opt_config_files': (), 23:14:37 INFO - 'pip_index': False, 23:14:37 INFO - 'sps_profile': False, 23:14:37 INFO - 'sps_profile_interval': 0, 23:14:37 INFO - 'suite': 'dromaeojs-e10s', 23:14:37 INFO - 'system_bits': '32', 23:14:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:14:37 INFO - 'title': 'talos-linux64-ix-058', 23:14:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:14:37 INFO - 'use_talos_json': True, 23:14:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:14:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:14:37 INFO - 'work_dir': 'build'} 23:14:37 INFO - ##### 23:14:37 INFO - ##### Running clobber step. 23:14:37 INFO - ##### 23:14:37 INFO - Running pre-action listener: _resource_record_pre_action 23:14:37 INFO - Running main action method: clobber 23:14:37 INFO - rmtree: /builds/slave/test/build 23:14:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:14:38 INFO - Running post-action listener: _resource_record_post_action 23:14:38 INFO - ##### 23:14:38 INFO - ##### Finished clobber step (success) 23:14:38 INFO - ##### 23:14:38 INFO - ##### 23:14:38 INFO - ##### Running read-buildbot-config step. 23:14:38 INFO - ##### 23:14:38 INFO - Running pre-action listener: _resource_record_pre_action 23:14:38 INFO - Running main action method: read_buildbot_config 23:14:38 INFO - Using buildbot properties: 23:14:38 INFO - { 23:14:38 INFO - "project": "", 23:14:38 INFO - "product": "firefox", 23:14:38 INFO - "script_repo_revision": "production", 23:14:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:14:38 INFO - "repository": "", 23:14:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:14:38 INFO - "buildid": "20160620203028", 23:14:38 INFO - "pgo_build": "True", 23:14:38 INFO - "basedir": "/builds/slave/test", 23:14:38 INFO - "buildnumber": 846, 23:14:38 INFO - "slavename": "talos-linux64-ix-058", 23:14:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:14:38 INFO - "platform": "ubuntu64_hw", 23:14:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:14:38 INFO - "branch": "fx-team", 23:14:38 INFO - "repo_path": "integration/fx-team", 23:14:38 INFO - "revision": "027db1e33f89606c4996feae0203e5f3bb5db43d", 23:14:38 INFO - "stage_platform": "linux64-pgo", 23:14:38 INFO - "builduid": "225ecab999204cee827564fb449f0f2b", 23:14:38 INFO - "slavebuilddir": "test" 23:14:38 INFO - } 23:14:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:14:38 INFO - Running post-action listener: _resource_record_post_action 23:14:38 INFO - ##### 23:14:38 INFO - ##### Finished read-buildbot-config step (success) 23:14:38 INFO - ##### 23:14:38 INFO - ##### 23:14:38 INFO - ##### Running download-and-extract step. 23:14:38 INFO - ##### 23:14:38 INFO - Running pre-action listener: _resource_record_pre_action 23:14:38 INFO - Running main action method: download_and_extract 23:14:38 INFO - mkdir: /builds/slave/test/build/tests 23:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:38 INFO - https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:14:40 INFO - Downloaded 1361 bytes. 23:14:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:14:40 INFO - Using the following test package requirements: 23:14:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:14:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:14:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:14:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:40 INFO - u'jsshell-linux-x86_64.zip'], 23:14:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:14:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:14:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:14:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:14:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:14:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:14:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:14: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')]} 23:14:40 INFO - https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:14:42 INFO - Downloaded 24221315 bytes. 23:14: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'] 23:14: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 23:14:43 INFO - Return code: 0 23:14: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 23:14: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')]} 23:14:43 INFO - https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:14:45 INFO - Downloaded 24221315 bytes. 23:14: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'] 23:14: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 23:14:46 INFO - Return code: 0 23:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:46 INFO - https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:14:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:14:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:14:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:14:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:14:47 INFO - Downloaded 14405384 bytes. 23:14:47 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'] 23:14:47 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 23:14:48 INFO - Return code: 0 23:14: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')]} 23:14:48 INFO - https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:14:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:14:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:14:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:14:49 INFO - Downloaded 60125066 bytes. 23:14:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:14:49 INFO - mkdir: /builds/slave/test/properties 23:14:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:14:49 INFO - Writing to file /builds/slave/test/properties/build_url 23:14:49 INFO - Contents: 23:14:49 INFO - build_url:https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:14:50 INFO - Running post-action listener: _resource_record_post_action 23:14:50 INFO - Running post-action listener: set_extra_try_arguments 23:14:50 INFO - ##### 23:14:50 INFO - ##### Finished download-and-extract step (success) 23:14:50 INFO - ##### 23:14:50 INFO - ##### 23:14:50 INFO - ##### Running populate-webroot step. 23:14:50 INFO - ##### 23:14:50 INFO - Running pre-action listener: _resource_record_pre_action 23:14:50 INFO - Running main action method: populate_webroot 23:14:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:14:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:14:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:14:50 INFO - '--tppagecycles', 23:14:50 INFO - '7'], 23:14:50 INFO - 'tests': ['tsvgm']}}, 23:14:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:14:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:14:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:14:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:14:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:14:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:14:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:50 INFO - 'talos_options': ['--disable-e10s'], 23:14:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:14:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:14:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:50 INFO - 'talos_options': ['--disable-e10s'], 23:14:50 INFO - 'tests': ['damp', 'tps']}, 23:14:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:50 INFO - 'tests': ['damp', 'tps']}, 23:14:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:14:50 INFO - 'tests': ['dromaeo_dom']}, 23:14:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:14:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:14:50 INFO - 'tests': ['basic_compositor_video']}, 23:14:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:14:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:14:50 INFO - 'tests': ['a11yr', 23:14:50 INFO - 'ts_paint', 23:14:50 INFO - 'tpaint', 23:14:50 INFO - 'sessionrestore', 23:14:50 INFO - 'sessionrestore_no_auto_restore', 23:14:50 INFO - 'tabpaint']}, 23:14:50 INFO - 'other-e10s': {'tests': ['a11yr', 23:14:50 INFO - 'ts_paint', 23:14:50 INFO - 'tpaint', 23:14:50 INFO - 'sessionrestore', 23:14:50 INFO - 'sessionrestore_no_auto_restore', 23:14:50 INFO - 'tabpaint']}, 23:14:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:14:50 INFO - 'ts_paint', 23:14:50 INFO - 'tpaint', 23:14:50 INFO - 'sessionrestore', 23:14:50 INFO - 'sessionrestore_no_auto_restore', 23:14:50 INFO - 'tabpaint']}, 23:14:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:14:50 INFO - 'ts_paint', 23:14:50 INFO - 'tpaint', 23:14:50 INFO - 'sessionrestore', 23:14:50 INFO - 'sessionrestore_no_auto_restore', 23:14:50 INFO - 'tabpaint']}, 23:14:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:14:50 INFO - 'tests': ['a11yr', 23:14:50 INFO - 'ts_paint', 23:14:50 INFO - 'tpaint', 23:14:50 INFO - 'sessionrestore', 23:14:50 INFO - 'sessionrestore_no_auto_restore', 23:14:50 INFO - 'tabpaint']}, 23:14:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:14:50 INFO - 'tests': ['a11yr', 23:14:50 INFO - 'ts_paint', 23:14:50 INFO - 'tpaint', 23:14:50 INFO - 'sessionrestore', 23:14:50 INFO - 'sessionrestore_no_auto_restore', 23:14:50 INFO - 'tabpaint']}, 23:14:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:14:50 INFO - 'tests': ['tsvgx', 23:14:50 INFO - 'tsvgr_opacity', 23:14:50 INFO - 'tart', 23:14:50 INFO - 'tscrollx', 23:14:50 INFO - 'cart']}, 23:14:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:14:50 INFO - 'tsvgr_opacity', 23:14:50 INFO - 'tart', 23:14:50 INFO - 'tscrollx', 23:14:50 INFO - 'cart']}, 23:14:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:50 INFO - 'talos_options': ['--disable-e10s'], 23:14:50 INFO - 'tests': ['tp5o']}, 23:14:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:50 INFO - 'tests': ['tp5o']}, 23:14:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:50 INFO - 'talos_options': ['--disable-e10s', 23:14:50 INFO - '--xperf_path', 23:14:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:14:50 INFO - 'tests': ['tp5n']}, 23:14:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:50 INFO - 'talos_options': ['--xperf_path', 23:14:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:14:50 INFO - 'tests': ['tp5n']}}, 23:14:50 INFO - 'talos.zip': {'path': '', 23:14:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:14:50 INFO - Running post-action listener: _resource_record_post_action 23:14:50 INFO - ##### 23:14:50 INFO - ##### Finished populate-webroot step (success) 23:14:50 INFO - ##### 23:14:50 INFO - ##### 23:14:50 INFO - ##### Running create-virtualenv step. 23:14:50 INFO - ##### 23:14:50 INFO - Running pre-action listener: _resource_record_pre_action 23:14:50 INFO - Running main action method: create_virtualenv 23:14:50 INFO - Creating virtualenv /builds/slave/test/build/venv 23:14:50 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 23:14:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:14:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:14:50 INFO - Using real prefix '/usr' 23:14:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:14:51 INFO - Installing distribute.............................................................................................................................................................................................done. 23:14:53 INFO - Installing pip.................done. 23:14:53 INFO - Return code: 0 23:14:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:53 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 0x7f541d9a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21c0>, '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 0x1eb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3550>, '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': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', '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 23:14:53 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 23:14:53 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 23:14:53 INFO - Using env: {'DISPLAY': ':0', 23:14:53 INFO - 'HOME': '/home/cltbld', 23:14:53 INFO - 'LANG': 'en_US.UTF-8', 23:14:53 INFO - 'LANGUAGE': 'en_US:en', 23:14:53 INFO - 'LOGNAME': 'cltbld', 23:14:53 INFO - 'MAIL': '/var/mail/cltbld', 23:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:53 INFO - 'MOZ_NO_REMOTE': '1', 23:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:53 INFO - 'NO_EM_RESTART': '1', 23:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:14:53 INFO - 'PWD': '/builds/slave/test', 23:14:53 INFO - 'SHELL': '/bin/bash', 23:14:53 INFO - 'SHLVL': '1', 23:14:53 INFO - 'TERM': 'linux', 23:14:53 INFO - 'TMOUT': '86400', 23:14:53 INFO - 'USER': 'cltbld', 23:14:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', 23:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:53 INFO - '_': '/tools/buildbot/bin/python'} 23:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:53 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 23:14:53 INFO - Cleaning up... 23:14:53 INFO - Return code: 0 23:14:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:53 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 0x7f541d9a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21c0>, '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 0x1eb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3550>, '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': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', '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 23:14:53 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 23:14:53 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 23:14:53 INFO - Using env: {'DISPLAY': ':0', 23:14:53 INFO - 'HOME': '/home/cltbld', 23:14:53 INFO - 'LANG': 'en_US.UTF-8', 23:14:53 INFO - 'LANGUAGE': 'en_US:en', 23:14:53 INFO - 'LOGNAME': 'cltbld', 23:14:53 INFO - 'MAIL': '/var/mail/cltbld', 23:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:53 INFO - 'MOZ_NO_REMOTE': '1', 23:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:53 INFO - 'NO_EM_RESTART': '1', 23:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:14:53 INFO - 'PWD': '/builds/slave/test', 23:14:53 INFO - 'SHELL': '/bin/bash', 23:14:53 INFO - 'SHLVL': '1', 23:14:53 INFO - 'TERM': 'linux', 23:14:53 INFO - 'TMOUT': '86400', 23:14:53 INFO - 'USER': 'cltbld', 23:14:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', 23:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:53 INFO - '_': '/tools/buildbot/bin/python'} 23:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:53 INFO - Downloading/unpacking psutil>=3.1.1 23:14:53 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 23:14:53 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 23:14:53 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 23:14:53 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 23:14:53 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 23:14:53 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 23:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:14:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:14:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:14:55 INFO - Installing collected packages: psutil 23:14:55 INFO - Running setup.py install for psutil 23:14:55 INFO - building 'psutil._psutil_linux' extension 23:14:55 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 23:14:55 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 23:14:55 INFO - building 'psutil._psutil_posix' extension 23:14:55 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 23:14:56 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 23:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:14:56 INFO - Successfully installed psutil 23:14:56 INFO - Cleaning up... 23:14:56 INFO - Return code: 0 23:14:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:14:56 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')]} 23:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:56 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')]} 23:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:56 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 0x7f541d9a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21c0>, '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 0x1eb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3550>, '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': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', '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 23:14:56 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 23:14:56 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 23:14:56 INFO - Using env: {'DISPLAY': ':0', 23:14:56 INFO - 'HOME': '/home/cltbld', 23:14:56 INFO - 'LANG': 'en_US.UTF-8', 23:14:56 INFO - 'LANGUAGE': 'en_US:en', 23:14:56 INFO - 'LOGNAME': 'cltbld', 23:14:56 INFO - 'MAIL': '/var/mail/cltbld', 23:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:56 INFO - 'MOZ_NO_REMOTE': '1', 23:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:56 INFO - 'NO_EM_RESTART': '1', 23:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:14:56 INFO - 'PWD': '/builds/slave/test', 23:14:56 INFO - 'SHELL': '/bin/bash', 23:14:56 INFO - 'SHLVL': '1', 23:14:56 INFO - 'TERM': 'linux', 23:14:56 INFO - 'TMOUT': '86400', 23:14:56 INFO - 'USER': 'cltbld', 23:14:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', 23:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:56 INFO - '_': '/tools/buildbot/bin/python'} 23:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:14:56 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 23:14:56 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 23:14:56 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 23:14:56 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 23:14:56 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 23:14:56 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 23:14:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:14:58 INFO - Installing collected packages: mozsystemmonitor 23:14:58 INFO - Running setup.py install for mozsystemmonitor 23:14:58 INFO - Successfully installed mozsystemmonitor 23:14:58 INFO - Cleaning up... 23:14:58 INFO - Return code: 0 23:14:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f541d9a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21c0>, '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 0x1eb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3550>, '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': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', '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 23:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:14:58 INFO - Using env: {'DISPLAY': ':0', 23:14:58 INFO - 'HOME': '/home/cltbld', 23:14:58 INFO - 'LANG': 'en_US.UTF-8', 23:14:58 INFO - 'LANGUAGE': 'en_US:en', 23:14:58 INFO - 'LOGNAME': 'cltbld', 23:14:58 INFO - 'MAIL': '/var/mail/cltbld', 23:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:58 INFO - 'MOZ_NO_REMOTE': '1', 23:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:58 INFO - 'NO_EM_RESTART': '1', 23:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:14:58 INFO - 'PWD': '/builds/slave/test', 23:14:58 INFO - 'SHELL': '/bin/bash', 23:14:58 INFO - 'SHLVL': '1', 23:14:58 INFO - 'TERM': 'linux', 23:14:58 INFO - 'TMOUT': '86400', 23:14:58 INFO - 'USER': 'cltbld', 23:14:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', 23:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:58 INFO - '_': '/tools/buildbot/bin/python'} 23:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:58 INFO - Downloading/unpacking jsonschema==2.5.1 23:14:58 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 23:14:58 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 23:14:58 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 23:14:58 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 23:14:58 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 23:14:58 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 23:15:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:15:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:15: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 23:15: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 23:15: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 23:15: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 23:15: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 23:15: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 23:15:00 INFO - Downloading functools32-3.2.3-2.tar.gz 23:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:15:00 INFO - warning: no files found matching '*.txt' 23:15:00 INFO - no previously-included directories found matching 'build' 23:15:00 INFO - no previously-included directories found matching 'dist' 23:15:00 INFO - no previously-included directories found matching '.git*' 23:15:00 INFO - Installing collected packages: jsonschema, functools32 23:15:01 INFO - Running setup.py install for functools32 23:15:01 INFO - warning: no files found matching '*.txt' 23:15:01 INFO - no previously-included directories found matching 'build' 23:15:01 INFO - no previously-included directories found matching 'dist' 23:15:01 INFO - no previously-included directories found matching '.git*' 23:15:01 INFO - Successfully installed jsonschema functools32 23:15:01 INFO - Cleaning up... 23:15:01 INFO - Return code: 0 23:15:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f541d9a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21c0>, '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 0x1eb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3550>, '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': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', '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 23:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:15:01 INFO - Using env: {'DISPLAY': ':0', 23:15:01 INFO - 'HOME': '/home/cltbld', 23:15:01 INFO - 'LANG': 'en_US.UTF-8', 23:15:01 INFO - 'LANGUAGE': 'en_US:en', 23:15:01 INFO - 'LOGNAME': 'cltbld', 23:15:01 INFO - 'MAIL': '/var/mail/cltbld', 23:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:01 INFO - 'MOZ_NO_REMOTE': '1', 23:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:01 INFO - 'NO_EM_RESTART': '1', 23:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:01 INFO - 'PWD': '/builds/slave/test', 23:15:01 INFO - 'SHELL': '/bin/bash', 23:15:01 INFO - 'SHLVL': '1', 23:15:01 INFO - 'TERM': 'linux', 23:15:01 INFO - 'TMOUT': '86400', 23:15:01 INFO - 'USER': 'cltbld', 23:15:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', 23:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:01 INFO - '_': '/tools/buildbot/bin/python'} 23:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:01 INFO - Downloading/unpacking blobuploader==1.2.4 23:15:01 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 23:15:01 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 23:15:01 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 23:15:01 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 23:15:01 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 23:15:01 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 23:15:03 INFO - Downloading blobuploader-1.2.4.tar.gz 23:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:15:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:15:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:03 INFO - Downloading docopt-0.6.1.tar.gz 23:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:15:04 INFO - Installing collected packages: blobuploader, requests, docopt 23:15:04 INFO - Running setup.py install for blobuploader 23:15:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:15:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:15:04 INFO - Running setup.py install for requests 23:15:04 INFO - Running setup.py install for docopt 23:15:04 INFO - Successfully installed blobuploader requests docopt 23:15:04 INFO - Cleaning up... 23:15:04 INFO - Return code: 0 23:15:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:04 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 0x7f541d9a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21c0>, '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 0x1eb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3550>, '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': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', '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 23:15:04 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 23:15:04 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 23:15:04 INFO - Using env: {'DISPLAY': ':0', 23:15:04 INFO - 'HOME': '/home/cltbld', 23:15:04 INFO - 'LANG': 'en_US.UTF-8', 23:15:04 INFO - 'LANGUAGE': 'en_US:en', 23:15:04 INFO - 'LOGNAME': 'cltbld', 23:15:04 INFO - 'MAIL': '/var/mail/cltbld', 23:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:04 INFO - 'MOZ_NO_REMOTE': '1', 23:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:04 INFO - 'NO_EM_RESTART': '1', 23:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:04 INFO - 'PWD': '/builds/slave/test', 23:15:04 INFO - 'SHELL': '/bin/bash', 23:15:04 INFO - 'SHLVL': '1', 23:15:04 INFO - 'TERM': 'linux', 23:15:04 INFO - 'TMOUT': '86400', 23:15:04 INFO - 'USER': 'cltbld', 23:15:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', 23:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:04 INFO - '_': '/tools/buildbot/bin/python'} 23:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:15:04 INFO - Running setup.py (path:/tmp/pip-pJ2fsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:15:04 INFO - Running setup.py (path:/tmp/pip-gwz5pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:15:05 INFO - Running setup.py (path:/tmp/pip-ASOq3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:15:05 INFO - Running setup.py (path:/tmp/pip-XwWsOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:15:05 INFO - Running setup.py (path:/tmp/pip-5psDsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:15:05 INFO - Running setup.py (path:/tmp/pip-9PApSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:15:05 INFO - Running setup.py (path:/tmp/pip-_hjzZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:15:05 INFO - Running setup.py (path:/tmp/pip-FC7IY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:15:05 INFO - Running setup.py (path:/tmp/pip-f1Ihs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:15:05 INFO - Running setup.py (path:/tmp/pip-5Ntq8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:15:05 INFO - Running setup.py (path:/tmp/pip-0TJdFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:15:05 INFO - Running setup.py (path:/tmp/pip-TjBxI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:15:05 INFO - Running setup.py (path:/tmp/pip-rimIDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:15:05 INFO - Running setup.py (path:/tmp/pip-bzmwY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:05 INFO - Running setup.py (path:/tmp/pip-N5xDMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:15:05 INFO - Running setup.py (path:/tmp/pip-LQbDsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:15:06 INFO - Running setup.py (path:/tmp/pip-b9oXUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:15:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:15:06 INFO - Running setup.py install for manifestparser 23:15:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:15:06 INFO - Running setup.py install for mozcrash 23:15:06 INFO - Running setup.py install for mozdebug 23:15:06 INFO - Running setup.py install for mozdevice 23:15:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:15:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:15:06 INFO - Running setup.py install for mozfile 23:15:06 INFO - Running setup.py install for mozhttpd 23:15:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:15:06 INFO - Running setup.py install for mozinfo 23:15:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:15:06 INFO - Running setup.py install for mozInstall 23:15:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:15:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:15:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:15:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:15:06 INFO - Running setup.py install for mozleak 23:15:07 INFO - Running setup.py install for mozlog 23:15:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:15:07 INFO - Running setup.py install for moznetwork 23:15:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:15:07 INFO - Running setup.py install for mozprocess 23:15:07 INFO - Running setup.py install for mozprofile 23:15:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:15:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:15:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:15:07 INFO - Running setup.py install for mozrunner 23:15:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:15:07 INFO - Running setup.py install for mozscreenshot 23:15:07 INFO - Running setup.py install for moztest 23:15:07 INFO - Running setup.py install for mozversion 23:15:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:15:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:15:07 INFO - Cleaning up... 23:15:07 INFO - Return code: 0 23:15:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15:07 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')]} 23:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:07 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')]} 23:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:07 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 0x7f541d9a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21c0>, '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 0x1eb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3550>, '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': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', '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 23:15:07 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 23:15:07 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 23:15:07 INFO - Using env: {'DISPLAY': ':0', 23:15:07 INFO - 'HOME': '/home/cltbld', 23:15:07 INFO - 'LANG': 'en_US.UTF-8', 23:15:07 INFO - 'LANGUAGE': 'en_US:en', 23:15:07 INFO - 'LOGNAME': 'cltbld', 23:15:07 INFO - 'MAIL': '/var/mail/cltbld', 23:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:07 INFO - 'MOZ_NO_REMOTE': '1', 23:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:07 INFO - 'NO_EM_RESTART': '1', 23:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:07 INFO - 'PWD': '/builds/slave/test', 23:15:07 INFO - 'SHELL': '/bin/bash', 23:15:07 INFO - 'SHLVL': '1', 23:15:07 INFO - 'TERM': 'linux', 23:15:07 INFO - 'TMOUT': '86400', 23:15:07 INFO - 'USER': 'cltbld', 23:15:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', 23:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:07 INFO - '_': '/tools/buildbot/bin/python'} 23:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:15:08 INFO - Running setup.py (path:/tmp/pip-oBGC4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:15:08 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)) 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:15:08 INFO - Running setup.py (path:/tmp/pip-81xaaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:15:08 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)) 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:15:08 INFO - Running setup.py (path:/tmp/pip-0Rx1mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:15:08 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)) 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:15:08 INFO - Running setup.py (path:/tmp/pip-T5a9r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:15:08 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)) 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:15:08 INFO - Running setup.py (path:/tmp/pip-F5uV5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:15:08 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)) 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:15:08 INFO - Running setup.py (path:/tmp/pip-t27D5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:15:08 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)) 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:15:08 INFO - Running setup.py (path:/tmp/pip-RxaPbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:15:08 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)) 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:15:08 INFO - Running setup.py (path:/tmp/pip-vZfFUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:15:08 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)) 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:15:08 INFO - Running setup.py (path:/tmp/pip-VwiI0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:15:08 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)) 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:15:08 INFO - Running setup.py (path:/tmp/pip-NM2EBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:15:08 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)) 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:15:08 INFO - Running setup.py (path:/tmp/pip-0BDm4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:15:08 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)) 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:15:08 INFO - Running setup.py (path:/tmp/pip-f1bYYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:15:09 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)) 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:15:09 INFO - Running setup.py (path:/tmp/pip-r9TszS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:15:09 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)) 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:15:09 INFO - Running setup.py (path:/tmp/pip-lAv3Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:15:09 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)) 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:09 INFO - Running setup.py (path:/tmp/pip-IAIxmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:09 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)) 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:15:09 INFO - Running setup.py (path:/tmp/pip-KN_M0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:15:09 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)) 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:15:09 INFO - Running setup.py (path:/tmp/pip-KPMoT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:15:09 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)) 23:15:09 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)) 23:15:09 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)) 23:15:09 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)) 23:15:09 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)) 23:15:09 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)) 23:15:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:11 INFO - Downloading blessings-1.6.tar.gz 23:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:15:11 INFO - Installing collected packages: blessings 23:15:11 INFO - Running setup.py install for blessings 23:15:11 INFO - Successfully installed blessings 23:15:11 INFO - Cleaning up... 23:15:11 INFO - Return code: 0 23:15:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:15:11 INFO - Reading from file tmpfile_stdout 23:15:11 INFO - Current package versions: 23:15:11 INFO - argparse == 1.2.1 23:15:11 INFO - blessings == 1.6 23:15:11 INFO - blobuploader == 1.2.4 23:15:11 INFO - docopt == 0.6.1 23:15:11 INFO - functools32 == 3.2.3-2 23:15:11 INFO - jsonschema == 2.5.1 23:15:11 INFO - manifestparser == 1.1 23:15:11 INFO - mozInstall == 1.12 23:15:11 INFO - mozcrash == 0.17 23:15:11 INFO - mozdebug == 0.1 23:15:11 INFO - mozdevice == 0.48 23:15:11 INFO - mozfile == 1.2 23:15:11 INFO - mozhttpd == 0.7 23:15:11 INFO - mozinfo == 0.9 23:15:11 INFO - mozleak == 0.1 23:15:11 INFO - mozlog == 3.2 23:15:11 INFO - moznetwork == 0.27 23:15:11 INFO - mozprocess == 0.22 23:15:11 INFO - mozprofile == 0.28 23:15:11 INFO - mozrunner == 6.11 23:15:11 INFO - mozscreenshot == 0.1 23:15:11 INFO - mozsystemmonitor == 0.3 23:15:11 INFO - moztest == 0.7 23:15:11 INFO - mozversion == 1.4 23:15:11 INFO - psutil == 3.1.1 23:15:11 INFO - requests == 1.2.3 23:15:11 INFO - wsgiref == 0.1.2 23:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15: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')]} 23:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15: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')]} 23:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:11 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 0x7f541d9a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21c0>, '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 0x1eb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3550>, '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': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', '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 23:15:11 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 23:15:11 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 23:15:11 INFO - Using env: {'DISPLAY': ':0', 23:15:11 INFO - 'HOME': '/home/cltbld', 23:15:11 INFO - 'LANG': 'en_US.UTF-8', 23:15:11 INFO - 'LANGUAGE': 'en_US:en', 23:15:11 INFO - 'LOGNAME': 'cltbld', 23:15:11 INFO - 'MAIL': '/var/mail/cltbld', 23:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:11 INFO - 'MOZ_NO_REMOTE': '1', 23:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:11 INFO - 'NO_EM_RESTART': '1', 23:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:11 INFO - 'PWD': '/builds/slave/test', 23:15:11 INFO - 'SHELL': '/bin/bash', 23:15:11 INFO - 'SHLVL': '1', 23:15:11 INFO - 'TERM': 'linux', 23:15:11 INFO - 'TMOUT': '86400', 23:15:11 INFO - 'USER': 'cltbld', 23:15:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', 23:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:11 INFO - '_': '/tools/buildbot/bin/python'} 23:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:11 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)) 23:15:11 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)) 23:15:11 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)) 23:15:11 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)) 23:15:11 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)) 23:15:11 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)) 23:15:11 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)) 23:15:11 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)) 23:15:11 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)) 23:15:11 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)) 23:15:11 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)) 23:15:11 INFO - Cleaning up... 23:15:11 INFO - Return code: 0 23:15:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:15: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')]} 23:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15: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')]} 23:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:11 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 0x7f541d9a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21c0>, '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 0x1eb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3550>, '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': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', '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 23:15:11 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 23:15:11 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 23:15:11 INFO - Using env: {'DISPLAY': ':0', 23:15:11 INFO - 'HOME': '/home/cltbld', 23:15:11 INFO - 'LANG': 'en_US.UTF-8', 23:15:11 INFO - 'LANGUAGE': 'en_US:en', 23:15:11 INFO - 'LOGNAME': 'cltbld', 23:15:11 INFO - 'MAIL': '/var/mail/cltbld', 23:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:11 INFO - 'MOZ_NO_REMOTE': '1', 23:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:11 INFO - 'NO_EM_RESTART': '1', 23:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:11 INFO - 'PWD': '/builds/slave/test', 23:15:11 INFO - 'SHELL': '/bin/bash', 23:15:11 INFO - 'SHLVL': '1', 23:15:11 INFO - 'TERM': 'linux', 23:15:11 INFO - 'TMOUT': '86400', 23:15:11 INFO - 'USER': 'cltbld', 23:15:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', 23:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:11 INFO - '_': '/tools/buildbot/bin/python'} 23:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:15:12 INFO - Cleaning up... 23:15:12 INFO - Return code: 0 23:15:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:15:12 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')]} 23:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:12 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')]} 23:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:12 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 0x7f541d9a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21c0>, '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 0x1eb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3550>, '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': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', '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 23:15:12 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 23:15:12 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 23:15:12 INFO - Using env: {'DISPLAY': ':0', 23:15:12 INFO - 'HOME': '/home/cltbld', 23:15:12 INFO - 'LANG': 'en_US.UTF-8', 23:15:12 INFO - 'LANGUAGE': 'en_US:en', 23:15:12 INFO - 'LOGNAME': 'cltbld', 23:15:12 INFO - 'MAIL': '/var/mail/cltbld', 23:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:12 INFO - 'MOZ_NO_REMOTE': '1', 23:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:12 INFO - 'NO_EM_RESTART': '1', 23:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:12 INFO - 'PWD': '/builds/slave/test', 23:15:12 INFO - 'SHELL': '/bin/bash', 23:15:12 INFO - 'SHLVL': '1', 23:15:12 INFO - 'TERM': 'linux', 23:15:12 INFO - 'TMOUT': '86400', 23:15:12 INFO - 'USER': 'cltbld', 23:15:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', 23:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:12 INFO - '_': '/tools/buildbot/bin/python'} 23:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:12 INFO - Downloading/unpacking flake8 23:15:12 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 23:15:12 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 23:15:12 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 23:15:12 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 23:15:12 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 23:15:12 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 23:15:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:15:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:15:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:15:15 INFO - no previously-included directories found matching 'docs/_build' 23:15:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:15:15 INFO - Running setup.py install for pep8 23:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:15:15 INFO - no previously-included directories found matching 'docs/_build' 23:15:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:15:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:15:15 INFO - Cleaning up... 23:15:15 INFO - Return code: 0 23:15:15 INFO - Running post-action listener: _resource_record_post_action 23:15:15 INFO - Running post-action listener: _start_resource_monitoring 23:15:15 INFO - Starting resource monitoring. 23:15:15 INFO - ##### 23:15:15 INFO - ##### Finished create-virtualenv step (success) 23:15:15 INFO - ##### 23:15:15 INFO - ##### 23:15:15 INFO - ##### Running install step. 23:15:15 INFO - ##### 23:15:15 INFO - Running pre-action listener: _resource_record_pre_action 23:15:15 INFO - Running main action method: install 23:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:15:15 INFO - Reading from file tmpfile_stdout 23:15:15 INFO - Detecting whether we're running mozinstall >=1.0... 23:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:15:15 INFO - Reading from file tmpfile_stdout 23:15:15 INFO - Output received: 23:15:15 INFO - Usage: mozinstall [options] installer 23:15:15 INFO - Options: 23:15:15 INFO - -h, --help show this help message and exit 23:15:15 INFO - -d DEST, --destination=DEST 23:15:15 INFO - Directory to install application into. [default: 23:15:15 INFO - "/builds/slave/test"] 23:15:15 INFO - --app=APP Application being installed. [default: firefox] 23:15:15 INFO - mkdir: /builds/slave/test/build/application 23:15:15 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'] 23:15:15 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 23:15:32 INFO - Reading from file tmpfile_stdout 23:15:32 INFO - Output received: 23:15:32 INFO - /builds/slave/test/build/application/firefox/firefox 23:15:32 INFO - Running post-action listener: _resource_record_post_action 23:15:32 INFO - ##### 23:15:32 INFO - ##### Finished install step (success) 23:15:32 INFO - ##### 23:15:32 INFO - ##### 23:15:32 INFO - ##### Running run-tests step. 23:15:32 INFO - ##### 23:15:32 INFO - Running pre-action listener: _resource_record_pre_action 23:15:32 INFO - Running main action method: run_tests 23:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:15:32 INFO - Python 2.7.3 23:15:32 INFO - Return code: 0 23:15:32 INFO - grabbing minidump binary from tooltool 23:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:32 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 0x1eb21c0>, '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 0x1eb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:15:32 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 23:15:32 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 23:15:32 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 23:15:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:15:32 INFO - Return code: 0 23:15:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:15:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:15:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:15:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:15:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:15:33 INFO - Return code: 0 23:15:33 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/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 23:15:33 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/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 23:15:33 INFO - Using env: {'DISPLAY': ':0', 23:15:33 INFO - 'HOME': '/home/cltbld', 23:15:33 INFO - 'LANG': 'en_US.UTF-8', 23:15:33 INFO - 'LANGUAGE': 'en_US:en', 23:15:33 INFO - 'LOGNAME': 'cltbld', 23:15:33 INFO - 'MAIL': '/var/mail/cltbld', 23:15:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:15:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:33 INFO - 'MOZ_NO_REMOTE': '1', 23:15:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:33 INFO - 'NO_EM_RESTART': '1', 23:15:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:33 INFO - 'PWD': '/builds/slave/test', 23:15:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:15:33 INFO - 'SHELL': '/bin/bash', 23:15:33 INFO - 'SHLVL': '1', 23:15:33 INFO - 'TERM': 'linux', 23:15:33 INFO - 'TMOUT': '86400', 23:15:33 INFO - 'USER': 'cltbld', 23:15:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034', 23:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:33 INFO - '_': '/tools/buildbot/bin/python'} 23:15:33 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/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 23:15:33 INFO - mozversion application_buildid: 20160620203028 23:15:33 INFO - mozversion application_changeset: 027db1e33f89606c4996feae0203e5f3bb5db43d 23:15:33 INFO - mozversion application_display_name: Nightly 23:15:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:15:33 INFO - mozversion application_name: Firefox 23:15:33 INFO - mozversion application_remotingname: firefox 23:15:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:15:33 INFO - mozversion application_vendor: Mozilla 23:15:33 INFO - mozversion application_version: 50.0a1 23:15:33 INFO - mozversion platform_buildid: 20160620203028 23:15:33 INFO - mozversion platform_changeset: 027db1e33f89606c4996feae0203e5f3bb5db43d 23:15:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:15:33 INFO - mozversion platform_version: 50.0a1 23:15:33 INFO - using testdate: 1466489733 23:15:33 INFO - actual date: 1466489733 23:15:33 INFO - starting webserver on 'localhost:46786' 23:15:33 INFO - SUITE-START | Running 2 tests 23:15:33 INFO - TEST-START | dromaeo_css 23:15:33 INFO - operating with platform_type : linux_ 23:15:33 INFO - Initialising browser for dromaeo_css test... 23:15:33 INFO - TEST-INFO | started process 28553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVeGDNf/profile http://localhost:46786/getInfo.html) 23:15:38 INFO - PROCESS | 28553 | __metrics Screen width/height:1600/1200 23:15:38 INFO - PROCESS | 28553 | colorDepth:24 23:15:38 INFO - PROCESS | 28553 | Browser inner width/height: 1024/697 23:15:38 INFO - PROCESS | 28553 | __metrics 23:15:39 ERROR - PROCESS | 28553 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 23:15:40 INFO - TEST-INFO | 28553: exit 0 23:15:40 INFO - Browser initialized. 23:15:40 INFO - Running cycle 1/1 for dromaeo_css test... 23:15:40 INFO - TEST-INFO | started process 28675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVeGDNf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:15:52 INFO - PROCESS | 28675 | RSS: Main: 185180160 23:15:52 INFO - PROCESS | 28675 | 23:16:41 INFO - PROCESS | 28675 | 1466489801689 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] 23:18:49 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:46786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46786/tests/dromaeo/cssquery-ext.html) 23:18:50 INFO - PROCESS | 28675 | RSS: Main: 189734912 23:18:50 INFO - PROCESS | 28675 | 23:21:52 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:46786/tests/dromaeo/cssquery-ext.html (next: http://localhost:46786/tests/dromaeo/cssquery-jquery.html) 23:21:53 INFO - PROCESS | 28675 | RSS: Main: 187416576 23:21:53 INFO - PROCESS | 28675 | 23:24:55 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:46786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46786/tests/dromaeo/cssquery-mootools.html) 23:24:55 INFO - PROCESS | 28675 | RSS: Main: 189530112 23:24:55 INFO - PROCESS | 28675 | 23:27:57 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:46786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46786/tests/dromaeo/cssquery-prototype.html) 23:27:58 INFO - PROCESS | 28675 | RSS: Main: 186830848 23:27:58 INFO - PROCESS | 28675 | 23:31:00 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:46786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46786/tests/dromaeo/cssquery-yui.html) 23:31:01 INFO - PROCESS | 28675 | RSS: Main: 189165568 23:31:01 INFO - PROCESS | 28675 | 23:34:03 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:46786/tests/dromaeo/cssquery-yui.html (next: http://localhost:46786/tests/dromaeo/cssquery-dojo.html) 23:34:03 INFO - PROCESS | 28675 | RSS: Main: 189792256 23:34:03 INFO - PROCESS | 28675 | 23:34:03 INFO - PROCESS | 28675 | __start_tp_report 23:34:03 INFO - PROCESS | 28675 | _x_x_mozilla_page_load 23:34:03 INFO - PROCESS | 28675 | _x_x_mozilla_page_load_details 23:34:03 INFO - PROCESS | 28675 | |i|pagename|runs| 23:34:03 INFO - PROCESS | 28675 | |0;dojo.html;3058.9847050764743;3088.3514461962986;3112.891048813292;3143.3084721361292;3151.3854798314337;5431.565474762019;5432.402435732076;5451.127819548873;5463.508284254416;5511.22842802007;5325.547328477084;5428.294321738178;5470.9452905470935;5471.151971444432;5601.047821870282;4899.461059283476;4961.603071754251;5063.088644044071;5089.745512724349;5142.845714628567;450.75969175565854;4914.189158788796;4978.352814134158;5050.646454748169;5087.109755792721;5030.421501527335;5065.873353166164;5084.898302033976;5090.9745451272875;5112.412072611642;5112.795488180468;5115.488451154892;5120.820771272987;5138.614603904722;5147.202183661539;4896.755162241873;4981.9252711209365;4995.800167993276;4999.500049995007;5021;5470.452954704498;5474.698891560963;5492.038893193675;5513.062779327524;5531.529819965308;5758;5879.7648094076185;5887.5584331174905;5925.140854576062;5930.762769489215;6011.3086994995265;6015.037593984942;6040.607360521552;6054.152418661391;6086.482648974842;5629.690367029812;5651.208830763697;5654.321481422215;5659.490645841853;5670.801521946753;5924.229850119457;6028.849278767978;6081.209442772411;6177.042558403455;6186.721597528122;5804.158397032406;5807.157962095473;5812.622179558315;5815.447532484407;5826.766929322865;5970.701464926737;5976.043832986701;5978.880422391528;5982.312034116046;5998.040313549811;5937.851553711105;5957.165996760457;5958.6424814511265;5977.6114552553945;6020.217371741734;5950.9107363389585;5963.5825492216;6000.279966404059;6044.365341639153;6050.30421501533;4424.446944131983;4564.246899261651;4582.2668373060815;4582.9541704582525;4616.561426664462;3883.514560679915;3977.204559088194;3984.183242435352;4003.53959294679;4009.959900401017;5601.915971260434;5619.578531610146;5667.943320566824;5720.313562372542;5727.140928860705;5786.218860453869;6064.272287325461;6067.575269731076;6074.635521868702;6075.088736689444;5651.152327150878;5734.655920644775;5753.309602847685;5755;5776.364599894008;4952.455229924705;5000.849974500771;5022.196448568212;5031.4465408805;5129.9230511542355;6034.547408944347;6126.975740326312;6251.468625166912;6266.749330026839;6281.59169653971;6025.517958563392;6124.229237387393;6127.494965205145;6132.447291485866;6141.9078713818435;6252.124702541557;6265.561410701207;6278.591891527036;6286.811395658137;6304.71628776697;5694.4590263924865;5796.072628379439;5798.884022319615;5872.383399742966;5985.820425387245;5940.55445841555;5949.3753155918;5968.253968253968;5983.102534619842;5986.491148252273;5772.682502462405;5786.594938354275;5837.29952405714;5842.970785146047;5847.502962248086;5604.467575580314;5784.074548072288;5813.04084825999;5850.824475265749;5855.180274761452;5731.283589551306;5759.51044161251;5760.279965004374;5764.135379692912;5795.304563452412;5896.233489646319;5946.464818166386;5947.494462970523;5971.193888824953;5972.731227094878;5614.382417934105;5674.858128546819;5706.714664266853;5725.19847221381;5758.193852860519 23:34:03 INFO - PROCESS | 28675 | |1;ext.html;562.2465895699761;617.1236843681971;637.2607774981022;643.9645819479928;645.2772894358319;38624.42063369052;39959.20081598366;42964.14071718571;43132.353014704764;43193.56806431935;45855.54144458554;46064.309035364495;46116.76941615296;46122.99999999991;46346.07307853841;8900.8664870027;9030.729078127666;9034.186923176912;9085.591148398305;9099.772505687344;8916.286697064252;9020.2783777298;9026;9038.819223615525;9059.547022648874;9020.2783777298;9078.364514483988;9080.137386948229;9080.682176123837;9116.088391160898;9081.863772043425;9082.682106126254;9088;9100.317476189311;9108.043655416186;8908.821823563492;9000.144986226298;9003.5048072356;9012.63949442028;9017.053209413049;34451.82774086139;43260.783696081635;43649.78175109104;43717.78141109274;43792.78103609494;3428.297199074184;3456.3260164267977;3535.964640353615;3561.7684850484634;3666.7066634669163;31640.841795791104;31715.36569268625;31812;31885.84057079723;32847.83576082128;4243.299855523835;4267.295896177127;4347.478302603676;4398.690687389147;4432.312991486325;283373;284465;286459;286548;287446;35241;35298;35325.293494129975;35589.8220508901;35598;35450.29099417997;36278.45582316215;36353.45469817955;38386.80806596005;38427.23145537129;17619.383321583682;17818.5545361367;17838.643227135384;17841;17873.28506859711;12967.092303538662;13024;13055.673608159683;13075.738485230433;13123.671908202372;19730.605387892163;20116.597668046557;20117;20174.092165852573;20176.596468070555;7221.205667376585;7271;7353.411727061929;7447.292507211806;7466.664000120008;989.8020395920701;1029.2229366827996;1036.8341065429495;1077.380506208933;1097.286763603648;31145.844270778955;32573.837130814194;32774.50838237381;32890.8355458226;33113.50329745056;1110.9277896936674;1122.1976286954866;1126.8028095083491;1139.4416735799564;1145.0724912820476;16964.915175424045;17335.306587736603;17490.19059695091;17523.912380438018;17660.470185894443;551768;553737;554124;560894;561589;39712.404313935316;59129.704351477965;59131.40868591259;59433.10850337248;59658.10512842311;1265.5886836778084;1316.5194703933187;1321.1808678619318;1339.6650837290676;1345.7106722054805;30658.693413065583;31594;31952.84023579867;32096.704043832506;32877.50683739698;51894;52428.21357679561;52551.47448525466;52568.737156313975;52618;422499;427632;428470;430915;434201;27955.720442796126;28543.857280713462;28679.283017924718;28837.855810720812;28840.278993025342;46939.295910560686;48543.5145648539;48628.75685621549;48718;49280.260796088805;41215;41540.376894346;41583;42220.36669449899;42612.14775704406;41170;41350.8954384637;41612;42007.1598568033;42419.7879010603;40080.79959600183;40953.59046409498;41405.171896562504;41421;41499.37750933799;35861;36618.81690591636;37039;37329.62670373262;37337;27789.444211116068;28216.71783282141;28509.572356415087;28531.572026420035;28531.714682852904 23:34:04 INFO - PROCESS | 28675 | |2;jquery.html;380.8838304317182;380.97714137151763;385.57779231741245;396.36977206242085;402.9657479114275;16884.57788555285;19055;19370.612587748255;19395.515112122204;19437.902810485928;17511.299548018094;17725.82274177258;18095;18497.537561560966;18536;5553.7223138843;5694.202811606378;5739.110437882114;5775.5957083004205;5779.884402311951;5510.256115424427;5668.57485688573;5669.489745922866;5709.800156994506;5711.029125048752;5588.776448942038;5636.436356364372;5654.208410822488;5685.431456854323;5693.373728889819;5573.498385145336;5621.381648018735;5683.460071293221;5685.346185188673;5711.400302968191;5029.270755740434;5060.7722652480725;5071.7210553419545;5078.974605126988;5093.337866077386;21508.247211347683;21781;21917.452063698376;22072.44818879541;22102.0054097566;2353.51752890657;2400.687910571632;2464.653517193217;2515.5346260941783;2677.3975855432373;9443.102905223992;10081.495925203784;13934.163950163023;14335.211563364011;14471.493497727633;1918.8177123173277;1942.9125689344014;1988.9104990275328;2018.2734215682342;2029.954573394703;72951.63524182398;79865;81473.59263203705;82499.17500824975;82910;10502.21462351402;10679.893201068046;10760.192985526117;10995.065419439437;11176.832347514794;15154.924225378803;15208.543743687707;15299.541013769382;15306.846931530765;15328.156951367559;8163.346932245406;8223.136570660114;8322.916770832335;8491.915080849236;8507.61715722794;7967.163447837894;8050.718224862102;8072.556009419421;8189.754307370788;8296.087430382653;4536.909261814745;4703.811847526061;4722.386089808371;4772;4829.6860704054125;1952.7168560558923;1977.5352792093847;1991.9343151413923;1996.4609555419954;1998.6802111662064;940.8823897012874;965.1554889471712;1025.8453264279638;1029.6344797596746;1092.9672109836717;17906.194221260073;18544.536386590444;18546.258149674133;18568.44294671162;18799.248030078918;931.9254459643212;964.6816550538306;976.5068640336584;983.9852402213829;995.4674249276602;9202.171804537624;10468;10603.992620701021;10621.946890265499;10642.095421889071;431973;443398;448939;453560;457999;89873;91910.54044729733;92571;93530;93602.06397935933;874.8337815814975;886.9911300887038;899.5996781432331;904.1681652879366;906.886639170117;15707.842921570638;16324.428644997368;16564.254608542884;16752.246148923085;16919.154042298083;31932.840335798173;42031;43238.78380608203;44158.11683766243;44392.33411498766;50705;54763.45236547743;57484;57530.13704794515;58462;7438.256174382518;7832.099308579586;7916.9604151981175;8420.789480263042;8981.775455613662;9787.559559819683;13585.252811095485;13843.584692459242;13875.653108672364;14235;11344.9432752839;11536.653900383002;11716.70708232301;11779;12061.336626485627;11495.137864660017;11568.884311157117;11711.648650540157;11878.227915185485;11950.820737689115;11977.940110299742;12113.878861211275;12253.693657658274;12450.501979920702;12546.247225166519;8067.636956337096;8097.2307630774985;8153;8202.220789025034;8225.629846657035;10461.738456538647;11547.480363383836;11717.824232636687;11919.225250359046;12204.145709800583 23:34:04 INFO - PROCESS | 28675 | |3;mootools.html;1466.9193194374304;1476.3135142158897;1568.2550788375522;1714.4599451172887;1744.1802352894142;7735.806604834868;8242.546659933701;8311.459755115928;8735.694250701219;8743.868841967367;8407.159284071606;8655.567221638908;8732.039475657673;8755.86866197006;8757.386982911199;2237.7874101960288;2262.8189744820456;2272.227442669492;2273.3748219239674;2280.361498780344;2187.562487502498;2210.7568167501563;2221.6445368741006;2229.576380487702;2243.719535058118;2203.327984964585;2212.9557408851815;2219.34529313852;2235.61994460942;2264.5810525052834;2151.8924053797246;2164.751053628829;2166.3392665237097;2172.3265787605815;2178.3900507857825;2129.9254526091668;2142.1324363632752;2157.2773121004484;2158.686990386401;2164.826813854904;8700.129987001312;8745.693900713444;8777.122287771235;8792.736217913473;8798;5109.335786347789;5150.510701483353;5185.948140518584;5210.557102646279;5229.189475631283;3156.9684303157132;3292.1275861896615;3322.5016247562817;3388.40702876998;3422.401079811023;1120.1878637987395;1136.7101389145798;1143.279733767721;1165.4930105404176;1180.9527618895233;11929.403529823561;11946.402679865972;11968.70078248042;12039.157258991874;12055.517779288906;4510.075434535912;4593.63250939924;4612.561806628365;4621.815127394867;4650.697704649187;10195.643152489776;10199.439030853226;10218.284720069672;10233;10233.130183934449;5177.404598471148;5251.028559716465;5252.002119597264;5258.5267325940085;5262.947370526323;4187.853425130106;4788.712677239377;4836.927446088312;4861.95138048615;4888.95111048885;3899.1226973931207;3970.781607011584;4027.4160246764054;4086.366613174963;4089.1821635672986;1250.0249805151996;1302.5642049367743;1306.203216038216;1314.7304802515462;1321.154461144868;829.1915382502133;879.2262808728278;912.7307444303947;919.4758987377264;955;5816.302043754777;5861.70691465425;5935.643861368331;5984.132300816357;6446.290908000116;972.863799068131;987.7876256604865;1012.6000229909145;1025.374521541859;1040.0795296162798;4134.214499245134;4353.651707863363;4355.60799528044;4372.825086996484;4378.584034516716;10236.590536378462;10590.099841513404;10620.362778233331;10629.362238265574;10656.520456579472;9839.704808855746;10425.791484170275;10427.061564459234;10518;10532.631357902437;7726.7295644653295;7934.761957141295;8120.26917577409;8159.673613055411;8165.346772258205;5763.7118144093465;5961.642301461753;6150.323464419;6261.072075479216;6293.307736149111;9295.442273463614;9918.256130790363;10051.69844904654;10136.594536218468;10173.796524069328;9715.70852874415;10014.098731114234;10014.64948726791;10017.499125043865;10029.448380339152;7290.416766658761;7755.806104847424;7955.602219888867;8098.392620553364;8246.958765206376;8099.230573095547;8106.47307924983;8110.878336824834;8143.959280203561;8166.550839703873;7125.1093613298335;7133.072700548895;7163;7399.149097853816;7534.962325188339;7192.2088570258275;7196.424286056998;7366.765717007068;7391;7456.7762967111075;6578.177727784027;6671.499637527302;6699.263081061177;6710.966445167743;6718.596884186769;5143.92284115731;5290.206469029677;5341.359036915595;5438.6192966493545;5481.260029895913;5224.50367215114;5242.895142097061;5344.305240318734;5386.8383948481605;5454.4545545445135 23:34:04 INFO - PROCESS | 28675 | |4;prototype.html;319.3724331688232;332.66234771706706;333.9949900751489;335.93785149747316;337.9020084175588;5494.203340515628;5625.859353516164;5626.21233027376;5702.372738998707;5709.286339207599;5538.833834984957;5578.693171875555;5584.86037849054;5603.495685388314;5613.887722245553;4334.089841133366;4353.542877997804;4355.978220108895;4376.5623437656295;4381.846635367763;4246.686637391784;4387;4393.85759702478;4407.250767369539;4412.1175764847;4313.28830742927;4320.481542214939;4322.373255877896;4338.674599405057;4341.869743907688;4352.608265256111;4353.912921741579;4354.390385346054;4355.36847157162;4357.0196705740955;3510.1049232445816;3720.572134204574;3854.2484215577974;3879.534455865286;3880.641775378623;5338.893222135535;5379.838604841861;5420;5431.402545719968;5443.1835224716215;4791.784369703371;4801.4718380978065;4808.759562021885;4814.374131362935;4855.44162421319;5668.064769313059;5780.797672081457;5788.565857560699;5813.959298287692;5814.982378083819;4088.2641124597562;4096.40602112692;4112.88951982966;4115.54728979812;4117.7881252623;5824.330202026778;5852.531797456193;6075.392460753934;6086.969565152191;6126.969365153146;4111.259973204852;4119.402686610425;4129.587041295847;4132.958670413317;4143.1713657268665;4188.560201178893;4192.098698779777;4208.9789551052045;4210.726302790309;4218.430511880857;4636.4899861015265;4862.586680132157;4872.439669437989;4883.34074899891;4886.486918873467;5792.362840087587;5862.70686465675;5871.588988770745;5878.853028674317;5904.261967254093;1454.69451415204;1463.604826696786;1472.6686495538631;1482.2366481262159;1485.0990731863233;900.6532484993324;940.3323640215524;942.6794889737522;952.7379970508027;958.5446912716543;5046.041252162077;5050.651447077127;5054.231019143271;5067.417247016567;5081.59347252219;5294.152935530296;5322;5325.733713314319;5338.839834804962;5375.19372094189;5025.221090730943;5028.346314979102;5051.595872330205;5280.3663560373;5726.169705392695;3165.3036332006923;3181.3796309719382;3191.457452233126;3207.9839600801847;3222.2105584132037;6034.25441424151;6153.815385538441;6155.353687862799;6200.139958012668;6203.8138855833495;6057.273127224761;6106.6946652668075;6122.571420000557;6150.938490615036;6210.378962103753;6129.969350153221;6136.539759518054;6157.568970172045;6195.721192546346;6204.193454850841;5858.916100521417;5947.613405128653;5986.401359864153;6032.6983650818165;6052.969735151296;5849.385814489588;5862.296524417097;5880.294364676266;5896.823095307148;5936.762529498945;5913.822585322448;6041.456268935817;6222.81331560054;6228.408301211378;6240.219972503437;4235.23765722173;4253.787310634394;4260.998665313711;4277.657787377065;4278.0374415756205;5834.761707252346;6022.5784195105925;6055.394460553909;6062.878742425039;6106.969465152823;5857.765689372377;5864.266966629171;5871.882562348815;5872.618279811799;5884.32330282023;5796.275465566804;5827.912581311199;5859.882802343844;5899.351071382231;5907.40925907423;5570.693611851387;5744.4829965303325;5749.108888122348;5762.049261871744;5781.653100813965;5802.738876750472;5822.912656310074;5849.590528663123;5856.4143585641095;5887.027051339218;5648.491635752637;5649.6327738696855;5738.84793202549;5739.827805165852;5786.161006653927 23:34:04 INFO - PROCESS | 28675 | |5;yui.html;768.4851149729681;772.1622040086506;774.4617490843863;799.3046049936556;822.9506229626223;14079.296035198238;14893.776593351095;14979.47571834986;15006.39974401024;15007.849921500781;13161.144525605829;13210.801837972438;13285.202887826737;13318.267495287755;13319.400626971785;654.653033892038;774.0904437286181;783.75703531905;788.8146285622875;792.6670798264743;795.4829360915422;802.3180296747747;805.6334367862638;806.8103995561039;809.1988930958338;864.2783275964578;864.8400045991481;867.2758246863876;867.453504292295;867.8611422172454;858.0947100808644;858.3176374782063;859.2395729779128;859.9355048371334;862.2541501601132;620.1472974659843;622.5175488996019;623.7130919776909;624.1480379282247;625.4714766022704;14241.572752817432;14242.928785356007;14358.784618230735;14373.85626143746;14423.49517766873;15524.223788810627;15575.610609734735;15669.294881730235;15672.92163539175;15737.449189278435;12307.93846030773;12341.587345954762;12345.19756215852;12569.057320700984;12823.294718790463;3897.1815918657117;3920.490336256297;3933.6263055009726;3933.7049721270732;3972.2651309507833;87335;87346.56326718326;89168.55415722945;89497;89811.55094224487;11040.392778397105;11158.10735141203;11173.664790056311;11237.831432528355;11255.774884502263;18747;18786.906065469586;18876.24495020184;19025.524361890788;19209.51976200606;8574.099719529484;8712.869306960401;8727.60725767342;8749.16882896124;8791.956040219759;4452.109578084396;4530.29780384041;4564.1556312082375;4574.062317224961;4612.285095810154;3472.7569070164845;3502.9299414011575;3595.6224596417;3599.4420864766003;3607.47691584724;598.8706726884222;605.0893405424807;607.1590846677384;610.5512448350547;612.5803824380314;669.3406994110796;692.757534862794;709.4785332780402;728.4682182007165;732.3957734868754;9024;9250.259979201648;9299.163075323253;9356.204722598519;9669.371490853073;635.4725577770439;638.7381173718846;660.359451332207;698.4307789151926;760.2359628573248;4203.43253660758;4522.4573051234065;4582.890077563493;4606.482056376506;4674.509176536415;112792.43603781928;118652.40673796576;120344;120550;122532;88864;97975;103325.21735652404;104603;105718;56504.15243771347;87398.56300718455;90052.5497372509;90161.82815319848;90796;8371.497710137412;8571.357148213785;8620.5258710769;8637.265832404317;8850.20348168668;48158;49026.264606031655;49470.752646236535;50576;51041;72315.85315248262;76274.61862690651;78025;78108.60945695236;78230.6088469554;12580.119391642864;12610.117291789487;12734.299613521345;12773.297468639314;13297;12266.32535210572;12447.013870923036;12508.937455312665;12528.414015104618;12645.557405490763;11624.418779061183;11695.181337306647;11762.23545469576;11817;12157.939210303892;11711.824322635337;12310.507579696712;12592.433340499516;12610.095606083414;13091.476340946256;12038.518459261531;12479.376031198222;12482.375881205722;12944.15862968904;13021.027098617344;9787.265955053257;9875.20998320147;10196.557148457454;10255.58977640886;10308.536115874953;9582.568784404857;9748.853767193355;10497.685069447929;11199.552017919192;11439.771204576029 23:34:04 INFO - PROCESS | 28675 | __end_tp_report 23:34:04 INFO - PROCESS | 28675 | __start_cc_report 23:34:04 INFO - PROCESS | 28675 | _x_x_mozilla_cycle_collect,354 23:34:04 INFO - PROCESS | 28675 | __end_cc_report 23:34:04 INFO - PROCESS | 28675 | __startTimestamp1466490843991__endTimestamp 23:34:04 INFO - PROCESS | 28675 | 23:34:04 INFO - PROCESS | 28675 | ------- Summary: start ------- 23:34:04 INFO - PROCESS | 28675 | Number of tests: 6 23:34:04 INFO - PROCESS | 28675 | 23:34:04 INFO - PROCESS | 28675 | [#0] dojo.html Cycles:165 Average:5503.01 Median:5758.19 stddev:772.65 (13.4%) stddev-sans-first:750.86 23:34:04 INFO - PROCESS | 28675 | Values: 3059.0 3088.4 3112.9 3143.3 3151.4 5431.6 5432.4 5451.1 5463.5 5511.2 5325.5 5428.3 5470.9 5471.2 5601.0 4899.5 4961.6 5063.1 5089.7 5142.8 450.8 4914.2 4978.4 5050.6 5087.1 5030.4 5065.9 5084.9 5091.0 5112.4 5112.8 5115.5 5120.8 5138.6 5147.2 4896.8 4981.9 4995.8 4999.5 5021.0 5470.5 5474.7 5492.0 5513.1 5531.5 5758.0 5879.8 5887.6 5925.1 5930.8 6011.3 6015.0 6040.6 6054.2 6086.5 5629.7 5651.2 5654.3 5659.5 5670.8 5924.2 6028.8 6081.2 6177.0 6186.7 5804.2 5807.2 5812.6 5815.4 5826.8 5970.7 5976.0 5978.9 5982.3 5998.0 5937.9 5957.2 5958.6 5977.6 6020.2 5950.9 5963.6 6000.3 6044.4 6050.3 4424.4 4564.2 4582.3 4583.0 4616.6 3883.5 3977.2 3984.2 4003.5 4010.0 5601.9 5619.6 5667.9 5720.3 5727.1 5786.2 6064.3 6067.6 6074.6 6075.1 5651.2 5734.7 5753.3 5755.0 5776.4 4952.5 5000.8 5022.2 5031.4 5129.9 6034.5 6127.0 6251.5 6266.7 6281.6 6025.5 6124.2 6127.5 6132.4 6141.9 6252.1 6265.6 6278.6 6286.8 6304.7 5694.5 5796.1 5798.9 5872.4 5985.8 5940.6 5949.4 5968.3 5983.1 5986.5 5772.7 5786.6 5837.3 5843.0 5847.5 5604.5 5784.1 5813.0 5850.8 5855.2 5731.3 5759.5 5760.3 5764.1 5795.3 5896.2 5946.5 5947.5 5971.2 5972.7 5614.4 5674.9 5706.7 5725.2 5758.2 23:34:04 INFO - PROCESS | 28675 | 23:34:04 INFO - PROCESS | 28675 | [#1] ext.html Cycles:180 Average:57677.96 Median:41192.50 stddev:116357.55 (282.5%) stddev-sans-first:116604.94 23:34:04 INFO - PROCESS | 28675 | Values: 562.2 617.1 637.3 644.0 645.3 38624.4 39959.2 42964.1 43132.4 43193.6 45855.5 46064.3 46116.8 46123.0 46346.1 8900.9 9030.7 9034.2 9085.6 9099.8 8916.3 9020.3 9026.0 9038.8 9059.5 9020.3 9078.4 9080.1 9080.7 9116.1 9081.9 9082.7 9088.0 9100.3 9108.0 8908.8 9000.1 9003.5 9012.6 9017.1 34451.8 43260.8 43649.8 43717.8 43792.8 3428.3 3456.3 3536.0 3561.8 3666.7 31640.8 31715.4 31812.0 31885.8 32847.8 4243.3 4267.3 4347.5 4398.7 4432.3 283373.0 284465.0 286459.0 286548.0 287446.0 35241.0 35298.0 35325.3 35589.8 35598.0 35450.3 36278.5 36353.5 38386.8 38427.2 17619.4 17818.6 17838.6 17841.0 17873.3 12967.1 13024.0 13055.7 13075.7 13123.7 19730.6 20116.6 20117.0 20174.1 20176.6 7221.2 7271.0 7353.4 7447.3 7466.7 989.8 1029.2 1036.8 1077.4 1097.3 31145.8 32573.8 32774.5 32890.8 33113.5 1110.9 1122.2 1126.8 1139.4 1145.1 16964.9 17335.3 17490.2 17523.9 17660.5 551768.0 553737.0 554124.0 560894.0 561589.0 39712.4 59129.7 59131.4 59433.1 59658.1 1265.6 1316.5 1321.2 1339.7 1345.7 30658.7 31594.0 31952.8 32096.7 32877.5 51894.0 52428.2 52551.5 52568.7 52618.0 422499.0 427632.0 428470.0 430915.0 434201.0 27955.7 28543.9 28679.3 28837.9 28840.3 46939.3 48543.5 48628.8 48718.0 49280.3 41215.0 41540.4 41583.0 42220.4 42612.1 41170.0 41350.9 41612.0 42007.2 42419.8 40080.8 40953.6 41405.2 41421.0 41499.4 35861.0 36618.8 37039.0 37329.6 37337.0 27789.4 28216.7 28509.6 28531.6 28531.7 23:34:04 INFO - PROCESS | 28675 | 23:34:04 INFO - PROCESS | 28675 | [#2] jquery.html Cycles:180 Average:27613.74 Median:21216.98 stddev:73980.69 (348.7%) stddev-sans-first:74159.97 23:34:04 INFO - PROCESS | 28675 | Values: 380.9 381.0 385.6 396.4 403.0 16884.6 19055.0 19370.6 19395.5 19437.9 17511.3 17725.8 18095.0 18497.5 18536.0 5553.7 5694.2 5739.1 5775.6 5779.9 5510.3 5668.6 5669.5 5709.8 5711.0 5588.8 5636.4 5654.2 5685.4 5693.4 5573.5 5621.4 5683.5 5685.3 5711.4 5029.3 5060.8 5071.7 5079.0 5093.3 21508.2 21781.0 21917.5 22072.4 22102.0 2353.5 2400.7 2464.7 2515.5 2677.4 9443.1 10081.5 13934.2 14335.2 14471.5 1918.8 1942.9 1988.9 2018.3 2030.0 72951.6 79865.0 81473.6 82499.2 82910.0 10502.2 10679.9 10760.2 10995.1 11176.8 15154.9 15208.5 15299.5 15306.8 15328.2 8163.3 8223.1 8322.9 8491.9 8507.6 7967.2 8050.7 8072.6 8189.8 8296.1 4536.9 4703.8 4722.4 4772.0 4829.7 1952.7 1977.5 1991.9 1996.5 1998.7 940.9 965.2 1025.8 1029.6 1093.0 17906.2 18544.5 18546.3 18568.4 18799.2 931.9 964.7 976.5 984.0 995.5 9202.2 10468.0 10604.0 10621.9 10642.1 431973.0 443398.0 448939.0 453560.0 457999.0 89873.0 91910.5 92571.0 93530.0 93602.1 874.8 887.0 899.6 904.2 906.9 15707.8 16324.4 16564.3 16752.2 16919.2 31932.8 42031.0 43238.8 44158.1 44392.3 50705.0 54763.5 57484.0 57530.1 58462.0 7438.3 7832.1 7917.0 8420.8 8981.8 9787.6 13585.3 13843.6 13875.7 14235.0 11344.9 11536.7 11716.7 11779.0 12061.3 11495.1 11568.9 11711.6 11878.2 11950.8 11977.9 12113.9 12253.7 12450.5 12546.2 8067.6 8097.2 8153.0 8202.2 8225.6 10461.7 11547.5 11717.8 11919.2 12204.1 23:34:04 INFO - PROCESS | 28675 | 23:34:04 INFO - PROCESS | 28675 | [#3] mootools.html Cycles:180 Average:5698.74 Median:4812.82 stddev:3195.69 (66.4%) stddev-sans-first:3188.83 23:34:04 INFO - PROCESS | 28675 | Values: 1466.9 1476.3 1568.3 1714.5 1744.2 7735.8 8242.5 8311.5 8735.7 8743.9 8407.2 8655.6 8732.0 8755.9 8757.4 2237.8 2262.8 2272.2 2273.4 2280.4 2187.6 2210.8 2221.6 2229.6 2243.7 2203.3 2213.0 2219.3 2235.6 2264.6 2151.9 2164.8 2166.3 2172.3 2178.4 2129.9 2142.1 2157.3 2158.7 2164.8 8700.1 8745.7 8777.1 8792.7 8798.0 5109.3 5150.5 5185.9 5210.6 5229.2 3157.0 3292.1 3322.5 3388.4 3422.4 1120.2 1136.7 1143.3 1165.5 1181.0 11929.4 11946.4 11968.7 12039.2 12055.5 4510.1 4593.6 4612.6 4621.8 4650.7 10195.6 10199.4 10218.3 10233.0 10233.1 5177.4 5251.0 5252.0 5258.5 5262.9 4187.9 4788.7 4836.9 4862.0 4889.0 3899.1 3970.8 4027.4 4086.4 4089.2 1250.0 1302.6 1306.2 1314.7 1321.2 829.2 879.2 912.7 919.5 955.0 5816.3 5861.7 5935.6 5984.1 6446.3 972.9 987.8 1012.6 1025.4 1040.1 4134.2 4353.7 4355.6 4372.8 4378.6 10236.6 10590.1 10620.4 10629.4 10656.5 9839.7 10425.8 10427.1 10518.0 10532.6 7726.7 7934.8 8120.3 8159.7 8165.3 5763.7 5961.6 6150.3 6261.1 6293.3 9295.4 9918.3 10051.7 10136.6 10173.8 9715.7 10014.1 10014.6 10017.5 10029.4 7290.4 7755.8 7955.6 8098.4 8247.0 8099.2 8106.5 8110.9 8144.0 8166.6 7125.1 7133.1 7163.0 7399.1 7535.0 7192.2 7196.4 7366.8 7391.0 7456.8 6578.2 6671.5 6699.3 6711.0 6718.6 5143.9 5290.2 5341.4 5438.6 5481.3 5224.5 5242.9 5344.3 5386.8 5454.5 23:34:04 INFO - PROCESS | 28675 | 23:34:04 INFO - PROCESS | 28675 | [#4] prototype.html Cycles:180 Average:4854.86 Median:5554.76 stddev:1438.15 (25.9%) stddev-sans-first:1401.32 23:34:04 INFO - PROCESS | 28675 | Values: 319.4 332.7 334.0 335.9 337.9 5494.2 5625.9 5626.2 5702.4 5709.3 5538.8 5578.7 5584.9 5603.5 5613.9 4334.1 4353.5 4356.0 4376.6 4381.8 4246.7 4387.0 4393.9 4407.3 4412.1 4313.3 4320.5 4322.4 4338.7 4341.9 4352.6 4353.9 4354.4 4355.4 4357.0 3510.1 3720.6 3854.2 3879.5 3880.6 5338.9 5379.8 5420.0 5431.4 5443.2 4791.8 4801.5 4808.8 4814.4 4855.4 5668.1 5780.8 5788.6 5814.0 5815.0 4088.3 4096.4 4112.9 4115.5 4117.8 5824.3 5852.5 6075.4 6087.0 6127.0 4111.3 4119.4 4129.6 4133.0 4143.2 4188.6 4192.1 4209.0 4210.7 4218.4 4636.5 4862.6 4872.4 4883.3 4886.5 5792.4 5862.7 5871.6 5878.9 5904.3 1454.7 1463.6 1472.7 1482.2 1485.1 900.7 940.3 942.7 952.7 958.5 5046.0 5050.7 5054.2 5067.4 5081.6 5294.2 5322.0 5325.7 5338.8 5375.2 5025.2 5028.3 5051.6 5280.4 5726.2 3165.3 3181.4 3191.5 3208.0 3222.2 6034.3 6153.8 6155.4 6200.1 6203.8 6057.3 6106.7 6122.6 6150.9 6210.4 6130.0 6136.5 6157.6 6195.7 6204.2 5858.9 5947.6 5986.4 6032.7 6053.0 5849.4 5862.3 5880.3 5896.8 5936.8 5913.8 6041.5 6222.8 6228.4 6240.2 4235.2 4253.8 4261.0 4277.7 4278.0 5834.8 6022.6 6055.4 6062.9 6107.0 5857.8 5864.3 5871.9 5872.6 5884.3 5796.3 5827.9 5859.9 5899.4 5907.4 5570.7 5744.5 5749.1 5762.0 5781.7 5802.7 5822.9 5849.6 5856.4 5887.0 5648.5 5649.6 5738.8 5739.8 5786.2 23:34:04 INFO - PROCESS | 28675 | 23:34:04 INFO - PROCESS | 28675 | [#5] yui.html Cycles:180 Average:20837.09 Median:4594.69 stddev:31102.30 (676.9%) stddev-sans-first:31153.04 23:34:04 INFO - PROCESS | 28675 | Values: 768.5 772.2 774.5 799.3 823.0 14079.3 14893.8 14979.5 15006.4 15007.8 13161.1 13210.8 13285.2 13318.3 13319.4 654.7 774.1 783.8 788.8 792.7 795.5 802.3 805.6 806.8 809.2 864.3 864.8 867.3 867.5 867.9 858.1 858.3 859.2 859.9 862.3 620.1 622.5 623.7 624.1 625.5 14241.6 14242.9 14358.8 14373.9 14423.5 15524.2 15575.6 15669.3 15672.9 15737.4 12307.9 12341.6 12345.2 12569.1 12823.3 3897.2 3920.5 3933.6 3933.7 3972.3 87335.0 87346.6 89168.6 89497.0 89811.6 11040.4 11158.1 11173.7 11237.8 11255.8 18747.0 18786.9 18876.2 19025.5 19209.5 8574.1 8712.9 8727.6 8749.2 8792.0 4452.1 4530.3 4564.2 4574.1 4612.3 3472.8 3502.9 3595.6 3599.4 3607.5 598.9 605.1 607.2 610.6 612.6 669.3 692.8 709.5 728.5 732.4 9024.0 9250.3 9299.2 9356.2 9669.4 635.5 638.7 660.4 698.4 760.2 4203.4 4522.5 4582.9 4606.5 4674.5 112792.4 118652.4 120344.0 120550.0 122532.0 88864.0 97975.0 103325.2 104603.0 105718.0 56504.2 87398.6 90052.5 90161.8 90796.0 8371.5 8571.4 8620.5 8637.3 8850.2 48158.0 49026.3 49470.8 50576.0 51041.0 72315.9 76274.6 78025.0 78108.6 78230.6 12580.1 12610.1 12734.3 12773.3 13297.0 12266.3 12447.0 12508.9 12528.4 12645.6 11624.4 11695.2 11762.2 11817.0 12157.9 11711.8 12310.5 12592.4 12610.1 13091.5 12038.5 12479.4 12482.4 12944.2 13021.0 9787.3 9875.2 10196.6 10255.6 10308.5 9582.6 9748.9 10497.7 11199.6 11439.8 23:34:04 INFO - PROCESS | 28675 | -------- Summary: end -------- 23:34:04 INFO - PROCESS | 28675 | 23:34:04 INFO - TEST-INFO | 28675: exit 0 23:34:04 INFO - TEST-OK | dromaeo_css | took 1110943ms 23:34:04 INFO - TEST-START | kraken 23:34:04 INFO - operating with platform_type : linux_ 23:34:04 INFO - Initialising browser for kraken test... 23:34:04 INFO - TEST-INFO | started process 28910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMpkH8B/profile http://localhost:46786/getInfo.html) 23:34:09 INFO - PROCESS | 28910 | __metrics Screen width/height:1600/1200 23:34:09 INFO - PROCESS | 28910 | colorDepth:24 23:34:09 INFO - PROCESS | 28910 | Browser inner width/height: 1024/697 23:34:09 INFO - PROCESS | 28910 | __metrics 23:34:10 ERROR - PROCESS | 28910 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 23:34:10 INFO - TEST-INFO | 28910: exit 0 23:34:10 INFO - Browser initialized. 23:34:10 INFO - Running cycle 1/1 for kraken test... 23:34:10 INFO - TEST-INFO | started process 29033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMpkH8B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:34:23 INFO - PROCESS | 29033 | RSS: Main: 185368576 23:34:23 INFO - PROCESS | 29033 | 23:34:25 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46786/tests/kraken/driver.html?testName=audio-beat-detection) 23:34:26 INFO - PROCESS | 29033 | RSS: Main: 191000576 23:34:26 INFO - PROCESS | 29033 | 23:34:29 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46786/tests/kraken/driver.html?testName=audio-dft) 23:34:29 INFO - PROCESS | 29033 | RSS: Main: 190234624 23:34:29 INFO - PROCESS | 29033 | 23:34:32 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46786/tests/kraken/driver.html?testName=audio-fft) 23:34:33 INFO - PROCESS | 29033 | RSS: Main: 185536512 23:34:33 INFO - PROCESS | 29033 | 23:34:35 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46786/tests/kraken/driver.html?testName=audio-oscillator) 23:34:36 INFO - PROCESS | 29033 | RSS: Main: 185892864 23:34:36 INFO - PROCESS | 29033 | 23:34:38 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:34:39 INFO - PROCESS | 29033 | RSS: Main: 186486784 23:34:39 INFO - PROCESS | 29033 | 23:34:42 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46786/tests/kraken/driver.html?testName=imaging-darkroom) 23:34:42 INFO - PROCESS | 29033 | RSS: Main: 187162624 23:34:42 INFO - PROCESS | 29033 | 23:34:46 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46786/tests/kraken/driver.html?testName=imaging-desaturate) 23:34:46 INFO - PROCESS | 29033 | RSS: Main: 184582144 23:34:46 INFO - PROCESS | 29033 | 23:34:49 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46786/tests/kraken/driver.html?testName=json-parse-financial) 23:34:50 INFO - PROCESS | 29033 | RSS: Main: 185200640 23:34:50 INFO - PROCESS | 29033 | 23:34:51 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:34:52 INFO - PROCESS | 29033 | RSS: Main: 185864192 23:34:52 INFO - PROCESS | 29033 | 23:34:54 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46786/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:34:54 INFO - PROCESS | 29033 | RSS: Main: 186302464 23:34:54 INFO - PROCESS | 29033 | 23:34:57 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:34:57 INFO - PROCESS | 29033 | RSS: Main: 186900480 23:34:57 INFO - PROCESS | 29033 | 23:35:00 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:35:01 INFO - PROCESS | 29033 | RSS: Main: 187174912 23:35:01 INFO - PROCESS | 29033 | 23:35:03 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:35:04 INFO - PROCESS | 29033 | RSS: Main: 186781696 23:35:04 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | Cycle 1(1): loaded http://localhost:46786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46786/tests/kraken/driver.html?testName=ai-astar) 23:35:06 INFO - PROCESS | 29033 | RSS: Main: 187637760 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | __start_tp_report 23:35:06 INFO - PROCESS | 29033 | _x_x_mozilla_page_load 23:35:06 INFO - PROCESS | 29033 | _x_x_mozilla_page_load_details 23:35:06 INFO - PROCESS | 29033 | |i|pagename|runs| 23:35:06 INFO - PROCESS | 29033 | |0;ai-astar;113;109;113;111;111;113;113;112;110;111 23:35:06 INFO - PROCESS | 29033 | |1;audio-beat-detection;154;125;158;181;127;153;159;128;191;128 23:35:06 INFO - PROCESS | 29033 | |2;audio-dft;164;164;166;167;181;163;164;163;165;165 23:35:06 INFO - PROCESS | 29033 | |3;audio-fft;76;77;76;162;76;75;75;75;161;74 23:35:06 INFO - PROCESS | 29033 | |4;audio-oscillator;85;87;154;86;86;86;144;86;85;141 23:35:06 INFO - PROCESS | 29033 | |5;imaging-gaussian-blur;118;118;118;119;117;117;118;118;119;119 23:35:06 INFO - PROCESS | 29033 | |6;imaging-darkroom;149;148;148;147;147;148;148;148;147;148 23:35:06 INFO - PROCESS | 29033 | |7;imaging-desaturate;95;96;96;96;96;96;96;97;96;96 23:35:06 INFO - PROCESS | 29033 | |8;json-parse-financial;56;55;56;54;58;59;55;56;55;57 23:35:06 INFO - PROCESS | 29033 | |9;json-stringify-tinderbox;64;63;63;63;63;63;63;62;63;63 23:35:06 INFO - PROCESS | 29033 | |10;stanford-crypto-aes;79;78;81;86;81;82;86;81;116;88 23:35:06 INFO - PROCESS | 29033 | |11;stanford-crypto-ccm;126;132;131;140;124;137;143;138;131;138 23:35:06 INFO - PROCESS | 29033 | |12;stanford-crypto-pbkdf2;170;164;159;158;165;164;159;161;158;163 23:35:06 INFO - PROCESS | 29033 | |13;stanford-crypto-sha256-iterative;64;66;63;66;67;65;62;63;64;63 23:35:06 INFO - PROCESS | 29033 | __end_tp_report 23:35:06 INFO - PROCESS | 29033 | __start_cc_report 23:35:06 INFO - PROCESS | 29033 | _x_x_mozilla_cycle_collect,941 23:35:06 INFO - PROCESS | 29033 | __end_cc_report 23:35:06 INFO - PROCESS | 29033 | __startTimestamp1466490906296__endTimestamp 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | ------- Summary: start ------- 23:35:06 INFO - PROCESS | 29033 | Number of tests: 14 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:1.43 (1.3%) stddev-sans-first:1.42 23:35:06 INFO - PROCESS | 29033 | Values: 113.0 109.0 113.0 111.0 111.0 113.0 113.0 112.0 110.0 111.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:156.00 stddev:23.41 (15.0%) stddev-sans-first:24.79 23:35:06 INFO - PROCESS | 29033 | Values: 154.0 125.0 158.0 181.0 127.0 153.0 159.0 128.0 191.0 128.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#2] audio-dft Cycles:10 Average:166.20 Median:165.00 stddev:5.35 (3.2%) stddev-sans-first:5.61 23:35:06 INFO - PROCESS | 29033 | Values: 164.0 164.0 166.0 167.0 181.0 163.0 164.0 163.0 165.0 165.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.50 stddev:36.27 (48.0%) stddev-sans-first:37.96 23:35:06 INFO - PROCESS | 29033 | Values: 76.0 77.0 76.0 162.0 76.0 75.0 75.0 75.0 161.0 74.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:86.00 stddev:29.39 (34.2%) stddev-sans-first:30.36 23:35:06 INFO - PROCESS | 29033 | Values: 85.0 87.0 154.0 86.0 86.0 86.0 144.0 86.0 85.0 141.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 23:35:06 INFO - PROCESS | 29033 | Values: 118.0 118.0 118.0 119.0 117.0 117.0 118.0 118.0 119.0 119.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 23:35:06 INFO - PROCESS | 29033 | Values: 149.0 148.0 148.0 147.0 147.0 148.0 148.0 148.0 147.0 148.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 23:35:06 INFO - PROCESS | 29033 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.52 (2.7%) stddev-sans-first:1.62 23:35:06 INFO - PROCESS | 29033 | Values: 56.0 55.0 56.0 54.0 58.0 59.0 55.0 56.0 55.0 57.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 23:35:06 INFO - PROCESS | 29033 | Values: 64.0 63.0 63.0 63.0 63.0 63.0 63.0 62.0 63.0 63.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:81.50 stddev:11.09 (13.6%) stddev-sans-first:11.49 23:35:06 INFO - PROCESS | 29033 | Values: 79.0 78.0 81.0 86.0 81.0 82.0 86.0 81.0 116.0 88.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:137.50 stddev:6.18 (4.5%) stddev-sans-first:5.84 23:35:06 INFO - PROCESS | 29033 | Values: 126.0 132.0 131.0 140.0 124.0 137.0 143.0 138.0 131.0 138.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:163.50 stddev:3.84 (2.4%) stddev-sans-first:2.82 23:35:06 INFO - PROCESS | 29033 | Values: 170.0 164.0 159.0 158.0 165.0 164.0 159.0 161.0 158.0 163.0 23:35:06 INFO - PROCESS | 29033 | 23:35:06 INFO - PROCESS | 29033 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:1.64 (2.5%) stddev-sans-first:1.73 23:35:06 INFO - PROCESS | 29033 | Values: 64.0 66.0 63.0 66.0 67.0 65.0 62.0 63.0 64.0 63.0 23:35:06 INFO - PROCESS | 29033 | -------- Summary: end -------- 23:35:06 INFO - PROCESS | 29033 | 23:35:07 INFO - TEST-INFO | 29033: exit 0 23:35:07 INFO - TEST-OK | kraken | took 62542ms 23:35:07 INFO - SUITE-END | took 1173s 23:35:07 INFO - Completed test suite (00:19:33) 23:35:07 INFO - javascript benchmark 23:35:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7242.511043791977, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.9847050764743, 3088.3514461962986, 3112.891048813292, 3143.3084721361292, 3151.3854798314337, 5431.565474762019, 5432.402435732076, 5451.127819548873, 5463.508284254416, 5511.22842802007, 5325.547328477084, 5428.294321738178, 5470.9452905470935, 5471.151971444432, 5601.047821870282, 4899.461059283476, 4961.603071754251, 5063.088644044071, 5089.745512724349, 5142.845714628567, 450.75969175565854, 4914.189158788796, 4978.352814134158, 5050.646454748169, 5087.109755792721, 5030.421501527335, 5065.873353166164, 5084.898302033976, 5090.9745451272875, 5112.412072611642, 5112.795488180468, 5115.488451154892, 5120.820771272987, 5138.614603904722, 5147.202183661539, 4896.755162241873, 4981.9252711209365, 4995.800167993276, 4999.500049995007, 5021.0, 5470.452954704498, 5474.698891560963, 5492.038893193675, 5513.062779327524, 5531.529819965308, 5758.0, 5879.7648094076185, 5887.5584331174905, 5925.140854576062, 5930.762769489215, 6011.3086994995265, 6015.037593984942, 6040.607360521552, 6054.152418661391, 6086.482648974842, 5629.690367029812, 5651.208830763697, 5654.321481422215, 5659.490645841853, 5670.801521946753, 5924.229850119457, 6028.849278767978, 6081.209442772411, 6177.042558403455, 6186.721597528122, 5804.158397032406, 5807.157962095473, 5812.622179558315, 5815.447532484407, 5826.766929322865, 5970.701464926737, 5976.043832986701, 5978.880422391528, 5982.312034116046, 5998.040313549811, 5937.851553711105, 5957.165996760457, 5958.6424814511265, 5977.6114552553945, 6020.217371741734, 5950.9107363389585, 5963.5825492216, 6000.279966404059, 6044.365341639153, 6050.30421501533, 4424.446944131983, 4564.246899261651, 4582.2668373060815, 4582.9541704582525, 4616.561426664462, 3883.514560679915, 3977.204559088194, 3984.183242435352, 4003.53959294679, 4009.959900401017, 5601.915971260434, 5619.578531610146, 5667.943320566824, 5720.313562372542, 5727.140928860705, 5786.218860453869, 6064.272287325461, 6067.575269731076, 6074.635521868702, 6075.088736689444, 5651.152327150878, 5734.655920644775, 5753.309602847685, 5755.0, 5776.364599894008, 4952.455229924705, 5000.849974500771, 5022.196448568212, 5031.4465408805, 5129.9230511542355, 6034.547408944347, 6126.975740326312, 6251.468625166912, 6266.749330026839, 6281.59169653971, 6025.517958563392, 6124.229237387393, 6127.494965205145, 6132.447291485866, 6141.9078713818435, 6252.124702541557, 6265.561410701207, 6278.591891527036, 6286.811395658137, 6304.71628776697, 5694.4590263924865, 5796.072628379439, 5798.884022319615, 5872.383399742966, 5985.820425387245, 5940.55445841555, 5949.3753155918, 5968.253968253968, 5983.102534619842, 5986.491148252273, 5772.682502462405, 5786.594938354275, 5837.29952405714, 5842.970785146047, 5847.502962248086, 5604.467575580314, 5784.074548072288, 5813.04084825999, 5850.824475265749, 5855.180274761452, 5731.283589551306, 5759.51044161251, 5760.279965004374, 5764.135379692912, 5795.304563452412, 5896.233489646319, 5946.464818166386, 5947.494462970523, 5971.193888824953, 5972.731227094878, 5614.382417934105, 5674.858128546819, 5706.714664266853, 5725.19847221381, 5758.193852860519], "value": 5449.447360374834, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.2465895699761, 617.1236843681971, 637.2607774981022, 643.9645819479928, 645.2772894358319, 38624.42063369052, 39959.20081598366, 42964.14071718571, 43132.353014704764, 43193.56806431935, 45855.54144458554, 46064.309035364495, 46116.76941615296, 46122.99999999991, 46346.07307853841, 8900.8664870027, 9030.729078127666, 9034.186923176912, 9085.591148398305, 9099.772505687344, 8916.286697064252, 9020.2783777298, 9026.0, 9038.819223615525, 9059.547022648874, 9020.2783777298, 9078.364514483988, 9080.137386948229, 9080.682176123837, 9116.088391160898, 9081.863772043425, 9082.682106126254, 9088.0, 9100.317476189311, 9108.043655416186, 8908.821823563492, 9000.144986226298, 9003.5048072356, 9012.63949442028, 9017.053209413049, 34451.82774086139, 43260.783696081635, 43649.78175109104, 43717.78141109274, 43792.78103609494, 3428.297199074184, 3456.3260164267977, 3535.964640353615, 3561.7684850484634, 3666.7066634669163, 31640.841795791104, 31715.36569268625, 31812.0, 31885.84057079723, 32847.83576082128, 4243.299855523835, 4267.295896177127, 4347.478302603676, 4398.690687389147, 4432.312991486325, 283373.0, 284465.0, 286459.0, 286548.0, 287446.0, 35241.0, 35298.0, 35325.293494129975, 35589.8220508901, 35598.0, 35450.29099417997, 36278.45582316215, 36353.45469817955, 38386.80806596005, 38427.23145537129, 17619.383321583682, 17818.5545361367, 17838.643227135384, 17841.0, 17873.28506859711, 12967.092303538662, 13024.0, 13055.673608159683, 13075.738485230433, 13123.671908202372, 19730.605387892163, 20116.597668046557, 20117.0, 20174.092165852573, 20176.596468070555, 7221.205667376585, 7271.0, 7353.411727061929, 7447.292507211806, 7466.664000120008, 989.8020395920701, 1029.2229366827996, 1036.8341065429495, 1077.380506208933, 1097.286763603648, 31145.844270778955, 32573.837130814194, 32774.50838237381, 32890.8355458226, 33113.50329745056, 1110.9277896936674, 1122.1976286954866, 1126.8028095083491, 1139.4416735799564, 1145.0724912820476, 16964.915175424045, 17335.306587736603, 17490.19059695091, 17523.912380438018, 17660.470185894443, 551768.0, 553737.0, 554124.0, 560894.0, 561589.0, 39712.404313935316, 59129.704351477965, 59131.40868591259, 59433.10850337248, 59658.10512842311, 1265.5886836778084, 1316.5194703933187, 1321.1808678619318, 1339.6650837290676, 1345.7106722054805, 30658.693413065583, 31594.0, 31952.84023579867, 32096.704043832506, 32877.50683739698, 51894.0, 52428.21357679561, 52551.47448525466, 52568.737156313975, 52618.0, 422499.0, 427632.0, 428470.0, 430915.0, 434201.0, 27955.720442796126, 28543.857280713462, 28679.283017924718, 28837.855810720812, 28840.278993025342, 46939.295910560686, 48543.5145648539, 48628.75685621549, 48718.0, 49280.260796088805, 41215.0, 41540.376894346, 41583.0, 42220.36669449899, 42612.14775704406, 41170.0, 41350.8954384637, 41612.0, 42007.1598568033, 42419.7879010603, 40080.79959600183, 40953.59046409498, 41405.171896562504, 41421.0, 41499.37750933799, 35861.0, 36618.81690591636, 37039.0, 37329.62670373262, 37337.0, 27789.444211116068, 28216.71783282141, 28509.572356415087, 28531.572026420035, 28531.714682852904], "value": 19673.073819148718, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.8838304317182, 380.97714137151763, 385.57779231741245, 396.36977206242085, 402.9657479114275, 16884.57788555285, 19055.0, 19370.612587748255, 19395.515112122204, 19437.902810485928, 17511.299548018094, 17725.82274177258, 18095.0, 18497.537561560966, 18536.0, 5553.7223138843, 5694.202811606378, 5739.110437882114, 5775.5957083004205, 5779.884402311951, 5510.256115424427, 5668.57485688573, 5669.489745922866, 5709.800156994506, 5711.029125048752, 5588.776448942038, 5636.436356364372, 5654.208410822488, 5685.431456854323, 5693.373728889819, 5573.498385145336, 5621.381648018735, 5683.460071293221, 5685.346185188673, 5711.400302968191, 5029.270755740434, 5060.7722652480725, 5071.7210553419545, 5078.974605126988, 5093.337866077386, 21508.247211347683, 21781.0, 21917.452063698376, 22072.44818879541, 22102.0054097566, 2353.51752890657, 2400.687910571632, 2464.653517193217, 2515.5346260941783, 2677.3975855432373, 9443.102905223992, 10081.495925203784, 13934.163950163023, 14335.211563364011, 14471.493497727633, 1918.8177123173277, 1942.9125689344014, 1988.9104990275328, 2018.2734215682342, 2029.954573394703, 72951.63524182398, 79865.0, 81473.59263203705, 82499.17500824975, 82910.0, 10502.21462351402, 10679.893201068046, 10760.192985526117, 10995.065419439437, 11176.832347514794, 15154.924225378803, 15208.543743687707, 15299.541013769382, 15306.846931530765, 15328.156951367559, 8163.346932245406, 8223.136570660114, 8322.916770832335, 8491.915080849236, 8507.61715722794, 7967.163447837894, 8050.718224862102, 8072.556009419421, 8189.754307370788, 8296.087430382653, 4536.909261814745, 4703.811847526061, 4722.386089808371, 4772.0, 4829.6860704054125, 1952.7168560558923, 1977.5352792093847, 1991.9343151413923, 1996.4609555419954, 1998.6802111662064, 940.8823897012874, 965.1554889471712, 1025.8453264279638, 1029.6344797596746, 1092.9672109836717, 17906.194221260073, 18544.536386590444, 18546.258149674133, 18568.44294671162, 18799.248030078918, 931.9254459643212, 964.6816550538306, 976.5068640336584, 983.9852402213829, 995.4674249276602, 9202.171804537624, 10468.0, 10603.992620701021, 10621.946890265499, 10642.095421889071, 431973.0, 443398.0, 448939.0, 453560.0, 457999.0, 89873.0, 91910.54044729733, 92571.0, 93530.0, 93602.06397935933, 874.8337815814975, 886.9911300887038, 899.5996781432331, 904.1681652879366, 906.886639170117, 15707.842921570638, 16324.428644997368, 16564.254608542884, 16752.246148923085, 16919.154042298083, 31932.840335798173, 42031.0, 43238.78380608203, 44158.11683766243, 44392.33411498766, 50705.0, 54763.45236547743, 57484.0, 57530.13704794515, 58462.0, 7438.256174382518, 7832.099308579586, 7916.9604151981175, 8420.789480263042, 8981.775455613662, 9787.559559819683, 13585.252811095485, 13843.584692459242, 13875.653108672364, 14235.0, 11344.9432752839, 11536.653900383002, 11716.70708232301, 11779.0, 12061.336626485627, 11495.137864660017, 11568.884311157117, 11711.648650540157, 11878.227915185485, 11950.820737689115, 11977.940110299742, 12113.878861211275, 12253.693657658274, 12450.501979920702, 12546.247225166519, 8067.636956337096, 8097.2307630774985, 8153.0, 8202.220789025034, 8225.629846657035, 10461.738456538647, 11547.480363383836, 11717.824232636687, 11919.225250359046, 12204.145709800583], "value": 9104.337651395597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.9193194374304, 1476.3135142158897, 1568.2550788375522, 1714.4599451172887, 1744.1802352894142, 7735.806604834868, 8242.546659933701, 8311.459755115928, 8735.694250701219, 8743.868841967367, 8407.159284071606, 8655.567221638908, 8732.039475657673, 8755.86866197006, 8757.386982911199, 2237.7874101960288, 2262.8189744820456, 2272.227442669492, 2273.3748219239674, 2280.361498780344, 2187.562487502498, 2210.7568167501563, 2221.6445368741006, 2229.576380487702, 2243.719535058118, 2203.327984964585, 2212.9557408851815, 2219.34529313852, 2235.61994460942, 2264.5810525052834, 2151.8924053797246, 2164.751053628829, 2166.3392665237097, 2172.3265787605815, 2178.3900507857825, 2129.9254526091668, 2142.1324363632752, 2157.2773121004484, 2158.686990386401, 2164.826813854904, 8700.129987001312, 8745.693900713444, 8777.122287771235, 8792.736217913473, 8798.0, 5109.335786347789, 5150.510701483353, 5185.948140518584, 5210.557102646279, 5229.189475631283, 3156.9684303157132, 3292.1275861896615, 3322.5016247562817, 3388.40702876998, 3422.401079811023, 1120.1878637987395, 1136.7101389145798, 1143.279733767721, 1165.4930105404176, 1180.9527618895233, 11929.403529823561, 11946.402679865972, 11968.70078248042, 12039.157258991874, 12055.517779288906, 4510.075434535912, 4593.63250939924, 4612.561806628365, 4621.815127394867, 4650.697704649187, 10195.643152489776, 10199.439030853226, 10218.284720069672, 10233.0, 10233.130183934449, 5177.404598471148, 5251.028559716465, 5252.002119597264, 5258.5267325940085, 5262.947370526323, 4187.853425130106, 4788.712677239377, 4836.927446088312, 4861.95138048615, 4888.95111048885, 3899.1226973931207, 3970.781607011584, 4027.4160246764054, 4086.366613174963, 4089.1821635672986, 1250.0249805151996, 1302.5642049367743, 1306.203216038216, 1314.7304802515462, 1321.154461144868, 829.1915382502133, 879.2262808728278, 912.7307444303947, 919.4758987377264, 955.0, 5816.302043754777, 5861.70691465425, 5935.643861368331, 5984.132300816357, 6446.290908000116, 972.863799068131, 987.7876256604865, 1012.6000229909145, 1025.374521541859, 1040.0795296162798, 4134.214499245134, 4353.651707863363, 4355.60799528044, 4372.825086996484, 4378.584034516716, 10236.590536378462, 10590.099841513404, 10620.362778233331, 10629.362238265574, 10656.520456579472, 9839.704808855746, 10425.791484170275, 10427.061564459234, 10518.0, 10532.631357902437, 7726.7295644653295, 7934.761957141295, 8120.26917577409, 8159.673613055411, 8165.346772258205, 5763.7118144093465, 5961.642301461753, 6150.323464419, 6261.072075479216, 6293.307736149111, 9295.442273463614, 9918.256130790363, 10051.69844904654, 10136.594536218468, 10173.796524069328, 9715.70852874415, 10014.098731114234, 10014.64948726791, 10017.499125043865, 10029.448380339152, 7290.416766658761, 7755.806104847424, 7955.602219888867, 8098.392620553364, 8246.958765206376, 8099.230573095547, 8106.47307924983, 8110.878336824834, 8143.959280203561, 8166.550839703873, 7125.1093613298335, 7133.072700548895, 7163.0, 7399.149097853816, 7534.962325188339, 7192.2088570258275, 7196.424286056998, 7366.765717007068, 7391.0, 7456.7762967111075, 6578.177727784027, 6671.499637527302, 6699.263081061177, 6710.966445167743, 6718.596884186769, 5143.92284115731, 5290.206469029677, 5341.359036915595, 5438.6192966493545, 5481.260029895913, 5224.50367215114, 5242.895142097061, 5344.305240318734, 5386.8383948481605, 5454.4545545445135], "value": 4577.284976285977, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.3724331688232, 332.66234771706706, 333.9949900751489, 335.93785149747316, 337.9020084175588, 5494.203340515628, 5625.859353516164, 5626.21233027376, 5702.372738998707, 5709.286339207599, 5538.833834984957, 5578.693171875555, 5584.86037849054, 5603.495685388314, 5613.887722245553, 4334.089841133366, 4353.542877997804, 4355.978220108895, 4376.5623437656295, 4381.846635367763, 4246.686637391784, 4387.0, 4393.85759702478, 4407.250767369539, 4412.1175764847, 4313.28830742927, 4320.481542214939, 4322.373255877896, 4338.674599405057, 4341.869743907688, 4352.608265256111, 4353.912921741579, 4354.390385346054, 4355.36847157162, 4357.0196705740955, 3510.1049232445816, 3720.572134204574, 3854.2484215577974, 3879.534455865286, 3880.641775378623, 5338.893222135535, 5379.838604841861, 5420.0, 5431.402545719968, 5443.1835224716215, 4791.784369703371, 4801.4718380978065, 4808.759562021885, 4814.374131362935, 4855.44162421319, 5668.064769313059, 5780.797672081457, 5788.565857560699, 5813.959298287692, 5814.982378083819, 4088.2641124597562, 4096.40602112692, 4112.88951982966, 4115.54728979812, 4117.7881252623, 5824.330202026778, 5852.531797456193, 6075.392460753934, 6086.969565152191, 6126.969365153146, 4111.259973204852, 4119.402686610425, 4129.587041295847, 4132.958670413317, 4143.1713657268665, 4188.560201178893, 4192.098698779777, 4208.9789551052045, 4210.726302790309, 4218.430511880857, 4636.4899861015265, 4862.586680132157, 4872.439669437989, 4883.34074899891, 4886.486918873467, 5792.362840087587, 5862.70686465675, 5871.588988770745, 5878.853028674317, 5904.261967254093, 1454.69451415204, 1463.604826696786, 1472.6686495538631, 1482.2366481262159, 1485.0990731863233, 900.6532484993324, 940.3323640215524, 942.6794889737522, 952.7379970508027, 958.5446912716543, 5046.041252162077, 5050.651447077127, 5054.231019143271, 5067.417247016567, 5081.59347252219, 5294.152935530296, 5322.0, 5325.733713314319, 5338.839834804962, 5375.19372094189, 5025.221090730943, 5028.346314979102, 5051.595872330205, 5280.3663560373, 5726.169705392695, 3165.3036332006923, 3181.3796309719382, 3191.457452233126, 3207.9839600801847, 3222.2105584132037, 6034.25441424151, 6153.815385538441, 6155.353687862799, 6200.139958012668, 6203.8138855833495, 6057.273127224761, 6106.6946652668075, 6122.571420000557, 6150.938490615036, 6210.378962103753, 6129.969350153221, 6136.539759518054, 6157.568970172045, 6195.721192546346, 6204.193454850841, 5858.916100521417, 5947.613405128653, 5986.401359864153, 6032.6983650818165, 6052.969735151296, 5849.385814489588, 5862.296524417097, 5880.294364676266, 5896.823095307148, 5936.762529498945, 5913.822585322448, 6041.456268935817, 6222.81331560054, 6228.408301211378, 6240.219972503437, 4235.23765722173, 4253.787310634394, 4260.998665313711, 4277.657787377065, 4278.0374415756205, 5834.761707252346, 6022.5784195105925, 6055.394460553909, 6062.878742425039, 6106.969465152823, 5857.765689372377, 5864.266966629171, 5871.882562348815, 5872.618279811799, 5884.32330282023, 5796.275465566804, 5827.912581311199, 5859.882802343844, 5899.351071382231, 5907.40925907423, 5570.693611851387, 5744.4829965303325, 5749.108888122348, 5762.049261871744, 5781.653100813965, 5802.738876750472, 5822.912656310074, 5849.590528663123, 5856.4143585641095, 5887.027051339218, 5648.491635752637, 5649.6327738696855, 5738.84793202549, 5739.827805165852, 5786.161006653927], "value": 4390.311074933561, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.4851149729681, 772.1622040086506, 774.4617490843863, 799.3046049936556, 822.9506229626223, 14079.296035198238, 14893.776593351095, 14979.47571834986, 15006.39974401024, 15007.849921500781, 13161.144525605829, 13210.801837972438, 13285.202887826737, 13318.267495287755, 13319.400626971785, 654.653033892038, 774.0904437286181, 783.75703531905, 788.8146285622875, 792.6670798264743, 795.4829360915422, 802.3180296747747, 805.6334367862638, 806.8103995561039, 809.1988930958338, 864.2783275964578, 864.8400045991481, 867.2758246863876, 867.453504292295, 867.8611422172454, 858.0947100808644, 858.3176374782063, 859.2395729779128, 859.9355048371334, 862.2541501601132, 620.1472974659843, 622.5175488996019, 623.7130919776909, 624.1480379282247, 625.4714766022704, 14241.572752817432, 14242.928785356007, 14358.784618230735, 14373.85626143746, 14423.49517766873, 15524.223788810627, 15575.610609734735, 15669.294881730235, 15672.92163539175, 15737.449189278435, 12307.93846030773, 12341.587345954762, 12345.19756215852, 12569.057320700984, 12823.294718790463, 3897.1815918657117, 3920.490336256297, 3933.6263055009726, 3933.7049721270732, 3972.2651309507833, 87335.0, 87346.56326718326, 89168.55415722945, 89497.0, 89811.55094224487, 11040.392778397105, 11158.10735141203, 11173.664790056311, 11237.831432528355, 11255.774884502263, 18747.0, 18786.906065469586, 18876.24495020184, 19025.524361890788, 19209.51976200606, 8574.099719529484, 8712.869306960401, 8727.60725767342, 8749.16882896124, 8791.956040219759, 4452.109578084396, 4530.29780384041, 4564.1556312082375, 4574.062317224961, 4612.285095810154, 3472.7569070164845, 3502.9299414011575, 3595.6224596417, 3599.4420864766003, 3607.47691584724, 598.8706726884222, 605.0893405424807, 607.1590846677384, 610.5512448350547, 612.5803824380314, 669.3406994110796, 692.757534862794, 709.4785332780402, 728.4682182007165, 732.3957734868754, 9024.0, 9250.259979201648, 9299.163075323253, 9356.204722598519, 9669.371490853073, 635.4725577770439, 638.7381173718846, 660.359451332207, 698.4307789151926, 760.2359628573248, 4203.43253660758, 4522.4573051234065, 4582.890077563493, 4606.482056376506, 4674.509176536415, 112792.43603781928, 118652.40673796576, 120344.0, 120550.0, 122532.0, 88864.0, 97975.0, 103325.21735652404, 104603.0, 105718.0, 56504.15243771347, 87398.56300718455, 90052.5497372509, 90161.82815319848, 90796.0, 8371.497710137412, 8571.357148213785, 8620.5258710769, 8637.265832404317, 8850.20348168668, 48158.0, 49026.264606031655, 49470.752646236535, 50576.0, 51041.0, 72315.85315248262, 76274.61862690651, 78025.0, 78108.60945695236, 78230.6088469554, 12580.119391642864, 12610.117291789487, 12734.299613521345, 12773.297468639314, 13297.0, 12266.32535210572, 12447.013870923036, 12508.937455312665, 12528.414015104618, 12645.557405490763, 11624.418779061183, 11695.181337306647, 11762.23545469576, 11817.0, 12157.939210303892, 11711.824322635337, 12310.507579696712, 12592.433340499516, 12610.095606083414, 13091.476340946256, 12038.518459261531, 12479.376031198222, 12482.375881205722, 12944.15862968904, 13021.027098617344, 9787.265955053257, 9875.20998320147, 10196.557148457454, 10255.58977640886, 10308.536115874953, 9582.568784404857, 9748.853767193355, 10497.685069447929, 11199.552017919192, 11439.771204576029], "value": 7357.261758559909, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 113.0, 111.0, 111.0, 113.0, 113.0, 112.0, 110.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 158.0, 181.0, 127.0, 153.0, 159.0, 128.0, 191.0, 128.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 166.0, 167.0, 181.0, 163.0, 164.0, 163.0, 165.0, 165.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 162.0, 76.0, 75.0, 75.0, 75.0, 161.0, 74.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 154.0, 86.0, 86.0, 86.0, 144.0, 86.0, 85.0, 141.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 118.0, 118.0, 119.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 54.0, 58.0, 59.0, 55.0, 56.0, 55.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 81.0, 86.0, 81.0, 82.0, 86.0, 81.0, 116.0, 88.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 132.0, 131.0, 140.0, 124.0, 137.0, 143.0, 138.0, 131.0, 138.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 164.0, 159.0, 158.0, 165.0, 164.0, 159.0, 161.0, 158.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 63.0, 66.0, 67.0, 65.0, 62.0, 63.0, 64.0, 63.0], "value": 64.3, "unit": "score"}]}]} 23:35:07 INFO - Return code: 0 23:35:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:35:07 ERROR - # TBPL SUCCESS # 23:35:07 INFO - Running post-action listener: _resource_record_post_action 23:35:07 INFO - ##### 23:35:07 INFO - ##### Finished run-tests step (success) 23:35:07 INFO - ##### 23:35:07 INFO - Running post-run listener: _resource_record_post_run 23:35:07 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 20480; Write bytes: 566026240; Read time: 432; Write time: 403128 23:35:07 INFO - TinderboxPrint: CPU usage
13.5% 23:35:07 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 432 23:35:07 INFO - TinderboxPrint: I/O write bytes / time
566,026,240 / 403,128 23:35:07 INFO - TinderboxPrint: CPU idle
8,223.8 (86.5%) 23:35:07 INFO - TinderboxPrint: CPU user
1,225.0 (12.9%) 23:35:07 INFO - TinderboxPrint: Swap in / out
0 / 0 23:35:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 209276928; Read time: 180; Write time: 202324 23:35:07 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 16384; Write bytes: 294043648; Read time: 252; Write time: 173428 23:35:08 INFO - Running post-run listener: _upload_blobber_files 23:35:08 INFO - Blob upload gear active. 23:35:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:35:08 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 23:35:08 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'] 23:35:08 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 23:35:08 INFO - (blobuploader) - INFO - Open directory for files ... 23:35:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:35:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:35:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:35:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:35:12 INFO - (blobuploader) - INFO - Done attempting. 23:35:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:35:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:35:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:35:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:35:13 INFO - (blobuploader) - INFO - Done attempting. 23:35:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:35:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:35:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:35:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:35:14 INFO - (blobuploader) - INFO - Done attempting. 23:35:14 INFO - (blobuploader) - INFO - Iteration through files over. 23:35:14 INFO - Return code: 0 23:35:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:35:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:35:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b748dec8b9918f2ca520a6aff0282b68d5e14522b898179ec3ce72d4db2f9222b45004844b96e0cc434beb7d7a40499bc18523e4eceb2b93445539d6f05a1001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94a68c24b0c7f0896b7ad95b93ce88c234cb3acc03c44d8948f2696521ca07d9d34cf3793a1e1ac3852c6d4f512d837769fbb8d41b73b1b7a28dbdb93a12872a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0176b08625b7e02b3310d1476c7bdc1092858cb4cf84e7a69a264684c3afbb19e92942ed9feda55ceb76b7fed874a75b37c9f03e199698a0f761892bdebe8788"} 23:35:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:35:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:35:14 INFO - Contents: 23:35:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b748dec8b9918f2ca520a6aff0282b68d5e14522b898179ec3ce72d4db2f9222b45004844b96e0cc434beb7d7a40499bc18523e4eceb2b93445539d6f05a1001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94a68c24b0c7f0896b7ad95b93ce88c234cb3acc03c44d8948f2696521ca07d9d34cf3793a1e1ac3852c6d4f512d837769fbb8d41b73b1b7a28dbdb93a12872a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0176b08625b7e02b3310d1476c7bdc1092858cb4cf84e7a69a264684c3afbb19e92942ed9feda55ceb76b7fed874a75b37c9f03e199698a0f761892bdebe8788"} 23:35:14 INFO - Running post-run listener: copy_logs_to_upload_dir 23:35:14 INFO - Copying logs to upload dir... 23:35:14 INFO - mkdir: /builds/slave/test/build/upload/logs 23:35:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.478659 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-20 23:35:13.649198) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 23:35:13.652825) ========= 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=0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034 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/b748dec8b9918f2ca520a6aff0282b68d5e14522b898179ec3ce72d4db2f9222b45004844b96e0cc434beb7d7a40499bc18523e4eceb2b93445539d6f05a1001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94a68c24b0c7f0896b7ad95b93ce88c234cb3acc03c44d8948f2696521ca07d9d34cf3793a1e1ac3852c6d4f512d837769fbb8d41b73b1b7a28dbdb93a12872a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0176b08625b7e02b3310d1476c7bdc1092858cb4cf84e7a69a264684c3afbb19e92942ed9feda55ceb76b7fed874a75b37c9f03e199698a0f761892bdebe8788"} build_url:https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011454 build_url: 'https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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/b748dec8b9918f2ca520a6aff0282b68d5e14522b898179ec3ce72d4db2f9222b45004844b96e0cc434beb7d7a40499bc18523e4eceb2b93445539d6f05a1001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94a68c24b0c7f0896b7ad95b93ce88c234cb3acc03c44d8948f2696521ca07d9d34cf3793a1e1ac3852c6d4f512d837769fbb8d41b73b1b7a28dbdb93a12872a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0176b08625b7e02b3310d1476c7bdc1092858cb4cf84e7a69a264684c3afbb19e92942ed9feda55ceb76b7fed874a75b37c9f03e199698a0f761892bdebe8788"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 23:35:13.677510) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:35:13.677789) ========= 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=0e2a256762fed810e2f0f810000001b3-1466488508.118824-1958917034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:35:13.760066) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 23:35:13.760369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 23:35:13.760666) ========= ========= Total master_lag: 0.16 =========