builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1466518504.54 results: success (0) buildid: 20160621064400 builduid: 774b8571136f4237973290f4f2baba9a revision: ecd3562339dcd51a604e82efbcb347de8b823aee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:04.539235) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:04.539751) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:04.540098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:04.584437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:04.584762) ========= 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=00204705a9daa57ed339a427000001b9-1466517397.778851-596258064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 07:15:04-- 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% 43.1M=0s 2016-06-21 07:15:04 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167302 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:04.775037) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:04.775363) ========= 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=00204705a9daa57ed339a427000001b9-1466517397.778851-596258064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.092039 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:04.876855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 07:15:04.877175) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ecd3562339dcd51a604e82efbcb347de8b823aee --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 ecd3562339dcd51a604e82efbcb347de8b823aee --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=00204705a9daa57ed339a427000001b9-1466517397.778851-596258064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 07:15:04,938 truncating revision to first 12 chars 2016-06-21 07:15:04,938 Setting DEBUG logging. 2016-06-21 07:15:04,938 attempt 1/10 2016-06-21 07:15:04,938 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ecd3562339dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 07:15:05,785 unpacking tar archive at: fx-team-ecd3562339dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.240637 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 07:15:06.131465) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:06.131779) ========= script_repo_revision: ecd3562339dcd51a604e82efbcb347de8b823aee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:06.132197) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:06.132497) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 07:15:06.142234) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-21 07:15:06.142541) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=00204705a9daa57ed339a427000001b9-1466517397.778851-596258064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:15:06 INFO - MultiFileLogger online at 20160621 07:15:06 in /builds/slave/test 07:15:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:15:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:06 INFO - {'append_to_log': False, 07:15:06 INFO - 'base_work_dir': '/builds/slave/test', 07:15:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:15:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:06 INFO - 'branch': 'Fx-Team-Non-PGO', 07:15:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:06 INFO - 'config_files': ('talos/linux_config.py',), 07:15:06 INFO - 'default_actions': ('clobber', 07:15:06 INFO - 'read-buildbot-config', 07:15:06 INFO - 'download-and-extract', 07:15:06 INFO - 'populate-webroot', 07:15:06 INFO - 'create-virtualenv', 07:15:06 INFO - 'install', 07:15:06 INFO - 'run-tests'), 07:15:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:06 INFO - 'download_minidump_stackwalk': True, 07:15:06 INFO - 'download_symbols': 'ondemand', 07:15:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:06 INFO - 'installer_path': 'installer.exe', 07:15:06 INFO - 'log_level': 'info', 07:15:06 INFO - 'log_name': 'talos', 07:15:06 INFO - 'log_to_console': True, 07:15:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:15:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:15:06 INFO - 'opt_config_files': (), 07:15:06 INFO - 'pip_index': False, 07:15:06 INFO - 'sps_profile': False, 07:15:06 INFO - 'sps_profile_interval': 0, 07:15:06 INFO - 'suite': 'dromaeojs', 07:15:06 INFO - 'system_bits': '32', 07:15:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:06 INFO - 'title': 'talos-linux64-ix-016', 07:15:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:06 INFO - 'use_talos_json': True, 07:15:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:06 INFO - 'work_dir': 'build'} 07:15:06 INFO - ##### 07:15:06 INFO - ##### Running clobber step. 07:15:06 INFO - ##### 07:15:06 INFO - Running pre-action listener: _resource_record_pre_action 07:15:06 INFO - Running main action method: clobber 07:15:06 INFO - rmtree: /builds/slave/test/build 07:15:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:08 INFO - Running post-action listener: _resource_record_post_action 07:15:08 INFO - ##### 07:15:08 INFO - ##### Finished clobber step (success) 07:15:08 INFO - ##### 07:15:08 INFO - ##### 07:15:08 INFO - ##### Running read-buildbot-config step. 07:15:08 INFO - ##### 07:15:08 INFO - Running pre-action listener: _resource_record_pre_action 07:15:08 INFO - Running main action method: read_buildbot_config 07:15:08 INFO - Using buildbot properties: 07:15:08 INFO - { 07:15:08 INFO - "project": "", 07:15:08 INFO - "product": "firefox", 07:15:08 INFO - "script_repo_revision": "production", 07:15:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:15:08 INFO - "repository": "", 07:15:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:15:08 INFO - "buildid": "20160621064400", 07:15:08 INFO - "pgo_build": "False", 07:15:08 INFO - "basedir": "/builds/slave/test", 07:15:08 INFO - "buildnumber": 1767, 07:15:08 INFO - "slavename": "talos-linux64-ix-016", 07:15:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:15:08 INFO - "platform": "ubuntu64_hw", 07:15:08 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:15:08 INFO - "branch": "fx-team", 07:15:08 INFO - "repo_path": "integration/fx-team", 07:15:08 INFO - "revision": "ecd3562339dcd51a604e82efbcb347de8b823aee", 07:15:08 INFO - "stage_platform": "linux64", 07:15:08 INFO - "builduid": "774b8571136f4237973290f4f2baba9a", 07:15:08 INFO - "slavebuilddir": "test" 07:15:08 INFO - } 07:15:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:15:08 INFO - Running post-action listener: _resource_record_post_action 07:15:08 INFO - ##### 07:15:08 INFO - ##### Finished read-buildbot-config step (success) 07:15:08 INFO - ##### 07:15:08 INFO - ##### 07:15:08 INFO - ##### Running download-and-extract step. 07:15:08 INFO - ##### 07:15:08 INFO - Running pre-action listener: _resource_record_pre_action 07:15:08 INFO - Running main action method: download_and_extract 07:15:08 INFO - mkdir: /builds/slave/test/build/tests 07:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:08 INFO - https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:15:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:15:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:15:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/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 07:15:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/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 07:15:11 INFO - Downloaded 1361 bytes. 07:15:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:15:11 INFO - Using the following test package requirements: 07:15:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:15:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:15:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'jsshell-linux-x86_64.zip'], 07:15:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:15:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:15:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:15:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:15:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:15:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:11 INFO - https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/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 07:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/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 07:15:15 INFO - Downloaded 22658730 bytes. 07:15:15 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'] 07:15:15 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 07:15:16 INFO - Return code: 0 07:15:16 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 07:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:16 INFO - https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/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 07:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/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 07:15:17 INFO - Downloaded 22658730 bytes. 07:15: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'] 07:15: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 07:15:19 INFO - Return code: 0 07:15: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')]} 07:15:19 INFO - https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:15:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/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 07:15:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/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 07:15:20 INFO - Downloaded 14405384 bytes. 07:15:20 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'] 07:15:20 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 07:15:20 INFO - Return code: 0 07:15:20 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')]} 07:15:20 INFO - https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/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 07:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PmiCwNN6SeSzutIzcI6EWw/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 07:15:21 INFO - Downloaded 56237188 bytes. 07:15:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:21 INFO - mkdir: /builds/slave/test/properties 07:15:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:21 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:21 INFO - Contents: 07:15:21 INFO - build_url:https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:22 INFO - Running post-action listener: _resource_record_post_action 07:15:22 INFO - Running post-action listener: set_extra_try_arguments 07:15:22 INFO - ##### 07:15:22 INFO - ##### Finished download-and-extract step (success) 07:15:22 INFO - ##### 07:15:22 INFO - ##### 07:15:22 INFO - ##### Running populate-webroot step. 07:15:22 INFO - ##### 07:15:22 INFO - Running pre-action listener: _resource_record_pre_action 07:15:22 INFO - Running main action method: populate_webroot 07:15:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:22 INFO - '--tppagecycles', 07:15:22 INFO - '7'], 07:15:22 INFO - 'tests': ['tsvgm']}}, 07:15:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:22 INFO - 'talos_options': ['--disable-e10s'], 07:15:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:22 INFO - 'talos_options': ['--disable-e10s'], 07:15:22 INFO - 'tests': ['damp', 'tps']}, 07:15:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:22 INFO - 'tests': ['damp', 'tps']}, 07:15:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:22 INFO - 'tests': ['dromaeo_dom']}, 07:15:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:15:22 INFO - 'tests': ['basic_compositor_video']}, 07:15:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:15:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:22 INFO - 'tests': ['a11yr', 07:15:22 INFO - 'ts_paint', 07:15:22 INFO - 'tpaint', 07:15:22 INFO - 'sessionrestore', 07:15:22 INFO - 'sessionrestore_no_auto_restore', 07:15:22 INFO - 'tabpaint']}, 07:15:22 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:22 INFO - 'ts_paint', 07:15:22 INFO - 'tpaint', 07:15:22 INFO - 'sessionrestore', 07:15:22 INFO - 'sessionrestore_no_auto_restore', 07:15:22 INFO - 'tabpaint']}, 07:15:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:22 INFO - 'ts_paint', 07:15:22 INFO - 'tpaint', 07:15:22 INFO - 'sessionrestore', 07:15:22 INFO - 'sessionrestore_no_auto_restore', 07:15:22 INFO - 'tabpaint']}, 07:15:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:22 INFO - 'ts_paint', 07:15:22 INFO - 'tpaint', 07:15:22 INFO - 'sessionrestore', 07:15:22 INFO - 'sessionrestore_no_auto_restore', 07:15:22 INFO - 'tabpaint']}, 07:15:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:22 INFO - 'tests': ['a11yr', 07:15:22 INFO - 'ts_paint', 07:15:22 INFO - 'tpaint', 07:15:22 INFO - 'sessionrestore', 07:15:22 INFO - 'sessionrestore_no_auto_restore', 07:15:22 INFO - 'tabpaint']}, 07:15:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:22 INFO - 'tests': ['a11yr', 07:15:22 INFO - 'ts_paint', 07:15:22 INFO - 'tpaint', 07:15:22 INFO - 'sessionrestore', 07:15:22 INFO - 'sessionrestore_no_auto_restore', 07:15:22 INFO - 'tabpaint']}, 07:15:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:22 INFO - 'tests': ['tsvgx', 07:15:22 INFO - 'tsvgr_opacity', 07:15:22 INFO - 'tart', 07:15:22 INFO - 'tscrollx', 07:15:22 INFO - 'cart']}, 07:15:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:22 INFO - 'tsvgr_opacity', 07:15:22 INFO - 'tart', 07:15:22 INFO - 'tscrollx', 07:15:22 INFO - 'cart']}, 07:15:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:22 INFO - 'talos_options': ['--disable-e10s'], 07:15:22 INFO - 'tests': ['tp5o']}, 07:15:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:22 INFO - 'tests': ['tp5o']}, 07:15:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:22 INFO - 'talos_options': ['--disable-e10s', 07:15:22 INFO - '--xperf_path', 07:15:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:22 INFO - 'tests': ['tp5n']}, 07:15:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:22 INFO - 'talos_options': ['--xperf_path', 07:15:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:22 INFO - 'tests': ['tp5n']}}, 07:15:22 INFO - 'talos.zip': {'path': '', 07:15:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:22 INFO - Running post-action listener: _resource_record_post_action 07:15:22 INFO - ##### 07:15:22 INFO - ##### Finished populate-webroot step (success) 07:15:22 INFO - ##### 07:15:22 INFO - ##### 07:15:22 INFO - ##### Running create-virtualenv step. 07:15:22 INFO - ##### 07:15:22 INFO - Running pre-action listener: _resource_record_pre_action 07:15:22 INFO - Running main action method: create_virtualenv 07:15:22 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:22 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 07:15:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:22 INFO - Using real prefix '/usr' 07:15:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:23 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:25 INFO - Installing pip.................done. 07:15:25 INFO - Return code: 0 07:15:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:25 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 0x7f260ac9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c1c0>, '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 0x1a4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d550>, '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': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', '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 07:15:25 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 07:15:25 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 07:15:25 INFO - Using env: {'DISPLAY': ':0', 07:15:25 INFO - 'HOME': '/home/cltbld', 07:15:25 INFO - 'LANG': 'en_US.UTF-8', 07:15:25 INFO - 'LANGUAGE': 'en_US:en', 07:15:25 INFO - 'LOGNAME': 'cltbld', 07:15:25 INFO - 'MAIL': '/var/mail/cltbld', 07:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:25 INFO - 'MOZ_NO_REMOTE': '1', 07:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:25 INFO - 'NO_EM_RESTART': '1', 07:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:25 INFO - 'PWD': '/builds/slave/test', 07:15:25 INFO - 'SHELL': '/bin/bash', 07:15:25 INFO - 'SHLVL': '1', 07:15:25 INFO - 'TERM': 'linux', 07:15:25 INFO - 'TMOUT': '86400', 07:15:25 INFO - 'USER': 'cltbld', 07:15:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', 07:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:25 INFO - '_': '/tools/buildbot/bin/python'} 07:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:26 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 07:15:26 INFO - Cleaning up... 07:15:26 INFO - Return code: 0 07:15:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:15:26 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')]} 07:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:26 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')]} 07:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:26 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 0x7f260ac9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c1c0>, '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 0x1a4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d550>, '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': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', '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 07:15:26 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 07:15:26 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 07:15:26 INFO - Using env: {'DISPLAY': ':0', 07:15:26 INFO - 'HOME': '/home/cltbld', 07:15:26 INFO - 'LANG': 'en_US.UTF-8', 07:15:26 INFO - 'LANGUAGE': 'en_US:en', 07:15:26 INFO - 'LOGNAME': 'cltbld', 07:15:26 INFO - 'MAIL': '/var/mail/cltbld', 07:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:26 INFO - 'MOZ_NO_REMOTE': '1', 07:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:26 INFO - 'NO_EM_RESTART': '1', 07:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:26 INFO - 'PWD': '/builds/slave/test', 07:15:26 INFO - 'SHELL': '/bin/bash', 07:15:26 INFO - 'SHLVL': '1', 07:15:26 INFO - 'TERM': 'linux', 07:15:26 INFO - 'TMOUT': '86400', 07:15:26 INFO - 'USER': 'cltbld', 07:15:26 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', 07:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:26 INFO - '_': '/tools/buildbot/bin/python'} 07:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:26 INFO - Downloading/unpacking psutil>=3.1.1 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:28 INFO - Installing collected packages: psutil 07:15:28 INFO - Running setup.py install for psutil 07:15:28 INFO - building 'psutil._psutil_linux' extension 07:15:28 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 07:15:29 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 07:15:29 INFO - building 'psutil._psutil_posix' extension 07:15:29 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 07:15:29 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 07:15:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:30 INFO - Successfully installed psutil 07:15:30 INFO - Cleaning up... 07:15:30 INFO - Return code: 0 07:15:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:15:30 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')]} 07:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:30 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')]} 07:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:30 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 0x7f260ac9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c1c0>, '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 0x1a4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d550>, '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': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', '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 07:15:30 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 07:15:30 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 07:15:30 INFO - Using env: {'DISPLAY': ':0', 07:15:30 INFO - 'HOME': '/home/cltbld', 07:15:30 INFO - 'LANG': 'en_US.UTF-8', 07:15:30 INFO - 'LANGUAGE': 'en_US:en', 07:15:30 INFO - 'LOGNAME': 'cltbld', 07:15:30 INFO - 'MAIL': '/var/mail/cltbld', 07:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:30 INFO - 'MOZ_NO_REMOTE': '1', 07:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:30 INFO - 'NO_EM_RESTART': '1', 07:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:30 INFO - 'PWD': '/builds/slave/test', 07:15:30 INFO - 'SHELL': '/bin/bash', 07:15:30 INFO - 'SHLVL': '1', 07:15:30 INFO - 'TERM': 'linux', 07:15:30 INFO - 'TMOUT': '86400', 07:15:30 INFO - 'USER': 'cltbld', 07:15:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', 07:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:30 INFO - '_': '/tools/buildbot/bin/python'} 07:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:15:30 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 07:15:30 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 07:15:30 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 07:15:30 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 07:15:30 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 07:15:30 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 07:15:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:15:32 INFO - Installing collected packages: mozsystemmonitor 07:15:32 INFO - Running setup.py install for mozsystemmonitor 07:15:32 INFO - Successfully installed mozsystemmonitor 07:15:32 INFO - Cleaning up... 07:15:32 INFO - Return code: 0 07:15:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:32 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 0x7f260ac9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c1c0>, '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 0x1a4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d550>, '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': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', '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 07:15:32 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 07:15:32 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 07:15:32 INFO - Using env: {'DISPLAY': ':0', 07:15:32 INFO - 'HOME': '/home/cltbld', 07:15:32 INFO - 'LANG': 'en_US.UTF-8', 07:15:32 INFO - 'LANGUAGE': 'en_US:en', 07:15:32 INFO - 'LOGNAME': 'cltbld', 07:15:32 INFO - 'MAIL': '/var/mail/cltbld', 07:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:32 INFO - 'MOZ_NO_REMOTE': '1', 07:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:32 INFO - 'NO_EM_RESTART': '1', 07:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:32 INFO - 'PWD': '/builds/slave/test', 07:15:32 INFO - 'SHELL': '/bin/bash', 07:15:32 INFO - 'SHLVL': '1', 07:15:32 INFO - 'TERM': 'linux', 07:15:32 INFO - 'TMOUT': '86400', 07:15:32 INFO - 'USER': 'cltbld', 07:15:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', 07:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:32 INFO - '_': '/tools/buildbot/bin/python'} 07:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:32 INFO - Downloading/unpacking jsonschema==2.5.1 07:15:32 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 07:15:32 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 07:15:32 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 07:15:32 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 07:15:32 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 07:15:32 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 07:15:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:34 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:34 INFO - warning: no files found matching '*.txt' 07:15:34 INFO - no previously-included directories found matching 'build' 07:15:34 INFO - no previously-included directories found matching 'dist' 07:15:34 INFO - no previously-included directories found matching '.git*' 07:15:34 INFO - Installing collected packages: jsonschema, functools32 07:15:34 INFO - Running setup.py install for functools32 07:15:34 INFO - warning: no files found matching '*.txt' 07:15:34 INFO - no previously-included directories found matching 'build' 07:15:34 INFO - no previously-included directories found matching 'dist' 07:15:34 INFO - no previously-included directories found matching '.git*' 07:15:34 INFO - Successfully installed jsonschema functools32 07:15:34 INFO - Cleaning up... 07:15:35 INFO - Return code: 0 07:15:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:35 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 0x7f260ac9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c1c0>, '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 0x1a4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d550>, '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': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', '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 07:15:35 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 07:15:35 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 07:15:35 INFO - Using env: {'DISPLAY': ':0', 07:15:35 INFO - 'HOME': '/home/cltbld', 07:15:35 INFO - 'LANG': 'en_US.UTF-8', 07:15:35 INFO - 'LANGUAGE': 'en_US:en', 07:15:35 INFO - 'LOGNAME': 'cltbld', 07:15:35 INFO - 'MAIL': '/var/mail/cltbld', 07:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:35 INFO - 'MOZ_NO_REMOTE': '1', 07:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:35 INFO - 'NO_EM_RESTART': '1', 07:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:35 INFO - 'PWD': '/builds/slave/test', 07:15:35 INFO - 'SHELL': '/bin/bash', 07:15:35 INFO - 'SHLVL': '1', 07:15:35 INFO - 'TERM': 'linux', 07:15:35 INFO - 'TMOUT': '86400', 07:15:35 INFO - 'USER': 'cltbld', 07:15:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', 07:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:35 INFO - '_': '/tools/buildbot/bin/python'} 07:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:35 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:35 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 07:15:35 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 07:15:35 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 07:15:35 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 07:15:35 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 07:15:35 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 07:15:37 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:38 INFO - Downloading docopt-0.6.1.tar.gz 07:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:38 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:38 INFO - Running setup.py install for blobuploader 07:15:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:38 INFO - Running setup.py install for requests 07:15:38 INFO - Running setup.py install for docopt 07:15:38 INFO - Successfully installed blobuploader requests docopt 07:15:38 INFO - Cleaning up... 07:15:38 INFO - Return code: 0 07:15:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:38 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 0x7f260ac9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c1c0>, '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 0x1a4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d550>, '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': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', '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 07:15:38 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 07:15:38 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 07:15:38 INFO - Using env: {'DISPLAY': ':0', 07:15:38 INFO - 'HOME': '/home/cltbld', 07:15:38 INFO - 'LANG': 'en_US.UTF-8', 07:15:38 INFO - 'LANGUAGE': 'en_US:en', 07:15:38 INFO - 'LOGNAME': 'cltbld', 07:15:38 INFO - 'MAIL': '/var/mail/cltbld', 07:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:38 INFO - 'MOZ_NO_REMOTE': '1', 07:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:38 INFO - 'NO_EM_RESTART': '1', 07:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:38 INFO - 'PWD': '/builds/slave/test', 07:15:38 INFO - 'SHELL': '/bin/bash', 07:15:38 INFO - 'SHLVL': '1', 07:15:38 INFO - 'TERM': 'linux', 07:15:38 INFO - 'TMOUT': '86400', 07:15:38 INFO - 'USER': 'cltbld', 07:15:38 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', 07:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:38 INFO - '_': '/tools/buildbot/bin/python'} 07:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:38 INFO - Running setup.py (path:/tmp/pip-mkMhNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:38 INFO - Running setup.py (path:/tmp/pip-VufXrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:39 INFO - Running setup.py (path:/tmp/pip-oMys2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:39 INFO - Running setup.py (path:/tmp/pip-qHeDz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:39 INFO - Running setup.py (path:/tmp/pip-lDq0ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:39 INFO - Running setup.py (path:/tmp/pip-z5poqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:39 INFO - Running setup.py (path:/tmp/pip-RCGmJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:39 INFO - Running setup.py (path:/tmp/pip-wCOK9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:39 INFO - Running setup.py (path:/tmp/pip-mxQfac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:39 INFO - Running setup.py (path:/tmp/pip-a3OqFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:39 INFO - Running setup.py (path:/tmp/pip-QIlFWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:39 INFO - Running setup.py (path:/tmp/pip-rgywr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:39 INFO - Running setup.py (path:/tmp/pip-cqWcWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:39 INFO - Running setup.py (path:/tmp/pip-ow9fxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:39 INFO - Running setup.py (path:/tmp/pip-LaY3tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:40 INFO - Running setup.py (path:/tmp/pip-qdgyLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:40 INFO - Running setup.py (path:/tmp/pip-QEEk_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:40 INFO - Running setup.py install for manifestparser 07:15:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:40 INFO - Running setup.py install for mozcrash 07:15:40 INFO - Running setup.py install for mozdebug 07:15:40 INFO - Running setup.py install for mozdevice 07:15:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:40 INFO - Running setup.py install for mozfile 07:15:40 INFO - Running setup.py install for mozhttpd 07:15:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:40 INFO - Running setup.py install for mozinfo 07:15:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:40 INFO - Running setup.py install for mozInstall 07:15:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:40 INFO - Running setup.py install for mozleak 07:15:41 INFO - Running setup.py install for mozlog 07:15:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:41 INFO - Running setup.py install for moznetwork 07:15:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:41 INFO - Running setup.py install for mozprocess 07:15:41 INFO - Running setup.py install for mozprofile 07:15:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:41 INFO - Running setup.py install for mozrunner 07:15:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:41 INFO - Running setup.py install for mozscreenshot 07:15:41 INFO - Running setup.py install for moztest 07:15:41 INFO - Running setup.py install for mozversion 07:15:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:41 INFO - Cleaning up... 07:15:41 INFO - Return code: 0 07:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:41 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 0x7f260ac9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c1c0>, '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 0x1a4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d550>, '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': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', '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 07:15:41 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 07:15:41 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 07:15:41 INFO - Using env: {'DISPLAY': ':0', 07:15:41 INFO - 'HOME': '/home/cltbld', 07:15:41 INFO - 'LANG': 'en_US.UTF-8', 07:15:41 INFO - 'LANGUAGE': 'en_US:en', 07:15:41 INFO - 'LOGNAME': 'cltbld', 07:15:41 INFO - 'MAIL': '/var/mail/cltbld', 07:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:41 INFO - 'MOZ_NO_REMOTE': '1', 07:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:41 INFO - 'NO_EM_RESTART': '1', 07:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:41 INFO - 'PWD': '/builds/slave/test', 07:15:41 INFO - 'SHELL': '/bin/bash', 07:15:41 INFO - 'SHLVL': '1', 07:15:41 INFO - 'TERM': 'linux', 07:15:41 INFO - 'TMOUT': '86400', 07:15:41 INFO - 'USER': 'cltbld', 07:15:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', 07:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:41 INFO - '_': '/tools/buildbot/bin/python'} 07:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:42 INFO - Running setup.py (path:/tmp/pip-wq6pQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:42 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)) 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:42 INFO - Running setup.py (path:/tmp/pip-OYvgiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:42 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)) 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:42 INFO - Running setup.py (path:/tmp/pip-TqdBMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:42 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)) 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:42 INFO - Running setup.py (path:/tmp/pip-Vlvynq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:42 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)) 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:42 INFO - Running setup.py (path:/tmp/pip-CoFE1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:42 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)) 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:42 INFO - Running setup.py (path:/tmp/pip-alhKq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:42 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)) 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:42 INFO - Running setup.py (path:/tmp/pip-5arcuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:42 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)) 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:42 INFO - Running setup.py (path:/tmp/pip-ADJcHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:42 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)) 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:42 INFO - Running setup.py (path:/tmp/pip-fhqeB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:42 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)) 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:42 INFO - Running setup.py (path:/tmp/pip-g8J4us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:42 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)) 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:42 INFO - Running setup.py (path:/tmp/pip-unla_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:42 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)) 07:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:42 INFO - Running setup.py (path:/tmp/pip-Cz56vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:43 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)) 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:43 INFO - Running setup.py (path:/tmp/pip-lnP3TH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:43 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)) 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:43 INFO - Running setup.py (path:/tmp/pip-JLiLvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:43 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)) 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:43 INFO - Running setup.py (path:/tmp/pip-oTJTnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:43 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)) 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:43 INFO - Running setup.py (path:/tmp/pip-Zw8Ski-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:43 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)) 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:43 INFO - Running setup.py (path:/tmp/pip-b4cUrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:43 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)) 07:15:43 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)) 07:15:43 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)) 07:15:43 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)) 07:15:43 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)) 07:15:43 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)) 07:15:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:45 INFO - Downloading blessings-1.6.tar.gz 07:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:45 INFO - Installing collected packages: blessings 07:15:45 INFO - Running setup.py install for blessings 07:15:45 INFO - Successfully installed blessings 07:15:45 INFO - Cleaning up... 07:15:45 INFO - Return code: 0 07:15:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:45 INFO - Reading from file tmpfile_stdout 07:15:45 INFO - Current package versions: 07:15:45 INFO - argparse == 1.2.1 07:15:45 INFO - blessings == 1.6 07:15:45 INFO - blobuploader == 1.2.4 07:15:45 INFO - docopt == 0.6.1 07:15:45 INFO - functools32 == 3.2.3-2 07:15:45 INFO - jsonschema == 2.5.1 07:15:45 INFO - manifestparser == 1.1 07:15:45 INFO - mozInstall == 1.12 07:15:45 INFO - mozcrash == 0.17 07:15:45 INFO - mozdebug == 0.1 07:15:45 INFO - mozdevice == 0.48 07:15:45 INFO - mozfile == 1.2 07:15:45 INFO - mozhttpd == 0.7 07:15:45 INFO - mozinfo == 0.9 07:15:45 INFO - mozleak == 0.1 07:15:45 INFO - mozlog == 3.2 07:15:45 INFO - moznetwork == 0.27 07:15:45 INFO - mozprocess == 0.22 07:15:45 INFO - mozprofile == 0.28 07:15:45 INFO - mozrunner == 6.11 07:15:45 INFO - mozscreenshot == 0.1 07:15:45 INFO - mozsystemmonitor == 0.3 07:15:45 INFO - moztest == 0.7 07:15:45 INFO - mozversion == 1.4 07:15:45 INFO - psutil == 3.1.1 07:15:45 INFO - requests == 1.2.3 07:15:45 INFO - wsgiref == 0.1.2 07:15:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:45 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 0x7f260ac9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c1c0>, '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 0x1a4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d550>, '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': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', '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 07:15:45 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 07:15:45 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 07:15:45 INFO - Using env: {'DISPLAY': ':0', 07:15:45 INFO - 'HOME': '/home/cltbld', 07:15:45 INFO - 'LANG': 'en_US.UTF-8', 07:15:45 INFO - 'LANGUAGE': 'en_US:en', 07:15:45 INFO - 'LOGNAME': 'cltbld', 07:15:45 INFO - 'MAIL': '/var/mail/cltbld', 07:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:45 INFO - 'MOZ_NO_REMOTE': '1', 07:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:45 INFO - 'NO_EM_RESTART': '1', 07:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:45 INFO - 'PWD': '/builds/slave/test', 07:15:45 INFO - 'SHELL': '/bin/bash', 07:15:45 INFO - 'SHLVL': '1', 07:15:45 INFO - 'TERM': 'linux', 07:15:45 INFO - 'TMOUT': '86400', 07:15:45 INFO - 'USER': 'cltbld', 07:15:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', 07:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:45 INFO - '_': '/tools/buildbot/bin/python'} 07:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:45 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)) 07:15:45 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)) 07:15:45 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)) 07:15:45 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)) 07:15:45 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)) 07:15:45 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)) 07:15:45 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)) 07:15:45 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)) 07:15:45 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)) 07:15:45 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)) 07:15:45 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)) 07:15:45 INFO - Cleaning up... 07:15:46 INFO - Return code: 0 07:15:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:46 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 0x7f260ac9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c1c0>, '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 0x1a4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d550>, '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': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', '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 07:15:46 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 07:15:46 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 07:15:46 INFO - Using env: {'DISPLAY': ':0', 07:15:46 INFO - 'HOME': '/home/cltbld', 07:15:46 INFO - 'LANG': 'en_US.UTF-8', 07:15:46 INFO - 'LANGUAGE': 'en_US:en', 07:15:46 INFO - 'LOGNAME': 'cltbld', 07:15:46 INFO - 'MAIL': '/var/mail/cltbld', 07:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:46 INFO - 'MOZ_NO_REMOTE': '1', 07:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:46 INFO - 'NO_EM_RESTART': '1', 07:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:46 INFO - 'PWD': '/builds/slave/test', 07:15:46 INFO - 'SHELL': '/bin/bash', 07:15:46 INFO - 'SHLVL': '1', 07:15:46 INFO - 'TERM': 'linux', 07:15:46 INFO - 'TMOUT': '86400', 07:15:46 INFO - 'USER': 'cltbld', 07:15:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', 07:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:46 INFO - '_': '/tools/buildbot/bin/python'} 07:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:15:46 INFO - Cleaning up... 07:15:46 INFO - Return code: 0 07:15:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:46 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 0x7f260ac9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c1c0>, '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 0x1a4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d550>, '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': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', '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 07:15:46 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 07:15:46 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 07:15:46 INFO - Using env: {'DISPLAY': ':0', 07:15:46 INFO - 'HOME': '/home/cltbld', 07:15:46 INFO - 'LANG': 'en_US.UTF-8', 07:15:46 INFO - 'LANGUAGE': 'en_US:en', 07:15:46 INFO - 'LOGNAME': 'cltbld', 07:15:46 INFO - 'MAIL': '/var/mail/cltbld', 07:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:46 INFO - 'MOZ_NO_REMOTE': '1', 07:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:46 INFO - 'NO_EM_RESTART': '1', 07:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:46 INFO - 'PWD': '/builds/slave/test', 07:15:46 INFO - 'SHELL': '/bin/bash', 07:15:46 INFO - 'SHLVL': '1', 07:15:46 INFO - 'TERM': 'linux', 07:15:46 INFO - 'TMOUT': '86400', 07:15:46 INFO - 'USER': 'cltbld', 07:15:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', 07:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:46 INFO - '_': '/tools/buildbot/bin/python'} 07:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:46 INFO - Downloading/unpacking flake8 07:15:46 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 07:15:46 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 07:15:46 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 07:15:46 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 07:15:46 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 07:15:46 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 07:15:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:15:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:15:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 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 07:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:49 INFO - no previously-included directories found matching 'docs/_build' 07:15:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:15:49 INFO - Running setup.py install for pep8 07:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:49 INFO - no previously-included directories found matching 'docs/_build' 07:15:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:15:49 INFO - Cleaning up... 07:15:49 INFO - Return code: 0 07:15:49 INFO - Running post-action listener: _resource_record_post_action 07:15:49 INFO - Running post-action listener: _start_resource_monitoring 07:15:49 INFO - Starting resource monitoring. 07:15:49 INFO - ##### 07:15:49 INFO - ##### Finished create-virtualenv step (success) 07:15:49 INFO - ##### 07:15:49 INFO - ##### 07:15:49 INFO - ##### Running install step. 07:15:49 INFO - ##### 07:15:49 INFO - Running pre-action listener: _resource_record_pre_action 07:15:49 INFO - Running main action method: install 07:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:49 INFO - Reading from file tmpfile_stdout 07:15:49 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:15:49 INFO - Reading from file tmpfile_stdout 07:15:49 INFO - Output received: 07:15:49 INFO - Usage: mozinstall [options] installer 07:15:49 INFO - Options: 07:15:49 INFO - -h, --help show this help message and exit 07:15:49 INFO - -d DEST, --destination=DEST 07:15:49 INFO - Directory to install application into. [default: 07:15:49 INFO - "/builds/slave/test"] 07:15:49 INFO - --app=APP Application being installed. [default: firefox] 07:15:49 INFO - mkdir: /builds/slave/test/build/application 07:15:49 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'] 07:15:49 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 07:16:05 INFO - Reading from file tmpfile_stdout 07:16:05 INFO - Output received: 07:16:05 INFO - /builds/slave/test/build/application/firefox/firefox 07:16:05 INFO - Running post-action listener: _resource_record_post_action 07:16:05 INFO - ##### 07:16:05 INFO - ##### Finished install step (success) 07:16:05 INFO - ##### 07:16:05 INFO - ##### 07:16:05 INFO - ##### Running run-tests step. 07:16:05 INFO - ##### 07:16:05 INFO - Running pre-action listener: _resource_record_pre_action 07:16:05 INFO - Running main action method: run_tests 07:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:05 INFO - Python 2.7.3 07:16:05 INFO - Return code: 0 07:16:05 INFO - grabbing minidump binary from tooltool 07:16: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')]} 07:16:05 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 0x1a4c1c0>, '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 0x1a4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16:05 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 07:16:05 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 07:16:05 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 07:16:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:06 INFO - Return code: 0 07:16:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:16:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:16:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:16:07 INFO - Return code: 0 07:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 07:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 07:16:07 INFO - Using env: {'DISPLAY': ':0', 07:16:07 INFO - 'HOME': '/home/cltbld', 07:16:07 INFO - 'LANG': 'en_US.UTF-8', 07:16:07 INFO - 'LANGUAGE': 'en_US:en', 07:16:07 INFO - 'LOGNAME': 'cltbld', 07:16:07 INFO - 'MAIL': '/var/mail/cltbld', 07:16:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:07 INFO - 'MOZ_NO_REMOTE': '1', 07:16:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:07 INFO - 'NO_EM_RESTART': '1', 07:16:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:07 INFO - 'PWD': '/builds/slave/test', 07:16:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:07 INFO - 'SHELL': '/bin/bash', 07:16:07 INFO - 'SHLVL': '1', 07:16:07 INFO - 'TERM': 'linux', 07:16:07 INFO - 'TMOUT': '86400', 07:16:07 INFO - 'USER': 'cltbld', 07:16:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466517397.778851-596258064', 07:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:07 INFO - '_': '/tools/buildbot/bin/python'} 07:16:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 07:16:07 INFO - mozversion application_buildid: 20160621064400 07:16:07 INFO - mozversion application_changeset: ecd3562339dcd51a604e82efbcb347de8b823aee 07:16:07 INFO - mozversion application_display_name: Nightly 07:16:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:07 INFO - mozversion application_name: Firefox 07:16:07 INFO - mozversion application_remotingname: firefox 07:16:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:16:07 INFO - mozversion application_vendor: Mozilla 07:16:07 INFO - mozversion application_version: 50.0a1 07:16:07 INFO - mozversion platform_buildid: 20160621064400 07:16:07 INFO - mozversion platform_changeset: ecd3562339dcd51a604e82efbcb347de8b823aee 07:16:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:16:07 INFO - mozversion platform_version: 50.0a1 07:16:07 INFO - using testdate: 1466518567 07:16:07 INFO - actual date: 1466518567 07:16:07 INFO - starting webserver on 'localhost:40758' 07:16:07 INFO - SUITE-START | Running 2 tests 07:16:07 INFO - TEST-START | dromaeo_css 07:16:07 INFO - operating with platform_type : linux_ 07:16:07 INFO - Initialising browser for dromaeo_css test... 07:16:07 INFO - TEST-INFO | started process 3401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOBQ95u/profile http://localhost:40758/getInfo.html) 07:16:13 INFO - PROCESS | 3401 | __metrics Screen width/height:1600/1200 07:16:13 INFO - PROCESS | 3401 | colorDepth:24 07:16:13 INFO - PROCESS | 3401 | Browser inner width/height: 1024/697 07:16:13 INFO - PROCESS | 3401 | __metrics 07:16:14 INFO - PROCESS | 3401 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:16:14 INFO - TEST-INFO | 3401: exit 0 07:16:14 INFO - Browser initialized. 07:16:14 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:14 INFO - TEST-INFO | started process 3483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOBQ95u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:27 INFO - PROCESS | 3483 | RSS: Main: 175480832 07:16:27 INFO - PROCESS | 3483 | 07:17:18 INFO - PROCESS | 3483 | 1466518638097 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] 07:19:31 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:40758/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40758/tests/dromaeo/cssquery-ext.html) 07:19:32 INFO - PROCESS | 3483 | RSS: Main: 296292352 07:19:32 INFO - PROCESS | 3483 | 07:22:35 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:40758/tests/dromaeo/cssquery-ext.html (next: http://localhost:40758/tests/dromaeo/cssquery-jquery.html) 07:22:35 INFO - PROCESS | 3483 | RSS: Main: 256659456 07:22:35 INFO - PROCESS | 3483 | 07:25:37 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:40758/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40758/tests/dromaeo/cssquery-mootools.html) 07:25:38 INFO - PROCESS | 3483 | RSS: Main: 256294912 07:25:38 INFO - PROCESS | 3483 | 07:28:40 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:40758/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40758/tests/dromaeo/cssquery-prototype.html) 07:28:41 INFO - PROCESS | 3483 | RSS: Main: 248729600 07:28:41 INFO - PROCESS | 3483 | 07:31:44 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:40758/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40758/tests/dromaeo/cssquery-yui.html) 07:31:45 INFO - PROCESS | 3483 | RSS: Main: 239800320 07:31:45 INFO - PROCESS | 3483 | 07:34:47 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:40758/tests/dromaeo/cssquery-yui.html (next: http://localhost:40758/tests/dromaeo/cssquery-dojo.html) 07:34:48 INFO - PROCESS | 3483 | RSS: Main: 300331008 07:34:48 INFO - PROCESS | 3483 | 07:34:48 INFO - PROCESS | 3483 | __start_tp_report 07:34:48 INFO - PROCESS | 3483 | _x_x_mozilla_page_load 07:34:48 INFO - PROCESS | 3483 | _x_x_mozilla_page_load_details 07:34:48 INFO - PROCESS | 3483 | |i|pagename|runs| 07:34:48 INFO - PROCESS | 3483 | |0;dojo.html;2619.58086706127;2633.3021749236445;2640.273924670715;2657.548216803143;2662.6671666041743;4603.769811509428;4709.45841228258;4737.881552961174;4815.807367705292;4870.318155458234;4742.644301677379;4743.952560474394;4785.18651829189;4844.61243100552;4848.878778030542;4161.334186530155;4293.613574778269;4372.431583894089;4400.911981760363;4520.660950428714;4431.468223813147;4467.218236808561;4478.596926276635;4483.3723278741;4517.525659805722;4299.204647140289;4326.935095973563;4354.085642015149;4425.247707889666;4427.867163985085;4313.698041137121;4328.675349348811;4331.047169622678;4366.6070053695;4388.7147335423415;4346.913061738779;4359.651227901761;4365.519792822819;4402.7578483183415;4404.207242696313;4693.530646935314;4740.881477963078;4782.33047373368;4809.975950120262;4811.639127065484;5161.845144645667;5188.610854185951;5191.6625419348;5201.349831271091;5214.113600687892;5159.690418574897;5193.298904647862;5196.740162991835;5197.038547868657;5197.376314842205;4637.350770892078;4758.95241047592;4826.95173048272;4828.324034635154;4885.291632713308;5336.386315573759;5363.19552067193;5364.517193452608;5364.91952620711;5374.543163831118;4836.540528649773;5131.948680513147;5142.742862856842;5142.897142057138;5145.202493613496;5006.549410553068;5054.570361519239;5060.367454068241;5069.264956581349;5083.466236045236;5021.121303771898;5031.069252188284;5037.345145131109;5043.571296439771;5087;4843.660943733905;4996.050750357421;5016.423111342169;5030.346055012825;5032.47159048302;4294.828206871753;4307.461567304087;4328.632066274339;4369.08249267651;4370.104128653618;3751.493548370935;3763.0780458787226;3770.8868733938025;3787.280416720814;3794.0704527390967;4262.808173632194;4310.008697999415;4401.603855652943;4440.111977604492;4447.933281000787;5108.029474399852;5112.821051263262;5132.486751324912;5172.818951336685;5184.092783762826;4411.029573493826;4418.270985287391;4420.425344705232;4421.801018954155;4465.821367145343;4624.491305956342;4625.283081122431;4632.930506042412;4635.096156249567;4676.742779147112;4722.24444088951;4777.4505931818285;4835.516448355136;4843.588294994965;4858.975705121593;5190.636655434235;5194.506521880416;5195.220716892496;5202.765875535534;5214.113600687816;4640.721556706473;4837.540433658797;4857.271409288635;4861;4906.558409742997;5031;5045.495450454925;5083.059633967728;5089.287499750112;5095.898082038412;5141.794328226829;5156.1492353761205;5163.0190263849745;5166.844994650167;5196.220566914993;4851.902961940812;4933.1613625683;4994.450610432922;5005.524475174852;5008.899822003613;4981.352424184833;4982.626303027215;5009.949900500948;5011.24831275297;5059.620528460454;4926.458089610212;4979.925301120558;4985.825496107619;4999.475055119306;5003.249512573143;4926.802927882844;5036.471170527188;5066.08810414129;5083.415407228068;5108.310378099058;5003.974980125076;5012.6240531960975;5033.597312215087;5038.1435156022835;5055.898882022412 07:34:48 INFO - PROCESS | 3483 | |1;ext.html;541.974820753119;576.1012820000801;580.7909152705026;586.7564960541375;589.8230530840748;26833.329166770814;38127.61872381275;39110.608893911056;39200.80399597998;39230.607693923055;40199.19601607966;40635.39046914291;40660.18679626405;40666.59333406665;40725.185496290054;7548.735794247203;7706.576138312376;7724.806879827993;7738.148803631596;7908.327792137647;7729.420293477983;9762.804743905117;10094.949525252363;10098.89901100987;10397.324173928708;10070.597176112984;10149.289549731522;10225.897741022569;10227.437490937995;10246.9487652562;7543.170251272356;9884.308098433112;10059.144972677295;10129.493525323742;10139;9753.170980466668;10068.093871551522;10080;10083.294169408144;10099.29304948654;37999.24001519954;38246.80876595627;38351;38372.80813595942;38423.423648645294;3013.6383633964065;3130.311331507065;3144.6540880503353;3144.779865409422;3250.772445928786;29096.563551546744;29466.11601651954;29684.109476715515;29977.550336744967;30148.69851301481;3142.245860993368;3165.841707914595;3172.762622577197;3238.676132386766;3243.6107667079864;247003;247964;248433.7578312115;248564.78588035263;249449;31138.68861311403;31901.20246993844;32061;52860.73569632127;53238.20142697862;33659.495107573406;33770.662293377245;33804;33861.830690846386;33887.322253555285;12090.335031573348;12101.69745756363;12114.757704845853;12231.449584768707;12237.082218833444;9079.137481939206;9404.435733855991;9610.66362677317;10039.598416063276;10157.542910569042;7952.443328966917;7957.403194760416;7960.044794624682;7972.083210430875;8031.879521807177;3135.153508552678;3148.3231105312466;3154.8738050477723;3189.872405103816;3199.77601567888;825.9917400826035;903.9186473217442;911.070707877974;926.2775035472342;953.4470007395832;27145.728542714714;27974.3006424841;28019.43961120766;28076.43847123087;28162.869848209746;941.1482608239554;956.4213650741341;971.5530855806267;972.7130496503548;983.4394395194813;14650.633734156518;14954.551363459113;14978.043673942359;15055.096694198382;15081.436155853531;422672;430327;430581;430594;431482;48677.51322486801;49861;49904;49948.25077623838;50052.49947500551;1071.1591400750374;1090.7491277006334;1101.24014430043;1177.381874515886;1211.2187638972814;20672.689909651068;24123.879380602986;24285;25211.36971575652;25933.740662593133;45269;45407.7729611363;45708.542914570426;45914.770426147654;46063.76968115138;334940;337997;338388;338588;338977;21864.672029919882;22576.209832656434;23994.88002559976;24804;25294.747052529976;39059.218815624095;39526.2094758109;39597.60402395939;39828.60171398249;40180;33617;34542.65457345395;34568.48147277743;35085.824570878;35283.64716352804;34335;34557.654423455446;34566.30867382688;34923.30153396969;35031.29937401289;33908.49137262894;34759.4786078204;34787.65212347844;34838.47742283918;34895.47656785201;30621.846890765402;30657.846710767197;30902.22744431407;31295.687043129277;31508.684913150573;24138.75861241365;24626.876865616276;24634.384140396633;24760.752392475846;24944.37639059038 07:34:48 INFO - PROCESS | 3483 | |2;jquery.html;369.3186071697718;375.88159729685145;382.8143350475019;383.9001859516525;384.6403612622197;15669.45156919508;17495.912520437396;17617.55956101098;17929.193186306617;17959.730604040917;10774.191935604842;16443;17068.719846011536;17426.47720568382;17433.30266789327;4579.519150489201;4771.141194584973;4796;4810.759462026902;4820.035992801436;3398.5921689397182;3589.300086483137;4684.906301873961;6545.934540654604;7024.578525288473;6890.276520965302;7019.157701075878;7147.392471639917;7200.531965422231;7203.567785932834;7083.256258092903;7097.92902070983;7132.857342853114;7135.89296160558;7139.9286007140045;3864.942025869614;6129.325774164839;6629.834254143685;6640.236372817091;6862.073620061277;23312.76687233123;23376.883115584482;23474.530509389715;23578.17476388318;23899;2023.3727544461265;2093.874367537953;2097.8321734261376;2117.502386939068;2153.569286142778;13912.30438478072;14410.567682969528;14602.269886505632;14728.263586820724;15165.469208577646;1921.4139687395339;1958.8432925365937;1975.3185151122984;2014.1842553765748;2034.7049677796786;50121;50569.24146137811;50820.49179508194;52272;80464.99999999942;15841.762373564407;15869.761953570705;15884.60288492797;16017.439389621308;16025.679486410207;28524.572131418045;28533.286667833054;28581.714182857904;28614.856925715238;28857;8511.616977236039;8546.658133674584;8584.957075214585;8588.484690918565;8737.082606326372;6721;6758.966205168943;6894.069300644449;6955.89566156508;6998.090248267693;8260.291633768695;8418.873716894252;8499.490030598185;8576.271016963628;8631.395802293779;2718.9320266993086;3194.233383987826;3228.6932741389533;3239.72462340699;3347.3305338931823;770.8150043989515;879.612970293069;881.7266647339345;899.2985471332371;912.4570880326195;15762.842371576367;16407.1796410179;16600.169991500617;16776.916115419346;17164;418.91831092937196;840.8906842110487;889.3507739350181;895.1138373010803;900.4327273817584;5511.0080185566185;5690.032694441955;5794.82615521535;5838.620489668243;5977.820665380045;374259;379047;380547;386589;391061;72832.35260297699;78263;78599;78763.21236787674;79485.03862210242;428.8156092880029;431.8207943703328;436.2322312729619;436.44353449351695;437.3876572798108;9966.850497242402;10152.644657436955;10321.380717156995;10471.795743489596;10513.316634418738;36245;36941.815290923376;36972.63027369799;37068.44397334096;37987;50143.498565013884;53448;53896.46103538915;54066;54076.18885716796;7628.084629844454;7728.8454230916195;7763.223677632417;7782.844343112993;7874.56689882062;6983.476239281973;8595.484270943763;10648.787024259627;11362.886371136183;11876.287422754662;9952.55213515379;10184.23618228621;10293.845592316271;10443.425611591436;10520.10579100785;8256.917430825855;10324.638637647646;10368.377897326185;10542.209334300112;10637.468126593794;10325.586976520855;10517.526711297856;10611.787764244826;10697;10749.462526873469;7599;7812.804679883048;7867.291943725092;7927.286544211049;8014.679412823421;7823.374130069695;9492.57283422234;9921.65274215399;10082.747931301483;10487.737806554896 07:34:48 INFO - PROCESS | 3483 | |3;mootools.html;1201.2852352850061;1380.0339762166486;1425.059460755901;1499.4976682811257;1676.6898123847088;6764.661766911653;7714.074311082671;7948.7217947371855;7971.163027882076;8222.95888520558;7926.722564710236;8081.39389545785;8087.9595602022055;8106.797330066736;8106.797330066751;1869.0934896575218;2151.7202763640703;2232.787885150908;2237.5077482953766;2271.954560908781;2268.0360846640197;2289.3933107726466;2291;2296.5866144094057;2300.068472268734;2215.3907675389237;2224.5662095891307;2252.538229662915;2254.7519772824976;2255.12050300383;1816.1645643004233;2086.1968142265187;2159.2010955946243;2160.0387827416807;2201.9559608807813;2178.880161591112;2190.507135894411;2195.078067211775;2197.648376259807;2198.4613769626385;8000.279974802237;8057.919420805775;8071.152528984489;8076.273135417782;8079.434439589231;4663.44038715353;4784.569388755029;4790.089882922233;4792.832250871237;4798.208295631217;2913.980106962546;3064.341166649181;3178.904632861018;3203.2792621660174;3216.131644455984;967.9128878400978;975.7414285214423;981.7349315684725;989.6140505202976;990.321629683669;10987.121030317556;11028.558857645765;11035;11090.667279981613;11106.44467776608;4270.380794784739;4301.376300436482;4372.409724687126;4473;4476.888077798081;8753;8783.604737786814;8829.646814127364;8830.116988301119;8844.115588441104;4733.384659994179;4775.880602984884;4776.641751868624;4781.95218047822;4782.880427989328;3657.0674478007936;4280.636145927631;4390.143921935192;4390.253656878338;4473.910521789611;3397.1846756778195;3477.1307173206696;3483.1292176955762;3497.370473314828;3606.6032736398975;993.3046867192994;1014.3609525998721;1014.8579198912158;1022.2741853284103;1026.7279171019536;865.2731705367521;873.4453621949981;883.1212943121507;884.3058199313508;916.3631276263067;5389.946100539023;5461.726913654302;5559.499645031886;5572.693501857437;5698.230738850202;854.7350321400386;896.3904544909524;914.2229105260475;935.6210734652477;960.5389413081621;3534.6111927687934;3556.897361817793;3760.699144068468;3813.580506144322;3818.522684664417;9639.662611808693;9799.853002204973;10099.495025248709;10123.291369604058;10143.08712215904;9960.651377201762;10009.349392289478;10039;10041.949790251148;10085.798284034277;7069.9646501767165;7215.134183897966;7352.963235183897;7354.521956072945;7374.26257374269;5632.802851900164;5638.154276858504;5691;5848.795292164924;5878.470937615635;8923.375363724477;9221.262299015929;9228.723138305862;9239;9265.53672316395;8766.21104100634;9109.134632209929;9249.075092490966;9289.303302252494;9309.162175404246;6144.754209831735;6671.532992690465;6899.586024838526;6920.377166055079;7094.787156385317;7776.572288524186;7802.726904558313;7844.6077696113825;7860.135385107519;7870.331021862977;6782.762603308861;6797.320267973163;6973.7210511581;7051;7067;6801.387875091265;6884.586924784529;6951.200611929693;6956.200036995608;6992;6179.721912513858;6181.84545386369;6216.502679785516;6228.968855155696;6242.625442473466;4792.305115758265;4802.567768900815;4828.058528587032;4867.977724677858;4900.068986892479;4405.933910991402;4645.512221216723;4672.976635116803;4747.501512341292;4821.011692602938 07:34:48 INFO - PROCESS | 3483 | |4;prototype.html;311.1676265988481;317.6664502272613;318.04586241276155;318.0569611103079;319.9072269041977;4899.142650036243;4907.950920490794;4926.38901382268;4969.652124351297;4971.154903666372;4779.976100119503;4794;4820.879478013051;4849.975750121244;4879.316895634614;3607.2244467439496;3740.5511338639403;3754.2303827715255;3767.717421193408;3771.7548359356556;3505.8772942947003;3705.2589482103554;3776.3580191367396;3777.9811100944457;3843.3082045231845;3781.1870447853707;3822.273767984088;3826.923461530768;3827.9234415311676;3838.5777564467885;3805.334066538345;3818.8281527331337;3821.9426708599394;3831.080540670233;3843.942340864889;3205.8557364918634;3276;3386.4581666933173;3413.8805141820167;3446.724262059029;4750.382450281476;4765.117104152007;4766.904661906742;4771.427428708577;4777.378940737716;4395.362672412482;4397.1205758848355;4397.934030989538;4414.448193975753;4417.425734654506;4914.901701965977;5073.441921388644;5085.542301192873;5092.065015294164;5105.957616953211;3716.2195938852874;3722.7021838253145;3730.123420996064;3733.9813300933592;3745.550533935918;5019.397672279313;5203.505666961632;5315.123004704219;5344.732763361816;5390.137577987503;3835.5972622874197;3895.8052097395584;3898.766074035567;3900.551436584772;3912.960870391317;3922.5096862892137;3927.803609819555;3947;3956.3076461619676;3966.504186976628;4256.425382573313;4368.847090351823;4423.712458690239;4428.202923473741;4460.840181552755;5064.924026139611;5065.898682026339;5072.340595722532;5082.390113186441;5102.3877134743325;1344.6436694276024;1366.3441548056987;1368.555219553649;1377.7531334142618;1379.5309594737837;833.6832003838502;871.3116637856023;882.9072947340566;896.6682327538722;904.5432056811268;3999.5200575931076;4011.939820902689;4024.91950161001;4037.29347364216;4039.313316736162;4604.240300350471;4653.627709783277;4685.554872287127;4701.694389864648;4713.95286047142;3989.6409323160474;4042.9381015682216;4043.272211001989;4049.6152865477734;4072.165206132736;2500.3874050857657;2582.2382397192873;2782.332240262363;2803.313188268887;2828.5474324108045;4924.975375123101;4943.505649435027;4952.727599982036;4982.8754281143265;4983.426905905795;5248.816291429858;5370.892582148335;5406.8918621627345;5434.755436005389;5435.864103397367;4928.630352723489;4932.284818701268;4952.257161425743;4952.47998960104;4961.156603377434;5233.319668443078;5259.263703081495;5263.736813159403;5270.183121616155;5276.683398996072;4894.975525122351;5116.74416279192;5150.459201783909;5161.225816127611;5168.131686913799;4978.925316120333;4980.925286120639;4990.226514890198;5006.374203224597;5014.398272207212;3768.3970564709516;3771.2080463103057;3783.659470647655;3792.905177370588;3817.232506432925;5155.32980712505;5383.407825139153;5385.596080294072;5388.353397592314;5397.8110766123;5152.330197074356;5165.070287348313;5170.43125256229;5176.663516871391;5190.636655434235;5161.870953226199;5165.690058596496;5213.530782229617;5218.495122341222;5236.790528378822;4949.406071271471;5122.462141475092;5135.7432128394175;5138.665986710852;5149.639525233198;5186.559142472781;5206.297149884868;5235.712035838065;5236.109861323508;5250.894982100413;5115.2071428928575;5123.282740416419;5183.766730497212;5184.559312458332;5193.792248310026 07:34:48 INFO - PROCESS | 3483 | |5;yui.html;697.403719819554;720.6432815756201;722.966158393497;740.3373980287645;752.5071078443615;12281.754364912707;13664.316784160801;13966.650833729162;14791.186484743335;14846.628834279149;14919.850801491983;14957.850421495781;15034.699306013874;15076.698466030673;15080.924595377008;609.0559632569522;768.8539177556274;796.4623878881761;799.5562462833125;802.2058162419221;782.6126067596548;788.7673136424739;788.8106854354942;789.5420656019523;790.9288164065233;825.352098602597;831.2767891934026;831.3017065664841;831.4055450352996;831.4553967151526;637.5568979559208;802.0976401548259;806.9636866341028;830.3772170871846;831.2061980808344;612.8529153003292;612.9785457508966;613.5429105316567;613.8925688004626;614.0206370838505;12422.378881056002;12501.062420318513;12540.937295313557;12579.433925473375;12606.054545909094;11925.463354149084;11987.22083064598;12335.383230838512;12345.321007344592;12591.811122833165;11741.295522268605;11891.167618266725;12045.337506437143;12118.212316199419;12427.627171184879;4096.365063415175;4103.250762478619;4158.293090174678;4289.764062976535;4297.570242975708;43730;44226.778866105466;44249;44324;44489;9497.525123743786;9850.556724947395;9923.305368624271;10006.949965250127;10175.694729158136;17113.22990465432;17158.142092895305;17180.484585462455;17197;17202.655946880994;6379.71291291893;6409.967950160312;6631.303713110054;6753.932460675429;6835.487338449636;3504.789712617251;3537.964620353815;3594.8382322795014;3625.4199328107375;3676.062604035954;2807.228012296594;2909.6072030276064;2909.709029097073;2916.7229113234207;2917.1831887071653;496.22341036278107;497.6541303793829;500.1522419498987;500.18220209956985;515.7086246270845;416.79160419790105;518.8287865004615;554.9250851135126;585.7247093865876;604.4046614085123;7715.4443563230525;7762.728304509428;8100.311473524816;8202.302804261586;8204.548749818818;478.9497102804225;510.4614631563736;535.087675513249;544.8338256831626;615.4553220399978;3628.4375921732176;3690.9077273068388;3707.4068149096015;3815.313243616176;3818.0836599215986;90153;90877.54561227151;91065;91089.7227569316;91855.54072229596;83048.58475707704;85153.57423212969;85460;85771.57114214389;87352;59853.700731496065;68906.62186756337;69326;70124.64937675279;71348.64325678338;6834.350736680008;7134.571925684268;7208.17106032792;7428.182899880901;7546.584937828472;41402.792986034874;41553.168936620496;42168;42382.36426453544;43914;57197.71401142968;61912;62825.685871572176;63847.36152638414;64307.35692643013;8969.327300452362;9073;9207.493587852732;9215.354925155174;9446.811063778823;10677.839832402366;10697.358158510515;10739.892601073889;11046.392448415414;11059.447027648746;9730.708078757649;9856.704298871045;9920.503974801375;9962.701118966443;10189.439580823126;10505.422201778976;10743.409112498888;10744;10768.784624307627;10976.176786740867;9059.320550958837;9352.275320191755;9539.666111686058;9562.904370956201;9718.902810972082;8610.225079742853;8752.562371881508;8820;9067.90932090697;9323.160915517636;8206.384521161057;8275.54484503334;8308.086110527716;8495.918499967547;8805.471671699719 07:34:48 INFO - PROCESS | 3483 | __end_tp_report 07:34:48 INFO - PROCESS | 3483 | __start_cc_report 07:34:48 INFO - PROCESS | 3483 | _x_x_mozilla_cycle_collect,1107 07:34:48 INFO - PROCESS | 3483 | __end_cc_report 07:34:48 INFO - PROCESS | 3483 | __startTimestamp1466519688126__endTimestamp 07:34:48 INFO - PROCESS | 3483 | 07:34:48 INFO - PROCESS | 3483 | ------- Summary: start ------- 07:34:48 INFO - PROCESS | 3483 | Number of tests: 6 07:34:48 INFO - PROCESS | 3483 | 07:34:48 INFO - PROCESS | 3483 | [#0] dojo.html Cycles:165 Average:4737.12 Median:4857.27 stddev:514.13 (10.6%) stddev-sans-first:488.13 07:34:48 INFO - PROCESS | 3483 | Values: 2619.6 2633.3 2640.3 2657.5 2662.7 4603.8 4709.5 4737.9 4815.8 4870.3 4742.6 4744.0 4785.2 4844.6 4848.9 4161.3 4293.6 4372.4 4400.9 4520.7 4431.5 4467.2 4478.6 4483.4 4517.5 4299.2 4326.9 4354.1 4425.2 4427.9 4313.7 4328.7 4331.0 4366.6 4388.7 4346.9 4359.7 4365.5 4402.8 4404.2 4693.5 4740.9 4782.3 4810.0 4811.6 5161.8 5188.6 5191.7 5201.3 5214.1 5159.7 5193.3 5196.7 5197.0 5197.4 4637.4 4759.0 4827.0 4828.3 4885.3 5336.4 5363.2 5364.5 5364.9 5374.5 4836.5 5131.9 5142.7 5142.9 5145.2 5006.5 5054.6 5060.4 5069.3 5083.5 5021.1 5031.1 5037.3 5043.6 5087.0 4843.7 4996.1 5016.4 5030.3 5032.5 4294.8 4307.5 4328.6 4369.1 4370.1 3751.5 3763.1 3770.9 3787.3 3794.1 4262.8 4310.0 4401.6 4440.1 4447.9 5108.0 5112.8 5132.5 5172.8 5184.1 4411.0 4418.3 4420.4 4421.8 4465.8 4624.5 4625.3 4632.9 4635.1 4676.7 4722.2 4777.5 4835.5 4843.6 4859.0 5190.6 5194.5 5195.2 5202.8 5214.1 4640.7 4837.5 4857.3 4861.0 4906.6 5031.0 5045.5 5083.1 5089.3 5095.9 5141.8 5156.1 5163.0 5166.8 5196.2 4851.9 4933.2 4994.5 5005.5 5008.9 4981.4 4982.6 5009.9 5011.2 5059.6 4926.5 4979.9 4985.8 4999.5 5003.2 4926.8 5036.5 5066.1 5083.4 5108.3 5004.0 5012.6 5033.6 5038.1 5055.9 07:34:48 INFO - PROCESS | 3483 | 07:34:48 INFO - PROCESS | 3483 | [#1] ext.html Cycles:180 Average:47481.71 Median:185900.50 stddev:91723.28 (49.3%) stddev-sans-first:91912.88 07:34:48 INFO - PROCESS | 3483 | Values: 542.0 576.1 580.8 586.8 589.8 26833.3 38127.6 39110.6 39200.8 39230.6 40199.2 40635.4 40660.2 40666.6 40725.2 7548.7 7706.6 7724.8 7738.1 7908.3 7729.4 9762.8 10094.9 10098.9 10397.3 10070.6 10149.3 10225.9 10227.4 10246.9 7543.2 9884.3 10059.1 10129.5 10139.0 9753.2 10068.1 10080.0 10083.3 10099.3 37999.2 38246.8 38351.0 38372.8 38423.4 3013.6 3130.3 3144.7 3144.8 3250.8 29096.6 29466.1 29684.1 29977.6 30148.7 3142.2 3165.8 3172.8 3238.7 3243.6 247003.0 247964.0 248433.8 248564.8 249449.0 31138.7 31901.2 32061.0 52860.7 53238.2 33659.5 33770.7 33804.0 33861.8 33887.3 12090.3 12101.7 12114.8 12231.4 12237.1 9079.1 9404.4 9610.7 10039.6 10157.5 7952.4 7957.4 7960.0 7972.1 8031.9 3135.2 3148.3 3154.9 3189.9 3199.8 826.0 903.9 911.1 926.3 953.4 27145.7 27974.3 28019.4 28076.4 28162.9 941.1 956.4 971.6 972.7 983.4 14650.6 14954.6 14978.0 15055.1 15081.4 422672.0 430327.0 430581.0 430594.0 431482.0 48677.5 49861.0 49904.0 49948.3 50052.5 1071.2 1090.7 1101.2 1177.4 1211.2 20672.7 24123.9 24285.0 25211.4 25933.7 45269.0 45407.8 45708.5 45914.8 46063.8 334940.0 337997.0 338388.0 338588.0 338977.0 21864.7 22576.2 23994.9 24804.0 25294.7 39059.2 39526.2 39597.6 39828.6 40180.0 33617.0 34542.7 34568.5 35085.8 35283.6 34335.0 34557.7 34566.3 34923.3 35031.3 33908.5 34759.5 34787.7 34838.5 34895.5 30621.8 30657.8 30902.2 31295.7 31508.7 24138.8 24626.9 24634.4 24760.8 24944.4 07:34:48 INFO - PROCESS | 3483 | 07:34:48 INFO - PROCESS | 3483 | [#2] jquery.html Cycles:180 Average:24580.95 Median:423.87 stddev:62952.75 (14852.0%) stddev-sans-first:63103.10 07:34:48 INFO - PROCESS | 3483 | Values: 369.3 375.9 382.8 383.9 384.6 15669.5 17495.9 17617.6 17929.2 17959.7 10774.2 16443.0 17068.7 17426.5 17433.3 4579.5 4771.1 4796.0 4810.8 4820.0 3398.6 3589.3 4684.9 6545.9 7024.6 6890.3 7019.2 7147.4 7200.5 7203.6 7083.3 7097.9 7132.9 7135.9 7139.9 3864.9 6129.3 6629.8 6640.2 6862.1 23312.8 23376.9 23474.5 23578.2 23899.0 2023.4 2093.9 2097.8 2117.5 2153.6 13912.3 14410.6 14602.3 14728.3 15165.5 1921.4 1958.8 1975.3 2014.2 2034.7 50121.0 50569.2 50820.5 52272.0 80465.0 15841.8 15869.8 15884.6 16017.4 16025.7 28524.6 28533.3 28581.7 28614.9 28857.0 8511.6 8546.7 8585.0 8588.5 8737.1 6721.0 6759.0 6894.1 6955.9 6998.1 8260.3 8418.9 8499.5 8576.3 8631.4 2718.9 3194.2 3228.7 3239.7 3347.3 770.8 879.6 881.7 899.3 912.5 15762.8 16407.2 16600.2 16776.9 17164.0 418.9 840.9 889.4 895.1 900.4 5511.0 5690.0 5794.8 5838.6 5977.8 374259.0 379047.0 380547.0 386589.0 391061.0 72832.4 78263.0 78599.0 78763.2 79485.0 428.8 431.8 436.2 436.4 437.4 9966.9 10152.6 10321.4 10471.8 10513.3 36245.0 36941.8 36972.6 37068.4 37987.0 50143.5 53448.0 53896.5 54066.0 54076.2 7628.1 7728.8 7763.2 7782.8 7874.6 6983.5 8595.5 10648.8 11362.9 11876.3 9952.6 10184.2 10293.8 10443.4 10520.1 8256.9 10324.6 10368.4 10542.2 10637.5 10325.6 10517.5 10611.8 10697.0 10749.5 7599.0 7812.8 7867.3 7927.3 8014.7 7823.4 9492.6 9921.7 10082.7 10487.7 07:34:48 INFO - PROCESS | 3483 | 07:34:48 INFO - PROCESS | 3483 | [#3] mootools.html Cycles:180 Average:5259.38 Median:5145.01 stddev:2954.93 (57.4%) stddev-sans-first:2947.48 07:34:48 INFO - PROCESS | 3483 | Values: 1201.3 1380.0 1425.1 1499.5 1676.7 6764.7 7714.1 7948.7 7971.2 8223.0 7926.7 8081.4 8088.0 8106.8 8106.8 1869.1 2151.7 2232.8 2237.5 2272.0 2268.0 2289.4 2291.0 2296.6 2300.1 2215.4 2224.6 2252.5 2254.8 2255.1 1816.2 2086.2 2159.2 2160.0 2202.0 2178.9 2190.5 2195.1 2197.6 2198.5 8000.3 8057.9 8071.2 8076.3 8079.4 4663.4 4784.6 4790.1 4792.8 4798.2 2914.0 3064.3 3178.9 3203.3 3216.1 967.9 975.7 981.7 989.6 990.3 10987.1 11028.6 11035.0 11090.7 11106.4 4270.4 4301.4 4372.4 4473.0 4476.9 8753.0 8783.6 8829.6 8830.1 8844.1 4733.4 4775.9 4776.6 4782.0 4782.9 3657.1 4280.6 4390.1 4390.3 4473.9 3397.2 3477.1 3483.1 3497.4 3606.6 993.3 1014.4 1014.9 1022.3 1026.7 865.3 873.4 883.1 884.3 916.4 5389.9 5461.7 5559.5 5572.7 5698.2 854.7 896.4 914.2 935.6 960.5 3534.6 3556.9 3760.7 3813.6 3818.5 9639.7 9799.9 10099.5 10123.3 10143.1 9960.7 10009.3 10039.0 10041.9 10085.8 7070.0 7215.1 7353.0 7354.5 7374.3 5632.8 5638.2 5691.0 5848.8 5878.5 8923.4 9221.3 9228.7 9239.0 9265.5 8766.2 9109.1 9249.1 9289.3 9309.2 6144.8 6671.5 6899.6 6920.4 7094.8 7776.6 7802.7 7844.6 7860.1 7870.3 6782.8 6797.3 6973.7 7051.0 7067.0 6801.4 6884.6 6951.2 6956.2 6992.0 6179.7 6181.8 6216.5 6229.0 6242.6 4792.3 4802.6 4828.1 4868.0 4900.1 4405.9 4645.5 4673.0 4747.5 4821.0 07:34:48 INFO - PROCESS | 3483 | 07:34:48 INFO - PROCESS | 3483 | [#4] prototype.html Cycles:180 Average:4231.08 Median:4786.99 stddev:1226.06 (25.6%) stddev-sans-first:1193.68 07:34:48 INFO - PROCESS | 3483 | Values: 311.2 317.7 318.0 318.1 319.9 4899.1 4908.0 4926.4 4969.7 4971.2 4780.0 4794.0 4820.9 4850.0 4879.3 3607.2 3740.6 3754.2 3767.7 3771.8 3505.9 3705.3 3776.4 3778.0 3843.3 3781.2 3822.3 3826.9 3827.9 3838.6 3805.3 3818.8 3821.9 3831.1 3843.9 3205.9 3276.0 3386.5 3413.9 3446.7 4750.4 4765.1 4766.9 4771.4 4777.4 4395.4 4397.1 4397.9 4414.4 4417.4 4914.9 5073.4 5085.5 5092.1 5106.0 3716.2 3722.7 3730.1 3734.0 3745.6 5019.4 5203.5 5315.1 5344.7 5390.1 3835.6 3895.8 3898.8 3900.6 3913.0 3922.5 3927.8 3947.0 3956.3 3966.5 4256.4 4368.8 4423.7 4428.2 4460.8 5064.9 5065.9 5072.3 5082.4 5102.4 1344.6 1366.3 1368.6 1377.8 1379.5 833.7 871.3 882.9 896.7 904.5 3999.5 4011.9 4024.9 4037.3 4039.3 4604.2 4653.6 4685.6 4701.7 4714.0 3989.6 4042.9 4043.3 4049.6 4072.2 2500.4 2582.2 2782.3 2803.3 2828.5 4925.0 4943.5 4952.7 4982.9 4983.4 5248.8 5370.9 5406.9 5434.8 5435.9 4928.6 4932.3 4952.3 4952.5 4961.2 5233.3 5259.3 5263.7 5270.2 5276.7 4895.0 5116.7 5150.5 5161.2 5168.1 4978.9 4980.9 4990.2 5006.4 5014.4 3768.4 3771.2 3783.7 3792.9 3817.2 5155.3 5383.4 5385.6 5388.4 5397.8 5152.3 5165.1 5170.4 5176.7 5190.6 5161.9 5165.7 5213.5 5218.5 5236.8 4949.4 5122.5 5135.7 5138.7 5149.6 5186.6 5206.3 5235.7 5236.1 5250.9 5115.2 5123.3 5183.8 5184.6 5193.8 07:34:48 INFO - PROCESS | 3483 | 07:34:48 INFO - PROCESS | 3483 | [#5] yui.html Cycles:180 Average:16537.97 Median:612.92 stddev:23686.80 (3864.6%) stddev-sans-first:23723.38 07:34:48 INFO - PROCESS | 3483 | Values: 697.4 720.6 723.0 740.3 752.5 12281.8 13664.3 13966.7 14791.2 14846.6 14919.9 14957.9 15034.7 15076.7 15080.9 609.1 768.9 796.5 799.6 802.2 782.6 788.8 788.8 789.5 790.9 825.4 831.3 831.3 831.4 831.5 637.6 802.1 807.0 830.4 831.2 612.9 613.0 613.5 613.9 614.0 12422.4 12501.1 12540.9 12579.4 12606.1 11925.5 11987.2 12335.4 12345.3 12591.8 11741.3 11891.2 12045.3 12118.2 12427.6 4096.4 4103.3 4158.3 4289.8 4297.6 43730.0 44226.8 44249.0 44324.0 44489.0 9497.5 9850.6 9923.3 10006.9 10175.7 17113.2 17158.1 17180.5 17197.0 17202.7 6379.7 6410.0 6631.3 6753.9 6835.5 3504.8 3538.0 3594.8 3625.4 3676.1 2807.2 2909.6 2909.7 2916.7 2917.2 496.2 497.7 500.2 500.2 515.7 416.8 518.8 554.9 585.7 604.4 7715.4 7762.7 8100.3 8202.3 8204.5 478.9 510.5 535.1 544.8 615.5 3628.4 3690.9 3707.4 3815.3 3818.1 90153.0 90877.5 91065.0 91089.7 91855.5 83048.6 85153.6 85460.0 85771.6 87352.0 59853.7 68906.6 69326.0 70124.6 71348.6 6834.4 7134.6 7208.2 7428.2 7546.6 41402.8 41553.2 42168.0 42382.4 43914.0 57197.7 61912.0 62825.7 63847.4 64307.4 8969.3 9073.0 9207.5 9215.4 9446.8 10677.8 10697.4 10739.9 11046.4 11059.4 9730.7 9856.7 9920.5 9962.7 10189.4 10505.4 10743.4 10744.0 10768.8 10976.2 9059.3 9352.3 9539.7 9562.9 9718.9 8610.2 8752.6 8820.0 9067.9 9323.2 8206.4 8275.5 8308.1 8495.9 8805.5 07:34:48 INFO - PROCESS | 3483 | -------- Summary: end -------- 07:34:48 INFO - PROCESS | 3483 | 07:34:48 INFO - TEST-INFO | 3483: exit 0 07:34:48 INFO - TEST-OK | dromaeo_css | took 1121614ms 07:34:48 INFO - TEST-START | kraken 07:34:48 INFO - operating with platform_type : linux_ 07:34:48 INFO - Initialising browser for kraken test... 07:34:48 INFO - TEST-INFO | started process 3672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq1Qqxq/profile http://localhost:40758/getInfo.html) 07:34:53 INFO - PROCESS | 3672 | __metrics Screen width/height:1600/1200 07:34:53 INFO - PROCESS | 3672 | colorDepth:24 07:34:53 INFO - PROCESS | 3672 | Browser inner width/height: 1024/697 07:34:53 INFO - PROCESS | 3672 | __metrics 07:34:54 INFO - PROCESS | 3672 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:34:54 INFO - TEST-INFO | 3672: exit 0 07:34:54 INFO - Browser initialized. 07:34:54 INFO - Running cycle 1/1 for kraken test... 07:34:54 INFO - TEST-INFO | started process 3752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq1Qqxq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:07 INFO - PROCESS | 3752 | RSS: Main: 175771648 07:35:07 INFO - PROCESS | 3752 | 07:35:09 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40758/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:10 INFO - PROCESS | 3752 | RSS: Main: 232624128 07:35:10 INFO - PROCESS | 3752 | 07:35:13 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40758/tests/kraken/driver.html?testName=audio-dft) 07:35:14 INFO - PROCESS | 3752 | RSS: Main: 221872128 07:35:14 INFO - PROCESS | 3752 | 07:35:17 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40758/tests/kraken/driver.html?testName=audio-fft) 07:35:18 INFO - PROCESS | 3752 | RSS: Main: 289107968 07:35:18 INFO - PROCESS | 3752 | 07:35:20 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40758/tests/kraken/driver.html?testName=audio-oscillator) 07:35:20 INFO - PROCESS | 3752 | RSS: Main: 199065600 07:35:20 INFO - PROCESS | 3752 | 07:35:23 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40758/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:23 INFO - PROCESS | 3752 | RSS: Main: 203214848 07:35:23 INFO - PROCESS | 3752 | 07:35:26 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40758/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:27 INFO - PROCESS | 3752 | RSS: Main: 238829568 07:35:27 INFO - PROCESS | 3752 | 07:35:30 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40758/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:31 INFO - PROCESS | 3752 | RSS: Main: 234770432 07:35:31 INFO - PROCESS | 3752 | 07:35:34 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40758/tests/kraken/driver.html?testName=json-parse-financial) 07:35:35 INFO - PROCESS | 3752 | RSS: Main: 237629440 07:35:35 INFO - PROCESS | 3752 | 07:35:36 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40758/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:37 INFO - PROCESS | 3752 | RSS: Main: 226263040 07:35:37 INFO - PROCESS | 3752 | 07:35:39 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40758/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:39 INFO - PROCESS | 3752 | RSS: Main: 231923712 07:35:39 INFO - PROCESS | 3752 | 07:35:42 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40758/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:42 INFO - PROCESS | 3752 | RSS: Main: 237715456 07:35:42 INFO - PROCESS | 3752 | 07:35:45 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:46 INFO - PROCESS | 3752 | RSS: Main: 240521216 07:35:46 INFO - PROCESS | 3752 | 07:35:49 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:35:49 INFO - PROCESS | 3752 | RSS: Main: 240013312 07:35:49 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | Cycle 1(1): loaded http://localhost:40758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40758/tests/kraken/driver.html?testName=ai-astar) 07:35:51 INFO - PROCESS | 3752 | RSS: Main: 282849280 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | __start_tp_report 07:35:51 INFO - PROCESS | 3752 | _x_x_mozilla_page_load 07:35:51 INFO - PROCESS | 3752 | _x_x_mozilla_page_load_details 07:35:51 INFO - PROCESS | 3752 | |i|pagename|runs| 07:35:51 INFO - PROCESS | 3752 | |0;ai-astar;115;109;114;116;114;112;114;114;114;114 07:35:51 INFO - PROCESS | 3752 | |1;audio-beat-detection;166;141;133;180;132;143;165;131;191;132 07:35:51 INFO - PROCESS | 3752 | |2;audio-dft;160;160;160;159;159;160;162;161;160;159 07:35:51 INFO - PROCESS | 3752 | |3;audio-fft;76;77;77;133;77;77;77;76;104;77 07:35:51 INFO - PROCESS | 3752 | |4;audio-oscillator;87;86;115;87;87;86;126;85;87;125 07:35:51 INFO - PROCESS | 3752 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 07:35:51 INFO - PROCESS | 3752 | |6;imaging-darkroom;146;147;146;146;145;146;146;147;146;146 07:35:51 INFO - PROCESS | 3752 | |7;imaging-desaturate;94;95;95;96;96;96;95;96;95;96 07:35:51 INFO - PROCESS | 3752 | |8;json-parse-financial;64;66;66;64;66;66;64;65;65;65 07:35:51 INFO - PROCESS | 3752 | |9;json-stringify-tinderbox;64;65;63;64;65;65;65;64;64;65 07:35:51 INFO - PROCESS | 3752 | |10;stanford-crypto-aes;90;84;84;83;85;85;90;92;113;91 07:35:51 INFO - PROCESS | 3752 | |11;stanford-crypto-ccm;134;132;131;133;142;137;130;128;138;134 07:35:51 INFO - PROCESS | 3752 | |12;stanford-crypto-pbkdf2;170;170;169;168;167;167;165;168;168;167 07:35:51 INFO - PROCESS | 3752 | |13;stanford-crypto-sha256-iterative;68;71;68;68;68;67;69;69;72;67 07:35:51 INFO - PROCESS | 3752 | __end_tp_report 07:35:51 INFO - PROCESS | 3752 | __start_cc_report 07:35:51 INFO - PROCESS | 3752 | _x_x_mozilla_cycle_collect,1931 07:35:51 INFO - PROCESS | 3752 | __end_cc_report 07:35:51 INFO - PROCESS | 3752 | __startTimestamp1466519751822__endTimestamp 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | ------- Summary: start ------- 07:35:51 INFO - PROCESS | 3752 | Number of tests: 14 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.90 (1.7%) stddev-sans-first:1.94 07:35:51 INFO - PROCESS | 3752 | Values: 115.0 109.0 114.0 116.0 114.0 112.0 114.0 114.0 114.0 114.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:154.00 stddev:22.29 (14.5%) stddev-sans-first:23.00 07:35:51 INFO - PROCESS | 3752 | Values: 166.0 141.0 133.0 180.0 132.0 143.0 165.0 131.0 191.0 132.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 07:35:51 INFO - PROCESS | 3752 | Values: 160.0 160.0 160.0 159.0 159.0 160.0 162.0 161.0 160.0 159.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#3] audio-fft Cycles:10 Average:85.10 Median:77.00 stddev:18.89 (24.5%) stddev-sans-first:19.74 07:35:51 INFO - PROCESS | 3752 | Values: 76.0 77.0 77.0 133.0 77.0 77.0 77.0 76.0 104.0 77.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:86.50 stddev:17.43 (20.2%) stddev-sans-first:18.10 07:35:51 INFO - PROCESS | 3752 | Values: 87.0 86.0 115.0 87.0 87.0 86.0 126.0 85.0 87.0 125.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:35:51 INFO - PROCESS | 3752 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:35:51 INFO - PROCESS | 3752 | Values: 146.0 147.0 146.0 146.0 145.0 146.0 146.0 147.0 146.0 146.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 07:35:51 INFO - PROCESS | 3752 | Values: 94.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.50 stddev:0.88 (1.3%) stddev-sans-first:0.83 07:35:51 INFO - PROCESS | 3752 | Values: 64.0 66.0 66.0 64.0 66.0 66.0 64.0 65.0 65.0 65.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 07:35:51 INFO - PROCESS | 3752 | Values: 64.0 65.0 63.0 64.0 65.0 65.0 65.0 64.0 64.0 65.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:87.50 stddev:8.84 (10.1%) stddev-sans-first:9.38 07:35:51 INFO - PROCESS | 3752 | Values: 90.0 84.0 84.0 83.0 85.0 85.0 90.0 92.0 113.0 91.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:134.00 stddev:4.15 (3.1%) stddev-sans-first:4.40 07:35:51 INFO - PROCESS | 3752 | Values: 134.0 132.0 131.0 133.0 142.0 137.0 130.0 128.0 138.0 134.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:1.52 (0.9%) stddev-sans-first:1.41 07:35:51 INFO - PROCESS | 3752 | Values: 170.0 170.0 169.0 168.0 167.0 167.0 165.0 168.0 168.0 167.0 07:35:51 INFO - PROCESS | 3752 | 07:35:51 INFO - PROCESS | 3752 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:1.64 (2.4%) stddev-sans-first:1.72 07:35:51 INFO - PROCESS | 3752 | Values: 68.0 71.0 68.0 68.0 68.0 67.0 69.0 69.0 72.0 67.0 07:35:51 INFO - PROCESS | 3752 | -------- Summary: end -------- 07:35:51 INFO - PROCESS | 3752 | 07:35:52 INFO - TEST-INFO | 3752: exit 0 07:35:52 INFO - TEST-OK | kraken | took 63979ms 07:35:52 INFO - SUITE-END | took 1185s 07:35:52 INFO - Completed test suite (00:19:45) 07:35:52 INFO - javascript benchmark 07:35:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.58086706127, 2633.3021749236445, 2640.273924670715, 2657.548216803143, 2662.6671666041743, 4603.769811509428, 4709.45841228258, 4737.881552961174, 4815.807367705292, 4870.318155458234, 4742.644301677379, 4743.952560474394, 4785.18651829189, 4844.61243100552, 4848.878778030542, 4161.334186530155, 4293.613574778269, 4372.431583894089, 4400.911981760363, 4520.660950428714, 4431.468223813147, 4467.218236808561, 4478.596926276635, 4483.3723278741, 4517.525659805722, 4299.204647140289, 4326.935095973563, 4354.085642015149, 4425.247707889666, 4427.867163985085, 4313.698041137121, 4328.675349348811, 4331.047169622678, 4366.6070053695, 4388.7147335423415, 4346.913061738779, 4359.651227901761, 4365.519792822819, 4402.7578483183415, 4404.207242696313, 4693.530646935314, 4740.881477963078, 4782.33047373368, 4809.975950120262, 4811.639127065484, 5161.845144645667, 5188.610854185951, 5191.6625419348, 5201.349831271091, 5214.113600687892, 5159.690418574897, 5193.298904647862, 5196.740162991835, 5197.038547868657, 5197.376314842205, 4637.350770892078, 4758.95241047592, 4826.95173048272, 4828.324034635154, 4885.291632713308, 5336.386315573759, 5363.19552067193, 5364.517193452608, 5364.91952620711, 5374.543163831118, 4836.540528649773, 5131.948680513147, 5142.742862856842, 5142.897142057138, 5145.202493613496, 5006.549410553068, 5054.570361519239, 5060.367454068241, 5069.264956581349, 5083.466236045236, 5021.121303771898, 5031.069252188284, 5037.345145131109, 5043.571296439771, 5087.0, 4843.660943733905, 4996.050750357421, 5016.423111342169, 5030.346055012825, 5032.47159048302, 4294.828206871753, 4307.461567304087, 4328.632066274339, 4369.08249267651, 4370.104128653618, 3751.493548370935, 3763.0780458787226, 3770.8868733938025, 3787.280416720814, 3794.0704527390967, 4262.808173632194, 4310.008697999415, 4401.603855652943, 4440.111977604492, 4447.933281000787, 5108.029474399852, 5112.821051263262, 5132.486751324912, 5172.818951336685, 5184.092783762826, 4411.029573493826, 4418.270985287391, 4420.425344705232, 4421.801018954155, 4465.821367145343, 4624.491305956342, 4625.283081122431, 4632.930506042412, 4635.096156249567, 4676.742779147112, 4722.24444088951, 4777.4505931818285, 4835.516448355136, 4843.588294994965, 4858.975705121593, 5190.636655434235, 5194.506521880416, 5195.220716892496, 5202.765875535534, 5214.113600687816, 4640.721556706473, 4837.540433658797, 4857.271409288635, 4861.0, 4906.558409742997, 5031.0, 5045.495450454925, 5083.059633967728, 5089.287499750112, 5095.898082038412, 5141.794328226829, 5156.1492353761205, 5163.0190263849745, 5166.844994650167, 5196.220566914993, 4851.902961940812, 4933.1613625683, 4994.450610432922, 5005.524475174852, 5008.899822003613, 4981.352424184833, 4982.626303027215, 5009.949900500948, 5011.24831275297, 5059.620528460454, 4926.458089610212, 4979.925301120558, 4985.825496107619, 4999.475055119306, 5003.249512573143, 4926.802927882844, 5036.471170527188, 5066.08810414129, 5083.415407228068, 5108.310378099058, 5003.974980125076, 5012.6240531960975, 5033.597312215087, 5038.1435156022835, 5055.898882022412], "value": 4703.259778283264, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.974820753119, 576.1012820000801, 580.7909152705026, 586.7564960541375, 589.8230530840748, 26833.329166770814, 38127.61872381275, 39110.608893911056, 39200.80399597998, 39230.607693923055, 40199.19601607966, 40635.39046914291, 40660.18679626405, 40666.59333406665, 40725.185496290054, 7548.735794247203, 7706.576138312376, 7724.806879827993, 7738.148803631596, 7908.327792137647, 7729.420293477983, 9762.804743905117, 10094.949525252363, 10098.89901100987, 10397.324173928708, 10070.597176112984, 10149.289549731522, 10225.897741022569, 10227.437490937995, 10246.9487652562, 7543.170251272356, 9884.308098433112, 10059.144972677295, 10129.493525323742, 10139.0, 9753.170980466668, 10068.093871551522, 10080.0, 10083.294169408144, 10099.29304948654, 37999.24001519954, 38246.80876595627, 38351.0, 38372.80813595942, 38423.423648645294, 3013.6383633964065, 3130.311331507065, 3144.6540880503353, 3144.779865409422, 3250.772445928786, 29096.563551546744, 29466.11601651954, 29684.109476715515, 29977.550336744967, 30148.69851301481, 3142.245860993368, 3165.841707914595, 3172.762622577197, 3238.676132386766, 3243.6107667079864, 247003.0, 247964.0, 248433.7578312115, 248564.78588035263, 249449.0, 31138.68861311403, 31901.20246993844, 32061.0, 52860.73569632127, 53238.20142697862, 33659.495107573406, 33770.662293377245, 33804.0, 33861.830690846386, 33887.322253555285, 12090.335031573348, 12101.69745756363, 12114.757704845853, 12231.449584768707, 12237.082218833444, 9079.137481939206, 9404.435733855991, 9610.66362677317, 10039.598416063276, 10157.542910569042, 7952.443328966917, 7957.403194760416, 7960.044794624682, 7972.083210430875, 8031.879521807177, 3135.153508552678, 3148.3231105312466, 3154.8738050477723, 3189.872405103816, 3199.77601567888, 825.9917400826035, 903.9186473217442, 911.070707877974, 926.2775035472342, 953.4470007395832, 27145.728542714714, 27974.3006424841, 28019.43961120766, 28076.43847123087, 28162.869848209746, 941.1482608239554, 956.4213650741341, 971.5530855806267, 972.7130496503548, 983.4394395194813, 14650.633734156518, 14954.551363459113, 14978.043673942359, 15055.096694198382, 15081.436155853531, 422672.0, 430327.0, 430581.0, 430594.0, 431482.0, 48677.51322486801, 49861.0, 49904.0, 49948.25077623838, 50052.49947500551, 1071.1591400750374, 1090.7491277006334, 1101.24014430043, 1177.381874515886, 1211.2187638972814, 20672.689909651068, 24123.879380602986, 24285.0, 25211.36971575652, 25933.740662593133, 45269.0, 45407.7729611363, 45708.542914570426, 45914.770426147654, 46063.76968115138, 334940.0, 337997.0, 338388.0, 338588.0, 338977.0, 21864.672029919882, 22576.209832656434, 23994.88002559976, 24804.0, 25294.747052529976, 39059.218815624095, 39526.2094758109, 39597.60402395939, 39828.60171398249, 40180.0, 33617.0, 34542.65457345395, 34568.48147277743, 35085.824570878, 35283.64716352804, 34335.0, 34557.654423455446, 34566.30867382688, 34923.30153396969, 35031.29937401289, 33908.49137262894, 34759.4786078204, 34787.65212347844, 34838.47742283918, 34895.47656785201, 30621.846890765402, 30657.846710767197, 30902.22744431407, 31295.687043129277, 31508.684913150573, 24138.75861241365, 24626.876865616276, 24634.384140396633, 24760.752392475846, 24944.37639059038], "value": 16505.75069465765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.3186071697718, 375.88159729685145, 382.8143350475019, 383.9001859516525, 384.6403612622197, 15669.45156919508, 17495.912520437396, 17617.55956101098, 17929.193186306617, 17959.730604040917, 10774.191935604842, 16443.0, 17068.719846011536, 17426.47720568382, 17433.30266789327, 4579.519150489201, 4771.141194584973, 4796.0, 4810.759462026902, 4820.035992801436, 3398.5921689397182, 3589.300086483137, 4684.906301873961, 6545.934540654604, 7024.578525288473, 6890.276520965302, 7019.157701075878, 7147.392471639917, 7200.531965422231, 7203.567785932834, 7083.256258092903, 7097.92902070983, 7132.857342853114, 7135.89296160558, 7139.9286007140045, 3864.942025869614, 6129.325774164839, 6629.834254143685, 6640.236372817091, 6862.073620061277, 23312.76687233123, 23376.883115584482, 23474.530509389715, 23578.17476388318, 23899.0, 2023.3727544461265, 2093.874367537953, 2097.8321734261376, 2117.502386939068, 2153.569286142778, 13912.30438478072, 14410.567682969528, 14602.269886505632, 14728.263586820724, 15165.469208577646, 1921.4139687395339, 1958.8432925365937, 1975.3185151122984, 2014.1842553765748, 2034.7049677796786, 50121.0, 50569.24146137811, 50820.49179508194, 52272.0, 80464.99999999942, 15841.762373564407, 15869.761953570705, 15884.60288492797, 16017.439389621308, 16025.679486410207, 28524.572131418045, 28533.286667833054, 28581.714182857904, 28614.856925715238, 28857.0, 8511.616977236039, 8546.658133674584, 8584.957075214585, 8588.484690918565, 8737.082606326372, 6721.0, 6758.966205168943, 6894.069300644449, 6955.89566156508, 6998.090248267693, 8260.291633768695, 8418.873716894252, 8499.490030598185, 8576.271016963628, 8631.395802293779, 2718.9320266993086, 3194.233383987826, 3228.6932741389533, 3239.72462340699, 3347.3305338931823, 770.8150043989515, 879.612970293069, 881.7266647339345, 899.2985471332371, 912.4570880326195, 15762.842371576367, 16407.1796410179, 16600.169991500617, 16776.916115419346, 17164.0, 418.91831092937196, 840.8906842110487, 889.3507739350181, 895.1138373010803, 900.4327273817584, 5511.0080185566185, 5690.032694441955, 5794.82615521535, 5838.620489668243, 5977.820665380045, 374259.0, 379047.0, 380547.0, 386589.0, 391061.0, 72832.35260297699, 78263.0, 78599.0, 78763.21236787674, 79485.03862210242, 428.8156092880029, 431.8207943703328, 436.2322312729619, 436.44353449351695, 437.3876572798108, 9966.850497242402, 10152.644657436955, 10321.380717156995, 10471.795743489596, 10513.316634418738, 36245.0, 36941.815290923376, 36972.63027369799, 37068.44397334096, 37987.0, 50143.498565013884, 53448.0, 53896.46103538915, 54066.0, 54076.18885716796, 7628.084629844454, 7728.8454230916195, 7763.223677632417, 7782.844343112993, 7874.56689882062, 6983.476239281973, 8595.484270943763, 10648.787024259627, 11362.886371136183, 11876.287422754662, 9952.55213515379, 10184.23618228621, 10293.845592316271, 10443.425611591436, 10520.10579100785, 8256.917430825855, 10324.638637647646, 10368.377897326185, 10542.209334300112, 10637.468126593794, 10325.586976520855, 10517.526711297856, 10611.787764244826, 10697.0, 10749.462526873469, 7599.0, 7812.804679883048, 7867.291943725092, 7927.286544211049, 8014.679412823421, 7823.374130069695, 9492.57283422234, 9921.65274215399, 10082.747931301483, 10487.737806554896], "value": 8619.082274409624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1201.2852352850061, 1380.0339762166486, 1425.059460755901, 1499.4976682811257, 1676.6898123847088, 6764.661766911653, 7714.074311082671, 7948.7217947371855, 7971.163027882076, 8222.95888520558, 7926.722564710236, 8081.39389545785, 8087.9595602022055, 8106.797330066736, 8106.797330066751, 1869.0934896575218, 2151.7202763640703, 2232.787885150908, 2237.5077482953766, 2271.954560908781, 2268.0360846640197, 2289.3933107726466, 2291.0, 2296.5866144094057, 2300.068472268734, 2215.3907675389237, 2224.5662095891307, 2252.538229662915, 2254.7519772824976, 2255.12050300383, 1816.1645643004233, 2086.1968142265187, 2159.2010955946243, 2160.0387827416807, 2201.9559608807813, 2178.880161591112, 2190.507135894411, 2195.078067211775, 2197.648376259807, 2198.4613769626385, 8000.279974802237, 8057.919420805775, 8071.152528984489, 8076.273135417782, 8079.434439589231, 4663.44038715353, 4784.569388755029, 4790.089882922233, 4792.832250871237, 4798.208295631217, 2913.980106962546, 3064.341166649181, 3178.904632861018, 3203.2792621660174, 3216.131644455984, 967.9128878400978, 975.7414285214423, 981.7349315684725, 989.6140505202976, 990.321629683669, 10987.121030317556, 11028.558857645765, 11035.0, 11090.667279981613, 11106.44467776608, 4270.380794784739, 4301.376300436482, 4372.409724687126, 4473.0, 4476.888077798081, 8753.0, 8783.604737786814, 8829.646814127364, 8830.116988301119, 8844.115588441104, 4733.384659994179, 4775.880602984884, 4776.641751868624, 4781.95218047822, 4782.880427989328, 3657.0674478007936, 4280.636145927631, 4390.143921935192, 4390.253656878338, 4473.910521789611, 3397.1846756778195, 3477.1307173206696, 3483.1292176955762, 3497.370473314828, 3606.6032736398975, 993.3046867192994, 1014.3609525998721, 1014.8579198912158, 1022.2741853284103, 1026.7279171019536, 865.2731705367521, 873.4453621949981, 883.1212943121507, 884.3058199313508, 916.3631276263067, 5389.946100539023, 5461.726913654302, 5559.499645031886, 5572.693501857437, 5698.230738850202, 854.7350321400386, 896.3904544909524, 914.2229105260475, 935.6210734652477, 960.5389413081621, 3534.6111927687934, 3556.897361817793, 3760.699144068468, 3813.580506144322, 3818.522684664417, 9639.662611808693, 9799.853002204973, 10099.495025248709, 10123.291369604058, 10143.08712215904, 9960.651377201762, 10009.349392289478, 10039.0, 10041.949790251148, 10085.798284034277, 7069.9646501767165, 7215.134183897966, 7352.963235183897, 7354.521956072945, 7374.26257374269, 5632.802851900164, 5638.154276858504, 5691.0, 5848.795292164924, 5878.470937615635, 8923.375363724477, 9221.262299015929, 9228.723138305862, 9239.0, 9265.53672316395, 8766.21104100634, 9109.134632209929, 9249.075092490966, 9289.303302252494, 9309.162175404246, 6144.754209831735, 6671.532992690465, 6899.586024838526, 6920.377166055079, 7094.787156385317, 7776.572288524186, 7802.726904558313, 7844.6077696113825, 7860.135385107519, 7870.331021862977, 6782.762603308861, 6797.320267973163, 6973.7210511581, 7051.0, 7067.0, 6801.387875091265, 6884.586924784529, 6951.200611929693, 6956.200036995608, 6992.0, 6179.721912513858, 6181.84545386369, 6216.502679785516, 6228.968855155696, 6242.625442473466, 4792.305115758265, 4802.567768900815, 4828.058528587032, 4867.977724677858, 4900.068986892479, 4405.933910991402, 4645.512221216723, 4672.976635116803, 4747.501512341292, 4821.011692602938], "value": 4222.746108295722, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.1676265988481, 317.6664502272613, 318.04586241276155, 318.0569611103079, 319.9072269041977, 4899.142650036243, 4907.950920490794, 4926.38901382268, 4969.652124351297, 4971.154903666372, 4779.976100119503, 4794.0, 4820.879478013051, 4849.975750121244, 4879.316895634614, 3607.2244467439496, 3740.5511338639403, 3754.2303827715255, 3767.717421193408, 3771.7548359356556, 3505.8772942947003, 3705.2589482103554, 3776.3580191367396, 3777.9811100944457, 3843.3082045231845, 3781.1870447853707, 3822.273767984088, 3826.923461530768, 3827.9234415311676, 3838.5777564467885, 3805.334066538345, 3818.8281527331337, 3821.9426708599394, 3831.080540670233, 3843.942340864889, 3205.8557364918634, 3276.0, 3386.4581666933173, 3413.8805141820167, 3446.724262059029, 4750.382450281476, 4765.117104152007, 4766.904661906742, 4771.427428708577, 4777.378940737716, 4395.362672412482, 4397.1205758848355, 4397.934030989538, 4414.448193975753, 4417.425734654506, 4914.901701965977, 5073.441921388644, 5085.542301192873, 5092.065015294164, 5105.957616953211, 3716.2195938852874, 3722.7021838253145, 3730.123420996064, 3733.9813300933592, 3745.550533935918, 5019.397672279313, 5203.505666961632, 5315.123004704219, 5344.732763361816, 5390.137577987503, 3835.5972622874197, 3895.8052097395584, 3898.766074035567, 3900.551436584772, 3912.960870391317, 3922.5096862892137, 3927.803609819555, 3947.0, 3956.3076461619676, 3966.504186976628, 4256.425382573313, 4368.847090351823, 4423.712458690239, 4428.202923473741, 4460.840181552755, 5064.924026139611, 5065.898682026339, 5072.340595722532, 5082.390113186441, 5102.3877134743325, 1344.6436694276024, 1366.3441548056987, 1368.555219553649, 1377.7531334142618, 1379.5309594737837, 833.6832003838502, 871.3116637856023, 882.9072947340566, 896.6682327538722, 904.5432056811268, 3999.5200575931076, 4011.939820902689, 4024.91950161001, 4037.29347364216, 4039.313316736162, 4604.240300350471, 4653.627709783277, 4685.554872287127, 4701.694389864648, 4713.95286047142, 3989.6409323160474, 4042.9381015682216, 4043.272211001989, 4049.6152865477734, 4072.165206132736, 2500.3874050857657, 2582.2382397192873, 2782.332240262363, 2803.313188268887, 2828.5474324108045, 4924.975375123101, 4943.505649435027, 4952.727599982036, 4982.8754281143265, 4983.426905905795, 5248.816291429858, 5370.892582148335, 5406.8918621627345, 5434.755436005389, 5435.864103397367, 4928.630352723489, 4932.284818701268, 4952.257161425743, 4952.47998960104, 4961.156603377434, 5233.319668443078, 5259.263703081495, 5263.736813159403, 5270.183121616155, 5276.683398996072, 4894.975525122351, 5116.74416279192, 5150.459201783909, 5161.225816127611, 5168.131686913799, 4978.925316120333, 4980.925286120639, 4990.226514890198, 5006.374203224597, 5014.398272207212, 3768.3970564709516, 3771.2080463103057, 3783.659470647655, 3792.905177370588, 3817.232506432925, 5155.32980712505, 5383.407825139153, 5385.596080294072, 5388.353397592314, 5397.8110766123, 5152.330197074356, 5165.070287348313, 5170.43125256229, 5176.663516871391, 5190.636655434235, 5161.870953226199, 5165.690058596496, 5213.530782229617, 5218.495122341222, 5236.790528378822, 4949.406071271471, 5122.462141475092, 5135.7432128394175, 5138.665986710852, 5149.639525233198, 5186.559142472781, 5206.297149884868, 5235.712035838065, 5236.109861323508, 5250.894982100413, 5115.2071428928575, 5123.282740416419, 5183.766730497212, 5184.559312458332, 5193.792248310026], "value": 3849.263362624263, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.403719819554, 720.6432815756201, 722.966158393497, 740.3373980287645, 752.5071078443615, 12281.754364912707, 13664.316784160801, 13966.650833729162, 14791.186484743335, 14846.628834279149, 14919.850801491983, 14957.850421495781, 15034.699306013874, 15076.698466030673, 15080.924595377008, 609.0559632569522, 768.8539177556274, 796.4623878881761, 799.5562462833125, 802.2058162419221, 782.6126067596548, 788.7673136424739, 788.8106854354942, 789.5420656019523, 790.9288164065233, 825.352098602597, 831.2767891934026, 831.3017065664841, 831.4055450352996, 831.4553967151526, 637.5568979559208, 802.0976401548259, 806.9636866341028, 830.3772170871846, 831.2061980808344, 612.8529153003292, 612.9785457508966, 613.5429105316567, 613.8925688004626, 614.0206370838505, 12422.378881056002, 12501.062420318513, 12540.937295313557, 12579.433925473375, 12606.054545909094, 11925.463354149084, 11987.22083064598, 12335.383230838512, 12345.321007344592, 12591.811122833165, 11741.295522268605, 11891.167618266725, 12045.337506437143, 12118.212316199419, 12427.627171184879, 4096.365063415175, 4103.250762478619, 4158.293090174678, 4289.764062976535, 4297.570242975708, 43730.0, 44226.778866105466, 44249.0, 44324.0, 44489.0, 9497.525123743786, 9850.556724947395, 9923.305368624271, 10006.949965250127, 10175.694729158136, 17113.22990465432, 17158.142092895305, 17180.484585462455, 17197.0, 17202.655946880994, 6379.71291291893, 6409.967950160312, 6631.303713110054, 6753.932460675429, 6835.487338449636, 3504.789712617251, 3537.964620353815, 3594.8382322795014, 3625.4199328107375, 3676.062604035954, 2807.228012296594, 2909.6072030276064, 2909.709029097073, 2916.7229113234207, 2917.1831887071653, 496.22341036278107, 497.6541303793829, 500.1522419498987, 500.18220209956985, 515.7086246270845, 416.79160419790105, 518.8287865004615, 554.9250851135126, 585.7247093865876, 604.4046614085123, 7715.4443563230525, 7762.728304509428, 8100.311473524816, 8202.302804261586, 8204.548749818818, 478.9497102804225, 510.4614631563736, 535.087675513249, 544.8338256831626, 615.4553220399978, 3628.4375921732176, 3690.9077273068388, 3707.4068149096015, 3815.313243616176, 3818.0836599215986, 90153.0, 90877.54561227151, 91065.0, 91089.7227569316, 91855.54072229596, 83048.58475707704, 85153.57423212969, 85460.0, 85771.57114214389, 87352.0, 59853.700731496065, 68906.62186756337, 69326.0, 70124.64937675279, 71348.64325678338, 6834.350736680008, 7134.571925684268, 7208.17106032792, 7428.182899880901, 7546.584937828472, 41402.792986034874, 41553.168936620496, 42168.0, 42382.36426453544, 43914.0, 57197.71401142968, 61912.0, 62825.685871572176, 63847.36152638414, 64307.35692643013, 8969.327300452362, 9073.0, 9207.493587852732, 9215.354925155174, 9446.811063778823, 10677.839832402366, 10697.358158510515, 10739.892601073889, 11046.392448415414, 11059.447027648746, 9730.708078757649, 9856.704298871045, 9920.503974801375, 9962.701118966443, 10189.439580823126, 10505.422201778976, 10743.409112498888, 10744.0, 10768.784624307627, 10976.176786740867, 9059.320550958837, 9352.275320191755, 9539.666111686058, 9562.904370956201, 9718.902810972082, 8610.225079742853, 8752.562371881508, 8820.0, 9067.90932090697, 9323.160915517636, 8206.384521161057, 8275.54484503334, 8308.086110527716, 8495.918499967547, 8805.471671699719], "value": 6258.270250578283, "unit": "score"}], "name": "dromaeo_css", "value": 6389.9100834487845, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 116.0, 114.0, 112.0, 114.0, 114.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 141.0, 133.0, 180.0, 132.0, 143.0, 165.0, 131.0, 191.0, 132.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 159.0, 160.0, 162.0, 161.0, 160.0, 159.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 133.0, 77.0, 77.0, 77.0, 76.0, 104.0, 77.0], "value": 85.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 115.0, 87.0, 87.0, 86.0, 126.0, 85.0, 87.0, 125.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 64.0, 66.0, 66.0, 64.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 84.0, 83.0, 85.0, 85.0, 90.0, 92.0, 113.0, 91.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 131.0, 133.0, 142.0, 137.0, 130.0, 128.0, 138.0, 134.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 169.0, 168.0, 167.0, 167.0, 165.0, 168.0, 168.0, 167.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 68.0, 68.0, 68.0, 67.0, 69.0, 69.0, 72.0, 67.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1555.4000000000003, "alertThreshold": 2.0}]} 07:35:53 INFO - Return code: 0 07:35:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:35:53 INFO - # TBPL SUCCESS # 07:35:53 INFO - Running post-action listener: _resource_record_post_action 07:35:53 INFO - ##### 07:35:53 INFO - ##### Finished run-tests step (success) 07:35:53 INFO - ##### 07:35:53 INFO - Running post-run listener: _resource_record_post_run 07:35:53 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 7819264; Write bytes: 420524032; Read time: 1580; Write time: 371608 07:35:53 INFO - TinderboxPrint: CPU usage
13.2% 07:35:53 INFO - TinderboxPrint: I/O read bytes / time
7,819,264 / 1,580 07:35:53 INFO - TinderboxPrint: I/O write bytes / time
420,524,032 / 371,608 07:35:53 INFO - TinderboxPrint: CPU idle
8,335.6 (86.8%) 07:35:53 INFO - TinderboxPrint: CPU user
1,216.5 (12.7%) 07:35:53 INFO - TinderboxPrint: Swap in / out
0 / 0 07:35:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 4874240; Read time: 0; Write time: 10228 07:35:53 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 6049792; Write bytes: 346984448; Read time: 1176; Write time: 310112 07:35:53 INFO - Running post-run listener: _upload_blobber_files 07:35:53 INFO - Blob upload gear active. 07:35:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:35:53 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 07:35:53 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:35:53 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:35:54 INFO - (blobuploader) - INFO - Open directory for files ... 07:35:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:35:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:35:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:54 INFO - (blobuploader) - INFO - Done attempting. 07:35:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:35:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:35:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:58 INFO - (blobuploader) - INFO - Done attempting. 07:35:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:35:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:00 INFO - (blobuploader) - INFO - Done attempting. 07:36:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:36:00 INFO - Return code: 0 07:36:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:36:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:36:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/431aebce7f7b688a0ee89280bf732c55c3b5e6460ff00f104750844af96b67a340df37eed74956de14b42cc0a180afbb7d4c95e18b600d7516f3c742d5d433b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da6ab32667d8f9a29d8bb6d38a693a99cb5a388af4b76cafd74311bfca7c5760db5c5664187d75005a86dabfa792aba6ccec1d805778064e3de9cf1bbfb3f2ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35937821cae286f564a40906a143f93bbefffafbd5411d94515ba29255e1a55c61929d8677ea716be04554bcc2631ec0d46e6bb47838317e1dd407cf3f56389e"} 07:36:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:36:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:36:00 INFO - Contents: 07:36:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/431aebce7f7b688a0ee89280bf732c55c3b5e6460ff00f104750844af96b67a340df37eed74956de14b42cc0a180afbb7d4c95e18b600d7516f3c742d5d433b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da6ab32667d8f9a29d8bb6d38a693a99cb5a388af4b76cafd74311bfca7c5760db5c5664187d75005a86dabfa792aba6ccec1d805778064e3de9cf1bbfb3f2ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35937821cae286f564a40906a143f93bbefffafbd5411d94515ba29255e1a55c61929d8677ea716be04554bcc2631ec0d46e6bb47838317e1dd407cf3f56389e"} 07:36:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:36:00 INFO - Copying logs to upload dir... 07:36:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:36:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.694065 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-21 07:36:00.861389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 07:36:00.864759) ========= 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=00204705a9daa57ed339a427000001b9-1466517397.778851-596258064 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-Non-PGO/sha512/431aebce7f7b688a0ee89280bf732c55c3b5e6460ff00f104750844af96b67a340df37eed74956de14b42cc0a180afbb7d4c95e18b600d7516f3c742d5d433b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da6ab32667d8f9a29d8bb6d38a693a99cb5a388af4b76cafd74311bfca7c5760db5c5664187d75005a86dabfa792aba6ccec1d805778064e3de9cf1bbfb3f2ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35937821cae286f564a40906a143f93bbefffafbd5411d94515ba29255e1a55c61929d8677ea716be04554bcc2631ec0d46e6bb47838317e1dd407cf3f56389e"} build_url:https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/PmiCwNN6SeSzutIzcI6EWw/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-Non-PGO/sha512/431aebce7f7b688a0ee89280bf732c55c3b5e6460ff00f104750844af96b67a340df37eed74956de14b42cc0a180afbb7d4c95e18b600d7516f3c742d5d433b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da6ab32667d8f9a29d8bb6d38a693a99cb5a388af4b76cafd74311bfca7c5760db5c5664187d75005a86dabfa792aba6ccec1d805778064e3de9cf1bbfb3f2ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35937821cae286f564a40906a143f93bbefffafbd5411d94515ba29255e1a55c61929d8677ea716be04554bcc2631ec0d46e6bb47838317e1dd407cf3f56389e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 07:36:00.890631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:36:00.891016) ========= 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=00204705a9daa57ed339a427000001b9-1466517397.778851-596258064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004367 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:36:00.973429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 07:36:00.973759) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 07:36:00.974060) ========= ========= Total master_lag: 0.16 =========