builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1465517982.29 results: success (0) buildid: 20160609143002 builduid: 62633a00d7bc48198a66f6b64e9cc4e4 revision: f48fbe4116507315b13ddf3e1861d74c15d72550 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:42.292535) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:42.293022) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:42.293326) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:42.307653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:42.307948) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 17:19:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.9M=0s 2016-06-09 17:19:42 (88.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135155 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:42.457091) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:42.457432) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017906 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:42.508027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 17:19:42.508612) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f48fbe4116507315b13ddf3e1861d74c15d72550 --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 f48fbe4116507315b13ddf3e1861d74c15d72550 --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=78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 17:19:42,714 truncating revision to first 12 chars 2016-06-09 17:19:42,715 Setting DEBUG logging. 2016-06-09 17:19:42,715 attempt 1/10 2016-06-09 17:19:42,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f48fbe411650?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 17:19:43,733 unpacking tar archive at: fx-team-f48fbe411650/testing/mozharness/ program finished with exit code 0 elapsedTime=1.394895 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 17:19:43.918284) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:43.918631) ========= script_repo_revision: f48fbe4116507315b13ddf3e1861d74c15d72550 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:43.919176) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:43.919561) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 17:19:43.929233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-09 17:19:43.929589) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:19:44 INFO - MultiFileLogger online at 20160609 17:19:44 in /builds/slave/test 17:19:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:19:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:19:44 INFO - {'append_to_log': False, 17:19:44 INFO - 'base_work_dir': '/builds/slave/test', 17:19:44 INFO - 'blob_upload_branch': 'Fx-Team', 17:19:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:19:44 INFO - 'branch': 'Fx-Team', 17:19:44 INFO - 'buildbot_json_path': 'buildprops.json', 17:19:44 INFO - 'config_files': ('talos/linux_config.py',), 17:19:44 INFO - 'default_actions': ('clobber', 17:19:44 INFO - 'read-buildbot-config', 17:19:44 INFO - 'download-and-extract', 17:19:44 INFO - 'populate-webroot', 17:19:44 INFO - 'create-virtualenv', 17:19:44 INFO - 'install', 17:19:44 INFO - 'run-tests'), 17:19:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:19:44 INFO - 'download_minidump_stackwalk': True, 17:19:44 INFO - 'download_symbols': 'ondemand', 17:19:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:19:44 INFO - 'tooltool.py': '/tools/tooltool.py', 17:19:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:19:44 INFO - '/tools/misc-python/virtualenv.py')}, 17:19:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:19:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:19:44 INFO - 'installer_path': 'installer.exe', 17:19:44 INFO - 'log_level': 'info', 17:19:44 INFO - 'log_name': 'talos', 17:19:44 INFO - 'log_to_console': True, 17:19:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:19:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:19:44 INFO - 'opt_config_files': (), 17:19:44 INFO - 'pip_index': False, 17:19:44 INFO - 'sps_profile': False, 17:19:44 INFO - 'sps_profile_interval': 0, 17:19:44 INFO - 'suite': 'dromaeojs', 17:19:44 INFO - 'system_bits': '32', 17:19:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:19:44 INFO - 'title': 'talos-linux64-ix-019', 17:19:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:19:44 INFO - 'use_talos_json': True, 17:19:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:19:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:19:44 INFO - 'work_dir': 'build'} 17:19:44 INFO - ##### 17:19:44 INFO - ##### Running clobber step. 17:19:44 INFO - ##### 17:19:44 INFO - Running pre-action listener: _resource_record_pre_action 17:19:44 INFO - Running main action method: clobber 17:19:44 INFO - rmtree: /builds/slave/test/build 17:19:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:19:44 INFO - Running post-action listener: _resource_record_post_action 17:19:44 INFO - ##### 17:19:44 INFO - ##### Finished clobber step (success) 17:19:44 INFO - ##### 17:19:44 INFO - ##### 17:19:44 INFO - ##### Running read-buildbot-config step. 17:19:44 INFO - ##### 17:19:44 INFO - Running pre-action listener: _resource_record_pre_action 17:19:44 INFO - Running main action method: read_buildbot_config 17:19:44 INFO - Using buildbot properties: 17:19:44 INFO - { 17:19:44 INFO - "project": "", 17:19:44 INFO - "product": "firefox", 17:19:44 INFO - "script_repo_revision": "production", 17:19:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:19:44 INFO - "repository": "", 17:19:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:19:44 INFO - "buildid": "20160609143002", 17:19:44 INFO - "pgo_build": "True", 17:19:44 INFO - "basedir": "/builds/slave/test", 17:19:44 INFO - "buildnumber": 794, 17:19:44 INFO - "slavename": "talos-linux64-ix-019", 17:19:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:19:44 INFO - "platform": "ubuntu64_hw", 17:19:44 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:19:44 INFO - "branch": "fx-team", 17:19:44 INFO - "repo_path": "integration/fx-team", 17:19:44 INFO - "revision": "f48fbe4116507315b13ddf3e1861d74c15d72550", 17:19:44 INFO - "stage_platform": "linux64-pgo", 17:19:44 INFO - "builduid": "62633a00d7bc48198a66f6b64e9cc4e4", 17:19:44 INFO - "slavebuilddir": "test" 17:19:44 INFO - } 17:19:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:19:44 INFO - Running post-action listener: _resource_record_post_action 17:19:44 INFO - ##### 17:19:44 INFO - ##### Finished read-buildbot-config step (success) 17:19:44 INFO - ##### 17:19:44 INFO - ##### 17:19:44 INFO - ##### Running download-and-extract step. 17:19:44 INFO - ##### 17:19:44 INFO - Running pre-action listener: _resource_record_pre_action 17:19:44 INFO - Running main action method: download_and_extract 17:19:44 INFO - mkdir: /builds/slave/test/build/tests 17:19:44 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')]} 17:19:44 INFO - https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:19:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:19:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:19:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:19:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:19:45 INFO - Downloaded 1361 bytes. 17:19:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:19:45 INFO - Using the following test package requirements: 17:19:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:19:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:19:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:19:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:45 INFO - u'jsshell-linux-x86_64.zip'], 17:19:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:19:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:19:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:19:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:19:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:19:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:19:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:19:45 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')]} 17:19:45 INFO - https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:19:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:19:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:19:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:19:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:19:46 INFO - Downloaded 24452313 bytes. 17:19:46 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'] 17:19:46 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 17:19:47 INFO - Return code: 0 17:19:47 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 17:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:47 INFO - https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:19:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:19:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:19:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:19:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:19:49 INFO - Downloaded 24452313 bytes. 17:19:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:19:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:19:50 INFO - Return code: 0 17:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:50 INFO - https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:19:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:19:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:19:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:19:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:19:51 INFO - Downloaded 10833377 bytes. 17:19:51 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'] 17:19:51 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 17:19:51 INFO - Return code: 0 17:19:51 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')]} 17:19:51 INFO - https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:19:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:19:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:19:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:19:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:19:52 INFO - Downloaded 59281989 bytes. 17:19:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:19:52 INFO - mkdir: /builds/slave/test/properties 17:19:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:19:52 INFO - Writing to file /builds/slave/test/properties/build_url 17:19:52 INFO - Contents: 17:19:52 INFO - build_url:https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:19:53 INFO - Running post-action listener: _resource_record_post_action 17:19:53 INFO - Running post-action listener: set_extra_try_arguments 17:19:53 INFO - ##### 17:19:53 INFO - ##### Finished download-and-extract step (success) 17:19:53 INFO - ##### 17:19:53 INFO - ##### 17:19:53 INFO - ##### Running populate-webroot step. 17:19:53 INFO - ##### 17:19:53 INFO - Running pre-action listener: _resource_record_pre_action 17:19:53 INFO - Running main action method: populate_webroot 17:19:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:19:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:19:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:19:53 INFO - '--tppagecycles', 17:19:53 INFO - '7'], 17:19:53 INFO - 'tests': ['tsvgm']}}, 17:19:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:19:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:19:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:19:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:19:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:19:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:19:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:53 INFO - 'talos_options': ['--disable-e10s'], 17:19:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:19:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:19:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:53 INFO - 'talos_options': ['--disable-e10s'], 17:19:53 INFO - 'tests': ['damp', 'tps']}, 17:19:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:53 INFO - 'tests': ['damp', 'tps']}, 17:19:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:19:53 INFO - 'tests': ['dromaeo_dom']}, 17:19:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:19:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:19:53 INFO - 'tests': ['a11yr', 17:19:53 INFO - 'ts_paint', 17:19:53 INFO - 'tpaint', 17:19:53 INFO - 'sessionrestore', 17:19:53 INFO - 'sessionrestore_no_auto_restore', 17:19:53 INFO - 'tabpaint']}, 17:19:53 INFO - 'other-e10s': {'tests': ['a11yr', 17:19:53 INFO - 'ts_paint', 17:19:53 INFO - 'tpaint', 17:19:53 INFO - 'sessionrestore', 17:19:53 INFO - 'sessionrestore_no_auto_restore', 17:19:53 INFO - 'tabpaint']}, 17:19:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:19:53 INFO - 'ts_paint', 17:19:53 INFO - 'tpaint', 17:19:53 INFO - 'sessionrestore', 17:19:53 INFO - 'sessionrestore_no_auto_restore', 17:19:53 INFO - 'tabpaint']}, 17:19:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:19:53 INFO - 'ts_paint', 17:19:53 INFO - 'tpaint', 17:19:53 INFO - 'sessionrestore', 17:19:53 INFO - 'sessionrestore_no_auto_restore', 17:19:53 INFO - 'tabpaint']}, 17:19:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:19:53 INFO - 'tests': ['a11yr', 17:19:53 INFO - 'ts_paint', 17:19:53 INFO - 'tpaint', 17:19:53 INFO - 'sessionrestore', 17:19:53 INFO - 'sessionrestore_no_auto_restore', 17:19:53 INFO - 'tabpaint']}, 17:19:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:19:53 INFO - 'tests': ['a11yr', 17:19:53 INFO - 'ts_paint', 17:19:53 INFO - 'tpaint', 17:19:53 INFO - 'sessionrestore', 17:19:53 INFO - 'sessionrestore_no_auto_restore', 17:19:53 INFO - 'tabpaint']}, 17:19:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:19:53 INFO - 'tests': ['tsvgx', 17:19:53 INFO - 'tsvgr_opacity', 17:19:53 INFO - 'tart', 17:19:53 INFO - 'tscrollx', 17:19:53 INFO - 'cart']}, 17:19:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:19:53 INFO - 'tsvgr_opacity', 17:19:53 INFO - 'tart', 17:19:53 INFO - 'tscrollx', 17:19:53 INFO - 'cart']}, 17:19:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:53 INFO - 'talos_options': ['--disable-e10s'], 17:19:53 INFO - 'tests': ['tp5o']}, 17:19:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:53 INFO - 'tests': ['tp5o']}, 17:19:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:53 INFO - 'talos_options': ['--disable-e10s', 17:19:53 INFO - '--xperf_path', 17:19:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:19:53 INFO - 'tests': ['tp5n']}, 17:19:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:53 INFO - 'talos_options': ['--xperf_path', 17:19:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:19:53 INFO - 'tests': ['tp5n']}}, 17:19:53 INFO - 'talos.zip': {'path': '', 17:19:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:19:53 INFO - Running post-action listener: _resource_record_post_action 17:19:53 INFO - ##### 17:19:53 INFO - ##### Finished populate-webroot step (success) 17:19:53 INFO - ##### 17:19:53 INFO - ##### 17:19:53 INFO - ##### Running create-virtualenv step. 17:19:53 INFO - ##### 17:19:53 INFO - Running pre-action listener: _resource_record_pre_action 17:19:53 INFO - Running main action method: create_virtualenv 17:19:53 INFO - Creating virtualenv /builds/slave/test/build/venv 17:19:53 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 17:19:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:19:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:19:53 INFO - Using real prefix '/usr' 17:19:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:19:54 INFO - Installing distribute.............................................................................................................................................................................................done. 17:19:56 INFO - Installing pip.................done. 17:19:56 INFO - Return code: 0 17:19:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:19: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')]} 17:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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')]} 17:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90dd783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120d1c0>, '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 0x120e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120e550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', '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 17:19: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', 'pip>=1.5'] in /builds/slave/test/build 17:19: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 pip>=1.5 17:19:56 INFO - Using env: {'DISPLAY': ':0', 17:19:56 INFO - 'HOME': '/home/cltbld', 17:19:56 INFO - 'LANG': 'en_US.UTF-8', 17:19:56 INFO - 'LANGUAGE': 'en_US:en', 17:19:56 INFO - 'LOGNAME': 'cltbld', 17:19:56 INFO - 'MAIL': '/var/mail/cltbld', 17:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:56 INFO - 'MOZ_NO_REMOTE': '1', 17:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:56 INFO - 'NO_EM_RESTART': '1', 17:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:56 INFO - 'PWD': '/builds/slave/test', 17:19:56 INFO - 'SHELL': '/bin/bash', 17:19:56 INFO - 'SHLVL': '1', 17:19:56 INFO - 'TERM': 'linux', 17:19:56 INFO - 'TMOUT': '86400', 17:19:56 INFO - 'USER': 'cltbld', 17:19:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', 17:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:56 INFO - '_': '/tools/buildbot/bin/python'} 17:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:56 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 17:19:56 INFO - Cleaning up... 17:19:56 INFO - Return code: 0 17:19:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:19: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')]} 17:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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')]} 17:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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', '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 0x7f90dd783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120d1c0>, '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 0x120e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120e550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', '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 17:19: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:19: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 psutil>=3.1.1 17:19:56 INFO - Using env: {'DISPLAY': ':0', 17:19:56 INFO - 'HOME': '/home/cltbld', 17:19:56 INFO - 'LANG': 'en_US.UTF-8', 17:19:56 INFO - 'LANGUAGE': 'en_US:en', 17:19:56 INFO - 'LOGNAME': 'cltbld', 17:19:56 INFO - 'MAIL': '/var/mail/cltbld', 17:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:56 INFO - 'MOZ_NO_REMOTE': '1', 17:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:56 INFO - 'NO_EM_RESTART': '1', 17:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:56 INFO - 'PWD': '/builds/slave/test', 17:19:56 INFO - 'SHELL': '/bin/bash', 17:19:56 INFO - 'SHLVL': '1', 17:19:56 INFO - 'TERM': 'linux', 17:19:56 INFO - 'TMOUT': '86400', 17:19:56 INFO - 'USER': 'cltbld', 17:19:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', 17:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:56 INFO - '_': '/tools/buildbot/bin/python'} 17:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:56 INFO - Downloading/unpacking psutil>=3.1.1 17:19: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 17:19: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 17:19: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 17:19: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 17:19: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 17:19: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 17:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:19:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:19:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:19:58 INFO - Installing collected packages: psutil 17:19:58 INFO - Running setup.py install for psutil 17:19:58 INFO - building 'psutil._psutil_linux' extension 17:19:58 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 17:19:59 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 17:19:59 INFO - building 'psutil._psutil_posix' extension 17:19:59 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 17:19:59 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 17:19:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:19:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:19:59 INFO - Successfully installed psutil 17:19:59 INFO - Cleaning up... 17:19:59 INFO - Return code: 0 17:19:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90dd783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120d1c0>, '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 0x120e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120e550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', '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 17:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:19:59 INFO - Using env: {'DISPLAY': ':0', 17:19:59 INFO - 'HOME': '/home/cltbld', 17:19:59 INFO - 'LANG': 'en_US.UTF-8', 17:19:59 INFO - 'LANGUAGE': 'en_US:en', 17:19:59 INFO - 'LOGNAME': 'cltbld', 17:19:59 INFO - 'MAIL': '/var/mail/cltbld', 17:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:59 INFO - 'MOZ_NO_REMOTE': '1', 17:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:59 INFO - 'NO_EM_RESTART': '1', 17:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:59 INFO - 'PWD': '/builds/slave/test', 17:19:59 INFO - 'SHELL': '/bin/bash', 17:19:59 INFO - 'SHLVL': '1', 17:19:59 INFO - 'TERM': 'linux', 17:19:59 INFO - 'TMOUT': '86400', 17:19:59 INFO - 'USER': 'cltbld', 17:19:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', 17:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:59 INFO - '_': '/tools/buildbot/bin/python'} 17:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:20:01 INFO - Installing collected packages: mozsystemmonitor 17:20:01 INFO - Running setup.py install for mozsystemmonitor 17:20:01 INFO - Successfully installed mozsystemmonitor 17:20:01 INFO - Cleaning up... 17:20:01 INFO - Return code: 0 17:20:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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', '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 0x7f90dd783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120d1c0>, '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 0x120e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120e550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', '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 17:20: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:20: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 jsonschema==2.5.1 17:20:01 INFO - Using env: {'DISPLAY': ':0', 17:20:01 INFO - 'HOME': '/home/cltbld', 17:20:01 INFO - 'LANG': 'en_US.UTF-8', 17:20:01 INFO - 'LANGUAGE': 'en_US:en', 17:20:01 INFO - 'LOGNAME': 'cltbld', 17:20:01 INFO - 'MAIL': '/var/mail/cltbld', 17:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:01 INFO - 'MOZ_NO_REMOTE': '1', 17:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:01 INFO - 'NO_EM_RESTART': '1', 17:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:01 INFO - 'PWD': '/builds/slave/test', 17:20:01 INFO - 'SHELL': '/bin/bash', 17:20:01 INFO - 'SHLVL': '1', 17:20:01 INFO - 'TERM': 'linux', 17:20:01 INFO - 'TMOUT': '86400', 17:20:01 INFO - 'USER': 'cltbld', 17:20:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', 17:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:01 INFO - '_': '/tools/buildbot/bin/python'} 17:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:02 INFO - Downloading/unpacking jsonschema==2.5.1 17:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:20:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:04 INFO - Downloading functools32-3.2.3-2.tar.gz 17:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:20:04 INFO - warning: no files found matching '*.txt' 17:20:04 INFO - no previously-included directories found matching 'build' 17:20:04 INFO - no previously-included directories found matching 'dist' 17:20:04 INFO - no previously-included directories found matching '.git*' 17:20:04 INFO - Installing collected packages: jsonschema, functools32 17:20:04 INFO - Running setup.py install for functools32 17:20:04 INFO - warning: no files found matching '*.txt' 17:20:04 INFO - no previously-included directories found matching 'build' 17:20:04 INFO - no previously-included directories found matching 'dist' 17:20:04 INFO - no previously-included directories found matching '.git*' 17:20:04 INFO - Successfully installed jsonschema functools32 17:20:04 INFO - Cleaning up... 17:20:04 INFO - Return code: 0 17:20:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:20: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')]} 17:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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')]} 17:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f90dd783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120d1c0>, '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 0x120e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120e550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', '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 17:20:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:20:04 INFO - Using env: {'DISPLAY': ':0', 17:20:04 INFO - 'HOME': '/home/cltbld', 17:20:04 INFO - 'LANG': 'en_US.UTF-8', 17:20:04 INFO - 'LANGUAGE': 'en_US:en', 17:20:04 INFO - 'LOGNAME': 'cltbld', 17:20:04 INFO - 'MAIL': '/var/mail/cltbld', 17:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:04 INFO - 'MOZ_NO_REMOTE': '1', 17:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:04 INFO - 'NO_EM_RESTART': '1', 17:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:04 INFO - 'PWD': '/builds/slave/test', 17:20:04 INFO - 'SHELL': '/bin/bash', 17:20:04 INFO - 'SHLVL': '1', 17:20:04 INFO - 'TERM': 'linux', 17:20:04 INFO - 'TMOUT': '86400', 17:20:04 INFO - 'USER': 'cltbld', 17:20:04 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', 17:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:04 INFO - '_': '/tools/buildbot/bin/python'} 17:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:04 INFO - Downloading/unpacking blobuploader==1.2.4 17:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:06 INFO - Downloading blobuploader-1.2.4.tar.gz 17:20:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:20:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:20:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:07 INFO - Downloading docopt-0.6.1.tar.gz 17:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:20:07 INFO - Installing collected packages: blobuploader, requests, docopt 17:20:07 INFO - Running setup.py install for blobuploader 17:20:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:20:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:20:07 INFO - Running setup.py install for requests 17:20:07 INFO - Running setup.py install for docopt 17:20:07 INFO - Successfully installed blobuploader requests docopt 17:20:07 INFO - Cleaning up... 17:20:08 INFO - Return code: 0 17:20:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90dd783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120d1c0>, '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 0x120e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120e550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', '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 17:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:20:08 INFO - Using env: {'DISPLAY': ':0', 17:20:08 INFO - 'HOME': '/home/cltbld', 17:20:08 INFO - 'LANG': 'en_US.UTF-8', 17:20:08 INFO - 'LANGUAGE': 'en_US:en', 17:20:08 INFO - 'LOGNAME': 'cltbld', 17:20:08 INFO - 'MAIL': '/var/mail/cltbld', 17:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:08 INFO - 'MOZ_NO_REMOTE': '1', 17:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:08 INFO - 'NO_EM_RESTART': '1', 17:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:08 INFO - 'PWD': '/builds/slave/test', 17:20:08 INFO - 'SHELL': '/bin/bash', 17:20:08 INFO - 'SHLVL': '1', 17:20:08 INFO - 'TERM': 'linux', 17:20:08 INFO - 'TMOUT': '86400', 17:20:08 INFO - 'USER': 'cltbld', 17:20:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', 17:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:08 INFO - '_': '/tools/buildbot/bin/python'} 17:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:08 INFO - Running setup.py (path:/tmp/pip-QF4MPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:08 INFO - Running setup.py (path:/tmp/pip-6F_szB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:08 INFO - Running setup.py (path:/tmp/pip-gumeuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:08 INFO - Running setup.py (path:/tmp/pip-KKfn7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:08 INFO - Running setup.py (path:/tmp/pip-3gjTl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:08 INFO - Running setup.py (path:/tmp/pip-orGmA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:08 INFO - Running setup.py (path:/tmp/pip-QOjRy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:08 INFO - Running setup.py (path:/tmp/pip-0Gmj21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:08 INFO - Running setup.py (path:/tmp/pip-LQkHkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:08 INFO - Running setup.py (path:/tmp/pip-0fwCkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:08 INFO - Running setup.py (path:/tmp/pip-tlEwn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:09 INFO - Running setup.py (path:/tmp/pip-lIP1ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:09 INFO - Running setup.py (path:/tmp/pip-bnaedy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:09 INFO - Running setup.py (path:/tmp/pip-JGNlxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:09 INFO - Running setup.py (path:/tmp/pip-Y09zxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:09 INFO - Running setup.py (path:/tmp/pip-hJQpYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:09 INFO - Running setup.py (path:/tmp/pip-MDMgTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:20:09 INFO - Running setup.py install for manifestparser 17:20:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:20:09 INFO - Running setup.py install for mozcrash 17:20:09 INFO - Running setup.py install for mozdebug 17:20:09 INFO - Running setup.py install for mozdevice 17:20:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:20:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:20:09 INFO - Running setup.py install for mozfile 17:20:10 INFO - Running setup.py install for mozhttpd 17:20:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:20:10 INFO - Running setup.py install for mozinfo 17:20:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:20:10 INFO - Running setup.py install for mozInstall 17:20:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:20:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:20:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:20:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:20:10 INFO - Running setup.py install for mozleak 17:20:10 INFO - Running setup.py install for mozlog 17:20:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:20:10 INFO - Running setup.py install for moznetwork 17:20:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:20:10 INFO - Running setup.py install for mozprocess 17:20:10 INFO - Running setup.py install for mozprofile 17:20:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:20:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:20:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:20:10 INFO - Running setup.py install for mozrunner 17:20:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:20:11 INFO - Running setup.py install for mozscreenshot 17:20:11 INFO - Running setup.py install for moztest 17:20:11 INFO - Running setup.py install for mozversion 17:20:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:20:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:20:11 INFO - Cleaning up... 17:20:11 INFO - Return code: 0 17:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20: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')]} 17:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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')]} 17:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90dd783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120d1c0>, '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 0x120e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120e550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', '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 17:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:20:11 INFO - Using env: {'DISPLAY': ':0', 17:20:11 INFO - 'HOME': '/home/cltbld', 17:20:11 INFO - 'LANG': 'en_US.UTF-8', 17:20:11 INFO - 'LANGUAGE': 'en_US:en', 17:20:11 INFO - 'LOGNAME': 'cltbld', 17:20:11 INFO - 'MAIL': '/var/mail/cltbld', 17:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:11 INFO - 'MOZ_NO_REMOTE': '1', 17:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:11 INFO - 'NO_EM_RESTART': '1', 17:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:11 INFO - 'PWD': '/builds/slave/test', 17:20:11 INFO - 'SHELL': '/bin/bash', 17:20:11 INFO - 'SHLVL': '1', 17:20:11 INFO - 'TERM': 'linux', 17:20:11 INFO - 'TMOUT': '86400', 17:20:11 INFO - 'USER': 'cltbld', 17:20:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', 17:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:11 INFO - '_': '/tools/buildbot/bin/python'} 17:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:11 INFO - Running setup.py (path:/tmp/pip-k3QzgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:11 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)) 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:11 INFO - Running setup.py (path:/tmp/pip-2CTCxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:11 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)) 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:11 INFO - Running setup.py (path:/tmp/pip-EKptqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:11 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)) 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:11 INFO - Running setup.py (path:/tmp/pip-OCL2ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:11 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)) 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:11 INFO - Running setup.py (path:/tmp/pip-ABfqsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:11 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)) 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:11 INFO - Running setup.py (path:/tmp/pip-rbT6I7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:11 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)) 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:11 INFO - Running setup.py (path:/tmp/pip-930imc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:12 INFO - Running setup.py (path:/tmp/pip-JrLDmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:12 INFO - Running setup.py (path:/tmp/pip-HsXOGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:12 INFO - Running setup.py (path:/tmp/pip-3KnXQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:12 INFO - Running setup.py (path:/tmp/pip-bMu5wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:12 INFO - Running setup.py (path:/tmp/pip-KV132c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:12 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)) 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:12 INFO - Running setup.py (path:/tmp/pip-mba6ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:12 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)) 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:12 INFO - Running setup.py (path:/tmp/pip-XlX5s8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:12 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)) 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:12 INFO - Running setup.py (path:/tmp/pip-4ENoWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:12 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)) 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:12 INFO - Running setup.py (path:/tmp/pip-UV2LP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:12 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)) 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:12 INFO - Running setup.py (path:/tmp/pip-R_TDEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:12 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)) 17:20:12 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)) 17:20:12 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)) 17:20:12 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)) 17:20:12 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)) 17:20:12 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)) 17:20:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:20: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 17:20:14 INFO - Downloading blessings-1.6.tar.gz 17:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:20:14 INFO - Installing collected packages: blessings 17:20:14 INFO - Running setup.py install for blessings 17:20:14 INFO - Successfully installed blessings 17:20:14 INFO - Cleaning up... 17:20:14 INFO - Return code: 0 17:20:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:20:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:15 INFO - Reading from file tmpfile_stdout 17:20:15 INFO - Current package versions: 17:20:15 INFO - argparse == 1.2.1 17:20:15 INFO - blessings == 1.6 17:20:15 INFO - blobuploader == 1.2.4 17:20:15 INFO - docopt == 0.6.1 17:20:15 INFO - functools32 == 3.2.3-2 17:20:15 INFO - jsonschema == 2.5.1 17:20:15 INFO - manifestparser == 1.1 17:20:15 INFO - mozInstall == 1.12 17:20:15 INFO - mozcrash == 0.17 17:20:15 INFO - mozdebug == 0.1 17:20:15 INFO - mozdevice == 0.48 17:20:15 INFO - mozfile == 1.2 17:20:15 INFO - mozhttpd == 0.7 17:20:15 INFO - mozinfo == 0.9 17:20:15 INFO - mozleak == 0.1 17:20:15 INFO - mozlog == 3.2 17:20:15 INFO - moznetwork == 0.27 17:20:15 INFO - mozprocess == 0.22 17:20:15 INFO - mozprofile == 0.28 17:20:15 INFO - mozrunner == 6.11 17:20:15 INFO - mozscreenshot == 0.1 17:20:15 INFO - mozsystemmonitor == 0.3 17:20:15 INFO - moztest == 0.7 17:20:15 INFO - mozversion == 1.4 17:20:15 INFO - psutil == 3.1.1 17:20:15 INFO - requests == 1.2.3 17:20:15 INFO - wsgiref == 0.1.2 17:20:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90dd783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120d1c0>, '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 0x120e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120e550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', '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 17:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:20:15 INFO - Using env: {'DISPLAY': ':0', 17:20:15 INFO - 'HOME': '/home/cltbld', 17:20:15 INFO - 'LANG': 'en_US.UTF-8', 17:20:15 INFO - 'LANGUAGE': 'en_US:en', 17:20:15 INFO - 'LOGNAME': 'cltbld', 17:20:15 INFO - 'MAIL': '/var/mail/cltbld', 17:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:15 INFO - 'MOZ_NO_REMOTE': '1', 17:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:15 INFO - 'NO_EM_RESTART': '1', 17:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:15 INFO - 'PWD': '/builds/slave/test', 17:20:15 INFO - 'SHELL': '/bin/bash', 17:20:15 INFO - 'SHLVL': '1', 17:20:15 INFO - 'TERM': 'linux', 17:20:15 INFO - 'TMOUT': '86400', 17:20:15 INFO - 'USER': 'cltbld', 17:20:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', 17:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:15 INFO - '_': '/tools/buildbot/bin/python'} 17:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:20:15 INFO - Cleaning up... 17:20:15 INFO - Return code: 0 17:20:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90dd783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120d1c0>, '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 0x120e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120e550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', '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 17:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:20:15 INFO - Using env: {'DISPLAY': ':0', 17:20:15 INFO - 'HOME': '/home/cltbld', 17:20:15 INFO - 'LANG': 'en_US.UTF-8', 17:20:15 INFO - 'LANGUAGE': 'en_US:en', 17:20:15 INFO - 'LOGNAME': 'cltbld', 17:20:15 INFO - 'MAIL': '/var/mail/cltbld', 17:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:15 INFO - 'MOZ_NO_REMOTE': '1', 17:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:15 INFO - 'NO_EM_RESTART': '1', 17:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:15 INFO - 'PWD': '/builds/slave/test', 17:20:15 INFO - 'SHELL': '/bin/bash', 17:20:15 INFO - 'SHLVL': '1', 17:20:15 INFO - 'TERM': 'linux', 17:20:15 INFO - 'TMOUT': '86400', 17:20:15 INFO - 'USER': 'cltbld', 17:20:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', 17:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:15 INFO - '_': '/tools/buildbot/bin/python'} 17:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:20:15 INFO - Cleaning up... 17:20:15 INFO - Return code: 0 17:20:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90dd783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120d1c0>, '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 0x120e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120e550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', '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 17:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:20:15 INFO - Using env: {'DISPLAY': ':0', 17:20:15 INFO - 'HOME': '/home/cltbld', 17:20:15 INFO - 'LANG': 'en_US.UTF-8', 17:20:15 INFO - 'LANGUAGE': 'en_US:en', 17:20:15 INFO - 'LOGNAME': 'cltbld', 17:20:15 INFO - 'MAIL': '/var/mail/cltbld', 17:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:15 INFO - 'MOZ_NO_REMOTE': '1', 17:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:15 INFO - 'NO_EM_RESTART': '1', 17:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:15 INFO - 'PWD': '/builds/slave/test', 17:20:15 INFO - 'SHELL': '/bin/bash', 17:20:15 INFO - 'SHLVL': '1', 17:20:15 INFO - 'TERM': 'linux', 17:20:15 INFO - 'TMOUT': '86400', 17:20:15 INFO - 'USER': 'cltbld', 17:20:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', 17:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:15 INFO - '_': '/tools/buildbot/bin/python'} 17:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:15 INFO - Downloading/unpacking flake8 17:20:15 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 17:20:15 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 17:20:15 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 17:20:15 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 17:20:15 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 17:20:15 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 17:20:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:20:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:20:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:20:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:20:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:20:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:20:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:20:18 INFO - no previously-included directories found matching 'docs/_build' 17:20:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:20:18 INFO - Running setup.py install for pep8 17:20:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:20:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:20:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:20:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:20:18 INFO - no previously-included directories found matching 'docs/_build' 17:20:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:20:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:20:18 INFO - Cleaning up... 17:20:18 INFO - Return code: 0 17:20:18 INFO - Running post-action listener: _resource_record_post_action 17:20:18 INFO - Running post-action listener: _start_resource_monitoring 17:20:18 INFO - Starting resource monitoring. 17:20:18 INFO - ##### 17:20:18 INFO - ##### Finished create-virtualenv step (success) 17:20:18 INFO - ##### 17:20:18 INFO - ##### 17:20:18 INFO - ##### Running install step. 17:20:18 INFO - ##### 17:20:18 INFO - Running pre-action listener: _resource_record_pre_action 17:20:18 INFO - Running main action method: install 17:20:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:18 INFO - Reading from file tmpfile_stdout 17:20:18 INFO - Detecting whether we're running mozinstall >=1.0... 17:20:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:20:18 INFO - Reading from file tmpfile_stdout 17:20:18 INFO - Output received: 17:20:18 INFO - Usage: mozinstall [options] installer 17:20:18 INFO - Options: 17:20:18 INFO - -h, --help show this help message and exit 17:20:18 INFO - -d DEST, --destination=DEST 17:20:18 INFO - Directory to install application into. [default: 17:20:18 INFO - "/builds/slave/test"] 17:20:18 INFO - --app=APP Application being installed. [default: firefox] 17:20:18 INFO - mkdir: /builds/slave/test/build/application 17:20:18 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'] 17:20:18 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 17:20:35 INFO - Reading from file tmpfile_stdout 17:20:35 INFO - Output received: 17:20:35 INFO - /builds/slave/test/build/application/firefox/firefox 17:20:35 INFO - Running post-action listener: _resource_record_post_action 17:20:35 INFO - ##### 17:20:35 INFO - ##### Finished install step (success) 17:20:35 INFO - ##### 17:20:35 INFO - ##### 17:20:35 INFO - ##### Running run-tests step. 17:20:35 INFO - ##### 17:20:35 INFO - Running pre-action listener: _resource_record_pre_action 17:20:35 INFO - Running main action method: run_tests 17:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:20:35 INFO - Python 2.7.3 17:20:35 INFO - Return code: 0 17:20:35 INFO - grabbing minidump binary from tooltool 17:20:35 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')]} 17:20:35 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 0x120d1c0>, '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 0x120e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:20:35 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 17:20:35 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 17:20:35 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 17:20:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:20:35 INFO - Return code: 0 17:20:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:20:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:20:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:20:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:20:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:20:36 INFO - Return code: 0 17:20:36 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:20:36 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:20:36 INFO - Using env: {'DISPLAY': ':0', 17:20:36 INFO - 'HOME': '/home/cltbld', 17:20:36 INFO - 'LANG': 'en_US.UTF-8', 17:20:36 INFO - 'LANGUAGE': 'en_US:en', 17:20:36 INFO - 'LOGNAME': 'cltbld', 17:20:36 INFO - 'MAIL': '/var/mail/cltbld', 17:20:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:20:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:36 INFO - 'MOZ_NO_REMOTE': '1', 17:20:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:36 INFO - 'NO_EM_RESTART': '1', 17:20:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:36 INFO - 'PWD': '/builds/slave/test', 17:20:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:20:36 INFO - 'SHELL': '/bin/bash', 17:20:36 INFO - 'SHLVL': '1', 17:20:36 INFO - 'TERM': 'linux', 17:20:36 INFO - 'TMOUT': '86400', 17:20:36 INFO - 'USER': 'cltbld', 17:20:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076', 17:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:36 INFO - '_': '/tools/buildbot/bin/python'} 17:20:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:20:36 INFO - mozversion application_buildid: 20160609143002 17:20:36 INFO - mozversion application_changeset: f48fbe4116507315b13ddf3e1861d74c15d72550 17:20:36 INFO - mozversion application_display_name: Nightly 17:20:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:20:36 INFO - mozversion application_name: Firefox 17:20:36 INFO - mozversion application_remotingname: firefox 17:20:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:20:36 INFO - mozversion application_vendor: Mozilla 17:20:36 INFO - mozversion application_version: 50.0a1 17:20:36 INFO - mozversion platform_buildid: 20160609143002 17:20:36 INFO - mozversion platform_changeset: f48fbe4116507315b13ddf3e1861d74c15d72550 17:20:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:20:36 INFO - mozversion platform_version: 50.0a1 17:20:36 INFO - using testdate: 1465518036 17:20:36 INFO - actual date: 1465518036 17:20:36 INFO - starting webserver on 'localhost:43186' 17:20:36 INFO - SUITE-START | Running 2 tests 17:20:36 INFO - TEST-START | dromaeo_css 17:20:36 INFO - operating with platform_type : linux_ 17:20:36 INFO - Initialising browser for dromaeo_css test... 17:20:36 INFO - TEST-INFO | started process 10407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1HpUVP/profile http://localhost:43186/getInfo.html) 17:20:41 INFO - PROCESS | 10407 | __metrics Screen width/height:1600/1200 17:20:41 INFO - PROCESS | 10407 | colorDepth:24 17:20:41 INFO - PROCESS | 10407 | Browser inner width/height: 1024/697 17:20:41 INFO - PROCESS | 10407 | __metrics 17:20:42 ERROR - PROCESS | 10407 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:20:42 INFO - PROCESS | 10407 | console.error: PushService: 17:20:42 INFO - PROCESS | 10407 | stateChangeProcessEnqueue: Error transitioning state 17:20:42 INFO - PROCESS | 10407 | UnknownError 17:20:43 INFO - TEST-INFO | 10407: exit 0 17:20:43 INFO - Browser initialized. 17:20:43 INFO - Running cycle 1/1 for dromaeo_css test... 17:20:43 INFO - TEST-INFO | started process 10488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1HpUVP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:20:55 INFO - PROCESS | 10488 | RSS: Main: 172904448 17:20:55 INFO - PROCESS | 10488 | 17:21:47 INFO - PROCESS | 10488 | 1465518107042 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] 17:23:54 INFO - PROCESS | 10488 | Cycle 1(1): loaded http://localhost:43186/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43186/tests/dromaeo/cssquery-ext.html) 17:23:56 INFO - PROCESS | 10488 | RSS: Main: 297492480 17:23:56 INFO - PROCESS | 10488 | 17:26:58 INFO - PROCESS | 10488 | Cycle 1(1): loaded http://localhost:43186/tests/dromaeo/cssquery-ext.html (next: http://localhost:43186/tests/dromaeo/cssquery-jquery.html) 17:26:59 INFO - PROCESS | 10488 | RSS: Main: 255590400 17:26:59 INFO - PROCESS | 10488 | 17:30:00 INFO - PROCESS | 10488 | Cycle 1(1): loaded http://localhost:43186/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43186/tests/dromaeo/cssquery-mootools.html) 17:30:01 INFO - PROCESS | 10488 | RSS: Main: 262320128 17:30:01 INFO - PROCESS | 10488 | 17:33:03 INFO - PROCESS | 10488 | Cycle 1(1): loaded http://localhost:43186/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43186/tests/dromaeo/cssquery-prototype.html) 17:33:04 INFO - PROCESS | 10488 | RSS: Main: 253669376 17:33:04 INFO - PROCESS | 10488 | 17:36:06 INFO - PROCESS | 10488 | Cycle 1(1): loaded http://localhost:43186/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43186/tests/dromaeo/cssquery-yui.html) 17:36:07 INFO - PROCESS | 10488 | RSS: Main: 237789184 17:36:07 INFO - PROCESS | 10488 | 17:39:09 INFO - PROCESS | 10488 | Cycle 1(1): loaded http://localhost:43186/tests/dromaeo/cssquery-yui.html (next: http://localhost:43186/tests/dromaeo/cssquery-dojo.html) 17:39:10 INFO - PROCESS | 10488 | RSS: Main: 299741184 17:39:10 INFO - PROCESS | 10488 | 17:39:10 INFO - PROCESS | 10488 | __start_tp_report 17:39:10 INFO - PROCESS | 10488 | _x_x_mozilla_page_load 17:39:10 INFO - PROCESS | 10488 | _x_x_mozilla_page_load_details 17:39:10 INFO - PROCESS | 10488 | |i|pagename|runs| 17:39:10 INFO - PROCESS | 10488 | |0;dojo.html;3026.8335241561713;3048.3903219356134;3069.754419646428;3084.6761090085556;3094.8916787912426;5069.087564238435;5191.662541934772;5214.556762675173;5265.789368425263;5290.497402746738;5191.273221748958;5226.425093239741;5233.79064837407;5241.659292146008;5331.147016477365;4723;4809.90380192396;4815.66290359675;4825.276208568707;4842.539958703936;4855.393075865517;4899.559039686427;4916.877078073059;4918.0901533216465;4960.404751429815;4720.76396180193;4766.761661916925;4767.833125840579;4835.1296766582;4852.927206091911;4776.25967974961;4797.18447863864;4818.108649899745;4849.660523763338;4880.511948805127;4761.59526440253;4763.952360476385;4774.140654682155;4779.737114458703;4814;5164.845054648366;5189.532942035197;5256.316678831728;5261.710605916673;5306.283651707047;5568.832935011957;5672.290963629546;5682.7442765075675;5691;5691.573132015115;5713.400092990218;5713.914291285634;5724.484796368347;5725.799597014085;5736.7992120276;5164.406093299281;5270.868228294246;5295.735213239323;5346.03771321162;5348.545373643245;5883.588148829541;5883.794067207627;5891.145783861316;5893.2044174035955;5897.941020589825;5615.410381909923;5659.518940889988;5669.489745922887;5673.546116310686;5674.602777805514;5481.342238931354;5573.331200255914;5620.747066382022;5651.378348381675;5714.142878568165;5640.774369025193;5656.85857853557;5661.66030038199;5672.602917795714;5675.886482270332;5578.804741834017;5635;5638;5641.689707066069;5645.802396916089;4197.160567886435;4275.914481710349;4298.634616057608;4314.352847072902;4361.105973275471;3857.787821669779;3867.6325749053794;3869.400242962345;3901.941470877939;3906.121122747359;5249.212618107238;5251.894962100737;5253.579713622901;5255.894882102337;5261.289725887033;5505.091659876156;5607.775688972477;5662.546996240291;5669.40471250521;5758.078707406795;5351.598630102758;5365.195220716923;5365.38298095724;5366.060939335601;5380.1929710542945;4927.876803079952;4934.037862616827;4938.111139994764;4938.530839570235;4978.502149785065;5702.54379649627;5778.248827652463;5820.76716931318;5830.18377427169;5851;5643.576731745054;5678.943210567842;5689.800856969986;5697.515711164598;5703;5866.530677545871;5880.970595146997;5882.23530940975;5883.735231914659;5885.55858310637;5426.240326354235;5521.2270282159725;5563.7496312666835;5580.21876937221;5600.4959553640365;5662.631928924607;5668.121441176624;5683.318001839806;5691.743871525874;5691.943080569141;5518.255035570147;5578.414266501959;5586.301712285965;5589.55283577321;5636.915446268227;5459.2902922619805;5462.644928079662;5490.3411590609385;5493.533049690821;5527.336719593674;5434.130539113723;5438.945610543844;5439.755211015593;5444.482774136451;5447.863803404946;5430.67415955044;5560.4161563035295;5566.832995010156;5589.357223919302;5609.579281553982;5372.516473517402;5416.7020813855615;5431.646942948696;5471.6169868108855;5479.123340265538 17:39:10 INFO - PROCESS | 10488 | |1;ext.html;575.4245754245754;615.5383462403198;623.5136593457103;633.2021652717576;639.1754636518891;29843.1047068588;41637.16725665489;42015.57984420155;42250.57749422505;42387.78806105969;43068;44218;44264.55735442645;44288.33567496482;44288.3356749649;8989.77525561863;9130.178283954443;9131.863022054675;9148.085191480865;9148.130927561871;8874.556272186397;8983.640654373818;8988.370814043019;8997.685081022166;8998.235150012257;9051.366404351698;9091.090890910922;9098.681546145854;9098.77253068672;9101.817963640757;8957.283417326598;8976.371653984224;8988.370814043019;8989.190972812414;8990.775230619221;8937.955310223408;9035.909640903637;9040.367174297802;9041.734157217994;9047.321450891144;42000.57999419997;42295.40489058434;42315.78842105801;42351.36472952908;42358.36462453066;3480.791152530831;3571.4107172316535;3617.2584620152807;3621.4748861414946;3638.7089032877307;32380;32438.513422298685;32906.341873162404;32924.1768955778;33223.6677633223;4379.75911324877;4400.11997600478;4406.669499787528;4481.820727170909;4597.862064138081;357570;357603;357902.05244869087;358678;359219;56137;56339;56542.7172864133;56874.17509898839;56937.145942810894;58666;58793;58819.11771323434;58904;58921.410785891596;17303.480895572902;17529;17574;17607.823921760875;17624.29502819873;13544.525941591997;13568.93215533916;13586.38861251246;13641.454341826216;13651.453941842414;13717.725645487233;15464.14947177916;15469.381224751109;15691.607709807346;15814.209289535478;5816.302043754692;6000.949833779071;6055.485283750931;6117.418845209698;6245;744.7971574713973;1019.179560453827;1071.4160782373624;1098.2531878322657;1102.7188067042853;31550;31980.68019319777;32147.839260804016;32735;32911.3417731644;1092.2845536173818;1149.9942500287445;1153.9826902596467;1157.455995682028;1163.6218229075585;16385.426510072328;16996.660066798595;17055.403060892808;17091.005285723477;17170.65658686844;502103;504287;504388;506724;507007;56183.43816561782;56550.43449565452;56696.732130715136;56767.71616141893;56956.715216423654;1252.843394575678;1323.483841301893;1351.9391627376792;1359.238826257299;1380.1925873364194;31369.215769605944;32493.837530812194;32853.342933141685;32972;33086.338273234884;49311;49391.25913111378;49791.50208497869;49860.501394985586;49865.25202122044;414181;417189;417673;419470;419532;37770.81114594409;40463.59536404716;40838.387424189255;41142.1771564573;43709.78145109254;48311;48486.75756621194;48622.75688621534;49438.50561494339;49548.25677614767;38431.231375372896;39989;40144.59855401408;40249.1950161001;40502;39294.803525982185;40133.598664012985;40365.79817100896;40396;40570.1885962285;40007.99980000523;40251.39622905717;40463.393049104874;41004.079510458934;41130.588694112674;33967.3206535863;35845.05916213678;36152.45771313485;36657.816710916275;37212;27206.183814485597;27487.45025099527;27590.586141207496;27682.861585691942;27814.721852782022 17:39:10 INFO - PROCESS | 10488 | |2;jquery.html;382.4492730468124;386.81819544813936;394.34735512726445;408.57304117197526;418.6692512914797;18122.90938545307;18611.348602798906;19524.121414536345;19632.411027669175;19738.703919441185;18313.54216144597;18481.907590462062;18642.533936651558;18684.81315186851;18695.813041869576;5505.6696598204235;5681.886362272752;5746.798862039829;5755.2230448889495;5799.043157878945;5532.170174473821;5702.914456283159;5726.284214473191;5730.369659337491;5746.051901436279;5568.888622227573;5579.358373787026;5615;5634.408387119355;5651.745671444774;5625.324961004706;5631.099024156136;5638.633488823213;5670.858228544278;5717.456841600041;4836.443808961979;5055.4186268579215;5059.494050594948;5065.670731402447;5099.08216521026;21410.143594256366;21435;21604.567908641897;22035.449113772283;22045.889770551206;2237.19460994042;2252.3693365857584;2253.8196944244423;2289.278877153691;2963.68881267466;13981.510647127301;14077.366518506691;14089.718205635932;14134.646633834134;14669.33987970544;1937.5059359863285;2013.5670830771307;2018.1019446346381;2034.176158655732;2090.5087304483586;77085.61457192735;77376;78578.21421785823;79817.60091199564;80167.5991620044;9953.900460995443;10199.113164064673;10255.282130250811;10386.42874641902;10447.529861156267;14528.346224419927;14623.561293161221;14647.487337943121;14650.853491464948;14652.560423187322;7625.504342217738;8230.917690823135;8270.669173233124;8364.121767214476;8387.245147936716;8051.5571643559;8059.153788852086;8128.471649342774;8184.140665230184;8250.834983300301;6470.417662410406;6494.675266236669;6528.08606795049;6533.705983230766;6535.934640653532;1905.6188762247607;1909.5703466719876;1929.5851391950798;1937.1282922684848;1965.2532037825536;982.9995958224978;984.6602921991902;1015.279151802214;1042.9153680172535;1087.8585783848207;16798;18097.276108955495;18366.908165459354;18636.72044919327;19100.140493677816;1010.9090181883665;1022.7852151048214;1032.0814475117152;1036.2538971940191;1082.2802836114054;10472.214583906085;10947.397893115955;11004.889951100387;11034.393108378956;11044.613438529614;478391;480640;481754.807332954;520298;521158;77035.61482192553;79202.20797792064;79572.83844453911;80117.59941200257;80296.59851700821;955.9474228917337;961.3510880155867;981.9134339528501;988.3871999360299;999.8951158969379;15702.607434813764;16029.599260018593;16145.596360090622;16192.919035404748;16488.17559122015;27545.173644790688;28000.43999120047;32135.67864321327;34780.478292826134;39201.411978820914;51187.232191517905;52880;52954.470455294955;53269.467305328;53544.19683704826;7388.926110739038;7585.734499292498;7663.616819159131;7977.840443190988;8145.592720364077;12585.685357866127;13448.731025379633;13647.404058729608;13736.93131534336;13863.861361386256;11328.660140195807;11666.733314671905;11688;11906.702332441759;11989.880101199225;11427.142964277546;11849.229800062969;11902.226355286879;11914.582989595669;11927.522899084286;11737.88262117368;11796.94101529487;12001.219920705125;12049.156559040783;12285.447154877873;7891.092524359772;7898.842023159619;7948.96663433773;7964.601769911365;8011.639476223468;11354.091672666333;11465.713357166138;11885.702857428634;11931.821022684493;11994.460249288977 17:39:10 INFO - PROCESS | 10488 | |3;mootools.html;1280.9807852882213;1458.5186888326853;1492.1569313337964;1634.4933070748061;1803.9458816235517;8294.4608600441;8794.51630160341;8817.559122043887;9058.547072646374;9059.229965452945;8774.210321071103;8970;8988.955055224731;8995.190432861042;9000.144986226314;2083.677030060343;2281.087564974007;2372.4424760181346;2380.1550449590363;2416.9516609667794;2342.6720259163644;2367.7987371073477;2373.95252094958;2373.9881300593474;2376.013954209001;2329.8835058247105;2353;2355.611324131516;2360.409897525619;2369.4313364792497;1978.980210197894;2251.3921241264766;2315.4790172211287;2321.9535609287886;2329.51080273142;2374.6675465434855;2390.3187591536503;2407.590709579376;2411.0837881605053;2415.806735461159;8956.283497320264;9007.774805629846;9013;9013.819723605557;9015.909840901573;5205.349331333583;5219.929914367545;5341.572674186055;5345.973270133624;5407.324084489439;3442.9827850860584;3622.9637703623152;3635.600083990759;3689.409694448902;3693.5752388475403;1160.7388337624052;1197.263682835059;1234.1052736765773;1258.4399942025711;1266.7909794883833;12680.112392132554;12727.554535591209;12733.808992865022;12746.681332966657;12758.170718903242;4756.548127927841;4866.367372241586;4891.682040667345;4892.779824907888;4954.1082605130705;10492.790144197073;10516.737081573021;10543.683689489328;10558.260921735558;10563.1021363185;5505.559555235572;5513.696746678971;5514.641548299348;5515.448455154453;5515.806946756844;4153.750774953452;4907.55831975124;4993.800247990112;5035.697858128524;5094.923576146361;4068.8372465101065;4076.4522173641476;4120.443740095049;4125;4172.833086676499;1259.2192840438804;1261.9810702839466;1271.815586739936;1288.62629837348;1290.728946921157;818.6479813680174;896.2068569316202;906.7098528470826;925.412363149405;965.0012237334325;5898.1152827076285;5915.497182739429;6024.849378765566;6117.357677443893;6244.784770280043;922.9953850230706;941.8493041113526;974.7563109222694;988.2588058955783;1017.9185665146771;3894.7078969077434;3998.1204135090234;4054.7567145971334;4099.077707515785;4129.256733787947;11013.724656883642;11203.94398028021;11305.943470282597;11423.885761142283;11490.253133546294;11125.443727813577;11206.831897521544;11209.887901120885;11287.322760634388;11298.378589177673;7948.125706172432;8091.514509129471;8272.710455134042;8285.212904774036;8470.322374210049;5862.208601838697;5897.941020589739;5943.762249509971;5947.910781338197;6038;9323.766905827408;9442.669506567237;9601.615935362508;9611;9625.278104142077;9479.431234125974;9771.657991970531;9858.408495490006;9859.408435493893;9933.801323973625;6796.864062718619;7695.615219239127;7807.9219207809465;7913.802154946173;7943.046834379911;8815.338849586178;8835.160659737314;8850.468971861708;8902.198802107841;8908.955455222942;7577.583232922242;7987.041555013436;7999.520028798291;8014.719484818003;8101.230383113595;7703.884441733267;7821.608919553886;7848.84302313962;7874.448788584744;7961;7242.7465038725495;7279.8544029120185;7324.267573242633;7333.1200255969625;7336.266373362621;4924.852254432372;4956.72737999399;5066.898662026665;5078.542931136216;5117.437081920912;5308.071087559739;5325.4940780625775;5374.220737993047;5416.83749487516;5447.1829225616475 17:39:10 INFO - PROCESS | 10488 | |4;prototype.html;324.94151052810486;329.8251926478967;332.51286864743133;334.2762918281919;338.16641977525404;5327.467253274671;5359.303290572225;5392.110301800208;5393.973030134854;5399;5246.449122842104;5260.368755749316;5270.420253772091;5282.947170528294;5292.603054770889;4081.755094694313;4170;4171.812268447912;4176.143890502447;4203;4108.691848111389;4138.875833724993;4138.896527586804;4155.459790227266;4200.088959523409;4123.649489793371;4138.089620283547;4161.4382058422025;4162.979185104085;4172.499300083994;3955.833029256362;3973.423853541249;4082.6733861291027;4139.606737359946;4159.23054234966;3619.7828130312264;3622.9637703623152;3641.908952276188;3643.526341575578;3662.7802331860175;5101.897962040775;5130.204818253177;5163.561097306733;5180.248863914749;5184.170532714786;4502.212112880233;4552.042621672679;4719.8612922406555;4720.43354797423;4749.786259618291;5414.296141501619;5467.097928841737;5509.944900550983;5524.696141712204;5524.779008839641;3932.4297976793205;3986.66113380363;4025.7117722328867;4028.315186418316;4040.2323558523785;5607.943920560783;5622.718864056781;5648.237487939116;5671.461211184931;5675.6878371689545;4041.8585349512628;4080.3879418087527;4093.5497095319492;4103.97948010258;4106.3635136553885;4137.462129923151;4138.8551400700835;4152.5432202457705;4152.730072545275;4155.877912963483;4583.381243532081;4604.631629469634;4675.976620116878;4684.156851766715;4727.3854398927915;5460.590455715837;5498.285222920995;5502.449755024546;5507.146392309199;5516.806911758069;1433.3120102350929;1435.0887186636353;1445.4724025730532;1451.998121296302;1455.039673815298;921.424109931293;925.2690374603987;937.465644582595;945.6075728572565;946.5693109635099;4691.906161876744;4714.528547145326;4735.905281894412;4740.838494568784;4759;4966.304717339575;5029.899402012013;5049.974750126225;5073.720945347967;5078.822241221614;4725.621950243973;4764.903442485295;4798.568128868349;4994.850154495371;5416.51251387377;3034.544818277276;3038.3771326878377;3040.239940014996;3048.8475576221545;3066.31008023193;5778.971105144531;5846.883062338729;5849.2103566018895;5869.53043756507;5872.884152011105;5537.197106419627;5777.111444277861;5821.854453638608;5829.562782791223;5843.474087332075;5817.912731309034;5835.665733706636;5839.620424672553;5845.766169353178;5862.443067908542;5415.972920135374;5660.632058916157;5710.257666503494;5724.570657200643;5732.254806875079;5633.521150702236;5641.069223578063;5647.667875953043;5685.630434021776;5686.60193786431;5822.3304320003745;5834.241548598655;5886.175935368966;5887.5575484006695;5906.616069955439;3983.521977362735;4118.299889018814;4124.587541245852;4151.937720934128;4179.832806687698;5790.913136303043;5836.591438599257;5853.356130825691;5864.648121112747;5865.384134665798;5499.835004949858;5668.603197776116;5728.79949201776;5735.942640573541;5741.311042674905;5534.723263836872;5537.754005348765;5552.944470555242;5562.332520097614;5582.86042848932;5241.44964778708;5457.789595213944;5496.890062198654;5517.613767036269;5548.195511650869;5379.757910894097;5576.27135587969;5590.496855282881;5597.720113994365;5627.268455100811;5482.945170548403;5494.2033405155225;5494.313210848644;5524.701695101568;5529.668219906818 17:39:10 INFO - PROCESS | 10488 | |5;yui.html;695.1692727191006;708.3412426443412;761.1551178192205;796.3310818912113;818.2962652119178;15034.473793417232;16521.173941302946;16551.586210344747;16560.171991400428;16582.41961531345;13871.375788089535;14658.780118298208;14889.925550372232;14918.701625967502;14933.551993440187;686.4885660183171;798.2895223251311;799.3445374792673;799.7081065411112;809.2069771623812;804.1676864445271;805.0982899152957;813.3615112136973;839.8866153069349;843.9915600844005;870.7300736771589;871.0331531999507;874.5802015032788;874.6107981948036;874.9387542872001;718.5580867766338;854.9615267312986;863.0334025891011;863.3007264116055;863.9827203455927;634.4163369699887;634.5082561015204;634.9174607301021;634.9301576826546;640.8301800022998;15963.521094367188;16042.39576042398;16062.036277823368;16062.678746425006;16077.276522556396;14477.78283325751;14600.561983140522;14640.194789286692;14769.852301476954;14888.10671359711;13282.800757988542;13302.866971330357;13339.799903001463;13559.322033898365;13586.116902401312;4481.5070342262325;4484.349769283435;4510.368548403226;4523.705959112647;4660;79168.60415697885;80794.59602702007;81203;81437;81815.18184818135;11473.71315717097;11521.884781152248;11552.826707599394;11701.23941943788;11794.351310677823;22513.662295065587;22789.430264243525;22835.657465138036;22847.200347987742;22873.428164296027;8444.493330400073;8481.787955301166;8705.956470217609;8717.564121794012;8805.735827925173;4648.372469716613;4770.499097594772;4790.856274311776;4873.756312184448;5085.440601533828;3504.737144714157;3591.317649646559;3606.585242697071;3630.636936306401;3630.709543236535;590.0441285118136;598.3597550620794;598.6198763785028;600.7266693654377;629.9401556852092;659.6437923521245;663.7676813115371;669.2537820330297;672.3881268046055;698.3644883156303;9146.90853091474;9413.952930235306;9466.90533094674;9503.667371642097;9539.90460095404;549.4944650921083;604.6372176693949;617.728199592178;630.9494691338961;693.1820451866846;4111.157212771434;4140.414939415244;4259.552746961586;4267.4025636410925;4717.669663825065;111538;112980;123767.38116309361;126148;126670;101786;106051;107437.46281268544;107712;108156.45921770498;76435.61782191053;91510.62734058994;91998;92835;93829;9098.499582523025;9188.58651360677;9196.954015229881;9207.677731279373;9286.674966376415;40625;45457.77271113756;45458;50877.49122508727;51703.22445163401;63998.3600164011;65239.347606523326;73718.26281737114;74027;74708.25291747013;13266;13288.335583220995;13356.532521362094;13363.331833408096;13928.885689145047;14843.92578037103;15157.466577607081;15300.617484562976;15542.689146216786;15618.21908904573;13172.538961136313;13203.669908251986;14012.649683757987;14070.96860413922;14535.781963270349;12134.150609457607;12421.689457763267;13197.472101115847;14170.362333695215;14588.416463341771;13924.58226253214;14165.36255868509;14265.714685706434;14636.268186590414;15025.173615451255;11093.944530277297;11388.772224555629;11741.647750567497;12124.454399551865;12156.878431215575;12154.270743755049;12188.695282618006;12269.447874845831;12289.357149225743;12474.937625311815 17:39:10 INFO - PROCESS | 10488 | __end_tp_report 17:39:10 INFO - PROCESS | 10488 | __start_cc_report 17:39:10 INFO - PROCESS | 10488 | _x_x_mozilla_cycle_collect,1008 17:39:10 INFO - PROCESS | 10488 | __end_cc_report 17:39:10 INFO - PROCESS | 10488 | __startTimestamp1465519150212__endTimestamp 17:39:10 INFO - PROCESS | 10488 | 17:39:10 INFO - PROCESS | 10488 | ------- Summary: start ------- 17:39:10 INFO - PROCESS | 10488 | Number of tests: 6 17:39:10 INFO - PROCESS | 10488 | 17:39:10 INFO - PROCESS | 10488 | [#0] dojo.html Cycles:165 Average:5255.10 Median:5439.76 stddev:597.54 (11.0%) stddev-sans-first:573.24 17:39:10 INFO - PROCESS | 10488 | Values: 3026.8 3048.4 3069.8 3084.7 3094.9 5069.1 5191.7 5214.6 5265.8 5290.5 5191.3 5226.4 5233.8 5241.7 5331.1 4723.0 4809.9 4815.7 4825.3 4842.5 4855.4 4899.6 4916.9 4918.1 4960.4 4720.8 4766.8 4767.8 4835.1 4852.9 4776.3 4797.2 4818.1 4849.7 4880.5 4761.6 4764.0 4774.1 4779.7 4814.0 5164.8 5189.5 5256.3 5261.7 5306.3 5568.8 5672.3 5682.7 5691.0 5691.6 5713.4 5713.9 5724.5 5725.8 5736.8 5164.4 5270.9 5295.7 5346.0 5348.5 5883.6 5883.8 5891.1 5893.2 5897.9 5615.4 5659.5 5669.5 5673.5 5674.6 5481.3 5573.3 5620.7 5651.4 5714.1 5640.8 5656.9 5661.7 5672.6 5675.9 5578.8 5635.0 5638.0 5641.7 5645.8 4197.2 4275.9 4298.6 4314.4 4361.1 3857.8 3867.6 3869.4 3901.9 3906.1 5249.2 5251.9 5253.6 5255.9 5261.3 5505.1 5607.8 5662.5 5669.4 5758.1 5351.6 5365.2 5365.4 5366.1 5380.2 4927.9 4934.0 4938.1 4938.5 4978.5 5702.5 5778.2 5820.8 5830.2 5851.0 5643.6 5678.9 5689.8 5697.5 5703.0 5866.5 5881.0 5882.2 5883.7 5885.6 5426.2 5521.2 5563.7 5580.2 5600.5 5662.6 5668.1 5683.3 5691.7 5691.9 5518.3 5578.4 5586.3 5589.6 5636.9 5459.3 5462.6 5490.3 5493.5 5527.3 5434.1 5438.9 5439.8 5444.5 5447.9 5430.7 5560.4 5566.8 5589.4 5609.6 5372.5 5416.7 5431.6 5471.6 5479.1 17:39:10 INFO - PROCESS | 10488 | 17:39:10 INFO - PROCESS | 10488 | [#1] ext.html Cycles:180 Average:59064.09 Median:229413.08 stddev:114008.28 (49.7%) stddev-sans-first:114243.53 17:39:10 INFO - PROCESS | 10488 | Values: 575.4 615.5 623.5 633.2 639.2 29843.1 41637.2 42015.6 42250.6 42387.8 43068.0 44218.0 44264.6 44288.3 44288.3 8989.8 9130.2 9131.9 9148.1 9148.1 8874.6 8983.6 8988.4 8997.7 8998.2 9051.4 9091.1 9098.7 9098.8 9101.8 8957.3 8976.4 8988.4 8989.2 8990.8 8938.0 9035.9 9040.4 9041.7 9047.3 42000.6 42295.4 42315.8 42351.4 42358.4 3480.8 3571.4 3617.3 3621.5 3638.7 32380.0 32438.5 32906.3 32924.2 33223.7 4379.8 4400.1 4406.7 4481.8 4597.9 357570.0 357603.0 357902.1 358678.0 359219.0 56137.0 56339.0 56542.7 56874.2 56937.1 58666.0 58793.0 58819.1 58904.0 58921.4 17303.5 17529.0 17574.0 17607.8 17624.3 13544.5 13568.9 13586.4 13641.5 13651.5 13717.7 15464.1 15469.4 15691.6 15814.2 5816.3 6000.9 6055.5 6117.4 6245.0 744.8 1019.2 1071.4 1098.3 1102.7 31550.0 31980.7 32147.8 32735.0 32911.3 1092.3 1150.0 1154.0 1157.5 1163.6 16385.4 16996.7 17055.4 17091.0 17170.7 502103.0 504287.0 504388.0 506724.0 507007.0 56183.4 56550.4 56696.7 56767.7 56956.7 1252.8 1323.5 1351.9 1359.2 1380.2 31369.2 32493.8 32853.3 32972.0 33086.3 49311.0 49391.3 49791.5 49860.5 49865.3 414181.0 417189.0 417673.0 419470.0 419532.0 37770.8 40463.6 40838.4 41142.2 43709.8 48311.0 48486.8 48622.8 49438.5 49548.3 38431.2 39989.0 40144.6 40249.2 40502.0 39294.8 40133.6 40365.8 40396.0 40570.2 40008.0 40251.4 40463.4 41004.1 41130.6 33967.3 35845.1 36152.5 36657.8 37212.0 27206.2 27487.5 27590.6 27682.9 27814.7 17:39:10 INFO - PROCESS | 10488 | 17:39:10 INFO - PROCESS | 10488 | [#2] jquery.html Cycles:180 Average:28325.53 Median:14917.23 stddev:81518.90 (546.5%) stddev-sans-first:81720.58 17:39:10 INFO - PROCESS | 10488 | Values: 382.4 386.8 394.3 408.6 418.7 18122.9 18611.3 19524.1 19632.4 19738.7 18313.5 18481.9 18642.5 18684.8 18695.8 5505.7 5681.9 5746.8 5755.2 5799.0 5532.2 5702.9 5726.3 5730.4 5746.1 5568.9 5579.4 5615.0 5634.4 5651.7 5625.3 5631.1 5638.6 5670.9 5717.5 4836.4 5055.4 5059.5 5065.7 5099.1 21410.1 21435.0 21604.6 22035.4 22045.9 2237.2 2252.4 2253.8 2289.3 2963.7 13981.5 14077.4 14089.7 14134.6 14669.3 1937.5 2013.6 2018.1 2034.2 2090.5 77085.6 77376.0 78578.2 79817.6 80167.6 9953.9 10199.1 10255.3 10386.4 10447.5 14528.3 14623.6 14647.5 14650.9 14652.6 7625.5 8230.9 8270.7 8364.1 8387.2 8051.6 8059.2 8128.5 8184.1 8250.8 6470.4 6494.7 6528.1 6533.7 6535.9 1905.6 1909.6 1929.6 1937.1 1965.3 983.0 984.7 1015.3 1042.9 1087.9 16798.0 18097.3 18366.9 18636.7 19100.1 1010.9 1022.8 1032.1 1036.3 1082.3 10472.2 10947.4 11004.9 11034.4 11044.6 478391.0 480640.0 481754.8 520298.0 521158.0 77035.6 79202.2 79572.8 80117.6 80296.6 955.9 961.4 981.9 988.4 999.9 15702.6 16029.6 16145.6 16192.9 16488.2 27545.2 28000.4 32135.7 34780.5 39201.4 51187.2 52880.0 52954.5 53269.5 53544.2 7388.9 7585.7 7663.6 7977.8 8145.6 12585.7 13448.7 13647.4 13736.9 13863.9 11328.7 11666.7 11688.0 11906.7 11989.9 11427.1 11849.2 11902.2 11914.6 11927.5 11737.9 11796.9 12001.2 12049.2 12285.4 7891.1 7898.8 7949.0 7964.6 8011.6 11354.1 11465.7 11885.7 11931.8 11994.5 17:39:10 INFO - PROCESS | 10488 | 17:39:10 INFO - PROCESS | 10488 | [#3] mootools.html Cycles:180 Average:5885.06 Median:5161.39 stddev:3340.73 (64.7%) stddev-sans-first:3332.18 17:39:10 INFO - PROCESS | 10488 | Values: 1281.0 1458.5 1492.2 1634.5 1803.9 8294.5 8794.5 8817.6 9058.5 9059.2 8774.2 8970.0 8989.0 8995.2 9000.1 2083.7 2281.1 2372.4 2380.2 2417.0 2342.7 2367.8 2374.0 2374.0 2376.0 2329.9 2353.0 2355.6 2360.4 2369.4 1979.0 2251.4 2315.5 2322.0 2329.5 2374.7 2390.3 2407.6 2411.1 2415.8 8956.3 9007.8 9013.0 9013.8 9015.9 5205.3 5219.9 5341.6 5346.0 5407.3 3443.0 3623.0 3635.6 3689.4 3693.6 1160.7 1197.3 1234.1 1258.4 1266.8 12680.1 12727.6 12733.8 12746.7 12758.2 4756.5 4866.4 4891.7 4892.8 4954.1 10492.8 10516.7 10543.7 10558.3 10563.1 5505.6 5513.7 5514.6 5515.4 5515.8 4153.8 4907.6 4993.8 5035.7 5094.9 4068.8 4076.5 4120.4 4125.0 4172.8 1259.2 1262.0 1271.8 1288.6 1290.7 818.6 896.2 906.7 925.4 965.0 5898.1 5915.5 6024.8 6117.4 6244.8 923.0 941.8 974.8 988.3 1017.9 3894.7 3998.1 4054.8 4099.1 4129.3 11013.7 11203.9 11305.9 11423.9 11490.3 11125.4 11206.8 11209.9 11287.3 11298.4 7948.1 8091.5 8272.7 8285.2 8470.3 5862.2 5897.9 5943.8 5947.9 6038.0 9323.8 9442.7 9601.6 9611.0 9625.3 9479.4 9771.7 9858.4 9859.4 9933.8 6796.9 7695.6 7807.9 7913.8 7943.0 8815.3 8835.2 8850.5 8902.2 8909.0 7577.6 7987.0 7999.5 8014.7 8101.2 7703.9 7821.6 7848.8 7874.4 7961.0 7242.7 7279.9 7324.3 7333.1 7336.3 4924.9 4956.7 5066.9 5078.5 5117.4 5308.1 5325.5 5374.2 5416.8 5447.2 17:39:10 INFO - PROCESS | 10488 | 17:39:10 INFO - PROCESS | 10488 | [#4] prototype.html Cycles:180 Average:4636.34 Median:5253.41 stddev:1354.82 (25.8%) stddev-sans-first:1319.41 17:39:10 INFO - PROCESS | 10488 | Values: 324.9 329.8 332.5 334.3 338.2 5327.5 5359.3 5392.1 5394.0 5399.0 5246.4 5260.4 5270.4 5282.9 5292.6 4081.8 4170.0 4171.8 4176.1 4203.0 4108.7 4138.9 4138.9 4155.5 4200.1 4123.6 4138.1 4161.4 4163.0 4172.5 3955.8 3973.4 4082.7 4139.6 4159.2 3619.8 3623.0 3641.9 3643.5 3662.8 5101.9 5130.2 5163.6 5180.2 5184.2 4502.2 4552.0 4719.9 4720.4 4749.8 5414.3 5467.1 5509.9 5524.7 5524.8 3932.4 3986.7 4025.7 4028.3 4040.2 5607.9 5622.7 5648.2 5671.5 5675.7 4041.9 4080.4 4093.5 4104.0 4106.4 4137.5 4138.9 4152.5 4152.7 4155.9 4583.4 4604.6 4676.0 4684.2 4727.4 5460.6 5498.3 5502.4 5507.1 5516.8 1433.3 1435.1 1445.5 1452.0 1455.0 921.4 925.3 937.5 945.6 946.6 4691.9 4714.5 4735.9 4740.8 4759.0 4966.3 5029.9 5050.0 5073.7 5078.8 4725.6 4764.9 4798.6 4994.9 5416.5 3034.5 3038.4 3040.2 3048.8 3066.3 5779.0 5846.9 5849.2 5869.5 5872.9 5537.2 5777.1 5821.9 5829.6 5843.5 5817.9 5835.7 5839.6 5845.8 5862.4 5416.0 5660.6 5710.3 5724.6 5732.3 5633.5 5641.1 5647.7 5685.6 5686.6 5822.3 5834.2 5886.2 5887.6 5906.6 3983.5 4118.3 4124.6 4151.9 4179.8 5790.9 5836.6 5853.4 5864.6 5865.4 5499.8 5668.6 5728.8 5735.9 5741.3 5534.7 5537.8 5552.9 5562.3 5582.9 5241.4 5457.8 5496.9 5517.6 5548.2 5379.8 5576.3 5590.5 5597.7 5627.3 5482.9 5494.2 5494.3 5524.7 5529.7 17:39:10 INFO - PROCESS | 10488 | 17:39:10 INFO - PROCESS | 10488 | [#5] yui.html Cycles:180 Average:21348.33 Median:4482.93 stddev:31049.33 (692.6%) stddev-sans-first:31097.70 17:39:10 INFO - PROCESS | 10488 | Values: 695.2 708.3 761.2 796.3 818.3 15034.5 16521.2 16551.6 16560.2 16582.4 13871.4 14658.8 14889.9 14918.7 14933.6 686.5 798.3 799.3 799.7 809.2 804.2 805.1 813.4 839.9 844.0 870.7 871.0 874.6 874.6 874.9 718.6 855.0 863.0 863.3 864.0 634.4 634.5 634.9 634.9 640.8 15963.5 16042.4 16062.0 16062.7 16077.3 14477.8 14600.6 14640.2 14769.9 14888.1 13282.8 13302.9 13339.8 13559.3 13586.1 4481.5 4484.3 4510.4 4523.7 4660.0 79168.6 80794.6 81203.0 81437.0 81815.2 11473.7 11521.9 11552.8 11701.2 11794.4 22513.7 22789.4 22835.7 22847.2 22873.4 8444.5 8481.8 8706.0 8717.6 8805.7 4648.4 4770.5 4790.9 4873.8 5085.4 3504.7 3591.3 3606.6 3630.6 3630.7 590.0 598.4 598.6 600.7 629.9 659.6 663.8 669.3 672.4 698.4 9146.9 9414.0 9466.9 9503.7 9539.9 549.5 604.6 617.7 630.9 693.2 4111.2 4140.4 4259.6 4267.4 4717.7 111538.0 112980.0 123767.4 126148.0 126670.0 101786.0 106051.0 107437.5 107712.0 108156.5 76435.6 91510.6 91998.0 92835.0 93829.0 9098.5 9188.6 9197.0 9207.7 9286.7 40625.0 45457.8 45458.0 50877.5 51703.2 63998.4 65239.3 73718.3 74027.0 74708.3 13266.0 13288.3 13356.5 13363.3 13928.9 14843.9 15157.5 15300.6 15542.7 15618.2 13172.5 13203.7 14012.6 14071.0 14535.8 12134.2 12421.7 13197.5 14170.4 14588.4 13924.6 14165.4 14265.7 14636.3 15025.2 11093.9 11388.8 11741.6 12124.5 12156.9 12154.3 12188.7 12269.4 12289.4 12474.9 17:39:10 INFO - PROCESS | 10488 | -------- Summary: end -------- 17:39:10 INFO - PROCESS | 10488 | 17:39:10 INFO - TEST-INFO | 10488: exit 0 17:39:10 INFO - TEST-OK | dromaeo_css | took 1113988ms 17:39:10 INFO - TEST-START | kraken 17:39:10 INFO - operating with platform_type : linux_ 17:39:10 INFO - Initialising browser for kraken test... 17:39:10 INFO - TEST-INFO | started process 10668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg9QEgG/profile http://localhost:43186/getInfo.html) 17:39:15 INFO - PROCESS | 10668 | __metrics Screen width/height:1600/1200 17:39:15 INFO - PROCESS | 10668 | colorDepth:24 17:39:15 INFO - PROCESS | 10668 | Browser inner width/height: 1024/697 17:39:15 INFO - PROCESS | 10668 | __metrics 17:39:16 ERROR - PROCESS | 10668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:39:16 INFO - PROCESS | 10668 | console.error: PushService: 17:39:16 INFO - PROCESS | 10668 | stateChangeProcessEnqueue: Error transitioning state 17:39:16 INFO - PROCESS | 10668 | UnknownError 17:39:17 INFO - TEST-INFO | 10668: exit 0 17:39:17 INFO - Browser initialized. 17:39:17 INFO - Running cycle 1/1 for kraken test... 17:39:17 INFO - TEST-INFO | started process 10753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg9QEgG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:29 INFO - PROCESS | 10753 | RSS: Main: 173010944 17:39:29 INFO - PROCESS | 10753 | 17:39:31 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43186/tests/kraken/driver.html?testName=audio-beat-detection) 17:39:32 INFO - PROCESS | 10753 | RSS: Main: 231485440 17:39:32 INFO - PROCESS | 10753 | 17:39:35 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43186/tests/kraken/driver.html?testName=audio-dft) 17:39:36 INFO - PROCESS | 10753 | RSS: Main: 219955200 17:39:36 INFO - PROCESS | 10753 | 17:39:39 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43186/tests/kraken/driver.html?testName=audio-fft) 17:39:39 INFO - PROCESS | 10753 | RSS: Main: 285458432 17:39:39 INFO - PROCESS | 10753 | 17:39:41 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43186/tests/kraken/driver.html?testName=audio-oscillator) 17:39:42 INFO - PROCESS | 10753 | RSS: Main: 196534272 17:39:42 INFO - PROCESS | 10753 | 17:39:44 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43186/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:39:45 INFO - PROCESS | 10753 | RSS: Main: 200269824 17:39:45 INFO - PROCESS | 10753 | 17:39:48 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43186/tests/kraken/driver.html?testName=imaging-darkroom) 17:39:48 INFO - PROCESS | 10753 | RSS: Main: 236732416 17:39:48 INFO - PROCESS | 10753 | 17:39:52 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43186/tests/kraken/driver.html?testName=imaging-desaturate) 17:39:52 INFO - PROCESS | 10753 | RSS: Main: 237260800 17:39:52 INFO - PROCESS | 10753 | 17:39:55 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43186/tests/kraken/driver.html?testName=json-parse-financial) 17:39:56 INFO - PROCESS | 10753 | RSS: Main: 236437504 17:39:56 INFO - PROCESS | 10753 | 17:39:57 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43186/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:39:58 INFO - PROCESS | 10753 | RSS: Main: 219725824 17:39:58 INFO - PROCESS | 10753 | 17:40:00 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43186/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:40:00 INFO - PROCESS | 10753 | RSS: Main: 225529856 17:40:00 INFO - PROCESS | 10753 | 17:40:02 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43186/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:40:03 INFO - PROCESS | 10753 | RSS: Main: 233496576 17:40:03 INFO - PROCESS | 10753 | 17:40:06 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:40:06 INFO - PROCESS | 10753 | RSS: Main: 238927872 17:40:06 INFO - PROCESS | 10753 | 17:40:09 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:40:10 INFO - PROCESS | 10753 | RSS: Main: 241102848 17:40:10 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | Cycle 1(1): loaded http://localhost:43186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43186/tests/kraken/driver.html?testName=ai-astar) 17:40:11 INFO - PROCESS | 10753 | RSS: Main: 283017216 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | __start_tp_report 17:40:11 INFO - PROCESS | 10753 | _x_x_mozilla_page_load 17:40:11 INFO - PROCESS | 10753 | _x_x_mozilla_page_load_details 17:40:11 INFO - PROCESS | 10753 | |i|pagename|runs| 17:40:11 INFO - PROCESS | 10753 | |0;ai-astar;110;104;110;109;113;111;109;112;109;110 17:40:11 INFO - PROCESS | 10753 | |1;audio-beat-detection;170;125;128;184;127;127;153;125;168;127 17:40:11 INFO - PROCESS | 10753 | |2;audio-dft;161;160;161;160;160;159;160;160;162;160 17:40:11 INFO - PROCESS | 10753 | |3;audio-fft;75;76;75;118;75;75;75;76;102;75 17:40:11 INFO - PROCESS | 10753 | |4;audio-oscillator;85;93;114;84;85;94;121;84;85;122 17:40:11 INFO - PROCESS | 10753 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;117;117;118 17:40:11 INFO - PROCESS | 10753 | |6;imaging-darkroom;146;146;145;146;145;147;146;146;146;146 17:40:11 INFO - PROCESS | 10753 | |7;imaging-desaturate;94;95;96;95;95;95;94;94;95;95 17:40:11 INFO - PROCESS | 10753 | |8;json-parse-financial;54;55;55;54;61;54;54;54;54;54 17:40:11 INFO - PROCESS | 10753 | |9;json-stringify-tinderbox;61;61;61;61;62;60;60;61;61;61 17:40:11 INFO - PROCESS | 10753 | |10;stanford-crypto-aes;79;78;84;78;80;80;81;80;113;81 17:40:11 INFO - PROCESS | 10753 | |11;stanford-crypto-ccm;121;137;123;123;121;129;126;131;132;132 17:40:11 INFO - PROCESS | 10753 | |12;stanford-crypto-pbkdf2;164;160;159;163;162;161;158;162;159;157 17:40:11 INFO - PROCESS | 10753 | |13;stanford-crypto-sha256-iterative;64;65;65;66;63;67;63;64;65;62 17:40:11 INFO - PROCESS | 10753 | __end_tp_report 17:40:11 INFO - PROCESS | 10753 | __start_cc_report 17:40:11 INFO - PROCESS | 10753 | _x_x_mozilla_cycle_collect,1634 17:40:11 INFO - PROCESS | 10753 | __end_cc_report 17:40:11 INFO - PROCESS | 10753 | __startTimestamp1465519211933__endTimestamp 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | ------- Summary: start ------- 17:40:11 INFO - PROCESS | 10753 | Number of tests: 14 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:2.41 (2.2%) stddev-sans-first:2.55 17:40:11 INFO - PROCESS | 10753 | Values: 110.0 104.0 110.0 109.0 113.0 111.0 109.0 112.0 109.0 110.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:140.50 stddev:23.03 (16.4%) stddev-sans-first:22.33 17:40:11 INFO - PROCESS | 10753 | Values: 170.0 125.0 128.0 184.0 127.0 127.0 153.0 125.0 168.0 127.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 17:40:11 INFO - PROCESS | 10753 | Values: 161.0 160.0 161.0 160.0 160.0 159.0 160.0 160.0 162.0 160.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:15.13 (20.2%) stddev-sans-first:15.83 17:40:11 INFO - PROCESS | 10753 | Values: 75.0 76.0 75.0 118.0 75.0 75.0 75.0 76.0 102.0 75.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:85.00 stddev:15.93 (18.7%) stddev-sans-first:16.32 17:40:11 INFO - PROCESS | 10753 | Values: 85.0 93.0 114.0 84.0 85.0 94.0 121.0 84.0 85.0 122.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:40:11 INFO - PROCESS | 10753 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:40:11 INFO - PROCESS | 10753 | Values: 146.0 146.0 145.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 17:40:11 INFO - PROCESS | 10753 | Values: 94.0 95.0 96.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.00 stddev:2.18 (4.0%) stddev-sans-first:2.29 17:40:11 INFO - PROCESS | 10753 | Values: 54.0 55.0 55.0 54.0 61.0 54.0 54.0 54.0 54.0 54.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 17:40:11 INFO - PROCESS | 10753 | Values: 61.0 61.0 61.0 61.0 62.0 60.0 60.0 61.0 61.0 61.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:80.00 stddev:10.54 (13.2%) stddev-sans-first:11.06 17:40:11 INFO - PROCESS | 10753 | Values: 79.0 78.0 84.0 78.0 80.0 80.0 81.0 80.0 113.0 81.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:130.00 stddev:5.50 (4.2%) stddev-sans-first:5.31 17:40:11 INFO - PROCESS | 10753 | Values: 121.0 137.0 123.0 123.0 121.0 129.0 126.0 131.0 132.0 132.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.50 stddev:2.27 (1.4%) stddev-sans-first:2.03 17:40:11 INFO - PROCESS | 10753 | Values: 164.0 160.0 159.0 163.0 162.0 161.0 158.0 162.0 159.0 157.0 17:40:11 INFO - PROCESS | 10753 | 17:40:11 INFO - PROCESS | 10753 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:1.51 (2.3%) stddev-sans-first:1.59 17:40:11 INFO - PROCESS | 10753 | Values: 64.0 65.0 65.0 66.0 63.0 67.0 63.0 64.0 65.0 62.0 17:40:11 INFO - PROCESS | 10753 | -------- Summary: end -------- 17:40:11 INFO - PROCESS | 10753 | 17:40:12 INFO - TEST-INFO | 10753: exit 0 17:40:12 INFO - TEST-OK | kraken | took 61990ms 17:40:12 INFO - SUITE-END | took 1175s 17:40:13 INFO - Completed test suite (00:19:36) 17:40:13 INFO - javascript benchmark 17:40:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3026.8335241561713, 3048.3903219356134, 3069.754419646428, 3084.6761090085556, 3094.8916787912426, 5069.087564238435, 5191.662541934772, 5214.556762675173, 5265.789368425263, 5290.497402746738, 5191.273221748958, 5226.425093239741, 5233.79064837407, 5241.659292146008, 5331.147016477365, 4723.0, 4809.90380192396, 4815.66290359675, 4825.276208568707, 4842.539958703936, 4855.393075865517, 4899.559039686427, 4916.877078073059, 4918.0901533216465, 4960.404751429815, 4720.76396180193, 4766.761661916925, 4767.833125840579, 4835.1296766582, 4852.927206091911, 4776.25967974961, 4797.18447863864, 4818.108649899745, 4849.660523763338, 4880.511948805127, 4761.59526440253, 4763.952360476385, 4774.140654682155, 4779.737114458703, 4814.0, 5164.845054648366, 5189.532942035197, 5256.316678831728, 5261.710605916673, 5306.283651707047, 5568.832935011957, 5672.290963629546, 5682.7442765075675, 5691.0, 5691.573132015115, 5713.400092990218, 5713.914291285634, 5724.484796368347, 5725.799597014085, 5736.7992120276, 5164.406093299281, 5270.868228294246, 5295.735213239323, 5346.03771321162, 5348.545373643245, 5883.588148829541, 5883.794067207627, 5891.145783861316, 5893.2044174035955, 5897.941020589825, 5615.410381909923, 5659.518940889988, 5669.489745922887, 5673.546116310686, 5674.602777805514, 5481.342238931354, 5573.331200255914, 5620.747066382022, 5651.378348381675, 5714.142878568165, 5640.774369025193, 5656.85857853557, 5661.66030038199, 5672.602917795714, 5675.886482270332, 5578.804741834017, 5635.0, 5638.0, 5641.689707066069, 5645.802396916089, 4197.160567886435, 4275.914481710349, 4298.634616057608, 4314.352847072902, 4361.105973275471, 3857.787821669779, 3867.6325749053794, 3869.400242962345, 3901.941470877939, 3906.121122747359, 5249.212618107238, 5251.894962100737, 5253.579713622901, 5255.894882102337, 5261.289725887033, 5505.091659876156, 5607.775688972477, 5662.546996240291, 5669.40471250521, 5758.078707406795, 5351.598630102758, 5365.195220716923, 5365.38298095724, 5366.060939335601, 5380.1929710542945, 4927.876803079952, 4934.037862616827, 4938.111139994764, 4938.530839570235, 4978.502149785065, 5702.54379649627, 5778.248827652463, 5820.76716931318, 5830.18377427169, 5851.0, 5643.576731745054, 5678.943210567842, 5689.800856969986, 5697.515711164598, 5703.0, 5866.530677545871, 5880.970595146997, 5882.23530940975, 5883.735231914659, 5885.55858310637, 5426.240326354235, 5521.2270282159725, 5563.7496312666835, 5580.21876937221, 5600.4959553640365, 5662.631928924607, 5668.121441176624, 5683.318001839806, 5691.743871525874, 5691.943080569141, 5518.255035570147, 5578.414266501959, 5586.301712285965, 5589.55283577321, 5636.915446268227, 5459.2902922619805, 5462.644928079662, 5490.3411590609385, 5493.533049690821, 5527.336719593674, 5434.130539113723, 5438.945610543844, 5439.755211015593, 5444.482774136451, 5447.863803404946, 5430.67415955044, 5560.4161563035295, 5566.832995010156, 5589.357223919302, 5609.579281553982, 5372.516473517402, 5416.7020813855615, 5431.646942948696, 5471.6169868108855, 5479.123340265538], "value": 5214.7314998732345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.4245754245754, 615.5383462403198, 623.5136593457103, 633.2021652717576, 639.1754636518891, 29843.1047068588, 41637.16725665489, 42015.57984420155, 42250.57749422505, 42387.78806105969, 43068.0, 44218.0, 44264.55735442645, 44288.33567496482, 44288.3356749649, 8989.77525561863, 9130.178283954443, 9131.863022054675, 9148.085191480865, 9148.130927561871, 8874.556272186397, 8983.640654373818, 8988.370814043019, 8997.685081022166, 8998.235150012257, 9051.366404351698, 9091.090890910922, 9098.681546145854, 9098.77253068672, 9101.817963640757, 8957.283417326598, 8976.371653984224, 8988.370814043019, 8989.190972812414, 8990.775230619221, 8937.955310223408, 9035.909640903637, 9040.367174297802, 9041.734157217994, 9047.321450891144, 42000.57999419997, 42295.40489058434, 42315.78842105801, 42351.36472952908, 42358.36462453066, 3480.791152530831, 3571.4107172316535, 3617.2584620152807, 3621.4748861414946, 3638.7089032877307, 32380.0, 32438.513422298685, 32906.341873162404, 32924.1768955778, 33223.6677633223, 4379.75911324877, 4400.11997600478, 4406.669499787528, 4481.820727170909, 4597.862064138081, 357570.0, 357603.0, 357902.05244869087, 358678.0, 359219.0, 56137.0, 56339.0, 56542.7172864133, 56874.17509898839, 56937.145942810894, 58666.0, 58793.0, 58819.11771323434, 58904.0, 58921.410785891596, 17303.480895572902, 17529.0, 17574.0, 17607.823921760875, 17624.29502819873, 13544.525941591997, 13568.93215533916, 13586.38861251246, 13641.454341826216, 13651.453941842414, 13717.725645487233, 15464.14947177916, 15469.381224751109, 15691.607709807346, 15814.209289535478, 5816.302043754692, 6000.949833779071, 6055.485283750931, 6117.418845209698, 6245.0, 744.7971574713973, 1019.179560453827, 1071.4160782373624, 1098.2531878322657, 1102.7188067042853, 31550.0, 31980.68019319777, 32147.839260804016, 32735.0, 32911.3417731644, 1092.2845536173818, 1149.9942500287445, 1153.9826902596467, 1157.455995682028, 1163.6218229075585, 16385.426510072328, 16996.660066798595, 17055.403060892808, 17091.005285723477, 17170.65658686844, 502103.0, 504287.0, 504388.0, 506724.0, 507007.0, 56183.43816561782, 56550.43449565452, 56696.732130715136, 56767.71616141893, 56956.715216423654, 1252.843394575678, 1323.483841301893, 1351.9391627376792, 1359.238826257299, 1380.1925873364194, 31369.215769605944, 32493.837530812194, 32853.342933141685, 32972.0, 33086.338273234884, 49311.0, 49391.25913111378, 49791.50208497869, 49860.501394985586, 49865.25202122044, 414181.0, 417189.0, 417673.0, 419470.0, 419532.0, 37770.81114594409, 40463.59536404716, 40838.387424189255, 41142.1771564573, 43709.78145109254, 48311.0, 48486.75756621194, 48622.75688621534, 49438.50561494339, 49548.25677614767, 38431.231375372896, 39989.0, 40144.59855401408, 40249.1950161001, 40502.0, 39294.803525982185, 40133.598664012985, 40365.79817100896, 40396.0, 40570.1885962285, 40007.99980000523, 40251.39622905717, 40463.393049104874, 41004.079510458934, 41130.588694112674, 33967.3206535863, 35845.05916213678, 36152.45771313485, 36657.816710916275, 37212.0, 27206.183814485597, 27487.45025099527, 27590.586141207496, 27682.861585691942, 27814.721852782022], "value": 20072.50957112868, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.4492730468124, 386.81819544813936, 394.34735512726445, 408.57304117197526, 418.6692512914797, 18122.90938545307, 18611.348602798906, 19524.121414536345, 19632.411027669175, 19738.703919441185, 18313.54216144597, 18481.907590462062, 18642.533936651558, 18684.81315186851, 18695.813041869576, 5505.6696598204235, 5681.886362272752, 5746.798862039829, 5755.2230448889495, 5799.043157878945, 5532.170174473821, 5702.914456283159, 5726.284214473191, 5730.369659337491, 5746.051901436279, 5568.888622227573, 5579.358373787026, 5615.0, 5634.408387119355, 5651.745671444774, 5625.324961004706, 5631.099024156136, 5638.633488823213, 5670.858228544278, 5717.456841600041, 4836.443808961979, 5055.4186268579215, 5059.494050594948, 5065.670731402447, 5099.08216521026, 21410.143594256366, 21435.0, 21604.567908641897, 22035.449113772283, 22045.889770551206, 2237.19460994042, 2252.3693365857584, 2253.8196944244423, 2289.278877153691, 2963.68881267466, 13981.510647127301, 14077.366518506691, 14089.718205635932, 14134.646633834134, 14669.33987970544, 1937.5059359863285, 2013.5670830771307, 2018.1019446346381, 2034.176158655732, 2090.5087304483586, 77085.61457192735, 77376.0, 78578.21421785823, 79817.60091199564, 80167.5991620044, 9953.900460995443, 10199.113164064673, 10255.282130250811, 10386.42874641902, 10447.529861156267, 14528.346224419927, 14623.561293161221, 14647.487337943121, 14650.853491464948, 14652.560423187322, 7625.504342217738, 8230.917690823135, 8270.669173233124, 8364.121767214476, 8387.245147936716, 8051.5571643559, 8059.153788852086, 8128.471649342774, 8184.140665230184, 8250.834983300301, 6470.417662410406, 6494.675266236669, 6528.08606795049, 6533.705983230766, 6535.934640653532, 1905.6188762247607, 1909.5703466719876, 1929.5851391950798, 1937.1282922684848, 1965.2532037825536, 982.9995958224978, 984.6602921991902, 1015.279151802214, 1042.9153680172535, 1087.8585783848207, 16798.0, 18097.276108955495, 18366.908165459354, 18636.72044919327, 19100.140493677816, 1010.9090181883665, 1022.7852151048214, 1032.0814475117152, 1036.2538971940191, 1082.2802836114054, 10472.214583906085, 10947.397893115955, 11004.889951100387, 11034.393108378956, 11044.613438529614, 478391.0, 480640.0, 481754.807332954, 520298.0, 521158.0, 77035.61482192553, 79202.20797792064, 79572.83844453911, 80117.59941200257, 80296.59851700821, 955.9474228917337, 961.3510880155867, 981.9134339528501, 988.3871999360299, 999.8951158969379, 15702.607434813764, 16029.599260018593, 16145.596360090622, 16192.919035404748, 16488.17559122015, 27545.173644790688, 28000.43999120047, 32135.67864321327, 34780.478292826134, 39201.411978820914, 51187.232191517905, 52880.0, 52954.470455294955, 53269.467305328, 53544.19683704826, 7388.926110739038, 7585.734499292498, 7663.616819159131, 7977.840443190988, 8145.592720364077, 12585.685357866127, 13448.731025379633, 13647.404058729608, 13736.93131534336, 13863.861361386256, 11328.660140195807, 11666.733314671905, 11688.0, 11906.702332441759, 11989.880101199225, 11427.142964277546, 11849.229800062969, 11902.226355286879, 11914.582989595669, 11927.522899084286, 11737.88262117368, 11796.94101529487, 12001.219920705125, 12049.156559040783, 12285.447154877873, 7891.092524359772, 7898.842023159619, 7948.96663433773, 7964.601769911365, 8011.639476223468, 11354.091672666333, 11465.713357166138, 11885.702857428634, 11931.821022684493, 11994.460249288977], "value": 9135.57005849737, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.9807852882213, 1458.5186888326853, 1492.1569313337964, 1634.4933070748061, 1803.9458816235517, 8294.4608600441, 8794.51630160341, 8817.559122043887, 9058.547072646374, 9059.229965452945, 8774.210321071103, 8970.0, 8988.955055224731, 8995.190432861042, 9000.144986226314, 2083.677030060343, 2281.087564974007, 2372.4424760181346, 2380.1550449590363, 2416.9516609667794, 2342.6720259163644, 2367.7987371073477, 2373.95252094958, 2373.9881300593474, 2376.013954209001, 2329.8835058247105, 2353.0, 2355.611324131516, 2360.409897525619, 2369.4313364792497, 1978.980210197894, 2251.3921241264766, 2315.4790172211287, 2321.9535609287886, 2329.51080273142, 2374.6675465434855, 2390.3187591536503, 2407.590709579376, 2411.0837881605053, 2415.806735461159, 8956.283497320264, 9007.774805629846, 9013.0, 9013.819723605557, 9015.909840901573, 5205.349331333583, 5219.929914367545, 5341.572674186055, 5345.973270133624, 5407.324084489439, 3442.9827850860584, 3622.9637703623152, 3635.600083990759, 3689.409694448902, 3693.5752388475403, 1160.7388337624052, 1197.263682835059, 1234.1052736765773, 1258.4399942025711, 1266.7909794883833, 12680.112392132554, 12727.554535591209, 12733.808992865022, 12746.681332966657, 12758.170718903242, 4756.548127927841, 4866.367372241586, 4891.682040667345, 4892.779824907888, 4954.1082605130705, 10492.790144197073, 10516.737081573021, 10543.683689489328, 10558.260921735558, 10563.1021363185, 5505.559555235572, 5513.696746678971, 5514.641548299348, 5515.448455154453, 5515.806946756844, 4153.750774953452, 4907.55831975124, 4993.800247990112, 5035.697858128524, 5094.923576146361, 4068.8372465101065, 4076.4522173641476, 4120.443740095049, 4125.0, 4172.833086676499, 1259.2192840438804, 1261.9810702839466, 1271.815586739936, 1288.62629837348, 1290.728946921157, 818.6479813680174, 896.2068569316202, 906.7098528470826, 925.412363149405, 965.0012237334325, 5898.1152827076285, 5915.497182739429, 6024.849378765566, 6117.357677443893, 6244.784770280043, 922.9953850230706, 941.8493041113526, 974.7563109222694, 988.2588058955783, 1017.9185665146771, 3894.7078969077434, 3998.1204135090234, 4054.7567145971334, 4099.077707515785, 4129.256733787947, 11013.724656883642, 11203.94398028021, 11305.943470282597, 11423.885761142283, 11490.253133546294, 11125.443727813577, 11206.831897521544, 11209.887901120885, 11287.322760634388, 11298.378589177673, 7948.125706172432, 8091.514509129471, 8272.710455134042, 8285.212904774036, 8470.322374210049, 5862.208601838697, 5897.941020589739, 5943.762249509971, 5947.910781338197, 6038.0, 9323.766905827408, 9442.669506567237, 9601.615935362508, 9611.0, 9625.278104142077, 9479.431234125974, 9771.657991970531, 9858.408495490006, 9859.408435493893, 9933.801323973625, 6796.864062718619, 7695.615219239127, 7807.9219207809465, 7913.802154946173, 7943.046834379911, 8815.338849586178, 8835.160659737314, 8850.468971861708, 8902.198802107841, 8908.955455222942, 7577.583232922242, 7987.041555013436, 7999.520028798291, 8014.719484818003, 8101.230383113595, 7703.884441733267, 7821.608919553886, 7848.84302313962, 7874.448788584744, 7961.0, 7242.7465038725495, 7279.8544029120185, 7324.267573242633, 7333.1200255969625, 7336.266373362621, 4924.852254432372, 4956.72737999399, 5066.898662026665, 5078.542931136216, 5117.437081920912, 5308.071087559739, 5325.4940780625775, 5374.220737993047, 5416.83749487516, 5447.1829225616475], "value": 4706.2609820702455, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.94151052810486, 329.8251926478967, 332.51286864743133, 334.2762918281919, 338.16641977525404, 5327.467253274671, 5359.303290572225, 5392.110301800208, 5393.973030134854, 5399.0, 5246.449122842104, 5260.368755749316, 5270.420253772091, 5282.947170528294, 5292.603054770889, 4081.755094694313, 4170.0, 4171.812268447912, 4176.143890502447, 4203.0, 4108.691848111389, 4138.875833724993, 4138.896527586804, 4155.459790227266, 4200.088959523409, 4123.649489793371, 4138.089620283547, 4161.4382058422025, 4162.979185104085, 4172.499300083994, 3955.833029256362, 3973.423853541249, 4082.6733861291027, 4139.606737359946, 4159.23054234966, 3619.7828130312264, 3622.9637703623152, 3641.908952276188, 3643.526341575578, 3662.7802331860175, 5101.897962040775, 5130.204818253177, 5163.561097306733, 5180.248863914749, 5184.170532714786, 4502.212112880233, 4552.042621672679, 4719.8612922406555, 4720.43354797423, 4749.786259618291, 5414.296141501619, 5467.097928841737, 5509.944900550983, 5524.696141712204, 5524.779008839641, 3932.4297976793205, 3986.66113380363, 4025.7117722328867, 4028.315186418316, 4040.2323558523785, 5607.943920560783, 5622.718864056781, 5648.237487939116, 5671.461211184931, 5675.6878371689545, 4041.8585349512628, 4080.3879418087527, 4093.5497095319492, 4103.97948010258, 4106.3635136553885, 4137.462129923151, 4138.8551400700835, 4152.5432202457705, 4152.730072545275, 4155.877912963483, 4583.381243532081, 4604.631629469634, 4675.976620116878, 4684.156851766715, 4727.3854398927915, 5460.590455715837, 5498.285222920995, 5502.449755024546, 5507.146392309199, 5516.806911758069, 1433.3120102350929, 1435.0887186636353, 1445.4724025730532, 1451.998121296302, 1455.039673815298, 921.424109931293, 925.2690374603987, 937.465644582595, 945.6075728572565, 946.5693109635099, 4691.906161876744, 4714.528547145326, 4735.905281894412, 4740.838494568784, 4759.0, 4966.304717339575, 5029.899402012013, 5049.974750126225, 5073.720945347967, 5078.822241221614, 4725.621950243973, 4764.903442485295, 4798.568128868349, 4994.850154495371, 5416.51251387377, 3034.544818277276, 3038.3771326878377, 3040.239940014996, 3048.8475576221545, 3066.31008023193, 5778.971105144531, 5846.883062338729, 5849.2103566018895, 5869.53043756507, 5872.884152011105, 5537.197106419627, 5777.111444277861, 5821.854453638608, 5829.562782791223, 5843.474087332075, 5817.912731309034, 5835.665733706636, 5839.620424672553, 5845.766169353178, 5862.443067908542, 5415.972920135374, 5660.632058916157, 5710.257666503494, 5724.570657200643, 5732.254806875079, 5633.521150702236, 5641.069223578063, 5647.667875953043, 5685.630434021776, 5686.60193786431, 5822.3304320003745, 5834.241548598655, 5886.175935368966, 5887.5575484006695, 5906.616069955439, 3983.521977362735, 4118.299889018814, 4124.587541245852, 4151.937720934128, 4179.832806687698, 5790.913136303043, 5836.591438599257, 5853.356130825691, 5864.648121112747, 5865.384134665798, 5499.835004949858, 5668.603197776116, 5728.79949201776, 5735.942640573541, 5741.311042674905, 5534.723263836872, 5537.754005348765, 5552.944470555242, 5562.332520097614, 5582.86042848932, 5241.44964778708, 5457.789595213944, 5496.890062198654, 5517.613767036269, 5548.195511650869, 5379.757910894097, 5576.27135587969, 5590.496855282881, 5597.720113994365, 5627.268455100811, 5482.945170548403, 5494.2033405155225, 5494.313210848644, 5524.701695101568, 5529.668219906818], "value": 4206.823849235669, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.1692727191006, 708.3412426443412, 761.1551178192205, 796.3310818912113, 818.2962652119178, 15034.473793417232, 16521.173941302946, 16551.586210344747, 16560.171991400428, 16582.41961531345, 13871.375788089535, 14658.780118298208, 14889.925550372232, 14918.701625967502, 14933.551993440187, 686.4885660183171, 798.2895223251311, 799.3445374792673, 799.7081065411112, 809.2069771623812, 804.1676864445271, 805.0982899152957, 813.3615112136973, 839.8866153069349, 843.9915600844005, 870.7300736771589, 871.0331531999507, 874.5802015032788, 874.6107981948036, 874.9387542872001, 718.5580867766338, 854.9615267312986, 863.0334025891011, 863.3007264116055, 863.9827203455927, 634.4163369699887, 634.5082561015204, 634.9174607301021, 634.9301576826546, 640.8301800022998, 15963.521094367188, 16042.39576042398, 16062.036277823368, 16062.678746425006, 16077.276522556396, 14477.78283325751, 14600.561983140522, 14640.194789286692, 14769.852301476954, 14888.10671359711, 13282.800757988542, 13302.866971330357, 13339.799903001463, 13559.322033898365, 13586.116902401312, 4481.5070342262325, 4484.349769283435, 4510.368548403226, 4523.705959112647, 4660.0, 79168.60415697885, 80794.59602702007, 81203.0, 81437.0, 81815.18184818135, 11473.71315717097, 11521.884781152248, 11552.826707599394, 11701.23941943788, 11794.351310677823, 22513.662295065587, 22789.430264243525, 22835.657465138036, 22847.200347987742, 22873.428164296027, 8444.493330400073, 8481.787955301166, 8705.956470217609, 8717.564121794012, 8805.735827925173, 4648.372469716613, 4770.499097594772, 4790.856274311776, 4873.756312184448, 5085.440601533828, 3504.737144714157, 3591.317649646559, 3606.585242697071, 3630.636936306401, 3630.709543236535, 590.0441285118136, 598.3597550620794, 598.6198763785028, 600.7266693654377, 629.9401556852092, 659.6437923521245, 663.7676813115371, 669.2537820330297, 672.3881268046055, 698.3644883156303, 9146.90853091474, 9413.952930235306, 9466.90533094674, 9503.667371642097, 9539.90460095404, 549.4944650921083, 604.6372176693949, 617.728199592178, 630.9494691338961, 693.1820451866846, 4111.157212771434, 4140.414939415244, 4259.552746961586, 4267.4025636410925, 4717.669663825065, 111538.0, 112980.0, 123767.38116309361, 126148.0, 126670.0, 101786.0, 106051.0, 107437.46281268544, 107712.0, 108156.45921770498, 76435.61782191053, 91510.62734058994, 91998.0, 92835.0, 93829.0, 9098.499582523025, 9188.58651360677, 9196.954015229881, 9207.677731279373, 9286.674966376415, 40625.0, 45457.77271113756, 45458.0, 50877.49122508727, 51703.22445163401, 63998.3600164011, 65239.347606523326, 73718.26281737114, 74027.0, 74708.25291747013, 13266.0, 13288.335583220995, 13356.532521362094, 13363.331833408096, 13928.885689145047, 14843.92578037103, 15157.466577607081, 15300.617484562976, 15542.689146216786, 15618.21908904573, 13172.538961136313, 13203.669908251986, 14012.649683757987, 14070.96860413922, 14535.781963270349, 12134.150609457607, 12421.689457763267, 13197.472101115847, 14170.362333695215, 14588.416463341771, 13924.58226253214, 14165.36255868509, 14265.714685706434, 14636.268186590414, 15025.173615451255, 11093.944530277297, 11388.772224555629, 11741.647750567497, 12124.454399551865, 12156.878431215575, 12154.270743755049, 12188.695282618006, 12269.447874845831, 12289.357149225743, 12474.937625311815], "value": 7659.09551823638, "unit": "score"}], "name": "dromaeo_css", "value": 7248.3147494135355, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 109.0, 113.0, 111.0, 109.0, 112.0, 109.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 125.0, 128.0, 184.0, 127.0, 127.0, 153.0, 125.0, 168.0, 127.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 159.0, 160.0, 160.0, 162.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 118.0, 75.0, 75.0, 75.0, 76.0, 102.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 93.0, 114.0, 84.0, 85.0, 94.0, 121.0, 84.0, 85.0, 122.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 61.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 60.0, 60.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 84.0, 78.0, 80.0, 80.0, 81.0, 80.0, 113.0, 81.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 137.0, 123.0, 123.0, 121.0, 129.0, 126.0, 131.0, 132.0, 132.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 159.0, 163.0, 162.0, 161.0, 158.0, 162.0, 159.0, 157.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 63.0, 67.0, 63.0, 64.0, 65.0, 62.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1501.9, "alertThreshold": 2.0}]} 17:40:13 INFO - Return code: 0 17:40:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:40:13 ERROR - # TBPL SUCCESS # 17:40:13 INFO - Running post-action listener: _resource_record_post_action 17:40:13 INFO - ##### 17:40:13 INFO - ##### Finished run-tests step (success) 17:40:13 INFO - ##### 17:40:13 INFO - Running post-run listener: _resource_record_post_run 17:40:13 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 546926592; Read time: 0; Write time: 555524 17:40:13 INFO - TinderboxPrint: CPU usage
13.2% 17:40:13 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:40:13 INFO - TinderboxPrint: I/O write bytes / time
546,926,592 / 555,524 17:40:13 INFO - TinderboxPrint: CPU idle
8,270.5 (86.8%) 17:40:13 INFO - TinderboxPrint: CPU user
1,208.8 (12.7%) 17:40:13 INFO - TinderboxPrint: Swap in / out
0 / 0 17:40:13 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259702784; Read time: 0; Write time: 265000 17:40:13 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 287223808; Read time: 0; Write time: 290524 17:40:13 INFO - Running post-run listener: _upload_blobber_files 17:40:13 INFO - Blob upload gear active. 17:40:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:40:13 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 17:40:13 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'] 17:40:13 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 17:40:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:40:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:40:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:40:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:14 INFO - (blobuploader) - INFO - Done attempting. 17:40:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:40:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:40:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:16 INFO - (blobuploader) - INFO - Done attempting. 17:40:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:40:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:40:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:21 INFO - (blobuploader) - INFO - Done attempting. 17:40:21 INFO - (blobuploader) - INFO - Iteration through files over. 17:40:21 INFO - Return code: 0 17:40:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:40:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:40:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79c33d051b549348ae1238795183b44c5f72127c3101226b69cab251921285002b94f7b8f0fcabcb11485001c290ac4c5be41816724e80241e3bac64b19b8469", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23eb2da87a0929044168d0369ce5e458b0c35e85be3a35c446d83458119ef0d40d794bdc294aa7e756b319fd87c0cbd84445ca7e4a5dc8df0194b3ca234be68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/394dbb4b6d6ec97bb3afe92fb28925a507c0491daa57a6354bb9bef042267c8ae5947da859d97c93c315f0943e4955e5a5552582c5abc149b178dfb3be0cf6d1"} 17:40:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:40:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:40:21 INFO - Contents: 17:40:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79c33d051b549348ae1238795183b44c5f72127c3101226b69cab251921285002b94f7b8f0fcabcb11485001c290ac4c5be41816724e80241e3bac64b19b8469", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23eb2da87a0929044168d0369ce5e458b0c35e85be3a35c446d83458119ef0d40d794bdc294aa7e756b319fd87c0cbd84445ca7e4a5dc8df0194b3ca234be68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/394dbb4b6d6ec97bb3afe92fb28925a507c0491daa57a6354bb9bef042267c8ae5947da859d97c93c315f0943e4955e5a5552582c5abc149b178dfb3be0cf6d1"} 17:40:21 INFO - Running post-run listener: copy_logs_to_upload_dir 17:40:21 INFO - Copying logs to upload dir... 17:40:21 INFO - mkdir: /builds/slave/test/build/upload/logs 17:40:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.137560 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-09 17:40:21.084293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 17:40:21.087957) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79c33d051b549348ae1238795183b44c5f72127c3101226b69cab251921285002b94f7b8f0fcabcb11485001c290ac4c5be41816724e80241e3bac64b19b8469", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23eb2da87a0929044168d0369ce5e458b0c35e85be3a35c446d83458119ef0d40d794bdc294aa7e756b319fd87c0cbd84445ca7e4a5dc8df0194b3ca234be68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/394dbb4b6d6ec97bb3afe92fb28925a507c0491daa57a6354bb9bef042267c8ae5947da859d97c93c315f0943e4955e5a5552582c5abc149b178dfb3be0cf6d1"} build_url:https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011593 build_url: 'https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79c33d051b549348ae1238795183b44c5f72127c3101226b69cab251921285002b94f7b8f0fcabcb11485001c290ac4c5be41816724e80241e3bac64b19b8469", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23eb2da87a0929044168d0369ce5e458b0c35e85be3a35c446d83458119ef0d40d794bdc294aa7e756b319fd87c0cbd84445ca7e4a5dc8df0194b3ca234be68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/394dbb4b6d6ec97bb3afe92fb28925a507c0491daa57a6354bb9bef042267c8ae5947da859d97c93c315f0943e4955e5a5552582c5abc149b178dfb3be0cf6d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 17:40:21.117894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:40:21.118228) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465517981.776980-125545076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:40:21.200350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 17:40:21.200732) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 17:40:21.201042) ========= ========= Total master_lag: 0.17 =========