builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1466604565.8 results: success (0) buildid: 20160622065400 builduid: 9e130365890e4c6ba2f881f93546e5bc revision: 86cedfebcbda916da044c04efd0bb6c80f5b5587 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:25.806840) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:25.807351) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:25.807658) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:25.856416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:25.856694) ========= 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=0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 07:09: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.3M=0s 2016-06-22 07:09:26 (24.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184081 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:26.069265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:26.069641) ========= 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=0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.094103 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:26.175688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:26.176031) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 86cedfebcbda916da044c04efd0bb6c80f5b5587 --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 86cedfebcbda916da044c04efd0bb6c80f5b5587 --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=0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 07:09:26,274 truncating revision to first 12 chars 2016-06-22 07:09:26,274 Setting DEBUG logging. 2016-06-22 07:09:26,274 attempt 1/10 2016-06-22 07:09:26,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/86cedfebcbda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 07:09:26,808 unpacking tar archive at: fx-team-86cedfebcbda/testing/mozharness/ program finished with exit code 0 elapsedTime=0.916031 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:27.105673) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:27.105987) ========= script_repo_revision: 86cedfebcbda916da044c04efd0bb6c80f5b5587 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:27.106408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:27.106714) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 07:09:27.151675) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-22 07:09:27.152086) ========= /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=0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:09:27 INFO - MultiFileLogger online at 20160622 07:09:27 in /builds/slave/test 07:09:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:09:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:09:27 INFO - {'append_to_log': False, 07:09:27 INFO - 'base_work_dir': '/builds/slave/test', 07:09:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:09:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:09:27 INFO - 'branch': 'Fx-Team-Non-PGO', 07:09:27 INFO - 'buildbot_json_path': 'buildprops.json', 07:09:27 INFO - 'config_files': ('talos/linux_config.py',), 07:09:27 INFO - 'default_actions': ('clobber', 07:09:27 INFO - 'read-buildbot-config', 07:09:27 INFO - 'download-and-extract', 07:09:27 INFO - 'populate-webroot', 07:09:27 INFO - 'create-virtualenv', 07:09:27 INFO - 'install', 07:09:27 INFO - 'run-tests'), 07:09:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:09:27 INFO - 'download_minidump_stackwalk': True, 07:09:27 INFO - 'download_symbols': 'ondemand', 07:09:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:09:27 INFO - 'tooltool.py': '/tools/tooltool.py', 07:09:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:09:27 INFO - '/tools/misc-python/virtualenv.py')}, 07:09:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:09:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:09:27 INFO - 'installer_path': 'installer.exe', 07:09:27 INFO - 'log_level': 'info', 07:09:27 INFO - 'log_name': 'talos', 07:09:27 INFO - 'log_to_console': True, 07:09:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:09:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:09:27 INFO - 'opt_config_files': (), 07:09:27 INFO - 'pip_index': False, 07:09:27 INFO - 'sps_profile': False, 07:09:27 INFO - 'sps_profile_interval': 0, 07:09:27 INFO - 'suite': 'dromaeojs', 07:09:27 INFO - 'system_bits': '32', 07:09:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:09:27 INFO - 'title': 'talos-linux64-ix-017', 07:09:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:09:27 INFO - 'use_talos_json': True, 07:09:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:09:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:09:27 INFO - 'work_dir': 'build'} 07:09:27 INFO - ##### 07:09:27 INFO - ##### Running clobber step. 07:09:27 INFO - ##### 07:09:27 INFO - Running pre-action listener: _resource_record_pre_action 07:09:27 INFO - Running main action method: clobber 07:09:27 INFO - rmtree: /builds/slave/test/build 07:09:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:09:29 INFO - Running post-action listener: _resource_record_post_action 07:09:29 INFO - ##### 07:09:29 INFO - ##### Finished clobber step (success) 07:09:29 INFO - ##### 07:09:29 INFO - ##### 07:09:29 INFO - ##### Running read-buildbot-config step. 07:09:29 INFO - ##### 07:09:29 INFO - Running pre-action listener: _resource_record_pre_action 07:09:29 INFO - Running main action method: read_buildbot_config 07:09:29 INFO - Using buildbot properties: 07:09:29 INFO - { 07:09:29 INFO - "project": "", 07:09:29 INFO - "product": "firefox", 07:09:29 INFO - "script_repo_revision": "production", 07:09:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:09:29 INFO - "repository": "", 07:09:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:09:29 INFO - "buildid": "20160622065400", 07:09:29 INFO - "pgo_build": "False", 07:09:29 INFO - "basedir": "/builds/slave/test", 07:09:29 INFO - "buildnumber": 1877, 07:09:29 INFO - "slavename": "talos-linux64-ix-017", 07:09:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:09:29 INFO - "platform": "ubuntu64_hw", 07:09:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:09:29 INFO - "branch": "fx-team", 07:09:29 INFO - "repo_path": "integration/fx-team", 07:09:29 INFO - "revision": "86cedfebcbda916da044c04efd0bb6c80f5b5587", 07:09:29 INFO - "stage_platform": "linux64", 07:09:29 INFO - "builduid": "9e130365890e4c6ba2f881f93546e5bc", 07:09:29 INFO - "slavebuilddir": "test" 07:09:29 INFO - } 07:09:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:09:29 INFO - Running post-action listener: _resource_record_post_action 07:09:29 INFO - ##### 07:09:29 INFO - ##### Finished read-buildbot-config step (success) 07:09:29 INFO - ##### 07:09:29 INFO - ##### 07:09:29 INFO - ##### Running download-and-extract step. 07:09:29 INFO - ##### 07:09:29 INFO - Running pre-action listener: _resource_record_pre_action 07:09:29 INFO - Running main action method: download_and_extract 07:09:29 INFO - mkdir: /builds/slave/test/build/tests 07:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:29 INFO - https://queue.taskcluster.net/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:09:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:09:32 INFO - Downloaded 1361 bytes. 07:09:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:32 INFO - Using the following test package requirements: 07:09:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:09:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:09:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:32 INFO - u'jsshell-linux-x86_64.zip'], 07:09:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:09:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:09:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:09:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:09:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:09:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:32 INFO - https://queue.taskcluster.net/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:33 INFO - Downloaded 22703727 bytes. 07:09:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:35 INFO - Return code: 0 07:09:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:35 INFO - https://queue.taskcluster.net/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:37 INFO - Downloaded 22703727 bytes. 07:09:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:38 INFO - Return code: 0 07:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:38 INFO - https://queue.taskcluster.net/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:09:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:09:39 INFO - Downloaded 14405384 bytes. 07:09:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:09:40 INFO - Return code: 0 07:09: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')]} 07:09:40 INFO - https://queue.taskcluster.net/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:09:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:09:41 INFO - Downloaded 56262127 bytes. 07:09:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:41 INFO - mkdir: /builds/slave/test/properties 07:09:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:41 INFO - Contents: 07:09:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:42 INFO - Running post-action listener: _resource_record_post_action 07:09:42 INFO - Running post-action listener: set_extra_try_arguments 07:09:42 INFO - ##### 07:09:42 INFO - ##### Finished download-and-extract step (success) 07:09:42 INFO - ##### 07:09:42 INFO - ##### 07:09:42 INFO - ##### Running populate-webroot step. 07:09:42 INFO - ##### 07:09:42 INFO - Running pre-action listener: _resource_record_pre_action 07:09:42 INFO - Running main action method: populate_webroot 07:09:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:42 INFO - '--tppagecycles', 07:09:42 INFO - '7'], 07:09:42 INFO - 'tests': ['tsvgm']}}, 07:09:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:09:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:09:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:09:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:09:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:09:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:42 INFO - 'talos_options': ['--disable-e10s'], 07:09:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:42 INFO - 'talos_options': ['--disable-e10s'], 07:09:42 INFO - 'tests': ['damp', 'tps']}, 07:09:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:42 INFO - 'tests': ['damp', 'tps']}, 07:09:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:09:42 INFO - 'tests': ['dromaeo_dom']}, 07:09:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:09:42 INFO - 'tests': ['basic_compositor_video']}, 07:09:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:09:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:09:42 INFO - 'tests': ['a11yr', 07:09:42 INFO - 'ts_paint', 07:09:42 INFO - 'tpaint', 07:09:42 INFO - 'sessionrestore', 07:09:42 INFO - 'sessionrestore_no_auto_restore', 07:09:42 INFO - 'tabpaint']}, 07:09:42 INFO - 'other-e10s': {'tests': ['a11yr', 07:09:42 INFO - 'ts_paint', 07:09:42 INFO - 'tpaint', 07:09:42 INFO - 'sessionrestore', 07:09:42 INFO - 'sessionrestore_no_auto_restore', 07:09:42 INFO - 'tabpaint']}, 07:09:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:09:42 INFO - 'ts_paint', 07:09:42 INFO - 'tpaint', 07:09:42 INFO - 'sessionrestore', 07:09:42 INFO - 'sessionrestore_no_auto_restore', 07:09:42 INFO - 'tabpaint']}, 07:09:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:09:42 INFO - 'ts_paint', 07:09:42 INFO - 'tpaint', 07:09:42 INFO - 'sessionrestore', 07:09:42 INFO - 'sessionrestore_no_auto_restore', 07:09:42 INFO - 'tabpaint']}, 07:09:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:09:42 INFO - 'tests': ['a11yr', 07:09:42 INFO - 'ts_paint', 07:09:42 INFO - 'tpaint', 07:09:42 INFO - 'sessionrestore', 07:09:42 INFO - 'sessionrestore_no_auto_restore', 07:09:42 INFO - 'tabpaint']}, 07:09:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:09:42 INFO - 'tests': ['a11yr', 07:09:42 INFO - 'ts_paint', 07:09:42 INFO - 'tpaint', 07:09:42 INFO - 'sessionrestore', 07:09:42 INFO - 'sessionrestore_no_auto_restore', 07:09:42 INFO - 'tabpaint']}, 07:09:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:09:42 INFO - 'tests': ['tsvgx', 07:09:42 INFO - 'tsvgr_opacity', 07:09:42 INFO - 'tart', 07:09:42 INFO - 'tscrollx', 07:09:42 INFO - 'cart']}, 07:09:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:09:42 INFO - 'tsvgr_opacity', 07:09:42 INFO - 'tart', 07:09:42 INFO - 'tscrollx', 07:09:42 INFO - 'cart']}, 07:09:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:42 INFO - 'talos_options': ['--disable-e10s'], 07:09:42 INFO - 'tests': ['tp5o']}, 07:09:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:42 INFO - 'tests': ['tp5o']}, 07:09:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:42 INFO - 'talos_options': ['--disable-e10s', 07:09:42 INFO - '--xperf_path', 07:09:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:42 INFO - 'tests': ['tp5n']}, 07:09:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:42 INFO - 'talos_options': ['--xperf_path', 07:09:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:42 INFO - 'tests': ['tp5n']}}, 07:09:42 INFO - 'talos.zip': {'path': '', 07:09:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:42 INFO - Running post-action listener: _resource_record_post_action 07:09:42 INFO - ##### 07:09:42 INFO - ##### Finished populate-webroot step (success) 07:09:42 INFO - ##### 07:09:42 INFO - ##### 07:09:42 INFO - ##### Running create-virtualenv step. 07:09:42 INFO - ##### 07:09:42 INFO - Running pre-action listener: _resource_record_pre_action 07:09:42 INFO - Running main action method: create_virtualenv 07:09:42 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:09:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:42 INFO - Using real prefix '/usr' 07:09:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:43 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:45 INFO - Installing pip.................done. 07:09:45 INFO - Return code: 0 07:09:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:45 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 0x7fb2e0084f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22992e0>, '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 0x2205140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22055d0>, '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': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:09:45 INFO - Using env: {'DISPLAY': ':0', 07:09:45 INFO - 'HOME': '/home/cltbld', 07:09:45 INFO - 'LANG': 'en_US.UTF-8', 07:09:45 INFO - 'LANGUAGE': 'en_US:en', 07:09:45 INFO - 'LOGNAME': 'cltbld', 07:09:45 INFO - 'MAIL': '/var/mail/cltbld', 07:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:45 INFO - 'MOZ_NO_REMOTE': '1', 07:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:45 INFO - 'NO_EM_RESTART': '1', 07:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:45 INFO - 'PWD': '/builds/slave/test', 07:09:45 INFO - 'SHELL': '/bin/bash', 07:09:45 INFO - 'SHLVL': '1', 07:09:45 INFO - 'TERM': 'linux', 07:09:45 INFO - 'TMOUT': '86400', 07:09:45 INFO - 'USER': 'cltbld', 07:09:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 07:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:45 INFO - '_': '/tools/buildbot/bin/python'} 07:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:09:45 INFO - Cleaning up... 07:09:45 INFO - Return code: 0 07:09:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:45 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 0x7fb2e0084f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22992e0>, '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 0x2205140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22055d0>, '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': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:09:45 INFO - Using env: {'DISPLAY': ':0', 07:09:45 INFO - 'HOME': '/home/cltbld', 07:09:45 INFO - 'LANG': 'en_US.UTF-8', 07:09:45 INFO - 'LANGUAGE': 'en_US:en', 07:09:45 INFO - 'LOGNAME': 'cltbld', 07:09:45 INFO - 'MAIL': '/var/mail/cltbld', 07:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:45 INFO - 'MOZ_NO_REMOTE': '1', 07:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:45 INFO - 'NO_EM_RESTART': '1', 07:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:45 INFO - 'PWD': '/builds/slave/test', 07:09:45 INFO - 'SHELL': '/bin/bash', 07:09:45 INFO - 'SHLVL': '1', 07:09:45 INFO - 'TERM': 'linux', 07:09:45 INFO - 'TMOUT': '86400', 07:09:45 INFO - 'USER': 'cltbld', 07:09:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 07:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:45 INFO - '_': '/tools/buildbot/bin/python'} 07:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:46 INFO - Downloading/unpacking psutil>=3.1.1 07:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:48 INFO - Installing collected packages: psutil 07:09:48 INFO - Running setup.py install for psutil 07:09:48 INFO - building 'psutil._psutil_linux' extension 07:09:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:09:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:09:49 INFO - building 'psutil._psutil_posix' extension 07:09:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:09:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:09:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:50 INFO - Successfully installed psutil 07:09:50 INFO - Cleaning up... 07:09:50 INFO - Return code: 0 07:09:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:50 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 0x7fb2e0084f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22992e0>, '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 0x2205140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22055d0>, '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': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:09:50 INFO - Using env: {'DISPLAY': ':0', 07:09:50 INFO - 'HOME': '/home/cltbld', 07:09:50 INFO - 'LANG': 'en_US.UTF-8', 07:09:50 INFO - 'LANGUAGE': 'en_US:en', 07:09:50 INFO - 'LOGNAME': 'cltbld', 07:09:50 INFO - 'MAIL': '/var/mail/cltbld', 07:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:50 INFO - 'MOZ_NO_REMOTE': '1', 07:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:50 INFO - 'NO_EM_RESTART': '1', 07:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:50 INFO - 'PWD': '/builds/slave/test', 07:09:50 INFO - 'SHELL': '/bin/bash', 07:09:50 INFO - 'SHLVL': '1', 07:09:50 INFO - 'TERM': 'linux', 07:09:50 INFO - 'TMOUT': '86400', 07:09:50 INFO - 'USER': 'cltbld', 07:09:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 07:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:50 INFO - '_': '/tools/buildbot/bin/python'} 07:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:09:52 INFO - Installing collected packages: mozsystemmonitor 07:09:52 INFO - Running setup.py install for mozsystemmonitor 07:09:52 INFO - Successfully installed mozsystemmonitor 07:09:52 INFO - Cleaning up... 07:09:52 INFO - Return code: 0 07:09:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:52 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 0x7fb2e0084f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22992e0>, '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 0x2205140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22055d0>, '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': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:09:52 INFO - Using env: {'DISPLAY': ':0', 07:09:52 INFO - 'HOME': '/home/cltbld', 07:09:52 INFO - 'LANG': 'en_US.UTF-8', 07:09:52 INFO - 'LANGUAGE': 'en_US:en', 07:09:52 INFO - 'LOGNAME': 'cltbld', 07:09:52 INFO - 'MAIL': '/var/mail/cltbld', 07:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:52 INFO - 'MOZ_NO_REMOTE': '1', 07:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:52 INFO - 'NO_EM_RESTART': '1', 07:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:52 INFO - 'PWD': '/builds/slave/test', 07:09:52 INFO - 'SHELL': '/bin/bash', 07:09:52 INFO - 'SHLVL': '1', 07:09:52 INFO - 'TERM': 'linux', 07:09:52 INFO - 'TMOUT': '86400', 07:09:52 INFO - 'USER': 'cltbld', 07:09:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 07:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:52 INFO - '_': '/tools/buildbot/bin/python'} 07:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:52 INFO - Downloading/unpacking jsonschema==2.5.1 07:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:54 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:54 INFO - warning: no files found matching '*.txt' 07:09:54 INFO - no previously-included directories found matching 'build' 07:09:54 INFO - no previously-included directories found matching 'dist' 07:09:54 INFO - no previously-included directories found matching '.git*' 07:09:54 INFO - Installing collected packages: jsonschema, functools32 07:09:54 INFO - Running setup.py install for functools32 07:09:54 INFO - warning: no files found matching '*.txt' 07:09:54 INFO - no previously-included directories found matching 'build' 07:09:54 INFO - no previously-included directories found matching 'dist' 07:09:54 INFO - no previously-included directories found matching '.git*' 07:09:55 INFO - Successfully installed jsonschema functools32 07:09:55 INFO - Cleaning up... 07:09:55 INFO - Return code: 0 07:09:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:55 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 0x7fb2e0084f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22992e0>, '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 0x2205140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22055d0>, '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': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:09:55 INFO - Using env: {'DISPLAY': ':0', 07:09:55 INFO - 'HOME': '/home/cltbld', 07:09:55 INFO - 'LANG': 'en_US.UTF-8', 07:09:55 INFO - 'LANGUAGE': 'en_US:en', 07:09:55 INFO - 'LOGNAME': 'cltbld', 07:09:55 INFO - 'MAIL': '/var/mail/cltbld', 07:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:55 INFO - 'MOZ_NO_REMOTE': '1', 07:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:55 INFO - 'NO_EM_RESTART': '1', 07:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:55 INFO - 'PWD': '/builds/slave/test', 07:09:55 INFO - 'SHELL': '/bin/bash', 07:09:55 INFO - 'SHLVL': '1', 07:09:55 INFO - 'TERM': 'linux', 07:09:55 INFO - 'TMOUT': '86400', 07:09:55 INFO - 'USER': 'cltbld', 07:09:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 07:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:55 INFO - '_': '/tools/buildbot/bin/python'} 07:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:55 INFO - Downloading/unpacking blobuploader==1.2.4 07:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:58 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:09:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:58 INFO - Downloading docopt-0.6.1.tar.gz 07:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:58 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:58 INFO - Running setup.py install for blobuploader 07:09:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:09:59 INFO - Running setup.py install for requests 07:09:59 INFO - Running setup.py install for docopt 07:09:59 INFO - Successfully installed blobuploader requests docopt 07:09:59 INFO - Cleaning up... 07:09:59 INFO - Return code: 0 07:09:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:59 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 0x7fb2e0084f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22992e0>, '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 0x2205140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22055d0>, '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': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:09:59 INFO - Using env: {'DISPLAY': ':0', 07:09:59 INFO - 'HOME': '/home/cltbld', 07:09:59 INFO - 'LANG': 'en_US.UTF-8', 07:09:59 INFO - 'LANGUAGE': 'en_US:en', 07:09:59 INFO - 'LOGNAME': 'cltbld', 07:09:59 INFO - 'MAIL': '/var/mail/cltbld', 07:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:59 INFO - 'MOZ_NO_REMOTE': '1', 07:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:59 INFO - 'NO_EM_RESTART': '1', 07:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:59 INFO - 'PWD': '/builds/slave/test', 07:09:59 INFO - 'SHELL': '/bin/bash', 07:09:59 INFO - 'SHLVL': '1', 07:09:59 INFO - 'TERM': 'linux', 07:09:59 INFO - 'TMOUT': '86400', 07:09:59 INFO - 'USER': 'cltbld', 07:09:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 07:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:59 INFO - '_': '/tools/buildbot/bin/python'} 07:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:59 INFO - Running setup.py (path:/tmp/pip-pxbvSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:59 INFO - Running setup.py (path:/tmp/pip-BJLOdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:59 INFO - Running setup.py (path:/tmp/pip-Z7ekES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:59 INFO - Running setup.py (path:/tmp/pip-l8Z0mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:00 INFO - Running setup.py (path:/tmp/pip-pLBxbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:00 INFO - Running setup.py (path:/tmp/pip-tpOAMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:00 INFO - Running setup.py (path:/tmp/pip-Z6E3Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:00 INFO - Running setup.py (path:/tmp/pip-WD9bH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:00 INFO - Running setup.py (path:/tmp/pip-MUAIY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:00 INFO - Running setup.py (path:/tmp/pip-7LIHoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:00 INFO - Running setup.py (path:/tmp/pip-uAmDML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:00 INFO - Running setup.py (path:/tmp/pip-2gw8oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:00 INFO - Running setup.py (path:/tmp/pip-gXoVZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:00 INFO - Running setup.py (path:/tmp/pip-xXvYz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:00 INFO - Running setup.py (path:/tmp/pip-WJp09E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:00 INFO - Running setup.py (path:/tmp/pip-UTTjid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:00 INFO - Running setup.py (path:/tmp/pip-0_m3en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:10:00 INFO - Running setup.py install for manifestparser 07:10:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:10:01 INFO - Running setup.py install for mozcrash 07:10:01 INFO - Running setup.py install for mozdebug 07:10:01 INFO - Running setup.py install for mozdevice 07:10:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:10:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:10:01 INFO - Running setup.py install for mozfile 07:10:01 INFO - Running setup.py install for mozhttpd 07:10:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:10:01 INFO - Running setup.py install for mozinfo 07:10:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:10:01 INFO - Running setup.py install for mozInstall 07:10:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:10:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:10:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:10:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:10:01 INFO - Running setup.py install for mozleak 07:10:01 INFO - Running setup.py install for mozlog 07:10:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:10:02 INFO - Running setup.py install for moznetwork 07:10:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:10:02 INFO - Running setup.py install for mozprocess 07:10:02 INFO - Running setup.py install for mozprofile 07:10:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:10:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:10:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:10:02 INFO - Running setup.py install for mozrunner 07:10:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:10:02 INFO - Running setup.py install for mozscreenshot 07:10:02 INFO - Running setup.py install for moztest 07:10:02 INFO - Running setup.py install for mozversion 07:10:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:10:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:10:02 INFO - Cleaning up... 07:10:02 INFO - Return code: 0 07:10:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:02 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 0x7fb2e0084f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22992e0>, '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 0x2205140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22055d0>, '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': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:10:02 INFO - Using env: {'DISPLAY': ':0', 07:10:02 INFO - 'HOME': '/home/cltbld', 07:10:02 INFO - 'LANG': 'en_US.UTF-8', 07:10:02 INFO - 'LANGUAGE': 'en_US:en', 07:10:02 INFO - 'LOGNAME': 'cltbld', 07:10:02 INFO - 'MAIL': '/var/mail/cltbld', 07:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:02 INFO - 'MOZ_NO_REMOTE': '1', 07:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:02 INFO - 'NO_EM_RESTART': '1', 07:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:02 INFO - 'PWD': '/builds/slave/test', 07:10:02 INFO - 'SHELL': '/bin/bash', 07:10:02 INFO - 'SHLVL': '1', 07:10:02 INFO - 'TERM': 'linux', 07:10:02 INFO - 'TMOUT': '86400', 07:10:02 INFO - 'USER': 'cltbld', 07:10:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 07:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:02 INFO - '_': '/tools/buildbot/bin/python'} 07:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:02 INFO - Running setup.py (path:/tmp/pip-SOFG8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:03 INFO - Running setup.py (path:/tmp/pip-3_VSWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:03 INFO - Running setup.py (path:/tmp/pip-o84LwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:03 INFO - Running setup.py (path:/tmp/pip-LkAQF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:03 INFO - Running setup.py (path:/tmp/pip-USuU8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:03 INFO - Running setup.py (path:/tmp/pip-UNaiVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:03 INFO - Running setup.py (path:/tmp/pip-_bGnJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:03 INFO - Running setup.py (path:/tmp/pip-qLDKml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:03 INFO - Running setup.py (path:/tmp/pip-Zu3j5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:03 INFO - Running setup.py (path:/tmp/pip-3XXyUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:03 INFO - Running setup.py (path:/tmp/pip-uQb8cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:03 INFO - Running setup.py (path:/tmp/pip-MyP5oV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:03 INFO - Running setup.py (path:/tmp/pip-Rnt5sC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:03 INFO - Running setup.py (path:/tmp/pip-xVauTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:04 INFO - Running setup.py (path:/tmp/pip-AcfOJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:04 INFO - Running setup.py (path:/tmp/pip-SnHDTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:04 INFO - Running setup.py (path:/tmp/pip-6sk4uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:10:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:06 INFO - Downloading blessings-1.6.tar.gz 07:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:10:06 INFO - Installing collected packages: blessings 07:10:06 INFO - Running setup.py install for blessings 07:10:06 INFO - Successfully installed blessings 07:10:06 INFO - Cleaning up... 07:10:06 INFO - Return code: 0 07:10:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:10:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:06 INFO - Reading from file tmpfile_stdout 07:10:06 INFO - Current package versions: 07:10:06 INFO - argparse == 1.2.1 07:10:06 INFO - blessings == 1.6 07:10:06 INFO - blobuploader == 1.2.4 07:10:06 INFO - docopt == 0.6.1 07:10:06 INFO - functools32 == 3.2.3-2 07:10:06 INFO - jsonschema == 2.5.1 07:10:06 INFO - manifestparser == 1.1 07:10:06 INFO - mozInstall == 1.12 07:10:06 INFO - mozcrash == 0.17 07:10:06 INFO - mozdebug == 0.1 07:10:06 INFO - mozdevice == 0.48 07:10:06 INFO - mozfile == 1.2 07:10:06 INFO - mozhttpd == 0.7 07:10:06 INFO - mozinfo == 0.9 07:10:06 INFO - mozleak == 0.1 07:10:06 INFO - mozlog == 3.2 07:10:06 INFO - moznetwork == 0.27 07:10:06 INFO - mozprocess == 0.22 07:10:06 INFO - mozprofile == 0.28 07:10:06 INFO - mozrunner == 6.11 07:10:06 INFO - mozscreenshot == 0.1 07:10:06 INFO - mozsystemmonitor == 0.3 07:10:06 INFO - moztest == 0.7 07:10:06 INFO - mozversion == 1.4 07:10:06 INFO - psutil == 3.1.1 07:10:06 INFO - requests == 1.2.3 07:10:06 INFO - wsgiref == 0.1.2 07:10:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:06 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 0x7fb2e0084f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22992e0>, '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 0x2205140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22055d0>, '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': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:10:06 INFO - Using env: {'DISPLAY': ':0', 07:10:06 INFO - 'HOME': '/home/cltbld', 07:10:06 INFO - 'LANG': 'en_US.UTF-8', 07:10:06 INFO - 'LANGUAGE': 'en_US:en', 07:10:06 INFO - 'LOGNAME': 'cltbld', 07:10:06 INFO - 'MAIL': '/var/mail/cltbld', 07:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:06 INFO - 'MOZ_NO_REMOTE': '1', 07:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:06 INFO - 'NO_EM_RESTART': '1', 07:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:06 INFO - 'PWD': '/builds/slave/test', 07:10:06 INFO - 'SHELL': '/bin/bash', 07:10:06 INFO - 'SHLVL': '1', 07:10:06 INFO - 'TERM': 'linux', 07:10:06 INFO - 'TMOUT': '86400', 07:10:06 INFO - 'USER': 'cltbld', 07:10:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 07:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:06 INFO - '_': '/tools/buildbot/bin/python'} 07:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:10:06 INFO - Cleaning up... 07:10:06 INFO - Return code: 0 07:10:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:06 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 0x7fb2e0084f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22992e0>, '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 0x2205140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22055d0>, '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': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:10:06 INFO - Using env: {'DISPLAY': ':0', 07:10:06 INFO - 'HOME': '/home/cltbld', 07:10:06 INFO - 'LANG': 'en_US.UTF-8', 07:10:06 INFO - 'LANGUAGE': 'en_US:en', 07:10:06 INFO - 'LOGNAME': 'cltbld', 07:10:06 INFO - 'MAIL': '/var/mail/cltbld', 07:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:06 INFO - 'MOZ_NO_REMOTE': '1', 07:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:06 INFO - 'NO_EM_RESTART': '1', 07:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:06 INFO - 'PWD': '/builds/slave/test', 07:10:06 INFO - 'SHELL': '/bin/bash', 07:10:06 INFO - 'SHLVL': '1', 07:10:06 INFO - 'TERM': 'linux', 07:10:06 INFO - 'TMOUT': '86400', 07:10:06 INFO - 'USER': 'cltbld', 07:10:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 07:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:06 INFO - '_': '/tools/buildbot/bin/python'} 07:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:10:07 INFO - Cleaning up... 07:10:07 INFO - Return code: 0 07:10:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2e0084f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22992e0>, '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 0x2205140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22055d0>, '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': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:10:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:10:07 INFO - Using env: {'DISPLAY': ':0', 07:10:07 INFO - 'HOME': '/home/cltbld', 07:10:07 INFO - 'LANG': 'en_US.UTF-8', 07:10:07 INFO - 'LANGUAGE': 'en_US:en', 07:10:07 INFO - 'LOGNAME': 'cltbld', 07:10:07 INFO - 'MAIL': '/var/mail/cltbld', 07:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:07 INFO - 'MOZ_NO_REMOTE': '1', 07:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:07 INFO - 'NO_EM_RESTART': '1', 07:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:07 INFO - 'PWD': '/builds/slave/test', 07:10:07 INFO - 'SHELL': '/bin/bash', 07:10:07 INFO - 'SHLVL': '1', 07:10:07 INFO - 'TERM': 'linux', 07:10:07 INFO - 'TMOUT': '86400', 07:10:07 INFO - 'USER': 'cltbld', 07:10:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 07:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:07 INFO - '_': '/tools/buildbot/bin/python'} 07:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:07 INFO - Downloading/unpacking flake8 07:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:10:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:10:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:10:09 INFO - no previously-included directories found matching 'docs/_build' 07:10:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:10:09 INFO - Running setup.py install for pep8 07:10:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:10:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:10:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:10:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:10:10 INFO - no previously-included directories found matching 'docs/_build' 07:10:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:10:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:10:10 INFO - Cleaning up... 07:10:10 INFO - Return code: 0 07:10:10 INFO - Running post-action listener: _resource_record_post_action 07:10:10 INFO - Running post-action listener: _start_resource_monitoring 07:10:10 INFO - Starting resource monitoring. 07:10:10 INFO - ##### 07:10:10 INFO - ##### Finished create-virtualenv step (success) 07:10:10 INFO - ##### 07:10:10 INFO - ##### 07:10:10 INFO - ##### Running install step. 07:10:10 INFO - ##### 07:10:10 INFO - Running pre-action listener: _resource_record_pre_action 07:10:10 INFO - Running main action method: install 07:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:10 INFO - Reading from file tmpfile_stdout 07:10:10 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:10:10 INFO - Reading from file tmpfile_stdout 07:10:10 INFO - Output received: 07:10:10 INFO - Usage: mozinstall [options] installer 07:10:10 INFO - Options: 07:10:10 INFO - -h, --help show this help message and exit 07:10:10 INFO - -d DEST, --destination=DEST 07:10:10 INFO - Directory to install application into. [default: 07:10:10 INFO - "/builds/slave/test"] 07:10:10 INFO - --app=APP Application being installed. [default: firefox] 07:10:10 INFO - mkdir: /builds/slave/test/build/application 07:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:10:26 INFO - Reading from file tmpfile_stdout 07:10:26 INFO - Output received: 07:10:26 INFO - /builds/slave/test/build/application/firefox/firefox 07:10:26 INFO - Running post-action listener: _resource_record_post_action 07:10:26 INFO - ##### 07:10:26 INFO - ##### Finished install step (success) 07:10:26 INFO - ##### 07:10:26 INFO - ##### 07:10:26 INFO - ##### Running run-tests step. 07:10:26 INFO - ##### 07:10:26 INFO - Running pre-action listener: _resource_record_pre_action 07:10:26 INFO - Running main action method: run_tests 07:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:10:26 INFO - Python 2.7.3 07:10:26 INFO - Return code: 0 07:10:26 INFO - grabbing minidump binary from tooltool 07:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:26 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 0x22992e0>, '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 0x2205140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22055d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:10:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:10:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:10:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:10:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:10:26 INFO - Return code: 0 07:10:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:10:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:10:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:10:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:10:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:10:27 INFO - Return code: 0 07:10:27 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/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:10:27 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/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:10:27 INFO - Using env: {'DISPLAY': ':0', 07:10:27 INFO - 'HOME': '/home/cltbld', 07:10:27 INFO - 'LANG': 'en_US.UTF-8', 07:10:27 INFO - 'LANGUAGE': 'en_US:en', 07:10:27 INFO - 'LOGNAME': 'cltbld', 07:10:27 INFO - 'MAIL': '/var/mail/cltbld', 07:10:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:10:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:27 INFO - 'MOZ_NO_REMOTE': '1', 07:10:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:27 INFO - 'NO_EM_RESTART': '1', 07:10:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:27 INFO - 'PWD': '/builds/slave/test', 07:10:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:10:27 INFO - 'SHELL': '/bin/bash', 07:10:27 INFO - 'SHLVL': '1', 07:10:27 INFO - 'TERM': 'linux', 07:10:27 INFO - 'TMOUT': '86400', 07:10:27 INFO - 'USER': 'cltbld', 07:10:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046', 07:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:27 INFO - '_': '/tools/buildbot/bin/python'} 07:10:27 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/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:10:27 INFO - mozversion application_buildid: 20160622065400 07:10:27 INFO - mozversion application_changeset: 86cedfebcbda916da044c04efd0bb6c80f5b5587 07:10:27 INFO - mozversion application_display_name: Nightly 07:10:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:27 INFO - mozversion application_name: Firefox 07:10:27 INFO - mozversion application_remotingname: firefox 07:10:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:10:27 INFO - mozversion application_vendor: Mozilla 07:10:27 INFO - mozversion application_version: 50.0a1 07:10:27 INFO - mozversion platform_buildid: 20160622065400 07:10:27 INFO - mozversion platform_changeset: 86cedfebcbda916da044c04efd0bb6c80f5b5587 07:10:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:10:27 INFO - mozversion platform_version: 50.0a1 07:10:27 INFO - using testdate: 1466604627 07:10:27 INFO - actual date: 1466604627 07:10:27 INFO - starting webserver on 'localhost:53391' 07:10:27 INFO - SUITE-START | Running 2 tests 07:10:27 INFO - TEST-START | dromaeo_css 07:10:27 INFO - operating with platform_type : linux_ 07:10:27 INFO - Initialising browser for dromaeo_css test... 07:10:27 INFO - TEST-INFO | started process 3311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTlZL05/profile http://localhost:53391/getInfo.html) 07:10:33 INFO - PROCESS | 3311 | __metrics Screen width/height:1600/1200 07:10:33 INFO - PROCESS | 3311 | colorDepth:24 07:10:33 INFO - PROCESS | 3311 | Browser inner width/height: 1024/697 07:10:33 INFO - PROCESS | 3311 | __metrics 07:10:36 INFO - PROCESS | 3311 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:37 INFO - TEST-INFO | 3311: exit 0 07:10:37 INFO - Browser initialized. 07:10:37 INFO - Running cycle 1/1 for dromaeo_css test... 07:10:37 INFO - TEST-INFO | started process 3395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTlZL05/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:49 INFO - PROCESS | 3395 | RSS: Main: 175919104 07:10:49 INFO - PROCESS | 3395 | 07:11:40 INFO - PROCESS | 3395 | 1466604700641 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:13:53 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:53391/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53391/tests/dromaeo/cssquery-ext.html) 07:13:54 INFO - PROCESS | 3395 | RSS: Main: 293781504 07:13:54 INFO - PROCESS | 3395 | 07:16:57 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:53391/tests/dromaeo/cssquery-ext.html (next: http://localhost:53391/tests/dromaeo/cssquery-jquery.html) 07:16:58 INFO - PROCESS | 3395 | RSS: Main: 264302592 07:16:58 INFO - PROCESS | 3395 | 07:20:00 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:53391/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53391/tests/dromaeo/cssquery-mootools.html) 07:20:01 INFO - PROCESS | 3395 | RSS: Main: 257376256 07:20:01 INFO - PROCESS | 3395 | 07:23:03 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:53391/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53391/tests/dromaeo/cssquery-prototype.html) 07:23:03 INFO - PROCESS | 3395 | RSS: Main: 252354560 07:23:03 INFO - PROCESS | 3395 | 07:26:06 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:53391/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53391/tests/dromaeo/cssquery-yui.html) 07:26:07 INFO - PROCESS | 3395 | RSS: Main: 236859392 07:26:07 INFO - PROCESS | 3395 | 07:29:10 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:53391/tests/dromaeo/cssquery-yui.html (next: http://localhost:53391/tests/dromaeo/cssquery-dojo.html) 07:29:10 INFO - PROCESS | 3395 | RSS: Main: 289882112 07:29:10 INFO - PROCESS | 3395 | 07:29:10 INFO - PROCESS | 3395 | __start_tp_report 07:29:10 INFO - PROCESS | 3395 | _x_x_mozilla_page_load 07:29:10 INFO - PROCESS | 3395 | _x_x_mozilla_page_load_details 07:29:10 INFO - PROCESS | 3395 | |i|pagename|runs| 07:29:10 INFO - PROCESS | 3395 | |0;dojo.html;2638.709741928388;2643.735626437355;2682.235562864584;2684.67783865936;2692.9326766830827;4730.148573256813;4810.422749270093;4822.638302127341;4929.359183306174;4973.204287314031;4776.044791041788;4790.80836766529;4812.687175333601;4876.536729010747;4882.438519570251;4411.4265145531035;4486.214912390335;4492.7528985905765;4558.544145585448;4619.722816630996;4505.43682039745;4536.705114167585;4554.180247555439;4562.429696287964;4583;4372.672049596293;4412.580804823537;4424.225760491901;4492.73043617384;4503.797329120198;4421.867343979686;4423.7788110594665;4424.424824772791;4534.342520334566;4537.364768932319;4439.711418757771;4463.68754187207;4481.753503557303;4485.170243504929;4521.276595744665;4776.641751868624;4819.903601927942;4856.854294371175;4862.173430516786;4918.778654960535;5288.418273989858;5298.443663415363;5313.787448502056;5332.253484512172;5340.145576707708;5330.413654498002;5355.464453554652;5371.194320851903;5372.489613486712;5385.192221166856;4718.268668356411;4891.217405215149;4943.604511639061;4948.307236986825;4977.352944117241;5462.3445186577865;5494.670319780826;5503.3120859892515;5513.972430137824;5520.91718624221;5138.537531622172;5255.737213139404;5267.394249661262;5270.341207349082;5271.235670827708;5114.258432527263;5174.482551744871;5192.662476938987;5248.343957005374;5264.868378290496;5211.452797456288;5245.318108645852;5247.475252474722;5250.291210686585;5297.152455607084;5208.739563021833;5228.320318358665;5232.03207406631;5235.764390602356;5280.65675731084;4359.542248063971;4415.889602759957;4433.224185767543;4495.033567782943;4501.88745281364;3873.399623058374;3889.4749208857006;3891.630295121959;3926.4895563577124;3945.0926286953586;4492.73043617384;4498.415206023196;4503.301988191835;4508.977455112704;4551.931721024187;5061.772220250097;5099.286099946011;5177.223416487557;5280.471952804689;5285.339332583427;4432.357308190294;4452.198604251266;4471.754053527087;4530.88672783183;4539.182947069559;4713.552212539803;4731.455882573479;4735.928961065587;4737.597304229179;4763.071201115818;4763.285507173951;4850.80596776125;4902.1911384621135;4919.557239848287;4926.6551341406475;5269.578433725216;5287.180487024518;5292.52367286946;5292.894142117213;5333.9466605335;4923.409190897115;4934.901301974012;4935.4570997190995;4945.159322915041;4983.800647974041;5042.697438153723;5087.898242035212;5099;5144.6398752087;5192.065428222805;5198.298229738937;5212.061828870839;5221.765020574007;5223.268742375994;5224.895502090013;5071.087204303113;5072.188449848007;5089.821856235162;5092.9745351273;5104.846854594368;4980.377452818398;5037.748112594429;5073.3911930568565;5095.515925987025;5106.361704786902;5001.374828146481;5034.647574669884;5108.923366149436;5109;5116.283720279238;5044.167712327425;5162.5095615916425;5163.302954101148;5164.845054648366;5199.064168449715;4978.6763860348965;4983.451820299837;5019.52314530119;5027.572656324253;5078.568321692697 07:29:10 INFO - PROCESS | 3395 | |1;ext.html;549.9277847538973;576.3343338444097;583.2913010692008;593.1636392686311;613.2028363127936;26776;29660.555091673643;29685.554716679268;29688.851555742218;29749;26629.733702663016;40606.79696601513;41370;41483.17033659333;44851.55148448514;7855.05739311282;7969.4022948278825;7974.561399123046;7976.242256985577;7983.880241796349;7587.772366829004;7831.765047048598;7911.52530848148;7924.366050715929;7927;10065.496725163712;10323.638672646459;10338.32800867945;10626.681199564026;10628.256022078458;10162.491875406236;10241.48792560369;10248.180145588334;10251.948740256252;10257.640982565574;7626;9754.414735115844;10008.499575021293;10078.092971632515;10169.54237059334;37991.05022374463;38006.61993380058;38052.80973595142;38144.61855381438;38236.61763382358;3078.7998780079224;3171.5242713592916;3206.3266713990092;3278.6229583597715;3608.350496910555;29392.853035734897;29623.21437459572;29904.70095299041;30171.396572068654;30657.233569160726;2994.7005299470097;3022.7732920030867;3053.465643512399;3064.264576501646;3155.984220078885;255804;256006.99999999814;257483;257673;257890;46425.535744642795;46541.30188047114;46625.30062049072;46632;46670.76664616655;53338.466615334124;53651.73174134183;53697;54332.45667543353;54358;14256.42974281017;14754.40982360715;14760.040597361138;14761.11433313983;14800.111993280438;10556.947215263874;10573.312734672221;10590.364578125336;10638.202134839918;10640.680779576625;13472.730545389233;14834;15451.304691288919;15479.380824767108;15559.766603500957;5930.584859059911;5934.465898069195;6047.485963693135;6086.7260973255425;6152.369622050161;821.6877586517086;877.3595275448959;881.8060026794095;885.5867760352986;888.5734847273345;27110.780014899377;27545.44909101807;27870.86064569664;27971.30071748182;28059.298517537223;984.2077127911956;995.0596686131536;1027.2501074215716;1030.258214085857;1068.6740544133959;14145.575632731034;14488.927555362156;14614.196219208046;14823.629409264855;15035.398584056735;352706;359408;359956;361808;361939;47816.5218347819;47937.760311198224;47941;47943.760281199066;47949.520504794506;1077.1651969723528;1161.7153797319543;1185.2355230876037;1199.7420554580808;1227.4599176362372;27093;28580;28652.85673571702;28992.42015159727;29156.56265155982;40641.39037914493;40994.79502602468;41008.38487422751;41084.79457602693;41095;277539;278245;279386;279835;279846;29605.703942960296;39021;39680;40246.39630405605;40280.1943961125;41138.588614113476;41265.381019285334;41596;41692.791536042125;41990.58009419867;35756.46365304574;35962;36182.27635447329;36372.63627363798;36561.45157822582;35069.82465087658;35555.66578209886;35887.102822429646;35989;36061.0984725384;34238.486422704176;34452.310953781285;35077.824610876785;35140.12149696278;35164.82417587896;28780.568291475225;31483.212919677193;31488.842555787076;31498.37003259968;31607.683923161392;24690.753092468847;24778.752212477644;24861;24886.25341239766;25210 07:29:10 INFO - PROCESS | 3395 | |2;jquery.html;371.7416395605056;371.93677074897266;376.934036543605;384.50398985308954;398.1360447828213;15731.449399271014;17359.91320043401;17598.12009399528;17922.37271695489;17951.551211219725;15401.460948866765;15950.601234969132;16039.117848518326;16079.517614471555;16085.678286434293;5107.514786095315;5266.578673706094;5275.630705850592;5302.973485132569;5310.017646735347;3738.9439158412647;3939.5863434339412;5167.586593072545;5897.734601942923;6233.594816336947;6280.528960327971;6287.245530536342;6299.275583307909;6307.4954003679595;6313.621182729028;5931.822045338625;6159.599626024294;6167.136600875881;6167.352427995063;6176.166217560639;3386.102682789063;5042.949570504285;5381.784728610851;5384.623076384654;5416.160495123262;17485.300587976464;17566.82433175665;17627.383041593483;20954.790452095436;20963.895180524152;1871.0738184598574;1940.1463356123402;1947.5812700269369;2002.4893652118762;2030.8070733280463;13057.804132938014;13387.531436399679;13394.665133371645;13402.865971340358;13822.239776812272;1684.4778118783095;1685.418530606951;1715.9227537888287;1775.254393154865;1834.8807327523668;66223.3377666222;66315.66842165758;66581;67875.66062169657;71603.64198179028;9900.60397584103;10179.338343007681;10183.592656293666;10291.176705863512;10429.269951103503;14082.225477598626;14128.434862605587;14148.575542733735;14211.573652790226;14229.217393043482;7204.207537170907;7256.092988376453;7289.088863892013;7372.741954031583;7467.995008891657;6712.463002959751;6768;6802.795916122524;6894.482913781487;6914.481413893978;4338.1323735252445;4412.624926881251;4421.602055814928;4452;4458.487273963471;1639.7868277124137;1684.3178512702375;1787.3386846866742;1820.7633007709178;1834.990825045893;834.3116928533863;838.5723281126548;896.3814967672286;898.7393655839865;905.76902889764;16563.83436165623;16797.160141993096;16973.745393819103;17118.572035699206;17735.73396399055;846.34408333542;848.8981322241247;876.4609764994483;930.2046750028628;931.7065124485765;9331.34680572367;9804.754881128029;9930.950345248228;9943.801123977624;10016.198704103654;359750;359835;376441.9447569054;378871;383237;78106.2189378099;78807;82371;83049;83054.58472707598;886.242262865241;890.6693439763013;898.2723993565364;900.7522931193975;900.8828852249296;15397.615059623598;15545.766813498032;15577.376904923676;15580.454684086002;15989.520314390587;37285.440718389786;37811.81094094512;38074.23851523009;38740.225195496496;38770.224595508495;51672.741636291576;52238.47761522336;52481;52510;53472.73263633657;7241.203467618452;7594.240575942362;7635;7735.497192682457;7843.56860372685;9592.9040709592;11737.178397512434;11841.940790295994;11877.881221187678;11931.164818462972;10093.747656308651;10198.286119971532;10273;10358.637447689294;10558.683239502827;10355.792884142425;10404.115650169517;10486.895131048592;10586.258961872594;10626.415547144981;9992.450415227233;10319.845202322122;10447.373157610567;10654.467276635982;10706.304090234109;7782.649780759766;7882.093559240531;7890.881636775338;8073.031236251687;8093;8626.309895208242;9389.624415023596;10233.590656373663;10373.170146388422;10513.264071514921 07:29:10 INFO - PROCESS | 3395 | |3;mootools.html;1187.7446349034956;1331.181323486056;1380.834299884014;1425.757621204395;1671.298054816976;6608.140941677581;7611.314981651651;7843.098043724966;7845.4900431471915;8074;7555.924440755591;7703.961480192605;7713.614319284027;7724.884126738103;7725.768226953186;2193.4187440328324;2207.558488302338;2208.8343374246915;2213.55728854229;2228.55428914217;2141.1435425829713;2165.6426689596196;2185.5410363823617;2187.136081247906;2187.8030977212047;2164.642833932407;2185.3443966809973;2188.6935828983956;2193.320070778064;2207.3598656389627;2140.9464763380884;2142.1431427429075;2148.355493351996;2148.4843637527038;2148.9355319340443;2086.3219453677616;2130.7123538322285;2133.3386650138505;2134.7545032321173;2136.4338450310524;7806.336461400788;7830.960845195737;7931.484453510503;7947.483413578099;7972.760817175436;4709.62323014158;4825.806967721287;4835.323054772335;4838.491958344393;4843.39457567804;2921.1528656689534;2955.8374289414073;3044.893428729984;3047.6647568767416;3053.2519532714405;938.9483578403185;952.1525842000625;956.3257903178243;962.3119469579215;962.5860879821674;10851.78296434067;10981.17641176907;11022.173336999756;11025.283356581876;11038.227324087316;4166.895827604334;4237.385579091015;4248.575142485788;4442.8222871085445;4471.374007638933;8654.264387527131;8747.868781968276;8775.91224087751;8806.91193088061;8810.207081362709;4674.0885527322525;4674.485806561275;4680.063987202505;4683.742394168354;4684.0866031123605;3775;3788.5643151037984;4330.2205602991135;4363.563643635674;4364.367166760802;3464.705500032475;3490.860365585348;3553.7157027437743;3587.28254349126;3588.067102553303;1064.7923654887222;1071.1002757683584;1071.7802850415646;1073.8496610474383;1084.5661735305941;750.3996802557932;793.5159552672865;809.8947136872168;815.3721634341524;823.9464434811838;4815.542523460265;4941.851744447672;5024.723640199751;5088.542031217208;5139.486051394831;803.3171803966699;860.3547339495378;862.8964524257129;870.9869351959726;877.8902637170354;3312.403767321905;3356.6643335666727;3360.495925611178;3468.722502199818;3479.5824501060033;9827.901720982842;10030.398176109311;10057.346272492265;10108.090271875566;10185.94907025475;9225.400348977295;10005.699829005142;10016.048475394826;10020.899791002143;10052.195824334036;7228.746993855295;7424.703011879572;7532.13380461243;7554;7562.357199637982;5002.124628190125;5213.113770658922;5233.633645644768;5350.197470379474;5351.812686555952;9139.725808225763;9157.542122893696;9207.907920920705;9247.583858726239;9251;8855.91144088551;9167;9170.95414522923;9186.448813071238;9460;6628.07206991012;7303.598302093435;7533.3973282138395;7553.206913274027;7754.7673569793;7738.7678369649;7757.069151701832;7799.259070388304;7801.4929029612895;7818.296353328228;6685.966570167118;6833.384995350442;6852.828679283058;6969.106430966675;6983.6857341418745;6512.185976752906;6695.631740254138;6776.898346524905;6901.654917254017;7015.123109611299;6031.728572214173;6105.603135796159;6127.877442451037;6180.8763824722355;6253.7185826637;4257.765822879772;4266.189424009553;4313.158934007964;4391.341298805205;4505.887352816206;4245.893852653709;4313.072689371675;4422.49141348749;4454.354118652842;4464.285714285698 07:29:10 INFO - PROCESS | 3395 | |4;prototype.html;298.666986310264;305.75845082384916;306.76379188025237;309.3827813512043;310.0357886971519;4954.281629163774;4955.231939049444;4961.925571116436;4995.950040499594;5020.673656212343;4897.804087836482;4906.901861962759;4912.312276281324;4912.582430493412;4918.188498897677;3644.999999999993;3768.679662228714;3788.3181027415053;3870.20660764544;3896;3846.8076596170217;3860.7104467164936;3866.8839934802;3880.3403421418284;3882.1847412043503;3671.504346913159;3831.329517334469;3871.5354157501138;3882.1847412043503;3883.1262965832743;3747.1381582236104;3849.999999999986;3872.380419132925;3874.2251549690177;3878.553966293884;3398.5581874356176;3400.268942177444;3403.7617366784334;3406.591209054929;3412.9146771330666;4784.30627559002;4823.879403014953;4824.903501929942;4826.638002149853;4840.564349208588;4234.640055595278;4444.888877778049;4446.7554284514335;4452.866414007585;4464.308032255006;5161.612879034087;5172.741362931838;5178.197379406198;5183.64144314336;5194.792208311701;3784.5836957934607;3789.242151569697;3812.1803812180237;3812.4281357796276;3836.3094642964534;5204.375474943031;5382.596305277119;5396.381085674282;5468.72656367184;5521.1442226454965;3846.442265871433;3853.402722578005;3876.282887665791;3900.531936167678;3900.902477438087;3956.3076461619103;3966.0962737885397;3970.8808735737975;3983.6813054955533;4008.899777505586;4307.341673455742;4407.4050003249795;4424.845130420485;4442.489113751895;4448.266036104006;5095.159298715745;5106.897862042812;5121;5122.846314610493;5134.023400990645;1333.8599447058114;1350.9459621615222;1363.779417421422;1365.8360996680462;1370.6093763277418;880.9956649419667;890.6660002499062;924.1220840201835;955.1212884146602;959.7312752429331;4537.6143027842345;4542.250528662799;4548.363229147922;4580.587747102777;4582.473015603248;5275.657082289716;5306.708131052829;5324.787008519694;5325.588718989471;5353.2237825515085;4371.366151907955;4481.7983190756495;4518.932216016762;4533.070720502289;4548.817307500008;2769.8615069246457;2782.151443809617;2802.621646077794;2820.957685634717;2836.8014239003073;4897.2898929655;4918.55732984026;4921.975390123098;4927.531884471041;4937.629937629958;5177.715225662625;5273.973630131824;5308.893822123536;5313.601479889024;5351.866203344947;4876.708221950169;4880.779245443315;4881.170201065756;4894.339264199359;4926.655134140576;5217.869553261199;5225.294585231097;5233.633645644768;5258.947410525846;5272.446393128666;4977.427595826526;5101.189077877449;5198.492437193172;5202.8959420812125;5215.608829337739;4883.633727470383;4907.276461563723;4935.876603084952;4976.303317535476;5004.649674522749;3910.648041676263;3925.9607403925597;3930.1746633206203;3933.033483258371;3935.3703407455814;5141.897162056813;5345.385280692614;5423.5932305076485;5424.484673955968;5428.828468612586;5165.173572228426;5176.792928282826;5210.124355232189;5240.004399164147;5242.292290540729;5099.051165205189;5180.145276029413;5193.143131383279;5195.844124676266;5220.765065571983;4903.387076615423;4998.525140111684;5064.949350506447;5099.56653684441;5139.177731563082;5087.262346959744;5151.0470562945975;5239.4064937856;5241.030409374278;5243.584232257345;5112.3865136183895;5117.462666419972;5119.718415487035;5139.177731563082;5140.254663073908 07:29:10 INFO - PROCESS | 3395 | |5;yui.html;717.6160753996613;718.802329359426;728.7230852276134;735.9742409015686;763.8968739220205;12273.570425035126;13051.477940882352;13132.474701011972;13285.7342853143;13309.667258318546;12875.291858947778;12951.935240323784;12965.870341296584;12974.54589089382;12982.870171298284;633.1136409027375;764.9082110146762;786.5045021636361;789.72754399732;804.9597520123999;788.42051092447;790.4703848421572;794.9863923497529;795.4630624328584;799.4124318625805;842.3008902610849;843.9789005274887;845.327964268405;845.8096928191169;846.3398549131687;611.6910959965211;623.8066199478153;628.2900322635438;628.8962321216994;832.9292010179112;583.3787016827108;601.5668718522701;606.5026678123941;608.0939400293574;608.7108623403892;13765.862341376658;13774.173549587056;13789.655258618515;13791.724165516735;13799.2410417427;12852.935735321356;13288.601341959757;13317;13327.73344533104;13550.457981680722;11465.312081275068;11469.680577921152;11604.12969027318;11756.58851940178;11785.823212651818;4205.369194620801;4286.678499112548;4290.785460726951;4309.5905888940815;4432.091421258634;56078.43921560814;56839.14741278884;56853;59037.40962590405;59865.40134598642;10639.787204255872;10673.573057077785;10677.359358438518;10691.465426728633;10726.463676816127;19703.802961970196;19715.211391544464;19717.211311547664;19790.802091979185;19798.109085091204;7040.979058036556;7094.11323584552;7122.316757489804;7189.3170148836825;7317.743878964211;3823.866164684223;3843.0776613612534;3863.2273545291055;3892;3893.162969961472;2802.7617652499766;2899.942001159965;2905.956410653842;2907.5057240269207;2909.38902830408;505.73196206010874;509.3658395297804;509.43707203540293;509.6203328520276;537.5592014548033;534.4655344655345;566.9121286200563;588.802751078385;598.2462097756771;645.7191121862005;8398.832023359499;8469.491830490068;8494.617742201615;8561.914380856111;8580.485170889766;607.6414915200053;608.6682757896957;618.9257289125334;625.9405356491126;628.1237673445518;4172.874813755592;4307.590778876001;4320.719153255029;4336.82652693895;4378.014946636981;97616;101855.49072254592;101924.49037754764;103202.48398757959;103532.82335883327;87668.123318766;88791.55604221938;91209.54395227981;91312;92131.53934230286;75798;80117;80253;80482.59758701286;81268;7463.440241981764;7969.882014589731;8095.433319667567;8235.258826705625;8497.150284971452;30021.849890750407;30543.84728076434;38338.42492362561;41409.26688898747;43416.56583434125;40697.1860562793;49366.50633493763;59300;60809.95950202561;62804;9676.17752491018;9823.557939892866;9943.154831839374;9994.050565196294;10087.949560252151;10926.125909927028;10955.890441095487;11202.103831693608;11518.251313664585;11553.768924621292;9410.717678469657;9544.42733435996;9697.466639334622;9824.410535367615;10770;10456.424896630759;10605.946970265099;10885.564577417132;11317.264377815416;11335.149863760085;10457;10639.8936010642;10837.566497340018;11080.61217857371;11080.778384432106;9131.269498439977;9155.942770362039;9321.673741419017;9389.953050234704;9485.146336829719;9092.772680683036;9477.905220947978;10015.349002314826;10018.448985305879;10032.398056116657 07:29:10 INFO - PROCESS | 3395 | __end_tp_report 07:29:10 INFO - PROCESS | 3395 | __start_cc_report 07:29:10 INFO - PROCESS | 3395 | _x_x_mozilla_cycle_collect,1096 07:29:10 INFO - PROCESS | 3395 | __end_cc_report 07:29:10 INFO - PROCESS | 3395 | __startTimestamp1466605750658__endTimestamp 07:29:10 INFO - PROCESS | 3395 | 07:29:10 INFO - PROCESS | 3395 | ------- Summary: start ------- 07:29:10 INFO - PROCESS | 3395 | Number of tests: 6 07:29:10 INFO - PROCESS | 3395 | 07:29:10 INFO - PROCESS | 3395 | [#0] dojo.html Cycles:165 Average:4840.31 Median:4973.20 stddev:526.03 (10.6%) stddev-sans-first:498.49 07:29:10 INFO - PROCESS | 3395 | Values: 2638.7 2643.7 2682.2 2684.7 2692.9 4730.1 4810.4 4822.6 4929.4 4973.2 4776.0 4790.8 4812.7 4876.5 4882.4 4411.4 4486.2 4492.8 4558.5 4619.7 4505.4 4536.7 4554.2 4562.4 4583.0 4372.7 4412.6 4424.2 4492.7 4503.8 4421.9 4423.8 4424.4 4534.3 4537.4 4439.7 4463.7 4481.8 4485.2 4521.3 4776.6 4819.9 4856.9 4862.2 4918.8 5288.4 5298.4 5313.8 5332.3 5340.1 5330.4 5355.5 5371.2 5372.5 5385.2 4718.3 4891.2 4943.6 4948.3 4977.4 5462.3 5494.7 5503.3 5514.0 5520.9 5138.5 5255.7 5267.4 5270.3 5271.2 5114.3 5174.5 5192.7 5248.3 5264.9 5211.5 5245.3 5247.5 5250.3 5297.2 5208.7 5228.3 5232.0 5235.8 5280.7 4359.5 4415.9 4433.2 4495.0 4501.9 3873.4 3889.5 3891.6 3926.5 3945.1 4492.7 4498.4 4503.3 4509.0 4551.9 5061.8 5099.3 5177.2 5280.5 5285.3 4432.4 4452.2 4471.8 4530.9 4539.2 4713.6 4731.5 4735.9 4737.6 4763.1 4763.3 4850.8 4902.2 4919.6 4926.7 5269.6 5287.2 5292.5 5292.9 5333.9 4923.4 4934.9 4935.5 4945.2 4983.8 5042.7 5087.9 5099.0 5144.6 5192.1 5198.3 5212.1 5221.8 5223.3 5224.9 5071.1 5072.2 5089.8 5093.0 5104.8 4980.4 5037.7 5073.4 5095.5 5106.4 5001.4 5034.6 5108.9 5109.0 5116.3 5044.2 5162.5 5163.3 5164.8 5199.1 4978.7 4983.5 5019.5 5027.6 5078.6 07:29:10 INFO - PROCESS | 3395 | 07:29:10 INFO - PROCESS | 3395 | [#1] ext.html Cycles:180 Average:45428.73 Median:3242.47 stddev:79058.30 (2438.2%) stddev-sans-first:79208.27 07:29:10 INFO - PROCESS | 3395 | Values: 549.9 576.3 583.3 593.2 613.2 26776.0 29660.6 29685.6 29688.9 29749.0 26629.7 40606.8 41370.0 41483.2 44851.6 7855.1 7969.4 7974.6 7976.2 7983.9 7587.8 7831.8 7911.5 7924.4 7927.0 10065.5 10323.6 10338.3 10626.7 10628.3 10162.5 10241.5 10248.2 10251.9 10257.6 7626.0 9754.4 10008.5 10078.1 10169.5 37991.1 38006.6 38052.8 38144.6 38236.6 3078.8 3171.5 3206.3 3278.6 3608.4 29392.9 29623.2 29904.7 30171.4 30657.2 2994.7 3022.8 3053.5 3064.3 3156.0 255804.0 256007.0 257483.0 257673.0 257890.0 46425.5 46541.3 46625.3 46632.0 46670.8 53338.5 53651.7 53697.0 54332.5 54358.0 14256.4 14754.4 14760.0 14761.1 14800.1 10556.9 10573.3 10590.4 10638.2 10640.7 13472.7 14834.0 15451.3 15479.4 15559.8 5930.6 5934.5 6047.5 6086.7 6152.4 821.7 877.4 881.8 885.6 888.6 27110.8 27545.4 27870.9 27971.3 28059.3 984.2 995.1 1027.3 1030.3 1068.7 14145.6 14488.9 14614.2 14823.6 15035.4 352706.0 359408.0 359956.0 361808.0 361939.0 47816.5 47937.8 47941.0 47943.8 47949.5 1077.2 1161.7 1185.2 1199.7 1227.5 27093.0 28580.0 28652.9 28992.4 29156.6 40641.4 40994.8 41008.4 41084.8 41095.0 277539.0 278245.0 279386.0 279835.0 279846.0 29605.7 39021.0 39680.0 40246.4 40280.2 41138.6 41265.4 41596.0 41692.8 41990.6 35756.5 35962.0 36182.3 36372.6 36561.5 35069.8 35555.7 35887.1 35989.0 36061.1 34238.5 34452.3 35077.8 35140.1 35164.8 28780.6 31483.2 31488.8 31498.4 31607.7 24690.8 24778.8 24861.0 24886.3 25210.0 07:29:10 INFO - PROCESS | 3395 | 07:29:10 INFO - PROCESS | 3395 | [#2] jquery.html Cycles:180 Average:24056.41 Median:38755.22 stddev:61575.88 (158.9%) stddev-sans-first:61722.94 07:29:10 INFO - PROCESS | 3395 | Values: 371.7 371.9 376.9 384.5 398.1 15731.4 17359.9 17598.1 17922.4 17951.6 15401.5 15950.6 16039.1 16079.5 16085.7 5107.5 5266.6 5275.6 5303.0 5310.0 3738.9 3939.6 5167.6 5897.7 6233.6 6280.5 6287.2 6299.3 6307.5 6313.6 5931.8 6159.6 6167.1 6167.4 6176.2 3386.1 5042.9 5381.8 5384.6 5416.2 17485.3 17566.8 17627.4 20954.8 20963.9 1871.1 1940.1 1947.6 2002.5 2030.8 13057.8 13387.5 13394.7 13402.9 13822.2 1684.5 1685.4 1715.9 1775.3 1834.9 66223.3 66315.7 66581.0 67875.7 71603.6 9900.6 10179.3 10183.6 10291.2 10429.3 14082.2 14128.4 14148.6 14211.6 14229.2 7204.2 7256.1 7289.1 7372.7 7468.0 6712.5 6768.0 6802.8 6894.5 6914.5 4338.1 4412.6 4421.6 4452.0 4458.5 1639.8 1684.3 1787.3 1820.8 1835.0 834.3 838.6 896.4 898.7 905.8 16563.8 16797.2 16973.7 17118.6 17735.7 846.3 848.9 876.5 930.2 931.7 9331.3 9804.8 9931.0 9943.8 10016.2 359750.0 359835.0 376441.9 378871.0 383237.0 78106.2 78807.0 82371.0 83049.0 83054.6 886.2 890.7 898.3 900.8 900.9 15397.6 15545.8 15577.4 15580.5 15989.5 37285.4 37811.8 38074.2 38740.2 38770.2 51672.7 52238.5 52481.0 52510.0 53472.7 7241.2 7594.2 7635.0 7735.5 7843.6 9592.9 11737.2 11841.9 11877.9 11931.2 10093.7 10198.3 10273.0 10358.6 10558.7 10355.8 10404.1 10486.9 10586.3 10626.4 9992.5 10319.8 10447.4 10654.5 10706.3 7782.6 7882.1 7890.9 8073.0 8093.0 8626.3 9389.6 10233.6 10373.2 10513.3 07:29:10 INFO - PROCESS | 3395 | 07:29:10 INFO - PROCESS | 3395 | [#3] mootools.html Cycles:180 Average:5175.73 Median:4830.57 stddev:2961.61 (61.3%) stddev-sans-first:2954.75 07:29:10 INFO - PROCESS | 3395 | Values: 1187.7 1331.2 1380.8 1425.8 1671.3 6608.1 7611.3 7843.1 7845.5 8074.0 7555.9 7704.0 7713.6 7724.9 7725.8 2193.4 2207.6 2208.8 2213.6 2228.6 2141.1 2165.6 2185.5 2187.1 2187.8 2164.6 2185.3 2188.7 2193.3 2207.4 2140.9 2142.1 2148.4 2148.5 2148.9 2086.3 2130.7 2133.3 2134.8 2136.4 7806.3 7831.0 7931.5 7947.5 7972.8 4709.6 4825.8 4835.3 4838.5 4843.4 2921.2 2955.8 3044.9 3047.7 3053.3 938.9 952.2 956.3 962.3 962.6 10851.8 10981.2 11022.2 11025.3 11038.2 4166.9 4237.4 4248.6 4442.8 4471.4 8654.3 8747.9 8775.9 8806.9 8810.2 4674.1 4674.5 4680.1 4683.7 4684.1 3775.0 3788.6 4330.2 4363.6 4364.4 3464.7 3490.9 3553.7 3587.3 3588.1 1064.8 1071.1 1071.8 1073.8 1084.6 750.4 793.5 809.9 815.4 823.9 4815.5 4941.9 5024.7 5088.5 5139.5 803.3 860.4 862.9 871.0 877.9 3312.4 3356.7 3360.5 3468.7 3479.6 9827.9 10030.4 10057.3 10108.1 10185.9 9225.4 10005.7 10016.0 10020.9 10052.2 7228.7 7424.7 7532.1 7554.0 7562.4 5002.1 5213.1 5233.6 5350.2 5351.8 9139.7 9157.5 9207.9 9247.6 9251.0 8855.9 9167.0 9171.0 9186.4 9460.0 6628.1 7303.6 7533.4 7553.2 7754.8 7738.8 7757.1 7799.3 7801.5 7818.3 6686.0 6833.4 6852.8 6969.1 6983.7 6512.2 6695.6 6776.9 6901.7 7015.1 6031.7 6105.6 6127.9 6180.9 6253.7 4257.8 4266.2 4313.2 4391.3 4505.9 4245.9 4313.1 4422.5 4454.4 4464.3 07:29:10 INFO - PROCESS | 3395 | 07:29:10 INFO - PROCESS | 3395 | [#4] prototype.html Cycles:180 Average:4300.17 Median:4897.55 stddev:1228.52 (25.1%) stddev-sans-first:1194.69 07:29:10 INFO - PROCESS | 3395 | Values: 298.7 305.8 306.8 309.4 310.0 4954.3 4955.2 4961.9 4996.0 5020.7 4897.8 4906.9 4912.3 4912.6 4918.2 3645.0 3768.7 3788.3 3870.2 3896.0 3846.8 3860.7 3866.9 3880.3 3882.2 3671.5 3831.3 3871.5 3882.2 3883.1 3747.1 3850.0 3872.4 3874.2 3878.6 3398.6 3400.3 3403.8 3406.6 3412.9 4784.3 4823.9 4824.9 4826.6 4840.6 4234.6 4444.9 4446.8 4452.9 4464.3 5161.6 5172.7 5178.2 5183.6 5194.8 3784.6 3789.2 3812.2 3812.4 3836.3 5204.4 5382.6 5396.4 5468.7 5521.1 3846.4 3853.4 3876.3 3900.5 3900.9 3956.3 3966.1 3970.9 3983.7 4008.9 4307.3 4407.4 4424.8 4442.5 4448.3 5095.2 5106.9 5121.0 5122.8 5134.0 1333.9 1350.9 1363.8 1365.8 1370.6 881.0 890.7 924.1 955.1 959.7 4537.6 4542.3 4548.4 4580.6 4582.5 5275.7 5306.7 5324.8 5325.6 5353.2 4371.4 4481.8 4518.9 4533.1 4548.8 2769.9 2782.2 2802.6 2821.0 2836.8 4897.3 4918.6 4922.0 4927.5 4937.6 5177.7 5274.0 5308.9 5313.6 5351.9 4876.7 4880.8 4881.2 4894.3 4926.7 5217.9 5225.3 5233.6 5258.9 5272.4 4977.4 5101.2 5198.5 5202.9 5215.6 4883.6 4907.3 4935.9 4976.3 5004.6 3910.6 3926.0 3930.2 3933.0 3935.4 5141.9 5345.4 5423.6 5424.5 5428.8 5165.2 5176.8 5210.1 5240.0 5242.3 5099.1 5180.1 5193.1 5195.8 5220.8 4903.4 4998.5 5064.9 5099.6 5139.2 5087.3 5151.0 5239.4 5241.0 5243.6 5112.4 5117.5 5119.7 5139.2 5140.3 07:29:10 INFO - PROCESS | 3395 | 07:29:10 INFO - PROCESS | 3395 | [#5] yui.html Cycles:180 Average:17569.13 Median:536.01 stddev:25784.53 (4810.4%) stddev-sans-first:25825.81 07:29:10 INFO - PROCESS | 3395 | Values: 717.6 718.8 728.7 736.0 763.9 12273.6 13051.5 13132.5 13285.7 13309.7 12875.3 12951.9 12965.9 12974.5 12982.9 633.1 764.9 786.5 789.7 805.0 788.4 790.5 795.0 795.5 799.4 842.3 844.0 845.3 845.8 846.3 611.7 623.8 628.3 628.9 832.9 583.4 601.6 606.5 608.1 608.7 13765.9 13774.2 13789.7 13791.7 13799.2 12852.9 13288.6 13317.0 13327.7 13550.5 11465.3 11469.7 11604.1 11756.6 11785.8 4205.4 4286.7 4290.8 4309.6 4432.1 56078.4 56839.1 56853.0 59037.4 59865.4 10639.8 10673.6 10677.4 10691.5 10726.5 19703.8 19715.2 19717.2 19790.8 19798.1 7041.0 7094.1 7122.3 7189.3 7317.7 3823.9 3843.1 3863.2 3892.0 3893.2 2802.8 2899.9 2906.0 2907.5 2909.4 505.7 509.4 509.4 509.6 537.6 534.5 566.9 588.8 598.2 645.7 8398.8 8469.5 8494.6 8561.9 8580.5 607.6 608.7 618.9 625.9 628.1 4172.9 4307.6 4320.7 4336.8 4378.0 97616.0 101855.5 101924.5 103202.5 103532.8 87668.1 88791.6 91209.5 91312.0 92131.5 75798.0 80117.0 80253.0 80482.6 81268.0 7463.4 7969.9 8095.4 8235.3 8497.2 30021.8 30543.8 38338.4 41409.3 43416.6 40697.2 49366.5 59300.0 60810.0 62804.0 9676.2 9823.6 9943.2 9994.1 10087.9 10926.1 10955.9 11202.1 11518.3 11553.8 9410.7 9544.4 9697.5 9824.4 10770.0 10456.4 10605.9 10885.6 11317.3 11335.1 10457.0 10639.9 10837.6 11080.6 11080.8 9131.3 9155.9 9321.7 9390.0 9485.1 9092.8 9477.9 10015.3 10018.4 10032.4 07:29:10 INFO - PROCESS | 3395 | -------- Summary: end -------- 07:29:10 INFO - PROCESS | 3395 | 07:29:11 INFO - TEST-INFO | 3395: exit 0 07:29:11 INFO - TEST-OK | dromaeo_css | took 1123556ms 07:29:11 INFO - TEST-START | kraken 07:29:11 INFO - operating with platform_type : linux_ 07:29:11 INFO - Initialising browser for kraken test... 07:29:11 INFO - TEST-INFO | started process 3578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTdJfe8/profile http://localhost:53391/getInfo.html) 07:29:15 INFO - PROCESS | 3578 | __metrics Screen width/height:1600/1200 07:29:15 INFO - PROCESS | 3578 | colorDepth:24 07:29:15 INFO - PROCESS | 3578 | Browser inner width/height: 1024/697 07:29:15 INFO - PROCESS | 3578 | __metrics 07:29:16 INFO - PROCESS | 3578 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:17 INFO - TEST-INFO | 3578: exit 0 07:29:17 INFO - Browser initialized. 07:29:17 INFO - Running cycle 1/1 for kraken test... 07:29:17 INFO - TEST-INFO | started process 3660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTdJfe8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:30 INFO - PROCESS | 3660 | RSS: Main: 175280128 07:29:30 INFO - PROCESS | 3660 | 07:29:32 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53391/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:33 INFO - PROCESS | 3660 | RSS: Main: 233177088 07:29:33 INFO - PROCESS | 3660 | 07:29:36 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53391/tests/kraken/driver.html?testName=audio-dft) 07:29:37 INFO - PROCESS | 3660 | RSS: Main: 223449088 07:29:37 INFO - PROCESS | 3660 | 07:29:40 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53391/tests/kraken/driver.html?testName=audio-fft) 07:29:41 INFO - PROCESS | 3660 | RSS: Main: 288604160 07:29:41 INFO - PROCESS | 3660 | 07:29:43 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53391/tests/kraken/driver.html?testName=audio-oscillator) 07:29:43 INFO - PROCESS | 3660 | RSS: Main: 198791168 07:29:43 INFO - PROCESS | 3660 | 07:29:46 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53391/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:29:46 INFO - PROCESS | 3660 | RSS: Main: 202334208 07:29:46 INFO - PROCESS | 3660 | 07:29:49 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53391/tests/kraken/driver.html?testName=imaging-darkroom) 07:29:50 INFO - PROCESS | 3660 | RSS: Main: 238612480 07:29:50 INFO - PROCESS | 3660 | 07:29:53 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53391/tests/kraken/driver.html?testName=imaging-desaturate) 07:29:54 INFO - PROCESS | 3660 | RSS: Main: 234700800 07:29:54 INFO - PROCESS | 3660 | 07:29:57 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53391/tests/kraken/driver.html?testName=json-parse-financial) 07:29:58 INFO - PROCESS | 3660 | RSS: Main: 237195264 07:29:58 INFO - PROCESS | 3660 | 07:29:59 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53391/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:30:00 INFO - PROCESS | 3660 | RSS: Main: 224358400 07:30:00 INFO - PROCESS | 3660 | 07:30:02 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53391/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:30:02 INFO - PROCESS | 3660 | RSS: Main: 228831232 07:30:02 INFO - PROCESS | 3660 | 07:30:05 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53391/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:30:05 INFO - PROCESS | 3660 | RSS: Main: 235880448 07:30:05 INFO - PROCESS | 3660 | 07:30:08 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:30:09 INFO - PROCESS | 3660 | RSS: Main: 239882240 07:30:09 INFO - PROCESS | 3660 | 07:30:12 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:30:12 INFO - PROCESS | 3660 | RSS: Main: 240947200 07:30:12 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:53391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53391/tests/kraken/driver.html?testName=ai-astar) 07:30:14 INFO - PROCESS | 3660 | RSS: Main: 283787264 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | __start_tp_report 07:30:14 INFO - PROCESS | 3660 | _x_x_mozilla_page_load 07:30:14 INFO - PROCESS | 3660 | _x_x_mozilla_page_load_details 07:30:14 INFO - PROCESS | 3660 | |i|pagename|runs| 07:30:14 INFO - PROCESS | 3660 | |0;ai-astar;104;116;113;113;114;113;112;113;114;113 07:30:14 INFO - PROCESS | 3660 | |1;audio-beat-detection;168;131;133;181;131;139;166;137;203;131 07:30:14 INFO - PROCESS | 3660 | |2;audio-dft;162;161;161;162;163;162;162;166;161;160 07:30:14 INFO - PROCESS | 3660 | |3;audio-fft;74;77;78;120;75;76;76;77;102;75 07:30:14 INFO - PROCESS | 3660 | |4;audio-oscillator;87;85;116;87;88;86;122;85;85;124 07:30:14 INFO - PROCESS | 3660 | |5;imaging-gaussian-blur;117;117;118;116;117;117;116;117;117;116 07:30:14 INFO - PROCESS | 3660 | |6;imaging-darkroom;146;148;146;146;146;147;146;147;146;147 07:30:14 INFO - PROCESS | 3660 | |7;imaging-desaturate;95;96;95;96;95;94;95;95;96;95 07:30:14 INFO - PROCESS | 3660 | |8;json-parse-financial;62;64;63;63;64;64;63;63;62;64 07:30:14 INFO - PROCESS | 3660 | |9;json-stringify-tinderbox;66;65;66;66;66;67;66;65;65;65 07:30:14 INFO - PROCESS | 3660 | |10;stanford-crypto-aes;89;83;82;83;84;83;83;84;94;89 07:30:14 INFO - PROCESS | 3660 | |11;stanford-crypto-ccm;131;130;130;130;131;129;131;133;144;131 07:30:14 INFO - PROCESS | 3660 | |12;stanford-crypto-pbkdf2;174;166;170;174;166;168;170;167;165;170 07:30:14 INFO - PROCESS | 3660 | |13;stanford-crypto-sha256-iterative;68;68;70;67;70;65;70;66;68;67 07:30:14 INFO - PROCESS | 3660 | __end_tp_report 07:30:14 INFO - PROCESS | 3660 | __start_cc_report 07:30:14 INFO - PROCESS | 3660 | _x_x_mozilla_cycle_collect,1920 07:30:14 INFO - PROCESS | 3660 | __end_cc_report 07:30:14 INFO - PROCESS | 3660 | __startTimestamp1466605814640__endTimestamp 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | ------- Summary: start ------- 07:30:14 INFO - PROCESS | 3660 | Number of tests: 14 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:3.17 (2.8%) stddev-sans-first:1.13 07:30:14 INFO - PROCESS | 3660 | Values: 104.0 116.0 113.0 113.0 114.0 113.0 112.0 113.0 114.0 113.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:152.50 stddev:25.76 (16.9%) stddev-sans-first:26.66 07:30:14 INFO - PROCESS | 3660 | Values: 168.0 131.0 133.0 181.0 131.0 139.0 166.0 137.0 203.0 131.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.63 (1.0%) stddev-sans-first:1.73 07:30:14 INFO - PROCESS | 3660 | Values: 162.0 161.0 161.0 162.0 163.0 162.0 162.0 166.0 161.0 160.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.40 (20.3%) stddev-sans-first:15.98 07:30:14 INFO - PROCESS | 3660 | Values: 74.0 77.0 78.0 120.0 75.0 76.0 76.0 77.0 102.0 75.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.50 stddev:16.82 (19.7%) stddev-sans-first:17.49 07:30:14 INFO - PROCESS | 3660 | Values: 87.0 85.0 116.0 87.0 88.0 86.0 122.0 85.0 85.0 124.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 07:30:14 INFO - PROCESS | 3660 | Values: 117.0 117.0 118.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:30:14 INFO - PROCESS | 3660 | Values: 146.0 148.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:30:14 INFO - PROCESS | 3660 | Values: 95.0 96.0 95.0 96.0 95.0 94.0 95.0 95.0 96.0 95.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 07:30:14 INFO - PROCESS | 3660 | Values: 62.0 64.0 63.0 63.0 64.0 64.0 63.0 63.0 62.0 64.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 07:30:14 INFO - PROCESS | 3660 | Values: 66.0 65.0 66.0 66.0 66.0 67.0 66.0 65.0 65.0 65.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.00 stddev:3.92 (4.7%) stddev-sans-first:3.94 07:30:14 INFO - PROCESS | 3660 | Values: 89.0 83.0 82.0 83.0 84.0 83.0 83.0 84.0 94.0 89.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:131.00 stddev:4.35 (3.3%) stddev-sans-first:4.59 07:30:14 INFO - PROCESS | 3660 | Values: 131.0 130.0 130.0 130.0 131.0 129.0 131.0 133.0 144.0 131.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.00 stddev:3.20 (1.9%) stddev-sans-first:2.83 07:30:14 INFO - PROCESS | 3660 | Values: 174.0 166.0 170.0 174.0 166.0 168.0 170.0 167.0 165.0 170.0 07:30:14 INFO - PROCESS | 3660 | 07:30:14 INFO - PROCESS | 3660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.73 (2.5%) stddev-sans-first:1.83 07:30:14 INFO - PROCESS | 3660 | Values: 68.0 68.0 70.0 67.0 70.0 65.0 70.0 66.0 68.0 67.0 07:30:14 INFO - PROCESS | 3660 | -------- Summary: end -------- 07:30:14 INFO - PROCESS | 3660 | 07:30:15 INFO - TEST-INFO | 3660: exit 0 07:30:15 INFO - TEST-OK | kraken | took 64327ms 07:30:15 INFO - SUITE-END | took 1187s 07:30:16 INFO - Completed test suite (00:19:48) 07:30:16 INFO - javascript benchmark 07:30:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2638.709741928388, 2643.735626437355, 2682.235562864584, 2684.67783865936, 2692.9326766830827, 4730.148573256813, 4810.422749270093, 4822.638302127341, 4929.359183306174, 4973.204287314031, 4776.044791041788, 4790.80836766529, 4812.687175333601, 4876.536729010747, 4882.438519570251, 4411.4265145531035, 4486.214912390335, 4492.7528985905765, 4558.544145585448, 4619.722816630996, 4505.43682039745, 4536.705114167585, 4554.180247555439, 4562.429696287964, 4583.0, 4372.672049596293, 4412.580804823537, 4424.225760491901, 4492.73043617384, 4503.797329120198, 4421.867343979686, 4423.7788110594665, 4424.424824772791, 4534.342520334566, 4537.364768932319, 4439.711418757771, 4463.68754187207, 4481.753503557303, 4485.170243504929, 4521.276595744665, 4776.641751868624, 4819.903601927942, 4856.854294371175, 4862.173430516786, 4918.778654960535, 5288.418273989858, 5298.443663415363, 5313.787448502056, 5332.253484512172, 5340.145576707708, 5330.413654498002, 5355.464453554652, 5371.194320851903, 5372.489613486712, 5385.192221166856, 4718.268668356411, 4891.217405215149, 4943.604511639061, 4948.307236986825, 4977.352944117241, 5462.3445186577865, 5494.670319780826, 5503.3120859892515, 5513.972430137824, 5520.91718624221, 5138.537531622172, 5255.737213139404, 5267.394249661262, 5270.341207349082, 5271.235670827708, 5114.258432527263, 5174.482551744871, 5192.662476938987, 5248.343957005374, 5264.868378290496, 5211.452797456288, 5245.318108645852, 5247.475252474722, 5250.291210686585, 5297.152455607084, 5208.739563021833, 5228.320318358665, 5232.03207406631, 5235.764390602356, 5280.65675731084, 4359.542248063971, 4415.889602759957, 4433.224185767543, 4495.033567782943, 4501.88745281364, 3873.399623058374, 3889.4749208857006, 3891.630295121959, 3926.4895563577124, 3945.0926286953586, 4492.73043617384, 4498.415206023196, 4503.301988191835, 4508.977455112704, 4551.931721024187, 5061.772220250097, 5099.286099946011, 5177.223416487557, 5280.471952804689, 5285.339332583427, 4432.357308190294, 4452.198604251266, 4471.754053527087, 4530.88672783183, 4539.182947069559, 4713.552212539803, 4731.455882573479, 4735.928961065587, 4737.597304229179, 4763.071201115818, 4763.285507173951, 4850.80596776125, 4902.1911384621135, 4919.557239848287, 4926.6551341406475, 5269.578433725216, 5287.180487024518, 5292.52367286946, 5292.894142117213, 5333.9466605335, 4923.409190897115, 4934.901301974012, 4935.4570997190995, 4945.159322915041, 4983.800647974041, 5042.697438153723, 5087.898242035212, 5099.0, 5144.6398752087, 5192.065428222805, 5198.298229738937, 5212.061828870839, 5221.765020574007, 5223.268742375994, 5224.895502090013, 5071.087204303113, 5072.188449848007, 5089.821856235162, 5092.9745351273, 5104.846854594368, 4980.377452818398, 5037.748112594429, 5073.3911930568565, 5095.515925987025, 5106.361704786902, 5001.374828146481, 5034.647574669884, 5108.923366149436, 5109.0, 5116.283720279238, 5044.167712327425, 5162.5095615916425, 5163.302954101148, 5164.845054648366, 5199.064168449715, 4978.6763860348965, 4983.451820299837, 5019.52314530119, 5027.572656324253, 5078.568321692697], "value": 4805.3365796223925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.9277847538973, 576.3343338444097, 583.2913010692008, 593.1636392686311, 613.2028363127936, 26776.0, 29660.555091673643, 29685.554716679268, 29688.851555742218, 29749.0, 26629.733702663016, 40606.79696601513, 41370.0, 41483.17033659333, 44851.55148448514, 7855.05739311282, 7969.4022948278825, 7974.561399123046, 7976.242256985577, 7983.880241796349, 7587.772366829004, 7831.765047048598, 7911.52530848148, 7924.366050715929, 7927.0, 10065.496725163712, 10323.638672646459, 10338.32800867945, 10626.681199564026, 10628.256022078458, 10162.491875406236, 10241.48792560369, 10248.180145588334, 10251.948740256252, 10257.640982565574, 7626.0, 9754.414735115844, 10008.499575021293, 10078.092971632515, 10169.54237059334, 37991.05022374463, 38006.61993380058, 38052.80973595142, 38144.61855381438, 38236.61763382358, 3078.7998780079224, 3171.5242713592916, 3206.3266713990092, 3278.6229583597715, 3608.350496910555, 29392.853035734897, 29623.21437459572, 29904.70095299041, 30171.396572068654, 30657.233569160726, 2994.7005299470097, 3022.7732920030867, 3053.465643512399, 3064.264576501646, 3155.984220078885, 255804.0, 256006.99999999814, 257483.0, 257673.0, 257890.0, 46425.535744642795, 46541.30188047114, 46625.30062049072, 46632.0, 46670.76664616655, 53338.466615334124, 53651.73174134183, 53697.0, 54332.45667543353, 54358.0, 14256.42974281017, 14754.40982360715, 14760.040597361138, 14761.11433313983, 14800.111993280438, 10556.947215263874, 10573.312734672221, 10590.364578125336, 10638.202134839918, 10640.680779576625, 13472.730545389233, 14834.0, 15451.304691288919, 15479.380824767108, 15559.766603500957, 5930.584859059911, 5934.465898069195, 6047.485963693135, 6086.7260973255425, 6152.369622050161, 821.6877586517086, 877.3595275448959, 881.8060026794095, 885.5867760352986, 888.5734847273345, 27110.780014899377, 27545.44909101807, 27870.86064569664, 27971.30071748182, 28059.298517537223, 984.2077127911956, 995.0596686131536, 1027.2501074215716, 1030.258214085857, 1068.6740544133959, 14145.575632731034, 14488.927555362156, 14614.196219208046, 14823.629409264855, 15035.398584056735, 352706.0, 359408.0, 359956.0, 361808.0, 361939.0, 47816.5218347819, 47937.760311198224, 47941.0, 47943.760281199066, 47949.520504794506, 1077.1651969723528, 1161.7153797319543, 1185.2355230876037, 1199.7420554580808, 1227.4599176362372, 27093.0, 28580.0, 28652.85673571702, 28992.42015159727, 29156.56265155982, 40641.39037914493, 40994.79502602468, 41008.38487422751, 41084.79457602693, 41095.0, 277539.0, 278245.0, 279386.0, 279835.0, 279846.0, 29605.703942960296, 39021.0, 39680.0, 40246.39630405605, 40280.1943961125, 41138.588614113476, 41265.381019285334, 41596.0, 41692.791536042125, 41990.58009419867, 35756.46365304574, 35962.0, 36182.27635447329, 36372.63627363798, 36561.45157822582, 35069.82465087658, 35555.66578209886, 35887.102822429646, 35989.0, 36061.0984725384, 34238.486422704176, 34452.310953781285, 35077.824610876785, 35140.12149696278, 35164.82417587896, 28780.568291475225, 31483.212919677193, 31488.842555787076, 31498.37003259968, 31607.683923161392, 24690.753092468847, 24778.752212477644, 24861.0, 24886.25341239766, 25210.0], "value": 17495.73765417823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.7416395605056, 371.93677074897266, 376.934036543605, 384.50398985308954, 398.1360447828213, 15731.449399271014, 17359.91320043401, 17598.12009399528, 17922.37271695489, 17951.551211219725, 15401.460948866765, 15950.601234969132, 16039.117848518326, 16079.517614471555, 16085.678286434293, 5107.514786095315, 5266.578673706094, 5275.630705850592, 5302.973485132569, 5310.017646735347, 3738.9439158412647, 3939.5863434339412, 5167.586593072545, 5897.734601942923, 6233.594816336947, 6280.528960327971, 6287.245530536342, 6299.275583307909, 6307.4954003679595, 6313.621182729028, 5931.822045338625, 6159.599626024294, 6167.136600875881, 6167.352427995063, 6176.166217560639, 3386.102682789063, 5042.949570504285, 5381.784728610851, 5384.623076384654, 5416.160495123262, 17485.300587976464, 17566.82433175665, 17627.383041593483, 20954.790452095436, 20963.895180524152, 1871.0738184598574, 1940.1463356123402, 1947.5812700269369, 2002.4893652118762, 2030.8070733280463, 13057.804132938014, 13387.531436399679, 13394.665133371645, 13402.865971340358, 13822.239776812272, 1684.4778118783095, 1685.418530606951, 1715.9227537888287, 1775.254393154865, 1834.8807327523668, 66223.3377666222, 66315.66842165758, 66581.0, 67875.66062169657, 71603.64198179028, 9900.60397584103, 10179.338343007681, 10183.592656293666, 10291.176705863512, 10429.269951103503, 14082.225477598626, 14128.434862605587, 14148.575542733735, 14211.573652790226, 14229.217393043482, 7204.207537170907, 7256.092988376453, 7289.088863892013, 7372.741954031583, 7467.995008891657, 6712.463002959751, 6768.0, 6802.795916122524, 6894.482913781487, 6914.481413893978, 4338.1323735252445, 4412.624926881251, 4421.602055814928, 4452.0, 4458.487273963471, 1639.7868277124137, 1684.3178512702375, 1787.3386846866742, 1820.7633007709178, 1834.990825045893, 834.3116928533863, 838.5723281126548, 896.3814967672286, 898.7393655839865, 905.76902889764, 16563.83436165623, 16797.160141993096, 16973.745393819103, 17118.572035699206, 17735.73396399055, 846.34408333542, 848.8981322241247, 876.4609764994483, 930.2046750028628, 931.7065124485765, 9331.34680572367, 9804.754881128029, 9930.950345248228, 9943.801123977624, 10016.198704103654, 359750.0, 359835.0, 376441.9447569054, 378871.0, 383237.0, 78106.2189378099, 78807.0, 82371.0, 83049.0, 83054.58472707598, 886.242262865241, 890.6693439763013, 898.2723993565364, 900.7522931193975, 900.8828852249296, 15397.615059623598, 15545.766813498032, 15577.376904923676, 15580.454684086002, 15989.520314390587, 37285.440718389786, 37811.81094094512, 38074.23851523009, 38740.225195496496, 38770.224595508495, 51672.741636291576, 52238.47761522336, 52481.0, 52510.0, 53472.73263633657, 7241.203467618452, 7594.240575942362, 7635.0, 7735.497192682457, 7843.56860372685, 9592.9040709592, 11737.178397512434, 11841.940790295994, 11877.881221187678, 11931.164818462972, 10093.747656308651, 10198.286119971532, 10273.0, 10358.637447689294, 10558.683239502827, 10355.792884142425, 10404.115650169517, 10486.895131048592, 10586.258961872594, 10626.415547144981, 9992.450415227233, 10319.845202322122, 10447.373157610567, 10654.467276635982, 10706.304090234109, 7782.649780759766, 7882.093559240531, 7890.881636775338, 8073.031236251687, 8093.0, 8626.309895208242, 9389.624415023596, 10233.590656373663, 10373.170146388422, 10513.264071514921], "value": 8336.307994472398, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1187.7446349034956, 1331.181323486056, 1380.834299884014, 1425.757621204395, 1671.298054816976, 6608.140941677581, 7611.314981651651, 7843.098043724966, 7845.4900431471915, 8074.0, 7555.924440755591, 7703.961480192605, 7713.614319284027, 7724.884126738103, 7725.768226953186, 2193.4187440328324, 2207.558488302338, 2208.8343374246915, 2213.55728854229, 2228.55428914217, 2141.1435425829713, 2165.6426689596196, 2185.5410363823617, 2187.136081247906, 2187.8030977212047, 2164.642833932407, 2185.3443966809973, 2188.6935828983956, 2193.320070778064, 2207.3598656389627, 2140.9464763380884, 2142.1431427429075, 2148.355493351996, 2148.4843637527038, 2148.9355319340443, 2086.3219453677616, 2130.7123538322285, 2133.3386650138505, 2134.7545032321173, 2136.4338450310524, 7806.336461400788, 7830.960845195737, 7931.484453510503, 7947.483413578099, 7972.760817175436, 4709.62323014158, 4825.806967721287, 4835.323054772335, 4838.491958344393, 4843.39457567804, 2921.1528656689534, 2955.8374289414073, 3044.893428729984, 3047.6647568767416, 3053.2519532714405, 938.9483578403185, 952.1525842000625, 956.3257903178243, 962.3119469579215, 962.5860879821674, 10851.78296434067, 10981.17641176907, 11022.173336999756, 11025.283356581876, 11038.227324087316, 4166.895827604334, 4237.385579091015, 4248.575142485788, 4442.8222871085445, 4471.374007638933, 8654.264387527131, 8747.868781968276, 8775.91224087751, 8806.91193088061, 8810.207081362709, 4674.0885527322525, 4674.485806561275, 4680.063987202505, 4683.742394168354, 4684.0866031123605, 3775.0, 3788.5643151037984, 4330.2205602991135, 4363.563643635674, 4364.367166760802, 3464.705500032475, 3490.860365585348, 3553.7157027437743, 3587.28254349126, 3588.067102553303, 1064.7923654887222, 1071.1002757683584, 1071.7802850415646, 1073.8496610474383, 1084.5661735305941, 750.3996802557932, 793.5159552672865, 809.8947136872168, 815.3721634341524, 823.9464434811838, 4815.542523460265, 4941.851744447672, 5024.723640199751, 5088.542031217208, 5139.486051394831, 803.3171803966699, 860.3547339495378, 862.8964524257129, 870.9869351959726, 877.8902637170354, 3312.403767321905, 3356.6643335666727, 3360.495925611178, 3468.722502199818, 3479.5824501060033, 9827.901720982842, 10030.398176109311, 10057.346272492265, 10108.090271875566, 10185.94907025475, 9225.400348977295, 10005.699829005142, 10016.048475394826, 10020.899791002143, 10052.195824334036, 7228.746993855295, 7424.703011879572, 7532.13380461243, 7554.0, 7562.357199637982, 5002.124628190125, 5213.113770658922, 5233.633645644768, 5350.197470379474, 5351.812686555952, 9139.725808225763, 9157.542122893696, 9207.907920920705, 9247.583858726239, 9251.0, 8855.91144088551, 9167.0, 9170.95414522923, 9186.448813071238, 9460.0, 6628.07206991012, 7303.598302093435, 7533.3973282138395, 7553.206913274027, 7754.7673569793, 7738.7678369649, 7757.069151701832, 7799.259070388304, 7801.4929029612895, 7818.296353328228, 6685.966570167118, 6833.384995350442, 6852.828679283058, 6969.106430966675, 6983.6857341418745, 6512.185976752906, 6695.631740254138, 6776.898346524905, 6901.654917254017, 7015.123109611299, 6031.728572214173, 6105.603135796159, 6127.877442451037, 6180.8763824722355, 6253.7185826637, 4257.765822879772, 4266.189424009553, 4313.158934007964, 4391.341298805205, 4505.887352816206, 4245.893852653709, 4313.072689371675, 4422.49141348749, 4454.354118652842, 4464.285714285698], "value": 4132.909503628748, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.666986310264, 305.75845082384916, 306.76379188025237, 309.3827813512043, 310.0357886971519, 4954.281629163774, 4955.231939049444, 4961.925571116436, 4995.950040499594, 5020.673656212343, 4897.804087836482, 4906.901861962759, 4912.312276281324, 4912.582430493412, 4918.188498897677, 3644.999999999993, 3768.679662228714, 3788.3181027415053, 3870.20660764544, 3896.0, 3846.8076596170217, 3860.7104467164936, 3866.8839934802, 3880.3403421418284, 3882.1847412043503, 3671.504346913159, 3831.329517334469, 3871.5354157501138, 3882.1847412043503, 3883.1262965832743, 3747.1381582236104, 3849.999999999986, 3872.380419132925, 3874.2251549690177, 3878.553966293884, 3398.5581874356176, 3400.268942177444, 3403.7617366784334, 3406.591209054929, 3412.9146771330666, 4784.30627559002, 4823.879403014953, 4824.903501929942, 4826.638002149853, 4840.564349208588, 4234.640055595278, 4444.888877778049, 4446.7554284514335, 4452.866414007585, 4464.308032255006, 5161.612879034087, 5172.741362931838, 5178.197379406198, 5183.64144314336, 5194.792208311701, 3784.5836957934607, 3789.242151569697, 3812.1803812180237, 3812.4281357796276, 3836.3094642964534, 5204.375474943031, 5382.596305277119, 5396.381085674282, 5468.72656367184, 5521.1442226454965, 3846.442265871433, 3853.402722578005, 3876.282887665791, 3900.531936167678, 3900.902477438087, 3956.3076461619103, 3966.0962737885397, 3970.8808735737975, 3983.6813054955533, 4008.899777505586, 4307.341673455742, 4407.4050003249795, 4424.845130420485, 4442.489113751895, 4448.266036104006, 5095.159298715745, 5106.897862042812, 5121.0, 5122.846314610493, 5134.023400990645, 1333.8599447058114, 1350.9459621615222, 1363.779417421422, 1365.8360996680462, 1370.6093763277418, 880.9956649419667, 890.6660002499062, 924.1220840201835, 955.1212884146602, 959.7312752429331, 4537.6143027842345, 4542.250528662799, 4548.363229147922, 4580.587747102777, 4582.473015603248, 5275.657082289716, 5306.708131052829, 5324.787008519694, 5325.588718989471, 5353.2237825515085, 4371.366151907955, 4481.7983190756495, 4518.932216016762, 4533.070720502289, 4548.817307500008, 2769.8615069246457, 2782.151443809617, 2802.621646077794, 2820.957685634717, 2836.8014239003073, 4897.2898929655, 4918.55732984026, 4921.975390123098, 4927.531884471041, 4937.629937629958, 5177.715225662625, 5273.973630131824, 5308.893822123536, 5313.601479889024, 5351.866203344947, 4876.708221950169, 4880.779245443315, 4881.170201065756, 4894.339264199359, 4926.655134140576, 5217.869553261199, 5225.294585231097, 5233.633645644768, 5258.947410525846, 5272.446393128666, 4977.427595826526, 5101.189077877449, 5198.492437193172, 5202.8959420812125, 5215.608829337739, 4883.633727470383, 4907.276461563723, 4935.876603084952, 4976.303317535476, 5004.649674522749, 3910.648041676263, 3925.9607403925597, 3930.1746633206203, 3933.033483258371, 3935.3703407455814, 5141.897162056813, 5345.385280692614, 5423.5932305076485, 5424.484673955968, 5428.828468612586, 5165.173572228426, 5176.792928282826, 5210.124355232189, 5240.004399164147, 5242.292290540729, 5099.051165205189, 5180.145276029413, 5193.143131383279, 5195.844124676266, 5220.765065571983, 4903.387076615423, 4998.525140111684, 5064.949350506447, 5099.56653684441, 5139.177731563082, 5087.262346959744, 5151.0470562945975, 5239.4064937856, 5241.030409374278, 5243.584232257345, 5112.3865136183895, 5117.462666419972, 5119.718415487035, 5139.177731563082, 5140.254663073908], "value": 3912.452588107349, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.6160753996613, 718.802329359426, 728.7230852276134, 735.9742409015686, 763.8968739220205, 12273.570425035126, 13051.477940882352, 13132.474701011972, 13285.7342853143, 13309.667258318546, 12875.291858947778, 12951.935240323784, 12965.870341296584, 12974.54589089382, 12982.870171298284, 633.1136409027375, 764.9082110146762, 786.5045021636361, 789.72754399732, 804.9597520123999, 788.42051092447, 790.4703848421572, 794.9863923497529, 795.4630624328584, 799.4124318625805, 842.3008902610849, 843.9789005274887, 845.327964268405, 845.8096928191169, 846.3398549131687, 611.6910959965211, 623.8066199478153, 628.2900322635438, 628.8962321216994, 832.9292010179112, 583.3787016827108, 601.5668718522701, 606.5026678123941, 608.0939400293574, 608.7108623403892, 13765.862341376658, 13774.173549587056, 13789.655258618515, 13791.724165516735, 13799.2410417427, 12852.935735321356, 13288.601341959757, 13317.0, 13327.73344533104, 13550.457981680722, 11465.312081275068, 11469.680577921152, 11604.12969027318, 11756.58851940178, 11785.823212651818, 4205.369194620801, 4286.678499112548, 4290.785460726951, 4309.5905888940815, 4432.091421258634, 56078.43921560814, 56839.14741278884, 56853.0, 59037.40962590405, 59865.40134598642, 10639.787204255872, 10673.573057077785, 10677.359358438518, 10691.465426728633, 10726.463676816127, 19703.802961970196, 19715.211391544464, 19717.211311547664, 19790.802091979185, 19798.109085091204, 7040.979058036556, 7094.11323584552, 7122.316757489804, 7189.3170148836825, 7317.743878964211, 3823.866164684223, 3843.0776613612534, 3863.2273545291055, 3892.0, 3893.162969961472, 2802.7617652499766, 2899.942001159965, 2905.956410653842, 2907.5057240269207, 2909.38902830408, 505.73196206010874, 509.3658395297804, 509.43707203540293, 509.6203328520276, 537.5592014548033, 534.4655344655345, 566.9121286200563, 588.802751078385, 598.2462097756771, 645.7191121862005, 8398.832023359499, 8469.491830490068, 8494.617742201615, 8561.914380856111, 8580.485170889766, 607.6414915200053, 608.6682757896957, 618.9257289125334, 625.9405356491126, 628.1237673445518, 4172.874813755592, 4307.590778876001, 4320.719153255029, 4336.82652693895, 4378.014946636981, 97616.0, 101855.49072254592, 101924.49037754764, 103202.48398757959, 103532.82335883327, 87668.123318766, 88791.55604221938, 91209.54395227981, 91312.0, 92131.53934230286, 75798.0, 80117.0, 80253.0, 80482.59758701286, 81268.0, 7463.440241981764, 7969.882014589731, 8095.433319667567, 8235.258826705625, 8497.150284971452, 30021.849890750407, 30543.84728076434, 38338.42492362561, 41409.26688898747, 43416.56583434125, 40697.1860562793, 49366.50633493763, 59300.0, 60809.95950202561, 62804.0, 9676.17752491018, 9823.557939892866, 9943.154831839374, 9994.050565196294, 10087.949560252151, 10926.125909927028, 10955.890441095487, 11202.103831693608, 11518.251313664585, 11553.768924621292, 9410.717678469657, 9544.42733435996, 9697.466639334622, 9824.410535367615, 10770.0, 10456.424896630759, 10605.946970265099, 10885.564577417132, 11317.264377815416, 11335.149863760085, 10457.0, 10639.8936010642, 10837.566497340018, 11080.61217857371, 11080.778384432106, 9131.269498439977, 9155.942770362039, 9321.673741419017, 9389.953050234704, 9485.146336829719, 9092.772680683036, 9477.905220947978, 10015.349002314826, 10018.448985305879, 10032.398056116657], "value": 6525.273017970624, "unit": "score"}], "name": "dromaeo_css", "value": 6478.8342585421115, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 113.0, 113.0, 114.0, 113.0, 112.0, 113.0, 114.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 131.0, 133.0, 181.0, 131.0, 139.0, 166.0, 137.0, 203.0, 131.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 163.0, 162.0, 162.0, 166.0, 161.0, 160.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 78.0, 120.0, 75.0, 76.0, 76.0, 77.0, 102.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 116.0, 87.0, 88.0, 86.0, 122.0, 85.0, 85.0, 124.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0, 62.0, 64.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 65.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 82.0, 83.0, 84.0, 83.0, 83.0, 84.0, 94.0, 89.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 130.0, 130.0, 131.0, 129.0, 131.0, 133.0, 144.0, 131.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 166.0, 170.0, 174.0, 166.0, 168.0, 170.0, 167.0, 165.0, 170.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 67.0, 70.0, 65.0, 70.0, 66.0, 68.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1547.7000000000003, "alertThreshold": 2.0}]} 07:30:16 INFO - Return code: 0 07:30:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:30:16 INFO - # TBPL SUCCESS # 07:30:16 INFO - Running post-action listener: _resource_record_post_action 07:30:16 INFO - ##### 07:30:16 INFO - ##### Finished run-tests step (success) 07:30:16 INFO - ##### 07:30:16 INFO - Running post-run listener: _resource_record_post_run 07:30:16 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 7962624; Write bytes: 455049216; Read time: 1792; Write time: 396508 07:30:16 INFO - TinderboxPrint: CPU usage
13.1% 07:30:16 INFO - TinderboxPrint: I/O read bytes / time
7,962,624 / 1,792 07:30:16 INFO - TinderboxPrint: I/O write bytes / time
455,049,216 / 396,508 07:30:16 INFO - TinderboxPrint: CPU idle
8,358.9 (86.9%) 07:30:16 INFO - TinderboxPrint: CPU user
1,215.3 (12.6%) 07:30:16 INFO - TinderboxPrint: Swap in / out
0 / 0 07:30:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20287488; Read time: 0; Write time: 6960 07:30:16 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 6201344; Write bytes: 434761728; Read time: 1748; Write time: 389548 07:30:17 INFO - Running post-run listener: _upload_blobber_files 07:30:17 INFO - Blob upload gear active. 07:30:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:30:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:30:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:30:17 INFO - (blobuploader) - INFO - Open directory for files ... 07:30:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:30:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:30:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:18 INFO - (blobuploader) - INFO - Done attempting. 07:30:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:30:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:30:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:19 INFO - (blobuploader) - INFO - Done attempting. 07:30:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:30:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:30:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:24 INFO - (blobuploader) - INFO - Done attempting. 07:30:24 INFO - (blobuploader) - INFO - Iteration through files over. 07:30:24 INFO - Return code: 0 07:30:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:30:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:30:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56467d111009c33db7f75eb162677185d635f5bdf879a6a2d01dc5fad108778b272c4adf77255a2563ba3edf652e544df59721ed97f70154e48be9d1909778a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/539393b4b9f4ac30145056d785477d48c7c3d5387503d76d6de144e043a018299936fbf331d8c03f1a4078e2e7c228cb437308ec9e46fd1c4f4eb56cb07e0bfb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a5ec0933441bcdb3d6032cb42d6617b9cd13b54d336d7ec0477514fceb2c6bbe59bca0212a596053ec844adb933c09e819c49c80601da4d448fd99b637dc5b8"} 07:30:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:30:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:30:24 INFO - Contents: 07:30:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56467d111009c33db7f75eb162677185d635f5bdf879a6a2d01dc5fad108778b272c4adf77255a2563ba3edf652e544df59721ed97f70154e48be9d1909778a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/539393b4b9f4ac30145056d785477d48c7c3d5387503d76d6de144e043a018299936fbf331d8c03f1a4078e2e7c228cb437308ec9e46fd1c4f4eb56cb07e0bfb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a5ec0933441bcdb3d6032cb42d6617b9cd13b54d336d7ec0477514fceb2c6bbe59bca0212a596053ec844adb933c09e819c49c80601da4d448fd99b637dc5b8"} 07:30:24 INFO - Running post-run listener: copy_logs_to_upload_dir 07:30:24 INFO - Copying logs to upload dir... 07:30:24 INFO - mkdir: /builds/slave/test/build/upload/logs 07:30:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.645404 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-22 07:30:24.827074) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 07:30:24.830967) ========= 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=0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046 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/56467d111009c33db7f75eb162677185d635f5bdf879a6a2d01dc5fad108778b272c4adf77255a2563ba3edf652e544df59721ed97f70154e48be9d1909778a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/539393b4b9f4ac30145056d785477d48c7c3d5387503d76d6de144e043a018299936fbf331d8c03f1a4078e2e7c228cb437308ec9e46fd1c4f4eb56cb07e0bfb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a5ec0933441bcdb3d6032cb42d6617b9cd13b54d336d7ec0477514fceb2c6bbe59bca0212a596053ec844adb933c09e819c49c80601da4d448fd99b637dc5b8"} build_url:https://queue.taskcluster.net/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/Z7ugZvcYQYa7cTn-IT0wsw/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/56467d111009c33db7f75eb162677185d635f5bdf879a6a2d01dc5fad108778b272c4adf77255a2563ba3edf652e544df59721ed97f70154e48be9d1909778a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/539393b4b9f4ac30145056d785477d48c7c3d5387503d76d6de144e043a018299936fbf331d8c03f1a4078e2e7c228cb437308ec9e46fd1c4f4eb56cb07e0bfb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a5ec0933441bcdb3d6032cb42d6617b9cd13b54d336d7ec0477514fceb2c6bbe59bca0212a596053ec844adb933c09e819c49c80601da4d448fd99b637dc5b8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 07:30:24.858735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:30:24.859323) ========= 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=0333a256a5e4f052382dd180000001b1-1466604397.168831-1923676046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:30:24.942367) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 07:30:24.942699) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 07:30:24.942995) ========= ========= Total master_lag: 0.18 =========