builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1466820759.14 results: success (0) buildid: 20160624183759 builduid: d1c265662d6947efba3683165a95dc20 revision: 6de5b59dbcf95bb561d3c60f63743311f3f5d653 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:39.145683) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:39.146305) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:39.146678) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:39.268984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:39.269296) ========= 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=523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 19:12:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.0M=0.001s 2016-06-24 19:12:40 (20.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118322 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:39.431550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:39.431883) ========= 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=523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015895 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:39.495445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:39.495797) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6de5b59dbcf95bb561d3c60f63743311f3f5d653 --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 6de5b59dbcf95bb561d3c60f63743311f3f5d653 --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=523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 19:12:40,816 truncating revision to first 12 chars 2016-06-24 19:12:40,816 Setting DEBUG logging. 2016-06-24 19:12:40,816 attempt 1/10 2016-06-24 19:12:40,816 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6de5b59dbcf9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 19:12:41,309 unpacking tar archive at: fx-team-6de5b59dbcf9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.816500 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:40.332319) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:40.332644) ========= script_repo_revision: 6de5b59dbcf95bb561d3c60f63743311f3f5d653 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:40.333128) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:40.333458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 19:12:40.344857) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-06-24 19:12:40.345188) ========= /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=523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:12:41 INFO - MultiFileLogger online at 20160624 19:12:41 in /builds/slave/test 19:12:41 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 19:12:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:12:41 INFO - {'append_to_log': False, 19:12:41 INFO - 'base_work_dir': '/builds/slave/test', 19:12:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:12:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:12:41 INFO - 'branch': 'Fx-Team-Non-PGO', 19:12:41 INFO - 'buildbot_json_path': 'buildprops.json', 19:12:41 INFO - 'config_files': ('talos/linux_config.py',), 19:12:41 INFO - 'default_actions': ('clobber', 19:12:41 INFO - 'read-buildbot-config', 19:12:41 INFO - 'download-and-extract', 19:12:41 INFO - 'populate-webroot', 19:12:41 INFO - 'create-virtualenv', 19:12:41 INFO - 'install', 19:12:41 INFO - 'run-tests'), 19:12:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:12:41 INFO - 'download_minidump_stackwalk': True, 19:12:41 INFO - 'download_symbols': 'ondemand', 19:12:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:12:41 INFO - 'tooltool.py': '/tools/tooltool.py', 19:12:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:12:41 INFO - '/tools/misc-python/virtualenv.py')}, 19:12:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:12:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:12:41 INFO - 'installer_path': 'installer.exe', 19:12:41 INFO - 'log_level': 'info', 19:12:41 INFO - 'log_name': 'talos', 19:12:41 INFO - 'log_to_console': True, 19:12:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:12:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:12:41 INFO - 'opt_config_files': (), 19:12:41 INFO - 'pip_index': False, 19:12:41 INFO - 'sps_profile': False, 19:12:41 INFO - 'sps_profile_interval': 0, 19:12:41 INFO - 'suite': 'dromaeojs', 19:12:41 INFO - 'system_bits': '32', 19:12:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:12:41 INFO - 'title': 'talos-linux64-ix-065', 19:12:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:12:41 INFO - 'use_talos_json': True, 19:12:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:12:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:12:41 INFO - 'work_dir': 'build'} 19:12:41 INFO - ##### 19:12:41 INFO - ##### Running clobber step. 19:12:41 INFO - ##### 19:12:41 INFO - Running pre-action listener: _resource_record_pre_action 19:12:41 INFO - Running main action method: clobber 19:12:41 INFO - rmtree: /builds/slave/test/build 19:12:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:12:42 INFO - Running post-action listener: _resource_record_post_action 19:12:42 INFO - ##### 19:12:42 INFO - ##### Finished clobber step (success) 19:12:42 INFO - ##### 19:12:42 INFO - ##### 19:12:42 INFO - ##### Running read-buildbot-config step. 19:12:42 INFO - ##### 19:12:42 INFO - Running pre-action listener: _resource_record_pre_action 19:12:42 INFO - Running main action method: read_buildbot_config 19:12:42 INFO - Using buildbot properties: 19:12:42 INFO - { 19:12:42 INFO - "project": "", 19:12:42 INFO - "product": "firefox", 19:12:42 INFO - "script_repo_revision": "production", 19:12:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:12:42 INFO - "repository": "", 19:12:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:12:42 INFO - "buildid": "20160624183759", 19:12:42 INFO - "pgo_build": "False", 19:12:42 INFO - "basedir": "/builds/slave/test", 19:12:42 INFO - "buildnumber": 3116, 19:12:42 INFO - "slavename": "talos-linux64-ix-065", 19:12:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:12:42 INFO - "platform": "ubuntu64_hw", 19:12:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:12:42 INFO - "branch": "fx-team", 19:12:42 INFO - "repo_path": "integration/fx-team", 19:12:42 INFO - "revision": "6de5b59dbcf95bb561d3c60f63743311f3f5d653", 19:12:42 INFO - "stage_platform": "linux64", 19:12:42 INFO - "builduid": "d1c265662d6947efba3683165a95dc20", 19:12:42 INFO - "slavebuilddir": "test" 19:12:42 INFO - } 19:12:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:12:42 INFO - Running post-action listener: _resource_record_post_action 19:12:42 INFO - ##### 19:12:42 INFO - ##### Finished read-buildbot-config step (success) 19:12:42 INFO - ##### 19:12:42 INFO - ##### 19:12:42 INFO - ##### Running download-and-extract step. 19:12:42 INFO - ##### 19:12:42 INFO - Running pre-action listener: _resource_record_pre_action 19:12:42 INFO - Running main action method: download_and_extract 19:12:42 INFO - mkdir: /builds/slave/test/build/tests 19:12:42 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')]} 19:12:42 INFO - https://queue.taskcluster.net/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:12:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:12:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:12:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/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 19:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/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 19:12:53 INFO - Downloaded 1361 bytes. 19:12:53 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:12:53 INFO - Using the following test package requirements: 19:12:53 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:12:53 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:12:53 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:12:53 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:53 INFO - u'jsshell-linux-x86_64.zip'], 19:12:53 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:12:53 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:12:53 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:12:53 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:12:53 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:12:53 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:12:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:12:53 INFO - https://queue.taskcluster.net/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:12:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:12:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:12:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/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 19:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/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 19:12:59 INFO - Downloaded 22713106 bytes. 19:12:59 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'] 19:12:59 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 19:13:00 INFO - Return code: 0 19:13:00 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 19:13:00 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')]} 19:13:00 INFO - https://queue.taskcluster.net/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:13:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:13:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:13:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/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 19:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/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 19:13:01 INFO - Downloaded 22713106 bytes. 19:13:01 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'] 19:13:01 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 19:13:02 INFO - Return code: 0 19:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:02 INFO - https://queue.taskcluster.net/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:13:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:13:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:13:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/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 19:13:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/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 19:13:03 INFO - Downloaded 14405188 bytes. 19:13:03 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'] 19:13:03 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 19:13:04 INFO - Return code: 0 19:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:04 INFO - https://queue.taskcluster.net/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:13:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/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 19:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FH-z8ssMRmSGdapPAfFS8A/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 19:13:05 INFO - Downloaded 56254139 bytes. 19:13:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:05 INFO - mkdir: /builds/slave/test/properties 19:13:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:13:05 INFO - Writing to file /builds/slave/test/properties/build_url 19:13:05 INFO - Contents: 19:13:05 INFO - build_url:https://queue.taskcluster.net/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:06 INFO - Running post-action listener: _resource_record_post_action 19:13:06 INFO - Running post-action listener: set_extra_try_arguments 19:13:06 INFO - ##### 19:13:06 INFO - ##### Finished download-and-extract step (success) 19:13:06 INFO - ##### 19:13:06 INFO - ##### 19:13:06 INFO - ##### Running populate-webroot step. 19:13:06 INFO - ##### 19:13:06 INFO - Running pre-action listener: _resource_record_pre_action 19:13:06 INFO - Running main action method: populate_webroot 19:13:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:13:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:13:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:13:06 INFO - '--tppagecycles', 19:13:06 INFO - '7'], 19:13:06 INFO - 'tests': ['tsvgm']}}, 19:13:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:13:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:13:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:13:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:13:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:13:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:13:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:06 INFO - 'talos_options': ['--disable-e10s'], 19:13:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:13:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:13:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:06 INFO - 'talos_options': ['--disable-e10s'], 19:13:06 INFO - 'tests': ['damp', 'tps']}, 19:13:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:06 INFO - 'tests': ['damp', 'tps']}, 19:13:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:13:06 INFO - 'tests': ['dromaeo_dom']}, 19:13:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:13:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:13:06 INFO - 'tests': ['basic_compositor_video']}, 19:13:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:13:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:13:06 INFO - 'tests': ['a11yr', 19:13:06 INFO - 'ts_paint', 19:13:06 INFO - 'tpaint', 19:13:06 INFO - 'sessionrestore', 19:13:06 INFO - 'sessionrestore_no_auto_restore', 19:13:06 INFO - 'tabpaint']}, 19:13:06 INFO - 'other-e10s': {'tests': ['a11yr', 19:13:06 INFO - 'ts_paint', 19:13:06 INFO - 'tpaint', 19:13:06 INFO - 'sessionrestore', 19:13:06 INFO - 'sessionrestore_no_auto_restore', 19:13:06 INFO - 'tabpaint']}, 19:13:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:13:06 INFO - 'ts_paint', 19:13:06 INFO - 'tpaint', 19:13:06 INFO - 'sessionrestore', 19:13:06 INFO - 'sessionrestore_no_auto_restore', 19:13:06 INFO - 'tabpaint']}, 19:13:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:13:06 INFO - 'ts_paint', 19:13:06 INFO - 'tpaint', 19:13:06 INFO - 'sessionrestore', 19:13:06 INFO - 'sessionrestore_no_auto_restore', 19:13:06 INFO - 'tabpaint']}, 19:13:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:13:06 INFO - 'tests': ['a11yr', 19:13:06 INFO - 'ts_paint', 19:13:06 INFO - 'tpaint', 19:13:06 INFO - 'sessionrestore', 19:13:06 INFO - 'sessionrestore_no_auto_restore', 19:13:06 INFO - 'tabpaint']}, 19:13:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:13:06 INFO - 'tests': ['a11yr', 19:13:06 INFO - 'ts_paint', 19:13:06 INFO - 'tpaint', 19:13:06 INFO - 'sessionrestore', 19:13:06 INFO - 'sessionrestore_no_auto_restore', 19:13:06 INFO - 'tabpaint']}, 19:13:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:13:06 INFO - 'tests': ['tsvgx', 19:13:06 INFO - 'tsvgr_opacity', 19:13:06 INFO - 'tart', 19:13:06 INFO - 'tscrollx', 19:13:06 INFO - 'cart']}, 19:13:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:13:06 INFO - 'tsvgr_opacity', 19:13:06 INFO - 'tart', 19:13:06 INFO - 'tscrollx', 19:13:06 INFO - 'cart']}, 19:13:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:06 INFO - 'talos_options': ['--disable-e10s'], 19:13:06 INFO - 'tests': ['tp5o']}, 19:13:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:06 INFO - 'tests': ['tp5o']}, 19:13:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:06 INFO - 'talos_options': ['--disable-e10s', 19:13:06 INFO - '--xperf_path', 19:13:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:13:06 INFO - 'tests': ['tp5n']}, 19:13:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:06 INFO - 'talos_options': ['--xperf_path', 19:13:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:13:06 INFO - 'tests': ['tp5n']}}, 19:13:06 INFO - 'talos.zip': {'path': '', 19:13:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:13:06 INFO - Running post-action listener: _resource_record_post_action 19:13:06 INFO - ##### 19:13:06 INFO - ##### Finished populate-webroot step (success) 19:13:06 INFO - ##### 19:13:06 INFO - ##### 19:13:06 INFO - ##### Running create-virtualenv step. 19:13:06 INFO - ##### 19:13:06 INFO - Running pre-action listener: _resource_record_pre_action 19:13:06 INFO - Running main action method: create_virtualenv 19:13:06 INFO - Creating virtualenv /builds/slave/test/build/venv 19:13:06 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 19:13:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:13:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:13:06 INFO - Using real prefix '/usr' 19:13:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:13:06 INFO - Installing distribute.............................................................................................................................................................................................done. 19:13:08 INFO - Installing pip.................done. 19:13:08 INFO - Return code: 0 19:13:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:13: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')]} 19:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13: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')]} 19:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:08 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 0x7f8f4082ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c01c0>, '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 0x11c10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c1550>, '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': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', '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 19:13:08 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 19:13:08 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 19:13:08 INFO - Using env: {'DISPLAY': ':0', 19:13:08 INFO - 'HOME': '/home/cltbld', 19:13:08 INFO - 'LANG': 'en_US.UTF-8', 19:13:08 INFO - 'LANGUAGE': 'en_US:en', 19:13:08 INFO - 'LOGNAME': 'cltbld', 19:13:08 INFO - 'MAIL': '/var/mail/cltbld', 19:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:08 INFO - 'MOZ_NO_REMOTE': '1', 19:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:08 INFO - 'NO_EM_RESTART': '1', 19:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:08 INFO - 'PWD': '/builds/slave/test', 19:13:08 INFO - 'SHELL': '/bin/bash', 19:13:08 INFO - 'SHLVL': '1', 19:13:08 INFO - 'TERM': 'linux', 19:13:08 INFO - 'TMOUT': '86400', 19:13:08 INFO - 'USER': 'cltbld', 19:13:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', 19:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:08 INFO - '_': '/tools/buildbot/bin/python'} 19:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:08 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 19:13:08 INFO - Cleaning up... 19:13:08 INFO - Return code: 0 19:13:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:13: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')]} 19:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13: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')]} 19:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:08 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 0x7f8f4082ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c01c0>, '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 0x11c10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c1550>, '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': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', '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 19:13:08 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 19:13:08 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 19:13:08 INFO - Using env: {'DISPLAY': ':0', 19:13:08 INFO - 'HOME': '/home/cltbld', 19:13:08 INFO - 'LANG': 'en_US.UTF-8', 19:13:08 INFO - 'LANGUAGE': 'en_US:en', 19:13:08 INFO - 'LOGNAME': 'cltbld', 19:13:08 INFO - 'MAIL': '/var/mail/cltbld', 19:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:08 INFO - 'MOZ_NO_REMOTE': '1', 19:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:08 INFO - 'NO_EM_RESTART': '1', 19:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:08 INFO - 'PWD': '/builds/slave/test', 19:13:08 INFO - 'SHELL': '/bin/bash', 19:13:08 INFO - 'SHLVL': '1', 19:13:08 INFO - 'TERM': 'linux', 19:13:08 INFO - 'TMOUT': '86400', 19:13:08 INFO - 'USER': 'cltbld', 19:13:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', 19:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:08 INFO - '_': '/tools/buildbot/bin/python'} 19:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:09 INFO - Downloading/unpacking psutil>=3.1.1 19:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:13:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:13:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:13:11 INFO - Installing collected packages: psutil 19:13:11 INFO - Running setup.py install for psutil 19:13:11 INFO - building 'psutil._psutil_linux' extension 19:13:11 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 19:13:11 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 19:13:11 INFO - building 'psutil._psutil_posix' extension 19:13:11 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 19:13:11 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 19:13:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:13:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:13:11 INFO - Successfully installed psutil 19:13:11 INFO - Cleaning up... 19:13:11 INFO - Return code: 0 19:13:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:13: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')]} 19:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13: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')]} 19:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f4082ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c01c0>, '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 0x11c10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c1550>, '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': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', '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 19:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:13:11 INFO - Using env: {'DISPLAY': ':0', 19:13:11 INFO - 'HOME': '/home/cltbld', 19:13:11 INFO - 'LANG': 'en_US.UTF-8', 19:13:11 INFO - 'LANGUAGE': 'en_US:en', 19:13:11 INFO - 'LOGNAME': 'cltbld', 19:13:11 INFO - 'MAIL': '/var/mail/cltbld', 19:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:11 INFO - 'MOZ_NO_REMOTE': '1', 19:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:11 INFO - 'NO_EM_RESTART': '1', 19:13:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:11 INFO - 'PWD': '/builds/slave/test', 19:13:11 INFO - 'SHELL': '/bin/bash', 19:13:11 INFO - 'SHLVL': '1', 19:13:11 INFO - 'TERM': 'linux', 19:13:11 INFO - 'TMOUT': '86400', 19:13:11 INFO - 'USER': 'cltbld', 19:13:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', 19:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:11 INFO - '_': '/tools/buildbot/bin/python'} 19:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:13:11 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 19:13:11 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 19:13:11 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 19:13:11 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 19:13:11 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 19:13:11 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 19:13:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:13:13 INFO - Installing collected packages: mozsystemmonitor 19:13:13 INFO - Running setup.py install for mozsystemmonitor 19:13:13 INFO - Successfully installed mozsystemmonitor 19:13:13 INFO - Cleaning up... 19:13:13 INFO - Return code: 0 19:13:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:13 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 0x7f8f4082ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c01c0>, '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 0x11c10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c1550>, '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': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', '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 19:13:13 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 19:13:13 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 19:13:13 INFO - Using env: {'DISPLAY': ':0', 19:13:13 INFO - 'HOME': '/home/cltbld', 19:13:13 INFO - 'LANG': 'en_US.UTF-8', 19:13:13 INFO - 'LANGUAGE': 'en_US:en', 19:13:13 INFO - 'LOGNAME': 'cltbld', 19:13:13 INFO - 'MAIL': '/var/mail/cltbld', 19:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:13 INFO - 'MOZ_NO_REMOTE': '1', 19:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:13 INFO - 'NO_EM_RESTART': '1', 19:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:13 INFO - 'PWD': '/builds/slave/test', 19:13:13 INFO - 'SHELL': '/bin/bash', 19:13:13 INFO - 'SHLVL': '1', 19:13:13 INFO - 'TERM': 'linux', 19:13:13 INFO - 'TMOUT': '86400', 19:13:13 INFO - 'USER': 'cltbld', 19:13:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', 19:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:13 INFO - '_': '/tools/buildbot/bin/python'} 19:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:14 INFO - Downloading/unpacking jsonschema==2.5.1 19:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:13:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:13:16 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 19:13:16 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 19:13:16 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 19:13:16 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 19:13:16 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 19:13:16 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 19:13:16 INFO - Downloading functools32-3.2.3-2.tar.gz 19:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:13:16 INFO - warning: no files found matching '*.txt' 19:13:16 INFO - no previously-included directories found matching 'build' 19:13:16 INFO - no previously-included directories found matching 'dist' 19:13:16 INFO - no previously-included directories found matching '.git*' 19:13:16 INFO - Installing collected packages: jsonschema, functools32 19:13:16 INFO - Running setup.py install for functools32 19:13:16 INFO - warning: no files found matching '*.txt' 19:13:16 INFO - no previously-included directories found matching 'build' 19:13:16 INFO - no previously-included directories found matching 'dist' 19:13:16 INFO - no previously-included directories found matching '.git*' 19:13:16 INFO - Successfully installed jsonschema functools32 19:13:16 INFO - Cleaning up... 19:13:16 INFO - Return code: 0 19:13:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:13: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')]} 19:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13: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')]} 19:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:16 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 0x7f8f4082ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c01c0>, '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 0x11c10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c1550>, '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': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', '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 19:13:16 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 19:13:16 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 19:13:16 INFO - Using env: {'DISPLAY': ':0', 19:13:16 INFO - 'HOME': '/home/cltbld', 19:13:16 INFO - 'LANG': 'en_US.UTF-8', 19:13:16 INFO - 'LANGUAGE': 'en_US:en', 19:13:16 INFO - 'LOGNAME': 'cltbld', 19:13:16 INFO - 'MAIL': '/var/mail/cltbld', 19:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:16 INFO - 'MOZ_NO_REMOTE': '1', 19:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:16 INFO - 'NO_EM_RESTART': '1', 19:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:16 INFO - 'PWD': '/builds/slave/test', 19:13:16 INFO - 'SHELL': '/bin/bash', 19:13:16 INFO - 'SHLVL': '1', 19:13:16 INFO - 'TERM': 'linux', 19:13:16 INFO - 'TMOUT': '86400', 19:13:16 INFO - 'USER': 'cltbld', 19:13:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', 19:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:16 INFO - '_': '/tools/buildbot/bin/python'} 19:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:16 INFO - Downloading/unpacking blobuploader==1.2.4 19:13:16 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 19:13:16 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 19:13:16 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 19:13:16 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 19:13:16 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 19:13:16 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 19:13:18 INFO - Downloading blobuploader-1.2.4.tar.gz 19:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:13:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:13:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:13:19 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 19:13:19 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 19:13:19 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 19:13:19 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 19:13:19 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 19:13:19 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 19:13:19 INFO - Downloading docopt-0.6.1.tar.gz 19:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:13:19 INFO - Installing collected packages: blobuploader, requests, docopt 19:13:19 INFO - Running setup.py install for blobuploader 19:13:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:13:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:13:19 INFO - Running setup.py install for requests 19:13:19 INFO - Running setup.py install for docopt 19:13:19 INFO - Successfully installed blobuploader requests docopt 19:13:19 INFO - Cleaning up... 19:13:19 INFO - Return code: 0 19:13:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:13: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')]} 19:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13: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')]} 19:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:19 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 0x7f8f4082ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c01c0>, '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 0x11c10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c1550>, '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': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', '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 19:13:19 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 19:13:19 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 19:13:19 INFO - Using env: {'DISPLAY': ':0', 19:13:19 INFO - 'HOME': '/home/cltbld', 19:13:19 INFO - 'LANG': 'en_US.UTF-8', 19:13:19 INFO - 'LANGUAGE': 'en_US:en', 19:13:19 INFO - 'LOGNAME': 'cltbld', 19:13:19 INFO - 'MAIL': '/var/mail/cltbld', 19:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:19 INFO - 'MOZ_NO_REMOTE': '1', 19:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:19 INFO - 'NO_EM_RESTART': '1', 19:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:19 INFO - 'PWD': '/builds/slave/test', 19:13:19 INFO - 'SHELL': '/bin/bash', 19:13:19 INFO - 'SHLVL': '1', 19:13:19 INFO - 'TERM': 'linux', 19:13:19 INFO - 'TMOUT': '86400', 19:13:19 INFO - 'USER': 'cltbld', 19:13:19 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', 19:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:19 INFO - '_': '/tools/buildbot/bin/python'} 19:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:13:20 INFO - Running setup.py (path:/tmp/pip-wTZfqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:13:20 INFO - Running setup.py (path:/tmp/pip-0IlDdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:13:20 INFO - Running setup.py (path:/tmp/pip-sDXzN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:13:20 INFO - Running setup.py (path:/tmp/pip-m_XfaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:13:20 INFO - Running setup.py (path:/tmp/pip-cadiVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:13:20 INFO - Running setup.py (path:/tmp/pip-1PvBm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:13:20 INFO - Running setup.py (path:/tmp/pip-hxol5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:13:20 INFO - Running setup.py (path:/tmp/pip-IpAh9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:13:20 INFO - Running setup.py (path:/tmp/pip-h1Jcsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:13:20 INFO - Running setup.py (path:/tmp/pip-zg2Nfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:13:20 INFO - Running setup.py (path:/tmp/pip-TDGbfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:13:21 INFO - Running setup.py (path:/tmp/pip-t0fCif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:13:21 INFO - Running setup.py (path:/tmp/pip-0RuYwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:13:21 INFO - Running setup.py (path:/tmp/pip-le_ka_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:21 INFO - Running setup.py (path:/tmp/pip-QElDO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:13:21 INFO - Running setup.py (path:/tmp/pip-YDM1uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:13:21 INFO - Running setup.py (path:/tmp/pip-uIowOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:13:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:13:21 INFO - Running setup.py install for manifestparser 19:13:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:13:21 INFO - Running setup.py install for mozcrash 19:13:21 INFO - Running setup.py install for mozdebug 19:13:21 INFO - Running setup.py install for mozdevice 19:13:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:13:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:13:21 INFO - Running setup.py install for mozfile 19:13:21 INFO - Running setup.py install for mozhttpd 19:13:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Running setup.py install for mozinfo 19:13:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Running setup.py install for mozInstall 19:13:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Running setup.py install for mozleak 19:13:22 INFO - Running setup.py install for mozlog 19:13:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Running setup.py install for moznetwork 19:13:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Running setup.py install for mozprocess 19:13:22 INFO - Running setup.py install for mozprofile 19:13:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Running setup.py install for mozrunner 19:13:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Running setup.py install for mozscreenshot 19:13:23 INFO - Running setup.py install for moztest 19:13:23 INFO - Running setup.py install for mozversion 19:13:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:13:23 INFO - Cleaning up... 19:13:23 INFO - Return code: 0 19:13:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:23 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 0x7f8f4082ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c01c0>, '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 0x11c10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c1550>, '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': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', '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 19:13:23 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 19:13:23 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 19:13:23 INFO - Using env: {'DISPLAY': ':0', 19:13:23 INFO - 'HOME': '/home/cltbld', 19:13:23 INFO - 'LANG': 'en_US.UTF-8', 19:13:23 INFO - 'LANGUAGE': 'en_US:en', 19:13:23 INFO - 'LOGNAME': 'cltbld', 19:13:23 INFO - 'MAIL': '/var/mail/cltbld', 19:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:23 INFO - 'MOZ_NO_REMOTE': '1', 19:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:23 INFO - 'NO_EM_RESTART': '1', 19:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:23 INFO - 'PWD': '/builds/slave/test', 19:13:23 INFO - 'SHELL': '/bin/bash', 19:13:23 INFO - 'SHLVL': '1', 19:13:23 INFO - 'TERM': 'linux', 19:13:23 INFO - 'TMOUT': '86400', 19:13:23 INFO - 'USER': 'cltbld', 19:13:23 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', 19:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:23 INFO - '_': '/tools/buildbot/bin/python'} 19:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:13:23 INFO - Running setup.py (path:/tmp/pip-3M3Hqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:13:23 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)) 19:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:13:23 INFO - Running setup.py (path:/tmp/pip-CNsJU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:13:23 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)) 19:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:13:23 INFO - Running setup.py (path:/tmp/pip-H6cptV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:13:23 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)) 19:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:13:23 INFO - Running setup.py (path:/tmp/pip-Ehk8YZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:13:23 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)) 19:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:13:23 INFO - Running setup.py (path:/tmp/pip-rkHBI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:13:23 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)) 19:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:13:23 INFO - Running setup.py (path:/tmp/pip-Kgew7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:13:23 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)) 19:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:13:23 INFO - Running setup.py (path:/tmp/pip-ESk_FW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:13:23 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)) 19:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:13:23 INFO - Running setup.py (path:/tmp/pip-Dgy7zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:13:24 INFO - Running setup.py (path:/tmp/pip-CAQrWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:13:24 INFO - Running setup.py (path:/tmp/pip-3Tco5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:13:24 INFO - Running setup.py (path:/tmp/pip-xwXZdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:13:24 INFO - Running setup.py (path:/tmp/pip-bxC_H9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:13:24 INFO - Running setup.py (path:/tmp/pip-GLrFxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:13:24 INFO - Running setup.py (path:/tmp/pip-twt9gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:24 INFO - Running setup.py (path:/tmp/pip-u_n0BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:13:24 INFO - Running setup.py (path:/tmp/pip-xLZFWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:13:24 INFO - Running setup.py (path:/tmp/pip-0FyJAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:13:24 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)) 19:13:24 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)) 19:13:24 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)) 19:13:24 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)) 19:13:24 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)) 19:13:24 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)) 19:13:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:13:24 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 19:13:24 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 19:13:24 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 19:13:24 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 19:13:24 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 19:13:24 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 19:13:26 INFO - Downloading blessings-1.6.tar.gz 19:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:13:26 INFO - Installing collected packages: blessings 19:13:26 INFO - Running setup.py install for blessings 19:13:26 INFO - Successfully installed blessings 19:13:26 INFO - Cleaning up... 19:13:26 INFO - Return code: 0 19:13:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:13:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:13:27 INFO - Reading from file tmpfile_stdout 19:13:27 INFO - Current package versions: 19:13:27 INFO - argparse == 1.2.1 19:13:27 INFO - blessings == 1.6 19:13:27 INFO - blobuploader == 1.2.4 19:13:27 INFO - docopt == 0.6.1 19:13:27 INFO - functools32 == 3.2.3-2 19:13:27 INFO - jsonschema == 2.5.1 19:13:27 INFO - manifestparser == 1.1 19:13:27 INFO - mozInstall == 1.12 19:13:27 INFO - mozcrash == 0.17 19:13:27 INFO - mozdebug == 0.1 19:13:27 INFO - mozdevice == 0.48 19:13:27 INFO - mozfile == 1.2 19:13:27 INFO - mozhttpd == 0.7 19:13:27 INFO - mozinfo == 0.9 19:13:27 INFO - mozleak == 0.1 19:13:27 INFO - mozlog == 3.2 19:13:27 INFO - moznetwork == 0.27 19:13:27 INFO - mozprocess == 0.22 19:13:27 INFO - mozprofile == 0.28 19:13:27 INFO - mozrunner == 6.11 19:13:27 INFO - mozscreenshot == 0.1 19:13:27 INFO - mozsystemmonitor == 0.3 19:13:27 INFO - moztest == 0.7 19:13:27 INFO - mozversion == 1.4 19:13:27 INFO - psutil == 3.1.1 19:13:27 INFO - requests == 1.2.3 19:13:27 INFO - wsgiref == 0.1.2 19:13:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:27 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 0x7f8f4082ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c01c0>, '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 0x11c10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c1550>, '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': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', '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 19:13:27 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 19:13:27 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 19:13:27 INFO - Using env: {'DISPLAY': ':0', 19:13:27 INFO - 'HOME': '/home/cltbld', 19:13:27 INFO - 'LANG': 'en_US.UTF-8', 19:13:27 INFO - 'LANGUAGE': 'en_US:en', 19:13:27 INFO - 'LOGNAME': 'cltbld', 19:13:27 INFO - 'MAIL': '/var/mail/cltbld', 19:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:27 INFO - 'MOZ_NO_REMOTE': '1', 19:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:27 INFO - 'NO_EM_RESTART': '1', 19:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:27 INFO - 'PWD': '/builds/slave/test', 19:13:27 INFO - 'SHELL': '/bin/bash', 19:13:27 INFO - 'SHLVL': '1', 19:13:27 INFO - 'TERM': 'linux', 19:13:27 INFO - 'TMOUT': '86400', 19:13:27 INFO - 'USER': 'cltbld', 19:13:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', 19:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:27 INFO - '_': '/tools/buildbot/bin/python'} 19:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:27 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)) 19:13:27 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)) 19:13:27 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)) 19:13:27 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)) 19:13:27 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)) 19:13:27 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)) 19:13:27 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)) 19:13:27 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)) 19:13:27 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)) 19:13:27 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)) 19:13:27 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)) 19:13:27 INFO - Cleaning up... 19:13:27 INFO - Return code: 0 19:13:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:27 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 0x7f8f4082ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c01c0>, '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 0x11c10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c1550>, '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': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', '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 19:13:27 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 19:13:27 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 19:13:27 INFO - Using env: {'DISPLAY': ':0', 19:13:27 INFO - 'HOME': '/home/cltbld', 19:13:27 INFO - 'LANG': 'en_US.UTF-8', 19:13:27 INFO - 'LANGUAGE': 'en_US:en', 19:13:27 INFO - 'LOGNAME': 'cltbld', 19:13:27 INFO - 'MAIL': '/var/mail/cltbld', 19:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:27 INFO - 'MOZ_NO_REMOTE': '1', 19:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:27 INFO - 'NO_EM_RESTART': '1', 19:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:27 INFO - 'PWD': '/builds/slave/test', 19:13:27 INFO - 'SHELL': '/bin/bash', 19:13:27 INFO - 'SHLVL': '1', 19:13:27 INFO - 'TERM': 'linux', 19:13:27 INFO - 'TMOUT': '86400', 19:13:27 INFO - 'USER': 'cltbld', 19:13:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', 19:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:27 INFO - '_': '/tools/buildbot/bin/python'} 19:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:13:27 INFO - Cleaning up... 19:13:27 INFO - Return code: 0 19:13:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:27 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 0x7f8f4082ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c01c0>, '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 0x11c10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c1550>, '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': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', '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 19:13:27 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 19:13:27 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 19:13:27 INFO - Using env: {'DISPLAY': ':0', 19:13:27 INFO - 'HOME': '/home/cltbld', 19:13:27 INFO - 'LANG': 'en_US.UTF-8', 19:13:27 INFO - 'LANGUAGE': 'en_US:en', 19:13:27 INFO - 'LOGNAME': 'cltbld', 19:13:27 INFO - 'MAIL': '/var/mail/cltbld', 19:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:27 INFO - 'MOZ_NO_REMOTE': '1', 19:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:27 INFO - 'NO_EM_RESTART': '1', 19:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:27 INFO - 'PWD': '/builds/slave/test', 19:13:27 INFO - 'SHELL': '/bin/bash', 19:13:27 INFO - 'SHLVL': '1', 19:13:27 INFO - 'TERM': 'linux', 19:13:27 INFO - 'TMOUT': '86400', 19:13:27 INFO - 'USER': 'cltbld', 19:13:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', 19:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:27 INFO - '_': '/tools/buildbot/bin/python'} 19:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:27 INFO - Downloading/unpacking flake8 19:13:27 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 19:13:27 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 19:13:27 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 19:13:27 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 19:13:27 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 19:13:27 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 19:13:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:13:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:13:29 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 19:13:29 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 19:13:29 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 19:13:29 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 19:13:29 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 19:13:29 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 19:13:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:13:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:13:29 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 19:13:29 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 19:13:29 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 19:13:29 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 19:13:29 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 19:13:29 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 19:13:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:13: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 19:13: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 19:13: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 19:13: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 19:13: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 19:13: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 19:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:13:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:13:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:13:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:13:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:13:30 INFO - no previously-included directories found matching 'docs/_build' 19:13:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:13:30 INFO - Running setup.py install for pep8 19:13:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:13:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:13:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:13:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:13:30 INFO - no previously-included directories found matching 'docs/_build' 19:13:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:13:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:13:30 INFO - Cleaning up... 19:13:30 INFO - Return code: 0 19:13:30 INFO - Running post-action listener: _resource_record_post_action 19:13:30 INFO - Running post-action listener: _start_resource_monitoring 19:13:30 INFO - Starting resource monitoring. 19:13:30 INFO - ##### 19:13:30 INFO - ##### Finished create-virtualenv step (success) 19:13:30 INFO - ##### 19:13:30 INFO - ##### 19:13:30 INFO - ##### Running install step. 19:13:30 INFO - ##### 19:13:30 INFO - Running pre-action listener: _resource_record_pre_action 19:13:30 INFO - Running main action method: install 19:13:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:13:30 INFO - Reading from file tmpfile_stdout 19:13:30 INFO - Detecting whether we're running mozinstall >=1.0... 19:13:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:13:30 INFO - Reading from file tmpfile_stdout 19:13:30 INFO - Output received: 19:13:30 INFO - Usage: mozinstall [options] installer 19:13:30 INFO - Options: 19:13:30 INFO - -h, --help show this help message and exit 19:13:30 INFO - -d DEST, --destination=DEST 19:13:30 INFO - Directory to install application into. [default: 19:13:30 INFO - "/builds/slave/test"] 19:13:30 INFO - --app=APP Application being installed. [default: firefox] 19:13:30 INFO - mkdir: /builds/slave/test/build/application 19:13:30 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'] 19:13:30 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 19:13:47 INFO - Reading from file tmpfile_stdout 19:13:47 INFO - Output received: 19:13:47 INFO - /builds/slave/test/build/application/firefox/firefox 19:13:47 INFO - Running post-action listener: _resource_record_post_action 19:13:47 INFO - ##### 19:13:47 INFO - ##### Finished install step (success) 19:13:47 INFO - ##### 19:13:47 INFO - ##### 19:13:47 INFO - ##### Running run-tests step. 19:13:47 INFO - ##### 19:13:47 INFO - Running pre-action listener: _resource_record_pre_action 19:13:47 INFO - Running main action method: run_tests 19:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:13:47 INFO - Python 2.7.3 19:13:47 INFO - Return code: 0 19:13:47 INFO - grabbing minidump binary from tooltool 19:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:47 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 0x11c01c0>, '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 0x11c10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:13:47 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 19:13:47 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 19:13:47 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 19:13:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:13:47 INFO - Return code: 0 19:13:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:13:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:13:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:13:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:13:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:13:48 INFO - Return code: 0 19:13:48 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/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 19:13:48 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/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 19:13:48 INFO - Using env: {'DISPLAY': ':0', 19:13:48 INFO - 'HOME': '/home/cltbld', 19:13:48 INFO - 'LANG': 'en_US.UTF-8', 19:13:48 INFO - 'LANGUAGE': 'en_US:en', 19:13:48 INFO - 'LOGNAME': 'cltbld', 19:13:48 INFO - 'MAIL': '/var/mail/cltbld', 19:13:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:13:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:48 INFO - 'MOZ_NO_REMOTE': '1', 19:13:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:48 INFO - 'NO_EM_RESTART': '1', 19:13:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:48 INFO - 'PWD': '/builds/slave/test', 19:13:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:13:48 INFO - 'SHELL': '/bin/bash', 19:13:48 INFO - 'SHLVL': '1', 19:13:48 INFO - 'TERM': 'linux', 19:13:48 INFO - 'TMOUT': '86400', 19:13:48 INFO - 'USER': 'cltbld', 19:13:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878', 19:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:48 INFO - '_': '/tools/buildbot/bin/python'} 19:13:48 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/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 19:13:48 INFO - mozversion application_buildid: 20160624183759 19:13:48 INFO - mozversion application_changeset: 6de5b59dbcf95bb561d3c60f63743311f3f5d653 19:13:48 INFO - mozversion application_display_name: Nightly 19:13:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:13:48 INFO - mozversion application_name: Firefox 19:13:48 INFO - mozversion application_remotingname: firefox 19:13:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:13:48 INFO - mozversion application_vendor: Mozilla 19:13:48 INFO - mozversion application_version: 50.0a1 19:13:48 INFO - mozversion platform_buildid: 20160624183759 19:13:48 INFO - mozversion platform_changeset: 6de5b59dbcf95bb561d3c60f63743311f3f5d653 19:13:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:13:48 INFO - mozversion platform_version: 50.0a1 19:13:48 INFO - using testdate: 1466820828 19:13:48 INFO - actual date: 1466820828 19:13:48 INFO - starting webserver on 'localhost:60343' 19:13:48 INFO - SUITE-START | Running 2 tests 19:13:48 INFO - TEST-START | dromaeo_css 19:13:48 INFO - operating with platform_type : linux_ 19:13:48 INFO - Initialising browser for dromaeo_css test... 19:13:48 INFO - TEST-INFO | started process 16747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_gMkdk/profile http://localhost:60343/getInfo.html) 19:13:52 INFO - PROCESS | 16747 | __metrics Screen width/height:1600/1200 19:13:52 INFO - PROCESS | 16747 | colorDepth:24 19:13:52 INFO - PROCESS | 16747 | Browser inner width/height: 1024/697 19:13:52 INFO - PROCESS | 16747 | __metrics 19:13:53 INFO - PROCESS | 16747 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:13:54 INFO - TEST-INFO | 16747: exit 0 19:13:54 INFO - Browser initialized. 19:13:54 INFO - Running cycle 1/1 for dromaeo_css test... 19:13:54 INFO - TEST-INFO | started process 16830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_gMkdk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:14:06 INFO - PROCESS | 16830 | RSS: Main: 175333376 19:14:06 INFO - PROCESS | 16830 | 19:14:57 INFO - PROCESS | 16830 | 1466820897495 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] 19:17:10 INFO - PROCESS | 16830 | Cycle 1(1): loaded http://localhost:60343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60343/tests/dromaeo/cssquery-ext.html) 19:17:11 INFO - PROCESS | 16830 | RSS: Main: 251719680 19:17:11 INFO - PROCESS | 16830 | 19:20:14 INFO - PROCESS | 16830 | Cycle 1(1): loaded http://localhost:60343/tests/dromaeo/cssquery-ext.html (next: http://localhost:60343/tests/dromaeo/cssquery-jquery.html) 19:20:14 INFO - PROCESS | 16830 | RSS: Main: 252346368 19:20:14 INFO - PROCESS | 16830 | 19:23:17 INFO - PROCESS | 16830 | Cycle 1(1): loaded http://localhost:60343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60343/tests/dromaeo/cssquery-mootools.html) 19:23:17 INFO - PROCESS | 16830 | RSS: Main: 262496256 19:23:17 INFO - PROCESS | 16830 | 19:26:19 INFO - PROCESS | 16830 | Cycle 1(1): loaded http://localhost:60343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60343/tests/dromaeo/cssquery-prototype.html) 19:26:20 INFO - PROCESS | 16830 | RSS: Main: 257679360 19:26:20 INFO - PROCESS | 16830 | 19:29:23 INFO - PROCESS | 16830 | Cycle 1(1): loaded http://localhost:60343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60343/tests/dromaeo/cssquery-yui.html) 19:29:24 INFO - PROCESS | 16830 | RSS: Main: 229408768 19:29:24 INFO - PROCESS | 16830 | 19:32:26 INFO - PROCESS | 16830 | Cycle 1(1): loaded http://localhost:60343/tests/dromaeo/cssquery-yui.html (next: http://localhost:60343/tests/dromaeo/cssquery-dojo.html) 19:32:27 INFO - PROCESS | 16830 | RSS: Main: 337100800 19:32:27 INFO - PROCESS | 16830 | 19:32:27 INFO - PROCESS | 16830 | __start_tp_report 19:32:27 INFO - PROCESS | 16830 | _x_x_mozilla_page_load 19:32:27 INFO - PROCESS | 16830 | _x_x_mozilla_page_load_details 19:32:27 INFO - PROCESS | 16830 | |i|pagename|runs| 19:32:27 INFO - PROCESS | 16830 | |0;dojo.html;2607.830491018085;2630.526505229059;2662.9067982620604;2676.2907829425194;2682.155121136842;4736.052789442108;4816.422029356478;4827.927581086286;4896.094222568823;4922.729249891255;4808.278758186274;4820.8553743387665;4821.951780482194;4862.100511405392;4869.269609558568;4380.671449641273;4442;4452.666050046243;4510.842120525782;4579.084183163364;4472.127935052666;4511.278195488722;4525.389072475223;4528.456585209763;4551;4345.69580129391;4391.187630288407;4394.582514661102;4441.333799930004;4442.000549876284;4433.490148632884;4438.267685831834;4474.395956545857;4501.7974191161475;4509.954900451019;4474.597286244254;4478.57453541913;4527.366168736379;4530.3431002504785;4537.024539723942;4721.433427988629;4793.3049707792525;4802.831900883487;4835.830745923876;4853.102176097398;5237.528622424;5239.580833533309;5241.737913104368;5247.317848679685;5270.710110943896;5050.267711181858;5288.180332048539;5292.603054770908;5299.390570084451;5301.6818990860675;4845.345878306419;4896.926546101811;4897.608191344684;4957;4970.950290497121;5401.756920938567;5433.185022246695;5473.507384335429;5486.067368547277;5487.670739755627;5125.103106956268;5169.870753231199;5175.223716442564;5177.378714554202;5187.247849061865;5065.240213967934;5099.898002039939;5102.923456148161;5112.846614601568;5140.434552199255;5093.617978651616;5095.643304968691;5095.949040509621;5098.107831129538;5140.614453915897;4928.186849169919;5035.496450354935;5036.7733451994745;5039.143345631252;5060.671056381323;4270.978645106755;4290.570942905684;4353.717008394444;4355.564443555619;4414.668899832525;3788.981055094707;3818.8090595470117;3824.4263360496147;3846.480725102075;3858.710596705202;4531.546845315442;4537.205988951986;4539.523350048264;4540.795664195053;4582.610478109398;5022.196448568212;5040.344755181803;5144.331236939174;5178.792848286102;5190.584753219733;4486.506484286726;4514.142312960527;4517.977410112929;4521.864344069683;4570.108828778423;4568.588827005586;4616.976915115403;4646.697964632288;4664.650151238603;4699.812007519661;4879.682820616719;4902.215645496846;4922.064807686528;4940.481249468898;4951.282064100613;5225.059489291812;5228.398734145622;5253.474652534716;5256.342957130359;5316.734163291897;4721.4570324413135;4836.395450568679;4874.610031197425;4885.682430641997;4888.584470320063;5084.745762711924;5115.18157094863;5133.486651334837;5136.948630513796;5192.870178245574;5200.713960732196;5202.505761952609;5205.6356055075785;5215.087359711959;5219.582433405242;4927.60579153674;5050.065737838365;5054.2923990642075;5067.41724701664;5084.618653601069;5114.309568208244;5143.7428128594165;5144.717040562805;5146.408163061295;5177.741112944263;5051.520105589963;5057.367829021372;5095.490450954875;5108.514691104339;5109.386873575195;4905.558499735041;5019.222020586815;5071.264666623393;5095.4395016547405;5192.350956130484;4965.453800081916;4973.179425394914;4989.376327959005;4996.2505624156665;5053.242013697828 19:32:27 INFO - PROCESS | 16830 | |1;ext.html;560.6541625599906;577.3995045153041;587.5593305021234;591.9852003699909;601.7562887030751;26982.19053428398;38769.61230387695;38998.22003559927;39644.207115857665;40066.39900401493;36004;36445.63554364456;39834.60165398345;40178.59821401785;40178.79910600443;7560.092788865344;7732.845343093149;7843.921560784376;7873.370130389555;7879.133295337509;9901.950490247538;10212.489375531193;10218.540165692524;10513.158947284237;10526.578936842518;10182.898171018269;10257.692269231935;10280.22898282628;10281.691549253534;10328.793424131512;10033.548490317917;10101.040401161878;10101.848472272923;10112.241581881352;10114.039166279192;10040.648577299833;10098.091171794575;10098.596056157745;10106.44414557199;10112.342697724698;37902.43146352807;38132;38138.80930595329;38148.42777358342;38152.809235953646;2929.765618750495;2985.8656360463615;2988.8505574721394;3057.4343746406985;3137.074563003919;29069.70930290691;29893.551596726065;30104.247393815112;30215.546766798514;31018.534721979187;3043.893463728781;3107.3163903941095;3122.110198593413;3142.6543080261154;3177.9682203177904;251025;251919;253333;253623.73188134126;254704;56107;56541.151882721795;56626.99999999918;56732.71633641805;56776;58822.41177588255;58902;58983;59069;59074;14322.14067155974;14862.182579958206;14865;14873.33070011852;14876.70246595062;10302.587896484207;11173.888261117447;11226.158038147172;11406.771864562663;11439.428028598537;18285.908570457064;18353.63292734138;18441.26234950587;18475.81524184741;18507.35224267144;6571.5784477806;6871.4502839772695;6891.517593768388;6905.240423553506;7023.92976070243;824.530017889797;936.8313703533429;970.9805803884024;979.5396163803001;1001.7095042437758;27100.322491937466;27829.860850695615;28146.155615331572;28253.858730706215;28580;952.4951775558965;965.2663975378763;985.9507024648739;1016.1058268723624;1017.1405162637559;14593.78109328361;14917.47788827386;15150.621234469227;15251;15421.228938553028;383571;390711;391394;391558;395408;50118.49881501211;50238.49761502411;50383.74808125936;50675;50675.23987140196;1096.6052221200362;1181.0433548825479;1187.109667749188;1189.232944750631;1251.4243448014015;26580.202593922215;29541.261468462602;29675.85162074176;30007.099787006424;30210.84894575601;42952.35571466493;43766.56233437625;43776.343354849065;43778.562214377445;43869.341959871264;346365;355242;355507;356065;356067;32389.19027024343;33384;34019.82990085034;34077.318453631284;36530.8173459131;38416.80791596024;41657.37513937354;42348.36477452902;42937;42956.57043429526;35226.83191262934;36779.81610091932;36928;37451.81274093612;37519.624803752704;35489.290214195054;36237.45643815292;36419.45370819387;36433.81783091067;36622.450663240605;35424.46863297001;35598.11004724799;36612.450813238356;36692;36774.63225367712;31223.687763122078;32513.187170319987;33060.66939330576;33146.33707325792;33449.66550334466;24793.380165495284;25631.258217229126;27160.320991974568;27484.450310994067;27939.580906286017 19:32:27 INFO - PROCESS | 16830 | |2;jquery.html;367.3974681522304;371.817809273456;380.35150069132135;382.59062802801;395.40886374869575;15785.526434206979;16853;17144.742828857576;17152.485425437226;17182.48452546424;16324.918375408106;16480.505584832445;17058.573535661584;17313.134343282847;17364;4974.278729584208;5075.238714192882;5118.30902828119;5119.616028797836;5162.380514338284;3701.8334174962056;5026.894083301686;5726.68503232322;6085.908711369333;6100.633961962297;5836.941630583682;5988.461038506533;5998.190244317005;6027.487663548603;6039.969800150993;5752.137179423078;6003.309619393782;6028.427299406571;6028.819135425944;6033.155358249848;5308.681479111266;5308.73456327186;5317.042932272228;5320.388155362106;5336.626436149471;20742.066607002722;20941.685874711893;21112.472188195265;21202.469938251514;21319.5736085279;1983.6726940054873;1987.552800619849;2130.9147634094775;2168.577127460146;2345.2260753951155;13168.27574483403;13195.208287502684;13277.46890124394;13297.933510332483;13416.329183540784;1699.515638043164;1759.7712297401383;1781.5546113471632;1896.4500294914458;1915.789263181049;68975;69135;71002.28997710008;71068;71852;9838.212942964547;9895.60417583303;9957.651482198233;10053.497325133714;10066.49667516636;13748;13855.584332470042;13856.376463059187;13874.861251387358;13887.166769993833;7211.026511420996;7291.416686665054;7392.334689877936;7484.775456736198;7511.51175173612;6819.897701534481;6923.065386172802;6932.544165725153;7015.193252775996;7180.8922866157045;4343.413639158736;4392.934105988413;4415.712978656377;4447.110577884436;4516.954830451719;1799.4961410804995;1821.772278465192;1862.4133397979592;1872.6722823505831;1879.0886420086247;739.2348918868945;825.7275099217364;856.8372009318209;857.2456238510196;887.658251573149;16678.16609169561;16755.581110472336;16836.6632667346;17372.305107795546;17708.734368984475;829.1169904052285;847.741438861141;848.2154007542998;860.1742327365674;893.6693423433371;8065.879011814827;9682.56428460707;9853.901460985442;9904.950475247722;10053.59785608582;385632;403123;407934;408188;409513;50289.24566131511;55513.722431387585;75999.24000759922;78836;81187.59406203049;770.3182683325409;779.1001393390643;804.4248362420897;806.6289506826926;808.8058865872148;11909.22590031645;14673.779893301822;15336.15651139198;15472.613184670474;15844;27645.03242386507;30175.698243018167;33073.007809765746;36315;37151.81424092862;42884.78557607192;45020.77489612531;46874.53125468838;48964.75517622531;49064.509354906;7754.7673569793;8097.340045290819;11048.593350383504;11415.942920285346;11707.356095414834;11967.581134660246;12246.265224086583;12667;13130.949524037864;13191.604251872459;10933.234673572773;11325.433728313716;11328.490217940378;11331.433428328715;11378.260413073123;11210.383428911162;11411.714707132056;11423.714407139889;11513.50324457815;11515;11082.05802506796;11161.274517156358;11196.104311654884;11361.659150225507;11419.31484110956;11659.766804664028;11680.123990700562;11689.357085360387;11690.415479226174;11817.995470384769;10475.161987040867;10563.207759418228;10565.841512377167;10683.091937185427;10912.345259284468 19:32:27 INFO - PROCESS | 16830 | |3;mootools.html;1217.4338932396433;1340.7117469744005;1392.575264544314;1443.6174413780343;1723.4829551134656;7364.153122390927;7713.884291735614;7737.690492380305;8076.95961520193;8094.797630059252;7819.2571705688015;8014.95992520038;8018.759437216893;8019.037715474151;8030.91969080309;1874.7000479923215;1949.7855235924037;1949.9567731263776;2207.249535158046;2237.69791078204;1965.6854903215487;2150.892455377225;2253.346529506441;2256.4133325335447;2267.3424706835;2150.8817015064164;2186.661067534527;2197.0772275644267;2206.8234541236743;2207.7792220777956;1736.8436840684274;2099.0973881231066;2101.7898210179014;2103.6108319960704;2105.3999610111046;2039.7246371739923;2124.7768984256586;2126.383348828838;2127.361791462555;2128.361491552528;7993.240642138988;8023.719169829086;8040.2361775631225;8041.678332866678;8048.758537243892;4506.571875671806;4642.558956899089;4643.349931009661;4652.069586082763;4652.092841895832;2733.180045986216;2825.321922738528;2876.669183043956;2879.3809330993727;2884.769218462518;878.1701292278799;878.3939082033377;893.9418937769025;906.3836591118037;907.3240435875249;11068.501917413736;11071.612493562687;11075.446227688582;11085.556577736881;11108.833367499494;4110.301248787713;4271.530131685512;4303.806328715215;4385.101054283864;4386.298192289219;9222.308326875376;9233.722988310361;9235.399699019543;9238.86141707875;9243.168114869693;4722.858314250578;4724.763761811896;4727.527247275245;4728.645351598575;4734.147853386424;3225.2259457730447;3608.7293452990607;4195;4270.188664153863;4270.487541494978;3581.928361432757;3701.241245544657;3708.1841994761107;3734.6825519830577;3760.605136460687;1186.9584564540373;1203.897668698153;1207.8731733168067;1210.5278941212935;1232.3468561662332;702.2135208566439;810.878368244768;843.5318398289008;845.9788505287294;886.5833058462513;5224;5236.528712415901;5353.705546194997;5391.110466773017;5413.188021796684;414.23986983884305;420.03392197944606;422.2800125785528;423.40300176750634;910.1899309614448;3565.607783143852;3687.2809802088873;3701.130234394915;3737.252549490113;3763.9247215055548;9077.727668169833;9646.324757267064;10019.499025048719;10028.598856045823;10041.347312424816;9286.814263714688;9407.811843763086;9712.465814380135;9757.609695612238;9819.067188617213;7076.0801095857205;7079.29207079288;7250.60121693312;7251;7426.962865185747;5224.425313215467;5259.053370393366;5324.707141107277;5392.218128371443;5509.201165831012;8956.417832840845;9143;9220.354575179674;9231.76920576991;9241.584128714358;8686.478811271343;8950.820983580423;9002.144796244347;9095.863562046707;9320.207782338577;6655.134832471747;7192.532485388433;7370.262973702587;7385.667644956097;7548.282913123245;7582.014338136007;7635.847283054197;7651.311381975649;7654.846903062019;7674;6375.713092910923;6593.3736295051895;6672.8999065013095;6711.362420570038;6830.658467076726;6580.30906754803;6628;6633.900491492535;6657.900131498128;6702.229243637044;6428.939225027818;6431.48548116159;6457.289698133295;6529.249136349191;6532.477401807749;4541.795619197078;4579.816807327669;4610.331501932134;4780.306855506002;4810.59109975656;4498.662600305056;4602.677812553089;4619.907601848012;4668.369770080995;4696.976515117402 19:32:27 INFO - PROCESS | 16830 | |4;prototype.html;304.68312954527295;304.83995902151366;308.3909279173631;311.2064236197695;311.92669722615193;4903.926441103386;4914.483979182188;4915.926261106082;4919.139150648635;4949.480304568023;4894.290327902452;4897.779599918003;4913;4924.414682291798;4940.160172770628;3635.3638113330126;3762.4168253920684;3779.81100944953;3842.8078596070222;3870.9806450967844;3796.810159492028;3856.614338566149;3859.3824988001925;3861.2470568239205;3864.314301560403;3819.9236015279675;3820.426935959614;3821.29306078375;3824.120452295974;3825.387937929932;3618.113562177257;3703.8333275002688;3815.809209539512;3819.1597848473293;3843.577206507282;3348.484091703726;3368.8652453901814;3372.2581032172884;3373.375925453799;3386.4581666933173;4736.3369128322065;4739.431268247798;4746.620270378361;4748.839278128477;4769.54689304519;4243.130158317537;4354.477462704495;4366.192254432908;4366.672499562545;4380.167768124046;5077.416097148801;5090.720010399426;5093.828419463507;5094.261332106861;5111.565516931066;3676.7610105343333;3691.7600355977042;3696.6488183622514;3696.8890933272046;3711.033152429217;5150.175971844525;5324.866878327995;5371.811986580451;5386.973065134688;5387.434319396485;3759.8684046058256;3761.153740408386;3766.1902690921033;3783.3379158647126;3785.261873934556;3820.7582535676015;3821.140243445258;3824.464574959508;3827.3684842000757;3833.8083095845654;4308.633766129914;4329.2640251156745;4337.306031035019;4343.956560434355;4344.413504176959;4900.877478063006;5073.16292811682;5077.822276220315;5079.1365467870555;5091.847244582668;1316.1247770232878;1317.5849607373839;1330.9467621295234;1333.5665908579556;1340.805583190432;866.3502373220085;872.2978002707754;879.9704345915294;880.295763389286;916.9174774270348;4422.601965823092;4481.058977614737;4539.659525535598;4543.68194226401;4585.495595484494;5160.7935682573025;5176;5189.247559103985;5189.896202076013;5209.53114219722;4283.678724095706;4510.932336014962;4523.977380113144;4528.845144488135;4529.456465224194;2755;2761.62718033067;2784.7354501322343;2800.8739606717745;2803.4673412051643;4902.534259245366;4909.828156014522;4931.432885218246;4980.028894365636;4990.975045124751;5057.165567681292;5299.648589609625;5321.787128514816;5323;5337.86655333612;4890.608751299887;4893.314935908976;4903.166461701519;4916.287138364989;4949.975250123726;5174.197999309962;5221.477852214748;5221.869453263699;5234.607404444758;5246.685198888079;4964.553190212898;5083.186690129562;5112.821051263188;5129.435762066244;5139.537441630271;4860.3195552621955;4889.168841296917;4915;4918.2376731606655;4920.434150072644;3696.3716168250926;3741.2517496500263;3741.270452261783;3742.55089389275;3749.7562658427114;5003.44962054181;5192.766325515437;5236.345456817898;5239.7118158500125;5277.815276465305;5005.599552035901;5020.698758074527;5028.622853285945;5032.345795046621;5043.596512279082;5026.693059804404;5031.195008798574;5064.569511591409;5078.9238161426865;5106.821261255986;4800.279958006327;4957.429895561912;4978.626603004716;4998.325560936982;5006.349174607278;4921.778519966539;5005.974970125272;5055.570276526537;5121.283020377225;5135.87160320995;4991.276264941635;4999.625028122832;5010.3737032870895;5038.84883453497;5039.470855560114 19:32:27 INFO - PROCESS | 16830 | |5;yui.html;712.5582139073775;726.4914559808133;738.940884729222;756.2362014365489;766.134268276847;15282.617934551628;15803.841961580381;15814.209289535505;15841.603959901007;15842.84157158428;13789.793153102686;13791.448342066331;13861.722765544682;13929.373178206979;13939.93030034851;632.8765890651325;780.6760194519268;781.1524495921932;788.7673136424739;798.2655956520016;774.7753151586033;817.7587611654576;822.6092606012156;823.7446391618588;824.0523398092212;842.418731075559;843.527624530262;845.5476320168711;847.2840449819923;847.4957400346784;654.1757385694012;673.9123913891162;839.7774589733725;840.2143995364323;842.3640151685499;496.4365445219702;496.52829811678686;593.5666963116905;610.9450149486568;612.5558969746943;14058.789118163235;14071.788923166161;14084.507042253574;14102.788458173136;14143.504977325743;10606.734831629272;10760.73098172544;10777.83833242502;11051.392173430459;11103.225612986413;11885.405729713566;12100.515979360815;12186.268823870507;12200.816987745191;12305.876941230652;4054.5945405459515;4077.3883917412327;4131.483564554431;4164.56272091429;4210.157968406331;58017.419825801626;61055.69472152655;62300.37699622991;62714.37285627131;63255.68372158156;10244.948775256076;10263;10270.691879243635;10283.74290642725;10325.690229292983;18249;19335.323263685703;19401.708974365396;19442.611147776966;19450.319238826574;6944.756933507303;7017.298270173044;7065.1521817382245;7084;7251.383632391306;3567.304375646724;3661.2494438640015;3711.8515259389324;3745.8127093645207;3755.586885442599;2875.5830404591634;2973.3755911258877;2976.985115074454;2979.955300670492;2980.5976193214074;514.8970205958823;518.9065968125774;519.3715604118983;527.2144504687988;538.6391117950982;515.5669237840232;523.7250443517185;558.4973523828587;608.5253502268149;633.3318349141608;7765.92234077652;8000.35997120229;8144.714934977247;8259.297959673495;8463.788405289793;487.5709375749318;515.4253007896169;557.3729554251468;562.911597971522;635.4312889963456;3858.5369755629504;3916.6475017248586;3925.9018524537114;3954.3475326570792;4103.610157035077;78540;81330;89518;93855;93945;49664.50335496671;53592.73203633957;65683;66968;83233.58383208167;44445.33332000022;45784.54215457803;60599.69700151471;61009.389906101256;67733;8644.265237454887;8660.263877570225;8765.780855478664;8824.647014119364;8911.420757650732;41573.58426415697;42371.1525769489;43241;43446.70022846733;44165.558344416146;36666.63333366739;37379.626203737615;40709.59290407177;53034;58878.705606471696;10567.577296908345;10723.839142413026;10740.462976851282;10750.46247687628;11062.336259824437;12266.202696824677;12589.622311330675;12647.747045058863;12691.365431728562;12739.490420383452;11666.88333116658;11804.291742495478;11956.103292252941;12187;12319.75360492803;12168.756624867276;12222.449989750305;12659.177153485363;13075.019373547213;13124.803127953279;10840.178257184085;11534.307941523535;11896.643100706993;12260.509579616715;12275.263484190977;10140.29017968735;10273.345248763297;10474.423906685206;10725;10760.89239107599;9259.814803703754;9623.711288661352;9815.263855211031;10287.43419111956;10421.322614030063 19:32:27 INFO - PROCESS | 16830 | __end_tp_report 19:32:27 INFO - PROCESS | 16830 | __start_cc_report 19:32:27 INFO - PROCESS | 16830 | _x_x_mozilla_cycle_collect,1066 19:32:27 INFO - PROCESS | 16830 | __end_cc_report 19:32:27 INFO - PROCESS | 16830 | __startTimestamp1466821947105__endTimestamp 19:32:27 INFO - PROCESS | 16830 | 19:32:27 INFO - PROCESS | 16830 | ------- Summary: start ------- 19:32:27 INFO - PROCESS | 16830 | Number of tests: 6 19:32:27 INFO - PROCESS | 16830 | 19:32:27 INFO - PROCESS | 16830 | [#0] dojo.html Cycles:165 Average:4800.87 Median:4927.61 stddev:515.58 (10.5%) stddev-sans-first:487.61 19:32:27 INFO - PROCESS | 16830 | Values: 2607.8 2630.5 2662.9 2676.3 2682.2 4736.1 4816.4 4827.9 4896.1 4922.7 4808.3 4820.9 4822.0 4862.1 4869.3 4380.7 4442.0 4452.7 4510.8 4579.1 4472.1 4511.3 4525.4 4528.5 4551.0 4345.7 4391.2 4394.6 4441.3 4442.0 4433.5 4438.3 4474.4 4501.8 4510.0 4474.6 4478.6 4527.4 4530.3 4537.0 4721.4 4793.3 4802.8 4835.8 4853.1 5237.5 5239.6 5241.7 5247.3 5270.7 5050.3 5288.2 5292.6 5299.4 5301.7 4845.3 4896.9 4897.6 4957.0 4971.0 5401.8 5433.2 5473.5 5486.1 5487.7 5125.1 5169.9 5175.2 5177.4 5187.2 5065.2 5099.9 5102.9 5112.8 5140.4 5093.6 5095.6 5095.9 5098.1 5140.6 4928.2 5035.5 5036.8 5039.1 5060.7 4271.0 4290.6 4353.7 4355.6 4414.7 3789.0 3818.8 3824.4 3846.5 3858.7 4531.5 4537.2 4539.5 4540.8 4582.6 5022.2 5040.3 5144.3 5178.8 5190.6 4486.5 4514.1 4518.0 4521.9 4570.1 4568.6 4617.0 4646.7 4664.7 4699.8 4879.7 4902.2 4922.1 4940.5 4951.3 5225.1 5228.4 5253.5 5256.3 5316.7 4721.5 4836.4 4874.6 4885.7 4888.6 5084.7 5115.2 5133.5 5136.9 5192.9 5200.7 5202.5 5205.6 5215.1 5219.6 4927.6 5050.1 5054.3 5067.4 5084.6 5114.3 5143.7 5144.7 5146.4 5177.7 5051.5 5057.4 5095.5 5108.5 5109.4 4905.6 5019.2 5071.3 5095.4 5192.4 4965.5 4973.2 4989.4 4996.3 5053.2 19:32:27 INFO - PROCESS | 16830 | 19:32:27 INFO - PROCESS | 16830 | [#1] ext.html Cycles:180 Average:49345.47 Median:34048.57 stddev:88778.51 (260.7%) stddev-sans-first:88951.99 19:32:27 INFO - PROCESS | 16830 | Values: 560.7 577.4 587.6 592.0 601.8 26982.2 38769.6 38998.2 39644.2 40066.4 36004.0 36445.6 39834.6 40178.6 40178.8 7560.1 7732.8 7843.9 7873.4 7879.1 9902.0 10212.5 10218.5 10513.2 10526.6 10182.9 10257.7 10280.2 10281.7 10328.8 10033.5 10101.0 10101.8 10112.2 10114.0 10040.6 10098.1 10098.6 10106.4 10112.3 37902.4 38132.0 38138.8 38148.4 38152.8 2929.8 2985.9 2988.9 3057.4 3137.1 29069.7 29893.6 30104.2 30215.5 31018.5 3043.9 3107.3 3122.1 3142.7 3178.0 251025.0 251919.0 253333.0 253623.7 254704.0 56107.0 56541.2 56627.0 56732.7 56776.0 58822.4 58902.0 58983.0 59069.0 59074.0 14322.1 14862.2 14865.0 14873.3 14876.7 10302.6 11173.9 11226.2 11406.8 11439.4 18285.9 18353.6 18441.3 18475.8 18507.4 6571.6 6871.5 6891.5 6905.2 7023.9 824.5 936.8 971.0 979.5 1001.7 27100.3 27829.9 28146.2 28253.9 28580.0 952.5 965.3 986.0 1016.1 1017.1 14593.8 14917.5 15150.6 15251.0 15421.2 383571.0 390711.0 391394.0 391558.0 395408.0 50118.5 50238.5 50383.7 50675.0 50675.2 1096.6 1181.0 1187.1 1189.2 1251.4 26580.2 29541.3 29675.9 30007.1 30210.8 42952.4 43766.6 43776.3 43778.6 43869.3 346365.0 355242.0 355507.0 356065.0 356067.0 32389.2 33384.0 34019.8 34077.3 36530.8 38416.8 41657.4 42348.4 42937.0 42956.6 35226.8 36779.8 36928.0 37451.8 37519.6 35489.3 36237.5 36419.5 36433.8 36622.5 35424.5 35598.1 36612.5 36692.0 36774.6 31223.7 32513.2 33060.7 33146.3 33449.7 24793.4 25631.3 27160.3 27484.5 27939.6 19:32:27 INFO - PROCESS | 16830 | 19:32:27 INFO - PROCESS | 16830 | [#2] jquery.html Cycles:180 Average:24672.25 Median:2034.62 stddev:66182.22 (3252.8%) stddev-sans-first:66342.72 19:32:27 INFO - PROCESS | 16830 | Values: 367.4 371.8 380.4 382.6 395.4 15785.5 16853.0 17144.7 17152.5 17182.5 16324.9 16480.5 17058.6 17313.1 17364.0 4974.3 5075.2 5118.3 5119.6 5162.4 3701.8 5026.9 5726.7 6085.9 6100.6 5836.9 5988.5 5998.2 6027.5 6040.0 5752.1 6003.3 6028.4 6028.8 6033.2 5308.7 5308.7 5317.0 5320.4 5336.6 20742.1 20941.7 21112.5 21202.5 21319.6 1983.7 1987.6 2130.9 2168.6 2345.2 13168.3 13195.2 13277.5 13297.9 13416.3 1699.5 1759.8 1781.6 1896.5 1915.8 68975.0 69135.0 71002.3 71068.0 71852.0 9838.2 9895.6 9957.7 10053.5 10066.5 13748.0 13855.6 13856.4 13874.9 13887.2 7211.0 7291.4 7392.3 7484.8 7511.5 6819.9 6923.1 6932.5 7015.2 7180.9 4343.4 4392.9 4415.7 4447.1 4517.0 1799.5 1821.8 1862.4 1872.7 1879.1 739.2 825.7 856.8 857.2 887.7 16678.2 16755.6 16836.7 17372.3 17708.7 829.1 847.7 848.2 860.2 893.7 8065.9 9682.6 9853.9 9905.0 10053.6 385632.0 403123.0 407934.0 408188.0 409513.0 50289.2 55513.7 75999.2 78836.0 81187.6 770.3 779.1 804.4 806.6 808.8 11909.2 14673.8 15336.2 15472.6 15844.0 27645.0 30175.7 33073.0 36315.0 37151.8 42884.8 45020.8 46874.5 48964.8 49064.5 7754.8 8097.3 11048.6 11415.9 11707.4 11967.6 12246.3 12667.0 13130.9 13191.6 10933.2 11325.4 11328.5 11331.4 11378.3 11210.4 11411.7 11423.7 11513.5 11515.0 11082.1 11161.3 11196.1 11361.7 11419.3 11659.8 11680.1 11689.4 11690.4 11818.0 10475.2 10563.2 10565.8 10683.1 10912.3 19:32:27 INFO - PROCESS | 16830 | 19:32:27 INFO - PROCESS | 16830 | [#3] mootools.html Cycles:180 Average:5184.25 Median:4795.45 stddev:2970.36 (61.9%) stddev-sans-first:2963.73 19:32:27 INFO - PROCESS | 16830 | Values: 1217.4 1340.7 1392.6 1443.6 1723.5 7364.2 7713.9 7737.7 8077.0 8094.8 7819.3 8015.0 8018.8 8019.0 8030.9 1874.7 1949.8 1950.0 2207.2 2237.7 1965.7 2150.9 2253.3 2256.4 2267.3 2150.9 2186.7 2197.1 2206.8 2207.8 1736.8 2099.1 2101.8 2103.6 2105.4 2039.7 2124.8 2126.4 2127.4 2128.4 7993.2 8023.7 8040.2 8041.7 8048.8 4506.6 4642.6 4643.3 4652.1 4652.1 2733.2 2825.3 2876.7 2879.4 2884.8 878.2 878.4 893.9 906.4 907.3 11068.5 11071.6 11075.4 11085.6 11108.8 4110.3 4271.5 4303.8 4385.1 4386.3 9222.3 9233.7 9235.4 9238.9 9243.2 4722.9 4724.8 4727.5 4728.6 4734.1 3225.2 3608.7 4195.0 4270.2 4270.5 3581.9 3701.2 3708.2 3734.7 3760.6 1187.0 1203.9 1207.9 1210.5 1232.3 702.2 810.9 843.5 846.0 886.6 5224.0 5236.5 5353.7 5391.1 5413.2 414.2 420.0 422.3 423.4 910.2 3565.6 3687.3 3701.1 3737.3 3763.9 9077.7 9646.3 10019.5 10028.6 10041.3 9286.8 9407.8 9712.5 9757.6 9819.1 7076.1 7079.3 7250.6 7251.0 7427.0 5224.4 5259.1 5324.7 5392.2 5509.2 8956.4 9143.0 9220.4 9231.8 9241.6 8686.5 8950.8 9002.1 9095.9 9320.2 6655.1 7192.5 7370.3 7385.7 7548.3 7582.0 7635.8 7651.3 7654.8 7674.0 6375.7 6593.4 6672.9 6711.4 6830.7 6580.3 6628.0 6633.9 6657.9 6702.2 6428.9 6431.5 6457.3 6529.2 6532.5 4541.8 4579.8 4610.3 4780.3 4810.6 4498.7 4602.7 4619.9 4668.4 4697.0 19:32:27 INFO - PROCESS | 16830 | 19:32:27 INFO - PROCESS | 16830 | [#4] prototype.html Cycles:180 Average:4233.80 Median:4896.03 stddev:1213.64 (24.8%) stddev-sans-first:1180.67 19:32:27 INFO - PROCESS | 16830 | Values: 304.7 304.8 308.4 311.2 311.9 4903.9 4914.5 4915.9 4919.1 4949.5 4894.3 4897.8 4913.0 4924.4 4940.2 3635.4 3762.4 3779.8 3842.8 3871.0 3796.8 3856.6 3859.4 3861.2 3864.3 3819.9 3820.4 3821.3 3824.1 3825.4 3618.1 3703.8 3815.8 3819.2 3843.6 3348.5 3368.9 3372.3 3373.4 3386.5 4736.3 4739.4 4746.6 4748.8 4769.5 4243.1 4354.5 4366.2 4366.7 4380.2 5077.4 5090.7 5093.8 5094.3 5111.6 3676.8 3691.8 3696.6 3696.9 3711.0 5150.2 5324.9 5371.8 5387.0 5387.4 3759.9 3761.2 3766.2 3783.3 3785.3 3820.8 3821.1 3824.5 3827.4 3833.8 4308.6 4329.3 4337.3 4344.0 4344.4 4900.9 5073.2 5077.8 5079.1 5091.8 1316.1 1317.6 1330.9 1333.6 1340.8 866.4 872.3 880.0 880.3 916.9 4422.6 4481.1 4539.7 4543.7 4585.5 5160.8 5176.0 5189.2 5189.9 5209.5 4283.7 4510.9 4524.0 4528.8 4529.5 2755.0 2761.6 2784.7 2800.9 2803.5 4902.5 4909.8 4931.4 4980.0 4991.0 5057.2 5299.6 5321.8 5323.0 5337.9 4890.6 4893.3 4903.2 4916.3 4950.0 5174.2 5221.5 5221.9 5234.6 5246.7 4964.6 5083.2 5112.8 5129.4 5139.5 4860.3 4889.2 4915.0 4918.2 4920.4 3696.4 3741.3 3741.3 3742.6 3749.8 5003.4 5192.8 5236.3 5239.7 5277.8 5005.6 5020.7 5028.6 5032.3 5043.6 5026.7 5031.2 5064.6 5078.9 5106.8 4800.3 4957.4 4978.6 4998.3 5006.3 4921.8 5006.0 5055.6 5121.3 5135.9 4991.3 4999.6 5010.4 5038.8 5039.5 19:32:27 INFO - PROCESS | 16830 | 19:32:27 INFO - PROCESS | 16830 | [#5] yui.html Cycles:180 Average:16055.26 Median:23290.66 stddev:21238.02 (91.2%) stddev-sans-first:21266.36 19:32:27 INFO - PROCESS | 16830 | Values: 712.6 726.5 738.9 756.2 766.1 15282.6 15803.8 15814.2 15841.6 15842.8 13789.8 13791.4 13861.7 13929.4 13939.9 632.9 780.7 781.2 788.8 798.3 774.8 817.8 822.6 823.7 824.1 842.4 843.5 845.5 847.3 847.5 654.2 673.9 839.8 840.2 842.4 496.4 496.5 593.6 610.9 612.6 14058.8 14071.8 14084.5 14102.8 14143.5 10606.7 10760.7 10777.8 11051.4 11103.2 11885.4 12100.5 12186.3 12200.8 12305.9 4054.6 4077.4 4131.5 4164.6 4210.2 58017.4 61055.7 62300.4 62714.4 63255.7 10244.9 10263.0 10270.7 10283.7 10325.7 18249.0 19335.3 19401.7 19442.6 19450.3 6944.8 7017.3 7065.2 7084.0 7251.4 3567.3 3661.2 3711.9 3745.8 3755.6 2875.6 2973.4 2977.0 2980.0 2980.6 514.9 518.9 519.4 527.2 538.6 515.6 523.7 558.5 608.5 633.3 7765.9 8000.4 8144.7 8259.3 8463.8 487.6 515.4 557.4 562.9 635.4 3858.5 3916.6 3925.9 3954.3 4103.6 78540.0 81330.0 89518.0 93855.0 93945.0 49664.5 53592.7 65683.0 66968.0 83233.6 44445.3 45784.5 60599.7 61009.4 67733.0 8644.3 8660.3 8765.8 8824.6 8911.4 41573.6 42371.2 43241.0 43446.7 44165.6 36666.6 37379.6 40709.6 53034.0 58878.7 10567.6 10723.8 10740.5 10750.5 11062.3 12266.2 12589.6 12647.7 12691.4 12739.5 11666.9 11804.3 11956.1 12187.0 12319.8 12168.8 12222.4 12659.2 13075.0 13124.8 10840.2 11534.3 11896.6 12260.5 12275.3 10140.3 10273.3 10474.4 10725.0 10760.9 9259.8 9623.7 9815.3 10287.4 10421.3 19:32:27 INFO - PROCESS | 16830 | -------- Summary: end -------- 19:32:27 INFO - PROCESS | 16830 | 19:32:27 INFO - TEST-INFO | 16830: exit 0 19:32:27 INFO - TEST-OK | dromaeo_css | took 1119685ms 19:32:27 INFO - TEST-START | kraken 19:32:27 INFO - operating with platform_type : linux_ 19:32:27 INFO - Initialising browser for kraken test... 19:32:27 INFO - TEST-INFO | started process 17011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYYAOno/profile http://localhost:60343/getInfo.html) 19:32:32 INFO - PROCESS | 17011 | __metrics Screen width/height:1600/1200 19:32:32 INFO - PROCESS | 17011 | colorDepth:24 19:32:32 INFO - PROCESS | 17011 | Browser inner width/height: 1024/697 19:32:32 INFO - PROCESS | 17011 | __metrics 19:32:33 INFO - PROCESS | 17011 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:32:34 INFO - TEST-INFO | 17011: exit 0 19:32:34 INFO - Browser initialized. 19:32:34 INFO - Running cycle 1/1 for kraken test... 19:32:34 INFO - TEST-INFO | started process 17093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYYAOno/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:32:46 INFO - PROCESS | 17093 | RSS: Main: 176046080 19:32:46 INFO - PROCESS | 17093 | 19:32:48 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60343/tests/kraken/driver.html?testName=audio-beat-detection) 19:32:49 INFO - PROCESS | 17093 | RSS: Main: 234000384 19:32:49 INFO - PROCESS | 17093 | 19:32:52 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60343/tests/kraken/driver.html?testName=audio-dft) 19:32:53 INFO - PROCESS | 17093 | RSS: Main: 220880896 19:32:53 INFO - PROCESS | 17093 | 19:32:56 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60343/tests/kraken/driver.html?testName=audio-fft) 19:32:57 INFO - PROCESS | 17093 | RSS: Main: 288346112 19:32:57 INFO - PROCESS | 17093 | 19:32:59 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60343/tests/kraken/driver.html?testName=audio-oscillator) 19:32:59 INFO - PROCESS | 17093 | RSS: Main: 198598656 19:32:59 INFO - PROCESS | 17093 | 19:33:02 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:33:02 INFO - PROCESS | 17093 | RSS: Main: 201592832 19:33:02 INFO - PROCESS | 17093 | 19:33:05 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60343/tests/kraken/driver.html?testName=imaging-darkroom) 19:33:06 INFO - PROCESS | 17093 | RSS: Main: 238866432 19:33:06 INFO - PROCESS | 17093 | 19:33:10 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60343/tests/kraken/driver.html?testName=imaging-desaturate) 19:33:10 INFO - PROCESS | 17093 | RSS: Main: 233848832 19:33:10 INFO - PROCESS | 17093 | 19:33:13 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60343/tests/kraken/driver.html?testName=json-parse-financial) 19:33:14 INFO - PROCESS | 17093 | RSS: Main: 236711936 19:33:14 INFO - PROCESS | 17093 | 19:33:15 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:33:16 INFO - PROCESS | 17093 | RSS: Main: 223797248 19:33:16 INFO - PROCESS | 17093 | 19:33:18 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60343/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:33:18 INFO - PROCESS | 17093 | RSS: Main: 228257792 19:33:18 INFO - PROCESS | 17093 | 19:33:21 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:33:21 INFO - PROCESS | 17093 | RSS: Main: 235585536 19:33:21 INFO - PROCESS | 17093 | 19:33:24 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:33:25 INFO - PROCESS | 17093 | RSS: Main: 238743552 19:33:25 INFO - PROCESS | 17093 | 19:33:28 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:33:28 INFO - PROCESS | 17093 | RSS: Main: 240807936 19:33:28 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | Cycle 1(1): loaded http://localhost:60343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60343/tests/kraken/driver.html?testName=ai-astar) 19:33:30 INFO - PROCESS | 17093 | RSS: Main: 284012544 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | __start_tp_report 19:33:30 INFO - PROCESS | 17093 | _x_x_mozilla_page_load 19:33:30 INFO - PROCESS | 17093 | _x_x_mozilla_page_load_details 19:33:30 INFO - PROCESS | 17093 | |i|pagename|runs| 19:33:30 INFO - PROCESS | 17093 | |0;ai-astar;104;114;114;127;114;113;112;114;114;112 19:33:30 INFO - PROCESS | 17093 | |1;audio-beat-detection;161;130;133;189;138;152;136;155;172;130 19:33:30 INFO - PROCESS | 17093 | |2;audio-dft;161;163;164;165;161;161;161;161;162;162 19:33:30 INFO - PROCESS | 17093 | |3;audio-fft;75;76;76;124;77;77;75;74;99;78 19:33:30 INFO - PROCESS | 17093 | |4;audio-oscillator;85;86;123;85;85;86;118;85;85;128 19:33:30 INFO - PROCESS | 17093 | |5;imaging-gaussian-blur;116;117;117;117;118;117;117;117;118;117 19:33:30 INFO - PROCESS | 17093 | |6;imaging-darkroom;150;149;149;149;149;150;150;149;149;146 19:33:30 INFO - PROCESS | 17093 | |7;imaging-desaturate;95;95;95;95;96;96;95;95;95;96 19:33:30 INFO - PROCESS | 17093 | |8;json-parse-financial;64;63;65;64;65;65;64;63;64;64 19:33:30 INFO - PROCESS | 17093 | |9;json-stringify-tinderbox;64;65;64;64;65;64;64;64;64;65 19:33:30 INFO - PROCESS | 17093 | |10;stanford-crypto-aes;82;82;82;82;83;82;88;88;91;82 19:33:30 INFO - PROCESS | 17093 | |11;stanford-crypto-ccm;133;141;155;132;133;136;143;145;134;135 19:33:30 INFO - PROCESS | 17093 | |12;stanford-crypto-pbkdf2;172;169;171;168;173;172;177;168;172;165 19:33:30 INFO - PROCESS | 17093 | |13;stanford-crypto-sha256-iterative;68;67;67;71;66;66;67;68;66;65 19:33:30 INFO - PROCESS | 17093 | __end_tp_report 19:33:30 INFO - PROCESS | 17093 | __start_cc_report 19:33:30 INFO - PROCESS | 17093 | _x_x_mozilla_cycle_collect,1927 19:33:30 INFO - PROCESS | 17093 | __end_cc_report 19:33:30 INFO - PROCESS | 17093 | __startTimestamp1466822010829__endTimestamp 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | ------- Summary: start ------- 19:33:30 INFO - PROCESS | 17093 | Number of tests: 14 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:5.55 (4.9%) stddev-sans-first:4.62 19:33:30 INFO - PROCESS | 17093 | Values: 104.0 114.0 114.0 127.0 114.0 113.0 112.0 114.0 114.0 112.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:153.50 stddev:19.95 (13.0%) stddev-sans-first:20.73 19:33:30 INFO - PROCESS | 17093 | Values: 161.0 130.0 133.0 189.0 138.0 152.0 136.0 155.0 172.0 130.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.45 (0.9%) stddev-sans-first:1.48 19:33:30 INFO - PROCESS | 17093 | Values: 161.0 163.0 164.0 165.0 161.0 161.0 161.0 161.0 162.0 162.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.50 stddev:16.13 (21.1%) stddev-sans-first:16.84 19:33:30 INFO - PROCESS | 17093 | Values: 75.0 76.0 76.0 124.0 77.0 77.0 75.0 74.0 99.0 78.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:85.00 stddev:18.37 (21.6%) stddev-sans-first:19.00 19:33:30 INFO - PROCESS | 17093 | Values: 85.0 86.0 123.0 85.0 85.0 86.0 118.0 85.0 85.0 128.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 19:33:30 INFO - PROCESS | 17093 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.15 (0.8%) stddev-sans-first:1.17 19:33:30 INFO - PROCESS | 17093 | Values: 150.0 149.0 149.0 149.0 149.0 150.0 150.0 149.0 149.0 146.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:33:30 INFO - PROCESS | 17093 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 19:33:30 INFO - PROCESS | 17093 | Values: 64.0 63.0 65.0 64.0 65.0 65.0 64.0 63.0 64.0 64.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 19:33:30 INFO - PROCESS | 17093 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 65.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:82.50 stddev:3.43 (4.2%) stddev-sans-first:3.54 19:33:30 INFO - PROCESS | 17093 | Values: 82.0 82.0 82.0 82.0 83.0 82.0 88.0 88.0 91.0 82.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:138.50 stddev:7.32 (5.3%) stddev-sans-first:7.47 19:33:30 INFO - PROCESS | 17093 | Values: 133.0 141.0 155.0 132.0 133.0 136.0 143.0 145.0 134.0 135.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:172.00 stddev:3.33 (1.9%) stddev-sans-first:3.50 19:33:30 INFO - PROCESS | 17093 | Values: 172.0 169.0 171.0 168.0 173.0 172.0 177.0 168.0 172.0 165.0 19:33:30 INFO - PROCESS | 17093 | 19:33:30 INFO - PROCESS | 17093 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.66 (2.5%) stddev-sans-first:1.73 19:33:30 INFO - PROCESS | 17093 | Values: 68.0 67.0 67.0 71.0 66.0 66.0 67.0 68.0 66.0 65.0 19:33:30 INFO - PROCESS | 17093 | -------- Summary: end -------- 19:33:30 INFO - PROCESS | 17093 | 19:33:31 INFO - TEST-INFO | 17093: exit 0 19:33:31 INFO - TEST-OK | kraken | took 63995ms 19:33:31 INFO - SUITE-END | took 1183s 19:33:31 INFO - Completed test suite (00:19:43) 19:33:31 INFO - javascript benchmark 19:33:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.830491018085, 2630.526505229059, 2662.9067982620604, 2676.2907829425194, 2682.155121136842, 4736.052789442108, 4816.422029356478, 4827.927581086286, 4896.094222568823, 4922.729249891255, 4808.278758186274, 4820.8553743387665, 4821.951780482194, 4862.100511405392, 4869.269609558568, 4380.671449641273, 4442.0, 4452.666050046243, 4510.842120525782, 4579.084183163364, 4472.127935052666, 4511.278195488722, 4525.389072475223, 4528.456585209763, 4551.0, 4345.69580129391, 4391.187630288407, 4394.582514661102, 4441.333799930004, 4442.000549876284, 4433.490148632884, 4438.267685831834, 4474.395956545857, 4501.7974191161475, 4509.954900451019, 4474.597286244254, 4478.57453541913, 4527.366168736379, 4530.3431002504785, 4537.024539723942, 4721.433427988629, 4793.3049707792525, 4802.831900883487, 4835.830745923876, 4853.102176097398, 5237.528622424, 5239.580833533309, 5241.737913104368, 5247.317848679685, 5270.710110943896, 5050.267711181858, 5288.180332048539, 5292.603054770908, 5299.390570084451, 5301.6818990860675, 4845.345878306419, 4896.926546101811, 4897.608191344684, 4957.0, 4970.950290497121, 5401.756920938567, 5433.185022246695, 5473.507384335429, 5486.067368547277, 5487.670739755627, 5125.103106956268, 5169.870753231199, 5175.223716442564, 5177.378714554202, 5187.247849061865, 5065.240213967934, 5099.898002039939, 5102.923456148161, 5112.846614601568, 5140.434552199255, 5093.617978651616, 5095.643304968691, 5095.949040509621, 5098.107831129538, 5140.614453915897, 4928.186849169919, 5035.496450354935, 5036.7733451994745, 5039.143345631252, 5060.671056381323, 4270.978645106755, 4290.570942905684, 4353.717008394444, 4355.564443555619, 4414.668899832525, 3788.981055094707, 3818.8090595470117, 3824.4263360496147, 3846.480725102075, 3858.710596705202, 4531.546845315442, 4537.205988951986, 4539.523350048264, 4540.795664195053, 4582.610478109398, 5022.196448568212, 5040.344755181803, 5144.331236939174, 5178.792848286102, 5190.584753219733, 4486.506484286726, 4514.142312960527, 4517.977410112929, 4521.864344069683, 4570.108828778423, 4568.588827005586, 4616.976915115403, 4646.697964632288, 4664.650151238603, 4699.812007519661, 4879.682820616719, 4902.215645496846, 4922.064807686528, 4940.481249468898, 4951.282064100613, 5225.059489291812, 5228.398734145622, 5253.474652534716, 5256.342957130359, 5316.734163291897, 4721.4570324413135, 4836.395450568679, 4874.610031197425, 4885.682430641997, 4888.584470320063, 5084.745762711924, 5115.18157094863, 5133.486651334837, 5136.948630513796, 5192.870178245574, 5200.713960732196, 5202.505761952609, 5205.6356055075785, 5215.087359711959, 5219.582433405242, 4927.60579153674, 5050.065737838365, 5054.2923990642075, 5067.41724701664, 5084.618653601069, 5114.309568208244, 5143.7428128594165, 5144.717040562805, 5146.408163061295, 5177.741112944263, 5051.520105589963, 5057.367829021372, 5095.490450954875, 5108.514691104339, 5109.386873575195, 4905.558499735041, 5019.222020586815, 5071.264666623393, 5095.4395016547405, 5192.350956130484, 4965.453800081916, 4973.179425394914, 4989.376327959005, 4996.2505624156665, 5053.242013697828], "value": 4766.780127865018, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.6541625599906, 577.3995045153041, 587.5593305021234, 591.9852003699909, 601.7562887030751, 26982.19053428398, 38769.61230387695, 38998.22003559927, 39644.207115857665, 40066.39900401493, 36004.0, 36445.63554364456, 39834.60165398345, 40178.59821401785, 40178.79910600443, 7560.092788865344, 7732.845343093149, 7843.921560784376, 7873.370130389555, 7879.133295337509, 9901.950490247538, 10212.489375531193, 10218.540165692524, 10513.158947284237, 10526.578936842518, 10182.898171018269, 10257.692269231935, 10280.22898282628, 10281.691549253534, 10328.793424131512, 10033.548490317917, 10101.040401161878, 10101.848472272923, 10112.241581881352, 10114.039166279192, 10040.648577299833, 10098.091171794575, 10098.596056157745, 10106.44414557199, 10112.342697724698, 37902.43146352807, 38132.0, 38138.80930595329, 38148.42777358342, 38152.809235953646, 2929.765618750495, 2985.8656360463615, 2988.8505574721394, 3057.4343746406985, 3137.074563003919, 29069.70930290691, 29893.551596726065, 30104.247393815112, 30215.546766798514, 31018.534721979187, 3043.893463728781, 3107.3163903941095, 3122.110198593413, 3142.6543080261154, 3177.9682203177904, 251025.0, 251919.0, 253333.0, 253623.73188134126, 254704.0, 56107.0, 56541.151882721795, 56626.99999999918, 56732.71633641805, 56776.0, 58822.41177588255, 58902.0, 58983.0, 59069.0, 59074.0, 14322.14067155974, 14862.182579958206, 14865.0, 14873.33070011852, 14876.70246595062, 10302.587896484207, 11173.888261117447, 11226.158038147172, 11406.771864562663, 11439.428028598537, 18285.908570457064, 18353.63292734138, 18441.26234950587, 18475.81524184741, 18507.35224267144, 6571.5784477806, 6871.4502839772695, 6891.517593768388, 6905.240423553506, 7023.92976070243, 824.530017889797, 936.8313703533429, 970.9805803884024, 979.5396163803001, 1001.7095042437758, 27100.322491937466, 27829.860850695615, 28146.155615331572, 28253.858730706215, 28580.0, 952.4951775558965, 965.2663975378763, 985.9507024648739, 1016.1058268723624, 1017.1405162637559, 14593.78109328361, 14917.47788827386, 15150.621234469227, 15251.0, 15421.228938553028, 383571.0, 390711.0, 391394.0, 391558.0, 395408.0, 50118.49881501211, 50238.49761502411, 50383.74808125936, 50675.0, 50675.23987140196, 1096.6052221200362, 1181.0433548825479, 1187.109667749188, 1189.232944750631, 1251.4243448014015, 26580.202593922215, 29541.261468462602, 29675.85162074176, 30007.099787006424, 30210.84894575601, 42952.35571466493, 43766.56233437625, 43776.343354849065, 43778.562214377445, 43869.341959871264, 346365.0, 355242.0, 355507.0, 356065.0, 356067.0, 32389.19027024343, 33384.0, 34019.82990085034, 34077.318453631284, 36530.8173459131, 38416.80791596024, 41657.37513937354, 42348.36477452902, 42937.0, 42956.57043429526, 35226.83191262934, 36779.81610091932, 36928.0, 37451.81274093612, 37519.624803752704, 35489.290214195054, 36237.45643815292, 36419.45370819387, 36433.81783091067, 36622.450663240605, 35424.46863297001, 35598.11004724799, 36612.450813238356, 36692.0, 36774.63225367712, 31223.687763122078, 32513.187170319987, 33060.66939330576, 33146.33707325792, 33449.66550334466, 24793.380165495284, 25631.258217229126, 27160.320991974568, 27484.450310994067, 27939.580906286017], "value": 18369.23865306263, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.3974681522304, 371.817809273456, 380.35150069132135, 382.59062802801, 395.40886374869575, 15785.526434206979, 16853.0, 17144.742828857576, 17152.485425437226, 17182.48452546424, 16324.918375408106, 16480.505584832445, 17058.573535661584, 17313.134343282847, 17364.0, 4974.278729584208, 5075.238714192882, 5118.30902828119, 5119.616028797836, 5162.380514338284, 3701.8334174962056, 5026.894083301686, 5726.68503232322, 6085.908711369333, 6100.633961962297, 5836.941630583682, 5988.461038506533, 5998.190244317005, 6027.487663548603, 6039.969800150993, 5752.137179423078, 6003.309619393782, 6028.427299406571, 6028.819135425944, 6033.155358249848, 5308.681479111266, 5308.73456327186, 5317.042932272228, 5320.388155362106, 5336.626436149471, 20742.066607002722, 20941.685874711893, 21112.472188195265, 21202.469938251514, 21319.5736085279, 1983.6726940054873, 1987.552800619849, 2130.9147634094775, 2168.577127460146, 2345.2260753951155, 13168.27574483403, 13195.208287502684, 13277.46890124394, 13297.933510332483, 13416.329183540784, 1699.515638043164, 1759.7712297401383, 1781.5546113471632, 1896.4500294914458, 1915.789263181049, 68975.0, 69135.0, 71002.28997710008, 71068.0, 71852.0, 9838.212942964547, 9895.60417583303, 9957.651482198233, 10053.497325133714, 10066.49667516636, 13748.0, 13855.584332470042, 13856.376463059187, 13874.861251387358, 13887.166769993833, 7211.026511420996, 7291.416686665054, 7392.334689877936, 7484.775456736198, 7511.51175173612, 6819.897701534481, 6923.065386172802, 6932.544165725153, 7015.193252775996, 7180.8922866157045, 4343.413639158736, 4392.934105988413, 4415.712978656377, 4447.110577884436, 4516.954830451719, 1799.4961410804995, 1821.772278465192, 1862.4133397979592, 1872.6722823505831, 1879.0886420086247, 739.2348918868945, 825.7275099217364, 856.8372009318209, 857.2456238510196, 887.658251573149, 16678.16609169561, 16755.581110472336, 16836.6632667346, 17372.305107795546, 17708.734368984475, 829.1169904052285, 847.741438861141, 848.2154007542998, 860.1742327365674, 893.6693423433371, 8065.879011814827, 9682.56428460707, 9853.901460985442, 9904.950475247722, 10053.59785608582, 385632.0, 403123.0, 407934.0, 408188.0, 409513.0, 50289.24566131511, 55513.722431387585, 75999.24000759922, 78836.0, 81187.59406203049, 770.3182683325409, 779.1001393390643, 804.4248362420897, 806.6289506826926, 808.8058865872148, 11909.22590031645, 14673.779893301822, 15336.15651139198, 15472.613184670474, 15844.0, 27645.03242386507, 30175.698243018167, 33073.007809765746, 36315.0, 37151.81424092862, 42884.78557607192, 45020.77489612531, 46874.53125468838, 48964.75517622531, 49064.509354906, 7754.7673569793, 8097.340045290819, 11048.593350383504, 11415.942920285346, 11707.356095414834, 11967.581134660246, 12246.265224086583, 12667.0, 13130.949524037864, 13191.604251872459, 10933.234673572773, 11325.433728313716, 11328.490217940378, 11331.433428328715, 11378.260413073123, 11210.383428911162, 11411.714707132056, 11423.714407139889, 11513.50324457815, 11515.0, 11082.05802506796, 11161.274517156358, 11196.104311654884, 11361.659150225507, 11419.31484110956, 11659.766804664028, 11680.123990700562, 11689.357085360387, 11690.415479226174, 11817.995470384769, 10475.161987040867, 10563.207759418228, 10565.841512377167, 10683.091937185427, 10912.345259284468], "value": 8522.88389668653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.4338932396433, 1340.7117469744005, 1392.575264544314, 1443.6174413780343, 1723.4829551134656, 7364.153122390927, 7713.884291735614, 7737.690492380305, 8076.95961520193, 8094.797630059252, 7819.2571705688015, 8014.95992520038, 8018.759437216893, 8019.037715474151, 8030.91969080309, 1874.7000479923215, 1949.7855235924037, 1949.9567731263776, 2207.249535158046, 2237.69791078204, 1965.6854903215487, 2150.892455377225, 2253.346529506441, 2256.4133325335447, 2267.3424706835, 2150.8817015064164, 2186.661067534527, 2197.0772275644267, 2206.8234541236743, 2207.7792220777956, 1736.8436840684274, 2099.0973881231066, 2101.7898210179014, 2103.6108319960704, 2105.3999610111046, 2039.7246371739923, 2124.7768984256586, 2126.383348828838, 2127.361791462555, 2128.361491552528, 7993.240642138988, 8023.719169829086, 8040.2361775631225, 8041.678332866678, 8048.758537243892, 4506.571875671806, 4642.558956899089, 4643.349931009661, 4652.069586082763, 4652.092841895832, 2733.180045986216, 2825.321922738528, 2876.669183043956, 2879.3809330993727, 2884.769218462518, 878.1701292278799, 878.3939082033377, 893.9418937769025, 906.3836591118037, 907.3240435875249, 11068.501917413736, 11071.612493562687, 11075.446227688582, 11085.556577736881, 11108.833367499494, 4110.301248787713, 4271.530131685512, 4303.806328715215, 4385.101054283864, 4386.298192289219, 9222.308326875376, 9233.722988310361, 9235.399699019543, 9238.86141707875, 9243.168114869693, 4722.858314250578, 4724.763761811896, 4727.527247275245, 4728.645351598575, 4734.147853386424, 3225.2259457730447, 3608.7293452990607, 4195.0, 4270.188664153863, 4270.487541494978, 3581.928361432757, 3701.241245544657, 3708.1841994761107, 3734.6825519830577, 3760.605136460687, 1186.9584564540373, 1203.897668698153, 1207.8731733168067, 1210.5278941212935, 1232.3468561662332, 702.2135208566439, 810.878368244768, 843.5318398289008, 845.9788505287294, 886.5833058462513, 5224.0, 5236.528712415901, 5353.705546194997, 5391.110466773017, 5413.188021796684, 414.23986983884305, 420.03392197944606, 422.2800125785528, 423.40300176750634, 910.1899309614448, 3565.607783143852, 3687.2809802088873, 3701.130234394915, 3737.252549490113, 3763.9247215055548, 9077.727668169833, 9646.324757267064, 10019.499025048719, 10028.598856045823, 10041.347312424816, 9286.814263714688, 9407.811843763086, 9712.465814380135, 9757.609695612238, 9819.067188617213, 7076.0801095857205, 7079.29207079288, 7250.60121693312, 7251.0, 7426.962865185747, 5224.425313215467, 5259.053370393366, 5324.707141107277, 5392.218128371443, 5509.201165831012, 8956.417832840845, 9143.0, 9220.354575179674, 9231.76920576991, 9241.584128714358, 8686.478811271343, 8950.820983580423, 9002.144796244347, 9095.863562046707, 9320.207782338577, 6655.134832471747, 7192.532485388433, 7370.262973702587, 7385.667644956097, 7548.282913123245, 7582.014338136007, 7635.847283054197, 7651.311381975649, 7654.846903062019, 7674.0, 6375.713092910923, 6593.3736295051895, 6672.8999065013095, 6711.362420570038, 6830.658467076726, 6580.30906754803, 6628.0, 6633.900491492535, 6657.900131498128, 6702.229243637044, 6428.939225027818, 6431.48548116159, 6457.289698133295, 6529.249136349191, 6532.477401807749, 4541.795619197078, 4579.816807327669, 4610.331501932134, 4780.306855506002, 4810.59109975656, 4498.662600305056, 4602.677812553089, 4619.907601848012, 4668.369770080995, 4696.976515117402], "value": 4091.699832956897, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.68312954527295, 304.83995902151366, 308.3909279173631, 311.2064236197695, 311.92669722615193, 4903.926441103386, 4914.483979182188, 4915.926261106082, 4919.139150648635, 4949.480304568023, 4894.290327902452, 4897.779599918003, 4913.0, 4924.414682291798, 4940.160172770628, 3635.3638113330126, 3762.4168253920684, 3779.81100944953, 3842.8078596070222, 3870.9806450967844, 3796.810159492028, 3856.614338566149, 3859.3824988001925, 3861.2470568239205, 3864.314301560403, 3819.9236015279675, 3820.426935959614, 3821.29306078375, 3824.120452295974, 3825.387937929932, 3618.113562177257, 3703.8333275002688, 3815.809209539512, 3819.1597848473293, 3843.577206507282, 3348.484091703726, 3368.8652453901814, 3372.2581032172884, 3373.375925453799, 3386.4581666933173, 4736.3369128322065, 4739.431268247798, 4746.620270378361, 4748.839278128477, 4769.54689304519, 4243.130158317537, 4354.477462704495, 4366.192254432908, 4366.672499562545, 4380.167768124046, 5077.416097148801, 5090.720010399426, 5093.828419463507, 5094.261332106861, 5111.565516931066, 3676.7610105343333, 3691.7600355977042, 3696.6488183622514, 3696.8890933272046, 3711.033152429217, 5150.175971844525, 5324.866878327995, 5371.811986580451, 5386.973065134688, 5387.434319396485, 3759.8684046058256, 3761.153740408386, 3766.1902690921033, 3783.3379158647126, 3785.261873934556, 3820.7582535676015, 3821.140243445258, 3824.464574959508, 3827.3684842000757, 3833.8083095845654, 4308.633766129914, 4329.2640251156745, 4337.306031035019, 4343.956560434355, 4344.413504176959, 4900.877478063006, 5073.16292811682, 5077.822276220315, 5079.1365467870555, 5091.847244582668, 1316.1247770232878, 1317.5849607373839, 1330.9467621295234, 1333.5665908579556, 1340.805583190432, 866.3502373220085, 872.2978002707754, 879.9704345915294, 880.295763389286, 916.9174774270348, 4422.601965823092, 4481.058977614737, 4539.659525535598, 4543.68194226401, 4585.495595484494, 5160.7935682573025, 5176.0, 5189.247559103985, 5189.896202076013, 5209.53114219722, 4283.678724095706, 4510.932336014962, 4523.977380113144, 4528.845144488135, 4529.456465224194, 2755.0, 2761.62718033067, 2784.7354501322343, 2800.8739606717745, 2803.4673412051643, 4902.534259245366, 4909.828156014522, 4931.432885218246, 4980.028894365636, 4990.975045124751, 5057.165567681292, 5299.648589609625, 5321.787128514816, 5323.0, 5337.86655333612, 4890.608751299887, 4893.314935908976, 4903.166461701519, 4916.287138364989, 4949.975250123726, 5174.197999309962, 5221.477852214748, 5221.869453263699, 5234.607404444758, 5246.685198888079, 4964.553190212898, 5083.186690129562, 5112.821051263188, 5129.435762066244, 5139.537441630271, 4860.3195552621955, 4889.168841296917, 4915.0, 4918.2376731606655, 4920.434150072644, 3696.3716168250926, 3741.2517496500263, 3741.270452261783, 3742.55089389275, 3749.7562658427114, 5003.44962054181, 5192.766325515437, 5236.345456817898, 5239.7118158500125, 5277.815276465305, 5005.599552035901, 5020.698758074527, 5028.622853285945, 5032.345795046621, 5043.596512279082, 5026.693059804404, 5031.195008798574, 5064.569511591409, 5078.9238161426865, 5106.821261255986, 4800.279958006327, 4957.429895561912, 4978.626603004716, 4998.325560936982, 5006.349174607278, 4921.778519966539, 5005.974970125272, 5055.570276526537, 5121.283020377225, 5135.87160320995, 4991.276264941635, 4999.625028122832, 5010.3737032870895, 5038.84883453497, 5039.470855560114], "value": 3850.988379731197, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.5582139073775, 726.4914559808133, 738.940884729222, 756.2362014365489, 766.134268276847, 15282.617934551628, 15803.841961580381, 15814.209289535505, 15841.603959901007, 15842.84157158428, 13789.793153102686, 13791.448342066331, 13861.722765544682, 13929.373178206979, 13939.93030034851, 632.8765890651325, 780.6760194519268, 781.1524495921932, 788.7673136424739, 798.2655956520016, 774.7753151586033, 817.7587611654576, 822.6092606012156, 823.7446391618588, 824.0523398092212, 842.418731075559, 843.527624530262, 845.5476320168711, 847.2840449819923, 847.4957400346784, 654.1757385694012, 673.9123913891162, 839.7774589733725, 840.2143995364323, 842.3640151685499, 496.4365445219702, 496.52829811678686, 593.5666963116905, 610.9450149486568, 612.5558969746943, 14058.789118163235, 14071.788923166161, 14084.507042253574, 14102.788458173136, 14143.504977325743, 10606.734831629272, 10760.73098172544, 10777.83833242502, 11051.392173430459, 11103.225612986413, 11885.405729713566, 12100.515979360815, 12186.268823870507, 12200.816987745191, 12305.876941230652, 4054.5945405459515, 4077.3883917412327, 4131.483564554431, 4164.56272091429, 4210.157968406331, 58017.419825801626, 61055.69472152655, 62300.37699622991, 62714.37285627131, 63255.68372158156, 10244.948775256076, 10263.0, 10270.691879243635, 10283.74290642725, 10325.690229292983, 18249.0, 19335.323263685703, 19401.708974365396, 19442.611147776966, 19450.319238826574, 6944.756933507303, 7017.298270173044, 7065.1521817382245, 7084.0, 7251.383632391306, 3567.304375646724, 3661.2494438640015, 3711.8515259389324, 3745.8127093645207, 3755.586885442599, 2875.5830404591634, 2973.3755911258877, 2976.985115074454, 2979.955300670492, 2980.5976193214074, 514.8970205958823, 518.9065968125774, 519.3715604118983, 527.2144504687988, 538.6391117950982, 515.5669237840232, 523.7250443517185, 558.4973523828587, 608.5253502268149, 633.3318349141608, 7765.92234077652, 8000.35997120229, 8144.714934977247, 8259.297959673495, 8463.788405289793, 487.5709375749318, 515.4253007896169, 557.3729554251468, 562.911597971522, 635.4312889963456, 3858.5369755629504, 3916.6475017248586, 3925.9018524537114, 3954.3475326570792, 4103.610157035077, 78540.0, 81330.0, 89518.0, 93855.0, 93945.0, 49664.50335496671, 53592.73203633957, 65683.0, 66968.0, 83233.58383208167, 44445.33332000022, 45784.54215457803, 60599.69700151471, 61009.389906101256, 67733.0, 8644.265237454887, 8660.263877570225, 8765.780855478664, 8824.647014119364, 8911.420757650732, 41573.58426415697, 42371.1525769489, 43241.0, 43446.70022846733, 44165.558344416146, 36666.63333366739, 37379.626203737615, 40709.59290407177, 53034.0, 58878.705606471696, 10567.577296908345, 10723.839142413026, 10740.462976851282, 10750.46247687628, 11062.336259824437, 12266.202696824677, 12589.622311330675, 12647.747045058863, 12691.365431728562, 12739.490420383452, 11666.88333116658, 11804.291742495478, 11956.103292252941, 12187.0, 12319.75360492803, 12168.756624867276, 12222.449989750305, 12659.177153485363, 13075.019373547213, 13124.803127953279, 10840.178257184085, 11534.307941523535, 11896.643100706993, 12260.509579616715, 12275.263484190977, 10140.29017968735, 10273.345248763297, 10474.423906685206, 10725.0, 10760.89239107599, 9259.814803703754, 9623.711288661352, 9815.263855211031, 10287.43419111956, 10421.322614030063], "value": 6500.36095639653, "unit": "score"}], "name": "dromaeo_css", "value": 6514.703010099376, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 127.0, 114.0, 113.0, 112.0, 114.0, 114.0, 112.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 130.0, 133.0, 189.0, 138.0, 152.0, 136.0, 155.0, 172.0, 130.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 165.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 124.0, 77.0, 77.0, 75.0, 74.0, 99.0, 78.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 123.0, 85.0, 85.0, 86.0, 118.0, 85.0, 85.0, 128.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 149.0, 149.0, 150.0, 150.0, 149.0, 149.0, 146.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 64.0, 65.0, 65.0, 64.0, 63.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 83.0, 82.0, 88.0, 88.0, 91.0, 82.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 141.0, 155.0, 132.0, 133.0, 136.0, 143.0, 145.0, 134.0, 135.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 171.0, 168.0, 173.0, 172.0, 177.0, 168.0, 172.0, 165.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 71.0, 66.0, 66.0, 67.0, 68.0, 66.0, 65.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1555.7, "alertThreshold": 2.0}]} 19:33:32 INFO - Return code: 0 19:33:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:33:32 INFO - # TBPL SUCCESS # 19:33:32 INFO - Running post-action listener: _resource_record_post_action 19:33:32 INFO - ##### 19:33:32 INFO - ##### Finished run-tests step (success) 19:33:32 INFO - ##### 19:33:32 INFO - Running post-run listener: _resource_record_post_run 19:33:32 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534958080; Read time: 196; Write time: 485780 19:33:32 INFO - TinderboxPrint: CPU usage
13.2% 19:33:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 196 19:33:32 INFO - TinderboxPrint: I/O write bytes / time
534,958,080 / 485,780 19:33:32 INFO - TinderboxPrint: CPU idle
8,320.6 (86.8%) 19:33:32 INFO - TinderboxPrint: CPU user
1,217.4 (12.7%) 19:33:32 INFO - TinderboxPrint: Swap in / out
0 / 0 19:33:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245940224; Read time: 0; Write time: 282636 19:33:32 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288288768; Read time: 196; Write time: 203104 19:33:32 INFO - Running post-run listener: _upload_blobber_files 19:33:32 INFO - Blob upload gear active. 19:33:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:33:32 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 19:33:32 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'] 19:33:32 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 19:33:33 INFO - (blobuploader) - INFO - Open directory for files ... 19:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:45 INFO - (blobuploader) - INFO - Done attempting. 19:33:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:33:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:33:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:46 INFO - (blobuploader) - INFO - Done attempting. 19:33:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:33:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:33:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:47 INFO - (blobuploader) - INFO - Done attempting. 19:33:47 INFO - (blobuploader) - INFO - Iteration through files over. 19:33:47 INFO - Return code: 0 19:33:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:33:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:33:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83a66064a8bfe46062783086cac744f449f79d49990a815e698559f1198559d575d2ea4072e2f658bb480664cd643cc1f6e17225eea219cd734c49b851fd9ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc61b8287629096ebfe8d260aa36d65e27f9f4a74e3281ccb7c434b7ac3e41c50a247b05a60a5be1db96859f2c10005e1b37e9886424efbdeeb8f882f360e094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60bc0d37bb953c8e62f84d494851199f4c79cd240f00ad418420709c2461ae315af373f9608df2ce052a24625ef569a56129a41256513b03830379bc6f29d7e5"} 19:33:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:33:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:33:47 INFO - Contents: 19:33:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83a66064a8bfe46062783086cac744f449f79d49990a815e698559f1198559d575d2ea4072e2f658bb480664cd643cc1f6e17225eea219cd734c49b851fd9ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc61b8287629096ebfe8d260aa36d65e27f9f4a74e3281ccb7c434b7ac3e41c50a247b05a60a5be1db96859f2c10005e1b37e9886424efbdeeb8f882f360e094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60bc0d37bb953c8e62f84d494851199f4c79cd240f00ad418420709c2461ae315af373f9608df2ce052a24625ef569a56129a41256513b03830379bc6f29d7e5"} 19:33:47 INFO - Running post-run listener: copy_logs_to_upload_dir 19:33:47 INFO - Copying logs to upload dir... 19:33:47 INFO - mkdir: /builds/slave/test/build/upload/logs 19:33:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.794013 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-06-24 19:33:46.149100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 19:33:46.152581) ========= 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=523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878 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/83a66064a8bfe46062783086cac744f449f79d49990a815e698559f1198559d575d2ea4072e2f658bb480664cd643cc1f6e17225eea219cd734c49b851fd9ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc61b8287629096ebfe8d260aa36d65e27f9f4a74e3281ccb7c434b7ac3e41c50a247b05a60a5be1db96859f2c10005e1b37e9886424efbdeeb8f882f360e094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60bc0d37bb953c8e62f84d494851199f4c79cd240f00ad418420709c2461ae315af373f9608df2ce052a24625ef569a56129a41256513b03830379bc6f29d7e5"} build_url:https://queue.taskcluster.net/v1/task/FH-z8ssMRmSGdapPAfFS8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/FH-z8ssMRmSGdapPAfFS8A/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/83a66064a8bfe46062783086cac744f449f79d49990a815e698559f1198559d575d2ea4072e2f658bb480664cd643cc1f6e17225eea219cd734c49b851fd9ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc61b8287629096ebfe8d260aa36d65e27f9f4a74e3281ccb7c434b7ac3e41c50a247b05a60a5be1db96859f2c10005e1b37e9886424efbdeeb8f882f360e094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60bc0d37bb953c8e62f84d494851199f4c79cd240f00ad418420709c2461ae315af373f9608df2ce052a24625ef569a56129a41256513b03830379bc6f29d7e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 19:33:46.178994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:33:46.179373) ========= 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=523ca41ca1e0623de333ad52000001bf-1466817899.399125-402725878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:33:46.261295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 19:33:46.261649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 19:33:46.262002) ========= ========= Total master_lag: 0.21 =========