builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1465333359.99 results: success (0) buildid: 20160607113037 builduid: cb0b9d95df9d43d19caeab2c92d1f6aa revision: 3cf6f6e8022b9759ed2d914ad16f5a754de00366 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:39.988783) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:39.989409) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:39.989737) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:40.076974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:40.077263) ========= 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=836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 14:02: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-07 14:02:40 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104177 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:40.206220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:40.206593) ========= 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=836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023065 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:40.260363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:40.260741) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cf6f6e8022b9759ed2d914ad16f5a754de00366 --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 3cf6f6e8022b9759ed2d914ad16f5a754de00366 --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=836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 14:02:40,852 truncating revision to first 12 chars 2016-06-07 14:02:40,852 Setting DEBUG logging. 2016-06-07 14:02:40,852 attempt 1/10 2016-06-07 14:02:40,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cf6f6e8022b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 14:02:41,152 unpacking tar archive at: fx-team-3cf6f6e8022b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641434 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:40.918652) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:40.919313) ========= script_repo_revision: 3cf6f6e8022b9759ed2d914ad16f5a754de00366 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:40.920264) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:40.920861) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 14:02:40.932738) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-07 14:02:40.933032) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:02:41 INFO - MultiFileLogger online at 20160607 14:02:41 in /builds/slave/test 14:02:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:02:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:02:41 INFO - {'append_to_log': False, 14:02:41 INFO - 'base_work_dir': '/builds/slave/test', 14:02:41 INFO - 'blob_upload_branch': 'Fx-Team', 14:02:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:02:41 INFO - 'branch': 'Fx-Team', 14:02:41 INFO - 'buildbot_json_path': 'buildprops.json', 14:02:41 INFO - 'config_files': ('talos/linux_config.py',), 14:02:41 INFO - 'default_actions': ('clobber', 14:02:41 INFO - 'read-buildbot-config', 14:02:41 INFO - 'download-and-extract', 14:02:41 INFO - 'populate-webroot', 14:02:41 INFO - 'create-virtualenv', 14:02:41 INFO - 'install', 14:02:41 INFO - 'run-tests'), 14:02:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:02:41 INFO - 'download_minidump_stackwalk': True, 14:02:41 INFO - 'download_symbols': 'ondemand', 14:02:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:02:41 INFO - 'tooltool.py': '/tools/tooltool.py', 14:02:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:02:41 INFO - '/tools/misc-python/virtualenv.py')}, 14:02:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:02:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:02:41 INFO - 'installer_path': 'installer.exe', 14:02:41 INFO - 'log_level': 'info', 14:02:41 INFO - 'log_name': 'talos', 14:02:41 INFO - 'log_to_console': True, 14:02:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:02:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:02:41 INFO - 'opt_config_files': (), 14:02:41 INFO - 'pip_index': False, 14:02:41 INFO - 'sps_profile': False, 14:02:41 INFO - 'sps_profile_interval': 0, 14:02:41 INFO - 'suite': 'dromaeojs-e10s', 14:02:41 INFO - 'system_bits': '32', 14:02:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:02:41 INFO - 'title': 'talos-linux64-ix-028', 14:02:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:02:41 INFO - 'use_talos_json': True, 14:02:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:02:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:02:41 INFO - 'work_dir': 'build'} 14:02:41 INFO - ##### 14:02:41 INFO - ##### Running clobber step. 14:02:41 INFO - ##### 14:02:41 INFO - Running pre-action listener: _resource_record_pre_action 14:02:41 INFO - Running main action method: clobber 14:02:41 INFO - rmtree: /builds/slave/test/build 14:02:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:02:42 INFO - Running post-action listener: _resource_record_post_action 14:02:42 INFO - ##### 14:02:42 INFO - ##### Finished clobber step (success) 14:02:42 INFO - ##### 14:02:42 INFO - ##### 14:02:42 INFO - ##### Running read-buildbot-config step. 14:02:42 INFO - ##### 14:02:42 INFO - Running pre-action listener: _resource_record_pre_action 14:02:42 INFO - Running main action method: read_buildbot_config 14:02:42 INFO - Using buildbot properties: 14:02:42 INFO - { 14:02:42 INFO - "project": "", 14:02:42 INFO - "product": "firefox", 14:02:42 INFO - "script_repo_revision": "production", 14:02:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:02:42 INFO - "repository": "", 14:02:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:02:42 INFO - "buildid": "20160607113037", 14:02:42 INFO - "pgo_build": "True", 14:02:42 INFO - "basedir": "/builds/slave/test", 14:02:42 INFO - "buildnumber": 819, 14:02:42 INFO - "slavename": "talos-linux64-ix-028", 14:02:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:02:42 INFO - "platform": "ubuntu64_hw", 14:02:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:02:42 INFO - "branch": "fx-team", 14:02:42 INFO - "repo_path": "integration/fx-team", 14:02:42 INFO - "revision": "3cf6f6e8022b9759ed2d914ad16f5a754de00366", 14:02:42 INFO - "stage_platform": "linux64-pgo", 14:02:42 INFO - "builduid": "cb0b9d95df9d43d19caeab2c92d1f6aa", 14:02:42 INFO - "slavebuilddir": "test" 14:02:42 INFO - } 14:02:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:02:42 INFO - Running post-action listener: _resource_record_post_action 14:02:42 INFO - ##### 14:02:42 INFO - ##### Finished read-buildbot-config step (success) 14:02:42 INFO - ##### 14:02:42 INFO - ##### 14:02:42 INFO - ##### Running download-and-extract step. 14:02:42 INFO - ##### 14:02:42 INFO - Running pre-action listener: _resource_record_pre_action 14:02:42 INFO - Running main action method: download_and_extract 14:02:42 INFO - mkdir: /builds/slave/test/build/tests 14:02: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')]} 14:02:42 INFO - https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:02:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:02:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:02:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:47 INFO - Downloaded 1361 bytes. 14:02:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:02:47 INFO - Using the following test package requirements: 14:02:47 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:47 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:02:47 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:02:47 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'jsshell-linux-x86_64.zip'], 14:02:47 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:02:47 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:47 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:02:47 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:02:47 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:02:47 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:02:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:02: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')]} 14:02:47 INFO - https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:02:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:02:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:54 INFO - Downloaded 24446682 bytes. 14:02:54 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'] 14:02:54 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 14:02:55 INFO - Return code: 0 14:02:55 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 14:02:55 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')]} 14:02:55 INFO - https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:02:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:02:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:56 INFO - Downloaded 24446682 bytes. 14:02:56 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'] 14:02:56 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 14:02:58 INFO - Return code: 0 14:02:58 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')]} 14:02:58 INFO - https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:59 INFO - Downloaded 10833369 bytes. 14:02:59 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'] 14:02:59 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 14:02:59 INFO - Return code: 0 14:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:59 INFO - https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:02:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:02:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:02:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:02:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/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 14:03:00 INFO - Downloaded 59172803 bytes. 14:03:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:03:00 INFO - mkdir: /builds/slave/test/properties 14:03:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:03:00 INFO - Writing to file /builds/slave/test/properties/build_url 14:03:00 INFO - Contents: 14:03:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:03:01 INFO - Running post-action listener: _resource_record_post_action 14:03:01 INFO - Running post-action listener: set_extra_try_arguments 14:03:01 INFO - ##### 14:03:01 INFO - ##### Finished download-and-extract step (success) 14:03:01 INFO - ##### 14:03:01 INFO - ##### 14:03:01 INFO - ##### Running populate-webroot step. 14:03:01 INFO - ##### 14:03:01 INFO - Running pre-action listener: _resource_record_pre_action 14:03:01 INFO - Running main action method: populate_webroot 14:03:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:03:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:03:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:03:01 INFO - '--tppagecycles', 14:03:01 INFO - '7'], 14:03:01 INFO - 'tests': ['tsvgm']}}, 14:03:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:03:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:03:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:03:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:03:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:03:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:03:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:01 INFO - 'talos_options': ['--disable-e10s'], 14:03:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:03:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:03:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:01 INFO - 'talos_options': ['--disable-e10s'], 14:03:01 INFO - 'tests': ['damp', 'tps']}, 14:03:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:01 INFO - 'tests': ['damp', 'tps']}, 14:03:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:03:01 INFO - 'tests': ['dromaeo_dom']}, 14:03:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:03:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:03:01 INFO - 'tests': ['a11yr', 14:03:01 INFO - 'ts_paint', 14:03:01 INFO - 'tpaint', 14:03:01 INFO - 'sessionrestore', 14:03:01 INFO - 'sessionrestore_no_auto_restore', 14:03:01 INFO - 'tabpaint']}, 14:03:01 INFO - 'other-e10s': {'tests': ['a11yr', 14:03:01 INFO - 'ts_paint', 14:03:01 INFO - 'tpaint', 14:03:01 INFO - 'sessionrestore', 14:03:01 INFO - 'sessionrestore_no_auto_restore', 14:03:01 INFO - 'tabpaint']}, 14:03:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:03:01 INFO - 'ts_paint', 14:03:01 INFO - 'tpaint', 14:03:01 INFO - 'sessionrestore', 14:03:01 INFO - 'sessionrestore_no_auto_restore', 14:03:01 INFO - 'tabpaint']}, 14:03:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:03:01 INFO - 'ts_paint', 14:03:01 INFO - 'tpaint', 14:03:01 INFO - 'sessionrestore', 14:03:01 INFO - 'sessionrestore_no_auto_restore', 14:03:01 INFO - 'tabpaint']}, 14:03:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:03:01 INFO - 'tests': ['a11yr', 14:03:01 INFO - 'ts_paint', 14:03:01 INFO - 'tpaint', 14:03:01 INFO - 'sessionrestore', 14:03:01 INFO - 'sessionrestore_no_auto_restore', 14:03:01 INFO - 'tabpaint']}, 14:03:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:03:01 INFO - 'tests': ['a11yr', 14:03:01 INFO - 'ts_paint', 14:03:01 INFO - 'tpaint', 14:03:01 INFO - 'sessionrestore', 14:03:01 INFO - 'sessionrestore_no_auto_restore', 14:03:01 INFO - 'tabpaint']}, 14:03:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:03:01 INFO - 'tests': ['tsvgx', 14:03:01 INFO - 'tsvgr_opacity', 14:03:01 INFO - 'tart', 14:03:01 INFO - 'tscrollx', 14:03:01 INFO - 'cart']}, 14:03:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:03:01 INFO - 'tsvgr_opacity', 14:03:01 INFO - 'tart', 14:03:01 INFO - 'tscrollx', 14:03:01 INFO - 'cart']}, 14:03:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:01 INFO - 'talos_options': ['--disable-e10s'], 14:03:01 INFO - 'tests': ['tp5o']}, 14:03:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:01 INFO - 'tests': ['tp5o']}, 14:03:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:01 INFO - 'talos_options': ['--disable-e10s', 14:03:01 INFO - '--xperf_path', 14:03:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:03:01 INFO - 'tests': ['tp5n']}, 14:03:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:01 INFO - 'talos_options': ['--xperf_path', 14:03:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:03:01 INFO - 'tests': ['tp5n']}}, 14:03:01 INFO - 'talos.zip': {'path': '', 14:03:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:03:01 INFO - Running post-action listener: _resource_record_post_action 14:03:01 INFO - ##### 14:03:01 INFO - ##### Finished populate-webroot step (success) 14:03:01 INFO - ##### 14:03:01 INFO - ##### 14:03:01 INFO - ##### Running create-virtualenv step. 14:03:01 INFO - ##### 14:03:01 INFO - Running pre-action listener: _resource_record_pre_action 14:03:01 INFO - Running main action method: create_virtualenv 14:03:01 INFO - Creating virtualenv /builds/slave/test/build/venv 14:03:01 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 14:03:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:03:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:03:01 INFO - Using real prefix '/usr' 14:03:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:03:02 INFO - Installing distribute.............................................................................................................................................................................................done. 14:03:04 INFO - Installing pip.................done. 14:03:04 INFO - Return code: 0 14:03:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:03: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')]} 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a29d4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2113350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a21c0>, '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 0x21a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3550>, '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': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', '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 14:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:03:04 INFO - Using env: {'DISPLAY': ':0', 14:03:04 INFO - 'HOME': '/home/cltbld', 14:03:04 INFO - 'LANG': 'en_US.UTF-8', 14:03:04 INFO - 'LANGUAGE': 'en_US:en', 14:03:04 INFO - 'LOGNAME': 'cltbld', 14:03:04 INFO - 'MAIL': '/var/mail/cltbld', 14:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:04 INFO - 'MOZ_NO_REMOTE': '1', 14:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:04 INFO - 'NO_EM_RESTART': '1', 14:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:04 INFO - 'PWD': '/builds/slave/test', 14:03:04 INFO - 'SHELL': '/bin/bash', 14:03:04 INFO - 'SHLVL': '1', 14:03:04 INFO - 'TERM': 'linux', 14:03:04 INFO - 'TMOUT': '86400', 14:03:04 INFO - 'USER': 'cltbld', 14:03:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', 14:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:04 INFO - '_': '/tools/buildbot/bin/python'} 14:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:04 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 14:03:04 INFO - Cleaning up... 14:03:04 INFO - Return code: 0 14:03:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:03: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')]} 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1a29d4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2113350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a21c0>, '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 0x21a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3550>, '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': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', '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 14:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:03:04 INFO - Using env: {'DISPLAY': ':0', 14:03:04 INFO - 'HOME': '/home/cltbld', 14:03:04 INFO - 'LANG': 'en_US.UTF-8', 14:03:04 INFO - 'LANGUAGE': 'en_US:en', 14:03:04 INFO - 'LOGNAME': 'cltbld', 14:03:04 INFO - 'MAIL': '/var/mail/cltbld', 14:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:04 INFO - 'MOZ_NO_REMOTE': '1', 14:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:04 INFO - 'NO_EM_RESTART': '1', 14:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:04 INFO - 'PWD': '/builds/slave/test', 14:03:04 INFO - 'SHELL': '/bin/bash', 14:03:04 INFO - 'SHLVL': '1', 14:03:04 INFO - 'TERM': 'linux', 14:03:04 INFO - 'TMOUT': '86400', 14:03:04 INFO - 'USER': 'cltbld', 14:03:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', 14:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:04 INFO - '_': '/tools/buildbot/bin/python'} 14:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:04 INFO - Downloading/unpacking psutil>=3.1.1 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:03:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:06 INFO - Installing collected packages: psutil 14:03:06 INFO - Running setup.py install for psutil 14:03:06 INFO - building 'psutil._psutil_linux' extension 14:03:06 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 14:03:06 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 14:03:07 INFO - building 'psutil._psutil_posix' extension 14:03:07 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 14:03:07 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 14:03:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:07 INFO - Successfully installed psutil 14:03:07 INFO - Cleaning up... 14:03:07 INFO - Return code: 0 14:03:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a29d4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2113350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a21c0>, '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 0x21a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3550>, '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': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', '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 14:03:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:03:07 INFO - Using env: {'DISPLAY': ':0', 14:03:07 INFO - 'HOME': '/home/cltbld', 14:03:07 INFO - 'LANG': 'en_US.UTF-8', 14:03:07 INFO - 'LANGUAGE': 'en_US:en', 14:03:07 INFO - 'LOGNAME': 'cltbld', 14:03:07 INFO - 'MAIL': '/var/mail/cltbld', 14:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:07 INFO - 'MOZ_NO_REMOTE': '1', 14:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:07 INFO - 'NO_EM_RESTART': '1', 14:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:07 INFO - 'PWD': '/builds/slave/test', 14:03:07 INFO - 'SHELL': '/bin/bash', 14:03:07 INFO - 'SHLVL': '1', 14:03:07 INFO - 'TERM': 'linux', 14:03:07 INFO - 'TMOUT': '86400', 14:03:07 INFO - 'USER': 'cltbld', 14:03:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', 14:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:07 INFO - '_': '/tools/buildbot/bin/python'} 14:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:03:09 INFO - Installing collected packages: mozsystemmonitor 14:03:09 INFO - Running setup.py install for mozsystemmonitor 14:03:09 INFO - Successfully installed mozsystemmonitor 14:03:09 INFO - Cleaning up... 14:03:09 INFO - Return code: 0 14:03:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:09 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 0x7f1a29d4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2113350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a21c0>, '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 0x21a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3550>, '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': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', '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 14:03:09 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 14:03:09 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 14:03:09 INFO - Using env: {'DISPLAY': ':0', 14:03:09 INFO - 'HOME': '/home/cltbld', 14:03:09 INFO - 'LANG': 'en_US.UTF-8', 14:03:09 INFO - 'LANGUAGE': 'en_US:en', 14:03:09 INFO - 'LOGNAME': 'cltbld', 14:03:09 INFO - 'MAIL': '/var/mail/cltbld', 14:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:09 INFO - 'MOZ_NO_REMOTE': '1', 14:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:09 INFO - 'NO_EM_RESTART': '1', 14:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:09 INFO - 'PWD': '/builds/slave/test', 14:03:09 INFO - 'SHELL': '/bin/bash', 14:03:09 INFO - 'SHLVL': '1', 14:03:09 INFO - 'TERM': 'linux', 14:03:09 INFO - 'TMOUT': '86400', 14:03:09 INFO - 'USER': 'cltbld', 14:03:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', 14:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:09 INFO - '_': '/tools/buildbot/bin/python'} 14:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:09 INFO - Downloading/unpacking jsonschema==2.5.1 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:03:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:11 INFO - Downloading functools32-3.2.3-2.tar.gz 14:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:03:11 INFO - warning: no files found matching '*.txt' 14:03:11 INFO - no previously-included directories found matching 'build' 14:03:11 INFO - no previously-included directories found matching 'dist' 14:03:11 INFO - no previously-included directories found matching '.git*' 14:03:11 INFO - Installing collected packages: jsonschema, functools32 14:03:12 INFO - Running setup.py install for functools32 14:03:12 INFO - warning: no files found matching '*.txt' 14:03:12 INFO - no previously-included directories found matching 'build' 14:03:12 INFO - no previously-included directories found matching 'dist' 14:03:12 INFO - no previously-included directories found matching '.git*' 14:03:12 INFO - Successfully installed jsonschema functools32 14:03:12 INFO - Cleaning up... 14:03:12 INFO - Return code: 0 14:03:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:12 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 0x7f1a29d4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2113350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a21c0>, '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 0x21a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3550>, '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': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', '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 14:03:12 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 14:03:12 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 14:03:12 INFO - Using env: {'DISPLAY': ':0', 14:03:12 INFO - 'HOME': '/home/cltbld', 14:03:12 INFO - 'LANG': 'en_US.UTF-8', 14:03:12 INFO - 'LANGUAGE': 'en_US:en', 14:03:12 INFO - 'LOGNAME': 'cltbld', 14:03:12 INFO - 'MAIL': '/var/mail/cltbld', 14:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:12 INFO - 'MOZ_NO_REMOTE': '1', 14:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:12 INFO - 'NO_EM_RESTART': '1', 14:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:12 INFO - 'PWD': '/builds/slave/test', 14:03:12 INFO - 'SHELL': '/bin/bash', 14:03:12 INFO - 'SHLVL': '1', 14:03:12 INFO - 'TERM': 'linux', 14:03:12 INFO - 'TMOUT': '86400', 14:03:12 INFO - 'USER': 'cltbld', 14:03:12 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', 14:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:12 INFO - '_': '/tools/buildbot/bin/python'} 14:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:12 INFO - Downloading/unpacking blobuploader==1.2.4 14:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:14 INFO - Downloading blobuploader-1.2.4.tar.gz 14:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:03:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:03:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:14 INFO - Downloading docopt-0.6.1.tar.gz 14:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:03:15 INFO - Installing collected packages: blobuploader, requests, docopt 14:03:15 INFO - Running setup.py install for blobuploader 14:03:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:03:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:03:15 INFO - Running setup.py install for requests 14:03:15 INFO - Running setup.py install for docopt 14:03:15 INFO - Successfully installed blobuploader requests docopt 14:03:15 INFO - Cleaning up... 14:03:15 INFO - Return code: 0 14:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:15 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 0x7f1a29d4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2113350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a21c0>, '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 0x21a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3550>, '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': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', '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 14:03:15 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 14:03:15 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 14:03:15 INFO - Using env: {'DISPLAY': ':0', 14:03:15 INFO - 'HOME': '/home/cltbld', 14:03:15 INFO - 'LANG': 'en_US.UTF-8', 14:03:15 INFO - 'LANGUAGE': 'en_US:en', 14:03:15 INFO - 'LOGNAME': 'cltbld', 14:03:15 INFO - 'MAIL': '/var/mail/cltbld', 14:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:15 INFO - 'MOZ_NO_REMOTE': '1', 14:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:15 INFO - 'NO_EM_RESTART': '1', 14:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:15 INFO - 'PWD': '/builds/slave/test', 14:03:15 INFO - 'SHELL': '/bin/bash', 14:03:15 INFO - 'SHLVL': '1', 14:03:15 INFO - 'TERM': 'linux', 14:03:15 INFO - 'TMOUT': '86400', 14:03:15 INFO - 'USER': 'cltbld', 14:03:15 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', 14:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:15 INFO - '_': '/tools/buildbot/bin/python'} 14:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:03:15 INFO - Running setup.py (path:/tmp/pip-FaNufZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:03:15 INFO - Running setup.py (path:/tmp/pip-X8ggzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:03:16 INFO - Running setup.py (path:/tmp/pip-WARrbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:03:16 INFO - Running setup.py (path:/tmp/pip-phA8c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:03:16 INFO - Running setup.py (path:/tmp/pip-i8VSxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:03:16 INFO - Running setup.py (path:/tmp/pip-wyY6qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:03:16 INFO - Running setup.py (path:/tmp/pip-8U5n9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:03:16 INFO - Running setup.py (path:/tmp/pip-gMGqqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:03:16 INFO - Running setup.py (path:/tmp/pip-A0T9Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:03:16 INFO - Running setup.py (path:/tmp/pip-I9sVgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:03:16 INFO - Running setup.py (path:/tmp/pip-kt1d6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:03:16 INFO - Running setup.py (path:/tmp/pip-iLZSOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:03:16 INFO - Running setup.py (path:/tmp/pip-B8cf7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:03:16 INFO - Running setup.py (path:/tmp/pip-DkwL3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:16 INFO - Running setup.py (path:/tmp/pip-ZmfNN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:03:16 INFO - Running setup.py (path:/tmp/pip-TpW4ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:03:17 INFO - Running setup.py (path:/tmp/pip-LuwkEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:03:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:03:17 INFO - Running setup.py install for manifestparser 14:03:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Running setup.py install for mozcrash 14:03:17 INFO - Running setup.py install for mozdebug 14:03:17 INFO - Running setup.py install for mozdevice 14:03:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Running setup.py install for mozfile 14:03:17 INFO - Running setup.py install for mozhttpd 14:03:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Running setup.py install for mozinfo 14:03:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Running setup.py install for mozInstall 14:03:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:03:17 INFO - Running setup.py install for mozleak 14:03:18 INFO - Running setup.py install for mozlog 14:03:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:03:18 INFO - Running setup.py install for moznetwork 14:03:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:03:18 INFO - Running setup.py install for mozprocess 14:03:18 INFO - Running setup.py install for mozprofile 14:03:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:03:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:03:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:03:18 INFO - Running setup.py install for mozrunner 14:03:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:03:18 INFO - Running setup.py install for mozscreenshot 14:03:18 INFO - Running setup.py install for moztest 14:03:18 INFO - Running setup.py install for mozversion 14:03:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:03:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:18 INFO - Cleaning up... 14:03:18 INFO - Return code: 0 14:03:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:18 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 0x7f1a29d4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2113350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a21c0>, '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 0x21a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3550>, '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': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', '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 14:03:18 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 14:03:18 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 14:03:18 INFO - Using env: {'DISPLAY': ':0', 14:03:18 INFO - 'HOME': '/home/cltbld', 14:03:18 INFO - 'LANG': 'en_US.UTF-8', 14:03:18 INFO - 'LANGUAGE': 'en_US:en', 14:03:18 INFO - 'LOGNAME': 'cltbld', 14:03:18 INFO - 'MAIL': '/var/mail/cltbld', 14:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:18 INFO - 'MOZ_NO_REMOTE': '1', 14:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:18 INFO - 'NO_EM_RESTART': '1', 14:03:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:18 INFO - 'PWD': '/builds/slave/test', 14:03:18 INFO - 'SHELL': '/bin/bash', 14:03:18 INFO - 'SHLVL': '1', 14:03:18 INFO - 'TERM': 'linux', 14:03:18 INFO - 'TMOUT': '86400', 14:03:18 INFO - 'USER': 'cltbld', 14:03:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', 14:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:18 INFO - '_': '/tools/buildbot/bin/python'} 14:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:03:19 INFO - Running setup.py (path:/tmp/pip-CmObV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:03:19 INFO - Running setup.py (path:/tmp/pip-4DoqxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:03:19 INFO - Running setup.py (path:/tmp/pip-PtI1XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:03:19 INFO - Running setup.py (path:/tmp/pip-poK__t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:03:19 INFO - Running setup.py (path:/tmp/pip-jLY4I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:03:19 INFO - Running setup.py (path:/tmp/pip-_OVuqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:03:19 INFO - Running setup.py (path:/tmp/pip-t8e7Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:03:19 INFO - Running setup.py (path:/tmp/pip-vea50U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:03:19 INFO - Running setup.py (path:/tmp/pip-UJ8dzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:03:19 INFO - Running setup.py (path:/tmp/pip-iAcYLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:03:19 INFO - Running setup.py (path:/tmp/pip-4SbUee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:03:19 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)) 14:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:03:19 INFO - Running setup.py (path:/tmp/pip-bs1uO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:03:20 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)) 14:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:03:20 INFO - Running setup.py (path:/tmp/pip-BiBtwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:03:20 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)) 14:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:03:20 INFO - Running setup.py (path:/tmp/pip-_d1qFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:03:20 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)) 14:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:20 INFO - Running setup.py (path:/tmp/pip-0acVZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:20 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)) 14:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:03:20 INFO - Running setup.py (path:/tmp/pip-AgkUyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:03:20 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)) 14:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:03:20 INFO - Running setup.py (path:/tmp/pip-ejk76h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:03:20 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)) 14:03:20 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)) 14:03:20 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)) 14:03:20 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)) 14:03:20 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)) 14:03:20 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)) 14:03:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:22 INFO - Downloading blessings-1.6.tar.gz 14:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:22 INFO - Installing collected packages: blessings 14:03:22 INFO - Running setup.py install for blessings 14:03:22 INFO - Successfully installed blessings 14:03:22 INFO - Cleaning up... 14:03:22 INFO - Return code: 0 14:03:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:03:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:22 INFO - Reading from file tmpfile_stdout 14:03:22 INFO - Current package versions: 14:03:22 INFO - argparse == 1.2.1 14:03:22 INFO - blessings == 1.6 14:03:22 INFO - blobuploader == 1.2.4 14:03:22 INFO - docopt == 0.6.1 14:03:22 INFO - functools32 == 3.2.3-2 14:03:22 INFO - jsonschema == 2.5.1 14:03:22 INFO - manifestparser == 1.1 14:03:22 INFO - mozInstall == 1.12 14:03:22 INFO - mozcrash == 0.17 14:03:22 INFO - mozdebug == 0.1 14:03:22 INFO - mozdevice == 0.48 14:03:22 INFO - mozfile == 1.2 14:03:22 INFO - mozhttpd == 0.7 14:03:22 INFO - mozinfo == 0.9 14:03:22 INFO - mozleak == 0.1 14:03:22 INFO - mozlog == 3.2 14:03:22 INFO - moznetwork == 0.27 14:03:22 INFO - mozprocess == 0.22 14:03:22 INFO - mozprofile == 0.28 14:03:22 INFO - mozrunner == 6.11 14:03:22 INFO - mozscreenshot == 0.1 14:03:22 INFO - mozsystemmonitor == 0.3 14:03:22 INFO - moztest == 0.7 14:03:22 INFO - mozversion == 1.4 14:03:22 INFO - psutil == 3.1.1 14:03:22 INFO - requests == 1.2.3 14:03:22 INFO - wsgiref == 0.1.2 14:03:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:22 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 0x7f1a29d4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2113350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a21c0>, '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 0x21a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3550>, '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': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', '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 14:03:22 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 14:03:22 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 14:03:22 INFO - Using env: {'DISPLAY': ':0', 14:03:22 INFO - 'HOME': '/home/cltbld', 14:03:22 INFO - 'LANG': 'en_US.UTF-8', 14:03:22 INFO - 'LANGUAGE': 'en_US:en', 14:03:22 INFO - 'LOGNAME': 'cltbld', 14:03:22 INFO - 'MAIL': '/var/mail/cltbld', 14:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:22 INFO - 'MOZ_NO_REMOTE': '1', 14:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:22 INFO - 'NO_EM_RESTART': '1', 14:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:22 INFO - 'PWD': '/builds/slave/test', 14:03:22 INFO - 'SHELL': '/bin/bash', 14:03:22 INFO - 'SHLVL': '1', 14:03:22 INFO - 'TERM': 'linux', 14:03:22 INFO - 'TMOUT': '86400', 14:03:22 INFO - 'USER': 'cltbld', 14:03:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', 14:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:22 INFO - '_': '/tools/buildbot/bin/python'} 14:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:22 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)) 14:03:22 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)) 14:03:22 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)) 14:03:22 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)) 14:03:22 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)) 14:03:22 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)) 14:03:22 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)) 14:03:22 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)) 14:03:22 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)) 14:03:22 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)) 14:03:22 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)) 14:03:22 INFO - Cleaning up... 14:03:22 INFO - Return code: 0 14:03:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:22 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 0x7f1a29d4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2113350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a21c0>, '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 0x21a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3550>, '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': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', '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 14:03:22 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 14:03:22 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 14:03:22 INFO - Using env: {'DISPLAY': ':0', 14:03:22 INFO - 'HOME': '/home/cltbld', 14:03:22 INFO - 'LANG': 'en_US.UTF-8', 14:03:22 INFO - 'LANGUAGE': 'en_US:en', 14:03:22 INFO - 'LOGNAME': 'cltbld', 14:03:22 INFO - 'MAIL': '/var/mail/cltbld', 14:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:22 INFO - 'MOZ_NO_REMOTE': '1', 14:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:22 INFO - 'NO_EM_RESTART': '1', 14:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:22 INFO - 'PWD': '/builds/slave/test', 14:03:22 INFO - 'SHELL': '/bin/bash', 14:03:22 INFO - 'SHLVL': '1', 14:03:22 INFO - 'TERM': 'linux', 14:03:22 INFO - 'TMOUT': '86400', 14:03:22 INFO - 'USER': 'cltbld', 14:03:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', 14:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:22 INFO - '_': '/tools/buildbot/bin/python'} 14:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:03:23 INFO - Cleaning up... 14:03:23 INFO - Return code: 0 14:03:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:03: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')]} 14:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:23 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 0x7f1a29d4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2113350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a21c0>, '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 0x21a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3550>, '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': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', '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 14:03:23 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 14:03:23 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 14:03:23 INFO - Using env: {'DISPLAY': ':0', 14:03:23 INFO - 'HOME': '/home/cltbld', 14:03:23 INFO - 'LANG': 'en_US.UTF-8', 14:03:23 INFO - 'LANGUAGE': 'en_US:en', 14:03:23 INFO - 'LOGNAME': 'cltbld', 14:03:23 INFO - 'MAIL': '/var/mail/cltbld', 14:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:23 INFO - 'MOZ_NO_REMOTE': '1', 14:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:23 INFO - 'NO_EM_RESTART': '1', 14:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:23 INFO - 'PWD': '/builds/slave/test', 14:03:23 INFO - 'SHELL': '/bin/bash', 14:03:23 INFO - 'SHLVL': '1', 14:03:23 INFO - 'TERM': 'linux', 14:03:23 INFO - 'TMOUT': '86400', 14:03:23 INFO - 'USER': 'cltbld', 14:03:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', 14:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:23 INFO - '_': '/tools/buildbot/bin/python'} 14:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:23 INFO - Downloading/unpacking flake8 14:03:23 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 14:03:23 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 14:03:23 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 14:03:23 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 14:03:23 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 14:03:23 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 14:03:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:03:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:03:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:03:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:25 INFO - no previously-included directories found matching 'docs/_build' 14:03:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:03:26 INFO - Running setup.py install for pep8 14:03:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:26 INFO - no previously-included directories found matching 'docs/_build' 14:03:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:03:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:03:26 INFO - Cleaning up... 14:03:26 INFO - Return code: 0 14:03:26 INFO - Running post-action listener: _resource_record_post_action 14:03:26 INFO - Running post-action listener: _start_resource_monitoring 14:03:26 INFO - Starting resource monitoring. 14:03:26 INFO - ##### 14:03:26 INFO - ##### Finished create-virtualenv step (success) 14:03:26 INFO - ##### 14:03:26 INFO - ##### 14:03:26 INFO - ##### Running install step. 14:03:26 INFO - ##### 14:03:26 INFO - Running pre-action listener: _resource_record_pre_action 14:03:26 INFO - Running main action method: install 14:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:26 INFO - Reading from file tmpfile_stdout 14:03:26 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:03:26 INFO - Reading from file tmpfile_stdout 14:03:26 INFO - Output received: 14:03:26 INFO - Usage: mozinstall [options] installer 14:03:26 INFO - Options: 14:03:26 INFO - -h, --help show this help message and exit 14:03:26 INFO - -d DEST, --destination=DEST 14:03:26 INFO - Directory to install application into. [default: 14:03:26 INFO - "/builds/slave/test"] 14:03:26 INFO - --app=APP Application being installed. [default: firefox] 14:03:26 INFO - mkdir: /builds/slave/test/build/application 14:03:26 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'] 14:03:26 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 14:03:43 INFO - Reading from file tmpfile_stdout 14:03:43 INFO - Output received: 14:03:43 INFO - /builds/slave/test/build/application/firefox/firefox 14:03:43 INFO - Running post-action listener: _resource_record_post_action 14:03:43 INFO - ##### 14:03:43 INFO - ##### Finished install step (success) 14:03:43 INFO - ##### 14:03:43 INFO - ##### 14:03:43 INFO - ##### Running run-tests step. 14:03:43 INFO - ##### 14:03:43 INFO - Running pre-action listener: _resource_record_pre_action 14:03:43 INFO - Running main action method: run_tests 14:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:03:43 INFO - Python 2.7.3 14:03:43 INFO - Return code: 0 14:03:43 INFO - grabbing minidump binary from tooltool 14:03:43 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')]} 14:03:43 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 0x21a21c0>, '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 0x21a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:03:43 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 14:03:43 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 14:03:43 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 14:03:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:43 INFO - Return code: 0 14:03:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:03:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:03:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:03:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:03:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:03:44 INFO - Return code: 0 14:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:03:44 INFO - Using env: {'DISPLAY': ':0', 14:03:44 INFO - 'HOME': '/home/cltbld', 14:03:44 INFO - 'LANG': 'en_US.UTF-8', 14:03:44 INFO - 'LANGUAGE': 'en_US:en', 14:03:44 INFO - 'LOGNAME': 'cltbld', 14:03:44 INFO - 'MAIL': '/var/mail/cltbld', 14:03:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:03:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:44 INFO - 'MOZ_NO_REMOTE': '1', 14:03:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:44 INFO - 'NO_EM_RESTART': '1', 14:03:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:44 INFO - 'PWD': '/builds/slave/test', 14:03:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:03:44 INFO - 'SHELL': '/bin/bash', 14:03:44 INFO - 'SHLVL': '1', 14:03:44 INFO - 'TERM': 'linux', 14:03:44 INFO - 'TMOUT': '86400', 14:03:44 INFO - 'USER': 'cltbld', 14:03:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682', 14:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:44 INFO - '_': '/tools/buildbot/bin/python'} 14:03:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:03:44 INFO - mozversion application_buildid: 20160607113037 14:03:44 INFO - mozversion application_changeset: 3cf6f6e8022b9759ed2d914ad16f5a754de00366 14:03:44 INFO - mozversion application_display_name: Nightly 14:03:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:44 INFO - mozversion application_name: Firefox 14:03:44 INFO - mozversion application_remotingname: firefox 14:03:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:03:44 INFO - mozversion application_vendor: Mozilla 14:03:44 INFO - mozversion application_version: 50.0a1 14:03:44 INFO - mozversion platform_buildid: 20160607113037 14:03:44 INFO - mozversion platform_changeset: 3cf6f6e8022b9759ed2d914ad16f5a754de00366 14:03:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:03:44 INFO - mozversion platform_version: 50.0a1 14:03:44 INFO - using testdate: 1465333424 14:03:44 INFO - actual date: 1465333424 14:03:44 INFO - starting webserver on 'localhost:32956' 14:03:44 INFO - SUITE-START | Running 2 tests 14:03:44 INFO - TEST-START | dromaeo_css 14:03:44 INFO - operating with platform_type : linux_ 14:03:44 INFO - Initialising browser for dromaeo_css test... 14:03:44 INFO - TEST-INFO | started process 26099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpieioOt/profile http://localhost:32956/getInfo.html) 14:03:49 INFO - PROCESS | 26099 | __metrics Screen width/height:1600/1200 14:03:49 INFO - PROCESS | 26099 | colorDepth:24 14:03:49 INFO - PROCESS | 26099 | Browser inner width/height: 1024/697 14:03:49 INFO - PROCESS | 26099 | __metrics 14:03:50 ERROR - PROCESS | 26099 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:03:50 INFO - TEST-INFO | 26099: exit 0 14:03:50 INFO - Browser initialized. 14:03:50 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:50 INFO - TEST-INFO | started process 26215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpieioOt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:02 INFO - PROCESS | 26215 | RSS: Main: 166899712 14:04:02 INFO - PROCESS | 26215 | 14:04:52 INFO - PROCESS | 26215 | 1465333492493 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] 14:07:00 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:32956/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32956/tests/dromaeo/cssquery-ext.html) 14:07:01 INFO - PROCESS | 26215 | RSS: Main: 171368448 14:07:01 INFO - PROCESS | 26215 | 14:10:03 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:32956/tests/dromaeo/cssquery-ext.html (next: http://localhost:32956/tests/dromaeo/cssquery-jquery.html) 14:10:04 INFO - PROCESS | 26215 | RSS: Main: 169627648 14:10:04 INFO - PROCESS | 26215 | 14:13:05 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:32956/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32956/tests/dromaeo/cssquery-mootools.html) 14:13:06 INFO - PROCESS | 26215 | RSS: Main: 171413504 14:13:06 INFO - PROCESS | 26215 | 14:16:08 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:32956/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32956/tests/dromaeo/cssquery-prototype.html) 14:16:08 INFO - PROCESS | 26215 | RSS: Main: 168824832 14:16:08 INFO - PROCESS | 26215 | 14:19:11 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:32956/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32956/tests/dromaeo/cssquery-yui.html) 14:19:11 INFO - PROCESS | 26215 | RSS: Main: 170840064 14:19:11 INFO - PROCESS | 26215 | 14:22:14 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:32956/tests/dromaeo/cssquery-yui.html (next: http://localhost:32956/tests/dromaeo/cssquery-dojo.html) 14:22:14 INFO - PROCESS | 26215 | RSS: Main: 172244992 14:22:14 INFO - PROCESS | 26215 | 14:22:14 INFO - PROCESS | 26215 | __start_tp_report 14:22:14 INFO - PROCESS | 26215 | _x_x_mozilla_page_load 14:22:14 INFO - PROCESS | 26215 | _x_x_mozilla_page_load_details 14:22:14 INFO - PROCESS | 26215 | |i|pagename|runs| 14:22:14 INFO - PROCESS | 26215 | |0;dojo.html;3137.043201823446;3152.353767477667;3163.95254071189;3172.333809899921;3225.774195806293;5439.646422982503;5468.945310546894;5508.063629183039;5510.090835012224;5545.889082218353;5300.310959575259;5458.263134476844;5488.53347465466;5512.255845460862;5533;4960.702357858522;4995.500449954993;5050.242463630448;5088.567471764886;5151.484851514856;837.9660654148661;5054.9241761373605;5059;5060.797568097271;5108.029474399871;5020.146575082244;5036.924446133311;5042.949570504303;5057.645964782467;5079.415867175267;4889.022195560902;5044.167712327461;5053.393592768891;5076.314697515825;5085.23721441783;4893.143699852511;4956.950430495721;4963.975180124113;4968.552830245259;5052.8231511897275;5348.91976620351;5372.516473517402;5392.09113617289;5422.15956526739;5430.294061771984;5710.571707121982;5814.186013958049;5833.824985250407;5896.115582662592;5899.557533185029;5974.641521508724;5978.252718410199;6009.2188015557695;6011.819645410601;6015.27816661999;5460.31746031746;5491.478309560585;5520.199571062173;5520.199571062214;5521.5306698930635;5908.586398952032;5957.314908785458;5979.342272350038;6014.007688731398;6072.544559157993;5740.368559458456;5749.1663708762;5758.539316854642;5770.076787713946;5775.7400916957995;5825;5855.619384739978;5861.413858614104;5882.705864706748;5883.294004719461;5758;5777.277840269966;5790.681512516768;5852.824415267549;5858.765649374062;5712.143178523172;5816.621919575214;5840.561957853178;5852.414758524199;5858.970705146447;4504.054148628759;4515.774211289422;4529.388532548064;4533.455985281721;4561.817527298937;3894.2600905828367;3943.2113577284085;3966.702497312713;3978.3833505806647;4000.8199631016673;5563.109902415594;5590.385057643656;5623.718814059363;5628.183913332544;5662.037453632893;5831.154482599999;5866.941330586725;5867.442592953663;5878.970605146947;5919.792807251725;5422.376426710979;5534.1975413564805;5544.972275138679;5581.581381396411;5600.299962504687;4967.254911763264;4979.502049794992;4992.101421744121;4993.350864387679;5022.748862556858;6078.696065196723;6092.695365231721;6104.633721976696;6107.725152368154;6116.908246376308;5744.798932037359;5854.0048191806645;5893.734781934738;5930.555208359304;5944.435278648435;6085.361037091042;6114.144019837316;6129.632222066691;6143.846403839761;6147.538934579835;5770.855728606651;5804.187413762161;5818.4763371296785;5819.0689489681445;5823.126531020381;5701.4298570142655;5853.9121913172185;5891.823245302648;5914.497267732118;5915.526757859447;5719.48524632785;5732.254806875247;5746.051901436216;5752.28096487939;5757.481826635623;5654.971725141348;5711.314642242791;5749.453801888814;5754.309482861916;5763.049096899133;5538.889222215453;5589.636673616202;5603.187537807076;5637.379888212211;5692.886142277214;5747.281589801275;5770.826875193751;5815.651060936358;5827.533797296291;5837.474627283565;5545.584081193846;5650.095984642602;5703.515201207943;5706.372299047184;5708.600397972102 14:22:14 INFO - PROCESS | 26215 | |1;ext.html;585.9238299021126;604.5949214026601;636.3318515558664;649.0912722188934;649.3182158733332;43559.12881742363;44989.32516012262;45040.77479612602;45074.549254507445;48387.75806120964;44701.32948005774;45178.7741061295;45766;45778;45806.33549316055;8779.824403511926;8906.42108262964;8958.37291389603;8974.14745599167;8984.640614375417;8780.956095219546;8828;8828.42615230008;8878.511681857495;8898.555072246394;8859.335549833757;8876.378653494257;8904.8664270036;8921.420107693011;8926.152015558511;8915.59879805407;8916.821663566725;8967.775805604912;8979.730608081769;8986.326025548111;8755.25580325673;8910.465372077697;8914.73255802327;8944.59749311276;8968.596413161358;43271.918202044886;43324.783376082916;43684.12631747347;43745.78127109376;43781.12437751259;3520.6831385175456;3548.201654627714;3559.501669766235;3723.5345581802276;4156.646685031776;32848.83575582107;33314.16714582131;33567;33649.49525757116;34394.48408273878;4268.082362292091;4293.334533147367;4372.934405983913;4490.932636010462;4501.617362524189;349832.99999999744;350273;350335.7382491626;352113;352491;61863.6906815463;61949.690251548454;62425;62495.375046249865;62560.37439625637;35894;36352.63647363545;36797.44803827945;38515.229695405935;38575.22849542993;17434.825651743573;17576.472705818847;17592;17640.558986025197;17644.823551764573;12532.498700052078;12543.498260069677;12552.81170782439;12636.936815315865;12646.747065058831;19582.80417195838;19710.21159153618;19730.40808775739;19824.107915143566;19952.70070948937;7345.22875098107;7426.888596671054;7461.888071678929;7554.2823431773895;7636.770896873103;977.2865807960229;1102.4322473925934;1109.7780443911088;1115.130198445214;1132.9916374426766;32452.114131298757;32732.836335818167;32922.83538582292;33172.834135829646;33243.833780830944;1089.9509522071526;1104.8950349716763;1125.054953838763;1129.7288650723767;1205.69254840017;16973.321067157423;17446.825531744773;17513.211905464286;17616.471505854846;18514.259429622933;403173;405125;574463;575142;575244;59924;62768;63096;63127.36872631215;63454;1441.1137150652273;1453.404104317225;1465.1136062681924;1472.5435115114135;1482.5181815909873;31587.684123158473;33783.49324760081;34256.65743342634;34477.13807154841;34649;53753.19370209372;54264.72867635637;54978.45021549733;54989.175162373394;55105.72447137738;428449;430989;431412;431435;432401;43942;44904.65286041424;45853.77073114613;45959.77020114878;46026;48675;48868.75565622149;49107;50069.49930500648;50146.749266253435;40371.394429083;42049.36925946052;42238.366424503045;45287.54712452833;46016.30975535436;40330.395044073775;41400.79299603483;42232.57767422286;45324.77337613291;45954.770226148656;36214.4567831488;40911.59088409078;41043.589564103975;41857.79071104625;42347.364789527564;36430.8178459106;38812.80593597127;39134.608653914234;39220.607793922834;39576.2084758309;28939.56590651184;29016.854915725286;29104.27239319034;29263.414731705674;29507.55738663879 14:22:14 INFO - PROCESS | 26215 | |2;jquery.html;380.37238556381965;380.92191100824334;386.83752823813984;401.07151943251387;402.3120464006549;16860.494185174448;18891.811081889176;19148.90425547872;19198.90400547997;19199.712004319947;10976.560937562508;11291.717707057327;18220.908895455537;18936.5265868353;18943.147558359873;5018.548330650241;5211.973940130313;5248.317718696564;5258.92111618326;5261.947380526184;3873.845046198149;4697.765111744417;6288.717007734663;6298.307186209536;6345.302016778174;6320.589161704497;6330.588511746745;6347.746090156388;6364.649944253064;6366.872662546746;5266.605004624649;5510.256115424427;5573.359063707665;5651.208830763655;5660.377358490563;5279.287296215;5408.4050754416985;5434.212039254286;5435.076037073707;5445.9652665993335;12756.2984035878;12930.09489335747;13025.934870325682;16993.91503042489;22519.662205066936;2179.618566750828;2232.374935018181;2364.550735360276;2373.2168384433094;2418.504206637635;9390;9431.575579098957;9796.461194634292;9835.557399917021;9845.163161131313;1881.4261650196684;1983.3653230966097;2025.73665423494;2027.1992562937558;2033.0647901965115;77858.6107069461;78247.60876195582;78763;79863.20136798616;81198.59400703017;10002.199824014062;10104.646337378157;10235.43705096212;10392.168626509861;10582.735431614272;13971.09187902783;13975.860241397659;14099.929500352639;14144;14191.148531087962;7836.294733474015;7924.920750792418;8006.479578827358;8068.9596552016865;8186.345092392594;7786.221377862168;7822.882656760153;7895.486793358414;7924.326432253208;8033.1122186286175;4145.647619952338;4348.543402942645;4379.5182529921685;4412.477695195153;4465.196264672325;1794.2864564341023;1830.2313028528051;1842.3367587668429;1845.3264558436342;1880.858935579837;943.1982814607529;999.3404353126901;1107.3023994883172;1113.760541483585;1116.3469370418234;18007.009614471066;18442.524598032393;19150.521236969187;19241.615167696847;19365.709514357295;980.8479685648736;989.747614358334;997.6009596161448;1008.2186305613209;1051.4217180550665;9650.855237171449;10295.742606434898;11245.15661325404;11293;11702.239354442105;497962;498908;500250;500725;507796;61640;79945;95812.52093739486;96108.51945740226;96645;1044.5456226541478;1045.0490054050929;1070.309650275568;1074.1782536359692;1078.5146683992077;17308.740368894225;17648.294068237126;17706.5573360667;17813.46559603214;17921.820781792016;40660.59339406686;41621.583784162984;41668.583314167685;42303.09636066323;42798.78600606977;55813.72093139508;58807.411925880195;59609.40390596212;59920.40079599148;61778;11548.884511154782;12034.338111403957;12445.62663120108;12457.12800103984;13134.868651313365;13457.932710336385;13950.162990220619;14005.929970350084;14621.926890365905;14742.26288685583;11643.243189192675;11644.301341919512;11973.640790776291;11999.76000480003;12373.814392783936;11871.228370155912;12208.572699955459;12391.566295179626;12628.936855315664;12876.420561074587;8053.114157442559;8140.674373025013;8264.876026859722;8276.172382761675;8334.62494187751;12626.621201363974;13034.869651303365;13035.47858085666;13072.673183170496;13093.672658183621;11772.587959421378;11932.880671193177;12170.208936419105;12236.32700201462;12257.325847078497 14:22:14 INFO - PROCESS | 26215 | |3;mootools.html;1502.3690050178927;1523.6343277613373;1711.1786342555572;1807.466797294798;1839.310258653006;8164.877526837087;8778.166074222947;8918.598663060162;9412.576434060467;9431.528423578828;8942.776430589238;9198.310126740487;9229.676961306355;9270.536473176331;9280.582373793179;2312.8034117100024;2362.5393048355577;2365.656979737937;2366.7278262999716;2367.479154585997;2290.702208712865;2313.606686863229;2326.906923723049;2333.148400833692;2341.555104530142;2325.383773300077;2330.568844763716;2337.544178885118;2341.2273949596593;2346.601077816775;2285.4971906180613;2294.8852557372147;2300.562893050315;2306.907723691059;2325.93022209334;2277.9886100569556;2301.2635956493928;2301.7122859642545;2320.524292520029;2327.7788610082016;9175.853018372703;9247.352685311964;9258.398204116711;9259.120383563552;9292.349535532516;5189.247559103909;5297.814576489843;5306.655067420644;5312.389075256357;5313.707746073965;3230.96769032309;3377.527146199534;3418.265073009315;3474.826258687081;3505.2814173094707;1121.1535290855434;1150.8158694608906;1153.8384626152344;1178.7819253438142;1184.1829137894824;12720.809187862189;12852.100352975296;12868.678283042906;12903.419346129447;12935.48258069676;4595.770211489412;4718.221493453541;4767.070421267819;4813.03739252151;4843.878903027382;10809.567617295377;10886.945565272123;10928.235023548434;10938.453077346101;10940.343579385262;5416.350037995466;5439.456054394529;5444.8094316698725;5468.863278417992;5470.288862447936;4394.1651086293505;4891.584215341664;5045.646804723708;5046.571041461443;5054.21659642756;4103.2073105178215;4110.753354798721;4114.670826333886;4150.27370210212;4152.501699795984;1267.283984548727;1267.8985681145487;1270.707737220426;1272.6500212441467;1277.8466584009977;1021;1044.8380501022355;1052.55792567122;1053.204830353094;1057.8095942730229;6224.533160012927;6288.402601752826;6358.395952384516;6454.870902581922;6486.254080780676;450.76560188701694;459.48767124656433;461.56151655927005;462.9120467111238;462.94444666639544;4404.977975110104;4490.528494508095;4497.820087196541;4501.257292546758;4504.549545045535;10986.615468458565;11206.831897521544;11370.772584548262;11394.715132121763;11399.202055856176;10606.840897386546;11254.606088786853;11331.490082946288;11360.431978401211;11413.60052398162;8372.33021358302;8442.620082096197;8516.531590762568;8526.445781024213;8534;6041.818745437644;6237.438630523093;6247;6328.588641738273;6336.841578960563;10214.387136771817;10595.258331916692;10623.628173013907;10655.25413221067;10681.145508359468;10689.09142722846;10691.786164276515;10757;10805.945970270099;10865.511052002837;7413.518121322097;7804.648790804314;8073.717419890276;8136.75589732309;8271.2142346477;8959.328050396376;8998.280137589109;9009.234215091528;9043.864342034743;9056.456612603264;7925.326347260548;7953.960230198812;8125.593720313843;8225.95887020561;8246;7881.921180788118;8037.8392432152195;8052.476589021695;8102.513849169069;8144;7385.224551422239;7421.109466864011;7484.588347640932;7517.661705223388;7574.242575742382;5281.15501519755;5305.681659100466;5492.176173573996;5503.11950087984;5593.524550413261;5446.455354464521;5455.754491047992;5554.888902222014;5640.633358831663;5726 14:22:14 INFO - PROCESS | 26215 | |4;prototype.html;322.4840255591055;325.50035695207845;328.20901627078746;333.7663635455181;338.417921175578;5579.549317177532;5595.328560572727;5607.046802043657;5623.80316688916;5641.097424412095;5471.917921231185;5485.725713714308;5513.862153446166;5537.667739935607;5569.248151499546;4075.6739460843137;4156.729812562174;4273.978630106861;4288.185244803493;4299.978500107511;4304.892377690551;4314.590113939171;4315.741055536678;4318.265894797876;4320.416743739602;4298.247806633826;4308.80610372534;4316.287812510932;4319.157764235975;4324.956750432502;4040.43433919253;4215.704900656955;4241.130568233505;4245.15096980602;4319.568043195687;3668.6881615062753;3692.612275711065;3694.685951694109;3694.722895782827;3700.111973126457;5309.840704778863;5312;5313.893722125575;5323.707196104213;5331.840044798662;4645.86062418128;4828.155072862271;4858.51815196365;4864.197407427806;4889.511048895118;5637.60401829221;5751.971240143815;5778.88442231153;5782.566307526952;5785.537157027427;4036.2129384769983;4038.5557588665224;4050.675945924319;4072.572379900127;4108.383742438628;5981.282246130449;5984.611000285011;6070.939290607126;6084.847878803021;6105.8168254952425;4117.890992300794;4133.338665813455;4145.398917156996;4150.501939767248;4151.8339266429;4166.645835103989;4185.330347144442;4198.349255865346;4214.3678448232395;4229.957700422957;4657.534246575383;4806.7836947337455;4835.564799168092;4847.709137451764;4914.65597408178;5719.742611582489;5738.569607279471;5761.711914404263;5793.913091303634;5805.535557155417;1448.3699590678088;1460.6202387379146;1464.3264098514803;1475.1812743927223;1485.3687182947203;938.1369140390857;938.2353381993789;940.6801687426171;941.3692825806589;1007.2345017786535;5515.255440515479;5519.9448005520235;5582.106862901916;5586.748596313176;5594.82508673175;5845.246426072246;5846.356900740915;5889;5911.822645320562;5950.345461999176;5313.335833020872;5528.198411230349;5546.584006199551;5567.610267281251;5579.2746942897165;3088.922776930595;3120.75169932029;3133.9216519586735;3144.811311321328;3153.195935036597;5858.443447872445;6045.153678485016;6045.667488288098;6078.878422431527;6122.7244773984385;5920.31916329619;5984.952633289157;5996.310424301174;5998.610090344114;6065.60573562717;6094.268687757498;6129.632222066691;6138.6623735694075;6145.262568491809;6150.569460137837;5754.309482862083;5897.469227769521;5918.467337939606;5936.406359364029;5964.940350596438;5811.53507719373;5827.329857066492;5851.64890106595;5852.268466441695;5890.734916928663;5941.807349549344;6040.788572399945;6061.969690151697;6095;6126.938730612816;4085.836566537424;4086.734362266562;4121.793910304533;4124.360724087771;4177.12280421115;5921.467067963904;5952.434518720715;5982.940170598238;6010;6010.1285313628405;5699.829005129853;5775.364709881994;5782.710864456676;5789.94210057894;5890.352061273171;5717.828465146053;5740.311162660508;5765.7117144141785;5799.333076696234;5827.59206855516;5528.612997090165;5555.916661250004;5649.7740090397565;5692.2600061993335;5712.742926568231;5781.248437703071;5832.562557808096;5838.2702162229725;5839.299284085937;5868.413158684098;5483.8080667176455;5697.401772813961;5739.598228123991;5741.942580574308;5756.136579512939 14:22:14 INFO - PROCESS | 26215 | |5;yui.html;665.8568407792327;700.6601798127907;711.2638419236092;772.1352085664055;810.2464707821725;14788.778168327484;15624.375024998986;15659.608509787233;15661.686766264682;15902.681946361081;14291.857081429183;14308.642283942881;14618.269086545683;14643.267836608153;15221.391144354213;791.9247671471215;799.1528979281951;801.1387758159972;804.4409135650725;805.8589746794316;793.3494534481728;798.2177466083242;803.3813963248296;810.1210186947139;812.8496228197773;854.6624083487019;854.9187827156442;855.6491838346279;855.687673998989;856.9528675922821;856.8072183758667;858.3219256787131;859.9957000214958;860.8880845490108;861.1087524412203;622.3620788691582;626.0734113511983;629.1632129268063;630.1713247080075;630.782380078872;15035;15075.54773356801;15104.093754374662;15108.773368399483;15130;14788.778168327484;14926.40294388223;15005.324760385809;15039.548813535612;15056.473023444127;11479.426028698615;11575.710607234802;11680.591179308769;11724.355160466172;11727.589534366341;3818.2172654606015;3902.180542086165;3908.3746600543777;4027.7583344999393;4030.717849750519;74743.99999999946;74775.62612186959;75674.62162689152;76078;76811.23188768097;10792.730181745519;10818.837717434244;10850.837237441445;11011.944940275407;11083.778324433466;21448.142074317166;21473.892630536746;21482.355529334145;21532.461688457915;21592.460188495414;8163.469374490639;8206.712765053195;8350.373721970876;8365.24712775841;8403.117672644285;4650.348951146842;4662.953370466252;4687.320338550891;4741.217699079613;4834.806607735722;3542.1498840278146;3748.231612519427;3760.567534733486;3761.5486141663177;3762.9059273518383;582.2808831093596;599.5802937943457;600.579594284003;605.833395816154;608.6500262349167;688.7304500992077;751.9248075192437;764.4343186042289;766.9309762121436;795.6061749434067;9405.952970235105;9460.52697365129;9460.621575137055;9614.615415383307;9700.078492543196;599.5233789137646;604.8185544336769;754.5623538347745;770.6108415250262;783.7178615698344;4434.756088415168;4486.295207821007;4530.116627257719;4536.274196128669;4742.6685375024035;97696;104848.47575762072;108096.45951770191;112894;114645.42677286727;61076;75626.62186689032;86396.56801715952;94770;96656.51671741737;87373.12626873777;87394;91153.54423227975;91527;92115.53942230246;9263.649658353146;9332;9417.717468475958;9633.373830700983;10036.749081273027;49707.25439118344;49977.75011124921;50690.493095068574;51044.74477627588;51273.487265128366;67092;73031.26968730244;73250;74053.2594674068;76791.61604192166;12426.378681066091;12479.376031198586;12546.309952952675;12557.93721031389;12570.245785252913;14143;14213.573592792232;14344.713105737617;14457.710845783236;14479.05886117399;12536.658710506466;12971.935140324238;13001.778676804053;13054.869451305365;13104.868951310365;12259;12620.408489548194;12658.683532911382;12844.165129266568;13000.08999370035;11543.8268425972;12828.871711283142;12965.740685186054;13066.608001759962;13067.215967041628;10931.453427328443;10992.780144396907;11206.663800086011;11254.38100904458;11426.542938282375;10990.560377584807;11667.124965627781;11679.532818687157;11881.346525941157;11952.940235298767 14:22:14 INFO - PROCESS | 26215 | __end_tp_report 14:22:14 INFO - PROCESS | 26215 | __start_cc_report 14:22:14 INFO - PROCESS | 26215 | _x_x_mozilla_cycle_collect,341 14:22:14 INFO - PROCESS | 26215 | __end_cc_report 14:22:14 INFO - PROCESS | 26215 | __startTimestamp1465334534607__endTimestamp 14:22:14 INFO - PROCESS | 26215 | 14:22:14 INFO - PROCESS | 26215 | ------- Summary: start ------- 14:22:14 INFO - PROCESS | 26215 | Number of tests: 6 14:22:14 INFO - PROCESS | 26215 | 14:22:14 INFO - PROCESS | 26215 | [#0] dojo.html Cycles:165 Average:5430.27 Median:5701.43 stddev:716.25 (12.6%) stddev-sans-first:695.48 14:22:14 INFO - PROCESS | 26215 | Values: 3137.0 3152.4 3164.0 3172.3 3225.8 5439.6 5468.9 5508.1 5510.1 5545.9 5300.3 5458.3 5488.5 5512.3 5533.0 4960.7 4995.5 5050.2 5088.6 5151.5 838.0 5054.9 5059.0 5060.8 5108.0 5020.1 5036.9 5042.9 5057.6 5079.4 4889.0 5044.2 5053.4 5076.3 5085.2 4893.1 4957.0 4964.0 4968.6 5052.8 5348.9 5372.5 5392.1 5422.2 5430.3 5710.6 5814.2 5833.8 5896.1 5899.6 5974.6 5978.3 6009.2 6011.8 6015.3 5460.3 5491.5 5520.2 5520.2 5521.5 5908.6 5957.3 5979.3 6014.0 6072.5 5740.4 5749.2 5758.5 5770.1 5775.7 5825.0 5855.6 5861.4 5882.7 5883.3 5758.0 5777.3 5790.7 5852.8 5858.8 5712.1 5816.6 5840.6 5852.4 5859.0 4504.1 4515.8 4529.4 4533.5 4561.8 3894.3 3943.2 3966.7 3978.4 4000.8 5563.1 5590.4 5623.7 5628.2 5662.0 5831.2 5866.9 5867.4 5879.0 5919.8 5422.4 5534.2 5545.0 5581.6 5600.3 4967.3 4979.5 4992.1 4993.4 5022.7 6078.7 6092.7 6104.6 6107.7 6116.9 5744.8 5854.0 5893.7 5930.6 5944.4 6085.4 6114.1 6129.6 6143.8 6147.5 5770.9 5804.2 5818.5 5819.1 5823.1 5701.4 5853.9 5891.8 5914.5 5915.5 5719.5 5732.3 5746.1 5752.3 5757.5 5655.0 5711.3 5749.5 5754.3 5763.0 5538.9 5589.6 5603.2 5637.4 5692.9 5747.3 5770.8 5815.7 5827.5 5837.5 5545.6 5650.1 5703.5 5706.4 5708.6 14:22:14 INFO - PROCESS | 26215 | 14:22:14 INFO - PROCESS | 26215 | [#1] ext.html Cycles:180 Average:60025.98 Median:431200.50 stddev:115584.20 (26.8%) stddev-sans-first:115822.29 14:22:14 INFO - PROCESS | 26215 | Values: 585.9 604.6 636.3 649.1 649.3 43559.1 44989.3 45040.8 45074.5 48387.8 44701.3 45178.8 45766.0 45778.0 45806.3 8779.8 8906.4 8958.4 8974.1 8984.6 8781.0 8828.0 8828.4 8878.5 8898.6 8859.3 8876.4 8904.9 8921.4 8926.2 8915.6 8916.8 8967.8 8979.7 8986.3 8755.3 8910.5 8914.7 8944.6 8968.6 43271.9 43324.8 43684.1 43745.8 43781.1 3520.7 3548.2 3559.5 3723.5 4156.6 32848.8 33314.2 33567.0 33649.5 34394.5 4268.1 4293.3 4372.9 4490.9 4501.6 349833.0 350273.0 350335.7 352113.0 352491.0 61863.7 61949.7 62425.0 62495.4 62560.4 35894.0 36352.6 36797.4 38515.2 38575.2 17434.8 17576.5 17592.0 17640.6 17644.8 12532.5 12543.5 12552.8 12636.9 12646.7 19582.8 19710.2 19730.4 19824.1 19952.7 7345.2 7426.9 7461.9 7554.3 7636.8 977.3 1102.4 1109.8 1115.1 1133.0 32452.1 32732.8 32922.8 33172.8 33243.8 1090.0 1104.9 1125.1 1129.7 1205.7 16973.3 17446.8 17513.2 17616.5 18514.3 403173.0 405125.0 574463.0 575142.0 575244.0 59924.0 62768.0 63096.0 63127.4 63454.0 1441.1 1453.4 1465.1 1472.5 1482.5 31587.7 33783.5 34256.7 34477.1 34649.0 53753.2 54264.7 54978.5 54989.2 55105.7 428449.0 430989.0 431412.0 431435.0 432401.0 43942.0 44904.7 45853.8 45959.8 46026.0 48675.0 48868.8 49107.0 50069.5 50146.7 40371.4 42049.4 42238.4 45287.5 46016.3 40330.4 41400.8 42232.6 45324.8 45954.8 36214.5 40911.6 41043.6 41857.8 42347.4 36430.8 38812.8 39134.6 39220.6 39576.2 28939.6 29016.9 29104.3 29263.4 29507.6 14:22:14 INFO - PROCESS | 26215 | 14:22:14 INFO - PROCESS | 26215 | [#2] jquery.html Cycles:180 Average:28906.24 Median:12442.11 stddev:82485.59 (663.0%) stddev-sans-first:82689.17 14:22:14 INFO - PROCESS | 26215 | Values: 380.4 380.9 386.8 401.1 402.3 16860.5 18891.8 19148.9 19198.9 19199.7 10976.6 11291.7 18220.9 18936.5 18943.1 5018.5 5212.0 5248.3 5258.9 5261.9 3873.8 4697.8 6288.7 6298.3 6345.3 6320.6 6330.6 6347.7 6364.6 6366.9 5266.6 5510.3 5573.4 5651.2 5660.4 5279.3 5408.4 5434.2 5435.1 5446.0 12756.3 12930.1 13025.9 16993.9 22519.7 2179.6 2232.4 2364.6 2373.2 2418.5 9390.0 9431.6 9796.5 9835.6 9845.2 1881.4 1983.4 2025.7 2027.2 2033.1 77858.6 78247.6 78763.0 79863.2 81198.6 10002.2 10104.6 10235.4 10392.2 10582.7 13971.1 13975.9 14099.9 14144.0 14191.1 7836.3 7924.9 8006.5 8069.0 8186.3 7786.2 7822.9 7895.5 7924.3 8033.1 4145.6 4348.5 4379.5 4412.5 4465.2 1794.3 1830.2 1842.3 1845.3 1880.9 943.2 999.3 1107.3 1113.8 1116.3 18007.0 18442.5 19150.5 19241.6 19365.7 980.8 989.7 997.6 1008.2 1051.4 9650.9 10295.7 11245.2 11293.0 11702.2 497962.0 498908.0 500250.0 500725.0 507796.0 61640.0 79945.0 95812.5 96108.5 96645.0 1044.5 1045.0 1070.3 1074.2 1078.5 17308.7 17648.3 17706.6 17813.5 17921.8 40660.6 41621.6 41668.6 42303.1 42798.8 55813.7 58807.4 59609.4 59920.4 61778.0 11548.9 12034.3 12445.6 12457.1 13134.9 13457.9 13950.2 14005.9 14621.9 14742.3 11643.2 11644.3 11973.6 11999.8 12373.8 11871.2 12208.6 12391.6 12628.9 12876.4 8053.1 8140.7 8264.9 8276.2 8334.6 12626.6 13034.9 13035.5 13072.7 13093.7 11772.6 11932.9 12170.2 12236.3 12257.3 14:22:14 INFO - PROCESS | 26215 | 14:22:14 INFO - PROCESS | 26215 | [#3] mootools.html Cycles:180 Average:6032.33 Median:4502.90 stddev:3478.16 (77.2%) stddev-sans-first:3471.26 14:22:14 INFO - PROCESS | 26215 | Values: 1502.4 1523.6 1711.2 1807.5 1839.3 8164.9 8778.2 8918.6 9412.6 9431.5 8942.8 9198.3 9229.7 9270.5 9280.6 2312.8 2362.5 2365.7 2366.7 2367.5 2290.7 2313.6 2326.9 2333.1 2341.6 2325.4 2330.6 2337.5 2341.2 2346.6 2285.5 2294.9 2300.6 2306.9 2325.9 2278.0 2301.3 2301.7 2320.5 2327.8 9175.9 9247.4 9258.4 9259.1 9292.3 5189.2 5297.8 5306.7 5312.4 5313.7 3231.0 3377.5 3418.3 3474.8 3505.3 1121.2 1150.8 1153.8 1178.8 1184.2 12720.8 12852.1 12868.7 12903.4 12935.5 4595.8 4718.2 4767.1 4813.0 4843.9 10809.6 10886.9 10928.2 10938.5 10940.3 5416.4 5439.5 5444.8 5468.9 5470.3 4394.2 4891.6 5045.6 5046.6 5054.2 4103.2 4110.8 4114.7 4150.3 4152.5 1267.3 1267.9 1270.7 1272.7 1277.8 1021.0 1044.8 1052.6 1053.2 1057.8 6224.5 6288.4 6358.4 6454.9 6486.3 450.8 459.5 461.6 462.9 462.9 4405.0 4490.5 4497.8 4501.3 4504.5 10986.6 11206.8 11370.8 11394.7 11399.2 10606.8 11254.6 11331.5 11360.4 11413.6 8372.3 8442.6 8516.5 8526.4 8534.0 6041.8 6237.4 6247.0 6328.6 6336.8 10214.4 10595.3 10623.6 10655.3 10681.1 10689.1 10691.8 10757.0 10805.9 10865.5 7413.5 7804.6 8073.7 8136.8 8271.2 8959.3 8998.3 9009.2 9043.9 9056.5 7925.3 7954.0 8125.6 8226.0 8246.0 7881.9 8037.8 8052.5 8102.5 8144.0 7385.2 7421.1 7484.6 7517.7 7574.2 5281.2 5305.7 5492.2 5503.1 5593.5 5446.5 5455.8 5554.9 5640.6 5726.0 14:22:14 INFO - PROCESS | 26215 | 14:22:14 INFO - PROCESS | 26215 | [#4] prototype.html Cycles:180 Average:4843.28 Median:5579.41 stddev:1441.53 (25.8%) stddev-sans-first:1405.08 14:22:14 INFO - PROCESS | 26215 | Values: 322.5 325.5 328.2 333.8 338.4 5579.5 5595.3 5607.0 5623.8 5641.1 5471.9 5485.7 5513.9 5537.7 5569.2 4075.7 4156.7 4274.0 4288.2 4300.0 4304.9 4314.6 4315.7 4318.3 4320.4 4298.2 4308.8 4316.3 4319.2 4325.0 4040.4 4215.7 4241.1 4245.2 4319.6 3668.7 3692.6 3694.7 3694.7 3700.1 5309.8 5312.0 5313.9 5323.7 5331.8 4645.9 4828.2 4858.5 4864.2 4889.5 5637.6 5752.0 5778.9 5782.6 5785.5 4036.2 4038.6 4050.7 4072.6 4108.4 5981.3 5984.6 6070.9 6084.8 6105.8 4117.9 4133.3 4145.4 4150.5 4151.8 4166.6 4185.3 4198.3 4214.4 4230.0 4657.5 4806.8 4835.6 4847.7 4914.7 5719.7 5738.6 5761.7 5793.9 5805.5 1448.4 1460.6 1464.3 1475.2 1485.4 938.1 938.2 940.7 941.4 1007.2 5515.3 5519.9 5582.1 5586.7 5594.8 5845.2 5846.4 5889.0 5911.8 5950.3 5313.3 5528.2 5546.6 5567.6 5579.3 3088.9 3120.8 3133.9 3144.8 3153.2 5858.4 6045.2 6045.7 6078.9 6122.7 5920.3 5985.0 5996.3 5998.6 6065.6 6094.3 6129.6 6138.7 6145.3 6150.6 5754.3 5897.5 5918.5 5936.4 5964.9 5811.5 5827.3 5851.6 5852.3 5890.7 5941.8 6040.8 6062.0 6095.0 6126.9 4085.8 4086.7 4121.8 4124.4 4177.1 5921.5 5952.4 5982.9 6010.0 6010.1 5699.8 5775.4 5782.7 5789.9 5890.4 5717.8 5740.3 5765.7 5799.3 5827.6 5528.6 5555.9 5649.8 5692.3 5712.7 5781.2 5832.6 5838.3 5839.3 5868.4 5483.8 5697.4 5739.6 5741.9 5756.1 14:22:14 INFO - PROCESS | 26215 | 14:22:14 INFO - PROCESS | 26215 | [#5] yui.html Cycles:180 Average:20073.96 Median:4675.14 stddev:28414.53 (607.8%) stddev-sans-first:28456.87 14:22:14 INFO - PROCESS | 26215 | Values: 665.9 700.7 711.3 772.1 810.2 14788.8 15624.4 15659.6 15661.7 15902.7 14291.9 14308.6 14618.3 14643.3 15221.4 791.9 799.2 801.1 804.4 805.9 793.3 798.2 803.4 810.1 812.8 854.7 854.9 855.6 855.7 857.0 856.8 858.3 860.0 860.9 861.1 622.4 626.1 629.2 630.2 630.8 15035.0 15075.5 15104.1 15108.8 15130.0 14788.8 14926.4 15005.3 15039.5 15056.5 11479.4 11575.7 11680.6 11724.4 11727.6 3818.2 3902.2 3908.4 4027.8 4030.7 74744.0 74775.6 75674.6 76078.0 76811.2 10792.7 10818.8 10850.8 11011.9 11083.8 21448.1 21473.9 21482.4 21532.5 21592.5 8163.5 8206.7 8350.4 8365.2 8403.1 4650.3 4663.0 4687.3 4741.2 4834.8 3542.1 3748.2 3760.6 3761.5 3762.9 582.3 599.6 600.6 605.8 608.7 688.7 751.9 764.4 766.9 795.6 9406.0 9460.5 9460.6 9614.6 9700.1 599.5 604.8 754.6 770.6 783.7 4434.8 4486.3 4530.1 4536.3 4742.7 97696.0 104848.5 108096.5 112894.0 114645.4 61076.0 75626.6 86396.6 94770.0 96656.5 87373.1 87394.0 91153.5 91527.0 92115.5 9263.6 9332.0 9417.7 9633.4 10036.7 49707.3 49977.8 50690.5 51044.7 51273.5 67092.0 73031.3 73250.0 74053.3 76791.6 12426.4 12479.4 12546.3 12557.9 12570.2 14143.0 14213.6 14344.7 14457.7 14479.1 12536.7 12971.9 13001.8 13054.9 13104.9 12259.0 12620.4 12658.7 12844.2 13000.1 11543.8 12828.9 12965.7 13066.6 13067.2 10931.5 10992.8 11206.7 11254.4 11426.5 10990.6 11667.1 11679.5 11881.3 11952.9 14:22:14 INFO - PROCESS | 26215 | -------- Summary: end -------- 14:22:14 INFO - PROCESS | 26215 | 14:22:15 INFO - TEST-INFO | 26215: exit 0 14:22:15 INFO - TEST-OK | dromaeo_css | took 1110767ms 14:22:15 INFO - TEST-START | kraken 14:22:15 INFO - operating with platform_type : linux_ 14:22:15 INFO - Initialising browser for kraken test... 14:22:15 INFO - TEST-INFO | started process 26453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj7hZTB/profile http://localhost:32956/getInfo.html) 14:22:20 INFO - PROCESS | 26453 | __metrics Screen width/height:1600/1200 14:22:20 INFO - PROCESS | 26453 | colorDepth:24 14:22:20 INFO - PROCESS | 26453 | Browser inner width/height: 1024/697 14:22:20 INFO - PROCESS | 26453 | __metrics 14:22:20 ERROR - PROCESS | 26453 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:22:21 INFO - TEST-INFO | 26453: exit 0 14:22:21 INFO - Browser initialized. 14:22:21 INFO - Running cycle 1/1 for kraken test... 14:22:21 INFO - TEST-INFO | started process 26572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj7hZTB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:33 INFO - PROCESS | 26572 | RSS: Main: 166879232 14:22:33 INFO - PROCESS | 26572 | 14:22:36 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32956/tests/kraken/driver.html?testName=audio-beat-detection) 14:22:36 INFO - PROCESS | 26572 | RSS: Main: 172494848 14:22:36 INFO - PROCESS | 26572 | 14:22:39 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32956/tests/kraken/driver.html?testName=audio-dft) 14:22:40 INFO - PROCESS | 26572 | RSS: Main: 171696128 14:22:40 INFO - PROCESS | 26572 | 14:22:43 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32956/tests/kraken/driver.html?testName=audio-fft) 14:22:43 INFO - PROCESS | 26572 | RSS: Main: 166457344 14:22:43 INFO - PROCESS | 26572 | 14:22:46 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32956/tests/kraken/driver.html?testName=audio-oscillator) 14:22:46 INFO - PROCESS | 26572 | RSS: Main: 167100416 14:22:46 INFO - PROCESS | 26572 | 14:22:48 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32956/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:49 INFO - PROCESS | 26572 | RSS: Main: 167469056 14:22:49 INFO - PROCESS | 26572 | 14:22:52 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32956/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:53 INFO - PROCESS | 26572 | RSS: Main: 167964672 14:22:53 INFO - PROCESS | 26572 | 14:22:56 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32956/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:57 INFO - PROCESS | 26572 | RSS: Main: 165781504 14:22:57 INFO - PROCESS | 26572 | 14:23:00 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32956/tests/kraken/driver.html?testName=json-parse-financial) 14:23:00 INFO - PROCESS | 26572 | RSS: Main: 166723584 14:23:00 INFO - PROCESS | 26572 | 14:23:02 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32956/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:23:02 INFO - PROCESS | 26572 | RSS: Main: 167456768 14:23:02 INFO - PROCESS | 26572 | 14:23:04 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32956/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:23:05 INFO - PROCESS | 26572 | RSS: Main: 167645184 14:23:05 INFO - PROCESS | 26572 | 14:23:07 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32956/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:23:08 INFO - PROCESS | 26572 | RSS: Main: 167915520 14:23:08 INFO - PROCESS | 26572 | 14:23:10 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:23:11 INFO - PROCESS | 26572 | RSS: Main: 167849984 14:23:11 INFO - PROCESS | 26572 | 14:23:14 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:23:14 INFO - PROCESS | 26572 | RSS: Main: 167800832 14:23:14 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | Cycle 1(1): loaded http://localhost:32956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32956/tests/kraken/driver.html?testName=ai-astar) 14:23:16 INFO - PROCESS | 26572 | RSS: Main: 168472576 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | __start_tp_report 14:23:16 INFO - PROCESS | 26572 | _x_x_mozilla_page_load 14:23:16 INFO - PROCESS | 26572 | _x_x_mozilla_page_load_details 14:23:16 INFO - PROCESS | 26572 | |i|pagename|runs| 14:23:16 INFO - PROCESS | 26572 | |0;ai-astar;113;108;113;111;114;113;111;111;111;113 14:23:16 INFO - PROCESS | 26572 | |1;audio-beat-detection;152;129;163;181;134;156;151;125;186;125 14:23:16 INFO - PROCESS | 26572 | |2;audio-dft;162;163;162;162;161;164;175;173;164;163 14:23:16 INFO - PROCESS | 26572 | |3;audio-fft;77;77;76;159;76;76;74;75;177;75 14:23:16 INFO - PROCESS | 26572 | |4;audio-oscillator;84;84;143;86;87;85;140;84;86;139 14:23:16 INFO - PROCESS | 26572 | |5;imaging-gaussian-blur;117;117;118;117;117;117;118;117;118;117 14:23:16 INFO - PROCESS | 26572 | |6;imaging-darkroom;147;147;147;147;147;146;147;147;146;148 14:23:16 INFO - PROCESS | 26572 | |7;imaging-desaturate;95;95;95;95;94;95;96;95;96;95 14:23:16 INFO - PROCESS | 26572 | |8;json-parse-financial;56;56;56;57;59;58;58;55;56;58 14:23:16 INFO - PROCESS | 26572 | |9;json-stringify-tinderbox;61;61;61;61;60;61;61;61;60;61 14:23:16 INFO - PROCESS | 26572 | |10;stanford-crypto-aes;81;80;80;81;81;83;81;85;111;81 14:23:16 INFO - PROCESS | 26572 | |11;stanford-crypto-ccm;125;132;123;127;121;120;143;130;138;127 14:23:16 INFO - PROCESS | 26572 | |12;stanford-crypto-pbkdf2;164;158;161;164;162;158;161;163;160;160 14:23:16 INFO - PROCESS | 26572 | |13;stanford-crypto-sha256-iterative;66;66;63;62;68;62;63;64;62;65 14:23:16 INFO - PROCESS | 26572 | __end_tp_report 14:23:16 INFO - PROCESS | 26572 | __start_cc_report 14:23:16 INFO - PROCESS | 26572 | _x_x_mozilla_cycle_collect,903 14:23:16 INFO - PROCESS | 26572 | __end_cc_report 14:23:16 INFO - PROCESS | 26572 | __startTimestamp1465334596596__endTimestamp 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | ------- Summary: start ------- 14:23:16 INFO - PROCESS | 26572 | Number of tests: 14 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:1.75 (1.5%) stddev-sans-first:1.80 14:23:16 INFO - PROCESS | 26572 | Values: 113.0 108.0 113.0 111.0 114.0 113.0 111.0 111.0 111.0 113.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:154.00 stddev:22.14 (14.4%) stddev-sans-first:23.48 14:23:16 INFO - PROCESS | 26572 | Values: 152.0 129.0 163.0 181.0 134.0 156.0 151.0 125.0 186.0 125.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#2] audio-dft Cycles:10 Average:164.90 Median:163.50 stddev:4.91 (3.0%) stddev-sans-first:5.09 14:23:16 INFO - PROCESS | 26572 | Values: 162.0 163.0 162.0 162.0 161.0 164.0 175.0 173.0 164.0 163.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:39.14 (51.5%) stddev-sans-first:41.01 14:23:16 INFO - PROCESS | 26572 | Values: 77.0 77.0 76.0 159.0 76.0 76.0 74.0 75.0 177.0 75.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:84.50 stddev:26.86 (31.8%) stddev-sans-first:27.70 14:23:16 INFO - PROCESS | 26572 | Values: 84.0 84.0 143.0 86.0 87.0 85.0 140.0 84.0 86.0 139.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:23:16 INFO - PROCESS | 26572 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 14:23:16 INFO - PROCESS | 26572 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 148.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:23:16 INFO - PROCESS | 26572 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 96.0 95.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.50 stddev:1.29 (2.2%) stddev-sans-first:1.32 14:23:16 INFO - PROCESS | 26572 | Values: 56.0 56.0 56.0 57.0 59.0 58.0 58.0 55.0 56.0 58.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 14:23:16 INFO - PROCESS | 26572 | Values: 61.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 60.0 61.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:81.00 stddev:9.47 (11.7%) stddev-sans-first:9.96 14:23:16 INFO - PROCESS | 26572 | Values: 81.0 80.0 80.0 81.0 81.0 83.0 81.0 85.0 111.0 81.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.50 stddev:7.38 (5.7%) stddev-sans-first:7.71 14:23:16 INFO - PROCESS | 26572 | Values: 125.0 132.0 123.0 127.0 121.0 120.0 143.0 130.0 138.0 127.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:2.18 (1.4%) stddev-sans-first:2.05 14:23:16 INFO - PROCESS | 26572 | Values: 164.0 158.0 161.0 164.0 162.0 158.0 161.0 163.0 160.0 160.0 14:23:16 INFO - PROCESS | 26572 | 14:23:16 INFO - PROCESS | 26572 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:2.08 (3.2%) stddev-sans-first:2.09 14:23:16 INFO - PROCESS | 26572 | Values: 66.0 66.0 63.0 62.0 68.0 62.0 63.0 64.0 62.0 65.0 14:23:16 INFO - PROCESS | 26572 | -------- Summary: end -------- 14:23:16 INFO - PROCESS | 26572 | 14:23:17 INFO - TEST-INFO | 26572: exit 0 14:23:17 INFO - TEST-OK | kraken | took 62253ms 14:23:17 INFO - SUITE-END | took 1173s 14:23:17 INFO - Completed test suite (00:19:33) 14:23:17 INFO - javascript benchmark 14:23:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7339.321225483864, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.043201823446, 3152.353767477667, 3163.95254071189, 3172.333809899921, 3225.774195806293, 5439.646422982503, 5468.945310546894, 5508.063629183039, 5510.090835012224, 5545.889082218353, 5300.310959575259, 5458.263134476844, 5488.53347465466, 5512.255845460862, 5533.0, 4960.702357858522, 4995.500449954993, 5050.242463630448, 5088.567471764886, 5151.484851514856, 837.9660654148661, 5054.9241761373605, 5059.0, 5060.797568097271, 5108.029474399871, 5020.146575082244, 5036.924446133311, 5042.949570504303, 5057.645964782467, 5079.415867175267, 4889.022195560902, 5044.167712327461, 5053.393592768891, 5076.314697515825, 5085.23721441783, 4893.143699852511, 4956.950430495721, 4963.975180124113, 4968.552830245259, 5052.8231511897275, 5348.91976620351, 5372.516473517402, 5392.09113617289, 5422.15956526739, 5430.294061771984, 5710.571707121982, 5814.186013958049, 5833.824985250407, 5896.115582662592, 5899.557533185029, 5974.641521508724, 5978.252718410199, 6009.2188015557695, 6011.819645410601, 6015.27816661999, 5460.31746031746, 5491.478309560585, 5520.199571062173, 5520.199571062214, 5521.5306698930635, 5908.586398952032, 5957.314908785458, 5979.342272350038, 6014.007688731398, 6072.544559157993, 5740.368559458456, 5749.1663708762, 5758.539316854642, 5770.076787713946, 5775.7400916957995, 5825.0, 5855.619384739978, 5861.413858614104, 5882.705864706748, 5883.294004719461, 5758.0, 5777.277840269966, 5790.681512516768, 5852.824415267549, 5858.765649374062, 5712.143178523172, 5816.621919575214, 5840.561957853178, 5852.414758524199, 5858.970705146447, 4504.054148628759, 4515.774211289422, 4529.388532548064, 4533.455985281721, 4561.817527298937, 3894.2600905828367, 3943.2113577284085, 3966.702497312713, 3978.3833505806647, 4000.8199631016673, 5563.109902415594, 5590.385057643656, 5623.718814059363, 5628.183913332544, 5662.037453632893, 5831.154482599999, 5866.941330586725, 5867.442592953663, 5878.970605146947, 5919.792807251725, 5422.376426710979, 5534.1975413564805, 5544.972275138679, 5581.581381396411, 5600.299962504687, 4967.254911763264, 4979.502049794992, 4992.101421744121, 4993.350864387679, 5022.748862556858, 6078.696065196723, 6092.695365231721, 6104.633721976696, 6107.725152368154, 6116.908246376308, 5744.798932037359, 5854.0048191806645, 5893.734781934738, 5930.555208359304, 5944.435278648435, 6085.361037091042, 6114.144019837316, 6129.632222066691, 6143.846403839761, 6147.538934579835, 5770.855728606651, 5804.187413762161, 5818.4763371296785, 5819.0689489681445, 5823.126531020381, 5701.4298570142655, 5853.9121913172185, 5891.823245302648, 5914.497267732118, 5915.526757859447, 5719.48524632785, 5732.254806875247, 5746.051901436216, 5752.28096487939, 5757.481826635623, 5654.971725141348, 5711.314642242791, 5749.453801888814, 5754.309482861916, 5763.049096899133, 5538.889222215453, 5589.636673616202, 5603.187537807076, 5637.379888212211, 5692.886142277214, 5747.281589801275, 5770.826875193751, 5815.651060936358, 5827.533797296291, 5837.474627283565, 5545.584081193846, 5650.095984642602, 5703.515201207943, 5706.372299047184, 5708.600397972102], "value": 5383.91937493158, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.9238299021126, 604.5949214026601, 636.3318515558664, 649.0912722188934, 649.3182158733332, 43559.12881742363, 44989.32516012262, 45040.77479612602, 45074.549254507445, 48387.75806120964, 44701.32948005774, 45178.7741061295, 45766.0, 45778.0, 45806.33549316055, 8779.824403511926, 8906.42108262964, 8958.37291389603, 8974.14745599167, 8984.640614375417, 8780.956095219546, 8828.0, 8828.42615230008, 8878.511681857495, 8898.555072246394, 8859.335549833757, 8876.378653494257, 8904.8664270036, 8921.420107693011, 8926.152015558511, 8915.59879805407, 8916.821663566725, 8967.775805604912, 8979.730608081769, 8986.326025548111, 8755.25580325673, 8910.465372077697, 8914.73255802327, 8944.59749311276, 8968.596413161358, 43271.918202044886, 43324.783376082916, 43684.12631747347, 43745.78127109376, 43781.12437751259, 3520.6831385175456, 3548.201654627714, 3559.501669766235, 3723.5345581802276, 4156.646685031776, 32848.83575582107, 33314.16714582131, 33567.0, 33649.49525757116, 34394.48408273878, 4268.082362292091, 4293.334533147367, 4372.934405983913, 4490.932636010462, 4501.617362524189, 349832.99999999744, 350273.0, 350335.7382491626, 352113.0, 352491.0, 61863.6906815463, 61949.690251548454, 62425.0, 62495.375046249865, 62560.37439625637, 35894.0, 36352.63647363545, 36797.44803827945, 38515.229695405935, 38575.22849542993, 17434.825651743573, 17576.472705818847, 17592.0, 17640.558986025197, 17644.823551764573, 12532.498700052078, 12543.498260069677, 12552.81170782439, 12636.936815315865, 12646.747065058831, 19582.80417195838, 19710.21159153618, 19730.40808775739, 19824.107915143566, 19952.70070948937, 7345.22875098107, 7426.888596671054, 7461.888071678929, 7554.2823431773895, 7636.770896873103, 977.2865807960229, 1102.4322473925934, 1109.7780443911088, 1115.130198445214, 1132.9916374426766, 32452.114131298757, 32732.836335818167, 32922.83538582292, 33172.834135829646, 33243.833780830944, 1089.9509522071526, 1104.8950349716763, 1125.054953838763, 1129.7288650723767, 1205.69254840017, 16973.321067157423, 17446.825531744773, 17513.211905464286, 17616.471505854846, 18514.259429622933, 403173.0, 405125.0, 574463.0, 575142.0, 575244.0, 59924.0, 62768.0, 63096.0, 63127.36872631215, 63454.0, 1441.1137150652273, 1453.404104317225, 1465.1136062681924, 1472.5435115114135, 1482.5181815909873, 31587.684123158473, 33783.49324760081, 34256.65743342634, 34477.13807154841, 34649.0, 53753.19370209372, 54264.72867635637, 54978.45021549733, 54989.175162373394, 55105.72447137738, 428449.0, 430989.0, 431412.0, 431435.0, 432401.0, 43942.0, 44904.65286041424, 45853.77073114613, 45959.77020114878, 46026.0, 48675.0, 48868.75565622149, 49107.0, 50069.49930500648, 50146.749266253435, 40371.394429083, 42049.36925946052, 42238.366424503045, 45287.54712452833, 46016.30975535436, 40330.395044073775, 41400.79299603483, 42232.57767422286, 45324.77337613291, 45954.770226148656, 36214.4567831488, 40911.59088409078, 41043.589564103975, 41857.79071104625, 42347.364789527564, 36430.8178459106, 38812.80593597127, 39134.608653914234, 39220.607793922834, 39576.2084758309, 28939.56590651184, 29016.854915725286, 29104.27239319034, 29263.414731705674, 29507.55738663879], "value": 20676.736308475367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.37238556381965, 380.92191100824334, 386.83752823813984, 401.07151943251387, 402.3120464006549, 16860.494185174448, 18891.811081889176, 19148.90425547872, 19198.90400547997, 19199.712004319947, 10976.560937562508, 11291.717707057327, 18220.908895455537, 18936.5265868353, 18943.147558359873, 5018.548330650241, 5211.973940130313, 5248.317718696564, 5258.92111618326, 5261.947380526184, 3873.845046198149, 4697.765111744417, 6288.717007734663, 6298.307186209536, 6345.302016778174, 6320.589161704497, 6330.588511746745, 6347.746090156388, 6364.649944253064, 6366.872662546746, 5266.605004624649, 5510.256115424427, 5573.359063707665, 5651.208830763655, 5660.377358490563, 5279.287296215, 5408.4050754416985, 5434.212039254286, 5435.076037073707, 5445.9652665993335, 12756.2984035878, 12930.09489335747, 13025.934870325682, 16993.91503042489, 22519.662205066936, 2179.618566750828, 2232.374935018181, 2364.550735360276, 2373.2168384433094, 2418.504206637635, 9390.0, 9431.575579098957, 9796.461194634292, 9835.557399917021, 9845.163161131313, 1881.4261650196684, 1983.3653230966097, 2025.73665423494, 2027.1992562937558, 2033.0647901965115, 77858.6107069461, 78247.60876195582, 78763.0, 79863.20136798616, 81198.59400703017, 10002.199824014062, 10104.646337378157, 10235.43705096212, 10392.168626509861, 10582.735431614272, 13971.09187902783, 13975.860241397659, 14099.929500352639, 14144.0, 14191.148531087962, 7836.294733474015, 7924.920750792418, 8006.479578827358, 8068.9596552016865, 8186.345092392594, 7786.221377862168, 7822.882656760153, 7895.486793358414, 7924.326432253208, 8033.1122186286175, 4145.647619952338, 4348.543402942645, 4379.5182529921685, 4412.477695195153, 4465.196264672325, 1794.2864564341023, 1830.2313028528051, 1842.3367587668429, 1845.3264558436342, 1880.858935579837, 943.1982814607529, 999.3404353126901, 1107.3023994883172, 1113.760541483585, 1116.3469370418234, 18007.009614471066, 18442.524598032393, 19150.521236969187, 19241.615167696847, 19365.709514357295, 980.8479685648736, 989.747614358334, 997.6009596161448, 1008.2186305613209, 1051.4217180550665, 9650.855237171449, 10295.742606434898, 11245.15661325404, 11293.0, 11702.239354442105, 497962.0, 498908.0, 500250.0, 500725.0, 507796.0, 61640.0, 79945.0, 95812.52093739486, 96108.51945740226, 96645.0, 1044.5456226541478, 1045.0490054050929, 1070.309650275568, 1074.1782536359692, 1078.5146683992077, 17308.740368894225, 17648.294068237126, 17706.5573360667, 17813.46559603214, 17921.820781792016, 40660.59339406686, 41621.583784162984, 41668.583314167685, 42303.09636066323, 42798.78600606977, 55813.72093139508, 58807.411925880195, 59609.40390596212, 59920.40079599148, 61778.0, 11548.884511154782, 12034.338111403957, 12445.62663120108, 12457.12800103984, 13134.868651313365, 13457.932710336385, 13950.162990220619, 14005.929970350084, 14621.926890365905, 14742.26288685583, 11643.243189192675, 11644.301341919512, 11973.640790776291, 11999.76000480003, 12373.814392783936, 11871.228370155912, 12208.572699955459, 12391.566295179626, 12628.936855315664, 12876.420561074587, 8053.114157442559, 8140.674373025013, 8264.876026859722, 8276.172382761675, 8334.62494187751, 12626.621201363974, 13034.869651303365, 13035.47858085666, 13072.673183170496, 13093.672658183621, 11772.587959421378, 11932.880671193177, 12170.208936419105, 12236.32700201462, 12257.325847078497], "value": 9118.754418264045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.3690050178927, 1523.6343277613373, 1711.1786342555572, 1807.466797294798, 1839.310258653006, 8164.877526837087, 8778.166074222947, 8918.598663060162, 9412.576434060467, 9431.528423578828, 8942.776430589238, 9198.310126740487, 9229.676961306355, 9270.536473176331, 9280.582373793179, 2312.8034117100024, 2362.5393048355577, 2365.656979737937, 2366.7278262999716, 2367.479154585997, 2290.702208712865, 2313.606686863229, 2326.906923723049, 2333.148400833692, 2341.555104530142, 2325.383773300077, 2330.568844763716, 2337.544178885118, 2341.2273949596593, 2346.601077816775, 2285.4971906180613, 2294.8852557372147, 2300.562893050315, 2306.907723691059, 2325.93022209334, 2277.9886100569556, 2301.2635956493928, 2301.7122859642545, 2320.524292520029, 2327.7788610082016, 9175.853018372703, 9247.352685311964, 9258.398204116711, 9259.120383563552, 9292.349535532516, 5189.247559103909, 5297.814576489843, 5306.655067420644, 5312.389075256357, 5313.707746073965, 3230.96769032309, 3377.527146199534, 3418.265073009315, 3474.826258687081, 3505.2814173094707, 1121.1535290855434, 1150.8158694608906, 1153.8384626152344, 1178.7819253438142, 1184.1829137894824, 12720.809187862189, 12852.100352975296, 12868.678283042906, 12903.419346129447, 12935.48258069676, 4595.770211489412, 4718.221493453541, 4767.070421267819, 4813.03739252151, 4843.878903027382, 10809.567617295377, 10886.945565272123, 10928.235023548434, 10938.453077346101, 10940.343579385262, 5416.350037995466, 5439.456054394529, 5444.8094316698725, 5468.863278417992, 5470.288862447936, 4394.1651086293505, 4891.584215341664, 5045.646804723708, 5046.571041461443, 5054.21659642756, 4103.2073105178215, 4110.753354798721, 4114.670826333886, 4150.27370210212, 4152.501699795984, 1267.283984548727, 1267.8985681145487, 1270.707737220426, 1272.6500212441467, 1277.8466584009977, 1021.0, 1044.8380501022355, 1052.55792567122, 1053.204830353094, 1057.8095942730229, 6224.533160012927, 6288.402601752826, 6358.395952384516, 6454.870902581922, 6486.254080780676, 450.76560188701694, 459.48767124656433, 461.56151655927005, 462.9120467111238, 462.94444666639544, 4404.977975110104, 4490.528494508095, 4497.820087196541, 4501.257292546758, 4504.549545045535, 10986.615468458565, 11206.831897521544, 11370.772584548262, 11394.715132121763, 11399.202055856176, 10606.840897386546, 11254.606088786853, 11331.490082946288, 11360.431978401211, 11413.60052398162, 8372.33021358302, 8442.620082096197, 8516.531590762568, 8526.445781024213, 8534.0, 6041.818745437644, 6237.438630523093, 6247.0, 6328.588641738273, 6336.841578960563, 10214.387136771817, 10595.258331916692, 10623.628173013907, 10655.25413221067, 10681.145508359468, 10689.09142722846, 10691.786164276515, 10757.0, 10805.945970270099, 10865.511052002837, 7413.518121322097, 7804.648790804314, 8073.717419890276, 8136.75589732309, 8271.2142346477, 8959.328050396376, 8998.280137589109, 9009.234215091528, 9043.864342034743, 9056.456612603264, 7925.326347260548, 7953.960230198812, 8125.593720313843, 8225.95887020561, 8246.0, 7881.921180788118, 8037.8392432152195, 8052.476589021695, 8102.513849169069, 8144.0, 7385.224551422239, 7421.109466864011, 7484.588347640932, 7517.661705223388, 7574.242575742382, 5281.15501519755, 5305.681659100466, 5492.176173573996, 5503.11950087984, 5593.524550413261, 5446.455354464521, 5455.754491047992, 5554.888902222014, 5640.633358831663, 5726.0], "value": 4720.3922035279475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.4840255591055, 325.50035695207845, 328.20901627078746, 333.7663635455181, 338.417921175578, 5579.549317177532, 5595.328560572727, 5607.046802043657, 5623.80316688916, 5641.097424412095, 5471.917921231185, 5485.725713714308, 5513.862153446166, 5537.667739935607, 5569.248151499546, 4075.6739460843137, 4156.729812562174, 4273.978630106861, 4288.185244803493, 4299.978500107511, 4304.892377690551, 4314.590113939171, 4315.741055536678, 4318.265894797876, 4320.416743739602, 4298.247806633826, 4308.80610372534, 4316.287812510932, 4319.157764235975, 4324.956750432502, 4040.43433919253, 4215.704900656955, 4241.130568233505, 4245.15096980602, 4319.568043195687, 3668.6881615062753, 3692.612275711065, 3694.685951694109, 3694.722895782827, 3700.111973126457, 5309.840704778863, 5312.0, 5313.893722125575, 5323.707196104213, 5331.840044798662, 4645.86062418128, 4828.155072862271, 4858.51815196365, 4864.197407427806, 4889.511048895118, 5637.60401829221, 5751.971240143815, 5778.88442231153, 5782.566307526952, 5785.537157027427, 4036.2129384769983, 4038.5557588665224, 4050.675945924319, 4072.572379900127, 4108.383742438628, 5981.282246130449, 5984.611000285011, 6070.939290607126, 6084.847878803021, 6105.8168254952425, 4117.890992300794, 4133.338665813455, 4145.398917156996, 4150.501939767248, 4151.8339266429, 4166.645835103989, 4185.330347144442, 4198.349255865346, 4214.3678448232395, 4229.957700422957, 4657.534246575383, 4806.7836947337455, 4835.564799168092, 4847.709137451764, 4914.65597408178, 5719.742611582489, 5738.569607279471, 5761.711914404263, 5793.913091303634, 5805.535557155417, 1448.3699590678088, 1460.6202387379146, 1464.3264098514803, 1475.1812743927223, 1485.3687182947203, 938.1369140390857, 938.2353381993789, 940.6801687426171, 941.3692825806589, 1007.2345017786535, 5515.255440515479, 5519.9448005520235, 5582.106862901916, 5586.748596313176, 5594.82508673175, 5845.246426072246, 5846.356900740915, 5889.0, 5911.822645320562, 5950.345461999176, 5313.335833020872, 5528.198411230349, 5546.584006199551, 5567.610267281251, 5579.2746942897165, 3088.922776930595, 3120.75169932029, 3133.9216519586735, 3144.811311321328, 3153.195935036597, 5858.443447872445, 6045.153678485016, 6045.667488288098, 6078.878422431527, 6122.7244773984385, 5920.31916329619, 5984.952633289157, 5996.310424301174, 5998.610090344114, 6065.60573562717, 6094.268687757498, 6129.632222066691, 6138.6623735694075, 6145.262568491809, 6150.569460137837, 5754.309482862083, 5897.469227769521, 5918.467337939606, 5936.406359364029, 5964.940350596438, 5811.53507719373, 5827.329857066492, 5851.64890106595, 5852.268466441695, 5890.734916928663, 5941.807349549344, 6040.788572399945, 6061.969690151697, 6095.0, 6126.938730612816, 4085.836566537424, 4086.734362266562, 4121.793910304533, 4124.360724087771, 4177.12280421115, 5921.467067963904, 5952.434518720715, 5982.940170598238, 6010.0, 6010.1285313628405, 5699.829005129853, 5775.364709881994, 5782.710864456676, 5789.94210057894, 5890.352061273171, 5717.828465146053, 5740.311162660508, 5765.7117144141785, 5799.333076696234, 5827.59206855516, 5528.612997090165, 5555.916661250004, 5649.7740090397565, 5692.2600061993335, 5712.742926568231, 5781.248437703071, 5832.562557808096, 5838.2702162229725, 5839.299284085937, 5868.413158684098, 5483.8080667176455, 5697.401772813961, 5739.598228123991, 5741.942580574308, 5756.136579512939], "value": 4377.795967586371, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.8568407792327, 700.6601798127907, 711.2638419236092, 772.1352085664055, 810.2464707821725, 14788.778168327484, 15624.375024998986, 15659.608509787233, 15661.686766264682, 15902.681946361081, 14291.857081429183, 14308.642283942881, 14618.269086545683, 14643.267836608153, 15221.391144354213, 791.9247671471215, 799.1528979281951, 801.1387758159972, 804.4409135650725, 805.8589746794316, 793.3494534481728, 798.2177466083242, 803.3813963248296, 810.1210186947139, 812.8496228197773, 854.6624083487019, 854.9187827156442, 855.6491838346279, 855.687673998989, 856.9528675922821, 856.8072183758667, 858.3219256787131, 859.9957000214958, 860.8880845490108, 861.1087524412203, 622.3620788691582, 626.0734113511983, 629.1632129268063, 630.1713247080075, 630.782380078872, 15035.0, 15075.54773356801, 15104.093754374662, 15108.773368399483, 15130.0, 14788.778168327484, 14926.40294388223, 15005.324760385809, 15039.548813535612, 15056.473023444127, 11479.426028698615, 11575.710607234802, 11680.591179308769, 11724.355160466172, 11727.589534366341, 3818.2172654606015, 3902.180542086165, 3908.3746600543777, 4027.7583344999393, 4030.717849750519, 74743.99999999946, 74775.62612186959, 75674.62162689152, 76078.0, 76811.23188768097, 10792.730181745519, 10818.837717434244, 10850.837237441445, 11011.944940275407, 11083.778324433466, 21448.142074317166, 21473.892630536746, 21482.355529334145, 21532.461688457915, 21592.460188495414, 8163.469374490639, 8206.712765053195, 8350.373721970876, 8365.24712775841, 8403.117672644285, 4650.348951146842, 4662.953370466252, 4687.320338550891, 4741.217699079613, 4834.806607735722, 3542.1498840278146, 3748.231612519427, 3760.567534733486, 3761.5486141663177, 3762.9059273518383, 582.2808831093596, 599.5802937943457, 600.579594284003, 605.833395816154, 608.6500262349167, 688.7304500992077, 751.9248075192437, 764.4343186042289, 766.9309762121436, 795.6061749434067, 9405.952970235105, 9460.52697365129, 9460.621575137055, 9614.615415383307, 9700.078492543196, 599.5233789137646, 604.8185544336769, 754.5623538347745, 770.6108415250262, 783.7178615698344, 4434.756088415168, 4486.295207821007, 4530.116627257719, 4536.274196128669, 4742.6685375024035, 97696.0, 104848.47575762072, 108096.45951770191, 112894.0, 114645.42677286727, 61076.0, 75626.62186689032, 86396.56801715952, 94770.0, 96656.51671741737, 87373.12626873777, 87394.0, 91153.54423227975, 91527.0, 92115.53942230246, 9263.649658353146, 9332.0, 9417.717468475958, 9633.373830700983, 10036.749081273027, 49707.25439118344, 49977.75011124921, 50690.493095068574, 51044.74477627588, 51273.487265128366, 67092.0, 73031.26968730244, 73250.0, 74053.2594674068, 76791.61604192166, 12426.378681066091, 12479.376031198586, 12546.309952952675, 12557.93721031389, 12570.245785252913, 14143.0, 14213.573592792232, 14344.713105737617, 14457.710845783236, 14479.05886117399, 12536.658710506466, 12971.935140324238, 13001.778676804053, 13054.869451305365, 13104.868951310365, 12259.0, 12620.408489548194, 12658.683532911382, 12844.165129266568, 13000.08999370035, 11543.8268425972, 12828.871711283142, 12965.740685186054, 13066.608001759962, 13067.215967041628, 10931.453427328443, 10992.780144396907, 11206.663800086011, 11254.38100904458, 11426.542938282375, 10990.560377584807, 11667.124965627781, 11679.532818687157, 11881.346525941157, 11952.940235298767], "value": 7449.754699963479, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 113.0, 111.0, 114.0, 113.0, 111.0, 111.0, 111.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 163.0, 181.0, 134.0, 156.0, 151.0, 125.0, 186.0, 125.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 161.0, 164.0, 175.0, 173.0, 164.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 159.0, 76.0, 76.0, 74.0, 75.0, 177.0, 75.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 143.0, 86.0, 87.0, 85.0, 140.0, 84.0, 86.0, 139.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 59.0, 58.0, 58.0, 55.0, 56.0, 58.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 81.0, 81.0, 83.0, 81.0, 85.0, 111.0, 81.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 132.0, 123.0, 127.0, 121.0, 120.0, 143.0, 130.0, 138.0, 127.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 158.0, 161.0, 164.0, 162.0, 158.0, 161.0, 163.0, 160.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 63.0, 62.0, 68.0, 62.0, 63.0, 64.0, 62.0, 65.0], "value": 64.1, "unit": "score"}]}]} 14:23:17 INFO - Return code: 0 14:23:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:23:17 ERROR - # TBPL SUCCESS # 14:23:17 INFO - Running post-action listener: _resource_record_post_action 14:23:17 INFO - ##### 14:23:17 INFO - ##### Finished run-tests step (success) 14:23:17 INFO - ##### 14:23:17 INFO - Running post-run listener: _resource_record_post_run 14:23:17 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540622848; Read time: 4; Write time: 545452 14:23:17 INFO - TinderboxPrint: CPU usage
13.5% 14:23:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 14:23:17 INFO - TinderboxPrint: I/O write bytes / time
540,622,848 / 545,452 14:23:17 INFO - TinderboxPrint: CPU idle
8,222.3 (86.5%) 14:23:17 INFO - TinderboxPrint: CPU user
1,224.0 (12.9%) 14:23:17 INFO - TinderboxPrint: Swap in / out
0 / 0 14:23:17 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247828480; Read time: 0; Write time: 276556 14:23:17 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292794368; Read time: 4; Write time: 268896 14:23:18 INFO - Running post-run listener: _upload_blobber_files 14:23:18 INFO - Blob upload gear active. 14:23:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:23:18 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 14:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:23:18 INFO - (blobuploader) - INFO - Open directory for files ... 14:23:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:23:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:23:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:19 INFO - (blobuploader) - INFO - Done attempting. 14:23:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:23:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:23:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:23 INFO - (blobuploader) - INFO - Done attempting. 14:23:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:23:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:23:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:24 INFO - (blobuploader) - INFO - Done attempting. 14:23:24 INFO - (blobuploader) - INFO - Iteration through files over. 14:23:24 INFO - Return code: 0 14:23:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:23:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:23:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34891136228cf2f8d63655d52ec7dd2a7ae8e3186d99804c2e559f3f594167831d42cd4ff7cae09cdf92a4bee199bf9a19200efcba20fc147b6b700e095101c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f39c0ed9508a4d1fb4aeaa69ab2c416ac42f93a975547ac9a563effc7b33608fea3054d7c6d856d0474173802b034527ddc1827e39ff4f3fb66f32433f1760bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/297b289e1caad024bd555bdbd9cc5c29cff54903c0aae2457da0cdbe15b7a127951ff4da877cfde710f11aa8a546bf4dadfa3d743439692b1392b8b4e398f49a"} 14:23:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:23:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:23:24 INFO - Contents: 14:23:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34891136228cf2f8d63655d52ec7dd2a7ae8e3186d99804c2e559f3f594167831d42cd4ff7cae09cdf92a4bee199bf9a19200efcba20fc147b6b700e095101c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f39c0ed9508a4d1fb4aeaa69ab2c416ac42f93a975547ac9a563effc7b33608fea3054d7c6d856d0474173802b034527ddc1827e39ff4f3fb66f32433f1760bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/297b289e1caad024bd555bdbd9cc5c29cff54903c0aae2457da0cdbe15b7a127951ff4da877cfde710f11aa8a546bf4dadfa3d743439692b1392b8b4e398f49a"} 14:23:24 INFO - Running post-run listener: copy_logs_to_upload_dir 14:23:24 INFO - Copying logs to upload dir... 14:23:24 INFO - mkdir: /builds/slave/test/build/upload/logs 14:23:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.063904 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-07 14:23:24.005227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 14:23:24.008884) ========= 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=836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34891136228cf2f8d63655d52ec7dd2a7ae8e3186d99804c2e559f3f594167831d42cd4ff7cae09cdf92a4bee199bf9a19200efcba20fc147b6b700e095101c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f39c0ed9508a4d1fb4aeaa69ab2c416ac42f93a975547ac9a563effc7b33608fea3054d7c6d856d0474173802b034527ddc1827e39ff4f3fb66f32433f1760bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/297b289e1caad024bd555bdbd9cc5c29cff54903c0aae2457da0cdbe15b7a127951ff4da877cfde710f11aa8a546bf4dadfa3d743439692b1392b8b4e398f49a"} build_url:https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/Fb_AcVuKTSmWwOmbNyccNQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34891136228cf2f8d63655d52ec7dd2a7ae8e3186d99804c2e559f3f594167831d42cd4ff7cae09cdf92a4bee199bf9a19200efcba20fc147b6b700e095101c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f39c0ed9508a4d1fb4aeaa69ab2c416ac42f93a975547ac9a563effc7b33608fea3054d7c6d856d0474173802b034527ddc1827e39ff4f3fb66f32433f1760bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/297b289e1caad024bd555bdbd9cc5c29cff54903c0aae2457da0cdbe15b7a127951ff4da877cfde710f11aa8a546bf4dadfa3d743439692b1392b8b4e398f49a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 14:23:24.034240) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:23:24.034560) ========= 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=836cfdc75598d54cb747368e000001a9-1465330926.52810-1476687682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 14:23:24.117229) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 14:23:24.117542) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 14:23:24.117820) ========= ========= Total master_lag: 0.17 =========