builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1466902404.56 results: success (0) buildid: 20160625163624 builduid: 2c005786bdfe487096a1a7145087ceb5 revision: 076e176ce22e2602f63781027b0b18c1977cddd0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:24.560521) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:24.560917) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:24.561223) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:24.985400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:24.985677) ========= 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-1466902161.945958-1222444925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-25 17:53:25-- 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% 225M=0s 2016-06-25 17:53:25 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127545 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:25.137473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:25.137747) ========= 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-1466902161.945958-1222444925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014424 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:25.186525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:25.186882) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 076e176ce22e2602f63781027b0b18c1977cddd0 --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 076e176ce22e2602f63781027b0b18c1977cddd0 --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-1466902161.945958-1222444925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-25 17:53:25,927 truncating revision to first 12 chars 2016-06-25 17:53:25,927 Setting DEBUG logging. 2016-06-25 17:53:25,927 attempt 1/10 2016-06-25 17:53:25,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/076e176ce22e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-25 17:53:26,233 unpacking tar archive at: fx-team-076e176ce22e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646613 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:25.846824) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:25.850181) ========= script_repo_revision: 076e176ce22e2602f63781027b0b18c1977cddd0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:25.850614) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:25.850879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 17:53:25.860449) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-25 17:53:25.860723) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:53:26 INFO - MultiFileLogger online at 20160625 17:53:26 in /builds/slave/test 17:53:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:53:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:53:26 INFO - {'append_to_log': False, 17:53:26 INFO - 'base_work_dir': '/builds/slave/test', 17:53:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:53:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:53:26 INFO - 'branch': 'Fx-Team-Non-PGO', 17:53:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:53:26 INFO - 'config_files': ('talos/linux_config.py',), 17:53:26 INFO - 'default_actions': ('clobber', 17:53:26 INFO - 'read-buildbot-config', 17:53:26 INFO - 'download-and-extract', 17:53:26 INFO - 'populate-webroot', 17:53:26 INFO - 'create-virtualenv', 17:53:26 INFO - 'install', 17:53:26 INFO - 'run-tests'), 17:53:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:53:26 INFO - 'download_minidump_stackwalk': True, 17:53:26 INFO - 'download_symbols': 'ondemand', 17:53:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:53:26 INFO - 'tooltool.py': '/tools/tooltool.py', 17:53:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:53:26 INFO - '/tools/misc-python/virtualenv.py')}, 17:53:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:53:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:53:26 INFO - 'installer_path': 'installer.exe', 17:53:26 INFO - 'log_level': 'info', 17:53:26 INFO - 'log_name': 'talos', 17:53:26 INFO - 'log_to_console': True, 17:53:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:53:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:53:26 INFO - 'opt_config_files': (), 17:53:26 INFO - 'pip_index': False, 17:53:26 INFO - 'sps_profile': False, 17:53:26 INFO - 'sps_profile_interval': 0, 17:53:26 INFO - 'suite': 'dromaeojs', 17:53:26 INFO - 'system_bits': '32', 17:53:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:53:26 INFO - 'title': 'talos-linux64-ix-028', 17:53:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:53:26 INFO - 'use_talos_json': True, 17:53:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:53:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:53:26 INFO - 'work_dir': 'build'} 17:53:26 INFO - ##### 17:53:26 INFO - ##### Running clobber step. 17:53:26 INFO - ##### 17:53:26 INFO - Running pre-action listener: _resource_record_pre_action 17:53:26 INFO - Running main action method: clobber 17:53:26 INFO - rmtree: /builds/slave/test/build 17:53:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:53:27 INFO - Running post-action listener: _resource_record_post_action 17:53:27 INFO - ##### 17:53:27 INFO - ##### Finished clobber step (success) 17:53:27 INFO - ##### 17:53:27 INFO - ##### 17:53:27 INFO - ##### Running read-buildbot-config step. 17:53:27 INFO - ##### 17:53:27 INFO - Running pre-action listener: _resource_record_pre_action 17:53:27 INFO - Running main action method: read_buildbot_config 17:53:27 INFO - Using buildbot properties: 17:53:27 INFO - { 17:53:27 INFO - "project": "", 17:53:27 INFO - "product": "firefox", 17:53:27 INFO - "script_repo_revision": "production", 17:53:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:53:27 INFO - "repository": "", 17:53:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:53:27 INFO - "buildid": "20160625163624", 17:53:27 INFO - "pgo_build": "False", 17:53:27 INFO - "basedir": "/builds/slave/test", 17:53:27 INFO - "buildnumber": 3119, 17:53:27 INFO - "slavename": "talos-linux64-ix-028", 17:53:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:53:27 INFO - "platform": "ubuntu64_hw", 17:53:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:53:27 INFO - "branch": "fx-team", 17:53:27 INFO - "repo_path": "integration/fx-team", 17:53:27 INFO - "revision": "076e176ce22e2602f63781027b0b18c1977cddd0", 17:53:27 INFO - "stage_platform": "linux64", 17:53:27 INFO - "builduid": "2c005786bdfe487096a1a7145087ceb5", 17:53:27 INFO - "slavebuilddir": "test" 17:53:27 INFO - } 17:53:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:53:27 INFO - Running post-action listener: _resource_record_post_action 17:53:27 INFO - ##### 17:53:27 INFO - ##### Finished read-buildbot-config step (success) 17:53:27 INFO - ##### 17:53:27 INFO - ##### 17:53:27 INFO - ##### Running download-and-extract step. 17:53:27 INFO - ##### 17:53:27 INFO - Running pre-action listener: _resource_record_pre_action 17:53:27 INFO - Running main action method: download_and_extract 17:53:27 INFO - mkdir: /builds/slave/test/build/tests 17:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:27 INFO - https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:53:28 INFO - Downloaded 1361 bytes. 17:53:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:53:28 INFO - Using the following test package requirements: 17:53:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:53:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:53:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:53:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:28 INFO - u'jsshell-linux-x86_64.zip'], 17:53:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:53:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:53:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:53:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:53:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:53:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:53:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:53:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:28 INFO - https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:53:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:53:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:53:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:53:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:53:29 INFO - Downloaded 22712973 bytes. 17:53:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:53:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:53:30 INFO - Return code: 0 17:53:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:30 INFO - https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:53:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:53:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:53:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:53:32 INFO - Downloaded 22712973 bytes. 17:53:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:53:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:53:34 INFO - Return code: 0 17:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:34 INFO - https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:53:35 INFO - Downloaded 14405240 bytes. 17:53:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:53:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:53:35 INFO - Return code: 0 17:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:35 INFO - https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:53:37 INFO - Downloaded 56266479 bytes. 17:53:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:53:37 INFO - mkdir: /builds/slave/test/properties 17:53:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:53:37 INFO - Writing to file /builds/slave/test/properties/build_url 17:53:37 INFO - Contents: 17:53:37 INFO - build_url:https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:53:38 INFO - Running post-action listener: _resource_record_post_action 17:53:38 INFO - Running post-action listener: set_extra_try_arguments 17:53:38 INFO - ##### 17:53:38 INFO - ##### Finished download-and-extract step (success) 17:53:38 INFO - ##### 17:53:38 INFO - ##### 17:53:38 INFO - ##### Running populate-webroot step. 17:53:38 INFO - ##### 17:53:38 INFO - Running pre-action listener: _resource_record_pre_action 17:53:38 INFO - Running main action method: populate_webroot 17:53:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:53:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:53:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:53:38 INFO - '--tppagecycles', 17:53:38 INFO - '7'], 17:53:38 INFO - 'tests': ['tsvgm']}}, 17:53:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:53:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:53:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:53:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:53:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:53:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:53:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:38 INFO - 'talos_options': ['--disable-e10s'], 17:53:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:53:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:53:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:38 INFO - 'talos_options': ['--disable-e10s'], 17:53:38 INFO - 'tests': ['damp', 'tps']}, 17:53:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:38 INFO - 'tests': ['damp', 'tps']}, 17:53:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:53:38 INFO - 'tests': ['dromaeo_dom']}, 17:53:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:53:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:53:38 INFO - 'tests': ['basic_compositor_video']}, 17:53:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:53:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:53:38 INFO - 'tests': ['a11yr', 17:53:38 INFO - 'ts_paint', 17:53:38 INFO - 'tpaint', 17:53:38 INFO - 'sessionrestore', 17:53:38 INFO - 'sessionrestore_no_auto_restore', 17:53:38 INFO - 'tabpaint']}, 17:53:38 INFO - 'other-e10s': {'tests': ['a11yr', 17:53:38 INFO - 'ts_paint', 17:53:38 INFO - 'tpaint', 17:53:38 INFO - 'sessionrestore', 17:53:38 INFO - 'sessionrestore_no_auto_restore', 17:53:38 INFO - 'tabpaint']}, 17:53:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:53:38 INFO - 'ts_paint', 17:53:38 INFO - 'tpaint', 17:53:38 INFO - 'sessionrestore', 17:53:38 INFO - 'sessionrestore_no_auto_restore', 17:53:38 INFO - 'tabpaint']}, 17:53:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:53:38 INFO - 'ts_paint', 17:53:38 INFO - 'tpaint', 17:53:38 INFO - 'sessionrestore', 17:53:38 INFO - 'sessionrestore_no_auto_restore', 17:53:38 INFO - 'tabpaint']}, 17:53:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:53:38 INFO - 'tests': ['a11yr', 17:53:38 INFO - 'ts_paint', 17:53:38 INFO - 'tpaint', 17:53:38 INFO - 'sessionrestore', 17:53:38 INFO - 'sessionrestore_no_auto_restore', 17:53:38 INFO - 'tabpaint']}, 17:53:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:53:38 INFO - 'tests': ['a11yr', 17:53:38 INFO - 'ts_paint', 17:53:38 INFO - 'tpaint', 17:53:38 INFO - 'sessionrestore', 17:53:38 INFO - 'sessionrestore_no_auto_restore', 17:53:38 INFO - 'tabpaint']}, 17:53:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:53:38 INFO - 'tests': ['tsvgx', 17:53:38 INFO - 'tsvgr_opacity', 17:53:38 INFO - 'tart', 17:53:38 INFO - 'tscrollx', 17:53:38 INFO - 'cart']}, 17:53:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:53:38 INFO - 'tsvgr_opacity', 17:53:38 INFO - 'tart', 17:53:38 INFO - 'tscrollx', 17:53:38 INFO - 'cart']}, 17:53:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:38 INFO - 'talos_options': ['--disable-e10s'], 17:53:38 INFO - 'tests': ['tp5o']}, 17:53:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:38 INFO - 'tests': ['tp5o']}, 17:53:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:38 INFO - 'talos_options': ['--disable-e10s', 17:53:38 INFO - '--xperf_path', 17:53:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:53:38 INFO - 'tests': ['tp5n']}, 17:53:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:53:38 INFO - 'talos_options': ['--xperf_path', 17:53:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:53:38 INFO - 'tests': ['tp5n']}}, 17:53:38 INFO - 'talos.zip': {'path': '', 17:53:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:53:38 INFO - Running post-action listener: _resource_record_post_action 17:53:38 INFO - ##### 17:53:38 INFO - ##### Finished populate-webroot step (success) 17:53:38 INFO - ##### 17:53:38 INFO - ##### 17:53:38 INFO - ##### Running create-virtualenv step. 17:53:38 INFO - ##### 17:53:38 INFO - Running pre-action listener: _resource_record_pre_action 17:53:38 INFO - Running main action method: create_virtualenv 17:53:38 INFO - Creating virtualenv /builds/slave/test/build/venv 17:53:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:53:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:53:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:53:38 INFO - Using real prefix '/usr' 17:53:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:53:38 INFO - Installing distribute.............................................................................................................................................................................................done. 17:53:40 INFO - Installing pip.................done. 17:53:40 INFO - Return code: 0 17:53:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:40 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 0x7f7c6913cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f6f0>, '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 0xd705f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd70aa0>, '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-1466902161.945958-1222444925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:53:40 INFO - Using env: {'DISPLAY': ':0', 17:53:40 INFO - 'HOME': '/home/cltbld', 17:53:40 INFO - 'LANG': 'en_US.UTF-8', 17:53:40 INFO - 'LANGUAGE': 'en_US:en', 17:53:40 INFO - 'LOGNAME': 'cltbld', 17:53:40 INFO - 'MAIL': '/var/mail/cltbld', 17:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:40 INFO - 'MOZ_NO_REMOTE': '1', 17:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:40 INFO - 'NO_EM_RESTART': '1', 17:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:40 INFO - 'PWD': '/builds/slave/test', 17:53:40 INFO - 'SHELL': '/bin/bash', 17:53:40 INFO - 'SHLVL': '1', 17:53:40 INFO - 'TERM': 'linux', 17:53:40 INFO - 'TMOUT': '86400', 17:53:40 INFO - 'USER': 'cltbld', 17:53:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925', 17:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:40 INFO - '_': '/tools/buildbot/bin/python'} 17:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:53:40 INFO - Cleaning up... 17:53:41 INFO - Return code: 0 17:53:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7c6913cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f6f0>, '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 0xd705f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd70aa0>, '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-1466902161.945958-1222444925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:53:41 INFO - Using env: {'DISPLAY': ':0', 17:53:41 INFO - 'HOME': '/home/cltbld', 17:53:41 INFO - 'LANG': 'en_US.UTF-8', 17:53:41 INFO - 'LANGUAGE': 'en_US:en', 17:53:41 INFO - 'LOGNAME': 'cltbld', 17:53:41 INFO - 'MAIL': '/var/mail/cltbld', 17:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:41 INFO - 'MOZ_NO_REMOTE': '1', 17:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:41 INFO - 'NO_EM_RESTART': '1', 17:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:41 INFO - 'PWD': '/builds/slave/test', 17:53:41 INFO - 'SHELL': '/bin/bash', 17:53:41 INFO - 'SHLVL': '1', 17:53:41 INFO - 'TERM': 'linux', 17:53:41 INFO - 'TMOUT': '86400', 17:53:41 INFO - 'USER': 'cltbld', 17:53:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925', 17:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:41 INFO - '_': '/tools/buildbot/bin/python'} 17:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:41 INFO - Downloading/unpacking psutil>=3.1.1 17:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:53:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:53:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:53:43 INFO - Installing collected packages: psutil 17:53:43 INFO - Running setup.py install for psutil 17:53:43 INFO - building 'psutil._psutil_linux' extension 17:53:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:53:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:53:43 INFO - building 'psutil._psutil_posix' extension 17:53:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:53:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:53:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:53:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:53:43 INFO - Successfully installed psutil 17:53:43 INFO - Cleaning up... 17:53:43 INFO - Return code: 0 17:53:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:53: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')]} 17:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53: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')]} 17:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:43 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 0x7f7c6913cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f6f0>, '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 0xd705f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd70aa0>, '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-1466902161.945958-1222444925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:53:43 INFO - Using env: {'DISPLAY': ':0', 17:53:43 INFO - 'HOME': '/home/cltbld', 17:53:43 INFO - 'LANG': 'en_US.UTF-8', 17:53:43 INFO - 'LANGUAGE': 'en_US:en', 17:53:43 INFO - 'LOGNAME': 'cltbld', 17:53:43 INFO - 'MAIL': '/var/mail/cltbld', 17:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:43 INFO - 'MOZ_NO_REMOTE': '1', 17:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:43 INFO - 'NO_EM_RESTART': '1', 17:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:43 INFO - 'PWD': '/builds/slave/test', 17:53:43 INFO - 'SHELL': '/bin/bash', 17:53:43 INFO - 'SHLVL': '1', 17:53:43 INFO - 'TERM': 'linux', 17:53:43 INFO - 'TMOUT': '86400', 17:53:43 INFO - 'USER': 'cltbld', 17:53:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925', 17:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:43 INFO - '_': '/tools/buildbot/bin/python'} 17:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:53:45 INFO - Installing collected packages: mozsystemmonitor 17:53:45 INFO - Running setup.py install for mozsystemmonitor 17:53:46 INFO - Successfully installed mozsystemmonitor 17:53:46 INFO - Cleaning up... 17:53:46 INFO - Return code: 0 17:53:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7c6913cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f6f0>, '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 0xd705f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd70aa0>, '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-1466902161.945958-1222444925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:53:46 INFO - Using env: {'DISPLAY': ':0', 17:53:46 INFO - 'HOME': '/home/cltbld', 17:53:46 INFO - 'LANG': 'en_US.UTF-8', 17:53:46 INFO - 'LANGUAGE': 'en_US:en', 17:53:46 INFO - 'LOGNAME': 'cltbld', 17:53:46 INFO - 'MAIL': '/var/mail/cltbld', 17:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:46 INFO - 'MOZ_NO_REMOTE': '1', 17:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:46 INFO - 'NO_EM_RESTART': '1', 17:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:46 INFO - 'PWD': '/builds/slave/test', 17:53:46 INFO - 'SHELL': '/bin/bash', 17:53:46 INFO - 'SHLVL': '1', 17:53:46 INFO - 'TERM': 'linux', 17:53:46 INFO - 'TMOUT': '86400', 17:53:46 INFO - 'USER': 'cltbld', 17:53:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925', 17:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:46 INFO - '_': '/tools/buildbot/bin/python'} 17:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:46 INFO - Downloading/unpacking jsonschema==2.5.1 17:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:53:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:53:48 INFO - warning: no files found matching '*.txt' 17:53:48 INFO - no previously-included directories found matching 'build' 17:53:48 INFO - no previously-included directories found matching 'dist' 17:53:48 INFO - no previously-included directories found matching '.git*' 17:53:48 INFO - Installing collected packages: jsonschema, functools32 17:53:48 INFO - Running setup.py install for functools32 17:53:48 INFO - warning: no files found matching '*.txt' 17:53:48 INFO - no previously-included directories found matching 'build' 17:53:48 INFO - no previously-included directories found matching 'dist' 17:53:48 INFO - no previously-included directories found matching '.git*' 17:53:48 INFO - Successfully installed jsonschema functools32 17:53:48 INFO - Cleaning up... 17:53:48 INFO - Return code: 0 17:53:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:48 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 0x7f7c6913cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f6f0>, '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 0xd705f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd70aa0>, '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-1466902161.945958-1222444925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:53:48 INFO - Using env: {'DISPLAY': ':0', 17:53:48 INFO - 'HOME': '/home/cltbld', 17:53:48 INFO - 'LANG': 'en_US.UTF-8', 17:53:48 INFO - 'LANGUAGE': 'en_US:en', 17:53:48 INFO - 'LOGNAME': 'cltbld', 17:53:48 INFO - 'MAIL': '/var/mail/cltbld', 17:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:48 INFO - 'MOZ_NO_REMOTE': '1', 17:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:48 INFO - 'NO_EM_RESTART': '1', 17:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:48 INFO - 'PWD': '/builds/slave/test', 17:53:48 INFO - 'SHELL': '/bin/bash', 17:53:48 INFO - 'SHLVL': '1', 17:53:48 INFO - 'TERM': 'linux', 17:53:48 INFO - 'TMOUT': '86400', 17:53:48 INFO - 'USER': 'cltbld', 17:53:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925', 17:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:48 INFO - '_': '/tools/buildbot/bin/python'} 17:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:48 INFO - Downloading/unpacking blobuploader==1.2.4 17:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:50 INFO - Downloading blobuploader-1.2.4.tar.gz 17:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:53:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:53:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:51 INFO - Downloading docopt-0.6.1.tar.gz 17:53:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:53:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:53:51 INFO - Running setup.py install for blobuploader 17:53:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:53:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:53:51 INFO - Running setup.py install for requests 17:53:51 INFO - Running setup.py install for docopt 17:53:52 INFO - Successfully installed blobuploader requests docopt 17:53:52 INFO - Cleaning up... 17:53:52 INFO - Return code: 0 17:53:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:52 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 0x7f7c6913cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f6f0>, '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 0xd705f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd70aa0>, '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-1466902161.945958-1222444925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:53:52 INFO - Using env: {'DISPLAY': ':0', 17:53:52 INFO - 'HOME': '/home/cltbld', 17:53:52 INFO - 'LANG': 'en_US.UTF-8', 17:53:52 INFO - 'LANGUAGE': 'en_US:en', 17:53:52 INFO - 'LOGNAME': 'cltbld', 17:53:52 INFO - 'MAIL': '/var/mail/cltbld', 17:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:52 INFO - 'MOZ_NO_REMOTE': '1', 17:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:52 INFO - 'NO_EM_RESTART': '1', 17:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:52 INFO - 'PWD': '/builds/slave/test', 17:53:52 INFO - 'SHELL': '/bin/bash', 17:53:52 INFO - 'SHLVL': '1', 17:53:52 INFO - 'TERM': 'linux', 17:53:52 INFO - 'TMOUT': '86400', 17:53:52 INFO - 'USER': 'cltbld', 17:53:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925', 17:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:52 INFO - '_': '/tools/buildbot/bin/python'} 17:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:53:52 INFO - Running setup.py (path:/tmp/pip-bDmPRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:53:52 INFO - Running setup.py (path:/tmp/pip-FuwVpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:53:52 INFO - Running setup.py (path:/tmp/pip-lTaGp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:53:52 INFO - Running setup.py (path:/tmp/pip-aDcoCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:53:52 INFO - Running setup.py (path:/tmp/pip-_AtPOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:53:52 INFO - Running setup.py (path:/tmp/pip-VDNaL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:53:52 INFO - Running setup.py (path:/tmp/pip-z24TIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:53:52 INFO - Running setup.py (path:/tmp/pip-gebBAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:53:52 INFO - Running setup.py (path:/tmp/pip-p_bIWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:53:52 INFO - Running setup.py (path:/tmp/pip-YYcGfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:53:53 INFO - Running setup.py (path:/tmp/pip-pVMRnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:53:53 INFO - Running setup.py (path:/tmp/pip-SP74IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:53:53 INFO - Running setup.py (path:/tmp/pip-PzfBTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:53:53 INFO - Running setup.py (path:/tmp/pip-VZp1DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:53:53 INFO - Running setup.py (path:/tmp/pip-KjK8CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:53:53 INFO - Running setup.py (path:/tmp/pip-q0AIEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:53:53 INFO - Running setup.py (path:/tmp/pip-KCwnc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:53:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:53:53 INFO - Running setup.py install for manifestparser 17:53:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:53:53 INFO - Running setup.py install for mozcrash 17:53:53 INFO - Running setup.py install for mozdebug 17:53:53 INFO - Running setup.py install for mozdevice 17:53:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:53:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:53:53 INFO - Running setup.py install for mozfile 17:53:54 INFO - Running setup.py install for mozhttpd 17:53:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:53:54 INFO - Running setup.py install for mozinfo 17:53:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:53:54 INFO - Running setup.py install for mozInstall 17:53:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:53:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:53:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:53:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:53:54 INFO - Running setup.py install for mozleak 17:53:54 INFO - Running setup.py install for mozlog 17:53:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:53:54 INFO - Running setup.py install for moznetwork 17:53:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:53:54 INFO - Running setup.py install for mozprocess 17:53:54 INFO - Running setup.py install for mozprofile 17:53:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:53:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:53:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:53:54 INFO - Running setup.py install for mozrunner 17:53:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:53:55 INFO - Running setup.py install for mozscreenshot 17:53:55 INFO - Running setup.py install for moztest 17:53:55 INFO - Running setup.py install for mozversion 17:53:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:53:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:53:55 INFO - Cleaning up... 17:53:55 INFO - Return code: 0 17:53:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:53: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')]} 17:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53: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')]} 17:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:55 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 0x7f7c6913cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f6f0>, '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 0xd705f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd70aa0>, '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-1466902161.945958-1222444925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:53:55 INFO - Using env: {'DISPLAY': ':0', 17:53:55 INFO - 'HOME': '/home/cltbld', 17:53:55 INFO - 'LANG': 'en_US.UTF-8', 17:53:55 INFO - 'LANGUAGE': 'en_US:en', 17:53:55 INFO - 'LOGNAME': 'cltbld', 17:53:55 INFO - 'MAIL': '/var/mail/cltbld', 17:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:55 INFO - 'MOZ_NO_REMOTE': '1', 17:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:55 INFO - 'NO_EM_RESTART': '1', 17:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:55 INFO - 'PWD': '/builds/slave/test', 17:53:55 INFO - 'SHELL': '/bin/bash', 17:53:55 INFO - 'SHLVL': '1', 17:53:55 INFO - 'TERM': 'linux', 17:53:55 INFO - 'TMOUT': '86400', 17:53:55 INFO - 'USER': 'cltbld', 17:53:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925', 17:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:55 INFO - '_': '/tools/buildbot/bin/python'} 17:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:53:55 INFO - Running setup.py (path:/tmp/pip-huaN9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:53:55 INFO - Running setup.py (path:/tmp/pip-2A09Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:53:55 INFO - Running setup.py (path:/tmp/pip-7dUegd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:53:55 INFO - Running setup.py (path:/tmp/pip-yb1ahF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:53:55 INFO - Running setup.py (path:/tmp/pip-SuuNcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:53:55 INFO - Running setup.py (path:/tmp/pip-p9Byow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:53:56 INFO - Running setup.py (path:/tmp/pip-YnPagl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:53:56 INFO - Running setup.py (path:/tmp/pip-i1F4nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:53:56 INFO - Running setup.py (path:/tmp/pip-ITpJeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:53:56 INFO - Running setup.py (path:/tmp/pip-POqJrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:53:56 INFO - Running setup.py (path:/tmp/pip-Xi6kDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:53:56 INFO - Running setup.py (path:/tmp/pip-Dkfo91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:53:56 INFO - Running setup.py (path:/tmp/pip-5gGs6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:53:56 INFO - Running setup.py (path:/tmp/pip-Gza0WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:53:56 INFO - Running setup.py (path:/tmp/pip-mw21gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:53:56 INFO - Running setup.py (path:/tmp/pip-RXE5zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:53:56 INFO - Running setup.py (path:/tmp/pip-lMA4Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:53:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:58 INFO - Downloading blessings-1.6.tar.gz 17:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:53:58 INFO - Installing collected packages: blessings 17:53:58 INFO - Running setup.py install for blessings 17:53:58 INFO - Successfully installed blessings 17:53:58 INFO - Cleaning up... 17:53:58 INFO - Return code: 0 17:53:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:53:59 INFO - Reading from file tmpfile_stdout 17:53:59 INFO - Current package versions: 17:53:59 INFO - argparse == 1.2.1 17:53:59 INFO - blessings == 1.6 17:53:59 INFO - blobuploader == 1.2.4 17:53:59 INFO - docopt == 0.6.1 17:53:59 INFO - functools32 == 3.2.3-2 17:53:59 INFO - jsonschema == 2.5.1 17:53:59 INFO - manifestparser == 1.1 17:53:59 INFO - mozInstall == 1.12 17:53:59 INFO - mozcrash == 0.17 17:53:59 INFO - mozdebug == 0.1 17:53:59 INFO - mozdevice == 0.48 17:53:59 INFO - mozfile == 1.2 17:53:59 INFO - mozhttpd == 0.7 17:53:59 INFO - mozinfo == 0.9 17:53:59 INFO - mozleak == 0.1 17:53:59 INFO - mozlog == 3.2 17:53:59 INFO - moznetwork == 0.27 17:53:59 INFO - mozprocess == 0.22 17:53:59 INFO - mozprofile == 0.28 17:53:59 INFO - mozrunner == 6.11 17:53:59 INFO - mozscreenshot == 0.1 17:53:59 INFO - mozsystemmonitor == 0.3 17:53:59 INFO - moztest == 0.7 17:53:59 INFO - mozversion == 1.4 17:53:59 INFO - psutil == 3.1.1 17:53:59 INFO - requests == 1.2.3 17:53:59 INFO - wsgiref == 0.1.2 17:53:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:59 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 0x7f7c6913cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f6f0>, '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 0xd705f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd70aa0>, '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-1466902161.945958-1222444925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:53:59 INFO - Using env: {'DISPLAY': ':0', 17:53:59 INFO - 'HOME': '/home/cltbld', 17:53:59 INFO - 'LANG': 'en_US.UTF-8', 17:53:59 INFO - 'LANGUAGE': 'en_US:en', 17:53:59 INFO - 'LOGNAME': 'cltbld', 17:53:59 INFO - 'MAIL': '/var/mail/cltbld', 17:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:59 INFO - 'MOZ_NO_REMOTE': '1', 17:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:59 INFO - 'NO_EM_RESTART': '1', 17:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:59 INFO - 'PWD': '/builds/slave/test', 17:53:59 INFO - 'SHELL': '/bin/bash', 17:53:59 INFO - 'SHLVL': '1', 17:53:59 INFO - 'TERM': 'linux', 17:53:59 INFO - 'TMOUT': '86400', 17:53:59 INFO - 'USER': 'cltbld', 17:53:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925', 17:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:59 INFO - '_': '/tools/buildbot/bin/python'} 17:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:53:59 INFO - Cleaning up... 17:53:59 INFO - Return code: 0 17:53:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7c6913cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f6f0>, '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 0xd705f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd70aa0>, '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-1466902161.945958-1222444925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:53:59 INFO - Using env: {'DISPLAY': ':0', 17:53:59 INFO - 'HOME': '/home/cltbld', 17:53:59 INFO - 'LANG': 'en_US.UTF-8', 17:53:59 INFO - 'LANGUAGE': 'en_US:en', 17:53:59 INFO - 'LOGNAME': 'cltbld', 17:53:59 INFO - 'MAIL': '/var/mail/cltbld', 17:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:59 INFO - 'MOZ_NO_REMOTE': '1', 17:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:59 INFO - 'NO_EM_RESTART': '1', 17:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:59 INFO - 'PWD': '/builds/slave/test', 17:53:59 INFO - 'SHELL': '/bin/bash', 17:53:59 INFO - 'SHLVL': '1', 17:53:59 INFO - 'TERM': 'linux', 17:53:59 INFO - 'TMOUT': '86400', 17:53:59 INFO - 'USER': 'cltbld', 17:53:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925', 17:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:59 INFO - '_': '/tools/buildbot/bin/python'} 17:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:53:59 INFO - Cleaning up... 17:53:59 INFO - Return code: 0 17:53:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:53:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7c6913cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6f6f0>, '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 0xd705f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd70aa0>, '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-1466902161.945958-1222444925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:53:59 INFO - Using env: {'DISPLAY': ':0', 17:53:59 INFO - 'HOME': '/home/cltbld', 17:53:59 INFO - 'LANG': 'en_US.UTF-8', 17:53:59 INFO - 'LANGUAGE': 'en_US:en', 17:53:59 INFO - 'LOGNAME': 'cltbld', 17:53:59 INFO - 'MAIL': '/var/mail/cltbld', 17:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:59 INFO - 'MOZ_NO_REMOTE': '1', 17:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:59 INFO - 'NO_EM_RESTART': '1', 17:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:59 INFO - 'PWD': '/builds/slave/test', 17:53:59 INFO - 'SHELL': '/bin/bash', 17:53:59 INFO - 'SHLVL': '1', 17:53:59 INFO - 'TERM': 'linux', 17:53:59 INFO - 'TMOUT': '86400', 17:53:59 INFO - 'USER': 'cltbld', 17:53:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925', 17:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:59 INFO - '_': '/tools/buildbot/bin/python'} 17:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:53:59 INFO - Downloading/unpacking flake8 17:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:54:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:54:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:54:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:54:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:54:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:54:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:54:02 INFO - no previously-included directories found matching 'docs/_build' 17:54:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:54:02 INFO - Running setup.py install for pep8 17:54:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:54:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:54:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:54:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:54:02 INFO - no previously-included directories found matching 'docs/_build' 17:54:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:54:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:54:02 INFO - Cleaning up... 17:54:02 INFO - Return code: 0 17:54:02 INFO - Running post-action listener: _resource_record_post_action 17:54:02 INFO - Running post-action listener: _start_resource_monitoring 17:54:02 INFO - Starting resource monitoring. 17:54:02 INFO - ##### 17:54:02 INFO - ##### Finished create-virtualenv step (success) 17:54:02 INFO - ##### 17:54:02 INFO - ##### 17:54:02 INFO - ##### Running install step. 17:54:02 INFO - ##### 17:54:02 INFO - Running pre-action listener: _resource_record_pre_action 17:54:02 INFO - Running main action method: install 17:54:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:54:02 INFO - Reading from file tmpfile_stdout 17:54:02 INFO - Detecting whether we're running mozinstall >=1.0... 17:54:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:54:02 INFO - Reading from file tmpfile_stdout 17:54:02 INFO - Output received: 17:54:02 INFO - Usage: mozinstall [options] installer 17:54:02 INFO - Options: 17:54:02 INFO - -h, --help show this help message and exit 17:54:02 INFO - -d DEST, --destination=DEST 17:54:02 INFO - Directory to install application into. [default: 17:54:02 INFO - "/builds/slave/test"] 17:54:02 INFO - --app=APP Application being installed. [default: firefox] 17:54:02 INFO - mkdir: /builds/slave/test/build/application 17:54:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:54:19 INFO - Reading from file tmpfile_stdout 17:54:19 INFO - Output received: 17:54:19 INFO - /builds/slave/test/build/application/firefox/firefox 17:54:19 INFO - Running post-action listener: _resource_record_post_action 17:54:19 INFO - ##### 17:54:19 INFO - ##### Finished install step (success) 17:54:19 INFO - ##### 17:54:19 INFO - ##### 17:54:19 INFO - ##### Running run-tests step. 17:54:19 INFO - ##### 17:54:19 INFO - Running pre-action listener: _resource_record_pre_action 17:54:19 INFO - Running main action method: run_tests 17:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:54:19 INFO - Python 2.7.3 17:54:19 INFO - Return code: 0 17:54:19 INFO - grabbing minidump binary from tooltool 17:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:19 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 0xd6f6f0>, '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 0xd705f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd70aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:54:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:54:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:54:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:54:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:54:19 INFO - Return code: 0 17:54:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:54:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:54:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:54:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:54:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:54:20 INFO - Return code: 0 17:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:54:20 INFO - Using env: {'DISPLAY': ':0', 17:54:20 INFO - 'HOME': '/home/cltbld', 17:54:20 INFO - 'LANG': 'en_US.UTF-8', 17:54:20 INFO - 'LANGUAGE': 'en_US:en', 17:54:20 INFO - 'LOGNAME': 'cltbld', 17:54:20 INFO - 'MAIL': '/var/mail/cltbld', 17:54:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:54:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:20 INFO - 'MOZ_NO_REMOTE': '1', 17:54:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:20 INFO - 'NO_EM_RESTART': '1', 17:54:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:20 INFO - 'PWD': '/builds/slave/test', 17:54:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:54:20 INFO - 'SHELL': '/bin/bash', 17:54:20 INFO - 'SHLVL': '1', 17:54:20 INFO - 'TERM': 'linux', 17:54:20 INFO - 'TMOUT': '86400', 17:54:20 INFO - 'USER': 'cltbld', 17:54:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466902161.945958-1222444925', 17:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:20 INFO - '_': '/tools/buildbot/bin/python'} 17:54:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:54:20 INFO - mozversion application_buildid: 20160625163624 17:54:20 INFO - mozversion application_changeset: 076e176ce22e2602f63781027b0b18c1977cddd0 17:54:20 INFO - mozversion application_display_name: Nightly 17:54:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:54:20 INFO - mozversion application_name: Firefox 17:54:20 INFO - mozversion application_remotingname: firefox 17:54:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:54:20 INFO - mozversion application_vendor: Mozilla 17:54:20 INFO - mozversion application_version: 50.0a1 17:54:20 INFO - mozversion platform_buildid: 20160625163624 17:54:20 INFO - mozversion platform_changeset: 076e176ce22e2602f63781027b0b18c1977cddd0 17:54:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:54:20 INFO - mozversion platform_version: 50.0a1 17:54:20 INFO - using testdate: 1466902460 17:54:20 INFO - actual date: 1466902460 17:54:20 INFO - starting webserver on 'localhost:33111' 17:54:20 INFO - SUITE-START | Running 2 tests 17:54:20 INFO - TEST-START | dromaeo_css 17:54:20 INFO - operating with platform_type : linux_ 17:54:20 INFO - Initialising browser for dromaeo_css test... 17:54:20 INFO - TEST-INFO | started process 11999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFChdz/profile http://localhost:33111/getInfo.html) 17:54:24 INFO - PROCESS | 11999 | __metrics Screen width/height:1600/1200 17:54:24 INFO - PROCESS | 11999 | colorDepth:24 17:54:24 INFO - PROCESS | 11999 | Browser inner width/height: 1024/697 17:54:24 INFO - PROCESS | 11999 | __metrics 17:54:25 INFO - PROCESS | 11999 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:54:26 INFO - TEST-INFO | 11999: exit 0 17:54:26 INFO - Browser initialized. 17:54:26 INFO - Running cycle 1/1 for dromaeo_css test... 17:54:26 INFO - TEST-INFO | started process 12080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFChdz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:38 INFO - PROCESS | 12080 | RSS: Main: 175243264 17:54:38 INFO - PROCESS | 12080 | 17:55:29 INFO - PROCESS | 12080 | 1466902529940 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:57:42 INFO - PROCESS | 12080 | Cycle 1(1): loaded http://localhost:33111/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33111/tests/dromaeo/cssquery-ext.html) 17:57:43 INFO - PROCESS | 12080 | RSS: Main: 257249280 17:57:43 INFO - PROCESS | 12080 | 18:00:46 INFO - PROCESS | 12080 | Cycle 1(1): loaded http://localhost:33111/tests/dromaeo/cssquery-ext.html (next: http://localhost:33111/tests/dromaeo/cssquery-jquery.html) 18:00:47 INFO - PROCESS | 12080 | RSS: Main: 271601664 18:00:47 INFO - PROCESS | 12080 | 18:03:49 INFO - PROCESS | 12080 | Cycle 1(1): loaded http://localhost:33111/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33111/tests/dromaeo/cssquery-mootools.html) 18:03:50 INFO - PROCESS | 12080 | RSS: Main: 255963136 18:03:50 INFO - PROCESS | 12080 | 18:06:52 INFO - PROCESS | 12080 | Cycle 1(1): loaded http://localhost:33111/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33111/tests/dromaeo/cssquery-prototype.html) 18:06:52 INFO - PROCESS | 12080 | RSS: Main: 260571136 18:06:52 INFO - PROCESS | 12080 | 18:09:55 INFO - PROCESS | 12080 | Cycle 1(1): loaded http://localhost:33111/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33111/tests/dromaeo/cssquery-yui.html) 18:09:56 INFO - PROCESS | 12080 | RSS: Main: 244736000 18:09:56 INFO - PROCESS | 12080 | 18:12:59 INFO - PROCESS | 12080 | Cycle 1(1): loaded http://localhost:33111/tests/dromaeo/cssquery-yui.html (next: http://localhost:33111/tests/dromaeo/cssquery-dojo.html) 18:12:59 INFO - PROCESS | 12080 | RSS: Main: 294129664 18:12:59 INFO - PROCESS | 12080 | 18:12:59 INFO - PROCESS | 12080 | __start_tp_report 18:12:59 INFO - PROCESS | 12080 | _x_x_mozilla_page_load 18:12:59 INFO - PROCESS | 12080 | _x_x_mozilla_page_load_details 18:12:59 INFO - PROCESS | 12080 | |i|pagename|runs| 18:12:59 INFO - PROCESS | 12080 | |0;dojo.html;2595.078747044799;2616.5159445502595;2639.828411153274;2643.7752791012763;2646.8411895286285;4676.649251306158;4716.952830471694;4758.547937945894;4763.2378819388905;4815;4697.88255293617;4701.882452938678;4744.383230180072;4766.022965292107;4766.3088852116425;4170;4302.31163013917;4377.233984052794;4406.118776244748;4548.681592288541;4457.88855278619;4479.372887795711;4492.191405547001;4497.302918047708;4537.614302784267;4302.548232435612;4326.545712700153;4347.913041739179;4392.0776636906285;4397.2304846651705;4392.516823149451;4408.559144085566;4456.888577785581;4458.576435238647;4465.24090904547;4436.0240747035605;4436.0462500562535;4497.280435130396;4499.302608095751;4502.8874278142985;4574.313852922055;4743.905121897577;4769.642276829217;4812.614990800727;4861.416630004422;5131.61512886535;5160.845174644766;5186;5190.8183213587345;5204.193350030713;4969.304297398367;5175.870603234912;5229.058769421503;5240.711760853152;5241.50205730455;4727.503612120747;4791.089692958327;4796.2805579163405;4800.591949684316;4838.588719958772;5294.894102117936;5321.840344789663;5324.946750532445;5329.333833270841;5333.253344531769;4881.658283920163;4956.058348913695;5041.773120209599;5069.670471419346;5079.060373830853;5066.113430149709;5079.1365467870555;5099;5099.617528685363;5157.63896527247;5041.495850415003;5050.898982020339;5054.342935418372;5058.241263810458;5104.642675012714;4911.042346742351;4990.575801056878;5027.899442011139;5060.797568097235;5071.340725705634;4341.891452713708;4357.803898824561;4394.209042372339;4398.098389830077;4403.295472724349;3775.3959366501776;3792.2984247914223;3803.2773772983046;3830.3296923038356;3851.094992676719;4284.914301713949;4317.892052698645;4324.8486302979245;4373.540778218241;4377.759223242752;5041.168207245837;5051.887216468115;5074.695518268915;5079.568236699922;5134.897302053938;4328.069465065026;4338.132373525307;4338.869833904925;4387.276099443556;4403.185410699031;4508.954910450853;4560.338750881104;4577.473590537131;4580.977095114503;4581.221192397301;4802.351682522814;4819.518048195152;4830.082284365959;4843.854684359475;4867.294242334912;5098;5102.336696229615;5103.132467480463;5105.923411148761;5138.820141295037;4609.769511524343;4770.737609431515;4821.783019764189;4827.300041493893;4865.489123641966;5063.594912407072;5078.136716758234;5078.492150784892;5083.92374114396;5129.769160387867;5139.92290115656;5145.408278048072;5147.40804807452;5156.458571850052;5159.226116082467;4867.659263851497;4894.632902532396;4935.1856943605335;4945.961348116935;4968.875778105432;4926.778294976663;4951.529604687549;4955.479674634112;4960;5009.023240468219;4800.7599620019555;4882.340883980617;4902.117618828645;4932.21084626458;4933.087378834927;4911.361523001987;4970.304157418037;4978.1288274552535;4989.426215985208;5007.84976450707;4891.046245981999;4898.2652602109965;4901.779419926041;4902.093112774148;4942.308076869169 18:12:59 INFO - PROCESS | 12080 | |1;ext.html;561.9407417018919;567.1974156568456;569.8917205730913;594.1978329255505;595.9672218028006;40288.59711402889;41951.79024104879;42025.3696194557;45296.77351613245;45297;41781.16437671245;42452.363214551806;42532.57467425325;42551.57448425522;42554.36168457468;7576.772696819105;7824.647890844925;7977.641006154708;7992.280694737473;10069.54687039085;9936.105750482455;10328.58685652573;10330.690079297634;10337.483125843715;10339.74150646236;10419.374837509737;10457.424841633707;10470.267081304311;10473.319234249788;10476.26666133371;7639.885401718979;10150.746231344201;10310.639127630535;10387.480625968672;10406.531706073169;10251;10267.127294180003;10267.281290309682;10304.278700490968;10335.018173273527;38883.416748748794;39023.21953560913;39248.607513924784;39260.21479570421;39310.60689393127;2966.466036113499;3049.1157564306322;3177.396294703999;3202.327511222646;3379.8648054077808;29582.70417295821;30172.396552068836;30531.847340763154;30758.53862192069;30859.691403085908;2956.7486763625116;2966.792324537283;2974.687657795922;2979.4488019716423;3008.819470831735;250772.99999999817;250936.99999999817;251544;252341;252859;31996.840015800237;32331.353372932408;32367.35265294681;53994;54725.179122313195;33956.490652640234;34276.48585271223;34290.657093428745;34427.31145377079;34430.655693443245;13275.601731948056;13442.731145377038;13472.05695601318;13473.528426505221;13479.393427295796;9821.116099551075;10716.892831071746;10997.560097596166;11002.614908478165;11226;7943.563104029334;7961.36309095271;7982.401319900914;8058.435909486397;8065.072516660542;3059.7552195824283;3151.16494129056;3155.921101972469;3183.644103363494;3186.617605887262;766.5783818899583;797.8125140591957;841.2134654098437;860.8708693695995;889.5329951775241;27029;28575.57136642952;28650;30132;32151.356972860878;950.9381890177116;964.7588102974256;966.1787480641539;1012.1750773119884;1037.7820657661975;14627.853721462861;15013.624659383384;15021.173835438936;15122.621934451507;15186.620334491727;428834;430344;430374;430544;432406;50496.74751626292;50898.74550627223;50931.99999999926;50977.490225098016;51022;1094.441834664327;1106.3693694594165;1168.526746667601;1181.6336935550007;1218.597862705305;27037.459250815267;29033.7096629031;29217.7078229215;29271.85364073166;29515.409691805613;43110.56889431191;43928.56071439245;44031.33952990772;44037.779811102024;44119.55880441154;317234;327323;327944;328626;328655;22397.664035039812;22524.436889077904;22526.549469010857;24146.87926560356;24245.515089697754;36247.275054498234;39568;39779.20441591094;40578.391324129574;40639.59360406358;33886.491702623985;34346;34583.4812477808;34706.835179777576;35487.645123548435;34167.145821354665;34651.48022779711;34746.30507389889;34930.65069349274;35032;33507;33995.49006764851;34309.142271443416;34348.656513434544;34354.48468272928;30107.096787095546;30778.692213077582;31033.844830775703;31110.68889311078;31343.37313253768;24263.75736242615;24327.51344973055;24494.755052449247;24554.877225613756;24959.500809984063 18:12:59 INFO - PROCESS | 12080 | |2;jquery.html;368.57981900633274;371.3927728164452;373.132467014192;385.5566098986164;388.9066624010238;16106.75839862403;16894.155292235384;17215.655686886254;17218.311267549314;17262.395816146436;16759.16204189792;16846.915765421156;16859.40992065278;17294.2217600208;17648.029358385284;4981.452040275576;5181.740912954356;5220.895582088375;5221;5225.399079105913;3716.9256614867686;3931.2923673738715;5095.210242412432;5680.431956804307;6041.697915104249;6114.3579924108;6124.540659450537;6130.908036379458;6141.877162456771;6154.692265386735;5827.854303642401;6016.939830601704;6024.457798798129;6033.456988871023;6037.366076561963;3342.983285083559;4958.132326842788;5302.496262855023;5306.8407947761625;5317.973410132925;20208.29270975509;21047.89476052625;21055;21103.15587376503;21181.894090529604;1891.9121505134603;1974.7827738948704;2113.661814109735;2324.476992676651;2425.7452967438517;12738.554150604685;13182;13253.801192982017;13258.66853328665;14008.439662413492;1709.9572510687208;1780.3679693708677;1799.8380145786812;1832.8258815412648;1867.8879267244008;68273;69376;70000.6499967497;70646;71145;9397.812043759086;9644.18024467928;10020.398776073458;10297.330673506198;10521;13708.794368084287;13839.100458470168;13897.374618142208;13915.930420347833;13929.164250145024;7076.186238582526;7109.964450177716;7113.608751518613;7155.212926578072;7204.3155900189395;6555.6066636002;6574;6614.867702646016;6718.731250750013;6758.695858686371;6332.968335158294;6334.651594162366;6344.700755607058;6364.395382438661;6385.808425747235;1637.3368785641835;1637.7707121003068;1699.8895071820293;1734.8698847586481;1738.547977525827;782.710397153057;839.3369238301796;848.8854004709409;851.7827953871723;905.366243629462;16840.915795421188;17470.126493675518;17687.38094166698;17740.82259177392;18084.728729069073;862.5342315149875;874.5408660453313;885.4288983605538;889.5907882374051;926.1664501948301;9842.901570984199;10279.537420816081;10279.794404111875;10286.125679317342;10306.33008854422;314406;320280;320769;417216;421430;79060.60469697615;84288.15711842803;85461;85521.15830733527;86746.56626716827;929.5816882402946;935.2284365398573;955.2930831184873;965.9130678238993;968.5205823117602;16116;16623.66752664916;16736.497905062868;16772.916135419244;17005;37366.813165934;38551.2289754209;38785.2242955145;39501.40747888727;39632.207355852144;50454.49545504498;50613.493865060875;51961;58510.7074464625;59479.702601486715;7504.249575042452;7840.411969102226;7884.881726774218;7891.684332626631;7969.645160322875;11339.659810205707;11403.429828508708;11561.132915031238;11571.6528504145;11900.523979040741;9818.410895346302;10274.023967723055;10497.580096796042;10506.684799456028;10561.788764224826;4763.285507173951;7043.823904402431;9247.76880577991;10145;10325.101297507263;9281.86077208856;9908.900910990798;10177.898221017695;10603.840942386025;10640.946795265974;6616.933830661825;6806.65966701653;7892.723754668559;8081.757547273592;8088.393370497354;9475.384100033476;10000;10018.298719089593;10161.187105031431;10536.209784266057 18:12:59 INFO - PROCESS | 12080 | |3;mootools.html;1245.6449911775146;1355.376526797673;1414.497853262092;1469.2891614970383;1676.2373120230288;6717.865642687149;7564.621768911553;7783.922160778405;7805.609719514023;8035.035795704509;7744.109427415849;7874.842503149934;7877.606119694006;7887.526748395086;7893.210678932104;1886.4623582279053;2160.157538559963;2205.503761653627;2234.3967128875192;2235.3629215673536;2257.762934891837;2275.5335156293004;2283.383486458655;2283.8743869087193;2285.2116019973164;2219.755826859044;2223.67756675282;2254.323702889135;2260.4122928038664;2262.468319944812;1828.2686925229882;1881.9529511762178;1889.5748456597155;2120.385088324384;2176.3144609447972;2173.793489618484;2204.548067646129;2218.7670294618993;2219.87790671513;2220.0231897965004;7778.844423111563;7814.296713295774;7832.608369581498;7835.138134805167;7838.490498117604;4494.910101797946;4657.906841863178;4659.068186362741;4662.557057079572;4664.696794708333;2852.2441552988475;2902.840343781091;2934.4424559333656;2976.3749612581382;3016.306249562591;832.1678321678322;841.1084250694283;859.188067276424;861.6553378648528;867.7873920889359;10587.523561439753;10635.787284254271;10643.201759868041;10803.081738052275;10816;4102.261592913304;4198.055437526593;4215.536291007987;4293.463317085364;4322;9075.591598377956;9084.318676099187;9119.088091190828;9128.497932613636;9157.49633770149;4748.358971538867;4767.73777442244;4768.57082862544;4773.570378665867;4783.976080119577;3650.3064417760543;4173.373993900878;4305.031367942188;4309.612134907873;4374.737515749065;3608.693261072786;3631.418972964366;3690.1697118148204;3698.2418604186614;3726.9068273293383;1161.5480649188514;1182.3024415594668;1183.9052875769917;1189.1200511621512;1200.652723924725;822.0587427395599;827.2576409203472;831.7712629027066;840.0591337701813;846.7332790171199;5129.179331306973;5178.309721543728;5244.4413583767455;5244.606654500928;5255.080360936897;401.14956292659167;419.9160167966419;419.92231437184216;424.18979748679874;425.26641543338116;3519.1905861651962;3674.467202255658;3686.7419280650097;3705.481232627434;3767.3407153747985;9154.450732956044;9498.335116541914;9607.039296070338;9687.225021998223;9763.609455621696;9577.329586928849;9606.711798646053;9670.129688327943;9683.854742178873;9721.70834874955;7123.89314160288;7386.187519372865;7420.257974202645;7435.591042492607;7445.478816482902;5017.222330538772;5173.896522069613;5214.113600687968;5326.387465441524;5371.946280537301;8820;8914.777130571787;8926.330525210766;8933.419327743675;8933.731988040368;8463.49219046859;8779.561021949004;8789.648414063622;9053.321000925089;9062.139096785795;5889.469947704727;6180.320164781961;6324.873502530016;6607.141071660653;6738.225104113089;7405.333519983227;7449.292317229854;7458.47790654649;7470.252974702486;7509.962450187714;6396.936030639634;6644.10304608891;6681.933180668131;6769.086173366532;6780.694868731018;6629.171353580802;6687.565308254948;6746.460283177236;6835.453163746988;6887.690053947485;6228.22147231596;6256.374362563707;6340.334264902303;6351.555391122577;6352.936470635234;4590.288505281686;4595.333676616805;4659.277811939155;4746.43042834862;4763.618910487222;4422.314541246112;4559.0881823634745;4568.017876156642;4570.840020599263;4669.229577119737 18:12:59 INFO - PROCESS | 12080 | |4;prototype.html;291.9897803576874;308.7236922953956;309.5511508312947;312.50312003913774;314.8504460381319;4856.44150922644;4925.285833554132;4935.77788999495;4967.751612419378;5000.7249601271915;4652.581267685908;4772.949951010781;4818.469968303484;4819.554018876503;4943.728094954776;3771.6039815819354;3828.310904037279;3840.135969406875;3846.557645870733;3878.709096817736;3872.9419058714143;3901.6683581895572;3913.491246137998;3936.5276166859876;3938.487996560443;3657.158853463705;3826.4069069294305;3873.496445462086;3917.6082391760883;3926.7447615905016;3808.476609356252;3815.866444674451;3817.2938006468617;3830.80845957701;3841.3277676406656;3349.3874777673454;3352.9329413411597;3353.9161520961925;3362.562866827321;3381.4758712399616;4779.569838714532;4792.904141917142;4793.856184314476;4802.735849528274;4831.202851529493;4174.810179098972;4365.323374876899;4386.978065109686;4393.231184542692;4410.955890441119;5117.801374141161;5123.2827404163445;5124.923126153073;5142.717150556718;5149.716765577892;3686.8755029715926;3696.482492451059;3702.8148592570265;3718.3492888744363;3722.3858063419502;5111.795528178868;5406.351237851443;5434.429384914606;5441.619086663935;5464.6994415307145;3740.214554943492;3781.0925377909102;3790.753601015925;3793.577408471823;3794.924101517954;3815.751976121543;3840.846366145323;3841.9231615368094;3847.5190601174854;3852.7110466715108;4332.350147477903;4358.171947329997;4375.7374557526655;4381.539938306496;4392.780360981938;5096.337476128154;5205.932783779316;5213.165893457104;5214.765335559833;5215.55667768244;1254.4480428611382;1303.3678665847056;1327;1329.3021163888843;1333.3133436280323;885.9246964008003;904;914.6295750221171;919.3932004876749;921.3550514639779;4515.345274935116;4532.798808315799;4541.091781643619;4548.499665036843;4564.3153526970555;5252.343457067866;5269.525742683177;5271.78912843482;5334.279872217278;5335.573154147659;4324.935125973113;4490.3040028795585;4515.277555591089;4525.705829121162;4550.134444877651;2800.5939138824756;2806.6632004159223;2814.8733307000825;2823.74586287231;2823.842224687868;4908.263760435963;4949.455559888409;4957;4959.677620954626;4977.1538838397555;5237.224271136304;5291.920621190685;5417.891642167135;5432.239486471897;5460.426655201147;4965.950340496621;4977.402711674622;4984.750762461862;5007.4491805901325;5017.569992552105;5150.510701483353;5243.947560524499;5262.473752624707;5311.760970756248;5320.255164276927;5136.563392111712;5190.728271573489;5198.584113271005;5202.791888324425;5209.519812960926;4914.975425122994;4921.950780492292;4923.187674033744;4932.186189278872;4991.975040124777;3767.3030489359558;3795.7342985991822;3796.715246356479;3798.867039653599;3802.2775672622115;5036.866704991347;5195.1037871177505;5261.736913154404;5267.920981185362;5306.389765177054;5071.974640126776;5089.236614507853;5104.642675012714;5115.667481613683;5131.820386286611;4952.182889823139;5113.79544818218;5118.00198961199;5121.795128194831;5133.537981581676;4798.2802579613335;4955.65310428281;5057.760848592118;5057.949420505748;5112.565431938327;5164.715940623302;5180.222966555047;5196.350456192976;5223.817166399158;5230.8169214077325;5050.217216331474;5064.5948324134715;5066.265391518135;5085.821996230115;5113.028524580318 18:12:59 INFO - PROCESS | 12080 | |5;yui.html;658.0852614865337;665.7902760630398;682.743971010871;695.2353008459194;751.8421131562371;11684.415779211047;12288.324142172178;12338.691532711686;12371.938140309308;12518.374081295933;12375.44310506027;12548.811767823467;12551.560695375663;12558.05814563909;12569.371531423438;618.2704408797617;768.085977686554;779.4115442840647;787.9566623835686;789.8420315936806;776.0764690018859;780.1028816860598;781.2890269854433;787.6376866641352;789.5144486141039;829.2081062585247;831.4803247970019;834.2783492279195;835.0730688935307;835.3150416658343;653.6600967496922;672.7241830849329;679.1815861886415;684.6337209592843;833.8749187621845;596.3559355895623;607.8480379905023;608.4493533352279;614.2475467552257;618.6473709985311;12196.207246528948;12200.023998080222;12204.145709800317;12263.141580089397;12275.754484910341;12616.306103164323;13078.607641770763;13183.472661093545;13193.795738941537;13325;11030.50928413642;11624.941875290653;11699.298042117414;11867.109966752529;12142.696432589168;4090.8363665453644;4150.190712811003;4254.936175957363;4305.418768466279;4312.460942382202;58256;58479;58508;58554.70722646402;59333;10045.397276163307;10123.7469063274;10168.28821982469;10169.54237059334;10384.169266458664;16998.57503562421;17025.48923532296;17099.74350384745;17116.315347385964;17263.13684315779;6571.967140164268;6643.734250629921;6667.066610674509;6758.560693554903;6894.827629309207;3393.5588373511287;3438.4670376091744;3475.6176820549717;3492.476128580733;3622.3660859350034;3012.5631783391286;3125.890593829205;3154.41643295991;3154.6056742907135;3157.7315928146363;519.4831143012651;536.9919451208235;539.7463192299613;542.6798189068389;542.7530473634487;552.8065177187952;573.5211098732522;591.7189335065809;592.8340064781868;595.1489370200568;7816.8827467588035;7818.960905195438;7820.726274580363;7876.396254371475;8108.351331893435;529.9125644268653;557.7267139101892;558.3578884283107;563.492856429217;567.7416775367197;3564.7326450516316;3779.4330850372116;3844.4630939535696;3903.219356128729;3960.88117356474;87841.56079219563;95970;100269;103495;103642.48178759059;50151.498485015414;50211.24683129756;50992;62344;84008;75171.62414187894;77927;78037.21962780414;78486.6075669618;78880.60559697279;7461.938257325494;7463.776086717407;7499.362554182955;7668.003159589218;7750.806229844074;45337.31994020158;46069;46360.768196160156;46413.535864642276;47303.52696473129;59160.70419647874;65576.34423655702;67128.3287167122;67245.66377168083;67400.32599673941;9358.578863951274;9367.110124538158;9401.764955876159;9584.9041509584;9933.65232216869;10051.597936082475;10335.793284134426;10417.218708597036;10578.206634502289;10633.308834925705;10323.845142323022;10333.483325833527;10779.245452818228;11659.650210493699;12232.75534489323;11377.54489820398;11785.764284714429;12269.631911042683;12318.568850090203;12332.630021099381;11938.164328497269;12369.876301237233;12392.884640382408;12814;12921.224726516062;9226.953865230631;9405.341626086109;9532.61869525239;9624.326297159132;9629.614815407305;9096.818063638822;10052.346597471142;10084.54619542137;10126.79746405053;10146.137578305927 18:12:59 INFO - PROCESS | 12080 | __end_tp_report 18:12:59 INFO - PROCESS | 12080 | __start_cc_report 18:12:59 INFO - PROCESS | 12080 | _x_x_mozilla_cycle_collect,933 18:12:59 INFO - PROCESS | 12080 | __end_cc_report 18:12:59 INFO - PROCESS | 12080 | __startTimestamp1466903579818__endTimestamp 18:12:59 INFO - PROCESS | 12080 | 18:12:59 INFO - PROCESS | 12080 | ------- Summary: start ------- 18:12:59 INFO - PROCESS | 12080 | Number of tests: 6 18:12:59 INFO - PROCESS | 12080 | 18:12:59 INFO - PROCESS | 12080 | [#0] dojo.html Cycles:165 Average:4719.69 Median:4843.85 stddev:500.01 (10.3%) stddev-sans-first:472.95 18:12:59 INFO - PROCESS | 12080 | Values: 2595.1 2616.5 2639.8 2643.8 2646.8 4676.6 4717.0 4758.5 4763.2 4815.0 4697.9 4701.9 4744.4 4766.0 4766.3 4170.0 4302.3 4377.2 4406.1 4548.7 4457.9 4479.4 4492.2 4497.3 4537.6 4302.5 4326.5 4347.9 4392.1 4397.2 4392.5 4408.6 4456.9 4458.6 4465.2 4436.0 4436.0 4497.3 4499.3 4502.9 4574.3 4743.9 4769.6 4812.6 4861.4 5131.6 5160.8 5186.0 5190.8 5204.2 4969.3 5175.9 5229.1 5240.7 5241.5 4727.5 4791.1 4796.3 4800.6 4838.6 5294.9 5321.8 5324.9 5329.3 5333.3 4881.7 4956.1 5041.8 5069.7 5079.1 5066.1 5079.1 5099.0 5099.6 5157.6 5041.5 5050.9 5054.3 5058.2 5104.6 4911.0 4990.6 5027.9 5060.8 5071.3 4341.9 4357.8 4394.2 4398.1 4403.3 3775.4 3792.3 3803.3 3830.3 3851.1 4284.9 4317.9 4324.8 4373.5 4377.8 5041.2 5051.9 5074.7 5079.6 5134.9 4328.1 4338.1 4338.9 4387.3 4403.2 4509.0 4560.3 4577.5 4581.0 4581.2 4802.4 4819.5 4830.1 4843.9 4867.3 5098.0 5102.3 5103.1 5105.9 5138.8 4609.8 4770.7 4821.8 4827.3 4865.5 5063.6 5078.1 5078.5 5083.9 5129.8 5139.9 5145.4 5147.4 5156.5 5159.2 4867.7 4894.6 4935.2 4946.0 4968.9 4926.8 4951.5 4955.5 4960.0 5009.0 4800.8 4882.3 4902.1 4932.2 4933.1 4911.4 4970.3 4978.1 4989.4 5007.8 4891.0 4898.3 4901.8 4902.1 4942.3 18:12:59 INFO - PROCESS | 12080 | 18:12:59 INFO - PROCESS | 12080 | [#1] ext.html Cycles:180 Average:47822.85 Median:32241.36 stddev:90962.13 (282.1%) stddev-sans-first:91148.10 18:12:59 INFO - PROCESS | 12080 | Values: 561.9 567.2 569.9 594.2 596.0 40288.6 41951.8 42025.4 45296.8 45297.0 41781.2 42452.4 42532.6 42551.6 42554.4 7576.8 7824.6 7977.6 7992.3 10069.5 9936.1 10328.6 10330.7 10337.5 10339.7 10419.4 10457.4 10470.3 10473.3 10476.3 7639.9 10150.7 10310.6 10387.5 10406.5 10251.0 10267.1 10267.3 10304.3 10335.0 38883.4 39023.2 39248.6 39260.2 39310.6 2966.5 3049.1 3177.4 3202.3 3379.9 29582.7 30172.4 30531.8 30758.5 30859.7 2956.7 2966.8 2974.7 2979.4 3008.8 250773.0 250937.0 251544.0 252341.0 252859.0 31996.8 32331.4 32367.4 53994.0 54725.2 33956.5 34276.5 34290.7 34427.3 34430.7 13275.6 13442.7 13472.1 13473.5 13479.4 9821.1 10716.9 10997.6 11002.6 11226.0 7943.6 7961.4 7982.4 8058.4 8065.1 3059.8 3151.2 3155.9 3183.6 3186.6 766.6 797.8 841.2 860.9 889.5 27029.0 28575.6 28650.0 30132.0 32151.4 950.9 964.8 966.2 1012.2 1037.8 14627.9 15013.6 15021.2 15122.6 15186.6 428834.0 430344.0 430374.0 430544.0 432406.0 50496.7 50898.7 50932.0 50977.5 51022.0 1094.4 1106.4 1168.5 1181.6 1218.6 27037.5 29033.7 29217.7 29271.9 29515.4 43110.6 43928.6 44031.3 44037.8 44119.6 317234.0 327323.0 327944.0 328626.0 328655.0 22397.7 22524.4 22526.5 24146.9 24245.5 36247.3 39568.0 39779.2 40578.4 40639.6 33886.5 34346.0 34583.5 34706.8 35487.6 34167.1 34651.5 34746.3 34930.7 35032.0 33507.0 33995.5 34309.1 34348.7 34354.5 30107.1 30778.7 31033.8 31110.7 31343.4 24263.8 24327.5 24494.8 24554.9 24959.5 18:12:59 INFO - PROCESS | 12080 | 18:12:59 INFO - PROCESS | 12080 | [#2] jquery.html Cycles:180 Average:23996.98 Median:228424.10 stddev:60264.50 (26.4%) stddev-sans-first:60407.44 18:12:59 INFO - PROCESS | 12080 | Values: 368.6 371.4 373.1 385.6 388.9 16106.8 16894.2 17215.7 17218.3 17262.4 16759.2 16846.9 16859.4 17294.2 17648.0 4981.5 5181.7 5220.9 5221.0 5225.4 3716.9 3931.3 5095.2 5680.4 6041.7 6114.4 6124.5 6130.9 6141.9 6154.7 5827.9 6016.9 6024.5 6033.5 6037.4 3343.0 4958.1 5302.5 5306.8 5318.0 20208.3 21047.9 21055.0 21103.2 21181.9 1891.9 1974.8 2113.7 2324.5 2425.7 12738.6 13182.0 13253.8 13258.7 14008.4 1710.0 1780.4 1799.8 1832.8 1867.9 68273.0 69376.0 70000.6 70646.0 71145.0 9397.8 9644.2 10020.4 10297.3 10521.0 13708.8 13839.1 13897.4 13915.9 13929.2 7076.2 7110.0 7113.6 7155.2 7204.3 6555.6 6574.0 6614.9 6718.7 6758.7 6333.0 6334.7 6344.7 6364.4 6385.8 1637.3 1637.8 1699.9 1734.9 1738.5 782.7 839.3 848.9 851.8 905.4 16840.9 17470.1 17687.4 17740.8 18084.7 862.5 874.5 885.4 889.6 926.2 9842.9 10279.5 10279.8 10286.1 10306.3 314406.0 320280.0 320769.0 417216.0 421430.0 79060.6 84288.2 85461.0 85521.2 86746.6 929.6 935.2 955.3 965.9 968.5 16116.0 16623.7 16736.5 16772.9 17005.0 37366.8 38551.2 38785.2 39501.4 39632.2 50454.5 50613.5 51961.0 58510.7 59479.7 7504.2 7840.4 7884.9 7891.7 7969.6 11339.7 11403.4 11561.1 11571.7 11900.5 9818.4 10274.0 10497.6 10506.7 10561.8 4763.3 7043.8 9247.8 10145.0 10325.1 9281.9 9908.9 10177.9 10603.8 10640.9 6616.9 6806.7 7892.7 8081.8 8088.4 9475.4 10000.0 10018.3 10161.2 10536.2 18:12:59 INFO - PROCESS | 12080 | 18:12:59 INFO - PROCESS | 12080 | [#3] mootools.html Cycles:180 Average:5116.06 Median:5073.20 stddev:2885.52 (56.9%) stddev-sans-first:2878.96 18:12:59 INFO - PROCESS | 12080 | Values: 1245.6 1355.4 1414.5 1469.3 1676.2 6717.9 7564.6 7783.9 7805.6 8035.0 7744.1 7874.8 7877.6 7887.5 7893.2 1886.5 2160.2 2205.5 2234.4 2235.4 2257.8 2275.5 2283.4 2283.9 2285.2 2219.8 2223.7 2254.3 2260.4 2262.5 1828.3 1882.0 1889.6 2120.4 2176.3 2173.8 2204.5 2218.8 2219.9 2220.0 7778.8 7814.3 7832.6 7835.1 7838.5 4494.9 4657.9 4659.1 4662.6 4664.7 2852.2 2902.8 2934.4 2976.4 3016.3 832.2 841.1 859.2 861.7 867.8 10587.5 10635.8 10643.2 10803.1 10816.0 4102.3 4198.1 4215.5 4293.5 4322.0 9075.6 9084.3 9119.1 9128.5 9157.5 4748.4 4767.7 4768.6 4773.6 4784.0 3650.3 4173.4 4305.0 4309.6 4374.7 3608.7 3631.4 3690.2 3698.2 3726.9 1161.5 1182.3 1183.9 1189.1 1200.7 822.1 827.3 831.8 840.1 846.7 5129.2 5178.3 5244.4 5244.6 5255.1 401.1 419.9 419.9 424.2 425.3 3519.2 3674.5 3686.7 3705.5 3767.3 9154.5 9498.3 9607.0 9687.2 9763.6 9577.3 9606.7 9670.1 9683.9 9721.7 7123.9 7386.2 7420.3 7435.6 7445.5 5017.2 5173.9 5214.1 5326.4 5371.9 8820.0 8914.8 8926.3 8933.4 8933.7 8463.5 8779.6 8789.6 9053.3 9062.1 5889.5 6180.3 6324.9 6607.1 6738.2 7405.3 7449.3 7458.5 7470.3 7510.0 6396.9 6644.1 6681.9 6769.1 6780.7 6629.2 6687.6 6746.5 6835.5 6887.7 6228.2 6256.4 6340.3 6351.6 6352.9 4590.3 4595.3 4659.3 4746.4 4763.6 4422.3 4559.1 4568.0 4570.8 4669.2 18:12:59 INFO - PROCESS | 12080 | 18:12:59 INFO - PROCESS | 12080 | [#4] prototype.html Cycles:180 Average:4273.70 Median:4882.35 stddev:1230.65 (25.2%) stddev-sans-first:1197.27 18:12:59 INFO - PROCESS | 12080 | Values: 292.0 308.7 309.6 312.5 314.9 4856.4 4925.3 4935.8 4967.8 5000.7 4652.6 4772.9 4818.5 4819.6 4943.7 3771.6 3828.3 3840.1 3846.6 3878.7 3872.9 3901.7 3913.5 3936.5 3938.5 3657.2 3826.4 3873.5 3917.6 3926.7 3808.5 3815.9 3817.3 3830.8 3841.3 3349.4 3352.9 3353.9 3362.6 3381.5 4779.6 4792.9 4793.9 4802.7 4831.2 4174.8 4365.3 4387.0 4393.2 4411.0 5117.8 5123.3 5124.9 5142.7 5149.7 3686.9 3696.5 3702.8 3718.3 3722.4 5111.8 5406.4 5434.4 5441.6 5464.7 3740.2 3781.1 3790.8 3793.6 3794.9 3815.8 3840.8 3841.9 3847.5 3852.7 4332.4 4358.2 4375.7 4381.5 4392.8 5096.3 5205.9 5213.2 5214.8 5215.6 1254.4 1303.4 1327.0 1329.3 1333.3 885.9 904.0 914.6 919.4 921.4 4515.3 4532.8 4541.1 4548.5 4564.3 5252.3 5269.5 5271.8 5334.3 5335.6 4324.9 4490.3 4515.3 4525.7 4550.1 2800.6 2806.7 2814.9 2823.7 2823.8 4908.3 4949.5 4957.0 4959.7 4977.2 5237.2 5291.9 5417.9 5432.2 5460.4 4966.0 4977.4 4984.8 5007.4 5017.6 5150.5 5243.9 5262.5 5311.8 5320.3 5136.6 5190.7 5198.6 5202.8 5209.5 4915.0 4922.0 4923.2 4932.2 4992.0 3767.3 3795.7 3796.7 3798.9 3802.3 5036.9 5195.1 5261.7 5267.9 5306.4 5072.0 5089.2 5104.6 5115.7 5131.8 4952.2 5113.8 5118.0 5121.8 5133.5 4798.3 4955.7 5057.8 5057.9 5112.6 5164.7 5180.2 5196.4 5223.8 5230.8 5050.2 5064.6 5066.3 5085.8 5113.0 18:12:59 INFO - PROCESS | 12080 | 18:12:59 INFO - PROCESS | 12080 | [#5] yui.html Cycles:180 Average:17012.88 Median:524.70 stddev:24260.55 (4623.7%) stddev-sans-first:24297.53 18:12:59 INFO - PROCESS | 12080 | Values: 658.1 665.8 682.7 695.2 751.8 11684.4 12288.3 12338.7 12371.9 12518.4 12375.4 12548.8 12551.6 12558.1 12569.4 618.3 768.1 779.4 788.0 789.8 776.1 780.1 781.3 787.6 789.5 829.2 831.5 834.3 835.1 835.3 653.7 672.7 679.2 684.6 833.9 596.4 607.8 608.4 614.2 618.6 12196.2 12200.0 12204.1 12263.1 12275.8 12616.3 13078.6 13183.5 13193.8 13325.0 11030.5 11624.9 11699.3 11867.1 12142.7 4090.8 4150.2 4254.9 4305.4 4312.5 58256.0 58479.0 58508.0 58554.7 59333.0 10045.4 10123.7 10168.3 10169.5 10384.2 16998.6 17025.5 17099.7 17116.3 17263.1 6572.0 6643.7 6667.1 6758.6 6894.8 3393.6 3438.5 3475.6 3492.5 3622.4 3012.6 3125.9 3154.4 3154.6 3157.7 519.5 537.0 539.7 542.7 542.8 552.8 573.5 591.7 592.8 595.1 7816.9 7819.0 7820.7 7876.4 8108.4 529.9 557.7 558.4 563.5 567.7 3564.7 3779.4 3844.5 3903.2 3960.9 87841.6 95970.0 100269.0 103495.0 103642.5 50151.5 50211.2 50992.0 62344.0 84008.0 75171.6 77927.0 78037.2 78486.6 78880.6 7461.9 7463.8 7499.4 7668.0 7750.8 45337.3 46069.0 46360.8 46413.5 47303.5 59160.7 65576.3 67128.3 67245.7 67400.3 9358.6 9367.1 9401.8 9584.9 9933.7 10051.6 10335.8 10417.2 10578.2 10633.3 10323.8 10333.5 10779.2 11659.7 12232.8 11377.5 11785.8 12269.6 12318.6 12332.6 11938.2 12369.9 12392.9 12814.0 12921.2 9227.0 9405.3 9532.6 9624.3 9629.6 9096.8 10052.3 10084.5 10126.8 10146.1 18:12:59 INFO - PROCESS | 12080 | -------- Summary: end -------- 18:12:59 INFO - PROCESS | 12080 | 18:13:00 INFO - TEST-INFO | 12080: exit 0 18:13:00 INFO - TEST-OK | dromaeo_css | took 1120304ms 18:13:00 INFO - TEST-START | kraken 18:13:00 INFO - operating with platform_type : linux_ 18:13:00 INFO - Initialising browser for kraken test... 18:13:00 INFO - TEST-INFO | started process 12261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnhs89i/profile http://localhost:33111/getInfo.html) 18:13:05 INFO - PROCESS | 12261 | __metrics Screen width/height:1600/1200 18:13:05 INFO - PROCESS | 12261 | colorDepth:24 18:13:05 INFO - PROCESS | 12261 | Browser inner width/height: 1024/697 18:13:05 INFO - PROCESS | 12261 | __metrics 18:13:06 INFO - PROCESS | 12261 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:13:07 INFO - TEST-INFO | 12261: exit 0 18:13:07 INFO - Browser initialized. 18:13:07 INFO - Running cycle 1/1 for kraken test... 18:13:07 INFO - TEST-INFO | started process 12343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnhs89i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:13:19 INFO - PROCESS | 12343 | RSS: Main: 175480832 18:13:19 INFO - PROCESS | 12343 | 18:13:21 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33111/tests/kraken/driver.html?testName=audio-beat-detection) 18:13:22 INFO - PROCESS | 12343 | RSS: Main: 233476096 18:13:22 INFO - PROCESS | 12343 | 18:13:25 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33111/tests/kraken/driver.html?testName=audio-dft) 18:13:26 INFO - PROCESS | 12343 | RSS: Main: 220372992 18:13:26 INFO - PROCESS | 12343 | 18:13:29 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33111/tests/kraken/driver.html?testName=audio-fft) 18:13:30 INFO - PROCESS | 12343 | RSS: Main: 287551488 18:13:30 INFO - PROCESS | 12343 | 18:13:32 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33111/tests/kraken/driver.html?testName=audio-oscillator) 18:13:32 INFO - PROCESS | 12343 | RSS: Main: 197890048 18:13:32 INFO - PROCESS | 12343 | 18:13:35 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33111/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:13:35 INFO - PROCESS | 12343 | RSS: Main: 202125312 18:13:35 INFO - PROCESS | 12343 | 18:13:39 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33111/tests/kraken/driver.html?testName=imaging-darkroom) 18:13:39 INFO - PROCESS | 12343 | RSS: Main: 237993984 18:13:39 INFO - PROCESS | 12343 | 18:13:43 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33111/tests/kraken/driver.html?testName=imaging-desaturate) 18:13:43 INFO - PROCESS | 12343 | RSS: Main: 239108096 18:13:43 INFO - PROCESS | 12343 | 18:13:46 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33111/tests/kraken/driver.html?testName=json-parse-financial) 18:13:47 INFO - PROCESS | 12343 | RSS: Main: 239271936 18:13:47 INFO - PROCESS | 12343 | 18:13:48 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33111/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:13:49 INFO - PROCESS | 12343 | RSS: Main: 225947648 18:13:49 INFO - PROCESS | 12343 | 18:13:51 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33111/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:13:52 INFO - PROCESS | 12343 | RSS: Main: 229515264 18:13:52 INFO - PROCESS | 12343 | 18:13:54 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33111/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:13:54 INFO - PROCESS | 12343 | RSS: Main: 236011520 18:13:54 INFO - PROCESS | 12343 | 18:13:57 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:13:58 INFO - PROCESS | 12343 | RSS: Main: 239468544 18:13:58 INFO - PROCESS | 12343 | 18:14:01 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:14:01 INFO - PROCESS | 12343 | RSS: Main: 238628864 18:14:01 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | Cycle 1(1): loaded http://localhost:33111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33111/tests/kraken/driver.html?testName=ai-astar) 18:14:03 INFO - PROCESS | 12343 | RSS: Main: 280711168 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | __start_tp_report 18:14:03 INFO - PROCESS | 12343 | _x_x_mozilla_page_load 18:14:03 INFO - PROCESS | 12343 | _x_x_mozilla_page_load_details 18:14:03 INFO - PROCESS | 12343 | |i|pagename|runs| 18:14:03 INFO - PROCESS | 12343 | |0;ai-astar;103;116;113;113;113;113;114;111;113;113 18:14:03 INFO - PROCESS | 12343 | |1;audio-beat-detection;164;139;141;179;131;151;157;132;186;139 18:14:03 INFO - PROCESS | 12343 | |2;audio-dft;161;161;161;161;164;160;161;161;160;161 18:14:03 INFO - PROCESS | 12343 | |3;audio-fft;76;76;76;106;78;76;75;76;101;76 18:14:03 INFO - PROCESS | 12343 | |4;audio-oscillator;87;86;120;85;86;87;117;85;86;116 18:14:03 INFO - PROCESS | 12343 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;117;117 18:14:03 INFO - PROCESS | 12343 | |6;imaging-darkroom;146;146;147;146;147;146;147;146;147;146 18:14:03 INFO - PROCESS | 12343 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 18:14:03 INFO - PROCESS | 12343 | |8;json-parse-financial;63;63;63;64;63;64;64;64;63;63 18:14:03 INFO - PROCESS | 12343 | |9;json-stringify-tinderbox;65;65;66;63;65;65;64;66;65;65 18:14:03 INFO - PROCESS | 12343 | |10;stanford-crypto-aes;82;83;82;82;83;84;82;84;99;82 18:14:03 INFO - PROCESS | 12343 | |11;stanford-crypto-ccm;137;131;144;128;127;132;130;135;143;146 18:14:03 INFO - PROCESS | 12343 | |12;stanford-crypto-pbkdf2;165;163;163;164;169;171;168;165;168;165 18:14:03 INFO - PROCESS | 12343 | |13;stanford-crypto-sha256-iterative;67;66;69;67;65;69;70;64;64;64 18:14:03 INFO - PROCESS | 12343 | __end_tp_report 18:14:03 INFO - PROCESS | 12343 | __start_cc_report 18:14:03 INFO - PROCESS | 12343 | _x_x_mozilla_cycle_collect,1899 18:14:03 INFO - PROCESS | 12343 | __end_cc_report 18:14:03 INFO - PROCESS | 12343 | __startTimestamp1466903643724__endTimestamp 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | ------- Summary: start ------- 18:14:03 INFO - PROCESS | 12343 | Number of tests: 14 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:3.46 (3.1%) stddev-sans-first:1.30 18:14:03 INFO - PROCESS | 12343 | Values: 103.0 116.0 113.0 113.0 113.0 113.0 114.0 111.0 113.0 113.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:154.00 stddev:19.31 (12.5%) stddev-sans-first:19.98 18:14:03 INFO - PROCESS | 12343 | Values: 164.0 139.0 141.0 179.0 131.0 151.0 157.0 132.0 186.0 139.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 18:14:03 INFO - PROCESS | 12343 | Values: 161.0 161.0 161.0 161.0 164.0 160.0 161.0 161.0 160.0 161.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:11.63 (15.3%) stddev-sans-first:12.15 18:14:03 INFO - PROCESS | 12343 | Values: 76.0 76.0 76.0 106.0 78.0 76.0 75.0 76.0 101.0 76.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:86.00 stddev:15.34 (17.8%) stddev-sans-first:15.96 18:14:03 INFO - PROCESS | 12343 | Values: 87.0 86.0 120.0 85.0 86.0 87.0 117.0 85.0 86.0 116.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:14:03 INFO - PROCESS | 12343 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:14:03 INFO - PROCESS | 12343 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:14:03 INFO - PROCESS | 12343 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 18:14:03 INFO - PROCESS | 12343 | Values: 63.0 63.0 63.0 64.0 63.0 64.0 64.0 64.0 63.0 63.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 18:14:03 INFO - PROCESS | 12343 | Values: 65.0 65.0 66.0 63.0 65.0 65.0 64.0 66.0 65.0 65.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:5.23 (6.3%) stddev-sans-first:5.48 18:14:03 INFO - PROCESS | 12343 | Values: 82.0 83.0 82.0 82.0 83.0 84.0 82.0 84.0 99.0 82.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:136.00 stddev:6.93 (5.1%) stddev-sans-first:7.32 18:14:03 INFO - PROCESS | 12343 | Values: 137.0 131.0 144.0 128.0 127.0 132.0 130.0 135.0 143.0 146.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:166.50 stddev:2.73 (1.6%) stddev-sans-first:2.86 18:14:03 INFO - PROCESS | 12343 | Values: 165.0 163.0 163.0 164.0 169.0 171.0 168.0 165.0 168.0 165.0 18:14:03 INFO - PROCESS | 12343 | 18:14:03 INFO - PROCESS | 12343 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:2.27 (3.4%) stddev-sans-first:2.40 18:14:03 INFO - PROCESS | 12343 | Values: 67.0 66.0 69.0 67.0 65.0 69.0 70.0 64.0 64.0 64.0 18:14:03 INFO - PROCESS | 12343 | -------- Summary: end -------- 18:14:03 INFO - PROCESS | 12343 | 18:14:04 INFO - TEST-INFO | 12343: exit 0 18:14:04 INFO - TEST-OK | kraken | took 64221ms 18:14:04 INFO - SUITE-END | took 1184s 18:14:04 INFO - Completed test suite (00:19:44) 18:14:04 INFO - javascript benchmark 18:14:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2595.078747044799, 2616.5159445502595, 2639.828411153274, 2643.7752791012763, 2646.8411895286285, 4676.649251306158, 4716.952830471694, 4758.547937945894, 4763.2378819388905, 4815.0, 4697.88255293617, 4701.882452938678, 4744.383230180072, 4766.022965292107, 4766.3088852116425, 4170.0, 4302.31163013917, 4377.233984052794, 4406.118776244748, 4548.681592288541, 4457.88855278619, 4479.372887795711, 4492.191405547001, 4497.302918047708, 4537.614302784267, 4302.548232435612, 4326.545712700153, 4347.913041739179, 4392.0776636906285, 4397.2304846651705, 4392.516823149451, 4408.559144085566, 4456.888577785581, 4458.576435238647, 4465.24090904547, 4436.0240747035605, 4436.0462500562535, 4497.280435130396, 4499.302608095751, 4502.8874278142985, 4574.313852922055, 4743.905121897577, 4769.642276829217, 4812.614990800727, 4861.416630004422, 5131.61512886535, 5160.845174644766, 5186.0, 5190.8183213587345, 5204.193350030713, 4969.304297398367, 5175.870603234912, 5229.058769421503, 5240.711760853152, 5241.50205730455, 4727.503612120747, 4791.089692958327, 4796.2805579163405, 4800.591949684316, 4838.588719958772, 5294.894102117936, 5321.840344789663, 5324.946750532445, 5329.333833270841, 5333.253344531769, 4881.658283920163, 4956.058348913695, 5041.773120209599, 5069.670471419346, 5079.060373830853, 5066.113430149709, 5079.1365467870555, 5099.0, 5099.617528685363, 5157.63896527247, 5041.495850415003, 5050.898982020339, 5054.342935418372, 5058.241263810458, 5104.642675012714, 4911.042346742351, 4990.575801056878, 5027.899442011139, 5060.797568097235, 5071.340725705634, 4341.891452713708, 4357.803898824561, 4394.209042372339, 4398.098389830077, 4403.295472724349, 3775.3959366501776, 3792.2984247914223, 3803.2773772983046, 3830.3296923038356, 3851.094992676719, 4284.914301713949, 4317.892052698645, 4324.8486302979245, 4373.540778218241, 4377.759223242752, 5041.168207245837, 5051.887216468115, 5074.695518268915, 5079.568236699922, 5134.897302053938, 4328.069465065026, 4338.132373525307, 4338.869833904925, 4387.276099443556, 4403.185410699031, 4508.954910450853, 4560.338750881104, 4577.473590537131, 4580.977095114503, 4581.221192397301, 4802.351682522814, 4819.518048195152, 4830.082284365959, 4843.854684359475, 4867.294242334912, 5098.0, 5102.336696229615, 5103.132467480463, 5105.923411148761, 5138.820141295037, 4609.769511524343, 4770.737609431515, 4821.783019764189, 4827.300041493893, 4865.489123641966, 5063.594912407072, 5078.136716758234, 5078.492150784892, 5083.92374114396, 5129.769160387867, 5139.92290115656, 5145.408278048072, 5147.40804807452, 5156.458571850052, 5159.226116082467, 4867.659263851497, 4894.632902532396, 4935.1856943605335, 4945.961348116935, 4968.875778105432, 4926.778294976663, 4951.529604687549, 4955.479674634112, 4960.0, 5009.023240468219, 4800.7599620019555, 4882.340883980617, 4902.117618828645, 4932.21084626458, 4933.087378834927, 4911.361523001987, 4970.304157418037, 4978.1288274552535, 4989.426215985208, 5007.84976450707, 4891.046245981999, 4898.2652602109965, 4901.779419926041, 4902.093112774148, 4942.308076869169], "value": 4687.236231532025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.9407417018919, 567.1974156568456, 569.8917205730913, 594.1978329255505, 595.9672218028006, 40288.59711402889, 41951.79024104879, 42025.3696194557, 45296.77351613245, 45297.0, 41781.16437671245, 42452.363214551806, 42532.57467425325, 42551.57448425522, 42554.36168457468, 7576.772696819105, 7824.647890844925, 7977.641006154708, 7992.280694737473, 10069.54687039085, 9936.105750482455, 10328.58685652573, 10330.690079297634, 10337.483125843715, 10339.74150646236, 10419.374837509737, 10457.424841633707, 10470.267081304311, 10473.319234249788, 10476.26666133371, 7639.885401718979, 10150.746231344201, 10310.639127630535, 10387.480625968672, 10406.531706073169, 10251.0, 10267.127294180003, 10267.281290309682, 10304.278700490968, 10335.018173273527, 38883.416748748794, 39023.21953560913, 39248.607513924784, 39260.21479570421, 39310.60689393127, 2966.466036113499, 3049.1157564306322, 3177.396294703999, 3202.327511222646, 3379.8648054077808, 29582.70417295821, 30172.396552068836, 30531.847340763154, 30758.53862192069, 30859.691403085908, 2956.7486763625116, 2966.792324537283, 2974.687657795922, 2979.4488019716423, 3008.819470831735, 250772.99999999817, 250936.99999999817, 251544.0, 252341.0, 252859.0, 31996.840015800237, 32331.353372932408, 32367.35265294681, 53994.0, 54725.179122313195, 33956.490652640234, 34276.48585271223, 34290.657093428745, 34427.31145377079, 34430.655693443245, 13275.601731948056, 13442.731145377038, 13472.05695601318, 13473.528426505221, 13479.393427295796, 9821.116099551075, 10716.892831071746, 10997.560097596166, 11002.614908478165, 11226.0, 7943.563104029334, 7961.36309095271, 7982.401319900914, 8058.435909486397, 8065.072516660542, 3059.7552195824283, 3151.16494129056, 3155.921101972469, 3183.644103363494, 3186.617605887262, 766.5783818899583, 797.8125140591957, 841.2134654098437, 860.8708693695995, 889.5329951775241, 27029.0, 28575.57136642952, 28650.0, 30132.0, 32151.356972860878, 950.9381890177116, 964.7588102974256, 966.1787480641539, 1012.1750773119884, 1037.7820657661975, 14627.853721462861, 15013.624659383384, 15021.173835438936, 15122.621934451507, 15186.620334491727, 428834.0, 430344.0, 430374.0, 430544.0, 432406.0, 50496.74751626292, 50898.74550627223, 50931.99999999926, 50977.490225098016, 51022.0, 1094.441834664327, 1106.3693694594165, 1168.526746667601, 1181.6336935550007, 1218.597862705305, 27037.459250815267, 29033.7096629031, 29217.7078229215, 29271.85364073166, 29515.409691805613, 43110.56889431191, 43928.56071439245, 44031.33952990772, 44037.779811102024, 44119.55880441154, 317234.0, 327323.0, 327944.0, 328626.0, 328655.0, 22397.664035039812, 22524.436889077904, 22526.549469010857, 24146.87926560356, 24245.515089697754, 36247.275054498234, 39568.0, 39779.20441591094, 40578.391324129574, 40639.59360406358, 33886.491702623985, 34346.0, 34583.4812477808, 34706.835179777576, 35487.645123548435, 34167.145821354665, 34651.48022779711, 34746.30507389889, 34930.65069349274, 35032.0, 33507.0, 33995.49006764851, 34309.142271443416, 34348.656513434544, 34354.48468272928, 30107.096787095546, 30778.692213077582, 31033.844830775703, 31110.68889311078, 31343.37313253768, 24263.75736242615, 24327.51344973055, 24494.755052449247, 24554.877225613756, 24959.500809984063], "value": 16851.865022571546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.57981900633274, 371.3927728164452, 373.132467014192, 385.5566098986164, 388.9066624010238, 16106.75839862403, 16894.155292235384, 17215.655686886254, 17218.311267549314, 17262.395816146436, 16759.16204189792, 16846.915765421156, 16859.40992065278, 17294.2217600208, 17648.029358385284, 4981.452040275576, 5181.740912954356, 5220.895582088375, 5221.0, 5225.399079105913, 3716.9256614867686, 3931.2923673738715, 5095.210242412432, 5680.431956804307, 6041.697915104249, 6114.3579924108, 6124.540659450537, 6130.908036379458, 6141.877162456771, 6154.692265386735, 5827.854303642401, 6016.939830601704, 6024.457798798129, 6033.456988871023, 6037.366076561963, 3342.983285083559, 4958.132326842788, 5302.496262855023, 5306.8407947761625, 5317.973410132925, 20208.29270975509, 21047.89476052625, 21055.0, 21103.15587376503, 21181.894090529604, 1891.9121505134603, 1974.7827738948704, 2113.661814109735, 2324.476992676651, 2425.7452967438517, 12738.554150604685, 13182.0, 13253.801192982017, 13258.66853328665, 14008.439662413492, 1709.9572510687208, 1780.3679693708677, 1799.8380145786812, 1832.8258815412648, 1867.8879267244008, 68273.0, 69376.0, 70000.6499967497, 70646.0, 71145.0, 9397.812043759086, 9644.18024467928, 10020.398776073458, 10297.330673506198, 10521.0, 13708.794368084287, 13839.100458470168, 13897.374618142208, 13915.930420347833, 13929.164250145024, 7076.186238582526, 7109.964450177716, 7113.608751518613, 7155.212926578072, 7204.3155900189395, 6555.6066636002, 6574.0, 6614.867702646016, 6718.731250750013, 6758.695858686371, 6332.968335158294, 6334.651594162366, 6344.700755607058, 6364.395382438661, 6385.808425747235, 1637.3368785641835, 1637.7707121003068, 1699.8895071820293, 1734.8698847586481, 1738.547977525827, 782.710397153057, 839.3369238301796, 848.8854004709409, 851.7827953871723, 905.366243629462, 16840.915795421188, 17470.126493675518, 17687.38094166698, 17740.82259177392, 18084.728729069073, 862.5342315149875, 874.5408660453313, 885.4288983605538, 889.5907882374051, 926.1664501948301, 9842.901570984199, 10279.537420816081, 10279.794404111875, 10286.125679317342, 10306.33008854422, 314406.0, 320280.0, 320769.0, 417216.0, 421430.0, 79060.60469697615, 84288.15711842803, 85461.0, 85521.15830733527, 86746.56626716827, 929.5816882402946, 935.2284365398573, 955.2930831184873, 965.9130678238993, 968.5205823117602, 16116.0, 16623.66752664916, 16736.497905062868, 16772.916135419244, 17005.0, 37366.813165934, 38551.2289754209, 38785.2242955145, 39501.40747888727, 39632.207355852144, 50454.49545504498, 50613.493865060875, 51961.0, 58510.7074464625, 59479.702601486715, 7504.249575042452, 7840.411969102226, 7884.881726774218, 7891.684332626631, 7969.645160322875, 11339.659810205707, 11403.429828508708, 11561.132915031238, 11571.6528504145, 11900.523979040741, 9818.410895346302, 10274.023967723055, 10497.580096796042, 10506.684799456028, 10561.788764224826, 4763.285507173951, 7043.823904402431, 9247.76880577991, 10145.0, 10325.101297507263, 9281.86077208856, 9908.900910990798, 10177.898221017695, 10603.840942386025, 10640.946795265974, 6616.933830661825, 6806.65966701653, 7892.723754668559, 8081.757547273592, 8088.393370497354, 9475.384100033476, 10000.0, 10018.298719089593, 10161.187105031431, 10536.209784266057], "value": 8423.811433918909, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.6449911775146, 1355.376526797673, 1414.497853262092, 1469.2891614970383, 1676.2373120230288, 6717.865642687149, 7564.621768911553, 7783.922160778405, 7805.609719514023, 8035.035795704509, 7744.109427415849, 7874.842503149934, 7877.606119694006, 7887.526748395086, 7893.210678932104, 1886.4623582279053, 2160.157538559963, 2205.503761653627, 2234.3967128875192, 2235.3629215673536, 2257.762934891837, 2275.5335156293004, 2283.383486458655, 2283.8743869087193, 2285.2116019973164, 2219.755826859044, 2223.67756675282, 2254.323702889135, 2260.4122928038664, 2262.468319944812, 1828.2686925229882, 1881.9529511762178, 1889.5748456597155, 2120.385088324384, 2176.3144609447972, 2173.793489618484, 2204.548067646129, 2218.7670294618993, 2219.87790671513, 2220.0231897965004, 7778.844423111563, 7814.296713295774, 7832.608369581498, 7835.138134805167, 7838.490498117604, 4494.910101797946, 4657.906841863178, 4659.068186362741, 4662.557057079572, 4664.696794708333, 2852.2441552988475, 2902.840343781091, 2934.4424559333656, 2976.3749612581382, 3016.306249562591, 832.1678321678322, 841.1084250694283, 859.188067276424, 861.6553378648528, 867.7873920889359, 10587.523561439753, 10635.787284254271, 10643.201759868041, 10803.081738052275, 10816.0, 4102.261592913304, 4198.055437526593, 4215.536291007987, 4293.463317085364, 4322.0, 9075.591598377956, 9084.318676099187, 9119.088091190828, 9128.497932613636, 9157.49633770149, 4748.358971538867, 4767.73777442244, 4768.57082862544, 4773.570378665867, 4783.976080119577, 3650.3064417760543, 4173.373993900878, 4305.031367942188, 4309.612134907873, 4374.737515749065, 3608.693261072786, 3631.418972964366, 3690.1697118148204, 3698.2418604186614, 3726.9068273293383, 1161.5480649188514, 1182.3024415594668, 1183.9052875769917, 1189.1200511621512, 1200.652723924725, 822.0587427395599, 827.2576409203472, 831.7712629027066, 840.0591337701813, 846.7332790171199, 5129.179331306973, 5178.309721543728, 5244.4413583767455, 5244.606654500928, 5255.080360936897, 401.14956292659167, 419.9160167966419, 419.92231437184216, 424.18979748679874, 425.26641543338116, 3519.1905861651962, 3674.467202255658, 3686.7419280650097, 3705.481232627434, 3767.3407153747985, 9154.450732956044, 9498.335116541914, 9607.039296070338, 9687.225021998223, 9763.609455621696, 9577.329586928849, 9606.711798646053, 9670.129688327943, 9683.854742178873, 9721.70834874955, 7123.89314160288, 7386.187519372865, 7420.257974202645, 7435.591042492607, 7445.478816482902, 5017.222330538772, 5173.896522069613, 5214.113600687968, 5326.387465441524, 5371.946280537301, 8820.0, 8914.777130571787, 8926.330525210766, 8933.419327743675, 8933.731988040368, 8463.49219046859, 8779.561021949004, 8789.648414063622, 9053.321000925089, 9062.139096785795, 5889.469947704727, 6180.320164781961, 6324.873502530016, 6607.141071660653, 6738.225104113089, 7405.333519983227, 7449.292317229854, 7458.47790654649, 7470.252974702486, 7509.962450187714, 6396.936030639634, 6644.10304608891, 6681.933180668131, 6769.086173366532, 6780.694868731018, 6629.171353580802, 6687.565308254948, 6746.460283177236, 6835.453163746988, 6887.690053947485, 6228.22147231596, 6256.374362563707, 6340.334264902303, 6351.555391122577, 6352.936470635234, 4590.288505281686, 4595.333676616805, 4659.277811939155, 4746.43042834862, 4763.618910487222, 4422.314541246112, 4559.0881823634745, 4568.017876156642, 4570.840020599263, 4669.229577119737], "value": 4043.9634939319108, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.9897803576874, 308.7236922953956, 309.5511508312947, 312.50312003913774, 314.8504460381319, 4856.44150922644, 4925.285833554132, 4935.77788999495, 4967.751612419378, 5000.7249601271915, 4652.581267685908, 4772.949951010781, 4818.469968303484, 4819.554018876503, 4943.728094954776, 3771.6039815819354, 3828.310904037279, 3840.135969406875, 3846.557645870733, 3878.709096817736, 3872.9419058714143, 3901.6683581895572, 3913.491246137998, 3936.5276166859876, 3938.487996560443, 3657.158853463705, 3826.4069069294305, 3873.496445462086, 3917.6082391760883, 3926.7447615905016, 3808.476609356252, 3815.866444674451, 3817.2938006468617, 3830.80845957701, 3841.3277676406656, 3349.3874777673454, 3352.9329413411597, 3353.9161520961925, 3362.562866827321, 3381.4758712399616, 4779.569838714532, 4792.904141917142, 4793.856184314476, 4802.735849528274, 4831.202851529493, 4174.810179098972, 4365.323374876899, 4386.978065109686, 4393.231184542692, 4410.955890441119, 5117.801374141161, 5123.2827404163445, 5124.923126153073, 5142.717150556718, 5149.716765577892, 3686.8755029715926, 3696.482492451059, 3702.8148592570265, 3718.3492888744363, 3722.3858063419502, 5111.795528178868, 5406.351237851443, 5434.429384914606, 5441.619086663935, 5464.6994415307145, 3740.214554943492, 3781.0925377909102, 3790.753601015925, 3793.577408471823, 3794.924101517954, 3815.751976121543, 3840.846366145323, 3841.9231615368094, 3847.5190601174854, 3852.7110466715108, 4332.350147477903, 4358.171947329997, 4375.7374557526655, 4381.539938306496, 4392.780360981938, 5096.337476128154, 5205.932783779316, 5213.165893457104, 5214.765335559833, 5215.55667768244, 1254.4480428611382, 1303.3678665847056, 1327.0, 1329.3021163888843, 1333.3133436280323, 885.9246964008003, 904.0, 914.6295750221171, 919.3932004876749, 921.3550514639779, 4515.345274935116, 4532.798808315799, 4541.091781643619, 4548.499665036843, 4564.3153526970555, 5252.343457067866, 5269.525742683177, 5271.78912843482, 5334.279872217278, 5335.573154147659, 4324.935125973113, 4490.3040028795585, 4515.277555591089, 4525.705829121162, 4550.134444877651, 2800.5939138824756, 2806.6632004159223, 2814.8733307000825, 2823.74586287231, 2823.842224687868, 4908.263760435963, 4949.455559888409, 4957.0, 4959.677620954626, 4977.1538838397555, 5237.224271136304, 5291.920621190685, 5417.891642167135, 5432.239486471897, 5460.426655201147, 4965.950340496621, 4977.402711674622, 4984.750762461862, 5007.4491805901325, 5017.569992552105, 5150.510701483353, 5243.947560524499, 5262.473752624707, 5311.760970756248, 5320.255164276927, 5136.563392111712, 5190.728271573489, 5198.584113271005, 5202.791888324425, 5209.519812960926, 4914.975425122994, 4921.950780492292, 4923.187674033744, 4932.186189278872, 4991.975040124777, 3767.3030489359558, 3795.7342985991822, 3796.715246356479, 3798.867039653599, 3802.2775672622115, 5036.866704991347, 5195.1037871177505, 5261.736913154404, 5267.920981185362, 5306.389765177054, 5071.974640126776, 5089.236614507853, 5104.642675012714, 5115.667481613683, 5131.820386286611, 4952.182889823139, 5113.79544818218, 5118.00198961199, 5121.795128194831, 5133.537981581676, 4798.2802579613335, 4955.65310428281, 5057.760848592118, 5057.949420505748, 5112.565431938327, 5164.715940623302, 5180.222966555047, 5196.350456192976, 5223.817166399158, 5230.8169214077325, 5050.217216331474, 5064.5948324134715, 5066.265391518135, 5085.821996230115, 5113.028524580318], "value": 3885.100559131479, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.0852614865337, 665.7902760630398, 682.743971010871, 695.2353008459194, 751.8421131562371, 11684.415779211047, 12288.324142172178, 12338.691532711686, 12371.938140309308, 12518.374081295933, 12375.44310506027, 12548.811767823467, 12551.560695375663, 12558.05814563909, 12569.371531423438, 618.2704408797617, 768.085977686554, 779.4115442840647, 787.9566623835686, 789.8420315936806, 776.0764690018859, 780.1028816860598, 781.2890269854433, 787.6376866641352, 789.5144486141039, 829.2081062585247, 831.4803247970019, 834.2783492279195, 835.0730688935307, 835.3150416658343, 653.6600967496922, 672.7241830849329, 679.1815861886415, 684.6337209592843, 833.8749187621845, 596.3559355895623, 607.8480379905023, 608.4493533352279, 614.2475467552257, 618.6473709985311, 12196.207246528948, 12200.023998080222, 12204.145709800317, 12263.141580089397, 12275.754484910341, 12616.306103164323, 13078.607641770763, 13183.472661093545, 13193.795738941537, 13325.0, 11030.50928413642, 11624.941875290653, 11699.298042117414, 11867.109966752529, 12142.696432589168, 4090.8363665453644, 4150.190712811003, 4254.936175957363, 4305.418768466279, 4312.460942382202, 58256.0, 58479.0, 58508.0, 58554.70722646402, 59333.0, 10045.397276163307, 10123.7469063274, 10168.28821982469, 10169.54237059334, 10384.169266458664, 16998.57503562421, 17025.48923532296, 17099.74350384745, 17116.315347385964, 17263.13684315779, 6571.967140164268, 6643.734250629921, 6667.066610674509, 6758.560693554903, 6894.827629309207, 3393.5588373511287, 3438.4670376091744, 3475.6176820549717, 3492.476128580733, 3622.3660859350034, 3012.5631783391286, 3125.890593829205, 3154.41643295991, 3154.6056742907135, 3157.7315928146363, 519.4831143012651, 536.9919451208235, 539.7463192299613, 542.6798189068389, 542.7530473634487, 552.8065177187952, 573.5211098732522, 591.7189335065809, 592.8340064781868, 595.1489370200568, 7816.8827467588035, 7818.960905195438, 7820.726274580363, 7876.396254371475, 8108.351331893435, 529.9125644268653, 557.7267139101892, 558.3578884283107, 563.492856429217, 567.7416775367197, 3564.7326450516316, 3779.4330850372116, 3844.4630939535696, 3903.219356128729, 3960.88117356474, 87841.56079219563, 95970.0, 100269.0, 103495.0, 103642.48178759059, 50151.498485015414, 50211.24683129756, 50992.0, 62344.0, 84008.0, 75171.62414187894, 77927.0, 78037.21962780414, 78486.6075669618, 78880.60559697279, 7461.938257325494, 7463.776086717407, 7499.362554182955, 7668.003159589218, 7750.806229844074, 45337.31994020158, 46069.0, 46360.768196160156, 46413.535864642276, 47303.52696473129, 59160.70419647874, 65576.34423655702, 67128.3287167122, 67245.66377168083, 67400.32599673941, 9358.578863951274, 9367.110124538158, 9401.764955876159, 9584.9041509584, 9933.65232216869, 10051.597936082475, 10335.793284134426, 10417.218708597036, 10578.206634502289, 10633.308834925705, 10323.845142323022, 10333.483325833527, 10779.245452818228, 11659.650210493699, 12232.75534489323, 11377.54489820398, 11785.764284714429, 12269.631911042683, 12318.568850090203, 12332.630021099381, 11938.164328497269, 12369.876301237233, 12392.884640382408, 12814.0, 12921.224726516062, 9226.953865230631, 9405.341626086109, 9532.61869525239, 9624.326297159132, 9629.614815407305, 9096.818063638822, 10052.346597471142, 10084.54619542137, 10126.79746405053, 10146.137578305927], "value": 6407.995747436915, "unit": "score"}], "name": "dromaeo_css", "value": 6372.974775705856, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 113.0, 113.0, 113.0, 113.0, 114.0, 111.0, 113.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 139.0, 141.0, 179.0, 131.0, 151.0, 157.0, 132.0, 186.0, 139.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 164.0, 160.0, 161.0, 161.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 106.0, 78.0, 76.0, 75.0, 76.0, 101.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 120.0, 85.0, 86.0, 87.0, 117.0, 85.0, 86.0, 116.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 63.0, 65.0, 65.0, 64.0, 66.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 82.0, 83.0, 84.0, 82.0, 84.0, 99.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 144.0, 128.0, 127.0, 132.0, 130.0, 135.0, 143.0, 146.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 164.0, 169.0, 171.0, 168.0, 165.0, 168.0, 165.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 67.0, 65.0, 69.0, 70.0, 64.0, 64.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1540.8999999999999, "alertThreshold": 2.0}]} 18:14:04 INFO - Return code: 0 18:14:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:14:05 INFO - # TBPL SUCCESS # 18:14:05 INFO - Running post-action listener: _resource_record_post_action 18:14:05 INFO - ##### 18:14:05 INFO - ##### Finished run-tests step (success) 18:14:05 INFO - ##### 18:14:05 INFO - Running post-run listener: _resource_record_post_run 18:14:05 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550948864; Read time: 12; Write time: 552416 18:14:05 INFO - TinderboxPrint: CPU usage
13.2% 18:14:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:14:05 INFO - TinderboxPrint: I/O write bytes / time
550,948,864 / 552,416 18:14:05 INFO - TinderboxPrint: CPU idle
8,328.2 (86.8%) 18:14:05 INFO - TinderboxPrint: CPU user
1,215.4 (12.7%) 18:14:05 INFO - TinderboxPrint: Swap in / out
0 / 0 18:14:05 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 253210624; Read time: 0; Write time: 312716 18:14:05 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297738240; Read time: 12; Write time: 239700 18:14:05 INFO - Running post-run listener: _upload_blobber_files 18:14:05 INFO - Blob upload gear active. 18:14:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:14:05 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 18:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:14:06 INFO - (blobuploader) - INFO - Open directory for files ... 18:14:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:14:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:14:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:06 INFO - (blobuploader) - INFO - Done attempting. 18:14:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:14:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:14:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:10 INFO - (blobuploader) - INFO - Done attempting. 18:14:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:14:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:14:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:12 INFO - (blobuploader) - INFO - Done attempting. 18:14:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:14:12 INFO - Return code: 0 18:14:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:14:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:14:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a0854e0ed5f9d96f855f605a3a34746aef41d8efb2fbac6ab59681870736964109a478cd2623d8667aa2e76d8518a18bf214d8041fb93f3c7f8a5a064bd4735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05613243ab90ac4e6dd41885a64f207e62c9071d535156a21af075a1ee195b64daf0da4bb4fbd26dcf6bba89197f315d9d1c10dcc296208814596a7da912934b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89925354baad1af8d47c059260c06d8faacd30c2e77b06e49bfafb867a1f2d8f28b8ca73cb128dc11fb78f9c3a95182e1c1c605ae7e54c433e0560415e1bbf3c"} 18:14:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:14:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:14:12 INFO - Contents: 18:14:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a0854e0ed5f9d96f855f605a3a34746aef41d8efb2fbac6ab59681870736964109a478cd2623d8667aa2e76d8518a18bf214d8041fb93f3c7f8a5a064bd4735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05613243ab90ac4e6dd41885a64f207e62c9071d535156a21af075a1ee195b64daf0da4bb4fbd26dcf6bba89197f315d9d1c10dcc296208814596a7da912934b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89925354baad1af8d47c059260c06d8faacd30c2e77b06e49bfafb867a1f2d8f28b8ca73cb128dc11fb78f9c3a95182e1c1c605ae7e54c433e0560415e1bbf3c"} 18:14:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:14:12 INFO - Copying logs to upload dir... 18:14:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:14:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.751285 ========= master_lag: 0.71 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-25 18:14:12.322319) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 18:14:12.329445) ========= 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-1466902161.945958-1222444925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a0854e0ed5f9d96f855f605a3a34746aef41d8efb2fbac6ab59681870736964109a478cd2623d8667aa2e76d8518a18bf214d8041fb93f3c7f8a5a064bd4735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05613243ab90ac4e6dd41885a64f207e62c9071d535156a21af075a1ee195b64daf0da4bb4fbd26dcf6bba89197f315d9d1c10dcc296208814596a7da912934b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89925354baad1af8d47c059260c06d8faacd30c2e77b06e49bfafb867a1f2d8f28b8ca73cb128dc11fb78f9c3a95182e1c1c605ae7e54c433e0560415e1bbf3c"} build_url:https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/ejix43CNQmKwIX4cZgr0lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a0854e0ed5f9d96f855f605a3a34746aef41d8efb2fbac6ab59681870736964109a478cd2623d8667aa2e76d8518a18bf214d8041fb93f3c7f8a5a064bd4735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05613243ab90ac4e6dd41885a64f207e62c9071d535156a21af075a1ee195b64daf0da4bb4fbd26dcf6bba89197f315d9d1c10dcc296208814596a7da912934b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89925354baad1af8d47c059260c06d8faacd30c2e77b06e49bfafb867a1f2d8f28b8ca73cb128dc11fb78f9c3a95182e1c1c605ae7e54c433e0560415e1bbf3c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 18:14:12.357366) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 18:14:12.357686) ========= 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-1466902161.945958-1222444925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004672 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 18:14:12.406826) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 18:14:12.410227) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 18:14:12.410587) ========= ========= Total master_lag: 0.84 =========