builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1466641144.59 results: success (0) buildid: 20160622143004 builduid: 0b4bde6c3f03478e809a48325d9716e8 revision: 882dd3714959ace05ad400f14a1c7839f4482006 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:04.585522) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:04.585934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:04.586207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:04.613444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:04.613717) ========= 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=62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 17:19:05-- 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% 228M=0s 2016-06-22 17:19:05 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167037 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:04.794661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:04.794996) ========= 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=62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020717 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:04.843921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 17:19:04.844263) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 882dd3714959ace05ad400f14a1c7839f4482006 --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 882dd3714959ace05ad400f14a1c7839f4482006 --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=62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 17:19:05,380 truncating revision to first 12 chars 2016-06-22 17:19:05,380 Setting DEBUG logging. 2016-06-22 17:19:05,380 attempt 1/10 2016-06-22 17:19:05,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/882dd3714959?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 17:19:06,291 unpacking tar archive at: fx-team-882dd3714959/testing/mozharness/ program finished with exit code 0 elapsedTime=1.257239 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 17:19:06.116374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:06.116668) ========= script_repo_revision: 882dd3714959ace05ad400f14a1c7839f4482006 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:06.117112) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:06.117397) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 17:19:06.126858) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-06-22 17:19:06.127185) ========= /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=62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:19:06 INFO - MultiFileLogger online at 20160622 17:19:06 in /builds/slave/test 17:19:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:19:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:19:06 INFO - {'append_to_log': False, 17:19:06 INFO - 'base_work_dir': '/builds/slave/test', 17:19:06 INFO - 'blob_upload_branch': 'Fx-Team', 17:19:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:19:06 INFO - 'branch': 'Fx-Team', 17:19:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:19:06 INFO - 'config_files': ('talos/linux_config.py',), 17:19:06 INFO - 'default_actions': ('clobber', 17:19:06 INFO - 'read-buildbot-config', 17:19:06 INFO - 'download-and-extract', 17:19:06 INFO - 'populate-webroot', 17:19:06 INFO - 'create-virtualenv', 17:19:06 INFO - 'install', 17:19:06 INFO - 'run-tests'), 17:19:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:19:06 INFO - 'download_minidump_stackwalk': True, 17:19:06 INFO - 'download_symbols': 'ondemand', 17:19:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:19:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:19:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:19:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:19:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:19:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:19:06 INFO - 'installer_path': 'installer.exe', 17:19:06 INFO - 'log_level': 'info', 17:19:06 INFO - 'log_name': 'talos', 17:19:06 INFO - 'log_to_console': True, 17:19:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:19:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:19:06 INFO - 'opt_config_files': (), 17:19:06 INFO - 'pip_index': False, 17:19:06 INFO - 'sps_profile': False, 17:19:06 INFO - 'sps_profile_interval': 0, 17:19:06 INFO - 'suite': 'dromaeojs', 17:19:06 INFO - 'system_bits': '32', 17:19:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:19:06 INFO - 'title': 'talos-linux64-ix-018', 17:19:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:19:06 INFO - 'use_talos_json': True, 17:19:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:19:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:19:06 INFO - 'work_dir': 'build'} 17:19:06 INFO - ##### 17:19:06 INFO - ##### Running clobber step. 17:19:06 INFO - ##### 17:19:06 INFO - Running pre-action listener: _resource_record_pre_action 17:19:06 INFO - Running main action method: clobber 17:19:06 INFO - rmtree: /builds/slave/test/build 17:19:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:19:07 INFO - Running post-action listener: _resource_record_post_action 17:19:07 INFO - ##### 17:19:07 INFO - ##### Finished clobber step (success) 17:19:07 INFO - ##### 17:19:07 INFO - ##### 17:19:07 INFO - ##### Running read-buildbot-config step. 17:19:07 INFO - ##### 17:19:07 INFO - Running pre-action listener: _resource_record_pre_action 17:19:07 INFO - Running main action method: read_buildbot_config 17:19:07 INFO - Using buildbot properties: 17:19:07 INFO - { 17:19:07 INFO - "project": "", 17:19:07 INFO - "product": "firefox", 17:19:07 INFO - "script_repo_revision": "production", 17:19:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:19:07 INFO - "repository": "", 17:19:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:19:07 INFO - "buildid": "20160622143004", 17:19:07 INFO - "pgo_build": "True", 17:19:07 INFO - "basedir": "/builds/slave/test", 17:19:07 INFO - "buildnumber": 818, 17:19:07 INFO - "slavename": "talos-linux64-ix-018", 17:19:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:19:07 INFO - "platform": "ubuntu64_hw", 17:19:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:19:07 INFO - "branch": "fx-team", 17:19:07 INFO - "repo_path": "integration/fx-team", 17:19:07 INFO - "revision": "882dd3714959ace05ad400f14a1c7839f4482006", 17:19:07 INFO - "stage_platform": "linux64-pgo", 17:19:07 INFO - "builduid": "0b4bde6c3f03478e809a48325d9716e8", 17:19:07 INFO - "slavebuilddir": "test" 17:19:07 INFO - } 17:19:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:19:07 INFO - Running post-action listener: _resource_record_post_action 17:19:07 INFO - ##### 17:19:07 INFO - ##### Finished read-buildbot-config step (success) 17:19:07 INFO - ##### 17:19:07 INFO - ##### 17:19:07 INFO - ##### Running download-and-extract step. 17:19:07 INFO - ##### 17:19:07 INFO - Running pre-action listener: _resource_record_pre_action 17:19:07 INFO - Running main action method: download_and_extract 17:19:07 INFO - mkdir: /builds/slave/test/build/tests 17:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:07 INFO - https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:19:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:19:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:19:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:19:09 INFO - Downloaded 1361 bytes. 17:19:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:19:09 INFO - Using the following test package requirements: 17:19:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:19:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:19:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:19:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:09 INFO - u'jsshell-linux-x86_64.zip'], 17:19:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:19:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:19:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:19:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:19:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:19:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:19:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:09 INFO - https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:19:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:19:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:19:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:19:11 INFO - Downloaded 24269679 bytes. 17:19:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:19:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:19:12 INFO - Return code: 0 17:19:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:12 INFO - https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:19:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:19:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:19:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:19:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:19:17 INFO - Downloaded 24269679 bytes. 17:19:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:19:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:19:19 INFO - Return code: 0 17:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:19 INFO - https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:19:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:19:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:19:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:19:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:19:52 INFO - Downloaded 14405384 bytes. 17:19:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:19:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:19:52 INFO - Return code: 0 17:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:52 INFO - https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:19:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:19:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:19:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:19:55 INFO - Downloaded 60180028 bytes. 17:19:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:19:55 INFO - mkdir: /builds/slave/test/properties 17:19:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:19:55 INFO - Writing to file /builds/slave/test/properties/build_url 17:19:55 INFO - Contents: 17:19:55 INFO - build_url:https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:19:57 INFO - Running post-action listener: _resource_record_post_action 17:19:57 INFO - Running post-action listener: set_extra_try_arguments 17:19:57 INFO - ##### 17:19:57 INFO - ##### Finished download-and-extract step (success) 17:19:57 INFO - ##### 17:19:57 INFO - ##### 17:19:57 INFO - ##### Running populate-webroot step. 17:19:57 INFO - ##### 17:19:57 INFO - Running pre-action listener: _resource_record_pre_action 17:19:57 INFO - Running main action method: populate_webroot 17:19:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:19:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:19:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:19:57 INFO - '--tppagecycles', 17:19:57 INFO - '7'], 17:19:57 INFO - 'tests': ['tsvgm']}}, 17:19:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:19:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:19:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:19:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:19:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:19:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:19:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:57 INFO - 'talos_options': ['--disable-e10s'], 17:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:19:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:19:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:57 INFO - 'talos_options': ['--disable-e10s'], 17:19:57 INFO - 'tests': ['damp', 'tps']}, 17:19:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:57 INFO - 'tests': ['damp', 'tps']}, 17:19:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:19:57 INFO - 'tests': ['dromaeo_dom']}, 17:19:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:19:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:19:57 INFO - 'tests': ['basic_compositor_video']}, 17:19:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:19:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:19:57 INFO - 'tests': ['a11yr', 17:19:57 INFO - 'ts_paint', 17:19:57 INFO - 'tpaint', 17:19:57 INFO - 'sessionrestore', 17:19:57 INFO - 'sessionrestore_no_auto_restore', 17:19:57 INFO - 'tabpaint']}, 17:19:57 INFO - 'other-e10s': {'tests': ['a11yr', 17:19:57 INFO - 'ts_paint', 17:19:57 INFO - 'tpaint', 17:19:57 INFO - 'sessionrestore', 17:19:57 INFO - 'sessionrestore_no_auto_restore', 17:19:57 INFO - 'tabpaint']}, 17:19:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:19:57 INFO - 'ts_paint', 17:19:57 INFO - 'tpaint', 17:19:57 INFO - 'sessionrestore', 17:19:57 INFO - 'sessionrestore_no_auto_restore', 17:19:57 INFO - 'tabpaint']}, 17:19:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:19:57 INFO - 'ts_paint', 17:19:57 INFO - 'tpaint', 17:19:57 INFO - 'sessionrestore', 17:19:57 INFO - 'sessionrestore_no_auto_restore', 17:19:57 INFO - 'tabpaint']}, 17:19:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:19:57 INFO - 'tests': ['a11yr', 17:19:57 INFO - 'ts_paint', 17:19:57 INFO - 'tpaint', 17:19:57 INFO - 'sessionrestore', 17:19:57 INFO - 'sessionrestore_no_auto_restore', 17:19:57 INFO - 'tabpaint']}, 17:19:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:19:57 INFO - 'tests': ['a11yr', 17:19:57 INFO - 'ts_paint', 17:19:57 INFO - 'tpaint', 17:19:57 INFO - 'sessionrestore', 17:19:57 INFO - 'sessionrestore_no_auto_restore', 17:19:57 INFO - 'tabpaint']}, 17:19:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:19:57 INFO - 'tests': ['tsvgx', 17:19:57 INFO - 'tsvgr_opacity', 17:19:57 INFO - 'tart', 17:19:57 INFO - 'tscrollx', 17:19:57 INFO - 'cart']}, 17:19:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:19:57 INFO - 'tsvgr_opacity', 17:19:57 INFO - 'tart', 17:19:57 INFO - 'tscrollx', 17:19:57 INFO - 'cart']}, 17:19:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:57 INFO - 'talos_options': ['--disable-e10s'], 17:19:57 INFO - 'tests': ['tp5o']}, 17:19:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:57 INFO - 'tests': ['tp5o']}, 17:19:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:57 INFO - 'talos_options': ['--disable-e10s', 17:19:57 INFO - '--xperf_path', 17:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:19:57 INFO - 'tests': ['tp5n']}, 17:19:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:57 INFO - 'talos_options': ['--xperf_path', 17:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:19:57 INFO - 'tests': ['tp5n']}}, 17:19:57 INFO - 'talos.zip': {'path': '', 17:19:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:19:57 INFO - Running post-action listener: _resource_record_post_action 17:19:57 INFO - ##### 17:19:57 INFO - ##### Finished populate-webroot step (success) 17:19:57 INFO - ##### 17:19:57 INFO - ##### 17:19:57 INFO - ##### Running create-virtualenv step. 17:19:57 INFO - ##### 17:19:57 INFO - Running pre-action listener: _resource_record_pre_action 17:19:57 INFO - Running main action method: create_virtualenv 17:19:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:19:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:19:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:19:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:19:57 INFO - Using real prefix '/usr' 17:19:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:19:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:19:59 INFO - Installing pip.................done. 17:19:59 INFO - Return code: 0 17:19:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9228854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14271c0>, '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 0x14280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1428550>, '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': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:19:59 INFO - Using env: {'DISPLAY': ':0', 17:19:59 INFO - 'HOME': '/home/cltbld', 17:19:59 INFO - 'LANG': 'en_US.UTF-8', 17:19:59 INFO - 'LANGUAGE': 'en_US:en', 17:19:59 INFO - 'LOGNAME': 'cltbld', 17:19:59 INFO - 'MAIL': '/var/mail/cltbld', 17:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:59 INFO - 'MOZ_NO_REMOTE': '1', 17:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:59 INFO - 'NO_EM_RESTART': '1', 17:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:59 INFO - 'PWD': '/builds/slave/test', 17:19:59 INFO - 'SHELL': '/bin/bash', 17:19:59 INFO - 'SHLVL': '1', 17:19:59 INFO - 'TERM': 'linux', 17:19:59 INFO - 'TMOUT': '86400', 17:19:59 INFO - 'USER': 'cltbld', 17:19:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 17:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:59 INFO - '_': '/tools/buildbot/bin/python'} 17:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:19:59 INFO - Cleaning up... 17:19:59 INFO - Return code: 0 17:19:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9228854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14271c0>, '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 0x14280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1428550>, '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': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:19:59 INFO - Using env: {'DISPLAY': ':0', 17:19:59 INFO - 'HOME': '/home/cltbld', 17:19:59 INFO - 'LANG': 'en_US.UTF-8', 17:19:59 INFO - 'LANGUAGE': 'en_US:en', 17:19:59 INFO - 'LOGNAME': 'cltbld', 17:19:59 INFO - 'MAIL': '/var/mail/cltbld', 17:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:59 INFO - 'MOZ_NO_REMOTE': '1', 17:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:59 INFO - 'NO_EM_RESTART': '1', 17:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:59 INFO - 'PWD': '/builds/slave/test', 17:19:59 INFO - 'SHELL': '/bin/bash', 17:19:59 INFO - 'SHLVL': '1', 17:19:59 INFO - 'TERM': 'linux', 17:19:59 INFO - 'TMOUT': '86400', 17:19:59 INFO - 'USER': 'cltbld', 17:19:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 17:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:59 INFO - '_': '/tools/buildbot/bin/python'} 17:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:00 INFO - Downloading/unpacking psutil>=3.1.1 17:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:02 INFO - Installing collected packages: psutil 17:20:02 INFO - Running setup.py install for psutil 17:20:02 INFO - building 'psutil._psutil_linux' extension 17:20:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:20:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:20:02 INFO - building 'psutil._psutil_posix' extension 17:20:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:20:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:02 INFO - Successfully installed psutil 17:20:02 INFO - Cleaning up... 17:20:02 INFO - Return code: 0 17:20:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9228854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14271c0>, '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 0x14280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1428550>, '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': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:20:02 INFO - Using env: {'DISPLAY': ':0', 17:20:02 INFO - 'HOME': '/home/cltbld', 17:20:02 INFO - 'LANG': 'en_US.UTF-8', 17:20:02 INFO - 'LANGUAGE': 'en_US:en', 17:20:02 INFO - 'LOGNAME': 'cltbld', 17:20:02 INFO - 'MAIL': '/var/mail/cltbld', 17:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:02 INFO - 'MOZ_NO_REMOTE': '1', 17:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:02 INFO - 'NO_EM_RESTART': '1', 17:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:02 INFO - 'PWD': '/builds/slave/test', 17:20:02 INFO - 'SHELL': '/bin/bash', 17:20:02 INFO - 'SHLVL': '1', 17:20:02 INFO - 'TERM': 'linux', 17:20:02 INFO - 'TMOUT': '86400', 17:20:02 INFO - 'USER': 'cltbld', 17:20:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 17:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:02 INFO - '_': '/tools/buildbot/bin/python'} 17:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:20:04 INFO - Installing collected packages: mozsystemmonitor 17:20:04 INFO - Running setup.py install for mozsystemmonitor 17:20:04 INFO - Successfully installed mozsystemmonitor 17:20:04 INFO - Cleaning up... 17:20:05 INFO - Return code: 0 17:20:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9228854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14271c0>, '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 0x14280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1428550>, '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': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:20:05 INFO - Using env: {'DISPLAY': ':0', 17:20:05 INFO - 'HOME': '/home/cltbld', 17:20:05 INFO - 'LANG': 'en_US.UTF-8', 17:20:05 INFO - 'LANGUAGE': 'en_US:en', 17:20:05 INFO - 'LOGNAME': 'cltbld', 17:20:05 INFO - 'MAIL': '/var/mail/cltbld', 17:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:05 INFO - 'MOZ_NO_REMOTE': '1', 17:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:05 INFO - 'NO_EM_RESTART': '1', 17:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:05 INFO - 'PWD': '/builds/slave/test', 17:20:05 INFO - 'SHELL': '/bin/bash', 17:20:05 INFO - 'SHLVL': '1', 17:20:05 INFO - 'TERM': 'linux', 17:20:05 INFO - 'TMOUT': '86400', 17:20:05 INFO - 'USER': 'cltbld', 17:20:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 17:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:05 INFO - '_': '/tools/buildbot/bin/python'} 17:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:05 INFO - Downloading/unpacking jsonschema==2.5.1 17:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:20:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:20:07 INFO - warning: no files found matching '*.txt' 17:20:07 INFO - no previously-included directories found matching 'build' 17:20:07 INFO - no previously-included directories found matching 'dist' 17:20:07 INFO - no previously-included directories found matching '.git*' 17:20:07 INFO - Installing collected packages: jsonschema, functools32 17:20:07 INFO - Running setup.py install for functools32 17:20:07 INFO - warning: no files found matching '*.txt' 17:20:07 INFO - no previously-included directories found matching 'build' 17:20:07 INFO - no previously-included directories found matching 'dist' 17:20:07 INFO - no previously-included directories found matching '.git*' 17:20:07 INFO - Successfully installed jsonschema functools32 17:20:07 INFO - Cleaning up... 17:20:07 INFO - Return code: 0 17:20:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:07 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 0x7f9228854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14271c0>, '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 0x14280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1428550>, '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': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:20:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:20:07 INFO - Using env: {'DISPLAY': ':0', 17:20:07 INFO - 'HOME': '/home/cltbld', 17:20:07 INFO - 'LANG': 'en_US.UTF-8', 17:20:07 INFO - 'LANGUAGE': 'en_US:en', 17:20:07 INFO - 'LOGNAME': 'cltbld', 17:20:07 INFO - 'MAIL': '/var/mail/cltbld', 17:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:07 INFO - 'MOZ_NO_REMOTE': '1', 17:20:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:07 INFO - 'NO_EM_RESTART': '1', 17:20:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:07 INFO - 'PWD': '/builds/slave/test', 17:20:07 INFO - 'SHELL': '/bin/bash', 17:20:07 INFO - 'SHLVL': '1', 17:20:07 INFO - 'TERM': 'linux', 17:20:07 INFO - 'TMOUT': '86400', 17:20:07 INFO - 'USER': 'cltbld', 17:20:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 17:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:07 INFO - '_': '/tools/buildbot/bin/python'} 17:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:20:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:20:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:10 INFO - Downloading docopt-0.6.1.tar.gz 17:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:20:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:20:10 INFO - Running setup.py install for blobuploader 17:20:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:20:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:20:10 INFO - Running setup.py install for requests 17:20:11 INFO - Running setup.py install for docopt 17:20:11 INFO - Successfully installed blobuploader requests docopt 17:20:11 INFO - Cleaning up... 17:20:11 INFO - Return code: 0 17:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f9228854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14271c0>, '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 0x14280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1428550>, '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': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:20:11 INFO - Using env: {'DISPLAY': ':0', 17:20:11 INFO - 'HOME': '/home/cltbld', 17:20:11 INFO - 'LANG': 'en_US.UTF-8', 17:20:11 INFO - 'LANGUAGE': 'en_US:en', 17:20:11 INFO - 'LOGNAME': 'cltbld', 17:20:11 INFO - 'MAIL': '/var/mail/cltbld', 17:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:11 INFO - 'MOZ_NO_REMOTE': '1', 17:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:11 INFO - 'NO_EM_RESTART': '1', 17:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:11 INFO - 'PWD': '/builds/slave/test', 17:20:11 INFO - 'SHELL': '/bin/bash', 17:20:11 INFO - 'SHLVL': '1', 17:20:11 INFO - 'TERM': 'linux', 17:20:11 INFO - 'TMOUT': '86400', 17:20:11 INFO - 'USER': 'cltbld', 17:20:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 17:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:11 INFO - '_': '/tools/buildbot/bin/python'} 17:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:11 INFO - Running setup.py (path:/tmp/pip-d7QJVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:11 INFO - Running setup.py (path:/tmp/pip-0ym3mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:11 INFO - Running setup.py (path:/tmp/pip-pYEBKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:11 INFO - Running setup.py (path:/tmp/pip-yuGtp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:11 INFO - Running setup.py (path:/tmp/pip-HGnjG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:11 INFO - Running setup.py (path:/tmp/pip-udqBTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:11 INFO - Running setup.py (path:/tmp/pip-FauYvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:12 INFO - Running setup.py (path:/tmp/pip-JiYbCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:12 INFO - Running setup.py (path:/tmp/pip-RVyJEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:12 INFO - Running setup.py (path:/tmp/pip-tqKPA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:12 INFO - Running setup.py (path:/tmp/pip-8VPtqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:12 INFO - Running setup.py (path:/tmp/pip-2rmEGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:12 INFO - Running setup.py (path:/tmp/pip-76n7VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:12 INFO - Running setup.py (path:/tmp/pip-tYX_g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:12 INFO - Running setup.py (path:/tmp/pip-CaMFqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:12 INFO - Running setup.py (path:/tmp/pip-dhhriI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:12 INFO - Running setup.py (path:/tmp/pip-OexB63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:20:12 INFO - Running setup.py install for manifestparser 17:20:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:20:12 INFO - Running setup.py install for mozcrash 17:20:12 INFO - Running setup.py install for mozdebug 17:20:13 INFO - Running setup.py install for mozdevice 17:20:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:20:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:20:13 INFO - Running setup.py install for mozfile 17:20:13 INFO - Running setup.py install for mozhttpd 17:20:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:20:13 INFO - Running setup.py install for mozinfo 17:20:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:20:13 INFO - Running setup.py install for mozInstall 17:20:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:20:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:20:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:20:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:20:13 INFO - Running setup.py install for mozleak 17:20:13 INFO - Running setup.py install for mozlog 17:20:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:20:13 INFO - Running setup.py install for moznetwork 17:20:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:20:13 INFO - Running setup.py install for mozprocess 17:20:13 INFO - Running setup.py install for mozprofile 17:20:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:20:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:20:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:20:14 INFO - Running setup.py install for mozrunner 17:20:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:20:14 INFO - Running setup.py install for mozscreenshot 17:20:14 INFO - Running setup.py install for moztest 17:20:14 INFO - Running setup.py install for mozversion 17:20:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:20:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:20:14 INFO - Cleaning up... 17:20:14 INFO - Return code: 0 17:20:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:14 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 0x7f9228854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14271c0>, '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 0x14280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1428550>, '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': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:20:14 INFO - Using env: {'DISPLAY': ':0', 17:20:14 INFO - 'HOME': '/home/cltbld', 17:20:14 INFO - 'LANG': 'en_US.UTF-8', 17:20:14 INFO - 'LANGUAGE': 'en_US:en', 17:20:14 INFO - 'LOGNAME': 'cltbld', 17:20:14 INFO - 'MAIL': '/var/mail/cltbld', 17:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:14 INFO - 'MOZ_NO_REMOTE': '1', 17:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:14 INFO - 'NO_EM_RESTART': '1', 17:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:14 INFO - 'PWD': '/builds/slave/test', 17:20:14 INFO - 'SHELL': '/bin/bash', 17:20:14 INFO - 'SHLVL': '1', 17:20:14 INFO - 'TERM': 'linux', 17:20:14 INFO - 'TMOUT': '86400', 17:20:14 INFO - 'USER': 'cltbld', 17:20:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 17:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:14 INFO - '_': '/tools/buildbot/bin/python'} 17:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:14 INFO - Running setup.py (path:/tmp/pip-mfMnHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:14 INFO - Running setup.py (path:/tmp/pip-IXyGNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:14 INFO - Running setup.py (path:/tmp/pip-Z3fvjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:14 INFO - Running setup.py (path:/tmp/pip-DcYvqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:15 INFO - Running setup.py (path:/tmp/pip-y8mPHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:15 INFO - Running setup.py (path:/tmp/pip-lAlTRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:15 INFO - Running setup.py (path:/tmp/pip-ylP1jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:15 INFO - Running setup.py (path:/tmp/pip-wIrD7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:15 INFO - Running setup.py (path:/tmp/pip-7pXGlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:15 INFO - Running setup.py (path:/tmp/pip-TA5Wtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:15 INFO - Running setup.py (path:/tmp/pip-fvC0zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:15 INFO - Running setup.py (path:/tmp/pip-V1GggM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:15 INFO - Running setup.py (path:/tmp/pip-IR9JtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:15 INFO - Running setup.py (path:/tmp/pip-MpbBJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:15 INFO - Running setup.py (path:/tmp/pip-fCoVuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:15 INFO - Running setup.py (path:/tmp/pip-c10nIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:15 INFO - Running setup.py (path:/tmp/pip-40kn4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:20:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:17 INFO - Downloading blessings-1.6.tar.gz 17:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:20:17 INFO - Installing collected packages: blessings 17:20:17 INFO - Running setup.py install for blessings 17:20:18 INFO - Successfully installed blessings 17:20:18 INFO - Cleaning up... 17:20:18 INFO - Return code: 0 17:20:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:20:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:18 INFO - Reading from file tmpfile_stdout 17:20:18 INFO - Current package versions: 17:20:18 INFO - argparse == 1.2.1 17:20:18 INFO - blessings == 1.6 17:20:18 INFO - blobuploader == 1.2.4 17:20:18 INFO - docopt == 0.6.1 17:20:18 INFO - functools32 == 3.2.3-2 17:20:18 INFO - jsonschema == 2.5.1 17:20:18 INFO - manifestparser == 1.1 17:20:18 INFO - mozInstall == 1.12 17:20:18 INFO - mozcrash == 0.17 17:20:18 INFO - mozdebug == 0.1 17:20:18 INFO - mozdevice == 0.48 17:20:18 INFO - mozfile == 1.2 17:20:18 INFO - mozhttpd == 0.7 17:20:18 INFO - mozinfo == 0.9 17:20:18 INFO - mozleak == 0.1 17:20:18 INFO - mozlog == 3.2 17:20:18 INFO - moznetwork == 0.27 17:20:18 INFO - mozprocess == 0.22 17:20:18 INFO - mozprofile == 0.28 17:20:18 INFO - mozrunner == 6.11 17:20:18 INFO - mozscreenshot == 0.1 17:20:18 INFO - mozsystemmonitor == 0.3 17:20:18 INFO - moztest == 0.7 17:20:18 INFO - mozversion == 1.4 17:20:18 INFO - psutil == 3.1.1 17:20:18 INFO - requests == 1.2.3 17:20:18 INFO - wsgiref == 0.1.2 17:20:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:18 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 0x7f9228854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14271c0>, '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 0x14280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1428550>, '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': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:20:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:20:18 INFO - Using env: {'DISPLAY': ':0', 17:20:18 INFO - 'HOME': '/home/cltbld', 17:20:18 INFO - 'LANG': 'en_US.UTF-8', 17:20:18 INFO - 'LANGUAGE': 'en_US:en', 17:20:18 INFO - 'LOGNAME': 'cltbld', 17:20:18 INFO - 'MAIL': '/var/mail/cltbld', 17:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:18 INFO - 'MOZ_NO_REMOTE': '1', 17:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:18 INFO - 'NO_EM_RESTART': '1', 17:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:18 INFO - 'PWD': '/builds/slave/test', 17:20:18 INFO - 'SHELL': '/bin/bash', 17:20:18 INFO - 'SHLVL': '1', 17:20:18 INFO - 'TERM': 'linux', 17:20:18 INFO - 'TMOUT': '86400', 17:20:18 INFO - 'USER': 'cltbld', 17:20:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 17:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:18 INFO - '_': '/tools/buildbot/bin/python'} 17:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:20:18 INFO - Cleaning up... 17:20:18 INFO - Return code: 0 17:20:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:18 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 0x7f9228854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14271c0>, '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 0x14280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1428550>, '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': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:20:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:20:18 INFO - Using env: {'DISPLAY': ':0', 17:20:18 INFO - 'HOME': '/home/cltbld', 17:20:18 INFO - 'LANG': 'en_US.UTF-8', 17:20:18 INFO - 'LANGUAGE': 'en_US:en', 17:20:18 INFO - 'LOGNAME': 'cltbld', 17:20:18 INFO - 'MAIL': '/var/mail/cltbld', 17:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:18 INFO - 'MOZ_NO_REMOTE': '1', 17:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:18 INFO - 'NO_EM_RESTART': '1', 17:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:18 INFO - 'PWD': '/builds/slave/test', 17:20:18 INFO - 'SHELL': '/bin/bash', 17:20:18 INFO - 'SHLVL': '1', 17:20:18 INFO - 'TERM': 'linux', 17:20:18 INFO - 'TMOUT': '86400', 17:20:18 INFO - 'USER': 'cltbld', 17:20:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 17:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:18 INFO - '_': '/tools/buildbot/bin/python'} 17:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:20:18 INFO - Cleaning up... 17:20:18 INFO - Return code: 0 17:20:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:18 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 0x7f9228854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14271c0>, '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 0x14280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1428550>, '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': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:20:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:20:18 INFO - Using env: {'DISPLAY': ':0', 17:20:18 INFO - 'HOME': '/home/cltbld', 17:20:18 INFO - 'LANG': 'en_US.UTF-8', 17:20:18 INFO - 'LANGUAGE': 'en_US:en', 17:20:18 INFO - 'LOGNAME': 'cltbld', 17:20:18 INFO - 'MAIL': '/var/mail/cltbld', 17:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:18 INFO - 'MOZ_NO_REMOTE': '1', 17:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:18 INFO - 'NO_EM_RESTART': '1', 17:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:18 INFO - 'PWD': '/builds/slave/test', 17:20:18 INFO - 'SHELL': '/bin/bash', 17:20:18 INFO - 'SHLVL': '1', 17:20:18 INFO - 'TERM': 'linux', 17:20:18 INFO - 'TMOUT': '86400', 17:20:18 INFO - 'USER': 'cltbld', 17:20:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 17:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:18 INFO - '_': '/tools/buildbot/bin/python'} 17:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:18 INFO - Downloading/unpacking flake8 17:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:20:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:20:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:20:21 INFO - no previously-included directories found matching 'docs/_build' 17:20:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:20:21 INFO - Running setup.py install for pep8 17:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:20:21 INFO - no previously-included directories found matching 'docs/_build' 17:20:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:20:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:20:21 INFO - Cleaning up... 17:20:21 INFO - Return code: 0 17:20:21 INFO - Running post-action listener: _resource_record_post_action 17:20:21 INFO - Running post-action listener: _start_resource_monitoring 17:20:21 INFO - Starting resource monitoring. 17:20:21 INFO - ##### 17:20:21 INFO - ##### Finished create-virtualenv step (success) 17:20:21 INFO - ##### 17:20:21 INFO - ##### 17:20:21 INFO - ##### Running install step. 17:20:21 INFO - ##### 17:20:21 INFO - Running pre-action listener: _resource_record_pre_action 17:20:21 INFO - Running main action method: install 17:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:22 INFO - Reading from file tmpfile_stdout 17:20:22 INFO - Detecting whether we're running mozinstall >=1.0... 17:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:20:22 INFO - Reading from file tmpfile_stdout 17:20:22 INFO - Output received: 17:20:22 INFO - Usage: mozinstall [options] installer 17:20:22 INFO - Options: 17:20:22 INFO - -h, --help show this help message and exit 17:20:22 INFO - -d DEST, --destination=DEST 17:20:22 INFO - Directory to install application into. [default: 17:20:22 INFO - "/builds/slave/test"] 17:20:22 INFO - --app=APP Application being installed. [default: firefox] 17:20:22 INFO - mkdir: /builds/slave/test/build/application 17:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:20:39 INFO - Reading from file tmpfile_stdout 17:20:39 INFO - Output received: 17:20:39 INFO - /builds/slave/test/build/application/firefox/firefox 17:20:39 INFO - Running post-action listener: _resource_record_post_action 17:20:39 INFO - ##### 17:20:39 INFO - ##### Finished install step (success) 17:20:39 INFO - ##### 17:20:39 INFO - ##### 17:20:39 INFO - ##### Running run-tests step. 17:20:39 INFO - ##### 17:20:39 INFO - Running pre-action listener: _resource_record_pre_action 17:20:39 INFO - Running main action method: run_tests 17:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:20:39 INFO - Python 2.7.3 17:20:39 INFO - Return code: 0 17:20:39 INFO - grabbing minidump binary from tooltool 17:20: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')]} 17:20:39 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 0x14271c0>, '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 0x14280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1428550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:20:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:20:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:20:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:20:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:20:39 INFO - Return code: 0 17:20:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:20:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:20:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:20:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:20:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:20:40 INFO - Return code: 0 17:20:40 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/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:20:40 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/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:20:40 INFO - Using env: {'DISPLAY': ':0', 17:20:40 INFO - 'HOME': '/home/cltbld', 17:20:40 INFO - 'LANG': 'en_US.UTF-8', 17:20:40 INFO - 'LANGUAGE': 'en_US:en', 17:20:40 INFO - 'LOGNAME': 'cltbld', 17:20:40 INFO - 'MAIL': '/var/mail/cltbld', 17:20:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:20:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:40 INFO - 'MOZ_NO_REMOTE': '1', 17:20:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:40 INFO - 'NO_EM_RESTART': '1', 17:20:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:40 INFO - 'PWD': '/builds/slave/test', 17:20:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:20:40 INFO - 'SHELL': '/bin/bash', 17:20:40 INFO - 'SHLVL': '1', 17:20:40 INFO - 'TERM': 'linux', 17:20:40 INFO - 'TMOUT': '86400', 17:20:40 INFO - 'USER': 'cltbld', 17:20:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569', 17:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:40 INFO - '_': '/tools/buildbot/bin/python'} 17:20:40 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/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:20:40 INFO - mozversion application_buildid: 20160622143004 17:20:40 INFO - mozversion application_changeset: 882dd3714959ace05ad400f14a1c7839f4482006 17:20:40 INFO - mozversion application_display_name: Nightly 17:20:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:20:40 INFO - mozversion application_name: Firefox 17:20:40 INFO - mozversion application_remotingname: firefox 17:20:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:20:40 INFO - mozversion application_vendor: Mozilla 17:20:40 INFO - mozversion application_version: 50.0a1 17:20:40 INFO - mozversion platform_buildid: 20160622143004 17:20:40 INFO - mozversion platform_changeset: 882dd3714959ace05ad400f14a1c7839f4482006 17:20:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:20:40 INFO - mozversion platform_version: 50.0a1 17:20:40 INFO - using testdate: 1466641240 17:20:40 INFO - actual date: 1466641240 17:20:40 INFO - starting webserver on 'localhost:47657' 17:20:40 INFO - SUITE-START | Running 2 tests 17:20:40 INFO - TEST-START | dromaeo_css 17:20:40 INFO - operating with platform_type : linux_ 17:20:40 INFO - Initialising browser for dromaeo_css test... 17:20:40 INFO - TEST-INFO | started process 22845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKWFVo1/profile http://localhost:47657/getInfo.html) 17:20:44 INFO - PROCESS | 22845 | __metrics Screen width/height:1600/1200 17:20:44 INFO - PROCESS | 22845 | colorDepth:24 17:20:44 INFO - PROCESS | 22845 | Browser inner width/height: 1024/697 17:20:44 INFO - PROCESS | 22845 | __metrics 17:20:45 INFO - PROCESS | 22845 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:20:46 INFO - TEST-INFO | 22845: exit 0 17:20:46 INFO - Browser initialized. 17:20:46 INFO - Running cycle 1/1 for dromaeo_css test... 17:20:46 INFO - TEST-INFO | started process 22925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKWFVo1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:20:58 INFO - PROCESS | 22925 | RSS: Main: 173572096 17:20:58 INFO - PROCESS | 22925 | 17:21:49 INFO - PROCESS | 22925 | 1466641309109 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:23:57 INFO - PROCESS | 22925 | Cycle 1(1): loaded http://localhost:47657/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47657/tests/dromaeo/cssquery-ext.html) 17:23:59 INFO - PROCESS | 22925 | RSS: Main: 310546432 17:23:59 INFO - PROCESS | 22925 | 17:27:01 INFO - PROCESS | 22925 | Cycle 1(1): loaded http://localhost:47657/tests/dromaeo/cssquery-ext.html (next: http://localhost:47657/tests/dromaeo/cssquery-jquery.html) 17:27:02 INFO - PROCESS | 22925 | RSS: Main: 265629696 17:27:02 INFO - PROCESS | 22925 | 17:30:04 INFO - PROCESS | 22925 | Cycle 1(1): loaded http://localhost:47657/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47657/tests/dromaeo/cssquery-mootools.html) 17:30:05 INFO - PROCESS | 22925 | RSS: Main: 255565824 17:30:05 INFO - PROCESS | 22925 | 17:33:07 INFO - PROCESS | 22925 | Cycle 1(1): loaded http://localhost:47657/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47657/tests/dromaeo/cssquery-prototype.html) 17:33:07 INFO - PROCESS | 22925 | RSS: Main: 256999424 17:33:07 INFO - PROCESS | 22925 | 17:36:10 INFO - PROCESS | 22925 | Cycle 1(1): loaded http://localhost:47657/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47657/tests/dromaeo/cssquery-yui.html) 17:36:11 INFO - PROCESS | 22925 | RSS: Main: 224305152 17:36:11 INFO - PROCESS | 22925 | 17:39:14 INFO - PROCESS | 22925 | Cycle 1(1): loaded http://localhost:47657/tests/dromaeo/cssquery-yui.html (next: http://localhost:47657/tests/dromaeo/cssquery-dojo.html) 17:39:14 INFO - PROCESS | 22925 | RSS: Main: 314040320 17:39:14 INFO - PROCESS | 22925 | 17:39:14 INFO - PROCESS | 22925 | __start_tp_report 17:39:14 INFO - PROCESS | 22925 | _x_x_mozilla_page_load 17:39:14 INFO - PROCESS | 22925 | _x_x_mozilla_page_load_details 17:39:14 INFO - PROCESS | 22925 | |i|pagename|runs| 17:39:14 INFO - PROCESS | 22925 | |0;dojo.html;3114.4394009078364;3119.563261143439;3147.748180145589;3164.7626428017907;3191.1543440988144;5264.605154613405;5269.973650131754;5352.090144675405;5353.571714262859;5392.676439413638;5309.123994540906;5314.76083576239;5389.865253368668;5415.83752487425;5454.236406903036;4789.497102804207;4865.902681946359;4874.268859671042;4886.169351210285;5065.037642847866;4946.604271658259;4954.009198160365;5005.924911126336;5017.347744793172;5024.598032157419;4789.161896668086;4835.178019736653;4849.660523763338;4912.6806757561;4932.087563800708;4863.124637565237;4878.585320247783;4880.755962201912;4951;4985.476524964863;4849.854504364875;4877.658563900528;4885.682430641997;4885.926711099336;4887.682300650446;5202.141646628302;5284.788608455658;5333;5405.540529055035;5432.728363581805;5714.371419143891;5753.597248192628;5762.538996880239;5767.971160144214;5772.8845423091725;5791.88416231673;5823.9708801456145;5830.533557315404;5834.620749651259;5842.123681447774;5249.816256431007;5270.209468579667;5305.230741542455;5316.41519432866;5407.729613519347;5874.823755287348;5878.911816322759;5882.617629854131;5885.529157667376;5889.1755154278435;5634.1830434586755;5678.233438485751;5690.317161940594;5694.5159661428415;5696.943030569724;5546.362168350611;5629.380768115504;5667.574931880125;5696.8860622787315;5728.742206600713;5705.001624715658;5708.372079071299;5713.114467257582;5713.285839270091;5713.542916566665;5534.916976245359;5714;5717.714114294268;5721.056025755787;5726.055200891889;4297.205017071852;4310.116426132635;4316;4336.414584031116;4383.824647014148;3894.4353068804867;3904.39481880309;3913.4521167036637;3940.3498422760495;3952.66402355803;5302.761375738101;5409.810656626999;5442.863928401822;5456.154296084113;5460.126379779216;5678.375378708339;5727.968965586235;5729.627574207663;5734.340550836707;5770.913436298459;5456.536194423439;5460.918086228709;5464.207689884945;5467.371252305956;5475.06923822951;4821.132196204717;4940.086084074386;4956.801727930842;4966.950330496721;5018.4730603286125;5975.521958243417;6037.335893051761;6043.607165534227;6048.485878700271;6104.053871649901;5822.5633077518505;5836.970815145897;5839.065749480063;5839.445252700986;5849.268841394825;5682.403347648603;5887.234659494409;5914.172015917689;6027.939720602913;6039.365866584121;5688.601797874275;5693.5445164387575;5699.088145896802;5702.657840529581;5738.196652468574;5725.713714314351;5744.712764361681;5786.623869448473;5801.796937107181;5803.071508558611;5470.781168753205;5612.550995920398;5665.433456654301;5669.829905102853;5670.206171135962;5642.040853055072;5684.204211410323;5707.143928410772;5752.165935939349;5757.395473475225;5559.499645031967;5599.748011339418;5608.270924779753;5608.551315894801;5608.775648973995;5441.156620723794;5609.074502707008;5651.773929042793;5726.885462290647;5768.53851691872;5574.247476590771;5589.245451863946;5589.552835773047;5625;5639.069553523786 17:39:14 INFO - PROCESS | 22925 | |1;ext.html;582.5805420097531;624.2758400255702;628.8082134948842;641.108858686426;646.4634353486607;32008.35983280333;32417.837910810413;32698.346033079324;32709;32726.67273327269;42091;42811;42861.571384286144;42906.57093429065;43854.78072609632;8549.65801367946;8826.911730882674;8851.867221991675;8852.380333376666;8860;8035.517868927883;8792.69225577105;8885.511296878669;8885.733427997171;10279.434631095286;10376.273660843744;10683;10694.304870183452;10709.946450267777;10715.035646791786;10674.519646615881;10745.892541074645;10754.408507532082;10754.892451075468;10758.354498730101;10460.163186945103;10526.578911846878;10528.526216320284;10531.315464494859;10531.684049478528;41601.791991040154;41828;41908.37137442941;41921.580784192076;41929.37105943413;3707.7219208559195;3828.636279553438;3988.4615576897327;4025.6376926076796;4319.719218250835;31780.523292150636;31998.680013199802;32659.6734032659;32662;33185.004449866545;4067.8983025424304;4080.8571699990357;4125.91748165038;4225.661947044229;4261.019965407942;336731;338427.99999999756;338480;341018;341456;56566.7171664139;56778;57002.714986424806;57546.424535754944;57687.71156144192;59239.111413328836;59271.70364148238;59328.70335648294;59527;59560;16651;16794.580135496464;16817.83182168187;16821.243044063045;16821.915890420714;13447.596572102853;13498.93250533741;13501.527446539323;13526.32368381577;13528.93235533816;14656.340464679115;15992.840071599368;16066.75899861503;16091.758623620655;16129.83870161307;6522.934770652328;6563;6576.145101136822;6583.670816459158;6758.972308307488;902.444996327254;959.7456673981401;985.6156099121348;1006.3911333643186;1100.9889901101046;31547.36905261882;31933.20166995844;32112.83943580267;32266;32498.512522312183;1087.8640169978753;1117.6255954255416;1128.4527004402858;1145.3929417408788;1161.5760247509768;16744.581385465463;16810.83189168117;16966.745498817527;17110.401135960183;17131.737151197267;499506;502247;503676;503879;504173;57317;57321.14018289729;57384;57427.42572574304;57603;1244.5581818454318;1336.8663133686553;1360.4286199796109;1375.3467103125936;1387.6461502316845;31621.683783162793;32796.60466209066;32887.671123289416;33043.173920652174;33701;49073;49340.25989610087;49688;49803;49829;390873;393741;394171.2040078698;394750;394978;35255.82372088226;39783.403248951865;40738;41551.376729349686;44046.3393049111;42317.36523952082;42755.358669620604;47898;48800.267995979375;48833.75583122062;39581.80209098936;40385.1922961545;41215.79392103021;41408;41906.790466047474;40132.79933600313;40339.193216134925;40737.79631101825;40738.1852362957;41387.379189311585;39954;40216.19567608573;40536.1892762149;40580.18839623132;41342.37986430146;34936.650633494355;36453.17250660441;37040.62959370372;37051.81474092612;37580.81209593934;27823.30441738973;27932.184408014225;28053;28080.786047849073;28291.26475480651 17:39:14 INFO - PROCESS | 22925 | |2;jquery.html;385.7396257526169;386.90813147000483;392.6760422651312;395.1504265828468;411.5925234018323;14125.505607303747;15871.603209919758;18487.168077436512;19191.328303509363;19217;14275.2862356882;14415.279236038208;17786.199621017055;17858.285668573273;18330.450086497392;5248.6063545234165;5650.237217975562;5690.2887139107615;5691.117876729114;5692.629979051369;4033.3949907513816;5456.454354564532;5566.192902029204;5566.638168519034;5567.777288908439;5903.49820265278;6206.596571222879;6207.224096987877;6312.652804095773;6316.021016742412;6030.758769649231;6188.566800323979;6199.814005579839;6239.095331176976;6260.467860231885;5417.349918009864;5466.070767969455;5470.6444081135;5487.204355368449;5497.422770609109;21321.80172974051;21757.67363489549;22152.889235553717;22163.667544986838;22312;2520.3699075231193;2536.581464058428;2596.0913680211775;2885.3940672458807;3118.9064328069967;13459.596212113653;13702.93148534261;13855.445782168701;14042;14530.491432799801;1904.5714714189335;1922.7884932657396;2001.1395100106947;2004.9097790599458;2064.741907261592;75193.62403188004;77204.22795772027;77646;78296.8255476174;79591.20408795896;10088.899111008795;10101.797964040677;10127.493625318704;10293.639722609672;10506.527206275736;14323.641908952359;14350.928245358706;14353.92823035878;14370.640733981734;14386.48236558619;7122.6438678066925;7693.422993275527;7766.262205090507;7883.132855385903;8026.518408895368;7936.801579960547;8018.398620103516;8269.793255168548;8363.916360836314;8550.828983420297;6234.407731265523;6436.549441539141;6460.804751121058;6499.902501462482;6509.707063182168;1867.617138486634;1871.373090014833;1911.3214808742973;1920.8474915050858;1931.51712071982;943.8867335919596;1014.3356101753363;1045.6862941117633;1056;1077.5851297250615;18161.82607869884;18894.716579251322;18952.526186845163;19180.328688495836;19422.90288548548;1004.3923426327113;1010.3483253301579;1011.6863772230632;1052.000599430544;1136.943152842371;9838.75403114928;10846.837297440545;10895.291806032583;10898.128149748001;10919.836202456969;336680;346900;448735;449410;450798;62830.68584657047;77489.61255193688;97491.51254243826;99354.5032274834;100722.49638751906;1010.3937637417491;1023.242800327767;1051.1748277602046;1058.9364638121583;1063.5161001744343;16708.665826683642;16719.665606687555;17010.65978680444;17012.659746804748;17351.652966940845;41370.37944430776;43001.56998429976;43017.78491107524;43370.78314608407;43467.78266108776;59718.70140649269;61195.694021529605;62077;62886.6855665737;63390.68304658447;8403.369747268856;8596.527191004554;8646.740597782076;8718.346124040849;8856.822863542822;9059.501727405055;11020.614278500214;12130.878691212974;12283.385830708608;12473.688157796129;10766.946165269124;10884.12926965825;10926.235163538477;11148;11161.823444428259;10785.568577256821;10984.670459886216;11050.557977680803;11093;11170;11025.44872756375;11088.057515111306;11125.499352528994;11254.324740515267;11409.372484513431;8493.957530212308;8538.829223415622;8731.170538798804;8734.69428569997;9000.549972501218;10140.594376225163;10787;10900.34597924127;11063.114950803756;11090.5563777448 17:39:14 INFO - PROCESS | 22925 | |3;mootools.html;1309.882110610045;1434.311530465377;1475.3877140986492;1599.808023037235;1761.5419990802395;8045.91954080459;8431.915680843189;8448.788780280496;8717.607707653155;8729.432586881849;8549.87175192371;8560.143985601437;8643.438176518523;8645.265152462049;8650.178233067863;1991.9004049797452;2229.6209644360497;2302.9424264393397;2338.169949667869;2339.076064954342;2276;2307.3770082077913;2313.375388645065;2314.4329639238326;2315.7915787579113;2277.294038847954;2282.7717228277206;2294.724633044037;2320.872352020638;2325.511642555057;1958.3831093205665;2158.0396723458066;2230.8215342772537;2239.742429620598;2247.943466570709;2255.1881322723807;2272.6477396003647;2274.8748818814956;2278.28234106256;2278.3392816083315;8229.300509456703;8283.710070147516;8288;8296.211859873303;8302.792430189294;4918.581920536759;5059.848204553869;5063.468335824759;5073.492650734934;5080.898382032338;3172.1435212492497;3275.8689652414114;3390.7795993260606;3438.914027149316;3442.862285508577;1150.7410832562691;1173.266708307308;1176.159046281904;1189.756099999498;1193.5524178433088;11327.150463715254;11585.768284634345;11593.420328983517;11597.420128993517;11598.362090085042;4418.558144185556;4482.081173359454;4535.795889184995;4554.180247555471;4573.63410927125;9824.950875245579;9876.950615246878;9891.159251463563;9892.901070989343;9899.356541824758;5037.571806396498;5093.668911520739;5094.77073531692;5095.566876815512;5097.108006098918;4117.07365842683;4447.355133505624;4636.072785442925;4636.35091087248;4640.071985602893;3992.1416895367634;4009.959900401017;4075.551689314173;4116.567760385176;4144.606262405066;1233.5189276182296;1285.1108869961142;1297.267044120088;1306.3664122900386;1310.3382791690326;868.2099289646392;922.31748506105;950.3632566180676;957.5308099031564;987.6444479987199;5708.600397972102;5787.71061446926;5796.3913789052385;5858.589898707135;6077.301110372276;435.5861931165405;447.92385294500014;454.9567791059844;456.2973021546847;462.9236176030917;3758.2483503298904;3802.448644946467;3817.3319669057805;3832.3485007548784;3900.8244628991197;10104.242181836245;10413.114885234689;10479.580816767244;10545.84181237282;10580.259381843198;10401.53193106312;10412.947935260276;10443.843342349719;10451.94774026125;10453.895461045444;7826.5978847571105;7897.960510197528;7958.363330933512;7986.560739159402;8013.398995075393;5832.679202643895;5871.588988770916;5873.73568189424;5895.41045895407;5942.108683697307;9582.137607615348;9653.46905920181;9754.853677194706;9802.166815820736;9816.411015339103;9709.320347575602;9893.604255829974;9973.052560006789;9996.850047249152;9998.150157236425;6647.468202543688;7325.340719335285;7497.325240728361;7507.136679281953;7718.3053525183;8266.586670666322;8289.502629842229;8317.875231871647;8349.03986041613;8445.155484451505;7068.752593659197;7308.159561650478;7468.626568671653;7582.203868593719;7586.24137586237;7138.892916606359;7296.525725827804;7300.525465844916;7383.852322953619;7469.813254668677;6737.32626737342;6748.898766518408;6797.592144471149;6798.048273241849;6802.897956530557;4815.537071675808;4895.143349913679;5010.599152067753;5031.4213865405945;5060.772265247999;4910.43529994041;4913.7543122843;4954.950450495449;5013.315213318281;5130.692158470503 17:39:14 INFO - PROCESS | 22925 | |4;prototype.html;309.2978937811169;314.3885143396094;317.78390694327845;333.0624292616283;335.68613346521005;5126.205438157082;5279.445658205891;5306.734663266836;5381.246625472432;5411.377691565466;5286.444923283048;5329.973350133244;5339.893202135955;5349.5720342372615;5349.598780091489;4170.728902621335;4199.6220340169375;4208.242516347056;4224.450821393215;4230.111676547928;3929.25344184604;3959.4258832469272;4151.792410379484;4169.728967617095;4175.457190565222;4123.381492776092;4157.711109556032;4177;4179.143275628504;4192.287311157111;4145.896352591194;4156.2934301168725;4169.91660166798;4187.664986801079;4188.748675079474;3462.8441720122655;3728.4966529518438;3736.4395340698843;3742.8315725792404;3756.69946404287;5119.616028797818;5131.743412829381;5167;5173.301604283449;5178.446466060167;4641.489436162019;4667.883302917454;4706.223473126965;4728.574428301469;4734.621230301567;5326.280952071459;5511.53151982082;5517.227588137664;5529.778808847641;5536.944630553683;3975.8608448704445;3985.6612187964056;4004.2391945530258;4005.439238506611;4006.278869803434;5747.913781293242;5800.419958004208;5802.854928626776;5807.564432667525;5828.795992140297;3919.5884432134785;4066.1664358806374;4111.280525908014;4120.011197312683;4121.155163191538;4091.8158682859344;4097.610726980932;4099.0162361033135;4099.528554216304;4121.670266378683;4714.929276060861;4717.268823332389;4729.9054018920115;4735.242361222188;4756.096341695067;5497.616135393477;5543.530964294465;5576.888462230732;5582.218489411485;5611.5129490685;1382.4401117547409;1405.4378248700602;1411.8517555656713;1413;1417.588899219215;894.5661354243186;902.3052249767642;909.2180724576858;917.954102294896;922.4649703172144;4709.221559280041;4787.162246606899;4798.712077275374;4808.422989241313;4897.975510122426;5017.422996355393;5078.5937125029905;5132.30713853625;5152.9742351288005;5200.427952925175;4812.00301874725;4916.827911023097;4934.161192597196;4940.135476291634;5038.722870242172;3017.834019128925;3022.2293315204483;3025.8638361273797;3072.9692703072683;3092.969070309313;5858.5898987070495;5918.171455996164;5966.224390829165;5992.913649470526;6028.728707208186;5584.91622625661;5823.417658234227;5866;5879.52963762898;5881.294244690579;5888.852778680396;5897.321807992136;5914.763409463573;5925.34821169671;5931.703414829241;5622.297212848394;5741.62679425836;5742.827715168552;5757.856053598526;5789.61049348145;5591.804286850103;5656.3495198051105;5674.177244299636;5691.78020571969;5760.539156867357;5900.911486327623;5902.822915312548;5917.431880551571;5923.318818335774;5929.851753706192;3831.4252862069798;3891.5719270879613;3915.393114067324;3938.9364871483967;4092.304308267542;5602.887942241214;5622.8754249149515;5639.941421381249;5650.85872853182;5697.32225853848;5611.971940140274;5613.775448981995;5640.182173584889;5671.971640141773;5674.829755107354;5333.893322133613;5631.324241091095;5656.321241451053;5675.829725108253;5682.829515114553;5550.861228469321;5558.249636299048;5574.498295153456;5583.525400340854;5584.664920104807;5304.840854774363;5608.093248295599;5644.6613203207935;5678.403767604507;5734.677455630476;5512.255845460972;5516.503514683698;5517.200005999028;5519;5523.143912693539 17:39:14 INFO - PROCESS | 22925 | |5;yui.html;754.5095687802927;767.8310771630241;785.1598789295456;805.5087684533836;834.0033659776569;14721.116732996014;15332.310046047913;16012.679746405065;16311.429099981504;16371.672566548661;14063.08589941653;14177.929110354435;14250.358733856976;14250.429982800675;14264;661.8113837556298;791.1732239809385;791.232504470664;807.6607824713634;810.7810891059411;804.6620419423856;809.2918696140877;809.6397103289039;810.0158307656196;810.2586133687669;847.4703310430981;852.7569642651846;853.117023880284;853.2576658307281;853.8889944307263;686.8351595617066;791.5290402210676;809.29591255608;845.6532821543168;845.6575087089708;594.5481434110064;595.577140230437;595.577140230437;596.4989408896504;598.4554055809236;14919.92540037293;14963.625909352244;14978.325975331136;14978.550643480605;14980.250987450692;12777.361131943459;13243.404046817916;13252.469901204036;13490.932545337211;13773.586792396243;10179.491025448699;10804.1896857736;10829.512671929782;10931.512575768142;11053.392063436508;4403.200511442543;4447.933281000787;4468.173387923212;4513.119941611387;4664.55686709762;74825.25174748292;75589;75921.62039189768;76724.61637691775;77843;10423.270371074104;10547.367157970393;10557.524911378852;10666.14670826332;11226.382548959886;20357.898210508854;20438.28466003683;20485.18059277642;20507.794922050885;20550.58898822015;8255.752327430067;8267.29727973117;8328.167183281623;8527.914720852836;8844.425112367675;3351.346487434927;3408.4887266910164;4234.026173980002;4315.266404711207;4699.741514216751;3262.7389808815237;3332.0670212340583;3348.313595712873;3378.8648454061563;3387.6273609903383;536.1528784520449;591.1516973143553;602.7588964414269;603.3242768099757;604.6916072802815;534.3694440560099;556.2546188107955;670.1522573943964;682.737146198717;704.7251571886968;9297.558878373862;9678.17735492491;9719;9812.460314682761;9885.654002109892;609.8383928259015;644.2044075566765;675.2403546010738;681.1655721740926;687.2611942162096;4516.322551617218;4607.35497030416;4654.813807447732;4691.483936766953;4716.174669432836;121391;127342.36328818297;127693;128615;128866;104062;104356.47821760843;104361;104402;105063;90501.54749226212;91598.08401916029;92344.84448199847;93469;95345.52327238319;8828.293736501193;8947.552622368985;9041.864372034293;9130.315226357918;9135.543222838964;50596.49403506065;51588;51671.483285166665;52617.9476410462;54866.725666371414;73646;77730.6113469429;80176.19823801688;80289.19710802817;81555;11775.882241177822;11846.11154163424;12183.695407614881;12460.314682692177;12951.870481295444;13145.079844411182;13358.398872050586;13365.26491043002;13438.46246150143;14450.349734261774;12564.874351256736;12628.116031878048;12912.741745165233;12917.806232906327;13201.57630761876;11358.375289358833;11492.229267686187;12433.067519936221;12499.312537810507;14175;13280.80078798838;13348.26584537821;14007.649808754863;14027.579172624837;14437.494687685881;10938.726531836768;11160.888391115985;11207.43962801873;11705.122115841175;11945.82081268799;10870.402127882726;10959.287646302964;11349.319040857576;11685.707857303296;11899.107566932342 17:39:14 INFO - PROCESS | 22925 | __end_tp_report 17:39:14 INFO - PROCESS | 22925 | __start_cc_report 17:39:14 INFO - PROCESS | 22925 | _x_x_mozilla_cycle_collect,1110 17:39:14 INFO - PROCESS | 22925 | __end_cc_report 17:39:14 INFO - PROCESS | 22925 | __startTimestamp1466642354396__endTimestamp 17:39:14 INFO - PROCESS | 22925 | 17:39:14 INFO - PROCESS | 22925 | ------- Summary: start ------- 17:39:14 INFO - PROCESS | 22925 | Number of tests: 6 17:39:14 INFO - PROCESS | 22925 | 17:39:14 INFO - PROCESS | 22925 | [#0] dojo.html Cycles:165 Average:5346.93 Median:5589.55 stddev:609.97 (10.9%) stddev-sans-first:586.16 17:39:14 INFO - PROCESS | 22925 | Values: 3114.4 3119.6 3147.7 3164.8 3191.2 5264.6 5270.0 5352.1 5353.6 5392.7 5309.1 5314.8 5389.9 5415.8 5454.2 4789.5 4865.9 4874.3 4886.2 5065.0 4946.6 4954.0 5005.9 5017.3 5024.6 4789.2 4835.2 4849.7 4912.7 4932.1 4863.1 4878.6 4880.8 4951.0 4985.5 4849.9 4877.7 4885.7 4885.9 4887.7 5202.1 5284.8 5333.0 5405.5 5432.7 5714.4 5753.6 5762.5 5768.0 5772.9 5791.9 5824.0 5830.5 5834.6 5842.1 5249.8 5270.2 5305.2 5316.4 5407.7 5874.8 5878.9 5882.6 5885.5 5889.2 5634.2 5678.2 5690.3 5694.5 5696.9 5546.4 5629.4 5667.6 5696.9 5728.7 5705.0 5708.4 5713.1 5713.3 5713.5 5534.9 5714.0 5717.7 5721.1 5726.1 4297.2 4310.1 4316.0 4336.4 4383.8 3894.4 3904.4 3913.5 3940.3 3952.7 5302.8 5409.8 5442.9 5456.2 5460.1 5678.4 5728.0 5729.6 5734.3 5770.9 5456.5 5460.9 5464.2 5467.4 5475.1 4821.1 4940.1 4956.8 4967.0 5018.5 5975.5 6037.3 6043.6 6048.5 6104.1 5822.6 5837.0 5839.1 5839.4 5849.3 5682.4 5887.2 5914.2 6027.9 6039.4 5688.6 5693.5 5699.1 5702.7 5738.2 5725.7 5744.7 5786.6 5801.8 5803.1 5470.8 5612.6 5665.4 5669.8 5670.2 5642.0 5684.2 5707.1 5752.2 5757.4 5559.5 5599.7 5608.3 5608.6 5608.8 5441.2 5609.1 5651.8 5726.9 5768.5 5574.2 5589.2 5589.6 5625.0 5639.1 17:39:14 INFO - PROCESS | 22925 | 17:39:14 INFO - PROCESS | 22925 | [#1] ext.html Cycles:180 Average:57730.51 Median:217279.90 stddev:110306.24 (50.8%) stddev-sans-first:110532.22 17:39:14 INFO - PROCESS | 22925 | Values: 582.6 624.3 628.8 641.1 646.5 32008.4 32417.8 32698.3 32709.0 32726.7 42091.0 42811.0 42861.6 42906.6 43854.8 8549.7 8826.9 8851.9 8852.4 8860.0 8035.5 8792.7 8885.5 8885.7 10279.4 10376.3 10683.0 10694.3 10709.9 10715.0 10674.5 10745.9 10754.4 10754.9 10758.4 10460.2 10526.6 10528.5 10531.3 10531.7 41601.8 41828.0 41908.4 41921.6 41929.4 3707.7 3828.6 3988.5 4025.6 4319.7 31780.5 31998.7 32659.7 32662.0 33185.0 4067.9 4080.9 4125.9 4225.7 4261.0 336731.0 338428.0 338480.0 341018.0 341456.0 56566.7 56778.0 57002.7 57546.4 57687.7 59239.1 59271.7 59328.7 59527.0 59560.0 16651.0 16794.6 16817.8 16821.2 16821.9 13447.6 13498.9 13501.5 13526.3 13528.9 14656.3 15992.8 16066.8 16091.8 16129.8 6522.9 6563.0 6576.1 6583.7 6759.0 902.4 959.7 985.6 1006.4 1101.0 31547.4 31933.2 32112.8 32266.0 32498.5 1087.9 1117.6 1128.5 1145.4 1161.6 16744.6 16810.8 16966.7 17110.4 17131.7 499506.0 502247.0 503676.0 503879.0 504173.0 57317.0 57321.1 57384.0 57427.4 57603.0 1244.6 1336.9 1360.4 1375.3 1387.6 31621.7 32796.6 32887.7 33043.2 33701.0 49073.0 49340.3 49688.0 49803.0 49829.0 390873.0 393741.0 394171.2 394750.0 394978.0 35255.8 39783.4 40738.0 41551.4 44046.3 42317.4 42755.4 47898.0 48800.3 48833.8 39581.8 40385.2 41215.8 41408.0 41906.8 40132.8 40339.2 40737.8 40738.2 41387.4 39954.0 40216.2 40536.2 40580.2 41342.4 34936.7 36453.2 37040.6 37051.8 37580.8 27823.3 27932.2 28053.0 28080.8 28291.3 17:39:14 INFO - PROCESS | 22925 | 17:39:14 INFO - PROCESS | 22925 | [#2] jquery.html Cycles:180 Average:26420.50 Median:22158.28 stddev:68083.63 (307.3%) stddev-sans-first:68246.56 17:39:14 INFO - PROCESS | 22925 | Values: 385.7 386.9 392.7 395.2 411.6 14125.5 15871.6 18487.2 19191.3 19217.0 14275.3 14415.3 17786.2 17858.3 18330.5 5248.6 5650.2 5690.3 5691.1 5692.6 4033.4 5456.5 5566.2 5566.6 5567.8 5903.5 6206.6 6207.2 6312.7 6316.0 6030.8 6188.6 6199.8 6239.1 6260.5 5417.3 5466.1 5470.6 5487.2 5497.4 21321.8 21757.7 22152.9 22163.7 22312.0 2520.4 2536.6 2596.1 2885.4 3118.9 13459.6 13702.9 13855.4 14042.0 14530.5 1904.6 1922.8 2001.1 2004.9 2064.7 75193.6 77204.2 77646.0 78296.8 79591.2 10088.9 10101.8 10127.5 10293.6 10506.5 14323.6 14350.9 14353.9 14370.6 14386.5 7122.6 7693.4 7766.3 7883.1 8026.5 7936.8 8018.4 8269.8 8363.9 8550.8 6234.4 6436.5 6460.8 6499.9 6509.7 1867.6 1871.4 1911.3 1920.8 1931.5 943.9 1014.3 1045.7 1056.0 1077.6 18161.8 18894.7 18952.5 19180.3 19422.9 1004.4 1010.3 1011.7 1052.0 1136.9 9838.8 10846.8 10895.3 10898.1 10919.8 336680.0 346900.0 448735.0 449410.0 450798.0 62830.7 77489.6 97491.5 99354.5 100722.5 1010.4 1023.2 1051.2 1058.9 1063.5 16708.7 16719.7 17010.7 17012.7 17351.7 41370.4 43001.6 43017.8 43370.8 43467.8 59718.7 61195.7 62077.0 62886.7 63390.7 8403.4 8596.5 8646.7 8718.3 8856.8 9059.5 11020.6 12130.9 12283.4 12473.7 10766.9 10884.1 10926.2 11148.0 11161.8 10785.6 10984.7 11050.6 11093.0 11170.0 11025.4 11088.1 11125.5 11254.3 11409.4 8494.0 8538.8 8731.2 8734.7 9000.5 10140.6 10787.0 10900.3 11063.1 11090.6 17:39:14 INFO - PROCESS | 22925 | 17:39:14 INFO - PROCESS | 22925 | [#3] mootools.html Cycles:180 Average:5585.47 Median:4982.77 stddev:3161.51 (63.4%) stddev-sans-first:3154.05 17:39:14 INFO - PROCESS | 22925 | Values: 1309.9 1434.3 1475.4 1599.8 1761.5 8045.9 8431.9 8448.8 8717.6 8729.4 8549.9 8560.1 8643.4 8645.3 8650.2 1991.9 2229.6 2302.9 2338.2 2339.1 2276.0 2307.4 2313.4 2314.4 2315.8 2277.3 2282.8 2294.7 2320.9 2325.5 1958.4 2158.0 2230.8 2239.7 2247.9 2255.2 2272.6 2274.9 2278.3 2278.3 8229.3 8283.7 8288.0 8296.2 8302.8 4918.6 5059.8 5063.5 5073.5 5080.9 3172.1 3275.9 3390.8 3438.9 3442.9 1150.7 1173.3 1176.2 1189.8 1193.6 11327.2 11585.8 11593.4 11597.4 11598.4 4418.6 4482.1 4535.8 4554.2 4573.6 9825.0 9877.0 9891.2 9892.9 9899.4 5037.6 5093.7 5094.8 5095.6 5097.1 4117.1 4447.4 4636.1 4636.4 4640.1 3992.1 4010.0 4075.6 4116.6 4144.6 1233.5 1285.1 1297.3 1306.4 1310.3 868.2 922.3 950.4 957.5 987.6 5708.6 5787.7 5796.4 5858.6 6077.3 435.6 447.9 455.0 456.3 462.9 3758.2 3802.4 3817.3 3832.3 3900.8 10104.2 10413.1 10479.6 10545.8 10580.3 10401.5 10412.9 10443.8 10451.9 10453.9 7826.6 7898.0 7958.4 7986.6 8013.4 5832.7 5871.6 5873.7 5895.4 5942.1 9582.1 9653.5 9754.9 9802.2 9816.4 9709.3 9893.6 9973.1 9996.9 9998.2 6647.5 7325.3 7497.3 7507.1 7718.3 8266.6 8289.5 8317.9 8349.0 8445.2 7068.8 7308.2 7468.6 7582.2 7586.2 7138.9 7296.5 7300.5 7383.9 7469.8 6737.3 6748.9 6797.6 6798.0 6802.9 4815.5 4895.1 5010.6 5031.4 5060.8 4910.4 4913.8 4955.0 5013.3 5130.7 17:39:14 INFO - PROCESS | 22925 | 17:39:14 INFO - PROCESS | 22925 | [#4] prototype.html Cycles:180 Average:4654.03 Median:5239.94 stddev:1373.89 (26.2%) stddev-sans-first:1338.48 17:39:14 INFO - PROCESS | 22925 | Values: 309.3 314.4 317.8 333.1 335.7 5126.2 5279.4 5306.7 5381.2 5411.4 5286.4 5330.0 5339.9 5349.6 5349.6 4170.7 4199.6 4208.2 4224.5 4230.1 3929.3 3959.4 4151.8 4169.7 4175.5 4123.4 4157.7 4177.0 4179.1 4192.3 4145.9 4156.3 4169.9 4187.7 4188.7 3462.8 3728.5 3736.4 3742.8 3756.7 5119.6 5131.7 5167.0 5173.3 5178.4 4641.5 4667.9 4706.2 4728.6 4734.6 5326.3 5511.5 5517.2 5529.8 5536.9 3975.9 3985.7 4004.2 4005.4 4006.3 5747.9 5800.4 5802.9 5807.6 5828.8 3919.6 4066.2 4111.3 4120.0 4121.2 4091.8 4097.6 4099.0 4099.5 4121.7 4714.9 4717.3 4729.9 4735.2 4756.1 5497.6 5543.5 5576.9 5582.2 5611.5 1382.4 1405.4 1411.9 1413.0 1417.6 894.6 902.3 909.2 918.0 922.5 4709.2 4787.2 4798.7 4808.4 4898.0 5017.4 5078.6 5132.3 5153.0 5200.4 4812.0 4916.8 4934.2 4940.1 5038.7 3017.8 3022.2 3025.9 3073.0 3093.0 5858.6 5918.2 5966.2 5992.9 6028.7 5584.9 5823.4 5866.0 5879.5 5881.3 5888.9 5897.3 5914.8 5925.3 5931.7 5622.3 5741.6 5742.8 5757.9 5789.6 5591.8 5656.3 5674.2 5691.8 5760.5 5900.9 5902.8 5917.4 5923.3 5929.9 3831.4 3891.6 3915.4 3938.9 4092.3 5602.9 5622.9 5639.9 5650.9 5697.3 5612.0 5613.8 5640.2 5672.0 5674.8 5333.9 5631.3 5656.3 5675.8 5682.8 5550.9 5558.2 5574.5 5583.5 5584.7 5304.8 5608.1 5644.7 5678.4 5734.7 5512.3 5516.5 5517.2 5519.0 5523.1 17:39:14 INFO - PROCESS | 22925 | 17:39:14 INFO - PROCESS | 22925 | [#5] yui.html Cycles:180 Average:21357.03 Median:4458.05 stddev:32069.59 (719.4%) stddev-sans-first:32122.25 17:39:14 INFO - PROCESS | 22925 | Values: 754.5 767.8 785.2 805.5 834.0 14721.1 15332.3 16012.7 16311.4 16371.7 14063.1 14177.9 14250.4 14250.4 14264.0 661.8 791.2 791.2 807.7 810.8 804.7 809.3 809.6 810.0 810.3 847.5 852.8 853.1 853.3 853.9 686.8 791.5 809.3 845.7 845.7 594.5 595.6 595.6 596.5 598.5 14919.9 14963.6 14978.3 14978.6 14980.3 12777.4 13243.4 13252.5 13490.9 13773.6 10179.5 10804.2 10829.5 10931.5 11053.4 4403.2 4447.9 4468.2 4513.1 4664.6 74825.3 75589.0 75921.6 76724.6 77843.0 10423.3 10547.4 10557.5 10666.1 11226.4 20357.9 20438.3 20485.2 20507.8 20550.6 8255.8 8267.3 8328.2 8527.9 8844.4 3351.3 3408.5 4234.0 4315.3 4699.7 3262.7 3332.1 3348.3 3378.9 3387.6 536.2 591.2 602.8 603.3 604.7 534.4 556.3 670.2 682.7 704.7 9297.6 9678.2 9719.0 9812.5 9885.7 609.8 644.2 675.2 681.2 687.3 4516.3 4607.4 4654.8 4691.5 4716.2 121391.0 127342.4 127693.0 128615.0 128866.0 104062.0 104356.5 104361.0 104402.0 105063.0 90501.5 91598.1 92344.8 93469.0 95345.5 8828.3 8947.6 9041.9 9130.3 9135.5 50596.5 51588.0 51671.5 52617.9 54866.7 73646.0 77730.6 80176.2 80289.2 81555.0 11775.9 11846.1 12183.7 12460.3 12951.9 13145.1 13358.4 13365.3 13438.5 14450.3 12564.9 12628.1 12912.7 12917.8 13201.6 11358.4 11492.2 12433.1 12499.3 14175.0 13280.8 13348.3 14007.6 14027.6 14437.5 10938.7 11160.9 11207.4 11705.1 11945.8 10870.4 10959.3 11349.3 11685.7 11899.1 17:39:14 INFO - PROCESS | 22925 | -------- Summary: end -------- 17:39:14 INFO - PROCESS | 22925 | 17:39:15 INFO - TEST-INFO | 22925: exit 0 17:39:15 INFO - TEST-OK | dromaeo_css | took 1114798ms 17:39:15 INFO - TEST-START | kraken 17:39:15 INFO - operating with platform_type : linux_ 17:39:15 INFO - Initialising browser for kraken test... 17:39:15 INFO - TEST-INFO | started process 23106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiWUrjM/profile http://localhost:47657/getInfo.html) 17:39:19 INFO - PROCESS | 23106 | __metrics Screen width/height:1600/1200 17:39:19 INFO - PROCESS | 23106 | colorDepth:24 17:39:19 INFO - PROCESS | 23106 | Browser inner width/height: 1024/697 17:39:19 INFO - PROCESS | 23106 | __metrics 17:39:19 INFO - PROCESS | 23106 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:39:20 INFO - TEST-INFO | 23106: exit 0 17:39:20 INFO - Browser initialized. 17:39:20 INFO - Running cycle 1/1 for kraken test... 17:39:20 INFO - TEST-INFO | started process 23188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiWUrjM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:32 INFO - PROCESS | 23188 | RSS: Main: 174215168 17:39:32 INFO - PROCESS | 23188 | 17:39:35 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47657/tests/kraken/driver.html?testName=audio-beat-detection) 17:39:36 INFO - PROCESS | 23188 | RSS: Main: 232759296 17:39:36 INFO - PROCESS | 23188 | 17:39:38 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47657/tests/kraken/driver.html?testName=audio-dft) 17:39:39 INFO - PROCESS | 23188 | RSS: Main: 224276480 17:39:39 INFO - PROCESS | 23188 | 17:39:42 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47657/tests/kraken/driver.html?testName=audio-fft) 17:39:43 INFO - PROCESS | 23188 | RSS: Main: 287117312 17:39:43 INFO - PROCESS | 23188 | 17:39:45 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47657/tests/kraken/driver.html?testName=audio-oscillator) 17:39:45 INFO - PROCESS | 23188 | RSS: Main: 198057984 17:39:45 INFO - PROCESS | 23188 | 17:39:48 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47657/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:39:48 INFO - PROCESS | 23188 | RSS: Main: 201498624 17:39:48 INFO - PROCESS | 23188 | 17:39:51 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47657/tests/kraken/driver.html?testName=imaging-darkroom) 17:39:52 INFO - PROCESS | 23188 | RSS: Main: 237543424 17:39:52 INFO - PROCESS | 23188 | 17:39:55 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47657/tests/kraken/driver.html?testName=imaging-desaturate) 17:39:56 INFO - PROCESS | 23188 | RSS: Main: 239624192 17:39:56 INFO - PROCESS | 23188 | 17:39:59 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47657/tests/kraken/driver.html?testName=json-parse-financial) 17:39:59 INFO - PROCESS | 23188 | RSS: Main: 239173632 17:39:59 INFO - PROCESS | 23188 | 17:40:01 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47657/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:40:02 INFO - PROCESS | 23188 | RSS: Main: 225091584 17:40:02 INFO - PROCESS | 23188 | 17:40:03 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47657/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:40:04 INFO - PROCESS | 23188 | RSS: Main: 230481920 17:40:04 INFO - PROCESS | 23188 | 17:40:06 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47657/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:40:07 INFO - PROCESS | 23188 | RSS: Main: 236597248 17:40:07 INFO - PROCESS | 23188 | 17:40:09 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:40:10 INFO - PROCESS | 23188 | RSS: Main: 237182976 17:40:10 INFO - PROCESS | 23188 | 17:40:12 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:40:13 INFO - PROCESS | 23188 | RSS: Main: 234987520 17:40:13 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | Cycle 1(1): loaded http://localhost:47657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47657/tests/kraken/driver.html?testName=ai-astar) 17:40:15 INFO - PROCESS | 23188 | RSS: Main: 277786624 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | __start_tp_report 17:40:15 INFO - PROCESS | 23188 | _x_x_mozilla_page_load 17:40:15 INFO - PROCESS | 23188 | _x_x_mozilla_page_load_details 17:40:15 INFO - PROCESS | 23188 | |i|pagename|runs| 17:40:15 INFO - PROCESS | 23188 | |0;ai-astar;101;112;109;111;111;110;109;112;110;112 17:40:15 INFO - PROCESS | 23188 | |1;audio-beat-detection;160;128;133;183;133;132;158;131;176;125 17:40:15 INFO - PROCESS | 23188 | |2;audio-dft;160;161;161;161;167;161;161;161;162;161 17:40:15 INFO - PROCESS | 23188 | |3;audio-fft;74;75;77;126;78;75;74;74;104;74 17:40:15 INFO - PROCESS | 23188 | |4;audio-oscillator;85;85;124;85;85;85;117;85;85;134 17:40:15 INFO - PROCESS | 23188 | |5;imaging-gaussian-blur;117;116;116;116;116;116;117;116;116;117 17:40:15 INFO - PROCESS | 23188 | |6;imaging-darkroom;145;145;146;146;146;145;146;145;145;146 17:40:15 INFO - PROCESS | 23188 | |7;imaging-desaturate;95;94;95;95;95;95;95;96;95;95 17:40:15 INFO - PROCESS | 23188 | |8;json-parse-financial;54;53;54;55;55;55;54;56;56;54 17:40:15 INFO - PROCESS | 23188 | |9;json-stringify-tinderbox;61;61;60;60;61;60;60;61;60;61 17:40:15 INFO - PROCESS | 23188 | |10;stanford-crypto-aes;80;78;78;87;85;81;80;80;107;80 17:40:15 INFO - PROCESS | 23188 | |11;stanford-crypto-ccm;122;120;124;117;129;117;121;119;140;122 17:40:15 INFO - PROCESS | 23188 | |12;stanford-crypto-pbkdf2;158;163;158;157;162;158;157;157;160;161 17:40:15 INFO - PROCESS | 23188 | |13;stanford-crypto-sha256-iterative;63;62;66;62;63;66;69;62;61;64 17:40:15 INFO - PROCESS | 23188 | __end_tp_report 17:40:15 INFO - PROCESS | 23188 | __start_cc_report 17:40:15 INFO - PROCESS | 23188 | _x_x_mozilla_cycle_collect,1641 17:40:15 INFO - PROCESS | 23188 | __end_cc_report 17:40:15 INFO - PROCESS | 23188 | __startTimestamp1466642415463__endTimestamp 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | ------- Summary: start ------- 17:40:15 INFO - PROCESS | 23188 | Number of tests: 14 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.27 (2.9%) stddev-sans-first:1.22 17:40:15 INFO - PROCESS | 23188 | Values: 101.0 112.0 109.0 111.0 111.0 110.0 109.0 112.0 110.0 112.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:145.50 stddev:21.43 (14.7%) stddev-sans-first:22.11 17:40:15 INFO - PROCESS | 23188 | Values: 160.0 128.0 133.0 183.0 133.0 132.0 158.0 131.0 176.0 125.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:1.96 (1.2%) stddev-sans-first:1.99 17:40:15 INFO - PROCESS | 23188 | Values: 160.0 161.0 161.0 161.0 167.0 161.0 161.0 161.0 162.0 161.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#3] audio-fft Cycles:10 Average:83.10 Median:74.50 stddev:17.65 (23.7%) stddev-sans-first:18.41 17:40:15 INFO - PROCESS | 23188 | Values: 74.0 75.0 77.0 126.0 78.0 75.0 74.0 74.0 104.0 74.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:85.00 stddev:19.74 (23.2%) stddev-sans-first:20.45 17:40:15 INFO - PROCESS | 23188 | Values: 85.0 85.0 124.0 85.0 85.0 85.0 117.0 85.0 85.0 134.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 17:40:15 INFO - PROCESS | 23188 | Values: 117.0 116.0 116.0 116.0 116.0 116.0 117.0 116.0 116.0 117.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:40:15 INFO - PROCESS | 23188 | Values: 145.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 17:40:15 INFO - PROCESS | 23188 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.00 17:40:15 INFO - PROCESS | 23188 | Values: 54.0 53.0 54.0 55.0 55.0 55.0 54.0 56.0 56.0 54.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 17:40:15 INFO - PROCESS | 23188 | Values: 61.0 61.0 60.0 60.0 61.0 60.0 60.0 61.0 60.0 61.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:80.00 stddev:8.71 (10.9%) stddev-sans-first:9.14 17:40:15 INFO - PROCESS | 23188 | Values: 80.0 78.0 78.0 87.0 85.0 81.0 80.0 80.0 107.0 80.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:122.00 stddev:6.90 (5.7%) stddev-sans-first:7.31 17:40:15 INFO - PROCESS | 23188 | Values: 122.0 120.0 124.0 117.0 129.0 117.0 121.0 119.0 140.0 122.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.00 stddev:2.23 (1.4%) stddev-sans-first:2.33 17:40:15 INFO - PROCESS | 23188 | Values: 158.0 163.0 158.0 157.0 162.0 158.0 157.0 157.0 160.0 161.0 17:40:15 INFO - PROCESS | 23188 | 17:40:15 INFO - PROCESS | 23188 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:2.49 (3.9%) stddev-sans-first:2.62 17:40:15 INFO - PROCESS | 23188 | Values: 63.0 62.0 66.0 62.0 63.0 66.0 69.0 62.0 61.0 64.0 17:40:15 INFO - PROCESS | 23188 | -------- Summary: end -------- 17:40:15 INFO - PROCESS | 23188 | 17:40:16 INFO - TEST-INFO | 23188: exit 0 17:40:16 INFO - TEST-OK | kraken | took 61272ms 17:40:16 INFO - SUITE-END | took 1176s 17:40:16 INFO - Completed test suite (00:19:36) 17:40:16 INFO - javascript benchmark 17:40:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.4394009078364, 3119.563261143439, 3147.748180145589, 3164.7626428017907, 3191.1543440988144, 5264.605154613405, 5269.973650131754, 5352.090144675405, 5353.571714262859, 5392.676439413638, 5309.123994540906, 5314.76083576239, 5389.865253368668, 5415.83752487425, 5454.236406903036, 4789.497102804207, 4865.902681946359, 4874.268859671042, 4886.169351210285, 5065.037642847866, 4946.604271658259, 4954.009198160365, 5005.924911126336, 5017.347744793172, 5024.598032157419, 4789.161896668086, 4835.178019736653, 4849.660523763338, 4912.6806757561, 4932.087563800708, 4863.124637565237, 4878.585320247783, 4880.755962201912, 4951.0, 4985.476524964863, 4849.854504364875, 4877.658563900528, 4885.682430641997, 4885.926711099336, 4887.682300650446, 5202.141646628302, 5284.788608455658, 5333.0, 5405.540529055035, 5432.728363581805, 5714.371419143891, 5753.597248192628, 5762.538996880239, 5767.971160144214, 5772.8845423091725, 5791.88416231673, 5823.9708801456145, 5830.533557315404, 5834.620749651259, 5842.123681447774, 5249.816256431007, 5270.209468579667, 5305.230741542455, 5316.41519432866, 5407.729613519347, 5874.823755287348, 5878.911816322759, 5882.617629854131, 5885.529157667376, 5889.1755154278435, 5634.1830434586755, 5678.233438485751, 5690.317161940594, 5694.5159661428415, 5696.943030569724, 5546.362168350611, 5629.380768115504, 5667.574931880125, 5696.8860622787315, 5728.742206600713, 5705.001624715658, 5708.372079071299, 5713.114467257582, 5713.285839270091, 5713.542916566665, 5534.916976245359, 5714.0, 5717.714114294268, 5721.056025755787, 5726.055200891889, 4297.205017071852, 4310.116426132635, 4316.0, 4336.414584031116, 4383.824647014148, 3894.4353068804867, 3904.39481880309, 3913.4521167036637, 3940.3498422760495, 3952.66402355803, 5302.761375738101, 5409.810656626999, 5442.863928401822, 5456.154296084113, 5460.126379779216, 5678.375378708339, 5727.968965586235, 5729.627574207663, 5734.340550836707, 5770.913436298459, 5456.536194423439, 5460.918086228709, 5464.207689884945, 5467.371252305956, 5475.06923822951, 4821.132196204717, 4940.086084074386, 4956.801727930842, 4966.950330496721, 5018.4730603286125, 5975.521958243417, 6037.335893051761, 6043.607165534227, 6048.485878700271, 6104.053871649901, 5822.5633077518505, 5836.970815145897, 5839.065749480063, 5839.445252700986, 5849.268841394825, 5682.403347648603, 5887.234659494409, 5914.172015917689, 6027.939720602913, 6039.365866584121, 5688.601797874275, 5693.5445164387575, 5699.088145896802, 5702.657840529581, 5738.196652468574, 5725.713714314351, 5744.712764361681, 5786.623869448473, 5801.796937107181, 5803.071508558611, 5470.781168753205, 5612.550995920398, 5665.433456654301, 5669.829905102853, 5670.206171135962, 5642.040853055072, 5684.204211410323, 5707.143928410772, 5752.165935939349, 5757.395473475225, 5559.499645031967, 5599.748011339418, 5608.270924779753, 5608.551315894801, 5608.775648973995, 5441.156620723794, 5609.074502707008, 5651.773929042793, 5726.885462290647, 5768.53851691872, 5574.247476590771, 5589.245451863946, 5589.552835773047, 5625.0, 5639.069553523786], "value": 5305.835047565384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.5805420097531, 624.2758400255702, 628.8082134948842, 641.108858686426, 646.4634353486607, 32008.35983280333, 32417.837910810413, 32698.346033079324, 32709.0, 32726.67273327269, 42091.0, 42811.0, 42861.571384286144, 42906.57093429065, 43854.78072609632, 8549.65801367946, 8826.911730882674, 8851.867221991675, 8852.380333376666, 8860.0, 8035.517868927883, 8792.69225577105, 8885.511296878669, 8885.733427997171, 10279.434631095286, 10376.273660843744, 10683.0, 10694.304870183452, 10709.946450267777, 10715.035646791786, 10674.519646615881, 10745.892541074645, 10754.408507532082, 10754.892451075468, 10758.354498730101, 10460.163186945103, 10526.578911846878, 10528.526216320284, 10531.315464494859, 10531.684049478528, 41601.791991040154, 41828.0, 41908.37137442941, 41921.580784192076, 41929.37105943413, 3707.7219208559195, 3828.636279553438, 3988.4615576897327, 4025.6376926076796, 4319.719218250835, 31780.523292150636, 31998.680013199802, 32659.6734032659, 32662.0, 33185.004449866545, 4067.8983025424304, 4080.8571699990357, 4125.91748165038, 4225.661947044229, 4261.019965407942, 336731.0, 338427.99999999756, 338480.0, 341018.0, 341456.0, 56566.7171664139, 56778.0, 57002.714986424806, 57546.424535754944, 57687.71156144192, 59239.111413328836, 59271.70364148238, 59328.70335648294, 59527.0, 59560.0, 16651.0, 16794.580135496464, 16817.83182168187, 16821.243044063045, 16821.915890420714, 13447.596572102853, 13498.93250533741, 13501.527446539323, 13526.32368381577, 13528.93235533816, 14656.340464679115, 15992.840071599368, 16066.75899861503, 16091.758623620655, 16129.83870161307, 6522.934770652328, 6563.0, 6576.145101136822, 6583.670816459158, 6758.972308307488, 902.444996327254, 959.7456673981401, 985.6156099121348, 1006.3911333643186, 1100.9889901101046, 31547.36905261882, 31933.20166995844, 32112.83943580267, 32266.0, 32498.512522312183, 1087.8640169978753, 1117.6255954255416, 1128.4527004402858, 1145.3929417408788, 1161.5760247509768, 16744.581385465463, 16810.83189168117, 16966.745498817527, 17110.401135960183, 17131.737151197267, 499506.0, 502247.0, 503676.0, 503879.0, 504173.0, 57317.0, 57321.14018289729, 57384.0, 57427.42572574304, 57603.0, 1244.5581818454318, 1336.8663133686553, 1360.4286199796109, 1375.3467103125936, 1387.6461502316845, 31621.683783162793, 32796.60466209066, 32887.671123289416, 33043.173920652174, 33701.0, 49073.0, 49340.25989610087, 49688.0, 49803.0, 49829.0, 390873.0, 393741.0, 394171.2040078698, 394750.0, 394978.0, 35255.82372088226, 39783.403248951865, 40738.0, 41551.376729349686, 44046.3393049111, 42317.36523952082, 42755.358669620604, 47898.0, 48800.267995979375, 48833.75583122062, 39581.80209098936, 40385.1922961545, 41215.79392103021, 41408.0, 41906.790466047474, 40132.79933600313, 40339.193216134925, 40737.79631101825, 40738.1852362957, 41387.379189311585, 39954.0, 40216.19567608573, 40536.1892762149, 40580.18839623132, 41342.37986430146, 34936.650633494355, 36453.17250660441, 37040.62959370372, 37051.81474092612, 37580.81209593934, 27823.30441738973, 27932.184408014225, 28053.0, 28080.786047849073, 28291.26475480651], "value": 20196.14902037341, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.7396257526169, 386.90813147000483, 392.6760422651312, 395.1504265828468, 411.5925234018323, 14125.505607303747, 15871.603209919758, 18487.168077436512, 19191.328303509363, 19217.0, 14275.2862356882, 14415.279236038208, 17786.199621017055, 17858.285668573273, 18330.450086497392, 5248.6063545234165, 5650.237217975562, 5690.2887139107615, 5691.117876729114, 5692.629979051369, 4033.3949907513816, 5456.454354564532, 5566.192902029204, 5566.638168519034, 5567.777288908439, 5903.49820265278, 6206.596571222879, 6207.224096987877, 6312.652804095773, 6316.021016742412, 6030.758769649231, 6188.566800323979, 6199.814005579839, 6239.095331176976, 6260.467860231885, 5417.349918009864, 5466.070767969455, 5470.6444081135, 5487.204355368449, 5497.422770609109, 21321.80172974051, 21757.67363489549, 22152.889235553717, 22163.667544986838, 22312.0, 2520.3699075231193, 2536.581464058428, 2596.0913680211775, 2885.3940672458807, 3118.9064328069967, 13459.596212113653, 13702.93148534261, 13855.445782168701, 14042.0, 14530.491432799801, 1904.5714714189335, 1922.7884932657396, 2001.1395100106947, 2004.9097790599458, 2064.741907261592, 75193.62403188004, 77204.22795772027, 77646.0, 78296.8255476174, 79591.20408795896, 10088.899111008795, 10101.797964040677, 10127.493625318704, 10293.639722609672, 10506.527206275736, 14323.641908952359, 14350.928245358706, 14353.92823035878, 14370.640733981734, 14386.48236558619, 7122.6438678066925, 7693.422993275527, 7766.262205090507, 7883.132855385903, 8026.518408895368, 7936.801579960547, 8018.398620103516, 8269.793255168548, 8363.916360836314, 8550.828983420297, 6234.407731265523, 6436.549441539141, 6460.804751121058, 6499.902501462482, 6509.707063182168, 1867.617138486634, 1871.373090014833, 1911.3214808742973, 1920.8474915050858, 1931.51712071982, 943.8867335919596, 1014.3356101753363, 1045.6862941117633, 1056.0, 1077.5851297250615, 18161.82607869884, 18894.716579251322, 18952.526186845163, 19180.328688495836, 19422.90288548548, 1004.3923426327113, 1010.3483253301579, 1011.6863772230632, 1052.000599430544, 1136.943152842371, 9838.75403114928, 10846.837297440545, 10895.291806032583, 10898.128149748001, 10919.836202456969, 336680.0, 346900.0, 448735.0, 449410.0, 450798.0, 62830.68584657047, 77489.61255193688, 97491.51254243826, 99354.5032274834, 100722.49638751906, 1010.3937637417491, 1023.242800327767, 1051.1748277602046, 1058.9364638121583, 1063.5161001744343, 16708.665826683642, 16719.665606687555, 17010.65978680444, 17012.659746804748, 17351.652966940845, 41370.37944430776, 43001.56998429976, 43017.78491107524, 43370.78314608407, 43467.78266108776, 59718.70140649269, 61195.694021529605, 62077.0, 62886.6855665737, 63390.68304658447, 8403.369747268856, 8596.527191004554, 8646.740597782076, 8718.346124040849, 8856.822863542822, 9059.501727405055, 11020.614278500214, 12130.878691212974, 12283.385830708608, 12473.688157796129, 10766.946165269124, 10884.12926965825, 10926.235163538477, 11148.0, 11161.823444428259, 10785.568577256821, 10984.670459886216, 11050.557977680803, 11093.0, 11170.0, 11025.44872756375, 11088.057515111306, 11125.499352528994, 11254.324740515267, 11409.372484513431, 8493.957530212308, 8538.829223415622, 8731.170538798804, 8734.69428569997, 9000.549972501218, 10140.594376225163, 10787.0, 10900.34597924127, 11063.114950803756, 11090.5563777448], "value": 9179.777305129426, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.882110610045, 1434.311530465377, 1475.3877140986492, 1599.808023037235, 1761.5419990802395, 8045.91954080459, 8431.915680843189, 8448.788780280496, 8717.607707653155, 8729.432586881849, 8549.87175192371, 8560.143985601437, 8643.438176518523, 8645.265152462049, 8650.178233067863, 1991.9004049797452, 2229.6209644360497, 2302.9424264393397, 2338.169949667869, 2339.076064954342, 2276.0, 2307.3770082077913, 2313.375388645065, 2314.4329639238326, 2315.7915787579113, 2277.294038847954, 2282.7717228277206, 2294.724633044037, 2320.872352020638, 2325.511642555057, 1958.3831093205665, 2158.0396723458066, 2230.8215342772537, 2239.742429620598, 2247.943466570709, 2255.1881322723807, 2272.6477396003647, 2274.8748818814956, 2278.28234106256, 2278.3392816083315, 8229.300509456703, 8283.710070147516, 8288.0, 8296.211859873303, 8302.792430189294, 4918.581920536759, 5059.848204553869, 5063.468335824759, 5073.492650734934, 5080.898382032338, 3172.1435212492497, 3275.8689652414114, 3390.7795993260606, 3438.914027149316, 3442.862285508577, 1150.7410832562691, 1173.266708307308, 1176.159046281904, 1189.756099999498, 1193.5524178433088, 11327.150463715254, 11585.768284634345, 11593.420328983517, 11597.420128993517, 11598.362090085042, 4418.558144185556, 4482.081173359454, 4535.795889184995, 4554.180247555471, 4573.63410927125, 9824.950875245579, 9876.950615246878, 9891.159251463563, 9892.901070989343, 9899.356541824758, 5037.571806396498, 5093.668911520739, 5094.77073531692, 5095.566876815512, 5097.108006098918, 4117.07365842683, 4447.355133505624, 4636.072785442925, 4636.35091087248, 4640.071985602893, 3992.1416895367634, 4009.959900401017, 4075.551689314173, 4116.567760385176, 4144.606262405066, 1233.5189276182296, 1285.1108869961142, 1297.267044120088, 1306.3664122900386, 1310.3382791690326, 868.2099289646392, 922.31748506105, 950.3632566180676, 957.5308099031564, 987.6444479987199, 5708.600397972102, 5787.71061446926, 5796.3913789052385, 5858.589898707135, 6077.301110372276, 435.5861931165405, 447.92385294500014, 454.9567791059844, 456.2973021546847, 462.9236176030917, 3758.2483503298904, 3802.448644946467, 3817.3319669057805, 3832.3485007548784, 3900.8244628991197, 10104.242181836245, 10413.114885234689, 10479.580816767244, 10545.84181237282, 10580.259381843198, 10401.53193106312, 10412.947935260276, 10443.843342349719, 10451.94774026125, 10453.895461045444, 7826.5978847571105, 7897.960510197528, 7958.363330933512, 7986.560739159402, 8013.398995075393, 5832.679202643895, 5871.588988770916, 5873.73568189424, 5895.41045895407, 5942.108683697307, 9582.137607615348, 9653.46905920181, 9754.853677194706, 9802.166815820736, 9816.411015339103, 9709.320347575602, 9893.604255829974, 9973.052560006789, 9996.850047249152, 9998.150157236425, 6647.468202543688, 7325.340719335285, 7497.325240728361, 7507.136679281953, 7718.3053525183, 8266.586670666322, 8289.502629842229, 8317.875231871647, 8349.03986041613, 8445.155484451505, 7068.752593659197, 7308.159561650478, 7468.626568671653, 7582.203868593719, 7586.24137586237, 7138.892916606359, 7296.525725827804, 7300.525465844916, 7383.852322953619, 7469.813254668677, 6737.32626737342, 6748.898766518408, 6797.592144471149, 6798.048273241849, 6802.897956530557, 4815.537071675808, 4895.143349913679, 5010.599152067753, 5031.4213865405945, 5060.772265247999, 4910.43529994041, 4913.7543122843, 4954.950450495449, 5013.315213318281, 5130.692158470503], "value": 4417.676481856864, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.2978937811169, 314.3885143396094, 317.78390694327845, 333.0624292616283, 335.68613346521005, 5126.205438157082, 5279.445658205891, 5306.734663266836, 5381.246625472432, 5411.377691565466, 5286.444923283048, 5329.973350133244, 5339.893202135955, 5349.5720342372615, 5349.598780091489, 4170.728902621335, 4199.6220340169375, 4208.242516347056, 4224.450821393215, 4230.111676547928, 3929.25344184604, 3959.4258832469272, 4151.792410379484, 4169.728967617095, 4175.457190565222, 4123.381492776092, 4157.711109556032, 4177.0, 4179.143275628504, 4192.287311157111, 4145.896352591194, 4156.2934301168725, 4169.91660166798, 4187.664986801079, 4188.748675079474, 3462.8441720122655, 3728.4966529518438, 3736.4395340698843, 3742.8315725792404, 3756.69946404287, 5119.616028797818, 5131.743412829381, 5167.0, 5173.301604283449, 5178.446466060167, 4641.489436162019, 4667.883302917454, 4706.223473126965, 4728.574428301469, 4734.621230301567, 5326.280952071459, 5511.53151982082, 5517.227588137664, 5529.778808847641, 5536.944630553683, 3975.8608448704445, 3985.6612187964056, 4004.2391945530258, 4005.439238506611, 4006.278869803434, 5747.913781293242, 5800.419958004208, 5802.854928626776, 5807.564432667525, 5828.795992140297, 3919.5884432134785, 4066.1664358806374, 4111.280525908014, 4120.011197312683, 4121.155163191538, 4091.8158682859344, 4097.610726980932, 4099.0162361033135, 4099.528554216304, 4121.670266378683, 4714.929276060861, 4717.268823332389, 4729.9054018920115, 4735.242361222188, 4756.096341695067, 5497.616135393477, 5543.530964294465, 5576.888462230732, 5582.218489411485, 5611.5129490685, 1382.4401117547409, 1405.4378248700602, 1411.8517555656713, 1413.0, 1417.588899219215, 894.5661354243186, 902.3052249767642, 909.2180724576858, 917.954102294896, 922.4649703172144, 4709.221559280041, 4787.162246606899, 4798.712077275374, 4808.422989241313, 4897.975510122426, 5017.422996355393, 5078.5937125029905, 5132.30713853625, 5152.9742351288005, 5200.427952925175, 4812.00301874725, 4916.827911023097, 4934.161192597196, 4940.135476291634, 5038.722870242172, 3017.834019128925, 3022.2293315204483, 3025.8638361273797, 3072.9692703072683, 3092.969070309313, 5858.5898987070495, 5918.171455996164, 5966.224390829165, 5992.913649470526, 6028.728707208186, 5584.91622625661, 5823.417658234227, 5866.0, 5879.52963762898, 5881.294244690579, 5888.852778680396, 5897.321807992136, 5914.763409463573, 5925.34821169671, 5931.703414829241, 5622.297212848394, 5741.62679425836, 5742.827715168552, 5757.856053598526, 5789.61049348145, 5591.804286850103, 5656.3495198051105, 5674.177244299636, 5691.78020571969, 5760.539156867357, 5900.911486327623, 5902.822915312548, 5917.431880551571, 5923.318818335774, 5929.851753706192, 3831.4252862069798, 3891.5719270879613, 3915.393114067324, 3938.9364871483967, 4092.304308267542, 5602.887942241214, 5622.8754249149515, 5639.941421381249, 5650.85872853182, 5697.32225853848, 5611.971940140274, 5613.775448981995, 5640.182173584889, 5671.971640141773, 5674.829755107354, 5333.893322133613, 5631.324241091095, 5656.321241451053, 5675.829725108253, 5682.829515114553, 5550.861228469321, 5558.249636299048, 5574.498295153456, 5583.525400340854, 5584.664920104807, 5304.840854774363, 5608.093248295599, 5644.6613203207935, 5678.403767604507, 5734.677455630476, 5512.255845460972, 5516.503514683698, 5517.200005999028, 5519.0, 5523.143912693539], "value": 4211.666635503406, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.5095687802927, 767.8310771630241, 785.1598789295456, 805.5087684533836, 834.0033659776569, 14721.116732996014, 15332.310046047913, 16012.679746405065, 16311.429099981504, 16371.672566548661, 14063.08589941653, 14177.929110354435, 14250.358733856976, 14250.429982800675, 14264.0, 661.8113837556298, 791.1732239809385, 791.232504470664, 807.6607824713634, 810.7810891059411, 804.6620419423856, 809.2918696140877, 809.6397103289039, 810.0158307656196, 810.2586133687669, 847.4703310430981, 852.7569642651846, 853.117023880284, 853.2576658307281, 853.8889944307263, 686.8351595617066, 791.5290402210676, 809.29591255608, 845.6532821543168, 845.6575087089708, 594.5481434110064, 595.577140230437, 595.577140230437, 596.4989408896504, 598.4554055809236, 14919.92540037293, 14963.625909352244, 14978.325975331136, 14978.550643480605, 14980.250987450692, 12777.361131943459, 13243.404046817916, 13252.469901204036, 13490.932545337211, 13773.586792396243, 10179.491025448699, 10804.1896857736, 10829.512671929782, 10931.512575768142, 11053.392063436508, 4403.200511442543, 4447.933281000787, 4468.173387923212, 4513.119941611387, 4664.55686709762, 74825.25174748292, 75589.0, 75921.62039189768, 76724.61637691775, 77843.0, 10423.270371074104, 10547.367157970393, 10557.524911378852, 10666.14670826332, 11226.382548959886, 20357.898210508854, 20438.28466003683, 20485.18059277642, 20507.794922050885, 20550.58898822015, 8255.752327430067, 8267.29727973117, 8328.167183281623, 8527.914720852836, 8844.425112367675, 3351.346487434927, 3408.4887266910164, 4234.026173980002, 4315.266404711207, 4699.741514216751, 3262.7389808815237, 3332.0670212340583, 3348.313595712873, 3378.8648454061563, 3387.6273609903383, 536.1528784520449, 591.1516973143553, 602.7588964414269, 603.3242768099757, 604.6916072802815, 534.3694440560099, 556.2546188107955, 670.1522573943964, 682.737146198717, 704.7251571886968, 9297.558878373862, 9678.17735492491, 9719.0, 9812.460314682761, 9885.654002109892, 609.8383928259015, 644.2044075566765, 675.2403546010738, 681.1655721740926, 687.2611942162096, 4516.322551617218, 4607.35497030416, 4654.813807447732, 4691.483936766953, 4716.174669432836, 121391.0, 127342.36328818297, 127693.0, 128615.0, 128866.0, 104062.0, 104356.47821760843, 104361.0, 104402.0, 105063.0, 90501.54749226212, 91598.08401916029, 92344.84448199847, 93469.0, 95345.52327238319, 8828.293736501193, 8947.552622368985, 9041.864372034293, 9130.315226357918, 9135.543222838964, 50596.49403506065, 51588.0, 51671.483285166665, 52617.9476410462, 54866.725666371414, 73646.0, 77730.6113469429, 80176.19823801688, 80289.19710802817, 81555.0, 11775.882241177822, 11846.11154163424, 12183.695407614881, 12460.314682692177, 12951.870481295444, 13145.079844411182, 13358.398872050586, 13365.26491043002, 13438.46246150143, 14450.349734261774, 12564.874351256736, 12628.116031878048, 12912.741745165233, 12917.806232906327, 13201.57630761876, 11358.375289358833, 11492.229267686187, 12433.067519936221, 12499.312537810507, 14175.0, 13280.80078798838, 13348.26584537821, 14007.649808754863, 14027.579172624837, 14437.494687685881, 10938.726531836768, 11160.888391115985, 11207.43962801873, 11705.122115841175, 11945.82081268799, 10870.402127882726, 10959.287646302964, 11349.319040857576, 11685.707857303296, 11899.107566932342], "value": 7395.943280613786, "unit": "score"}], "name": "dromaeo_css", "value": 7165.676202994693, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 109.0, 111.0, 111.0, 110.0, 109.0, 112.0, 110.0, 112.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 133.0, 183.0, 133.0, 132.0, 158.0, 131.0, 176.0, 125.0], "value": 145.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 167.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 126.0, 78.0, 75.0, 74.0, 74.0, 104.0, 74.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 124.0, 85.0, 85.0, 85.0, 117.0, 85.0, 85.0, 134.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 55.0, 55.0, 55.0, 54.0, 56.0, 56.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 87.0, 85.0, 81.0, 80.0, 80.0, 107.0, 80.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 124.0, 117.0, 129.0, 117.0, 121.0, 119.0, 140.0, 122.0], "value": 123.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 163.0, 158.0, 157.0, 162.0, 158.0, 157.0, 157.0, 160.0, 161.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 66.0, 62.0, 63.0, 66.0, 69.0, 62.0, 61.0, 64.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1498.7999999999997, "alertThreshold": 2.0}]} 17:40:16 INFO - Return code: 0 17:40:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:40:16 INFO - # TBPL SUCCESS # 17:40:16 INFO - Running post-action listener: _resource_record_post_action 17:40:16 INFO - ##### 17:40:16 INFO - ##### Finished run-tests step (success) 17:40:16 INFO - ##### 17:40:16 INFO - Running post-run listener: _resource_record_post_run 17:40:16 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394653696; Read time: 12; Write time: 317176 17:40:16 INFO - TinderboxPrint: CPU usage
13.2% 17:40:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:40:16 INFO - TinderboxPrint: I/O write bytes / time
394,653,696 / 317,176 17:40:16 INFO - TinderboxPrint: CPU idle
8,270.2 (86.8%) 17:40:16 INFO - TinderboxPrint: CPU user
1,211.7 (12.7%) 17:40:16 INFO - TinderboxPrint: Swap in / out
0 / 0 17:40:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104620032; Read time: 0; Write time: 107524 17:40:16 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290033664; Read time: 12; Write time: 209652 17:40:17 INFO - Running post-run listener: _upload_blobber_files 17:40:17 INFO - Blob upload gear active. 17:40:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:40:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:40:17 INFO - (blobuploader) - INFO - Open directory for files ... 17:40:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:40:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:40:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:18 INFO - (blobuploader) - INFO - Done attempting. 17:40:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:40:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:40:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:19 INFO - (blobuploader) - INFO - Done attempting. 17:40:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:40:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:40:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:23 INFO - (blobuploader) - INFO - Done attempting. 17:40:23 INFO - (blobuploader) - INFO - Iteration through files over. 17:40:23 INFO - Return code: 0 17:40:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:40:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:40:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad754fc35f39206b71cd1b31e8026bb6eb8dc05d5238de435df57e2f1ff488be029c8ff61e8df9d47ae9879be2dd7b6b7834e7bc1b340426045cc7eaf0784e1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2358b11e651b07020b880473096982bbaf261158cb54dc39e2bc71c5dc427bbf2929042bf2217e17bce4adaaca6f8f14ea7e10c9ae68bc16c38121bcae23c221", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/882b57be4d32c2c544001a9ef1c8644ac4c800bae405fb7daaad7a401119923995142880b930e507ab6b9afd607cff755aa26e80313b3e7fa8c1209f325c2eec"} 17:40:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:40:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:40:23 INFO - Contents: 17:40:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad754fc35f39206b71cd1b31e8026bb6eb8dc05d5238de435df57e2f1ff488be029c8ff61e8df9d47ae9879be2dd7b6b7834e7bc1b340426045cc7eaf0784e1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2358b11e651b07020b880473096982bbaf261158cb54dc39e2bc71c5dc427bbf2929042bf2217e17bce4adaaca6f8f14ea7e10c9ae68bc16c38121bcae23c221", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/882b57be4d32c2c544001a9ef1c8644ac4c800bae405fb7daaad7a401119923995142880b930e507ab6b9afd607cff755aa26e80313b3e7fa8c1209f325c2eec"} 17:40:23 INFO - Running post-run listener: copy_logs_to_upload_dir 17:40:23 INFO - Copying logs to upload dir... 17:40:23 INFO - mkdir: /builds/slave/test/build/upload/logs 17:40:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.519552 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-06-22 17:40:22.664639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 17:40:22.667699) ========= 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=62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569 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/ad754fc35f39206b71cd1b31e8026bb6eb8dc05d5238de435df57e2f1ff488be029c8ff61e8df9d47ae9879be2dd7b6b7834e7bc1b340426045cc7eaf0784e1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2358b11e651b07020b880473096982bbaf261158cb54dc39e2bc71c5dc427bbf2929042bf2217e17bce4adaaca6f8f14ea7e10c9ae68bc16c38121bcae23c221", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/882b57be4d32c2c544001a9ef1c8644ac4c800bae405fb7daaad7a401119923995142880b930e507ab6b9afd607cff755aa26e80313b3e7fa8c1209f325c2eec"} build_url:https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/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/ad754fc35f39206b71cd1b31e8026bb6eb8dc05d5238de435df57e2f1ff488be029c8ff61e8df9d47ae9879be2dd7b6b7834e7bc1b340426045cc7eaf0784e1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2358b11e651b07020b880473096982bbaf261158cb54dc39e2bc71c5dc427bbf2929042bf2217e17bce4adaaca6f8f14ea7e10c9ae68bc16c38121bcae23c221", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/882b57be4d32c2c544001a9ef1c8644ac4c800bae405fb7daaad7a401119923995142880b930e507ab6b9afd607cff755aa26e80313b3e7fa8c1209f325c2eec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 17:40:22.693078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:40:22.693427) ========= 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=62c568580acbfdaac3eec7be000001dc-1466616258.208904-616195569 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:40:22.779173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 17:40:22.779506) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 17:40:22.779801) ========= ========= Total master_lag: 0.17 =========