builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1466694620.74 results: success (0) buildid: 20160623053004 builduid: ec09f4010edb4e879ae2822395415733 revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:20.743584) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:20.744126) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:20.744426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:20.759720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:20.760042) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 08:10:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-06-23 08:10:21 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116437 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:20.890420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:20.890775) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015227 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:20.940467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:20.940824) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --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 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --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=31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 08:10:21,131 truncating revision to first 12 chars 2016-06-23 08:10:21,131 Setting DEBUG logging. 2016-06-23 08:10:21,131 attempt 1/10 2016-06-23 08:10:21,131 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cdc8b1b2bb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 08:10:21,445 unpacking tar archive at: fx-team-3cdc8b1b2bb5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643430 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:21.598111) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:21.598444) ========= script_repo_revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:21.598855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:21.599121) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:10:21.609080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-23 08:10:21.609393) ========= /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=31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:10:21 INFO - MultiFileLogger online at 20160623 08:10:21 in /builds/slave/test 08:10:21 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 08:10:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:10:21 INFO - {'append_to_log': False, 08:10:21 INFO - 'base_work_dir': '/builds/slave/test', 08:10:21 INFO - 'blob_upload_branch': 'Fx-Team', 08:10:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:10:21 INFO - 'branch': 'Fx-Team', 08:10:21 INFO - 'buildbot_json_path': 'buildprops.json', 08:10:21 INFO - 'config_files': ('talos/linux_config.py',), 08:10:21 INFO - 'default_actions': ('clobber', 08:10:21 INFO - 'read-buildbot-config', 08:10:21 INFO - 'download-and-extract', 08:10:21 INFO - 'populate-webroot', 08:10:21 INFO - 'create-virtualenv', 08:10:21 INFO - 'install', 08:10:21 INFO - 'run-tests'), 08:10:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:10:21 INFO - 'download_minidump_stackwalk': True, 08:10:21 INFO - 'download_symbols': 'ondemand', 08:10:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:10:21 INFO - 'tooltool.py': '/tools/tooltool.py', 08:10:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:10:21 INFO - '/tools/misc-python/virtualenv.py')}, 08:10:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:10:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:10:21 INFO - 'installer_path': 'installer.exe', 08:10:21 INFO - 'log_level': 'info', 08:10:21 INFO - 'log_name': 'talos', 08:10:21 INFO - 'log_to_console': True, 08:10:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:10:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:10:21 INFO - 'opt_config_files': (), 08:10:21 INFO - 'pip_index': False, 08:10:21 INFO - 'sps_profile': False, 08:10:21 INFO - 'sps_profile_interval': 0, 08:10:21 INFO - 'suite': 'dromaeojs', 08:10:21 INFO - 'system_bits': '32', 08:10:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:10:21 INFO - 'title': 'talos-linux64-ix-014', 08:10:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:10:21 INFO - 'use_talos_json': True, 08:10:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:10:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:10:21 INFO - 'work_dir': 'build'} 08:10:21 INFO - ##### 08:10:21 INFO - ##### Running clobber step. 08:10:21 INFO - ##### 08:10:21 INFO - Running pre-action listener: _resource_record_pre_action 08:10:21 INFO - Running main action method: clobber 08:10:21 INFO - rmtree: /builds/slave/test/build 08:10:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:10:22 INFO - Running post-action listener: _resource_record_post_action 08:10:22 INFO - ##### 08:10:22 INFO - ##### Finished clobber step (success) 08:10:22 INFO - ##### 08:10:22 INFO - ##### 08:10:22 INFO - ##### Running read-buildbot-config step. 08:10:22 INFO - ##### 08:10:22 INFO - Running pre-action listener: _resource_record_pre_action 08:10:22 INFO - Running main action method: read_buildbot_config 08:10:22 INFO - Using buildbot properties: 08:10:22 INFO - { 08:10:22 INFO - "project": "", 08:10:22 INFO - "product": "firefox", 08:10:22 INFO - "script_repo_revision": "production", 08:10:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:10:22 INFO - "repository": "", 08:10:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:10:22 INFO - "buildid": "20160623053004", 08:10:22 INFO - "pgo_build": "True", 08:10:22 INFO - "basedir": "/builds/slave/test", 08:10:22 INFO - "buildnumber": 823, 08:10:22 INFO - "slavename": "talos-linux64-ix-014", 08:10:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:10:22 INFO - "platform": "ubuntu64_hw", 08:10:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:10:22 INFO - "branch": "fx-team", 08:10:22 INFO - "repo_path": "integration/fx-team", 08:10:22 INFO - "revision": "3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e", 08:10:22 INFO - "stage_platform": "linux64-pgo", 08:10:22 INFO - "builduid": "ec09f4010edb4e879ae2822395415733", 08:10:22 INFO - "slavebuilddir": "test" 08:10:22 INFO - } 08:10:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:10:22 INFO - Running post-action listener: _resource_record_post_action 08:10:22 INFO - ##### 08:10:22 INFO - ##### Finished read-buildbot-config step (success) 08:10:22 INFO - ##### 08:10:22 INFO - ##### 08:10:22 INFO - ##### Running download-and-extract step. 08:10:22 INFO - ##### 08:10:22 INFO - Running pre-action listener: _resource_record_pre_action 08:10:22 INFO - Running main action method: download_and_extract 08:10:22 INFO - mkdir: /builds/slave/test/build/tests 08:10:22 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')]} 08:10:22 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:10:23 INFO - Downloaded 1361 bytes. 08:10:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:23 INFO - Using the following test package requirements: 08:10:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:10:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:10:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:10:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:23 INFO - u'jsshell-linux-x86_64.zip'], 08:10:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:10:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:10:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:10:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:10:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:10:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:10:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:10:23 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')]} 08:10:23 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:10:24 INFO - Downloaded 24276007 bytes. 08:10:24 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'] 08:10:24 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 08:10:25 INFO - Return code: 0 08:10:25 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 08:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:25 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:10:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:10:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:10:26 INFO - Downloaded 24276007 bytes. 08:10:26 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'] 08:10:26 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 08:10:27 INFO - Return code: 0 08:10:27 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')]} 08:10:27 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:10:28 INFO - Downloaded 14405384 bytes. 08:10:28 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'] 08:10:28 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 08:10:29 INFO - Return code: 0 08:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:29 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:10:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:10:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:10:30 INFO - Downloaded 60160978 bytes. 08:10:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:30 INFO - mkdir: /builds/slave/test/properties 08:10:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:10:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:10:30 INFO - Contents: 08:10:30 INFO - build_url:https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:31 INFO - Running post-action listener: _resource_record_post_action 08:10:31 INFO - Running post-action listener: set_extra_try_arguments 08:10:31 INFO - ##### 08:10:31 INFO - ##### Finished download-and-extract step (success) 08:10:31 INFO - ##### 08:10:31 INFO - ##### 08:10:31 INFO - ##### Running populate-webroot step. 08:10:31 INFO - ##### 08:10:31 INFO - Running pre-action listener: _resource_record_pre_action 08:10:31 INFO - Running main action method: populate_webroot 08:10:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:10:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:10:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:10:31 INFO - '--tppagecycles', 08:10:31 INFO - '7'], 08:10:31 INFO - 'tests': ['tsvgm']}}, 08:10:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:10:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:10:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:10:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:10:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:10:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:10:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:31 INFO - 'talos_options': ['--disable-e10s'], 08:10:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:31 INFO - 'talos_options': ['--disable-e10s'], 08:10:31 INFO - 'tests': ['damp', 'tps']}, 08:10:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:31 INFO - 'tests': ['damp', 'tps']}, 08:10:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:10:31 INFO - 'tests': ['dromaeo_dom']}, 08:10:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:10:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:10:31 INFO - 'tests': ['basic_compositor_video']}, 08:10:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:10:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:10:31 INFO - 'tests': ['a11yr', 08:10:31 INFO - 'ts_paint', 08:10:31 INFO - 'tpaint', 08:10:31 INFO - 'sessionrestore', 08:10:31 INFO - 'sessionrestore_no_auto_restore', 08:10:31 INFO - 'tabpaint']}, 08:10:31 INFO - 'other-e10s': {'tests': ['a11yr', 08:10:31 INFO - 'ts_paint', 08:10:31 INFO - 'tpaint', 08:10:31 INFO - 'sessionrestore', 08:10:31 INFO - 'sessionrestore_no_auto_restore', 08:10:31 INFO - 'tabpaint']}, 08:10:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:10:31 INFO - 'ts_paint', 08:10:31 INFO - 'tpaint', 08:10:31 INFO - 'sessionrestore', 08:10:31 INFO - 'sessionrestore_no_auto_restore', 08:10:31 INFO - 'tabpaint']}, 08:10:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:10:31 INFO - 'ts_paint', 08:10:31 INFO - 'tpaint', 08:10:31 INFO - 'sessionrestore', 08:10:31 INFO - 'sessionrestore_no_auto_restore', 08:10:31 INFO - 'tabpaint']}, 08:10:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:10:31 INFO - 'tests': ['a11yr', 08:10:31 INFO - 'ts_paint', 08:10:31 INFO - 'tpaint', 08:10:31 INFO - 'sessionrestore', 08:10:31 INFO - 'sessionrestore_no_auto_restore', 08:10:31 INFO - 'tabpaint']}, 08:10:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:10:31 INFO - 'tests': ['a11yr', 08:10:31 INFO - 'ts_paint', 08:10:31 INFO - 'tpaint', 08:10:31 INFO - 'sessionrestore', 08:10:31 INFO - 'sessionrestore_no_auto_restore', 08:10:31 INFO - 'tabpaint']}, 08:10:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:10:31 INFO - 'tests': ['tsvgx', 08:10:31 INFO - 'tsvgr_opacity', 08:10:31 INFO - 'tart', 08:10:31 INFO - 'tscrollx', 08:10:31 INFO - 'cart']}, 08:10:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:10:31 INFO - 'tsvgr_opacity', 08:10:31 INFO - 'tart', 08:10:31 INFO - 'tscrollx', 08:10:31 INFO - 'cart']}, 08:10:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:31 INFO - 'talos_options': ['--disable-e10s'], 08:10:31 INFO - 'tests': ['tp5o']}, 08:10:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:31 INFO - 'tests': ['tp5o']}, 08:10:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:31 INFO - 'talos_options': ['--disable-e10s', 08:10:31 INFO - '--xperf_path', 08:10:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:31 INFO - 'tests': ['tp5n']}, 08:10:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:31 INFO - 'talos_options': ['--xperf_path', 08:10:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:31 INFO - 'tests': ['tp5n']}}, 08:10:31 INFO - 'talos.zip': {'path': '', 08:10:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:10:31 INFO - Running post-action listener: _resource_record_post_action 08:10:31 INFO - ##### 08:10:31 INFO - ##### Finished populate-webroot step (success) 08:10:31 INFO - ##### 08:10:31 INFO - ##### 08:10:31 INFO - ##### Running create-virtualenv step. 08:10:31 INFO - ##### 08:10:31 INFO - Running pre-action listener: _resource_record_pre_action 08:10:31 INFO - Running main action method: create_virtualenv 08:10:31 INFO - Creating virtualenv /builds/slave/test/build/venv 08:10:31 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 08:10:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:10:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:10:31 INFO - Using real prefix '/usr' 08:10:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:10:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:10:33 INFO - Installing pip.................done. 08:10:33 INFO - Return code: 0 08:10:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:10:33 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')]} 08:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:33 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')]} 08:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:33 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 0x7f028f6c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', '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 08:10:33 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 08:10:33 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 08:10:33 INFO - Using env: {'DISPLAY': ':0', 08:10:33 INFO - 'HOME': '/home/cltbld', 08:10:33 INFO - 'LANG': 'en_US.UTF-8', 08:10:33 INFO - 'LANGUAGE': 'en_US:en', 08:10:33 INFO - 'LOGNAME': 'cltbld', 08:10:33 INFO - 'MAIL': '/var/mail/cltbld', 08:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:33 INFO - 'MOZ_NO_REMOTE': '1', 08:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:33 INFO - 'NO_EM_RESTART': '1', 08:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:33 INFO - 'PWD': '/builds/slave/test', 08:10:33 INFO - 'SHELL': '/bin/bash', 08:10:33 INFO - 'SHLVL': '1', 08:10:33 INFO - 'TERM': 'linux', 08:10:33 INFO - 'TMOUT': '86400', 08:10:33 INFO - 'USER': 'cltbld', 08:10:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', 08:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:33 INFO - '_': '/tools/buildbot/bin/python'} 08:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:34 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 08:10:34 INFO - Cleaning up... 08:10:34 INFO - Return code: 0 08:10:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:10:34 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')]} 08:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:34 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')]} 08:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:34 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 0x7f028f6c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', '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 08:10:34 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 08:10:34 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 08:10:34 INFO - Using env: {'DISPLAY': ':0', 08:10:34 INFO - 'HOME': '/home/cltbld', 08:10:34 INFO - 'LANG': 'en_US.UTF-8', 08:10:34 INFO - 'LANGUAGE': 'en_US:en', 08:10:34 INFO - 'LOGNAME': 'cltbld', 08:10:34 INFO - 'MAIL': '/var/mail/cltbld', 08:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:34 INFO - 'MOZ_NO_REMOTE': '1', 08:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:34 INFO - 'NO_EM_RESTART': '1', 08:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:34 INFO - 'PWD': '/builds/slave/test', 08:10:34 INFO - 'SHELL': '/bin/bash', 08:10:34 INFO - 'SHLVL': '1', 08:10:34 INFO - 'TERM': 'linux', 08:10:34 INFO - 'TMOUT': '86400', 08:10:34 INFO - 'USER': 'cltbld', 08:10:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', 08:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:34 INFO - '_': '/tools/buildbot/bin/python'} 08:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:34 INFO - Downloading/unpacking psutil>=3.1.1 08:10:34 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 08:10:34 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 08:10:34 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 08:10:34 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 08:10:34 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 08:10:34 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 08:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:36 INFO - Installing collected packages: psutil 08:10:36 INFO - Running setup.py install for psutil 08:10:36 INFO - building 'psutil._psutil_linux' extension 08:10:36 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 08:10:36 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 08:10:36 INFO - building 'psutil._psutil_posix' extension 08:10:36 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 08:10:36 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 08:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:36 INFO - Successfully installed psutil 08:10:36 INFO - Cleaning up... 08:10:36 INFO - Return code: 0 08:10:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:36 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 0x7f028f6c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', '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 08:10:36 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 08:10:36 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 08:10:36 INFO - Using env: {'DISPLAY': ':0', 08:10:36 INFO - 'HOME': '/home/cltbld', 08:10:36 INFO - 'LANG': 'en_US.UTF-8', 08:10:36 INFO - 'LANGUAGE': 'en_US:en', 08:10:36 INFO - 'LOGNAME': 'cltbld', 08:10:36 INFO - 'MAIL': '/var/mail/cltbld', 08:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:36 INFO - 'MOZ_NO_REMOTE': '1', 08:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:36 INFO - 'NO_EM_RESTART': '1', 08:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:36 INFO - 'PWD': '/builds/slave/test', 08:10:36 INFO - 'SHELL': '/bin/bash', 08:10:36 INFO - 'SHLVL': '1', 08:10:36 INFO - 'TERM': 'linux', 08:10:36 INFO - 'TMOUT': '86400', 08:10:36 INFO - 'USER': 'cltbld', 08:10:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', 08:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:36 INFO - '_': '/tools/buildbot/bin/python'} 08:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:10:37 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 08:10:37 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 08:10:37 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 08:10:37 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 08:10:37 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 08:10:37 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 08:10:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:10:39 INFO - Installing collected packages: mozsystemmonitor 08:10:39 INFO - Running setup.py install for mozsystemmonitor 08:10:39 INFO - Successfully installed mozsystemmonitor 08:10:39 INFO - Cleaning up... 08:10:39 INFO - Return code: 0 08:10:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:10:39 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')]} 08:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:39 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')]} 08:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:39 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 0x7f028f6c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', '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 08:10:39 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 08:10:39 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 08:10:39 INFO - Using env: {'DISPLAY': ':0', 08:10:39 INFO - 'HOME': '/home/cltbld', 08:10:39 INFO - 'LANG': 'en_US.UTF-8', 08:10:39 INFO - 'LANGUAGE': 'en_US:en', 08:10:39 INFO - 'LOGNAME': 'cltbld', 08:10:39 INFO - 'MAIL': '/var/mail/cltbld', 08:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:39 INFO - 'MOZ_NO_REMOTE': '1', 08:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:39 INFO - 'NO_EM_RESTART': '1', 08:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:39 INFO - 'PWD': '/builds/slave/test', 08:10:39 INFO - 'SHELL': '/bin/bash', 08:10:39 INFO - 'SHLVL': '1', 08:10:39 INFO - 'TERM': 'linux', 08:10:39 INFO - 'TMOUT': '86400', 08:10:39 INFO - 'USER': 'cltbld', 08:10:39 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', 08:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:39 INFO - '_': '/tools/buildbot/bin/python'} 08:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:39 INFO - Downloading/unpacking jsonschema==2.5.1 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:10:41 INFO - warning: no files found matching '*.txt' 08:10:41 INFO - no previously-included directories found matching 'build' 08:10:41 INFO - no previously-included directories found matching 'dist' 08:10:41 INFO - no previously-included directories found matching '.git*' 08:10:41 INFO - Installing collected packages: jsonschema, functools32 08:10:41 INFO - Running setup.py install for functools32 08:10:41 INFO - warning: no files found matching '*.txt' 08:10:41 INFO - no previously-included directories found matching 'build' 08:10:41 INFO - no previously-included directories found matching 'dist' 08:10:41 INFO - no previously-included directories found matching '.git*' 08:10:41 INFO - Successfully installed jsonschema functools32 08:10:41 INFO - Cleaning up... 08:10:41 INFO - Return code: 0 08:10:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:41 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 0x7f028f6c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', '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 08:10:41 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 08:10:41 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 08:10:41 INFO - Using env: {'DISPLAY': ':0', 08:10:41 INFO - 'HOME': '/home/cltbld', 08:10:41 INFO - 'LANG': 'en_US.UTF-8', 08:10:41 INFO - 'LANGUAGE': 'en_US:en', 08:10:41 INFO - 'LOGNAME': 'cltbld', 08:10:41 INFO - 'MAIL': '/var/mail/cltbld', 08:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:41 INFO - 'MOZ_NO_REMOTE': '1', 08:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:41 INFO - 'NO_EM_RESTART': '1', 08:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:41 INFO - 'PWD': '/builds/slave/test', 08:10:41 INFO - 'SHELL': '/bin/bash', 08:10:41 INFO - 'SHLVL': '1', 08:10:41 INFO - 'TERM': 'linux', 08:10:41 INFO - 'TMOUT': '86400', 08:10:41 INFO - 'USER': 'cltbld', 08:10:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', 08:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:41 INFO - '_': '/tools/buildbot/bin/python'} 08:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:10:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:10:43 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 08:10:43 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 08:10:43 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 08:10:43 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 08:10:43 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 08:10:43 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 08:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:10:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:10:44 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 08:10:44 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 08:10:44 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 08:10:44 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 08:10:44 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 08:10:44 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 08:10:44 INFO - Downloading docopt-0.6.1.tar.gz 08:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:10:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:10:44 INFO - Running setup.py install for blobuploader 08:10:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:10:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:10:44 INFO - Running setup.py install for requests 08:10:45 INFO - Running setup.py install for docopt 08:10:45 INFO - Successfully installed blobuploader requests docopt 08:10:45 INFO - Cleaning up... 08:10:45 INFO - Return code: 0 08:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:45 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 0x7f028f6c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', '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 08:10:45 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 08:10:45 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 08:10:45 INFO - Using env: {'DISPLAY': ':0', 08:10:45 INFO - 'HOME': '/home/cltbld', 08:10:45 INFO - 'LANG': 'en_US.UTF-8', 08:10:45 INFO - 'LANGUAGE': 'en_US:en', 08:10:45 INFO - 'LOGNAME': 'cltbld', 08:10:45 INFO - 'MAIL': '/var/mail/cltbld', 08:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:45 INFO - 'MOZ_NO_REMOTE': '1', 08:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:45 INFO - 'NO_EM_RESTART': '1', 08:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:45 INFO - 'PWD': '/builds/slave/test', 08:10:45 INFO - 'SHELL': '/bin/bash', 08:10:45 INFO - 'SHLVL': '1', 08:10:45 INFO - 'TERM': 'linux', 08:10:45 INFO - 'TMOUT': '86400', 08:10:45 INFO - 'USER': 'cltbld', 08:10:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', 08:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:45 INFO - '_': '/tools/buildbot/bin/python'} 08:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:45 INFO - Running setup.py (path:/tmp/pip-JS_eRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:45 INFO - Running setup.py (path:/tmp/pip-kulKHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:45 INFO - Running setup.py (path:/tmp/pip-kK5OWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:45 INFO - Running setup.py (path:/tmp/pip-Yi_X1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:45 INFO - Running setup.py (path:/tmp/pip-gUUT9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:45 INFO - Running setup.py (path:/tmp/pip-41BMbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:45 INFO - Running setup.py (path:/tmp/pip-JSTGCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:45 INFO - Running setup.py (path:/tmp/pip-IgfFfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:46 INFO - Running setup.py (path:/tmp/pip-RUoKAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:46 INFO - Running setup.py (path:/tmp/pip-AxtM_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:46 INFO - Running setup.py (path:/tmp/pip-POs0VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:46 INFO - Running setup.py (path:/tmp/pip-JyLX7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:46 INFO - Running setup.py (path:/tmp/pip-MbhWVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:46 INFO - Running setup.py (path:/tmp/pip-xCstVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:46 INFO - Running setup.py (path:/tmp/pip-TTJZhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:46 INFO - Running setup.py (path:/tmp/pip-_kg_v9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:46 INFO - Running setup.py (path:/tmp/pip-3lxbi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:10:46 INFO - Running setup.py install for manifestparser 08:10:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:10:46 INFO - Running setup.py install for mozcrash 08:10:46 INFO - Running setup.py install for mozdebug 08:10:46 INFO - Running setup.py install for mozdevice 08:10:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for mozfile 08:10:47 INFO - Running setup.py install for mozhttpd 08:10:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for mozinfo 08:10:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for mozInstall 08:10:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for mozleak 08:10:47 INFO - Running setup.py install for mozlog 08:10:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for moznetwork 08:10:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for mozprocess 08:10:47 INFO - Running setup.py install for mozprofile 08:10:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:10:48 INFO - Running setup.py install for mozrunner 08:10:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:10:48 INFO - Running setup.py install for mozscreenshot 08:10:48 INFO - Running setup.py install for moztest 08:10:48 INFO - Running setup.py install for mozversion 08:10:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:10:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:10:48 INFO - Cleaning up... 08:10:48 INFO - Return code: 0 08:10:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:48 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 0x7f028f6c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', '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 08:10:48 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 08:10:48 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 08:10:48 INFO - Using env: {'DISPLAY': ':0', 08:10:48 INFO - 'HOME': '/home/cltbld', 08:10:48 INFO - 'LANG': 'en_US.UTF-8', 08:10:48 INFO - 'LANGUAGE': 'en_US:en', 08:10:48 INFO - 'LOGNAME': 'cltbld', 08:10:48 INFO - 'MAIL': '/var/mail/cltbld', 08:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:48 INFO - 'MOZ_NO_REMOTE': '1', 08:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:48 INFO - 'NO_EM_RESTART': '1', 08:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:48 INFO - 'PWD': '/builds/slave/test', 08:10:48 INFO - 'SHELL': '/bin/bash', 08:10:48 INFO - 'SHLVL': '1', 08:10:48 INFO - 'TERM': 'linux', 08:10:48 INFO - 'TMOUT': '86400', 08:10:48 INFO - 'USER': 'cltbld', 08:10:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', 08:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:48 INFO - '_': '/tools/buildbot/bin/python'} 08:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:48 INFO - Running setup.py (path:/tmp/pip-rTsC9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:48 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)) 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:48 INFO - Running setup.py (path:/tmp/pip-Hk0_mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:48 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)) 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:48 INFO - Running setup.py (path:/tmp/pip-H65zfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:48 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)) 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:48 INFO - Running setup.py (path:/tmp/pip-DHooUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:48 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)) 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:48 INFO - Running setup.py (path:/tmp/pip-ItfZQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:49 INFO - Running setup.py (path:/tmp/pip-C8bfwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:49 INFO - Running setup.py (path:/tmp/pip-d7mr5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:49 INFO - Running setup.py (path:/tmp/pip-iDIFqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:49 INFO - Running setup.py (path:/tmp/pip-aHu9Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:49 INFO - Running setup.py (path:/tmp/pip-wGZN6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:49 INFO - Running setup.py (path:/tmp/pip-xsDtod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:49 INFO - Running setup.py (path:/tmp/pip-T4o89S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:49 INFO - Running setup.py (path:/tmp/pip-zFijhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:49 INFO - Running setup.py (path:/tmp/pip-dwXAtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:49 INFO - Running setup.py (path:/tmp/pip-YY3zZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:49 INFO - Running setup.py (path:/tmp/pip-BSLLXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:49 INFO - Running setup.py (path:/tmp/pip-6oS0C7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:49 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)) 08:10:49 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)) 08:10:49 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)) 08:10:49 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)) 08:10:49 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)) 08:10:49 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)) 08:10:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:10:49 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 08:10:49 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 08:10:49 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 08:10:49 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 08:10:49 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 08:10:49 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 08:10:51 INFO - Downloading blessings-1.6.tar.gz 08:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:10:51 INFO - Installing collected packages: blessings 08:10:51 INFO - Running setup.py install for blessings 08:10:51 INFO - Successfully installed blessings 08:10:51 INFO - Cleaning up... 08:10:52 INFO - Return code: 0 08:10:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:52 INFO - Reading from file tmpfile_stdout 08:10:52 INFO - Current package versions: 08:10:52 INFO - argparse == 1.2.1 08:10:52 INFO - blessings == 1.6 08:10:52 INFO - blobuploader == 1.2.4 08:10:52 INFO - docopt == 0.6.1 08:10:52 INFO - functools32 == 3.2.3-2 08:10:52 INFO - jsonschema == 2.5.1 08:10:52 INFO - manifestparser == 1.1 08:10:52 INFO - mozInstall == 1.12 08:10:52 INFO - mozcrash == 0.17 08:10:52 INFO - mozdebug == 0.1 08:10:52 INFO - mozdevice == 0.48 08:10:52 INFO - mozfile == 1.2 08:10:52 INFO - mozhttpd == 0.7 08:10:52 INFO - mozinfo == 0.9 08:10:52 INFO - mozleak == 0.1 08:10:52 INFO - mozlog == 3.2 08:10:52 INFO - moznetwork == 0.27 08:10:52 INFO - mozprocess == 0.22 08:10:52 INFO - mozprofile == 0.28 08:10:52 INFO - mozrunner == 6.11 08:10:52 INFO - mozscreenshot == 0.1 08:10:52 INFO - mozsystemmonitor == 0.3 08:10:52 INFO - moztest == 0.7 08:10:52 INFO - mozversion == 1.4 08:10:52 INFO - psutil == 3.1.1 08:10:52 INFO - requests == 1.2.3 08:10:52 INFO - wsgiref == 0.1.2 08:10:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 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 0x7f028f6c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', '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 08:10:52 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 08:10:52 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 08:10:52 INFO - Using env: {'DISPLAY': ':0', 08:10:52 INFO - 'HOME': '/home/cltbld', 08:10:52 INFO - 'LANG': 'en_US.UTF-8', 08:10:52 INFO - 'LANGUAGE': 'en_US:en', 08:10:52 INFO - 'LOGNAME': 'cltbld', 08:10:52 INFO - 'MAIL': '/var/mail/cltbld', 08:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:52 INFO - 'MOZ_NO_REMOTE': '1', 08:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:52 INFO - 'NO_EM_RESTART': '1', 08:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:52 INFO - 'PWD': '/builds/slave/test', 08:10:52 INFO - 'SHELL': '/bin/bash', 08:10:52 INFO - 'SHLVL': '1', 08:10:52 INFO - 'TERM': 'linux', 08:10:52 INFO - 'TMOUT': '86400', 08:10:52 INFO - 'USER': 'cltbld', 08:10:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', 08:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:52 INFO - '_': '/tools/buildbot/bin/python'} 08:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 INFO - Cleaning up... 08:10:52 INFO - Return code: 0 08:10:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f028f6c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', '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 08:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:10:52 INFO - Using env: {'DISPLAY': ':0', 08:10:52 INFO - 'HOME': '/home/cltbld', 08:10:52 INFO - 'LANG': 'en_US.UTF-8', 08:10:52 INFO - 'LANGUAGE': 'en_US:en', 08:10:52 INFO - 'LOGNAME': 'cltbld', 08:10:52 INFO - 'MAIL': '/var/mail/cltbld', 08:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:52 INFO - 'MOZ_NO_REMOTE': '1', 08:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:52 INFO - 'NO_EM_RESTART': '1', 08:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:52 INFO - 'PWD': '/builds/slave/test', 08:10:52 INFO - 'SHELL': '/bin/bash', 08:10:52 INFO - 'SHLVL': '1', 08:10:52 INFO - 'TERM': 'linux', 08:10:52 INFO - 'TMOUT': '86400', 08:10:52 INFO - 'USER': 'cltbld', 08:10:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', 08:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:52 INFO - '_': '/tools/buildbot/bin/python'} 08:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:10:52 INFO - Cleaning up... 08:10:52 INFO - Return code: 0 08:10:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f028f6c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', '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 08:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:10:52 INFO - Using env: {'DISPLAY': ':0', 08:10:52 INFO - 'HOME': '/home/cltbld', 08:10:52 INFO - 'LANG': 'en_US.UTF-8', 08:10:52 INFO - 'LANGUAGE': 'en_US:en', 08:10:52 INFO - 'LOGNAME': 'cltbld', 08:10:52 INFO - 'MAIL': '/var/mail/cltbld', 08:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:52 INFO - 'MOZ_NO_REMOTE': '1', 08:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:52 INFO - 'NO_EM_RESTART': '1', 08:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:52 INFO - 'PWD': '/builds/slave/test', 08:10:52 INFO - 'SHELL': '/bin/bash', 08:10:52 INFO - 'SHLVL': '1', 08:10:52 INFO - 'TERM': 'linux', 08:10:52 INFO - 'TMOUT': '86400', 08:10:52 INFO - 'USER': 'cltbld', 08:10:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', 08:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:52 INFO - '_': '/tools/buildbot/bin/python'} 08:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:52 INFO - Downloading/unpacking flake8 08:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:10:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:10:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:10:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:10:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:10:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:10:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:10:55 INFO - no previously-included directories found matching 'docs/_build' 08:10:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:10:55 INFO - Running setup.py install for pep8 08:10:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:10:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:10:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:10:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:10:55 INFO - no previously-included directories found matching 'docs/_build' 08:10:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:10:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:10:55 INFO - Cleaning up... 08:10:55 INFO - Return code: 0 08:10:55 INFO - Running post-action listener: _resource_record_post_action 08:10:55 INFO - Running post-action listener: _start_resource_monitoring 08:10:55 INFO - Starting resource monitoring. 08:10:55 INFO - ##### 08:10:55 INFO - ##### Finished create-virtualenv step (success) 08:10:55 INFO - ##### 08:10:55 INFO - ##### 08:10:55 INFO - ##### Running install step. 08:10:55 INFO - ##### 08:10:55 INFO - Running pre-action listener: _resource_record_pre_action 08:10:55 INFO - Running main action method: install 08:10:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:56 INFO - Reading from file tmpfile_stdout 08:10:56 INFO - Detecting whether we're running mozinstall >=1.0... 08:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:10:56 INFO - Reading from file tmpfile_stdout 08:10:56 INFO - Output received: 08:10:56 INFO - Usage: mozinstall [options] installer 08:10:56 INFO - Options: 08:10:56 INFO - -h, --help show this help message and exit 08:10:56 INFO - -d DEST, --destination=DEST 08:10:56 INFO - Directory to install application into. [default: 08:10:56 INFO - "/builds/slave/test"] 08:10:56 INFO - --app=APP Application being installed. [default: firefox] 08:10:56 INFO - mkdir: /builds/slave/test/build/application 08:10:56 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'] 08:10:56 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 08:11:13 INFO - Reading from file tmpfile_stdout 08:11:13 INFO - Output received: 08:11:13 INFO - /builds/slave/test/build/application/firefox/firefox 08:11:13 INFO - Running post-action listener: _resource_record_post_action 08:11:13 INFO - ##### 08:11:13 INFO - ##### Finished install step (success) 08:11:13 INFO - ##### 08:11:13 INFO - ##### 08:11:13 INFO - ##### Running run-tests step. 08:11:13 INFO - ##### 08:11:13 INFO - Running pre-action listener: _resource_record_pre_action 08:11:13 INFO - Running main action method: run_tests 08:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:11:13 INFO - Python 2.7.3 08:11:13 INFO - Return code: 0 08:11:13 INFO - grabbing minidump binary from tooltool 08:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:13 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 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:13 INFO - Return code: 0 08:11:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:11:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:11:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:11:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:11:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:11:14 INFO - Return code: 0 08:11:14 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/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 08:11:14 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/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 08:11:14 INFO - Using env: {'DISPLAY': ':0', 08:11:14 INFO - 'HOME': '/home/cltbld', 08:11:14 INFO - 'LANG': 'en_US.UTF-8', 08:11:14 INFO - 'LANGUAGE': 'en_US:en', 08:11:14 INFO - 'LOGNAME': 'cltbld', 08:11:14 INFO - 'MAIL': '/var/mail/cltbld', 08:11:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:11:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:14 INFO - 'MOZ_NO_REMOTE': '1', 08:11:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:14 INFO - 'NO_EM_RESTART': '1', 08:11:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:14 INFO - 'PWD': '/builds/slave/test', 08:11:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:11:14 INFO - 'SHELL': '/bin/bash', 08:11:14 INFO - 'SHLVL': '1', 08:11:14 INFO - 'TERM': 'linux', 08:11:14 INFO - 'TMOUT': '86400', 08:11:14 INFO - 'USER': 'cltbld', 08:11:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636', 08:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:14 INFO - '_': '/tools/buildbot/bin/python'} 08:11:14 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/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 08:11:14 INFO - mozversion application_buildid: 20160623053004 08:11:14 INFO - mozversion application_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 08:11:14 INFO - mozversion application_display_name: Nightly 08:11:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:14 INFO - mozversion application_name: Firefox 08:11:14 INFO - mozversion application_remotingname: firefox 08:11:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:11:14 INFO - mozversion application_vendor: Mozilla 08:11:14 INFO - mozversion application_version: 50.0a1 08:11:14 INFO - mozversion platform_buildid: 20160623053004 08:11:14 INFO - mozversion platform_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 08:11:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:11:14 INFO - mozversion platform_version: 50.0a1 08:11:14 INFO - using testdate: 1466694674 08:11:14 INFO - actual date: 1466694674 08:11:14 INFO - starting webserver on 'localhost:48568' 08:11:14 INFO - SUITE-START | Running 2 tests 08:11:14 INFO - TEST-START | dromaeo_css 08:11:14 INFO - operating with platform_type : linux_ 08:11:14 INFO - Initialising browser for dromaeo_css test... 08:11:14 INFO - TEST-INFO | started process 25432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf8_TFQ/profile http://localhost:48568/getInfo.html) 08:11:18 INFO - PROCESS | 25432 | __metrics Screen width/height:1600/1200 08:11:18 INFO - PROCESS | 25432 | colorDepth:24 08:11:18 INFO - PROCESS | 25432 | Browser inner width/height: 1024/697 08:11:18 INFO - PROCESS | 25432 | __metrics 08:11:19 INFO - PROCESS | 25432 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:11:20 INFO - TEST-INFO | 25432: exit 0 08:11:20 INFO - Browser initialized. 08:11:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:11:20 INFO - TEST-INFO | started process 25521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf8_TFQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:32 INFO - PROCESS | 25521 | RSS: Main: 174129152 08:11:32 INFO - PROCESS | 25521 | 08:12:23 INFO - PROCESS | 25521 | 1466694743780 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] 08:14:31 INFO - PROCESS | 25521 | Cycle 1(1): loaded http://localhost:48568/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48568/tests/dromaeo/cssquery-ext.html) 08:14:32 INFO - PROCESS | 25521 | RSS: Main: 263020544 08:14:32 INFO - PROCESS | 25521 | 08:17:34 INFO - PROCESS | 25521 | Cycle 1(1): loaded http://localhost:48568/tests/dromaeo/cssquery-ext.html (next: http://localhost:48568/tests/dromaeo/cssquery-jquery.html) 08:17:35 INFO - PROCESS | 25521 | RSS: Main: 246255616 08:17:35 INFO - PROCESS | 25521 | 08:20:37 INFO - PROCESS | 25521 | Cycle 1(1): loaded http://localhost:48568/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48568/tests/dromaeo/cssquery-mootools.html) 08:20:38 INFO - PROCESS | 25521 | RSS: Main: 265687040 08:20:38 INFO - PROCESS | 25521 | 08:23:40 INFO - PROCESS | 25521 | Cycle 1(1): loaded http://localhost:48568/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48568/tests/dromaeo/cssquery-prototype.html) 08:23:40 INFO - PROCESS | 25521 | RSS: Main: 246829056 08:23:40 INFO - PROCESS | 25521 | 08:26:43 INFO - PROCESS | 25521 | Cycle 1(1): loaded http://localhost:48568/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48568/tests/dromaeo/cssquery-yui.html) 08:26:43 INFO - PROCESS | 25521 | RSS: Main: 247312384 08:26:43 INFO - PROCESS | 25521 | 08:29:46 INFO - PROCESS | 25521 | Cycle 1(1): loaded http://localhost:48568/tests/dromaeo/cssquery-yui.html (next: http://localhost:48568/tests/dromaeo/cssquery-dojo.html) 08:29:46 INFO - PROCESS | 25521 | RSS: Main: 282845184 08:29:46 INFO - PROCESS | 25521 | 08:29:46 INFO - PROCESS | 25521 | __start_tp_report 08:29:46 INFO - PROCESS | 25521 | _x_x_mozilla_page_load 08:29:46 INFO - PROCESS | 25521 | _x_x_mozilla_page_load_details 08:29:46 INFO - PROCESS | 25521 | |i|pagename|runs| 08:29:46 INFO - PROCESS | 25521 | |0;dojo.html;3051.6643169251392;3071.4932036214022;3076.446239676858;3101.503759398494;3113.875444982201;5005.2492126181;5086.109930762111;5126.231065340201;5206.6615669981475;5223.007628550573;5241.606879484035;5272.103742363798;5301.5228629423345;5308.787648494055;5323.121684921993;4539.72761634303;4747.548982846624;4839.830605928793;4853.320535125085;4873.780679869415;4794.640401969848;4831.178699621073;4840.370751802261;4865.586425153866;4932.457429682732;4629.8148074077;4671.953280467186;4724.905501889977;4727.858164255078;4746.810127594892;4738.526147385269;4747.952520474785;4755.286706993944;4814.614830813526;4857.854264372075;4762.02318837695;4789.760511974422;4800.615950723934;4801.663883528155;4840.612750979948;5064.797408103672;5118.795248190068;5194.194899790538;5252.474752524755;5254.7635356409055;5539.9169012464845;5544.584156188262;5571.582131340166;5589.944100558983;5595.692236926968;5360.517553420172;5653.632513886625;5663.830085097454;5669.206311116447;5669.773209071632;5147.613928955306;5148.510891465305;5149.794008239666;5197.376314842243;5221.269022336875;5650.74571644277;5667.404922483162;5667.546596272288;5669.177969194444;5671.234383358276;5240.318758561362;5398.352197736297;5442.9930462864495;5446.809361672323;5453.23654688344;5545;5586.385497595261;5591.217229587861;5618.578606604521;5635.718214089279;5547.72261386929;5560.77756889728;5580.609357344947;5584.190292407659;5585.664860108406;5378.97310513445;5445.945540544544;5504.559635229172;5556.527695145958;5565.860853478614;4250.362445633118;4259;4263.211305908417;4296.183725092223;4299.9570004300185;3816.3512202925567;3844.1927195288745;3845.884693438927;3867.1878905430176;3880.650741433228;5060.367454068241;5109.795608175631;5198.142306519458;5223.608229382811;5292.735363231823;5621.269234999424;5643.633163844337;5647.322321321468;5650.5479561634975;5671.773129074873;5275.076861549291;5301.5493683037375;5303.522682958553;5312.654677445954;5363.329583802025;4744.833930812474;4785.258284965836;4814.6870453420415;4877.731724755102;4879.707217566957;5689.630174038757;5691.857703557362;5694.231278777394;5699.116636921284;5740.311162660508;5561.138023606348;5570.470805273492;5577.888442231214;5578.665280083208;5583.637063590853;5501.5323697486165;5631.633943793804;5657.575681823797;5671.40450252734;5697.088465845445;5515.779368825362;5524.14375771756;5526.751296191762;5533.750981205936;5534.280543529477;5600.635958662674;5602.075657516464;5606.074997625346;5617.887642247214;5643;5270.314859068297;5285.365756109138;5318.255444237887;5333.573314134937;5373.167159090347;5325.174597937326;5328.09422398201;5337.306150200449;5339.546138578265;5340.198970154508;5183.0670479314085;5192.714400707846;5241.633085683966;5249.947500525099;5286.022085914118;5393.40672526014;5514.476124768141;5534.695591742493;5586.02244607184;5606.383297837153;5400.7569659364635;5428.104362780097;5435.2934118564335;5438.320209973754;5451.209574611738 08:29:46 INFO - PROCESS | 25521 | |1;ext.html;558.1697544840621;572.4819038769915;580.8780156167205;591.8609126855189;596.165368484122;28636;31054.53418198729;31171.68828311716;31272.374552508936;31319.21701957452;36509.26981460369;37442.999999999935;37550;40948.79525602368;41056.178876422455;8472.110428405022;8585.785355366135;8589.871151932726;8599.44103633265;8601.096884827097;8467.068622451525;8520.233179013887;8543.530105844176;8551.743447696548;8561.657533698644;8522.14778522146;8538.70114545991;8568.10034946331;8568.785780355478;8572.314214862827;8510.829783404328;8555.401121921468;8556.61495232716;8558.443701159405;8559.786005349853;8466.872996905051;8521.914780852174;8524.01973773018;8529.829403411959;8539.786505337353;34591.65408345909;34720.82639586811;34811.477827832605;34876.825615871756;34925.476117858;3089.9691003089906;3207.5669784579018;3412.266362732;3426.691597756189;3427.9314413711836;27798.583021254697;29665.11004669863;29704.40591188186;29731.10806675803;29777.404451911058;4294.871153865389;4380.299152135643;4391.802368893407;4559.794809233593;4583.72497650142;340291;341716;342319;342333;342596;29694.851525742233;30474.390512190075;44023.77988110039;44769.32846007313;44803.32795008012;32209.677903221138;32251.677483224867;32343.35313293768;32349.35301293961;32356.514652279762;13625.795613065811;13735.725285494435;13752.243626600633;13755.17468951866;13761.38073786682;10663.46682665879;10709.732256693489;10712;10719.517621707042;10720.624778132884;7590.544567325978;7597.6581053851605;7689.154193038761;7714.344280736088;7720.42096842739;2935.456940465978;2994.146668199596;2996.700329966986;3009.5485677148167;3010.1120169550036;862.9050804411635;911.5533388639651;942.6842007927421;948.4688574398359;981.764376549623;27592.361768958708;28306.85846570754;28719.712802871705;28774.280642983675;28906.566401503995;865.6018231613529;991.3952488981715;998.5456617239139;1016.1819735113305;1028.840529717895;14354.712905741826;14955;15005.69988600222;15136.394544218108;15277.083374997535;524554;526281;528717;528883;528995;47658.5234147661;47712.5228747715;47833.282500762514;47939.520604794205;48004;1092.382803715914;1097.358045543366;1155.5955415604471;1174.682835634391;1200.2918278215895;27908;29139.708602914547;29305.85347073251;29374.853125734233;29536.852315738284;41087.38368924409;41711.374329384475;41716.582834172485;41772.1645567093;41800.37299440572;366043;375708;376747;377197;377514;23916.88041559781;24530.264092077265;25074.985002999838;25250.36874078163;26831.597526037516;37624;39692.603073968894;40722;41342.793286033375;41836.37245441382;34842.82578587091;35497.1125721859;36015.45976810298;36125.45811812877;36335.636643633225;35594;35763.284734305686;35817.64182358143;35994.46008309825;36517.08707282339;35120.824395877855;35194.296114077064;35627.82186089053;35948.10129746777;36071.63928360788;31048.534271985485;32978.34043319168;33554.32891342208;33566.664333356355;33624.1593960153;24756.13353532618;25086.74913250844;25463;26060.739392605832;26274 08:29:46 INFO - PROCESS | 25521 | |2;jquery.html;367.08046343908507;368.5681128814555;369.5417682074229;379.5199073172439;385.1584288329999;16816.91591542042;18257.817421825777;18573.349932752357;18950.810491895078;18952.336668216616;15548.378064877392;16270;16511;16714.331426742916;16726.58183545412;4829.6377771667;5046.7224302663335;5066.84799456015;5078.8476345709505;5079.03498335317;3712.5544934607883;4444.444444444444;5001.699898006132;6204.6277223366515;6221.564490485668;6238.532110091739;6245;6249.093881387196;6253.405926436982;6270.216222972129;5261.368635763713;5551.833444996636;5552.250446189753;5640.238567793336;6242.719077641517;3662.505561749156;5125.410577783528;5394.703291318976;5407.242985981966;5440.809571664972;11871.46578403974;11981;12045.036397088212;13507.041478985491;20623.69064464034;2159.0715992123382;2167.089822274648;2170.8263338933007;2697.3661189620425;2778.4304217635336;9149.902011758564;9329.346945713804;9343.486108264044;12043.759124817541;12778.488860445572;1812.1120650881105;1840.3190819396775;1867.8505719542404;1881.5766452548205;1924.7594050743658;49608.50391496075;54062.45937540653;55250.17124743132;76692.61653691751;80731.5963420185;10237.74405639865;10330.173586113093;10448.373097614167;10450.790984180274;10554.155667546578;14090.365933533016;14165.291735413395;14181.85818141826;14183.007189496637;14191.64520886986;7429.4799364045075;7529.209433009564;7540.585267810323;7705.036870391201;7798.961005195051;7124.8575028499135;7241.637918104074;7248.876424154265;7266.237045110293;7688.231176882267;4215.725977811432;4242.681798865097;4261.403403523509;4407.713498622579;4533.252013417815;1786.4104845400987;1800.1359347513267;1822.88151270167;1830.8901465912088;1866.4773863318292;793.4882001109253;815.535144967363;824.7979245084992;837.4263629413871;837.8026089292688;17146.657066858843;17224.124571971206;17811.753177277726;18056.819431805776;18232.27070917175;849.613425891218;853.568947681417;855.6106971328031;877.7147427086222;905.8550631898996;9444.716658500256;9474.668386606436;10157.695269141937;10190;10427.478626068667;537490;549603;550165;561924;569408;92627;95753;96777.51611241899;97990.51004744931;99931.50034249782;891.7859713668673;895.3285036222833;916.7708072981754;918.4764684130115;933.3186773655134;16021.279042442884;16212.756808648115;16249.59376015609;16281.185940703155;16371.345146194019;42291;43281;44155.77922110369;44446.555534445535;44915.775421122686;58462;58727;59692.70153649204;59851;60300.09549856844;5824.15549745293;6655.767048153291;7985.361171106181;8154.796130096795;8423.284020858051;10747.516361763583;12413.193142445713;12567.93716031414;12630.873691263338;13043.28261945602;11176.720581985515;11335.376554289593;11367.658970230907;11524.193306468802;11673.766524669289;5525.585581081516;11088.503052087864;11128.1653875958;11250.437478126225;11288.830667539829;11380.203385762918;11536.769264614828;11565.884341156481;11686.824697629712;11692;8118;8138.145494722969;8225.506469611842;8267.338612911073;8282.792930176553;10900.618478353219;11325.32048077118;11382.772344553228;11433.428328583372;11513.42432878336 08:29:46 INFO - PROCESS | 25521 | |3;mootools.html;1133.6712353417508;1200.2558413783456;1207.782599132156;1250.8936740377067;1401.1312985948707;7531.472796904219;7763.7670869873855;7770.650320735566;7925.048994120699;7934.166912474194;7755.650995705193;7931.167227441122;7945.324647404963;7954.164812694656;7956.085050219226;1880.3136855047946;2163.145557504785;2212.4358288636417;2242.843000989931;2252.2117258959397;2198.4064302638276;2219.034719896842;2230.609643312414;2230.9107635694554;2232.6985856909273;2232.8325375596896;2238.597052530544;2247.404437823978;2258.672492488588;2263.9094436222613;1900.2968901506463;2157.320444060116;2198.5712786006734;2223.5108276179217;2228.810551103158;2217.5454031923578;2224.077008041661;2235.8434909556336;2239.80961618261;2240.9439764005865;8057.677692892277;8152.633131509037;8179.591020448954;8180.713675021346;8181.754547363588;4778.952210477885;4925.507449255082;4940.2342636891335;4941.7034977901085;4943.975280123613;3140.7173354397987;3277.2626159114247;3324.7672662913606;3336.249343897628;3366.9494957575657;1055.0926203465015;1066.8879767624444;1076.5048077884182;1079.3955384984433;1090.6946055104584;11731.17881748278;11920.165588408814;11983.520659173622;11983.94008029963;11994.760104797942;4282.379055037002;4306.913861722748;4388.758618276025;4423.977880110579;4424.181526417558;9686.9031309686;9702.51487425626;9707.077827606367;9715.611375544899;9720.708378748648;4953.578945789648;4958.553730164231;4964.478729733398;4966.03162383339;4967.105920934267;3781.470594116826;4364.519902810688;4508.211063063951;4546.249868771682;4584.77076146198;3662.249238906018;3733.1973625670066;3734.1224812169116;3809.5619003814363;3855.3445914194654;1174.2191442690687;1189.7501524679915;1194.2774621354129;1199.2205066706535;1207.3963018490754;750.7597568777938;835.5863847395578;858.1118542308681;870.7039606533809;875.1904488348252;5328.680279183184;5432.59255555827;5511.145772405283;5624.831255062355;5643.915341269884;800.1318569352202;829.1584042197175;829.5852073963018;837.937154713399;838.6142374507673;3780.1872597391693;3861.2470568238923;3884.533855937306;3909.7849618271266;3923.136909879822;9706.223502119814;9974.700758977242;10081.747956301004;10098.192144628412;10147.7463063424;9786.706398808046;9858.704238872846;9875.3211953968;10037.899621003842;10040.899591004143;7524.360429363456;7535;7568;7577.621118944141;7619.542827430372;5425.484578964992;5595.356533998643;5615.2700148980375;5670.121131224667;5800.651960882361;9631.422114673142;9842.60629574809;9890.208783297176;9940.602375904882;9972.900270997487;9692.806143877224;9915.405075695482;9973.60105595768;10072.395656260647;10309.74225644365;6095.664738439428;6239.688015599111;6242.687865606611;6811.114555107804;6944.9582562616015;7105.431565474646;7690.384769218337;7902.920970790218;7945.562994035384;8151.347892168731;7063.434925206074;7227.349538541346;7240.167380751071;7314.890276645748;7404.777856664308;6969.616671082937;7138.8215294615975;7284.708611655475;7290.5625662460425;7439.256074392518;6476.6114033158165;6568.770093046721;6576.046473261446;6595.175603049619;6599.241087275025;4974.427940786856;4974.726390048582;4985.900281994267;4990.600751939909;5039.319691841554;5087.618428617794;5094.312267843794;5101.183810590288;5213.348331458567;5257.00116977773 08:29:46 INFO - PROCESS | 25521 | |4;prototype.html;295.4430897757726;299.59255412638817;308.4478782978468;309.5017022593625;311.86901501369425;5119.1297479428495;5186.870328241786;5340.679559226444;5397.379301380342;5398.811041613544;5223.686578805275;5223.686578805275;5312.415634280236;5354.464553544643;5359;4104.527979282376;4122.525909520398;4134.772587507686;4142.792860356985;4150.128473020669;3851.383778595425;3915.158240978189;4107.199096176247;4109.424680544711;4114.053767633446;4041.898952526181;4062.5328087270045;4068.4743221292015;4089.488813898263;4090.713650044498;4039.0710136668436;4052.53395859477;4055.1484188320487;4061.8578349757913;4080.89797755057;3480.825958702055;3541.5395998520025;3563.572371315433;3574.749767516275;3591.2099338145827;5177.741112944338;5191.987562425328;5193.584513238932;5197.506236907488;5214.791408343662;4647.442306923191;4650.07022085834;4670.813167473297;4676.6960147590635;4679.508651591568;5250;5433.293671822637;5486.643368181056;5507.421720719347;5517.310336207974;3844.5770965193806;3871.1676989447406;3873.9031524211837;3879.321118804226;3890.5525864525657;5730.455606717355;5774.2782152230975;5791.247137872049;5795.884082318372;5827.592068555203;3855.4602355670227;3907.6112045985933;3929.646331830149;3961.3265744823448;3980.900477488086;3985.724568138226;4002.399640053957;4014.6386825185873;4020.6582440492302;4022.9684009574976;4612.630989520831;4626.653001024936;4634.675572709878;4643.303504474288;4645.304463870663;5357.571394288448;5493.587980901369;5552.3892371839065;5600.467955544217;5621.775128994795;1299.4282515693064;1325.2909693314032;1331.2145833957818;1343.8185844911006;1344.6302266876492;871.8605023196258;889.7375274294099;891.1623074310128;899.9730008099767;900.230303090861;4801.351817504592;4802.247179779355;4810.230363141881;4826.8793280168275;4858.902821943541;4767.713937163781;5010.774515146827;5023.472535383805;5125.564327032244;5166.870828229249;4711.9032030746675;4715.646326525524;4756.833510827105;4761.904761904742;4771.8028920623265;2701.2436517775054;2713.8330517877503;2721.7479959218585;2724.250831021485;2725.7683096936585;4920.179533572601;5071.340725705634;5133.374843102966;5156.74216289184;5204.8959020819375;5051.191809310492;5077.796888124433;5081.3140226069745;5085.474357692678;5118.232265160182;5024.020316038411;5048.974755126201;5055.317532133115;5081.0691937063675;5081.415637201769;4542.568455996675;4936.765808547863;4951.282064100613;4956.454789973028;4959.97520012412;4924.335214746106;4946.802127914843;4956.355673762388;4973.45292017885;4977.203647416396;5031.3082500861865;5043.394792624908;5050.84847454577;5068.442471328077;5105.544919697868;3576.964230357663;3656.5794933581915;3940.271049855786;3942.79744677876;3965.7620542767527;5607.971960140173;5613.438656134354;5614.27707561824;5649.683629711799;5670.631408958405;5510.236724248362;5526.58550608714;5528.668279903219;5534.723263836711;5546.528545073553;5288.2860813791185;5288.973555132354;5402.945970540244;5530.419305972976;5554.638948468337;5321.6540924839765;5340.572754179579;5344.3853956795465;5381.569474441957;5453.481919217668;5547.639403438763;5598.552115830642;5600.0679765480845;5603.243562119224;5645.379008309001;5288.338957630296;5462.262594549685;5475;5480.6437581557075;5501.202325662836 08:29:46 INFO - PROCESS | 25521 | |5;yui.html;585.3181044083643;593.9138824870394;612.4304396910874;613.6318209074556;644.8968165093584;12948.935255323722;13223.735525289489;13606.659833504142;13775.173489590632;13779.517716879911;12564.246145231293;12669.4932202712;12685.873141268585;12769.93615031926;12789.808152877715;518.5929045699127;577.4629594477135;586.6509426891004;596.698667173077;597.5309382135025;589.269306060484;591.9704014799242;594.1503649780811;594.7056207177453;595.0538643556744;625.924889013319;627.886980343538;627.9529035322346;628.0359647940412;628.2429672244957;533.6317940620959;544.7820871651352;603.2459425717852;618.8855061813579;623.0840664223607;443.6473003961858;444.86115544206933;445.48546428874704;446.70963873482174;447.0143333948668;12551.05867059965;12602.55891043809;12604.936975315157;12610.180338278074;12635.49458021678;12286.13997020209;12429.813552796715;12679;12929.547465838745;13151.736965260641;11772;12037.337946412943;12245;12302.138850280484;12490.063245256551;4373.190959672471;4383.123375324916;4416.933745993812;4441.822327106912;4499.6850220484575;71204.64397678031;72558.63720681415;79403.20596794074;79969.20030799675;80001.59999200025;10429.530671119817;10592.417417041983;10666.36001839892;10674.466276686135;10746.140308775435;17297.394591189248;17449.651006979788;17496.91251543734;17531.386401475887;17539.473815785546;7975.2423519765525;8192.918070819216;8337.708180213785;8524.914750852537;8552;4673.719576825401;4695.624350051988;4810.95189048112;4840.878978025507;5021.59827213822;3162.4307624627786;3259.885903993349;3266.1181481;3271.362084393568;3273.1980664737293;551.5807985930721;558.117442159641;564.8220810444778;577.8122110314081;584.2492397269489;522.9215617657381;543.9592030597641;564.9350324712628;635.6218050260088;661.7683810666324;9175.908240917639;9390.66631345876;9494.287928405398;9629.32594718363;9783.168430683329;556.2546188107955;599.346712083822;604.4016423740466;628.2272804450552;660.5871330418488;4570.520095390003;4599.724016559017;4686.835960741358;4722.52774722525;4745.725667848892;96658.51670741742;98221;100077;109737;114249;100338.49830750945;100811;102334.48832755789;103069.90790276304;105319;85155.72266416009;85181;85530;85937;94978;9040.367174297999;9139.314551408537;9314.534273286445;9366.297527685314;9407.2003879671;37916.62083379131;38653.613463866124;40564.3915341276;51170;53568.46431535791;73746.63126684332;74283.3145016951;77809;78361;78750.21249787658;10635.734106647085;10884.346939183675;10968.245080787356;11000.339979601249;11483.196176267582;13427.530036448677;13603.319834008458;13713.657158571115;13754.243516606683;14624.268786560842;13182.209067455984;13412.329383530589;13546.59360219195;13778.793318100035;13831.239281839595;12822.358882055672;12829.743405132032;13233.206007639572;13242.337883105614;13384.732305354033;12618.87381126177;12751.107422480338;13664;13914.956378271467;14190.077644953046;10658.147348211969;10923.016928476476;10982.341059536453;11296.774064518499;11621.128415368712;10318.638847640297;10425.895741042492;10489.895101049196;10611.787764244518;10662.946685266525 08:29:46 INFO - PROCESS | 25521 | __end_tp_report 08:29:46 INFO - PROCESS | 25521 | __start_cc_report 08:29:46 INFO - PROCESS | 25521 | _x_x_mozilla_cycle_collect,721 08:29:46 INFO - PROCESS | 25521 | __end_cc_report 08:29:46 INFO - PROCESS | 25521 | __startTimestamp1466695786605__endTimestamp 08:29:46 INFO - PROCESS | 25521 | 08:29:46 INFO - PROCESS | 25521 | ------- Summary: start ------- 08:29:46 INFO - PROCESS | 25521 | Number of tests: 6 08:29:46 INFO - PROCESS | 25521 | 08:29:46 INFO - PROCESS | 25521 | [#0] dojo.html Cycles:165 Average:5170.22 Median:5323.12 stddev:564.80 (10.6%) stddev-sans-first:541.53 08:29:46 INFO - PROCESS | 25521 | Values: 3051.7 3071.5 3076.4 3101.5 3113.9 5005.2 5086.1 5126.2 5206.7 5223.0 5241.6 5272.1 5301.5 5308.8 5323.1 4539.7 4747.5 4839.8 4853.3 4873.8 4794.6 4831.2 4840.4 4865.6 4932.5 4629.8 4672.0 4724.9 4727.9 4746.8 4738.5 4748.0 4755.3 4814.6 4857.9 4762.0 4789.8 4800.6 4801.7 4840.6 5064.8 5118.8 5194.2 5252.5 5254.8 5539.9 5544.6 5571.6 5589.9 5595.7 5360.5 5653.6 5663.8 5669.2 5669.8 5147.6 5148.5 5149.8 5197.4 5221.3 5650.7 5667.4 5667.5 5669.2 5671.2 5240.3 5398.4 5443.0 5446.8 5453.2 5545.0 5586.4 5591.2 5618.6 5635.7 5547.7 5560.8 5580.6 5584.2 5585.7 5379.0 5445.9 5504.6 5556.5 5565.9 4250.4 4259.0 4263.2 4296.2 4300.0 3816.4 3844.2 3845.9 3867.2 3880.7 5060.4 5109.8 5198.1 5223.6 5292.7 5621.3 5643.6 5647.3 5650.5 5671.8 5275.1 5301.5 5303.5 5312.7 5363.3 4744.8 4785.3 4814.7 4877.7 4879.7 5689.6 5691.9 5694.2 5699.1 5740.3 5561.1 5570.5 5577.9 5578.7 5583.6 5501.5 5631.6 5657.6 5671.4 5697.1 5515.8 5524.1 5526.8 5533.8 5534.3 5600.6 5602.1 5606.1 5617.9 5643.0 5270.3 5285.4 5318.3 5333.6 5373.2 5325.2 5328.1 5337.3 5339.5 5340.2 5183.1 5192.7 5241.6 5249.9 5286.0 5393.4 5514.5 5534.7 5586.0 5606.4 5400.8 5428.1 5435.3 5438.3 5451.2 08:29:46 INFO - PROCESS | 25521 | 08:29:46 INFO - PROCESS | 25521 | [#1] ext.html Cycles:180 Average:53632.81 Median:35790.46 stddev:112555.26 (314.5%) stddev-sans-first:112800.46 08:29:46 INFO - PROCESS | 25521 | Values: 558.2 572.5 580.9 591.9 596.2 28636.0 31054.5 31171.7 31272.4 31319.2 36509.3 37443.0 37550.0 40948.8 41056.2 8472.1 8585.8 8589.9 8599.4 8601.1 8467.1 8520.2 8543.5 8551.7 8561.7 8522.1 8538.7 8568.1 8568.8 8572.3 8510.8 8555.4 8556.6 8558.4 8559.8 8466.9 8521.9 8524.0 8529.8 8539.8 34591.7 34720.8 34811.5 34876.8 34925.5 3090.0 3207.6 3412.3 3426.7 3427.9 27798.6 29665.1 29704.4 29731.1 29777.4 4294.9 4380.3 4391.8 4559.8 4583.7 340291.0 341716.0 342319.0 342333.0 342596.0 29694.9 30474.4 44023.8 44769.3 44803.3 32209.7 32251.7 32343.4 32349.4 32356.5 13625.8 13735.7 13752.2 13755.2 13761.4 10663.5 10709.7 10712.0 10719.5 10720.6 7590.5 7597.7 7689.2 7714.3 7720.4 2935.5 2994.1 2996.7 3009.5 3010.1 862.9 911.6 942.7 948.5 981.8 27592.4 28306.9 28719.7 28774.3 28906.6 865.6 991.4 998.5 1016.2 1028.8 14354.7 14955.0 15005.7 15136.4 15277.1 524554.0 526281.0 528717.0 528883.0 528995.0 47658.5 47712.5 47833.3 47939.5 48004.0 1092.4 1097.4 1155.6 1174.7 1200.3 27908.0 29139.7 29305.9 29374.9 29536.9 41087.4 41711.4 41716.6 41772.2 41800.4 366043.0 375708.0 376747.0 377197.0 377514.0 23916.9 24530.3 25075.0 25250.4 26831.6 37624.0 39692.6 40722.0 41342.8 41836.4 34842.8 35497.1 36015.5 36125.5 36335.6 35594.0 35763.3 35817.6 35994.5 36517.1 35120.8 35194.3 35627.8 35948.1 36071.6 31048.5 32978.3 33554.3 33566.7 33624.2 24756.1 25086.7 25463.0 26060.7 26274.0 08:29:46 INFO - PROCESS | 25521 | 08:29:46 INFO - PROCESS | 25521 | [#2] jquery.html Cycles:180 Average:29779.23 Median:23844.36 stddev:91042.11 (381.8%) stddev-sans-first:91270.71 08:29:46 INFO - PROCESS | 25521 | Values: 367.1 368.6 369.5 379.5 385.2 16816.9 18257.8 18573.3 18950.8 18952.3 15548.4 16270.0 16511.0 16714.3 16726.6 4829.6 5046.7 5066.8 5078.8 5079.0 3712.6 4444.4 5001.7 6204.6 6221.6 6238.5 6245.0 6249.1 6253.4 6270.2 5261.4 5551.8 5552.3 5640.2 6242.7 3662.5 5125.4 5394.7 5407.2 5440.8 11871.5 11981.0 12045.0 13507.0 20623.7 2159.1 2167.1 2170.8 2697.4 2778.4 9149.9 9329.3 9343.5 12043.8 12778.5 1812.1 1840.3 1867.9 1881.6 1924.8 49608.5 54062.5 55250.2 76692.6 80731.6 10237.7 10330.2 10448.4 10450.8 10554.2 14090.4 14165.3 14181.9 14183.0 14191.6 7429.5 7529.2 7540.6 7705.0 7799.0 7124.9 7241.6 7248.9 7266.2 7688.2 4215.7 4242.7 4261.4 4407.7 4533.3 1786.4 1800.1 1822.9 1830.9 1866.5 793.5 815.5 824.8 837.4 837.8 17146.7 17224.1 17811.8 18056.8 18232.3 849.6 853.6 855.6 877.7 905.9 9444.7 9474.7 10157.7 10190.0 10427.5 537490.0 549603.0 550165.0 561924.0 569408.0 92627.0 95753.0 96777.5 97990.5 99931.5 891.8 895.3 916.8 918.5 933.3 16021.3 16212.8 16249.6 16281.2 16371.3 42291.0 43281.0 44155.8 44446.6 44915.8 58462.0 58727.0 59692.7 59851.0 60300.1 5824.2 6655.8 7985.4 8154.8 8423.3 10747.5 12413.2 12567.9 12630.9 13043.3 11176.7 11335.4 11367.7 11524.2 11673.8 5525.6 11088.5 11128.2 11250.4 11288.8 11380.2 11536.8 11565.9 11686.8 11692.0 8118.0 8138.1 8225.5 8267.3 8282.8 10900.6 11325.3 11382.8 11433.4 11513.4 08:29:46 INFO - PROCESS | 25521 | 08:29:46 INFO - PROCESS | 25521 | [#3] mootools.html Cycles:180 Average:5417.23 Median:5014.96 stddev:3092.38 (61.7%) stddev-sans-first:3084.30 08:29:46 INFO - PROCESS | 25521 | Values: 1133.7 1200.3 1207.8 1250.9 1401.1 7531.5 7763.8 7770.7 7925.0 7934.2 7755.7 7931.2 7945.3 7954.2 7956.1 1880.3 2163.1 2212.4 2242.8 2252.2 2198.4 2219.0 2230.6 2230.9 2232.7 2232.8 2238.6 2247.4 2258.7 2263.9 1900.3 2157.3 2198.6 2223.5 2228.8 2217.5 2224.1 2235.8 2239.8 2240.9 8057.7 8152.6 8179.6 8180.7 8181.8 4779.0 4925.5 4940.2 4941.7 4944.0 3140.7 3277.3 3324.8 3336.2 3366.9 1055.1 1066.9 1076.5 1079.4 1090.7 11731.2 11920.2 11983.5 11983.9 11994.8 4282.4 4306.9 4388.8 4424.0 4424.2 9686.9 9702.5 9707.1 9715.6 9720.7 4953.6 4958.6 4964.5 4966.0 4967.1 3781.5 4364.5 4508.2 4546.2 4584.8 3662.2 3733.2 3734.1 3809.6 3855.3 1174.2 1189.8 1194.3 1199.2 1207.4 750.8 835.6 858.1 870.7 875.2 5328.7 5432.6 5511.1 5624.8 5643.9 800.1 829.2 829.6 837.9 838.6 3780.2 3861.2 3884.5 3909.8 3923.1 9706.2 9974.7 10081.7 10098.2 10147.7 9786.7 9858.7 9875.3 10037.9 10040.9 7524.4 7535.0 7568.0 7577.6 7619.5 5425.5 5595.4 5615.3 5670.1 5800.7 9631.4 9842.6 9890.2 9940.6 9972.9 9692.8 9915.4 9973.6 10072.4 10309.7 6095.7 6239.7 6242.7 6811.1 6945.0 7105.4 7690.4 7902.9 7945.6 8151.3 7063.4 7227.3 7240.2 7314.9 7404.8 6969.6 7138.8 7284.7 7290.6 7439.3 6476.6 6568.8 6576.0 6595.2 6599.2 4974.4 4974.7 4985.9 4990.6 5039.3 5087.6 5094.3 5101.2 5213.3 5257.0 08:29:46 INFO - PROCESS | 25521 | 08:29:46 INFO - PROCESS | 25521 | [#4] prototype.html Cycles:180 Average:4450.21 Median:4975.33 stddev:1299.91 (26.1%) stddev-sans-first:1265.60 08:29:46 INFO - PROCESS | 25521 | Values: 295.4 299.6 308.4 309.5 311.9 5119.1 5186.9 5340.7 5397.4 5398.8 5223.7 5223.7 5312.4 5354.5 5359.0 4104.5 4122.5 4134.8 4142.8 4150.1 3851.4 3915.2 4107.2 4109.4 4114.1 4041.9 4062.5 4068.5 4089.5 4090.7 4039.1 4052.5 4055.1 4061.9 4080.9 3480.8 3541.5 3563.6 3574.7 3591.2 5177.7 5192.0 5193.6 5197.5 5214.8 4647.4 4650.1 4670.8 4676.7 4679.5 5250.0 5433.3 5486.6 5507.4 5517.3 3844.6 3871.2 3873.9 3879.3 3890.6 5730.5 5774.3 5791.2 5795.9 5827.6 3855.5 3907.6 3929.6 3961.3 3980.9 3985.7 4002.4 4014.6 4020.7 4023.0 4612.6 4626.7 4634.7 4643.3 4645.3 5357.6 5493.6 5552.4 5600.5 5621.8 1299.4 1325.3 1331.2 1343.8 1344.6 871.9 889.7 891.2 900.0 900.2 4801.4 4802.2 4810.2 4826.9 4858.9 4767.7 5010.8 5023.5 5125.6 5166.9 4711.9 4715.6 4756.8 4761.9 4771.8 2701.2 2713.8 2721.7 2724.3 2725.8 4920.2 5071.3 5133.4 5156.7 5204.9 5051.2 5077.8 5081.3 5085.5 5118.2 5024.0 5049.0 5055.3 5081.1 5081.4 4542.6 4936.8 4951.3 4956.5 4960.0 4924.3 4946.8 4956.4 4973.5 4977.2 5031.3 5043.4 5050.8 5068.4 5105.5 3577.0 3656.6 3940.3 3942.8 3965.8 5608.0 5613.4 5614.3 5649.7 5670.6 5510.2 5526.6 5528.7 5534.7 5546.5 5288.3 5289.0 5402.9 5530.4 5554.6 5321.7 5340.6 5344.4 5381.6 5453.5 5547.6 5598.6 5600.1 5603.2 5645.4 5288.3 5462.3 5475.0 5480.6 5501.2 08:29:46 INFO - PROCESS | 25521 | 08:29:46 INFO - PROCESS | 25521 | [#5] yui.html Cycles:180 Average:19964.70 Median:2443.34 stddev:29428.74 (1204.4%) stddev-sans-first:29475.32 08:29:46 INFO - PROCESS | 25521 | Values: 585.3 593.9 612.4 613.6 644.9 12948.9 13223.7 13606.7 13775.2 13779.5 12564.2 12669.5 12685.9 12769.9 12789.8 518.6 577.5 586.7 596.7 597.5 589.3 592.0 594.2 594.7 595.1 625.9 627.9 628.0 628.0 628.2 533.6 544.8 603.2 618.9 623.1 443.6 444.9 445.5 446.7 447.0 12551.1 12602.6 12604.9 12610.2 12635.5 12286.1 12429.8 12679.0 12929.5 13151.7 11772.0 12037.3 12245.0 12302.1 12490.1 4373.2 4383.1 4416.9 4441.8 4499.7 71204.6 72558.6 79403.2 79969.2 80001.6 10429.5 10592.4 10666.4 10674.5 10746.1 17297.4 17449.7 17496.9 17531.4 17539.5 7975.2 8192.9 8337.7 8524.9 8552.0 4673.7 4695.6 4811.0 4840.9 5021.6 3162.4 3259.9 3266.1 3271.4 3273.2 551.6 558.1 564.8 577.8 584.2 522.9 544.0 564.9 635.6 661.8 9175.9 9390.7 9494.3 9629.3 9783.2 556.3 599.3 604.4 628.2 660.6 4570.5 4599.7 4686.8 4722.5 4745.7 96658.5 98221.0 100077.0 109737.0 114249.0 100338.5 100811.0 102334.5 103069.9 105319.0 85155.7 85181.0 85530.0 85937.0 94978.0 9040.4 9139.3 9314.5 9366.3 9407.2 37916.6 38653.6 40564.4 51170.0 53568.5 73746.6 74283.3 77809.0 78361.0 78750.2 10635.7 10884.3 10968.2 11000.3 11483.2 13427.5 13603.3 13713.7 13754.2 14624.3 13182.2 13412.3 13546.6 13778.8 13831.2 12822.4 12829.7 13233.2 13242.3 13384.7 12618.9 12751.1 13664.0 13915.0 14190.1 10658.1 10923.0 10982.3 11296.8 11621.1 10318.6 10425.9 10489.9 10611.8 10662.9 08:29:46 INFO - PROCESS | 25521 | -------- Summary: end -------- 08:29:46 INFO - PROCESS | 25521 | 08:29:47 INFO - TEST-INFO | 25521: exit 0 08:29:47 INFO - TEST-OK | dromaeo_css | took 1112972ms 08:29:47 INFO - TEST-START | kraken 08:29:47 INFO - operating with platform_type : linux_ 08:29:47 INFO - Initialising browser for kraken test... 08:29:47 INFO - TEST-INFO | started process 25704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAovFc9/profile http://localhost:48568/getInfo.html) 08:29:51 INFO - PROCESS | 25704 | __metrics Screen width/height:1600/1200 08:29:51 INFO - PROCESS | 25704 | colorDepth:24 08:29:51 INFO - PROCESS | 25704 | Browser inner width/height: 1024/697 08:29:51 INFO - PROCESS | 25704 | __metrics 08:29:52 INFO - PROCESS | 25704 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:53 INFO - TEST-INFO | 25704: exit 0 08:29:53 INFO - Browser initialized. 08:29:53 INFO - Running cycle 1/1 for kraken test... 08:29:53 INFO - TEST-INFO | started process 25786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAovFc9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:05 INFO - PROCESS | 25786 | RSS: Main: 174120960 08:30:05 INFO - PROCESS | 25786 | 08:30:07 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48568/tests/kraken/driver.html?testName=audio-beat-detection) 08:30:08 INFO - PROCESS | 25786 | RSS: Main: 232656896 08:30:08 INFO - PROCESS | 25786 | 08:30:11 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48568/tests/kraken/driver.html?testName=audio-dft) 08:30:11 INFO - PROCESS | 25786 | RSS: Main: 221319168 08:30:11 INFO - PROCESS | 25786 | 08:30:15 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48568/tests/kraken/driver.html?testName=audio-fft) 08:30:15 INFO - PROCESS | 25786 | RSS: Main: 286269440 08:30:15 INFO - PROCESS | 25786 | 08:30:17 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48568/tests/kraken/driver.html?testName=audio-oscillator) 08:30:18 INFO - PROCESS | 25786 | RSS: Main: 197754880 08:30:18 INFO - PROCESS | 25786 | 08:30:20 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48568/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:30:21 INFO - PROCESS | 25786 | RSS: Main: 202346496 08:30:21 INFO - PROCESS | 25786 | 08:30:24 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48568/tests/kraken/driver.html?testName=imaging-darkroom) 08:30:24 INFO - PROCESS | 25786 | RSS: Main: 238485504 08:30:24 INFO - PROCESS | 25786 | 08:30:28 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48568/tests/kraken/driver.html?testName=imaging-desaturate) 08:30:28 INFO - PROCESS | 25786 | RSS: Main: 233742336 08:30:28 INFO - PROCESS | 25786 | 08:30:31 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48568/tests/kraken/driver.html?testName=json-parse-financial) 08:30:32 INFO - PROCESS | 25786 | RSS: Main: 236331008 08:30:32 INFO - PROCESS | 25786 | 08:30:33 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48568/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:30:34 INFO - PROCESS | 25786 | RSS: Main: 226611200 08:30:34 INFO - PROCESS | 25786 | 08:30:36 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48568/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:30:36 INFO - PROCESS | 25786 | RSS: Main: 230473728 08:30:36 INFO - PROCESS | 25786 | 08:30:38 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48568/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:30:39 INFO - PROCESS | 25786 | RSS: Main: 236298240 08:30:39 INFO - PROCESS | 25786 | 08:30:42 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:30:42 INFO - PROCESS | 25786 | RSS: Main: 240025600 08:30:42 INFO - PROCESS | 25786 | 08:30:45 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:30:46 INFO - PROCESS | 25786 | RSS: Main: 238247936 08:30:46 INFO - PROCESS | 25786 | 08:30:47 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:48568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48568/tests/kraken/driver.html?testName=ai-astar) 08:30:48 INFO - PROCESS | 25786 | RSS: Main: 281681920 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | __start_tp_report 08:30:48 INFO - PROCESS | 25786 | _x_x_mozilla_page_load 08:30:48 INFO - PROCESS | 25786 | _x_x_mozilla_page_load_details 08:30:48 INFO - PROCESS | 25786 | |i|pagename|runs| 08:30:48 INFO - PROCESS | 25786 | |0;ai-astar;102;110;110;109;110;108;108;109;108;107 08:30:48 INFO - PROCESS | 25786 | |1;audio-beat-detection;158;127;127;186;134;131;149;126;170;126 08:30:48 INFO - PROCESS | 25786 | |2;audio-dft;160;161;164;162;162;161;164;160;161;161 08:30:48 INFO - PROCESS | 25786 | |3;audio-fft;74;74;76;130;76;76;74;75;99;75 08:30:48 INFO - PROCESS | 25786 | |4;audio-oscillator;88;90;120;87;87;87;116;87;87;130 08:30:48 INFO - PROCESS | 25786 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 08:30:48 INFO - PROCESS | 25786 | |6;imaging-darkroom;148;148;149;148;148;148;150;149;152;146 08:30:48 INFO - PROCESS | 25786 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 08:30:48 INFO - PROCESS | 25786 | |8;json-parse-financial;53;52;53;54;53;60;52;54;52;54 08:30:48 INFO - PROCESS | 25786 | |9;json-stringify-tinderbox;62;63;62;62;63;63;62;61;63;63 08:30:48 INFO - PROCESS | 25786 | |10;stanford-crypto-aes;84;83;78;79;80;79;79;83;93;81 08:30:48 INFO - PROCESS | 25786 | |11;stanford-crypto-ccm;124;124;123;131;130;132;127;131;144;124 08:30:48 INFO - PROCESS | 25786 | |12;stanford-crypto-pbkdf2;158;160;160;158;163;159;158;160;164;166 08:30:48 INFO - PROCESS | 25786 | |13;stanford-crypto-sha256-iterative;63;62;66;64;67;62;61;63;63;61 08:30:48 INFO - PROCESS | 25786 | __end_tp_report 08:30:48 INFO - PROCESS | 25786 | __start_cc_report 08:30:48 INFO - PROCESS | 25786 | _x_x_mozilla_cycle_collect,1656 08:30:48 INFO - PROCESS | 25786 | __end_cc_report 08:30:48 INFO - PROCESS | 25786 | __startTimestamp1466695848032__endTimestamp 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | ------- Summary: start ------- 08:30:48 INFO - PROCESS | 25786 | Number of tests: 14 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:2.38 (2.2%) stddev-sans-first:1.09 08:30:48 INFO - PROCESS | 25786 | Values: 102.0 110.0 110.0 109.0 110.0 108.0 108.0 109.0 108.0 107.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:141.50 stddev:21.48 (15.2%) stddev-sans-first:22.12 08:30:48 INFO - PROCESS | 25786 | Values: 158.0 127.0 127.0 186.0 134.0 131.0 149.0 126.0 170.0 126.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.39 08:30:48 INFO - PROCESS | 25786 | Values: 160.0 161.0 164.0 162.0 162.0 161.0 164.0 160.0 161.0 161.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:18.21 (24.1%) stddev-sans-first:19.02 08:30:48 INFO - PROCESS | 25786 | Values: 74.0 74.0 76.0 130.0 76.0 76.0 74.0 75.0 99.0 75.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:87.00 stddev:17.00 (19.5%) stddev-sans-first:17.65 08:30:48 INFO - PROCESS | 25786 | Values: 88.0 90.0 120.0 87.0 87.0 87.0 116.0 87.0 87.0 130.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:30:48 INFO - PROCESS | 25786 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:1.58 (1.1%) stddev-sans-first:1.66 08:30:48 INFO - PROCESS | 25786 | Values: 148.0 148.0 149.0 148.0 148.0 148.0 150.0 149.0 152.0 146.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:30:48 INFO - PROCESS | 25786 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:2.36 (4.4%) stddev-sans-first:2.49 08:30:48 INFO - PROCESS | 25786 | Values: 53.0 52.0 53.0 54.0 53.0 60.0 52.0 54.0 52.0 54.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 08:30:48 INFO - PROCESS | 25786 | Values: 62.0 63.0 62.0 62.0 63.0 63.0 62.0 61.0 63.0 63.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:4.41 (5.4%) stddev-sans-first:4.61 08:30:48 INFO - PROCESS | 25786 | Values: 84.0 83.0 78.0 79.0 80.0 79.0 79.0 83.0 93.0 81.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:130.50 stddev:6.31 (4.8%) stddev-sans-first:6.42 08:30:48 INFO - PROCESS | 25786 | Values: 124.0 124.0 123.0 131.0 130.0 132.0 127.0 131.0 144.0 124.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:160.00 stddev:2.80 (1.7%) stddev-sans-first:2.80 08:30:48 INFO - PROCESS | 25786 | Values: 158.0 160.0 160.0 158.0 163.0 159.0 158.0 160.0 164.0 166.0 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - PROCESS | 25786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.99 (3.2%) stddev-sans-first:2.11 08:30:48 INFO - PROCESS | 25786 | Values: 63.0 62.0 66.0 64.0 67.0 62.0 61.0 63.0 63.0 61.0 08:30:48 INFO - PROCESS | 25786 | -------- Summary: end -------- 08:30:48 INFO - PROCESS | 25786 | 08:30:48 INFO - TEST-INFO | 25786: exit 0 08:30:49 INFO - TEST-OK | kraken | took 61713ms 08:30:49 INFO - SUITE-END | took 1174s 08:30:49 INFO - Completed test suite (00:19:34) 08:30:49 INFO - javascript benchmark 08:30:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3051.6643169251392, 3071.4932036214022, 3076.446239676858, 3101.503759398494, 3113.875444982201, 5005.2492126181, 5086.109930762111, 5126.231065340201, 5206.6615669981475, 5223.007628550573, 5241.606879484035, 5272.103742363798, 5301.5228629423345, 5308.787648494055, 5323.121684921993, 4539.72761634303, 4747.548982846624, 4839.830605928793, 4853.320535125085, 4873.780679869415, 4794.640401969848, 4831.178699621073, 4840.370751802261, 4865.586425153866, 4932.457429682732, 4629.8148074077, 4671.953280467186, 4724.905501889977, 4727.858164255078, 4746.810127594892, 4738.526147385269, 4747.952520474785, 4755.286706993944, 4814.614830813526, 4857.854264372075, 4762.02318837695, 4789.760511974422, 4800.615950723934, 4801.663883528155, 4840.612750979948, 5064.797408103672, 5118.795248190068, 5194.194899790538, 5252.474752524755, 5254.7635356409055, 5539.9169012464845, 5544.584156188262, 5571.582131340166, 5589.944100558983, 5595.692236926968, 5360.517553420172, 5653.632513886625, 5663.830085097454, 5669.206311116447, 5669.773209071632, 5147.613928955306, 5148.510891465305, 5149.794008239666, 5197.376314842243, 5221.269022336875, 5650.74571644277, 5667.404922483162, 5667.546596272288, 5669.177969194444, 5671.234383358276, 5240.318758561362, 5398.352197736297, 5442.9930462864495, 5446.809361672323, 5453.23654688344, 5545.0, 5586.385497595261, 5591.217229587861, 5618.578606604521, 5635.718214089279, 5547.72261386929, 5560.77756889728, 5580.609357344947, 5584.190292407659, 5585.664860108406, 5378.97310513445, 5445.945540544544, 5504.559635229172, 5556.527695145958, 5565.860853478614, 4250.362445633118, 4259.0, 4263.211305908417, 4296.183725092223, 4299.9570004300185, 3816.3512202925567, 3844.1927195288745, 3845.884693438927, 3867.1878905430176, 3880.650741433228, 5060.367454068241, 5109.795608175631, 5198.142306519458, 5223.608229382811, 5292.735363231823, 5621.269234999424, 5643.633163844337, 5647.322321321468, 5650.5479561634975, 5671.773129074873, 5275.076861549291, 5301.5493683037375, 5303.522682958553, 5312.654677445954, 5363.329583802025, 4744.833930812474, 4785.258284965836, 4814.6870453420415, 4877.731724755102, 4879.707217566957, 5689.630174038757, 5691.857703557362, 5694.231278777394, 5699.116636921284, 5740.311162660508, 5561.138023606348, 5570.470805273492, 5577.888442231214, 5578.665280083208, 5583.637063590853, 5501.5323697486165, 5631.633943793804, 5657.575681823797, 5671.40450252734, 5697.088465845445, 5515.779368825362, 5524.14375771756, 5526.751296191762, 5533.750981205936, 5534.280543529477, 5600.635958662674, 5602.075657516464, 5606.074997625346, 5617.887642247214, 5643.0, 5270.314859068297, 5285.365756109138, 5318.255444237887, 5333.573314134937, 5373.167159090347, 5325.174597937326, 5328.09422398201, 5337.306150200449, 5339.546138578265, 5340.198970154508, 5183.0670479314085, 5192.714400707846, 5241.633085683966, 5249.947500525099, 5286.022085914118, 5393.40672526014, 5514.476124768141, 5534.695591742493, 5586.02244607184, 5606.383297837153, 5400.7569659364635, 5428.104362780097, 5435.2934118564335, 5438.320209973754, 5451.209574611738], "value": 5133.823325793968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.1697544840621, 572.4819038769915, 580.8780156167205, 591.8609126855189, 596.165368484122, 28636.0, 31054.53418198729, 31171.68828311716, 31272.374552508936, 31319.21701957452, 36509.26981460369, 37442.999999999935, 37550.0, 40948.79525602368, 41056.178876422455, 8472.110428405022, 8585.785355366135, 8589.871151932726, 8599.44103633265, 8601.096884827097, 8467.068622451525, 8520.233179013887, 8543.530105844176, 8551.743447696548, 8561.657533698644, 8522.14778522146, 8538.70114545991, 8568.10034946331, 8568.785780355478, 8572.314214862827, 8510.829783404328, 8555.401121921468, 8556.61495232716, 8558.443701159405, 8559.786005349853, 8466.872996905051, 8521.914780852174, 8524.01973773018, 8529.829403411959, 8539.786505337353, 34591.65408345909, 34720.82639586811, 34811.477827832605, 34876.825615871756, 34925.476117858, 3089.9691003089906, 3207.5669784579018, 3412.266362732, 3426.691597756189, 3427.9314413711836, 27798.583021254697, 29665.11004669863, 29704.40591188186, 29731.10806675803, 29777.404451911058, 4294.871153865389, 4380.299152135643, 4391.802368893407, 4559.794809233593, 4583.72497650142, 340291.0, 341716.0, 342319.0, 342333.0, 342596.0, 29694.851525742233, 30474.390512190075, 44023.77988110039, 44769.32846007313, 44803.32795008012, 32209.677903221138, 32251.677483224867, 32343.35313293768, 32349.35301293961, 32356.514652279762, 13625.795613065811, 13735.725285494435, 13752.243626600633, 13755.17468951866, 13761.38073786682, 10663.46682665879, 10709.732256693489, 10712.0, 10719.517621707042, 10720.624778132884, 7590.544567325978, 7597.6581053851605, 7689.154193038761, 7714.344280736088, 7720.42096842739, 2935.456940465978, 2994.146668199596, 2996.700329966986, 3009.5485677148167, 3010.1120169550036, 862.9050804411635, 911.5533388639651, 942.6842007927421, 948.4688574398359, 981.764376549623, 27592.361768958708, 28306.85846570754, 28719.712802871705, 28774.280642983675, 28906.566401503995, 865.6018231613529, 991.3952488981715, 998.5456617239139, 1016.1819735113305, 1028.840529717895, 14354.712905741826, 14955.0, 15005.69988600222, 15136.394544218108, 15277.083374997535, 524554.0, 526281.0, 528717.0, 528883.0, 528995.0, 47658.5234147661, 47712.5228747715, 47833.282500762514, 47939.520604794205, 48004.0, 1092.382803715914, 1097.358045543366, 1155.5955415604471, 1174.682835634391, 1200.2918278215895, 27908.0, 29139.708602914547, 29305.85347073251, 29374.853125734233, 29536.852315738284, 41087.38368924409, 41711.374329384475, 41716.582834172485, 41772.1645567093, 41800.37299440572, 366043.0, 375708.0, 376747.0, 377197.0, 377514.0, 23916.88041559781, 24530.264092077265, 25074.985002999838, 25250.36874078163, 26831.597526037516, 37624.0, 39692.603073968894, 40722.0, 41342.793286033375, 41836.37245441382, 34842.82578587091, 35497.1125721859, 36015.45976810298, 36125.45811812877, 36335.636643633225, 35594.0, 35763.284734305686, 35817.64182358143, 35994.46008309825, 36517.08707282339, 35120.824395877855, 35194.296114077064, 35627.82186089053, 35948.10129746777, 36071.63928360788, 31048.534271985485, 32978.34043319168, 33554.32891342208, 33566.664333356355, 33624.1593960153, 24756.13353532618, 25086.74913250844, 25463.0, 26060.739392605832, 26274.0], "value": 16818.23916063613, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.08046343908507, 368.5681128814555, 369.5417682074229, 379.5199073172439, 385.1584288329999, 16816.91591542042, 18257.817421825777, 18573.349932752357, 18950.810491895078, 18952.336668216616, 15548.378064877392, 16270.0, 16511.0, 16714.331426742916, 16726.58183545412, 4829.6377771667, 5046.7224302663335, 5066.84799456015, 5078.8476345709505, 5079.03498335317, 3712.5544934607883, 4444.444444444444, 5001.699898006132, 6204.6277223366515, 6221.564490485668, 6238.532110091739, 6245.0, 6249.093881387196, 6253.405926436982, 6270.216222972129, 5261.368635763713, 5551.833444996636, 5552.250446189753, 5640.238567793336, 6242.719077641517, 3662.505561749156, 5125.410577783528, 5394.703291318976, 5407.242985981966, 5440.809571664972, 11871.46578403974, 11981.0, 12045.036397088212, 13507.041478985491, 20623.69064464034, 2159.0715992123382, 2167.089822274648, 2170.8263338933007, 2697.3661189620425, 2778.4304217635336, 9149.902011758564, 9329.346945713804, 9343.486108264044, 12043.759124817541, 12778.488860445572, 1812.1120650881105, 1840.3190819396775, 1867.8505719542404, 1881.5766452548205, 1924.7594050743658, 49608.50391496075, 54062.45937540653, 55250.17124743132, 76692.61653691751, 80731.5963420185, 10237.74405639865, 10330.173586113093, 10448.373097614167, 10450.790984180274, 10554.155667546578, 14090.365933533016, 14165.291735413395, 14181.85818141826, 14183.007189496637, 14191.64520886986, 7429.4799364045075, 7529.209433009564, 7540.585267810323, 7705.036870391201, 7798.961005195051, 7124.8575028499135, 7241.637918104074, 7248.876424154265, 7266.237045110293, 7688.231176882267, 4215.725977811432, 4242.681798865097, 4261.403403523509, 4407.713498622579, 4533.252013417815, 1786.4104845400987, 1800.1359347513267, 1822.88151270167, 1830.8901465912088, 1866.4773863318292, 793.4882001109253, 815.535144967363, 824.7979245084992, 837.4263629413871, 837.8026089292688, 17146.657066858843, 17224.124571971206, 17811.753177277726, 18056.819431805776, 18232.27070917175, 849.613425891218, 853.568947681417, 855.6106971328031, 877.7147427086222, 905.8550631898996, 9444.716658500256, 9474.668386606436, 10157.695269141937, 10190.0, 10427.478626068667, 537490.0, 549603.0, 550165.0, 561924.0, 569408.0, 92627.0, 95753.0, 96777.51611241899, 97990.51004744931, 99931.50034249782, 891.7859713668673, 895.3285036222833, 916.7708072981754, 918.4764684130115, 933.3186773655134, 16021.279042442884, 16212.756808648115, 16249.59376015609, 16281.185940703155, 16371.345146194019, 42291.0, 43281.0, 44155.77922110369, 44446.555534445535, 44915.775421122686, 58462.0, 58727.0, 59692.70153649204, 59851.0, 60300.09549856844, 5824.15549745293, 6655.767048153291, 7985.361171106181, 8154.796130096795, 8423.284020858051, 10747.516361763583, 12413.193142445713, 12567.93716031414, 12630.873691263338, 13043.28261945602, 11176.720581985515, 11335.376554289593, 11367.658970230907, 11524.193306468802, 11673.766524669289, 5525.585581081516, 11088.503052087864, 11128.1653875958, 11250.437478126225, 11288.830667539829, 11380.203385762918, 11536.769264614828, 11565.884341156481, 11686.824697629712, 11692.0, 8118.0, 8138.145494722969, 8225.506469611842, 8267.338612911073, 8282.792930176553, 10900.618478353219, 11325.32048077118, 11382.772344553228, 11433.428328583372, 11513.42432878336], "value": 8577.927235071955, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1133.6712353417508, 1200.2558413783456, 1207.782599132156, 1250.8936740377067, 1401.1312985948707, 7531.472796904219, 7763.7670869873855, 7770.650320735566, 7925.048994120699, 7934.166912474194, 7755.650995705193, 7931.167227441122, 7945.324647404963, 7954.164812694656, 7956.085050219226, 1880.3136855047946, 2163.145557504785, 2212.4358288636417, 2242.843000989931, 2252.2117258959397, 2198.4064302638276, 2219.034719896842, 2230.609643312414, 2230.9107635694554, 2232.6985856909273, 2232.8325375596896, 2238.597052530544, 2247.404437823978, 2258.672492488588, 2263.9094436222613, 1900.2968901506463, 2157.320444060116, 2198.5712786006734, 2223.5108276179217, 2228.810551103158, 2217.5454031923578, 2224.077008041661, 2235.8434909556336, 2239.80961618261, 2240.9439764005865, 8057.677692892277, 8152.633131509037, 8179.591020448954, 8180.713675021346, 8181.754547363588, 4778.952210477885, 4925.507449255082, 4940.2342636891335, 4941.7034977901085, 4943.975280123613, 3140.7173354397987, 3277.2626159114247, 3324.7672662913606, 3336.249343897628, 3366.9494957575657, 1055.0926203465015, 1066.8879767624444, 1076.5048077884182, 1079.3955384984433, 1090.6946055104584, 11731.17881748278, 11920.165588408814, 11983.520659173622, 11983.94008029963, 11994.760104797942, 4282.379055037002, 4306.913861722748, 4388.758618276025, 4423.977880110579, 4424.181526417558, 9686.9031309686, 9702.51487425626, 9707.077827606367, 9715.611375544899, 9720.708378748648, 4953.578945789648, 4958.553730164231, 4964.478729733398, 4966.03162383339, 4967.105920934267, 3781.470594116826, 4364.519902810688, 4508.211063063951, 4546.249868771682, 4584.77076146198, 3662.249238906018, 3733.1973625670066, 3734.1224812169116, 3809.5619003814363, 3855.3445914194654, 1174.2191442690687, 1189.7501524679915, 1194.2774621354129, 1199.2205066706535, 1207.3963018490754, 750.7597568777938, 835.5863847395578, 858.1118542308681, 870.7039606533809, 875.1904488348252, 5328.680279183184, 5432.59255555827, 5511.145772405283, 5624.831255062355, 5643.915341269884, 800.1318569352202, 829.1584042197175, 829.5852073963018, 837.937154713399, 838.6142374507673, 3780.1872597391693, 3861.2470568238923, 3884.533855937306, 3909.7849618271266, 3923.136909879822, 9706.223502119814, 9974.700758977242, 10081.747956301004, 10098.192144628412, 10147.7463063424, 9786.706398808046, 9858.704238872846, 9875.3211953968, 10037.899621003842, 10040.899591004143, 7524.360429363456, 7535.0, 7568.0, 7577.621118944141, 7619.542827430372, 5425.484578964992, 5595.356533998643, 5615.2700148980375, 5670.121131224667, 5800.651960882361, 9631.422114673142, 9842.60629574809, 9890.208783297176, 9940.602375904882, 9972.900270997487, 9692.806143877224, 9915.405075695482, 9973.60105595768, 10072.395656260647, 10309.74225644365, 6095.664738439428, 6239.688015599111, 6242.687865606611, 6811.114555107804, 6944.9582562616015, 7105.431565474646, 7690.384769218337, 7902.920970790218, 7945.562994035384, 8151.347892168731, 7063.434925206074, 7227.349538541346, 7240.167380751071, 7314.890276645748, 7404.777856664308, 6969.616671082937, 7138.8215294615975, 7284.708611655475, 7290.5625662460425, 7439.256074392518, 6476.6114033158165, 6568.770093046721, 6576.046473261446, 6595.175603049619, 6599.241087275025, 4974.427940786856, 4974.726390048582, 4985.900281994267, 4990.600751939909, 5039.319691841554, 5087.618428617794, 5094.312267843794, 5101.183810590288, 5213.348331458567, 5257.00116977773], "value": 4317.803956973133, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.4430897757726, 299.59255412638817, 308.4478782978468, 309.5017022593625, 311.86901501369425, 5119.1297479428495, 5186.870328241786, 5340.679559226444, 5397.379301380342, 5398.811041613544, 5223.686578805275, 5223.686578805275, 5312.415634280236, 5354.464553544643, 5359.0, 4104.527979282376, 4122.525909520398, 4134.772587507686, 4142.792860356985, 4150.128473020669, 3851.383778595425, 3915.158240978189, 4107.199096176247, 4109.424680544711, 4114.053767633446, 4041.898952526181, 4062.5328087270045, 4068.4743221292015, 4089.488813898263, 4090.713650044498, 4039.0710136668436, 4052.53395859477, 4055.1484188320487, 4061.8578349757913, 4080.89797755057, 3480.825958702055, 3541.5395998520025, 3563.572371315433, 3574.749767516275, 3591.2099338145827, 5177.741112944338, 5191.987562425328, 5193.584513238932, 5197.506236907488, 5214.791408343662, 4647.442306923191, 4650.07022085834, 4670.813167473297, 4676.6960147590635, 4679.508651591568, 5250.0, 5433.293671822637, 5486.643368181056, 5507.421720719347, 5517.310336207974, 3844.5770965193806, 3871.1676989447406, 3873.9031524211837, 3879.321118804226, 3890.5525864525657, 5730.455606717355, 5774.2782152230975, 5791.247137872049, 5795.884082318372, 5827.592068555203, 3855.4602355670227, 3907.6112045985933, 3929.646331830149, 3961.3265744823448, 3980.900477488086, 3985.724568138226, 4002.399640053957, 4014.6386825185873, 4020.6582440492302, 4022.9684009574976, 4612.630989520831, 4626.653001024936, 4634.675572709878, 4643.303504474288, 4645.304463870663, 5357.571394288448, 5493.587980901369, 5552.3892371839065, 5600.467955544217, 5621.775128994795, 1299.4282515693064, 1325.2909693314032, 1331.2145833957818, 1343.8185844911006, 1344.6302266876492, 871.8605023196258, 889.7375274294099, 891.1623074310128, 899.9730008099767, 900.230303090861, 4801.351817504592, 4802.247179779355, 4810.230363141881, 4826.8793280168275, 4858.902821943541, 4767.713937163781, 5010.774515146827, 5023.472535383805, 5125.564327032244, 5166.870828229249, 4711.9032030746675, 4715.646326525524, 4756.833510827105, 4761.904761904742, 4771.8028920623265, 2701.2436517775054, 2713.8330517877503, 2721.7479959218585, 2724.250831021485, 2725.7683096936585, 4920.179533572601, 5071.340725705634, 5133.374843102966, 5156.74216289184, 5204.8959020819375, 5051.191809310492, 5077.796888124433, 5081.3140226069745, 5085.474357692678, 5118.232265160182, 5024.020316038411, 5048.974755126201, 5055.317532133115, 5081.0691937063675, 5081.415637201769, 4542.568455996675, 4936.765808547863, 4951.282064100613, 4956.454789973028, 4959.97520012412, 4924.335214746106, 4946.802127914843, 4956.355673762388, 4973.45292017885, 4977.203647416396, 5031.3082500861865, 5043.394792624908, 5050.84847454577, 5068.442471328077, 5105.544919697868, 3576.964230357663, 3656.5794933581915, 3940.271049855786, 3942.79744677876, 3965.7620542767527, 5607.971960140173, 5613.438656134354, 5614.27707561824, 5649.683629711799, 5670.631408958405, 5510.236724248362, 5526.58550608714, 5528.668279903219, 5534.723263836711, 5546.528545073553, 5288.2860813791185, 5288.973555132354, 5402.945970540244, 5530.419305972976, 5554.638948468337, 5321.6540924839765, 5340.572754179579, 5344.3853956795465, 5381.569474441957, 5453.481919217668, 5547.639403438763, 5598.552115830642, 5600.0679765480845, 5603.243562119224, 5645.379008309001, 5288.338957630296, 5462.262594549685, 5475.0, 5480.6437581557075, 5501.202325662836], "value": 4029.741777697413, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.3181044083643, 593.9138824870394, 612.4304396910874, 613.6318209074556, 644.8968165093584, 12948.935255323722, 13223.735525289489, 13606.659833504142, 13775.173489590632, 13779.517716879911, 12564.246145231293, 12669.4932202712, 12685.873141268585, 12769.93615031926, 12789.808152877715, 518.5929045699127, 577.4629594477135, 586.6509426891004, 596.698667173077, 597.5309382135025, 589.269306060484, 591.9704014799242, 594.1503649780811, 594.7056207177453, 595.0538643556744, 625.924889013319, 627.886980343538, 627.9529035322346, 628.0359647940412, 628.2429672244957, 533.6317940620959, 544.7820871651352, 603.2459425717852, 618.8855061813579, 623.0840664223607, 443.6473003961858, 444.86115544206933, 445.48546428874704, 446.70963873482174, 447.0143333948668, 12551.05867059965, 12602.55891043809, 12604.936975315157, 12610.180338278074, 12635.49458021678, 12286.13997020209, 12429.813552796715, 12679.0, 12929.547465838745, 13151.736965260641, 11772.0, 12037.337946412943, 12245.0, 12302.138850280484, 12490.063245256551, 4373.190959672471, 4383.123375324916, 4416.933745993812, 4441.822327106912, 4499.6850220484575, 71204.64397678031, 72558.63720681415, 79403.20596794074, 79969.20030799675, 80001.59999200025, 10429.530671119817, 10592.417417041983, 10666.36001839892, 10674.466276686135, 10746.140308775435, 17297.394591189248, 17449.651006979788, 17496.91251543734, 17531.386401475887, 17539.473815785546, 7975.2423519765525, 8192.918070819216, 8337.708180213785, 8524.914750852537, 8552.0, 4673.719576825401, 4695.624350051988, 4810.95189048112, 4840.878978025507, 5021.59827213822, 3162.4307624627786, 3259.885903993349, 3266.1181481, 3271.362084393568, 3273.1980664737293, 551.5807985930721, 558.117442159641, 564.8220810444778, 577.8122110314081, 584.2492397269489, 522.9215617657381, 543.9592030597641, 564.9350324712628, 635.6218050260088, 661.7683810666324, 9175.908240917639, 9390.66631345876, 9494.287928405398, 9629.32594718363, 9783.168430683329, 556.2546188107955, 599.346712083822, 604.4016423740466, 628.2272804450552, 660.5871330418488, 4570.520095390003, 4599.724016559017, 4686.835960741358, 4722.52774722525, 4745.725667848892, 96658.51670741742, 98221.0, 100077.0, 109737.0, 114249.0, 100338.49830750945, 100811.0, 102334.48832755789, 103069.90790276304, 105319.0, 85155.72266416009, 85181.0, 85530.0, 85937.0, 94978.0, 9040.367174297999, 9139.314551408537, 9314.534273286445, 9366.297527685314, 9407.2003879671, 37916.62083379131, 38653.613463866124, 40564.3915341276, 51170.0, 53568.46431535791, 73746.63126684332, 74283.3145016951, 77809.0, 78361.0, 78750.21249787658, 10635.734106647085, 10884.346939183675, 10968.245080787356, 11000.339979601249, 11483.196176267582, 13427.530036448677, 13603.319834008458, 13713.657158571115, 13754.243516606683, 14624.268786560842, 13182.209067455984, 13412.329383530589, 13546.59360219195, 13778.793318100035, 13831.239281839595, 12822.358882055672, 12829.743405132032, 13233.206007639572, 13242.337883105614, 13384.732305354033, 12618.87381126177, 12751.107422480338, 13664.0, 13914.956378271467, 14190.077644953046, 10658.147348211969, 10923.016928476476, 10982.341059536453, 11296.774064518499, 11621.128415368712, 10318.638847640297, 10425.895741042492, 10489.895101049196, 10611.787764244518, 10662.946685266525], "value": 6819.675352156581, "unit": "score"}], "name": "dromaeo_css", "value": 6667.939541784843, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 109.0, 110.0, 108.0, 108.0, 109.0, 108.0, 107.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 127.0, 186.0, 134.0, 131.0, 149.0, 126.0, 170.0, 126.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 164.0, 162.0, 162.0, 161.0, 164.0, 160.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 130.0, 76.0, 76.0, 74.0, 75.0, 99.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 120.0, 87.0, 87.0, 87.0, 116.0, 87.0, 87.0, 130.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 150.0, 149.0, 152.0, 146.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 54.0, 53.0, 60.0, 52.0, 54.0, 52.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0, 61.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 78.0, 79.0, 80.0, 79.0, 79.0, 83.0, 93.0, 81.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 123.0, 131.0, 130.0, 132.0, 127.0, 131.0, 144.0, 124.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 160.0, 158.0, 163.0, 159.0, 158.0, 160.0, 164.0, 166.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 66.0, 64.0, 67.0, 62.0, 61.0, 63.0, 63.0, 61.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1505.0, "alertThreshold": 2.0}]} 08:30:49 INFO - Return code: 0 08:30:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:30:49 INFO - # TBPL SUCCESS # 08:30:49 INFO - Running post-action listener: _resource_record_post_action 08:30:49 INFO - ##### 08:30:49 INFO - ##### Finished run-tests step (success) 08:30:49 INFO - ##### 08:30:49 INFO - Running post-run listener: _resource_record_post_run 08:30:49 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 552378368; Read time: 0; Write time: 536836 08:30:49 INFO - TinderboxPrint: CPU usage
13.3% 08:30:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:30:49 INFO - TinderboxPrint: I/O write bytes / time
552,378,368 / 536,836 08:30:49 INFO - TinderboxPrint: CPU idle
8,257.4 (86.7%) 08:30:49 INFO - TinderboxPrint: CPU user
1,214.6 (12.8%) 08:30:49 INFO - TinderboxPrint: Swap in / out
0 / 0 08:30:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263098368; Read time: 0; Write time: 260504 08:30:49 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 288694272; Read time: 0; Write time: 276320 08:30:49 INFO - Running post-run listener: _upload_blobber_files 08:30:49 INFO - Blob upload gear active. 08:30:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:30:49 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 08:30:49 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'] 08:30:49 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 08:30:50 INFO - (blobuploader) - INFO - Open directory for files ... 08:30:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:30:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:30:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:51 INFO - (blobuploader) - INFO - Done attempting. 08:30:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:30:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:30:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:55 INFO - (blobuploader) - INFO - Done attempting. 08:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:30:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:56 INFO - (blobuploader) - INFO - Done attempting. 08:30:56 INFO - (blobuploader) - INFO - Iteration through files over. 08:30:56 INFO - Return code: 0 08:30:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:30:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:30:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8534878ac34b4713e28dd01c620e09f7e47eb8e22ef3a509e998af4fcc307743645970cdfabee40889022ee03b69abf88c812da52ca84b3b2df48086ea11cb5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c9722c1da55aa32dece4f575501abcb4fc1fe264298b1be1666e1bfde24c81ae1328911c087b7d74310579e63db2814daa0596c058e2d3f3d63f3bc9c395b62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfb9ed82ddb0db1892107c45255c2022d84eca9b8fdf43529a28871cd9c1d6a6b50dc1e057db47841b833dbc359f7082d83e895f12290edf0d6e577cd2be5820"} 08:30:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:30:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:30:56 INFO - Contents: 08:30:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8534878ac34b4713e28dd01c620e09f7e47eb8e22ef3a509e998af4fcc307743645970cdfabee40889022ee03b69abf88c812da52ca84b3b2df48086ea11cb5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c9722c1da55aa32dece4f575501abcb4fc1fe264298b1be1666e1bfde24c81ae1328911c087b7d74310579e63db2814daa0596c058e2d3f3d63f3bc9c395b62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfb9ed82ddb0db1892107c45255c2022d84eca9b8fdf43529a28871cd9c1d6a6b50dc1e057db47841b833dbc359f7082d83e895f12290edf0d6e577cd2be5820"} 08:30:56 INFO - Running post-run listener: copy_logs_to_upload_dir 08:30:56 INFO - Copying logs to upload dir... 08:30:56 INFO - mkdir: /builds/slave/test/build/upload/logs 08:30:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.440110 ========= master_lag: 6.94 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-23 08:31:02.985031) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:31:02.992546) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636 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/8534878ac34b4713e28dd01c620e09f7e47eb8e22ef3a509e998af4fcc307743645970cdfabee40889022ee03b69abf88c812da52ca84b3b2df48086ea11cb5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c9722c1da55aa32dece4f575501abcb4fc1fe264298b1be1666e1bfde24c81ae1328911c087b7d74310579e63db2814daa0596c058e2d3f3d63f3bc9c395b62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfb9ed82ddb0db1892107c45255c2022d84eca9b8fdf43529a28871cd9c1d6a6b50dc1e057db47841b833dbc359f7082d83e895f12290edf0d6e577cd2be5820"} build_url:https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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/8534878ac34b4713e28dd01c620e09f7e47eb8e22ef3a509e998af4fcc307743645970cdfabee40889022ee03b69abf88c812da52ca84b3b2df48086ea11cb5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c9722c1da55aa32dece4f575501abcb4fc1fe264298b1be1666e1bfde24c81ae1328911c087b7d74310579e63db2814daa0596c058e2d3f3d63f3bc9c395b62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfb9ed82ddb0db1892107c45255c2022d84eca9b8fdf43529a28871cd9c1d6a6b50dc1e057db47841b833dbc359f7082d83e895f12290edf0d6e577cd2be5820"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:31:03.115459) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:31:03.115846) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466694620.160178-1019163636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:31:03.340073) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:31:03.340364) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:31:03.340705) ========= ========= Total master_lag: 7.33 =========